TTSOpenAI

{"asctime": "2024-09-01 17:14:28,499", "levelname": "INFO", "message": "Starting gunicorn 21.2.0", "name": "gunicorn.error", "filename": "glogging.py", "lineno": 278, "module": "glogging", "funcName": "info", "process": 1, "thread": 140314149652288}

{"asctime": "2024-09-01 17:14:28,500", "levelname": "INFO", "message": "Listening at: http://0.0.0.0:8000 (1)", "name": "gunicorn.error", "filename": "glogging.py", "lineno": 278, "module": "glogging", "funcName": "info", "process": 1, "thread": 140314149652288}

{"asctime": "2024-09-01 17:14:28,501", "levelname": "INFO", "message": "Using worker: uvicorn.workers.UvicornWorker", "name": "gunicorn.error", "filename": "glogging.py", "lineno": 278, "module": "glogging", "funcName": "info", "process": 1, "thread": 140314149652288}

{"asctime": "2024-09-01 17:14:28,506", "levelname": "INFO", "message": "Booting worker with pid: 7", "name": "gunicorn.error", "filename": "glogging.py", "lineno": 278, "module": "glogging", "funcName": "info", "process": 7, "thread": 140314149652288}

{"asctime": "2024-09-01 17:14:28,550", "levelname": "INFO", "message": "Booting worker with pid: 8", "name": "gunicorn.error", "filename": "glogging.py", "lineno": 278, "module": "glogging", "funcName": "info", "process": 8, "thread": 140314149652288}

{"asctime": "2024-09-01 17:14:28,570", "levelname": "INFO", "message": "Booting worker with pid: 9", "name": "gunicorn.error", "filename": "glogging.py", "lineno": 278, "module": "glogging", "funcName": "info", "process": 9, "thread": 140314149652288}

{"asctime": "2024-09-01 17:14:28,621", "levelname": "INFO", "message": "Booting worker with pid: 10", "name": "gunicorn.error", "filename": "glogging.py", "lineno": 278, "module": "glogging", "funcName": "info", "process": 10, "thread": 140314149652288}

{"asctime": "2024-09-01 17:14:28,675", "levelname": "INFO", "message": "Booting worker with pid: 11", "name": "gunicorn.error", "filename": "glogging.py", "lineno": 278, "module": "glogging", "funcName": "info", "process": 11, "thread": 140314149652288}

{"asctime": "2024-09-01 17:14:43,114", "levelname": "INFO", "message": "Started server process [11]", "name": "uvicorn.error", "filename": "server.py", "lineno": 76, "module": "server", "funcName": "serve", "process": 11, "thread": 140314149652288, "color_message": "Started server process [\u001b[36m%d\u001b[0m]"}

{"asctime": "2024-09-01 17:14:43,115", "levelname": "INFO", "message": "Waiting for application startup.", "name": "uvicorn.error", "filename": "on.py", "lineno": 48, "module": "on", "funcName": "startup", "process": 11, "thread": 140314149652288}

{"asctime": "2024-09-01 17:14:43,116", "levelname": "INFO", "message": "Started server process [10]", "name": "uvicorn.error", "filename": "server.py", "lineno": 76, "module": "server", "funcName": "serve", "process": 10, "thread": 140314149652288, "color_message": "Started server process [\u001b[36m%d\u001b[0m]"}

{"asctime": "2024-09-01 17:14:43,116", "levelname": "INFO", "message": "Waiting for application startup.", "name": "uvicorn.error", "filename": "on.py", "lineno": 48, "module": "on", "funcName": "startup", "process": 10, "thread": 140314149652288}

{"asctime": "2024-09-01 17:14:43,117", "levelname": "INFO", "message": "Started server process [7]", "name": "uvicorn.error", "filename": "server.py", "lineno": 76, "module": "server", "funcName": "serve", "process": 7, "thread": 140314149652288, "color_message": "Started server process [\u001b[36m%d\u001b[0m]"}

{"asctime": "2024-09-01 17:14:43,117", "levelname": "INFO", "message": "Waiting for application startup.", "name": "uvicorn.error", "filename": "on.py", "lineno": 48, "module": "on", "funcName": "startup", "process": 7, "thread": 140314149652288}

{"asctime": "2024-09-01 17:14:43,129", "levelname": "INFO", "message": "Application startup complete.", "name": "uvicorn.error", "filename": "on.py", "lineno": 62, "module": "on", "funcName": "startup", "process": 11, "thread": 140314149652288}

{"asctime": "2024-09-01 17:14:43,130", "levelname": "INFO", "message": "Application startup complete.", "name": "uvicorn.error", "filename": "on.py", "lineno": 62, "module": "on", "funcName": "startup", "process": 10, "thread": 140314149652288}

{"asctime": "2024-09-01 17:14:43,143", "levelname": "INFO", "message": "Application startup complete.", "name": "uvicorn.error", "filename": "on.py", "lineno": 62, "module": "on", "funcName": "startup", "process": 7, "thread": 140314149652288}

{"asctime": "2024-09-01 17:14:43,220", "levelname": "INFO", "message": "Started server process [9]", "name": "uvicorn.error", "filename": "server.py", "lineno": 76, "module": "server", "funcName": "serve", "process": 9, "thread": 140314149652288, "color_message": "Started server process [\u001b[36m%d\u001b[0m]"}

{"asctime": "2024-09-01 17:14:43,221", "levelname": "INFO", "message": "Waiting for application startup.", "name": "uvicorn.error", "filename": "on.py", "lineno": 48, "module": "on", "funcName": "startup", "process": 9, "thread": 140314149652288}

{"asctime": "2024-09-01 17:14:43,235", "levelname": "INFO", "message": "Application startup complete.", "name": "uvicorn.error", "filename": "on.py", "lineno": 62, "module": "on", "funcName": "startup", "process": 9, "thread": 140314149652288}

{"asctime": "2024-09-01 17:14:43,242", "levelname": "INFO", "message": "Started server process [8]", "name": "uvicorn.error", "filename": "server.py", "lineno": 76, "module": "server", "funcName": "serve", "process": 8, "thread": 140314149652288, "color_message": "Started server process [\u001b[36m%d\u001b[0m]"}

{"asctime": "2024-09-01 17:14:43,242", "levelname": "INFO", "message": "Waiting for application startup.", "name": "uvicorn.error", "filename": "on.py", "lineno": 48, "module": "on", "funcName": "startup", "process": 8, "thread": 140314149652288}

{"asctime": "2024-09-01 17:14:43,254", "levelname": "INFO", "message": "Application startup complete.", "name": "uvicorn.error", "filename": "on.py", "lineno": 62, "module": "on", "funcName": "startup", "process": 8, "thread": 140314149652288}

{"asctime": "2024-09-01 17:14:46,090", "levelname": "INFO", "message": "10.42.0.113:53916 - \"OPTIONS /api/v1/voice-library/all?items_per_page=500&voice_type=user_voice HTTP/1.1\" 200", "name": "uvicorn.access", "filename": "h11_impl.py", "lineno": 498, "module": "h11_impl", "funcName": "send", "process": 11, "thread": 140314149652288}

{"asctime": "2024-09-01 17:14:46,092", "levelname": "INFO", "message": "10.42.0.113:53894 - \"OPTIONS /api/v1/histories?filter_by=all&items_per_page=10&page=1 HTTP/1.1\" 200", "name": "uvicorn.access", "filename": "h11_impl.py", "lineno": 498, "module": "h11_impl", "funcName": "send", "process": 11, "thread": 140314149652288}

{"asctime": "2024-09-01 17:14:46,092", "levelname": "INFO", "message": "10.42.0.113:53896 - \"OPTIONS /api/v1/voice-library/all?items_per_page=500&voice_type=system_voice HTTP/1.1\" 200", "name": "uvicorn.access", "filename": "h11_impl.py", "lineno": 498, "module": "h11_impl", "funcName": "send", "process": 11, "thread": 140314149652288}

{"asctime": "2024-09-01 17:14:46,093", "levelname": "INFO", "message": "10.42.0.113:53912 - \"OPTIONS /api/v1/products HTTP/1.1\" 200", "name": "uvicorn.access", "filename": "h11_impl.py", "lineno": 498, "module": "h11_impl", "funcName": "send", "process": 11, "thread": 140314149652288}

{"asctime": "2024-09-01 17:14:46,093", "levelname": "INFO", "message": "10.42.0.113:53918 - \"OPTIONS /api/v1/voice-library/all?items_per_page=500&favorite=1 HTTP/1.1\" 200", "name": "uvicorn.access", "filename": "h11_impl.py", "lineno": 498, "module": "h11_impl", "funcName": "send", "process": 11, "thread": 140314149652288}

token: ****************************************************************************************************2LTcyZmI3MjQyOWYzZSJ9.y-Ud3M90i8llVddDcNmqFwIlqFk8f8maZUUCYmfWmfQ

token: ****************************************************************************************************2LTcyZmI3MjQyOWYzZSJ9.y-Ud3M90i8llVddDcNmqFwIlqFk8f8maZUUCYmfWmfQ

{"asctime": "2024-09-01 17:14:46,543", "levelname": "ERROR", "message": "Traceback (most recent call last):\n File \"/app/app/tts_common/core/deps.py\", line 72, in get_current_user\n payload = jwt.decode(\n ^^^^^^^^^^^\n File \"/usr/local/lib/python3.11/site-packages/jose/jwt.py\", line 157, in decode\n _validate_claims(\n File \"/usr/local/lib/python3.11/site-packages/jose/jwt.py\", line 481, in _validate_claims\n _validate_exp(claims, leeway=leeway)\n File \"/usr/local/lib/python3.11/site-packages/jose/jwt.py\", line 314, in _validate_exp\n raise ExpiredSignatureError(\"Signature has expired.\")\njose.exceptions.ExpiredSignatureError: Signature has expired.\n\nDuring handling of the above exception, another exception occurred:\n\nTraceback (most recent call last):\n File \"/app/app/tts_common/core/deps.py\", line 41, in get_db\n yield db\nfastapi.exceptions.HTTPException: 403: Could not validate credentials\n", "name": "root", "filename": "deps.py", "lineno": 43, "module": "deps", "funcName": "get_db", "process": 11, "thread": 140314003539712, "exc_info": "Traceback (most recent call last):\n File \"/app/app/tts_common/core/deps.py\", line 72, in get_current_user\n payload = jwt.decode(\n ^^^^^^^^^^^\n File \"/usr/local/lib/python3.11/site-packages/jose/jwt.py\", line 157, in decode\n _validate_claims(\n File \"/usr/local/lib/python3.11/site-packages/jose/jwt.py\", line 481, in _validate_claims\n _validate_exp(claims, leeway=leeway)\n File \"/usr/local/lib/python3.11/site-packages/jose/jwt.py\", line 314, in _validate_exp\n raise ExpiredSignatureError(\"Signature has expired.\")\njose.exceptions.ExpiredSignatureError: Signature has expired.\n\nDuring handling of the above exception, another exception occurred:\n\nTraceback (most recent call last):\n File \"/app/app/tts_common/core/deps.py\", line 41, in get_db\n yield db\nfastapi.exceptions.HTTPException: 403: Could not validate credentials"}

{"asctime": "2024-09-01 17:14:46,545", "levelname": "ERROR", "message": "403: Could not validate credentials", "name": "root", "filename": "deps.py", "lineno": 44, "module": "deps", "funcName": "get_db", "process": 11, "thread": 140314003539712, "exc_info": "Traceback (most recent call last):\n File \"/app/app/tts_common/core/deps.py\", line 72, in get_current_user\n payload = jwt.decode(\n ^^^^^^^^^^^\n File \"/usr/local/lib/python3.11/site-packages/jose/jwt.py\", line 157, in decode\n _validate_claims(\n File \"/usr/local/lib/python3.11/site-packages/jose/jwt.py\", line 481, in _validate_claims\n _validate_exp(claims, leeway=leeway)\n File \"/usr/local/lib/python3.11/site-packages/jose/jwt.py\", line 314, in _validate_exp\n raise ExpiredSignatureError(\"Signature has expired.\")\njose.exceptions.ExpiredSignatureError: Signature has expired.\n\nDuring handling of the above exception, another exception occurred:\n\nTraceback (most recent call last):\n File \"/app/app/tts_common/core/deps.py\", line 41, in get_db\n yield db\nfastapi.exceptions.HTTPException: 403: Could not validate credentials"}

{"asctime": "2024-09-01 17:14:46,632", "levelname": "INFO", "message": "Tracing request: GET /api/v1/histories", "name": "app.main", "filename": "main.py", "lineno": 63, "module": "main", "funcName": "dispatch", "process": 11, "thread": 140314149652288, "client-ip": "10.42.0.113", "path": "/api/v1/histories", "user-agent": "Mozilla/5.0 (Windows NT 10.0; Win64; x64) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/128.0.0.0 Safari/537.36 Edg/128.0.0.0", "response-time": 268.338680267334, "response-code": 403}

{"asctime": "2024-09-01 17:14:46,633", "levelname": "INFO", "message": "10.42.0.113:53912 - \"GET /api/v1/histories?filter_by=all&items_per_page=10&page=1 HTTP/1.1\" 403", "name": "uvicorn.access", "filename": "h11_impl.py", "lineno": 498, "module": "h11_impl", "funcName": "send", "process": 11, "thread": 140314149652288}

token: ****************************************************************************************************2LTcyZmI3MjQyOWYzZSJ9.y-Ud3M90i8llVddDcNmqFwIlqFk8f8maZUUCYmfWmfQ

{"asctime": "2024-09-01 17:14:46,649", "levelname": "INFO", "message": "Tracing request: GET /api/v1/products", "name": "app.main", "filename": "main.py", "lineno": 63, "module": "main", "funcName": "dispatch", "process": 11, "thread": 140314149652288, "client-ip": "10.42.0.113", "path": "/api/v1/products", "user-agent": "Mozilla/5.0 (Windows NT 10.0; Win64; x64) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/128.0.0.0 Safari/537.36 Edg/128.0.0.0", "response-time": 284.94882583618164, "response-code": 200}

{"asctime": "2024-09-01 17:14:46,651", "levelname": "INFO", "message": "10.42.0.113:53894 - \"GET /api/v1/products HTTP/1.1\" 200", "name": "uvicorn.access", "filename": "h11_impl.py", "lineno": 498, "module": "h11_impl", "funcName": "send", "process": 11, "thread": 140314149652288}

{"asctime": "2024-09-01 17:14:46,654", "levelname": "INFO", "message": "Init key service with priorities: [94, 96, 97]", "name": "app.tts_common.services.key_service", "filename": "key_service.py", "lineno": 28, "module": "key_service", "funcName": "__init__", "process": 11, "thread": 140313995147008}

{"asctime": "2024-09-01 17:14:46,656", "levelname": "INFO", "message": "Init key service with priorities: [94, 96, 97]", "name": "app.tts_common.services.key_service", "filename": "key_service.py", "lineno": 28, "module": "key_service", "funcName": "__init__", "process": 11, "thread": 140313986737920}

{"asctime": "2024-09-01 17:14:46,656", "levelname": "INFO", "message": "Getting cache key voice-library::None::user_voice::False::1::500", "name": "app.api.api_v1.endpoints.cache", "filename": "cache.py", "lineno": 20, "module": "cache", "funcName": "get_cache", "process": 11, "thread": 140314149652288}

{"asctime": "2024-09-01 17:14:46,657", "levelname": "INFO", "message": "Getting cache key voice-library::None::system_voice::False::1::500", "name": "app.api.api_v1.endpoints.cache", "filename": "cache.py", "lineno": 20, "module": "cache", "funcName": "get_cache", "process": 11, "thread": 140314149652288}

{"asctime": "2024-09-01 17:14:46,661", "levelname": "INFO", "message": "Cache hit", "name": "app.api.api_v1.endpoints.cache", "filename": "cache.py", "lineno": 71, "module": "cache", "funcName": "wrapper", "process": 11, "thread": 140314149652288}

{"asctime": "2024-09-01 17:14:46,661", "levelname": "INFO", "message": "processing time via cache: 0.0052187442779541016", "name": "app.api.api_v1.endpoints.cache", "filename": "cache.py", "lineno": 73, "module": "cache", "funcName": "wrapper", "process": 11, "thread": 140314149652288}

{"asctime": "2024-09-01 17:14:46,663", "levelname": "INFO", "message": "Tracing request: GET /api/v1/voice-library/all", "name": "app.main", "filename": "main.py", "lineno": 63, "module": "main", "funcName": "dispatch", "process": 11, "thread": 140314149652288, "client-ip": "10.42.0.113", "path": "/api/v1/voice-library/all", "user-agent": "Mozilla/5.0 (Windows NT 10.0; Win64; x64) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/128.0.0.0 Safari/537.36 Edg/128.0.0.0", "response-time": 301.41615867614746, "response-code": 200}

{"asctime": "2024-09-01 17:14:46,663", "levelname": "INFO", "message": "10.42.0.113:53918 - \"GET /api/v1/voice-library/all?items_per_page=500&voice_type=user_voice HTTP/1.1\" 200", "name": "uvicorn.access", "filename": "h11_impl.py", "lineno": 498, "module": "h11_impl", "funcName": "send", "process": 11, "thread": 140314149652288}

{"asctime": "2024-09-01 17:14:46,665", "levelname": "INFO", "message": "Init key service with priorities: [94, 96, 97]", "name": "app.tts_common.services.key_service", "filename": "key_service.py", "lineno": 28, "module": "key_service", "funcName": "__init__", "process": 11, "thread": 140313628768000}

{"asctime": "2024-09-01 17:14:46,666", "levelname": "INFO", "message": "Getting cache key voice-library::None::None::True::1::500", "name": "app.api.api_v1.endpoints.cache", "filename": "cache.py", "lineno": 20, "module": "cache", "funcName": "get_cache", "process": 11, "thread": 140314149652288}

{"asctime": "2024-09-01 17:14:46,667", "levelname": "INFO", "message": "Cache hit", "name": "app.api.api_v1.endpoints.cache", "filename": "cache.py", "lineno": 71, "module": "cache", "funcName": "wrapper", "process": 11, "thread": 140314149652288}

{"asctime": "2024-09-01 17:14:46,668", "levelname": "INFO", "message": "processing time via cache: 0.0018117427825927734", "name": "app.api.api_v1.endpoints.cache", "filename": "cache.py", "lineno": 73, "module": "cache", "funcName": "wrapper", "process": 11, "thread": 140314149652288}

{"asctime": "2024-09-01 17:14:46,668", "levelname": "INFO", "message": "Tracing request: GET /api/v1/voice-library/all", "name": "app.main", "filename": "main.py", "lineno": 63, "module": "main", "funcName": "dispatch", "process": 11, "thread": 140314149652288, "client-ip": "10.42.0.113", "path": "/api/v1/voice-library/all", "user-agent": "Mozilla/5.0 (Windows NT 10.0; Win64; x64) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/128.0.0.0 Safari/537.36 Edg/128.0.0.0", "response-time": 42.18101501464844, "response-code": 200}

{"asctime": "2024-09-01 17:14:46,669", "levelname": "INFO", "message": "10.42.0.113:53916 - \"GET /api/v1/voice-library/all?items_per_page=500&favorite=1 HTTP/1.1\" 200", "name": "uvicorn.access", "filename": "h11_impl.py", "lineno": 498, "module": "h11_impl", "funcName": "send", "process": 11, "thread": 140314149652288}

{"asctime": "2024-09-01 17:14:46,674", "levelname": "INFO", "message": "Cache hit", "name": "app.api.api_v1.endpoints.cache", "filename": "cache.py", "lineno": 71, "module": "cache", "funcName": "wrapper", "process": 11, "thread": 140314149652288}

{"asctime": "2024-09-01 17:14:46,675", "levelname": "INFO", "message": "processing time via cache: 0.018587827682495117", "name": "app.api.api_v1.endpoints.cache", "filename": "cache.py", "lineno": 73, "module": "cache", "funcName": "wrapper", "process": 11, "thread": 140314149652288}

{"asctime": "2024-09-01 17:14:46,719", "levelname": "INFO", "message": "Tracing request: GET /api/v1/voice-library/all", "name": "app.main", "filename": "main.py", "lineno": 63, "module": "main", "funcName": "dispatch", "process": 11, "thread": 140314149652288, "client-ip": "10.42.0.113", "path": "/api/v1/voice-library/all", "user-agent": "Mozilla/5.0 (Windows NT 10.0; Win64; x64) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/128.0.0.0 Safari/537.36 Edg/128.0.0.0", "response-time": 354.45570945739746, "response-code": 200}

{"asctime": "2024-09-01 17:14:46,720", "levelname": "INFO", "message": "10.42.0.113:53896 - \"GET /api/v1/voice-library/all?items_per_page=500&voice_type=system_voice HTTP/1.1\" 200", "name": "uvicorn.access", "filename": "h11_impl.py", "lineno": 498, "module": "h11_impl", "funcName": "send", "process": 11, "thread": 140314149652288}

{"asctime": "2024-09-01 17:14:46,909", "levelname": "INFO", "message": "10.42.0.113:53896 - \"OPTIONS /api/v1/refresh-token HTTP/1.1\" 200", "name": "uvicorn.access", "filename": "h11_impl.py", "lineno": 498, "module": "h11_impl", "funcName": "send", "process": 11, "thread": 140314149652288}

{"asctime": "2024-09-01 17:14:47,326", "levelname": "INFO", "message": "Tracing request: POST /api/v1/refresh-token", "name": "app.main", "filename": "main.py", "lineno": 63, "module": "main", "funcName": "dispatch", "process": 11, "thread": 140314149652288, "client-ip": "10.42.0.113", "path": "/api/v1/refresh-token", "user-agent": "Mozilla/5.0 (Windows NT 10.0; Win64; x64) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/128.0.0.0 Safari/537.36 Edg/128.0.0.0", "response-time": 59.908151626586914, "response-code": 200}

{"asctime": "2024-09-01 17:14:47,327", "levelname": "INFO", "message": "10.42.0.113:53896 - \"POST /api/v1/refresh-token HTTP/1.1\" 200", "name": "uvicorn.access", "filename": "h11_impl.py", "lineno": 498, "module": "h11_impl", "funcName": "send", "process": 11, "thread": 140314149652288}

{"asctime": "2024-09-01 17:14:47,593", "levelname": "INFO", "message": "10.42.0.113:53896 - \"OPTIONS /api/v1/histories?filter_by=all&items_per_page=10&page=1 HTTP/1.1\" 200", "name": "uvicorn.access", "filename": "h11_impl.py", "lineno": 498, "module": "h11_impl", "funcName": "send", "process": 11, "thread": 140314149652288}

{"asctime": "2024-09-01 17:14:48,182", "levelname": "INFO", "message": "Tracing request: GET /api/v1/histories", "name": "app.main", "filename": "main.py", "lineno": 63, "module": "main", "funcName": "dispatch", "process": 11, "thread": 140314149652288, "client-ip": "10.42.0.113", "path": "/api/v1/histories", "user-agent": "Mozilla/5.0 (Windows NT 10.0; Win64; x64) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/128.0.0.0 Safari/537.36 Edg/128.0.0.0", "response-time": 325.88672637939453, "response-code": 200}

{"asctime": "2024-09-01 17:14:48,183", "levelname": "INFO", "message": "10.42.0.113:53896 - \"GET /api/v1/histories?filter_by=all&items_per_page=10&page=1 HTTP/1.1\" 200", "name": "uvicorn.access", "filename": "h11_impl.py", "lineno": 498, "module": "h11_impl", "funcName": "send", "process": 11, "thread": 140314149652288}

{"asctime": "2024-09-01 17:14:54,150", "levelname": "INFO", "message": "10.42.0.113:53932 - \"OPTIONS /api/v1/voice-library/all?items_per_page=500&favorite=1 HTTP/1.1\" 200", "name": "uvicorn.access", "filename": "h11_impl.py", "lineno": 498, "module": "h11_impl", "funcName": "send", "process": 7, "thread": 140314149652288}

{"asctime": "2024-09-01 17:14:54,150", "levelname": "INFO", "message": "10.42.0.113:53924 - \"OPTIONS /api/v1/voice-library/all?items_per_page=500&voice_type=user_voice HTTP/1.1\" 200", "name": "uvicorn.access", "filename": "h11_impl.py", "lineno": 498, "module": "h11_impl", "funcName": "send", "process": 10, "thread": 140314149652288}

{"asctime": "2024-09-01 17:14:54,150", "levelname": "INFO", "message": "10.42.0.113:53946 - \"OPTIONS /api/v1/histories?filter_by=all&items_per_page=10&page=1 HTTP/1.1\" 200", "name": "uvicorn.access", "filename": "h11_impl.py", "lineno": 498, "module": "h11_impl", "funcName": "send", "process": 8, "thread": 140314149652288}

{"asctime": "2024-09-01 17:14:54,151", "levelname": "INFO", "message": "10.42.0.113:53922 - \"OPTIONS /api/v1/products HTTP/1.1\" 200", "name": "uvicorn.access", "filename": "h11_impl.py", "lineno": 498, "module": "h11_impl", "funcName": "send", "process": 9, "thread": 140314149652288}

{"asctime": "2024-09-01 17:14:54,153", "levelname": "INFO", "message": "10.42.0.113:53962 - \"OPTIONS /api/v1/voice-library/all?items_per_page=500&voice_type=system_voice HTTP/1.1\" 200", "name": "uvicorn.access", "filename": "h11_impl.py", "lineno": 498, "module": "h11_impl", "funcName": "send", "process": 9, "thread": 140314149652288}

{"asctime": "2024-09-01 17:14:55,516", "levelname": "INFO", "message": "Tracing request: GET /api/v1/products", "name": "app.main", "filename": "main.py", "lineno": 63, "module": "main", "funcName": "dispatch", "process": 10, "thread": 140314149652288, "client-ip": "10.42.0.113", "path": "/api/v1/products", "user-agent": "Mozilla/5.0 (Windows NT 10.0; Win64; x64) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/128.0.0.0 Safari/537.36 Edg/128.0.0.0", "response-time": 1031.2418937683105, "response-code": 200}

{"asctime": "2024-09-01 17:14:55,517", "levelname": "INFO", "message": "10.42.0.113:53924 - \"GET /api/v1/products HTTP/1.1\" 200", "name": "uvicorn.access", "filename": "h11_impl.py", "lineno": 498, "module": "h11_impl", "funcName": "send", "process": 10, "thread": 140314149652288}

token: ****************************************************************************************************2LTcyZmI3MjQyOWYzZSJ9.sVfgGqqFsI8bmZG5B1Dq9ou3BbZ66wMHELYFCzBXSPw

{"asctime": "2024-09-01 17:14:55,621", "levelname": "INFO", "message": "Init key service with priorities: [94, 96, 97]", "name": "app.tts_common.services.key_service", "filename": "key_service.py", "lineno": 28, "module": "key_service", "funcName": "__init__", "process": 7, "thread": 140314003539712}

{"asctime": "2024-09-01 17:14:55,622", "levelname": "INFO", "message": "Getting cache key voice-library::204::system_voice::False::1::500", "name": "app.api.api_v1.endpoints.cache", "filename": "cache.py", "lineno": 20, "module": "cache", "funcName": "get_cache", "process": 7, "thread": 140314149652288}

{"asctime": "2024-09-01 17:14:55,625", "levelname": "INFO", "message": "Cache miss", "name": "app.api.api_v1.endpoints.cache", "filename": "cache.py", "lineno": 76, "module": "cache", "funcName": "wrapper", "process": 7, "thread": 140314149652288}

token: ****************************************************************************************************2LTcyZmI3MjQyOWYzZSJ9.sVfgGqqFsI8bmZG5B1Dq9ou3BbZ66wMHELYFCzBXSPw

token: ****************************************************************************************************2LTcyZmI3MjQyOWYzZSJ9.sVfgGqqFsI8bmZG5B1Dq9ou3BbZ66wMHELYFCzBXSPw

{"asctime": "2024-09-01 17:14:55,645", "levelname": "INFO", "message": "Init key service with priorities: [94, 96, 97]", "name": "app.tts_common.services.key_service", "filename": "key_service.py", "lineno": 28, "module": "key_service", "funcName": "__init__", "process": 9, "thread": 140313995151104}

{"asctime": "2024-09-01 17:14:55,647", "levelname": "INFO", "message": "Getting cache key voice-library::204::user_voice::False::1::500", "name": "app.api.api_v1.endpoints.cache", "filename": "cache.py", "lineno": 20, "module": "cache", "funcName": "get_cache", "process": 9, "thread": 140314149652288}

{"asctime": "2024-09-01 17:14:55,647", "levelname": "INFO", "message": "Init key service with priorities: [94, 96, 97]", "name": "app.tts_common.services.key_service", "filename": "key_service.py", "lineno": 28, "module": "key_service", "funcName": "__init__", "process": 9, "thread": 140314003543808}

{"asctime": "2024-09-01 17:14:55,714", "levelname": "INFO", "message": "Getting cache key voice-library::204::None::True::1::500", "name": "app.api.api_v1.endpoints.cache", "filename": "cache.py", "lineno": 20, "module": "cache", "funcName": "get_cache", "process": 9, "thread": 140314149652288}

{"asctime": "2024-09-01 17:14:55,715", "levelname": "INFO", "message": "Cache miss", "name": "app.api.api_v1.endpoints.cache", "filename": "cache.py", "lineno": 76, "module": "cache", "funcName": "wrapper", "process": 9, "thread": 140314149652288}

{"asctime": "2024-09-01 17:14:55,744", "levelname": "INFO", "message": "processing time via db: 0.09747147560119629", "name": "app.api.api_v1.endpoints.cache", "filename": "cache.py", "lineno": 80, "module": "cache", "funcName": "wrapper", "process": 9, "thread": 140314149652288}

{"asctime": "2024-09-01 17:14:55,814", "levelname": "INFO", "message": "Tracing request: GET /api/v1/voice-library/all", "name": "app.main", "filename": "main.py", "lineno": 63, "module": "main", "funcName": "dispatch", "process": 9, "thread": 140314149652288, "client-ip": "10.42.0.113", "path": "/api/v1/voice-library/all", "user-agent": "Mozilla/5.0 (Windows NT 10.0; Win64; x64) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/128.0.0.0 Safari/537.36 Edg/128.0.0.0", "response-time": 1326.6758918762207, "response-code": 200}

{"asctime": "2024-09-01 17:14:55,815", "levelname": "INFO", "message": "10.42.0.113:53922 - \"GET /api/v1/voice-library/all?items_per_page=500&voice_type=user_voice HTTP/1.1\" 200", "name": "uvicorn.access", "filename": "h11_impl.py", "lineno": 498, "module": "h11_impl", "funcName": "send", "process": 9, "thread": 140314149652288}

{"asctime": "2024-09-01 17:14:55,817", "levelname": "INFO", "message": "Cache miss", "name": "app.api.api_v1.endpoints.cache", "filename": "cache.py", "lineno": 76, "module": "cache", "funcName": "wrapper", "process": 9, "thread": 140314149652288}

{"asctime": "2024-09-01 17:14:55,837", "levelname": "INFO", "message": "processing time via db: 0.1236114501953125", "name": "app.api.api_v1.endpoints.cache", "filename": "cache.py", "lineno": 80, "module": "cache", "funcName": "wrapper", "process": 9, "thread": 140314149652288}

{"asctime": "2024-09-01 17:14:55,841", "levelname": "INFO", "message": "Tracing request: GET /api/v1/voice-library/all", "name": "app.main", "filename": "main.py", "lineno": 63, "module": "main", "funcName": "dispatch", "process": 9, "thread": 140314149652288, "client-ip": "10.42.0.113", "path": "/api/v1/voice-library/all", "user-agent": "Mozilla/5.0 (Windows NT 10.0; Win64; x64) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/128.0.0.0 Safari/537.36 Edg/128.0.0.0", "response-time": 1356.6038608551025, "response-code": 200}

{"asctime": "2024-09-01 17:14:55,843", "levelname": "INFO", "message": "10.42.0.113:53962 - \"GET /api/v1/voice-library/all?items_per_page=500&favorite=1 HTTP/1.1\" 200", "name": "uvicorn.access", "filename": "h11_impl.py", "lineno": 498, "module": "h11_impl", "funcName": "send", "process": 9, "thread": 140314149652288}

{"asctime": "2024-09-01 17:14:56,025", "levelname": "INFO", "message": "Tracing request: GET /api/v1/histories", "name": "app.main", "filename": "main.py", "lineno": 63, "module": "main", "funcName": "dispatch", "process": 8, "thread": 140314149652288, "client-ip": "10.42.0.113", "path": "/api/v1/histories", "user-agent": "Mozilla/5.0 (Windows NT 10.0; Win64; x64) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/128.0.0.0 Safari/537.36 Edg/128.0.0.0", "response-time": 1538.3338928222656, "response-code": 200}

{"asctime": "2024-09-01 17:14:56,026", "levelname": "INFO", "message": "10.42.0.113:53946 - \"GET /api/v1/histories?filter_by=all&items_per_page=10&page=1 HTTP/1.1\" 200", "name": "uvicorn.access", "filename": "h11_impl.py", "lineno": 498, "module": "h11_impl", "funcName": "send", "process": 8, "thread": 140314149652288}

{"asctime": "2024-09-01 17:14:56,425", "levelname": "INFO", "message": "10.42.0.113:53946 - \"OPTIONS /api/v1/story/detail/e9af4964-67b0-11ef-8486-dabf49e60d2d HTTP/1.1\" 200", "name": "uvicorn.access", "filename": "h11_impl.py", "lineno": 498, "module": "h11_impl", "funcName": "send", "process": 8, "thread": 140314149652288}

{"asctime": "2024-09-01 17:14:56,425", "levelname": "INFO", "message": "10.42.0.113:53962 - \"OPTIONS /api/v1/story/detail/c1616514-67b0-11ef-a706-4ee38dde040d HTTP/1.1\" 200", "name": "uvicorn.access", "filename": "h11_impl.py", "lineno": 498, "module": "h11_impl", "funcName": "send", "process": 9, "thread": 140314149652288}

{"asctime": "2024-09-01 17:14:56,426", "levelname": "INFO", "message": "10.42.0.113:53922 - \"OPTIONS /api/v1/story/detail/e0d45310-67a2-11ef-8348-72fb72429f3e HTTP/1.1\" 200", "name": "uvicorn.access", "filename": "h11_impl.py", "lineno": 498, "module": "h11_impl", "funcName": "send", "process": 9, "thread": 140314149652288}

{"asctime": "2024-09-01 17:14:56,833", "levelname": "INFO", "message": "Init key service with priorities: [94, 96, 97]", "name": "app.tts_common.services.key_service", "filename": "key_service.py", "lineno": 28, "module": "key_service", "funcName": "__init__", "process": 9, "thread": 140314003543808}

{"asctime": "2024-09-01 17:14:56,842", "levelname": "INFO", "message": "Init key service with priorities: [94, 96, 97]", "name": "app.tts_common.services.key_service", "filename": "key_service.py", "lineno": 28, "module": "key_service", "funcName": "__init__", "process": 8, "thread": 140314003539712}

{"asctime": "2024-09-01 17:14:56,918", "levelname": "INFO", "message": "Init key service with priorities: [94, 96, 97]", "name": "app.tts_common.services.key_service", "filename": "key_service.py", "lineno": 28, "module": "key_service", "funcName": "__init__", "process": 9, "thread": 140313995151104}

{"asctime": "2024-09-01 17:14:57,118", "levelname": "INFO", "message": "Tracing request: GET /api/v1/story/detail/e0d45310-67a2-11ef-8348-72fb72429f3e", "name": "app.main", "filename": "main.py", "lineno": 63, "module": "main", "funcName": "dispatch", "process": 8, "thread": 140314149652288, "client-ip": "10.42.0.113", "path": "/api/v1/story/detail/e0d45310-67a2-11ef-8348-72fb72429f3e", "user-agent": "Mozilla/5.0 (Windows NT 10.0; Win64; x64) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/128.0.0.0 Safari/537.36 Edg/128.0.0.0", "response-time": 348.6490249633789, "response-code": 200}

{"asctime": "2024-09-01 17:14:57,118", "levelname": "INFO", "message": "10.42.0.113:53946 - \"GET /api/v1/story/detail/e0d45310-67a2-11ef-8348-72fb72429f3e HTTP/1.1\" 200", "name": "uvicorn.access", "filename": "h11_impl.py", "lineno": 498, "module": "h11_impl", "funcName": "send", "process": 8, "thread": 140314149652288}

{"asctime": "2024-09-01 17:14:57,415", "levelname": "INFO", "message": "Tracing request: GET /api/v1/story/detail/e9af4964-67b0-11ef-8486-dabf49e60d2d", "name": "app.main", "filename": "main.py", "lineno": 63, "module": "main", "funcName": "dispatch", "process": 9, "thread": 140314149652288, "client-ip": "10.42.0.113", "path": "/api/v1/story/detail/e9af4964-67b0-11ef-8486-dabf49e60d2d", "user-agent": "Mozilla/5.0 (Windows NT 10.0; Win64; x64) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/128.0.0.0 Safari/537.36 Edg/128.0.0.0", "response-time": 645.9226608276367, "response-code": 200}

{"asctime": "2024-09-01 17:14:57,416", "levelname": "INFO", "message": "10.42.0.113:53922 - \"GET /api/v1/story/detail/e9af4964-67b0-11ef-8486-dabf49e60d2d HTTP/1.1\" 200", "name": "uvicorn.access", "filename": "h11_impl.py", "lineno": 498, "module": "h11_impl", "funcName": "send", "process": 9, "thread": 140314149652288}

{"asctime": "2024-09-01 17:14:57,417", "levelname": "INFO", "message": "Tracing request: GET /api/v1/story/detail/c1616514-67b0-11ef-a706-4ee38dde040d", "name": "app.main", "filename": "main.py", "lineno": 63, "module": "main", "funcName": "dispatch", "process": 9, "thread": 140314149652288, "client-ip": "10.42.0.113", "path": "/api/v1/story/detail/c1616514-67b0-11ef-a706-4ee38dde040d", "user-agent": "Mozilla/5.0 (Windows NT 10.0; Win64; x64) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/128.0.0.0 Safari/537.36 Edg/128.0.0.0", "response-time": 648.8058567047119, "response-code": 200}

{"asctime": "2024-09-01 17:14:57,418", "levelname": "INFO", "message": "10.42.0.113:53962 - \"GET /api/v1/story/detail/c1616514-67b0-11ef-a706-4ee38dde040d HTTP/1.1\" 200", "name": "uvicorn.access", "filename": "h11_impl.py", "lineno": 498, "module": "h11_impl", "funcName": "send", "process": 9, "thread": 140314149652288}

{"asctime": "2024-09-01 17:14:58,228", "levelname": "INFO", "message": "processing time via db: 2.606214761734009", "name": "app.api.api_v1.endpoints.cache", "filename": "cache.py", "lineno": 80, "module": "cache", "funcName": "wrapper", "process": 7, "thread": 140314149652288}

{"asctime": "2024-09-01 17:14:58,265", "levelname": "INFO", "message": "Tracing request: GET /api/v1/voice-library/all", "name": "app.main", "filename": "main.py", "lineno": 63, "module": "main", "funcName": "dispatch", "process": 7, "thread": 140314149652288, "client-ip": "10.42.0.113", "path": "/api/v1/voice-library/all", "user-agent": "Mozilla/5.0 (Windows NT 10.0; Win64; x64) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/128.0.0.0 Safari/537.36 Edg/128.0.0.0", "response-time": 3779.3896198272705, "response-code": 200}

{"asctime": "2024-09-01 17:14:58,266", "levelname": "INFO", "message": "10.42.0.113:53932 - \"GET /api/v1/voice-library/all?items_per_page=500&voice_type=system_voice HTTP/1.1\" 200", "name": "uvicorn.access", "filename": "h11_impl.py", "lineno": 498, "module": "h11_impl", "funcName": "send", "process": 7, "thread": 140314149652288}

{"asctime": "2024-09-01 17:15:07,309", "levelname": "INFO", "message": "Tracing request: GET /api/v1/products", "name": "app.main", "filename": "main.py", "lineno": 63, "module": "main", "funcName": "dispatch", "process": 8, "thread": 140314149652288, "client-ip": "10.42.0.113", "path": "/api/v1/products", "user-agent": "HetrixTools Uptime Monitoring Bot. https://hetrix.tools/uptime-monitoring-bot.html", "response-time": 29.73318099975586, "response-code": 200}

{"asctime": "2024-09-01 17:15:07,310", "levelname": "INFO", "message": "10.42.0.113:51206 - \"GET /api/v1/products HTTP/1.1\" 200", "name": "uvicorn.access", "filename": "h11_impl.py", "lineno": 498, "module": "h11_impl", "funcName": "send", "process": 8, "thread": 140314149652288}

{"asctime": "2024-09-01 17:15:07,977", "levelname": "INFO", "message": "Tracing request: GET /api/v1/products", "name": "app.main", "filename": "main.py", "lineno": 63, "module": "main", "funcName": "dispatch", "process": 10, "thread": 140314149652288, "client-ip": "10.42.0.113", "path": "/api/v1/products", "user-agent": "HetrixTools Uptime Monitoring Bot. https://hetrix.tools/uptime-monitoring-bot.html", "response-time": 10.756254196166992, "response-code": 200}

{"asctime": "2024-09-01 17:15:07,978", "levelname": "INFO", "message": "10.42.0.113:51214 - \"GET /api/v1/products HTTP/1.1\" 200", "name": "uvicorn.access", "filename": "h11_impl.py", "lineno": 498, "module": "h11_impl", "funcName": "send", "process": 10, "thread": 140314149652288}

{"asctime": "2024-09-01 17:15:13,510", "levelname": "INFO", "message": "10.42.0.113:51226 - \"OPTIONS /api/v1/story/block/0f1c42c6-576d-4fb1-b735-24f54e3e2396/retry-speech HTTP/1.1\" 200", "name": "uvicorn.access", "filename": "h11_impl.py", "lineno": 498, "module": "h11_impl", "funcName": "send", "process": 11, "thread": 140314149652288}

{"asctime": "2024-09-01 17:15:13,843", "levelname": "INFO", "message": "Init key service with priorities: [94, 96, 97]", "name": "app.tts_common.services.key_service", "filename": "key_service.py", "lineno": 28, "module": "key_service", "funcName": "__init__", "process": 11, "thread": 140313628768000}

{"asctime": "2024-09-01 17:15:13,845", "levelname": "INFO", "message": "route: /story/block/0f1c42c6-576d-4fb1-b735-24f54e3e2396/retry-speech", "name": "app.api.api_v1.endpoints.story", "filename": "story.py", "lineno": 108, "module": "story", "funcName": "retry_speech_story_block_detail_by_uuid", "process": 11, "thread": 140314149652288}

{"asctime": "2024-09-01 17:15:13,867", "levelname": "INFO", "message": "current_model: tts-1-hd", "name": "app.tts_common.services.story_service", "filename": "story_service.py", "lineno": 722, "module": "story_service", "funcName": "retry_speech_single_block", "process": 11, "thread": 140314149652288}

{"asctime": "2024-09-01 17:15:13,882", "levelname": "INFO", "message": "block absolute_credit: 5004", "name": "app.tts_common.services.story_service", "filename": "story_service.py", "lineno": 767, "module": "story_service", "funcName": "retry_speech_single_block", "process": 11, "thread": 140314149652288}

{"asctime": "2024-09-01 17:15:13,888", "levelname": "INFO", "message": "running_estimated_credits: 0", "name": "app.tts_common.services.story_service", "filename": "story_service.py", "lineno": 774, "module": "story_service", "funcName": "retry_speech_single_block", "process": 11, "thread": 140314149652288}

{"asctime": "2024-09-01 17:15:13,888", "levelname": "INFO", "message": "estimated_credits: 2502", "name": "app.tts_common.services.story_service", "filename": "story_service.py", "lineno": 775, "module": "story_service", "funcName": "retry_speech_single_block", "process": 11, "thread": 140314149652288}

{"asctime": "2024-09-01 17:15:13,888", "levelname": "INFO", "message": "locked_credit: 2502", "name": "app.tts_common.services.story_service", "filename": "story_service.py", "lineno": 777, "module": "story_service", "funcName": "retry_speech_single_block", "process": 11, "thread": 140314149652288}

{"asctime": "2024-09-01 17:15:13,942", "levelname": "INFO", "message": "setup_api_key_and_client of model: tts-1-hd", "name": "app.tts_common.services.key_service", "filename": "key_service.py", "lineno": 54, "module": "key_service", "funcName": "setup_api_key_and_client", "process": 11, "thread": 140314149652288}

{"asctime": "2024-09-01 17:15:13,977", "levelname": "INFO", "message": "Finish setup_api_key_and_client of model: priority: 94, version:tts-1-hd key_type: AZURE, https://hadykdfyaatt.openai.azure.com/, 2024-02-15-preview, tts-hd", "name": "app.tts_common.services.key_service", "filename": "key_service.py", "lineno": 109, "module": "key_service", "funcName": "setup_api_key_and_client", "process": 11, "thread": 140314149652288}

{"asctime": "2024-09-01 17:15:13,978", "levelname": "INFO", "message": "Try request_text_openai_by_piece 1/3", "name": "app.tts_common.services.story_service", "filename": "story_service.py", "lineno": 275, "module": "story_service", "funcName": "request_text_openai_by_piece", "process": 11, "thread": 140314149652288}

{"asctime": "2024-09-01 17:15:13,978", "levelname": "INFO", "message": "Requesting openAI key: ********************c234a4e25e04", "name": "app.tts_common.services.story_service", "filename": "story_service.py", "lineno": 278, "module": "story_service", "funcName": "request_text_openai_by_piece", "process": 11, "thread": 140314149652288}

{"asctime": "2024-09-01 17:15:13,978", "levelname": "INFO", "message": "Requesting openAI base_url: https://hadykdfyaatt.openai.azure.com//openai/deployments/tts-hd/", "name": "app.tts_common.services.story_service", "filename": "story_service.py", "lineno": 279, "module": "story_service", "funcName": "request_text_openai_by_piece", "process": 11, "thread": 140314149652288}

{"asctime": "2024-09-01 17:15:21,033", "levelname": "INFO", "message": "HTTP Request: POST https://hadykdfyaatt.openai.azure.com//openai/deployments/tts-hd/audio/speech?api-version=2024-02-15-preview \"HTTP/1.1 200 OK\"", "name": "httpx", "filename": "_client.py", "lineno": 1027, "module": "_client", "funcName": "_send_single_request", "process": 11, "thread": 140314149652288}

{"asctime": "2024-09-01 17:15:23,145", "levelname": "INFO", "message": "Tracing request: GET /api/v1/products", "name": "app.main", "filename": "main.py", "lineno": 63, "module": "main", "funcName": "dispatch", "process": 10, "thread": 140314149652288, "client-ip": "10.42.0.113", "path": "/api/v1/products", "user-agent": "HetrixTools Uptime Monitoring Bot. https://hetrix.tools/uptime-monitoring-bot.html", "response-time": 18.553495407104492, "response-code": 200}

{"asctime": "2024-09-01 17:15:23,146", "levelname": "INFO", "message": "10.42.0.113:33642 - \"GET /api/v1/products HTTP/1.1\" 200", "name": "uvicorn.access", "filename": "h11_impl.py", "lineno": 498, "module": "h11_impl", "funcName": "send", "process": 10, "thread": 140314149652288}

{"asctime": "2024-09-01 17:15:26,063", "levelname": "INFO", "message": "Tracing request: GET /api/v1/products", "name": "app.main", "filename": "main.py", "lineno": 63, "module": "main", "funcName": "dispatch", "process": 10, "thread": 140314149652288, "client-ip": "10.42.0.113", "path": "/api/v1/products", "user-agent": "HetrixTools Uptime Monitoring Bot. https://hetrix.tools/uptime-monitoring-bot.html", "response-time": 9.058952331542969, "response-code": 200}

{"asctime": "2024-09-01 17:15:26,064", "levelname": "INFO", "message": "10.42.0.113:33380 - \"GET /api/v1/products HTTP/1.1\" 200", "name": "uvicorn.access", "filename": "h11_impl.py", "lineno": 498, "module": "h11_impl", "funcName": "send", "process": 10, "thread": 140314149652288}

{"asctime": "2024-09-01 17:16:05,916", "levelname": "INFO", "message": "Tracing request: GET /api/v1/products", "name": "app.main", "filename": "main.py", "lineno": 63, "module": "main", "funcName": "dispatch", "process": 10, "thread": 140314149652288, "client-ip": "10.42.0.113", "path": "/api/v1/products", "user-agent": "HetrixTools Uptime Monitoring Bot. https://hetrix.tools/uptime-monitoring-bot.html", "response-time": 22.71747589111328, "response-code": 200}

{"asctime": "2024-09-01 17:16:05,917", "levelname": "INFO", "message": "10.42.0.113:37302 - \"GET /api/v1/products HTTP/1.1\" 200", "name": "uvicorn.access", "filename": "h11_impl.py", "lineno": 498, "module": "h11_impl", "funcName": "send", "process": 10, "thread": 140314149652288}

{"asctime": "2024-09-01 17:16:08,668", "levelname": "INFO", "message": "Tracing request: GET /api/v1/products", "name": "app.main", "filename": "main.py", "lineno": 63, "module": "main", "funcName": "dispatch", "process": 10, "thread": 140314149652288, "client-ip": "10.42.0.113", "path": "/api/v1/products", "user-agent": "HetrixTools Uptime Monitoring Bot. https://hetrix.tools/uptime-monitoring-bot.html", "response-time": 11.587858200073242, "response-code": 200}

{"asctime": "2024-09-01 17:16:08,668", "levelname": "INFO", "message": "10.42.0.113:37316 - \"GET /api/v1/products HTTP/1.1\" 200", "name": "uvicorn.access", "filename": "h11_impl.py", "lineno": 498, "module": "h11_impl", "funcName": "send", "process": 10, "thread": 140314149652288}

{"asctime": "2024-09-01 17:16:11,303", "levelname": "INFO", "message": "Tracing request: GET /api/v1/products", "name": "app.main", "filename": "main.py", "lineno": 63, "module": "main", "funcName": "dispatch", "process": 9, "thread": 140314149652288, "client-ip": "10.42.0.113", "path": "/api/v1/products", "user-agent": "HetrixTools Uptime Monitoring Bot. https://hetrix.tools/uptime-monitoring-bot.html", "response-time": 23.406267166137695, "response-code": 200}

{"asctime": "2024-09-01 17:16:11,304", "levelname": "INFO", "message": "10.42.0.113:37332 - \"GET /api/v1/products HTTP/1.1\" 200", "name": "uvicorn.access", "filename": "h11_impl.py", "lineno": 498, "module": "h11_impl", "funcName": "send", "process": 9, "thread": 140314149652288}

{"asctime": "2024-09-01 17:16:13,863", "levelname": "INFO", "message": "Init key service with priorities: [94, 96, 97]", "name": "app.tts_common.services.key_service", "filename": "key_service.py", "lineno": 28, "module": "key_service", "funcName": "__init__", "process": 10, "thread": 140314003539712}

{"asctime": "2024-09-01 17:16:13,864", "levelname": "INFO", "message": "route: /story/block/0f1c42c6-576d-4fb1-b735-24f54e3e2396/retry-speech", "name": "app.api.api_v1.endpoints.story", "filename": "story.py", "lineno": 108, "module": "story", "funcName": "retry_speech_story_block_detail_by_uuid", "process": 10, "thread": 140314149652288}

{"asctime": "2024-09-01 17:16:13,882", "levelname": "INFO", "message": "current_model: tts-1-hd", "name": "app.tts_common.services.story_service", "filename": "story_service.py", "lineno": 722, "module": "story_service", "funcName": "retry_speech_single_block", "process": 10, "thread": 140314149652288}

{"asctime": "2024-09-01 17:16:13,913", "levelname": "INFO", "message": "running_estimated_credits: 0", "name": "app.tts_common.services.story_service", "filename": "story_service.py", "lineno": 774, "module": "story_service", "funcName": "retry_speech_single_block", "process": 10, "thread": 140314149652288}

{"asctime": "2024-09-01 17:16:13,914", "levelname": "INFO", "message": "estimated_credits: 0", "name": "app.tts_common.services.story_service", "filename": "story_service.py", "lineno": 775, "module": "story_service", "funcName": "retry_speech_single_block", "process": 10, "thread": 140314149652288}

{"asctime": "2024-09-01 17:16:13,914", "levelname": "INFO", "message": "locked_credit: 0", "name": "app.tts_common.services.story_service", "filename": "story_service.py", "lineno": 777, "module": "story_service", "funcName": "retry_speech_single_block", "process": 10, "thread": 140314149652288}

{"asctime": "2024-09-01 17:16:13,955", "levelname": "INFO", "message": "setup_api_key_and_client of model: tts-1-hd", "name": "app.tts_common.services.key_service", "filename": "key_service.py", "lineno": 54, "module": "key_service", "funcName": "setup_api_key_and_client", "process": 10, "thread": 140314149652288}

{"asctime": "2024-09-01 17:16:13,991", "levelname": "INFO", "message": "Finish setup_api_key_and_client of model: priority: 94, version:tts-1-hd key_type: AZURE, https://hahykkdbbb.openai.azure.com/, 2024-02-15-preview, tts-hd", "name": "app.tts_common.services.key_service", "filename": "key_service.py", "lineno": 109, "module": "key_service", "funcName": "setup_api_key_and_client", "process": 10, "thread": 140314149652288}

{"asctime": "2024-09-01 17:16:13,991", "levelname": "INFO", "message": "Try request_text_openai_by_piece 1/3", "name": "app.tts_common.services.story_service", "filename": "story_service.py", "lineno": 275, "module": "story_service", "funcName": "request_text_openai_by_piece", "process": 10, "thread": 140314149652288}

{"asctime": "2024-09-01 17:16:13,992", "levelname": "INFO", "message": "Requesting openAI key: ********************5a3e7a90e071", "name": "app.tts_common.services.story_service", "filename": "story_service.py", "lineno": 278, "module": "story_service", "funcName": "request_text_openai_by_piece", "process": 10, "thread": 140314149652288}

{"asctime": "2024-09-01 17:16:13,992", "levelname": "INFO", "message": "Requesting openAI base_url: https://hahykkdbbb.openai.azure.com//openai/deployments/tts-hd/", "name": "app.tts_common.services.story_service", "filename": "story_service.py", "lineno": 279, "module": "story_service", "funcName": "request_text_openai_by_piece", "process": 10, "thread": 140314149652288}

{"asctime": "2024-09-01 17:16:16,401", "levelname": "INFO", "message": "Tracing request: GET /api/v1/products", "name": "app.main", "filename": "main.py", "lineno": 63, "module": "main", "funcName": "dispatch", "process": 8, "thread": 140314149652288, "client-ip": "10.42.0.113", "path": "/api/v1/products", "user-agent": "HetrixTools Uptime Monitoring Bot. https://hetrix.tools/uptime-monitoring-bot.html", "response-time": 22.203445434570312, "response-code": 200}

{"asctime": "2024-09-01 17:16:16,402", "levelname": "INFO", "message": "10.42.0.113:34252 - \"GET /api/v1/products HTTP/1.1\" 200", "name": "uvicorn.access", "filename": "h11_impl.py", "lineno": 498, "module": "h11_impl", "funcName": "send", "process": 8, "thread": 140314149652288}

{"asctime": "2024-09-01 17:16:21,005", "levelname": "INFO", "message": "HTTP Request: POST https://hahykkdbbb.openai.azure.com//openai/deployments/tts-hd/audio/speech?api-version=2024-02-15-preview \"HTTP/1.1 200 OK\"", "name": "httpx", "filename": "_client.py", "lineno": 1027, "module": "_client", "funcName": "_send_single_request", "process": 10, "thread": 140314149652288}

stream_to_file from openAI /tmp/flare_uploaded/204/20240901_081513_940150/Mỗi chúng ta khi sinh ra đời chúng ta._14077_retry.mp3

output_file_path /tmp/flare_uploaded/204/20240901_081513_940150/Mỗi chúng ta khi sinh ra đời chúng ta._14077_retry.mp3

The file /tmp/flare_uploaded/204/20240901_081513_940150/Mỗi chúng ta khi sinh ra đời chúng ta._14077_retry.mp3 exists. exiting waiting block 0f1c42c6-576d-4fb1-b735-24f54e3e2396

{"asctime": "2024-09-01 17:16:22,250", "levelname": "INFO", "message": "voice_library: id-PE0004 type system_voice", "name": "app.tts_common.services.story_service", "filename": "story_service.py", "lineno": 802, "module": "story_service", "funcName": "retry_speech_single_block", "process": 11, "thread": 140314149652288}

{"asctime": "2024-09-01 17:16:23,025", "levelname": "INFO", "message": "Successfully upload /tmp/flare_uploaded/204/20240901_081513_940150/M\u1ed7i ch\u00fang ta khi sinh ra \u0111\u1eddi ch\u00fang ta._14077_retry.mp3 to s3 bucket cdk-ttsopenai-gpt-dev-upload-bucket in flare_uploaded/204/20240901_081513_940150/M\u1ed7i ch\u00fang ta khi sinh ra \u0111\u1eddi ch\u00fang ta._14077_retry.mp3", "name": "app.tts_common.services.s3_client", "filename": "s3_client.py", "lineno": 51, "module": "s3_client", "funcName": "upload_file_to_s3", "process": 11, "thread": 140314149652288}

{"asctime": "2024-09-01 17:16:23,055", "levelname": "INFO", "message": "START block_process_inference ...", "name": "app.tts_common.helpers.tts_history_helper", "filename": "tts_history_helper.py", "lineno": 145, "module": "tts_history_helper", "funcName": "block_process_inference", "process": 11, "thread": 140314149652288}

{"asctime": "2024-09-01 17:16:23,118", "levelname": "INFO", "message": "Sending message to sqs", "name": "app.tts_common.helpers.tts_history_helper", "filename": "tts_history_helper.py", "lineno": 178, "module": "tts_history_helper", "funcName": "block_process_inference", "process": 11, "thread": 140314149652288}

{"asctime": "2024-09-01 17:16:23,118", "levelname": "INFO", "message": "", "name": "app.tts_common.helpers.tts_history_helper", "filename": "tts_history_helper.py", "lineno": 179, "module": "tts_history_helper", "funcName": "block_process_inference", "process": 11, "thread": 140314149652288, "trace_id": "0f1c42c6-576d-4fb1-b735-24f54e3e2396", "training_type": "sovit", "type": "SYSTEM_VOICE", "speaker": 4, "input_audio_path": "flare_uploaded/204/20240901_081513_940150/M\u1ed7i ch\u00fang ta khi sinh ra \u0111\u1eddi ch\u00fang ta._14077_retry.mp3", "output_audio_path": "flare_uploaded/204/20240901_081513_940150/M\u1ed7i ch\u00fang ta khi sinh ra \u0111\u1eddi ch\u00fang ta._14077_retry_inferred.mp3", "callback_endpoint": "https://api-dev.ttsopenai.com/api/v1/voice-library/webhook/inference/0f1c42c6-576d-4fb1-b735-24f54e3e2396"}

{"asctime": "2024-09-01 17:16:23,294", "levelname": "INFO", "message": "Message sent, response ...", "name": "app.tts_common.helpers.tts_history_helper", "filename": "tts_history_helper.py", "lineno": 184, "module": "tts_history_helper", "funcName": "block_process_inference", "process": 11, "thread": 140314149652288}

{"asctime": "2024-09-01 17:16:23,294", "levelname": "INFO", "message": "{\"MD5OfMessageBody\": \"827ffd72f3e16c6c8a3264e02cf09b69\", \"MessageId\": \"5cbe08d4-0ff2-4711-a85c-e653641a6705\", \"ResponseMetadata\": {\"RequestId\": \"43725f03-d994-5add-ae55-004dfc83df9d\", \"HTTPStatusCode\": 200, \"HTTPHeaders\": {\"x-amzn-requestid\": \"43725f03-d994-5add-ae55-004dfc83df9d\", \"date\": \"Sun, 01 Sep 2024 08:16:23 GMT\", \"content-type\": \"text/xml\", \"content-length\": \"378\", \"connection\": \"keep-alive\"}, \"RetryAttempts\": 0}}", "name": "app.tts_common.helpers.tts_history_helper", "filename": "tts_history_helper.py", "lineno": 185, "module": "tts_history_helper", "funcName": "block_process_inference", "process": 11, "thread": 140314149652288}

{"asctime": "2024-09-01 17:16:23,307", "levelname": "INFO", "message": "Tracing request: PUT /api/v1/story/block/0f1c42c6-576d-4fb1-b735-24f54e3e2396/retry-speech", "name": "app.main", "filename": "main.py", "lineno": 63, "module": "main", "funcName": "dispatch", "process": 11, "thread": 140314149652288, "client-ip": "10.42.0.113", "path": "/api/v1/story/block/0f1c42c6-576d-4fb1-b735-24f54e3e2396/retry-speech", "user-agent": "Mozilla/5.0 (Windows NT 10.0; Win64; x64) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/128.0.0.0 Safari/537.36 Edg/128.0.0.0", "response-time": 69509.58204269409, "response-code": 200}

{"asctime": "2024-09-01 17:17:01,536", "levelname": "INFO", "message": "Init key service with priorities: [94, 96, 97]", "name": "app.tts_common.services.key_service", "filename": "key_service.py", "lineno": 28, "module": "key_service", "funcName": "__init__", "process": 7, "thread": 140314003539712}

{"asctime": "2024-09-01 17:17:01,540", "levelname": "INFO", "message": "route /voice-library/webhook/inference/0f1c42c6-576d-4fb1-b735-24f54e3e2396", "name": "app.api.api_v1.endpoints.voice_library", "filename": "voice_library.py", "lineno": 122, "module": "voice_library", "funcName": "voice_inference_webhook", "process": 7, "thread": 140314149652288}

{"asctime": "2024-09-01 17:17:01,541", "levelname": "INFO", "message": "request body:", "name": "app.api.api_v1.endpoints.voice_library", "filename": "voice_library.py", "lineno": 125, "module": "voice_library", "funcName": "voice_inference_webhook", "process": 7, "thread": 140314149652288}

{"asctime": "2024-09-01 17:17:01,542", "levelname": "INFO", "message": "", "name": "app.api.api_v1.endpoints.voice_library", "filename": "voice_library.py", "lineno": 126, "module": "voice_library", "funcName": "voice_inference_webhook", "process": 7, "thread": 140314149652288, "status": "completed", "code": 200, "error": null}

status: completed

{"asctime": "2024-09-01 17:17:01,599", "levelname": "INFO", "message": "START update_tts_text_by_story_block", "name": "app.tts_common.services.story_service", "filename": "story_service.py", "lineno": 588, "module": "story_service", "funcName": "update_tts_text_by_story_block", "process": 7, "thread": 140314149652288}

{"asctime": "2024-09-01 17:17:01,600", "levelname": "INFO", "message": "Processing tts-text e0d45310-67a2-11ef-8348-72fb72429f3e", "name": "app.tts_common.services.story_service", "filename": "story_service.py", "lineno": 589, "module": "story_service", "funcName": "update_tts_text_by_story_block", "process": 7, "thread": 140314149652288}

{"asctime": "2024-09-01 17:17:01,600", "levelname": "INFO", "message": "tts-text is COMPLETED", "name": "app.tts_common.services.story_service", "filename": "story_service.py", "lineno": 592, "module": "story_service", "funcName": "update_tts_text_by_story_block", "process": 7, "thread": 140314149652288}

{"asctime": "2024-09-01 17:17:01,600", "levelname": "INFO", "message": "stop update tts-text e0d45310-67a2-11ef-8348-72fb72429f3e", "name": "app.tts_common.services.story_service", "filename": "story_service.py", "lineno": 593, "module": "story_service", "funcName": "update_tts_text_by_story_block", "process": 7, "thread": 140314149652288}

{"asctime": "2024-09-01 17:17:01,600", "levelname": "INFO", "message": "START deduct_retry_speech_block_credit", "name": "app.tts_common.services.story_service", "filename": "story_service.py", "lineno": 926, "module": "story_service", "funcName": "deduct_retry_speech_block_credit", "process": 7, "thread": 140314149652288}

{"asctime": "2024-09-01 17:17:01,601", "levelname": "INFO", "message": "processing block: 0f1c42c6-576d-4fb1-b735-24f54e3e2396", "name": "app.tts_common.services.story_service", "filename": "story_service.py", "lineno": 927, "module": "story_service", "funcName": "deduct_retry_speech_block_credit", "process": 7, "thread": 140314149652288}

{"asctime": "2024-09-01 17:17:01,634", "levelname": "INFO", "message": "user_id:204 - plan_id:PP0001", "name": "app.tts_common.services.story_service", "filename": "story_service.py", "lineno": 941, "module": "story_service", "funcName": "deduct_retry_speech_block_credit", "process": 7, "thread": 140314149652288}

{"asctime": "2024-09-01 17:17:01,635", "levelname": "INFO", "message": "processing update block 14077 block_used_credit: 20016", "name": "app.tts_common.services.story_service", "filename": "story_service.py", "lineno": 944, "module": "story_service", "funcName": "deduct_retry_speech_block_credit", "process": 7, "thread": 140314149652288}

{"asctime": "2024-09-01 17:17:01,791", "levelname": "INFO", "message": "processing update story 3587 story_used_credit: 34986", "name": "app.tts_common.services.story_service", "filename": "story_service.py", "lineno": 951, "module": "story_service", "funcName": "deduct_retry_speech_block_credit", "process": 7, "thread": 140314149652288}

{"asctime": "2024-09-01 17:17:02,038", "levelname": "INFO", "message": "Deduct user:204 Amount:2502", "name": "app.tts_common.services.story_service", "filename": "story_service.py", "lineno": 957, "module": "story_service", "funcName": "deduct_retry_speech_block_credit", "process": 7, "thread": 140314149652288}

{"asctime": "2024-09-01 17:17:02,050", "levelname": "INFO", "message": "Deduct user's credits: 2502", "name": "app.tts_common.services.user", "filename": "user.py", "lineno": 130, "module": "user", "funcName": "deduct_user_credits", "process": 7, "thread": 140314149652288}

{"asctime": "2024-09-01 17:17:02,224", "levelname": "INFO", "message": "Update user's credits completed: ", "name": "app.tts_common.services.user", "filename": "user.py", "lineno": 155, "module": "user", "funcName": "deduct_user_credits", "process": 7, "thread": 140314149652288}

{"asctime": "2024-09-01 17:17:02,277", "levelname": "INFO", "message": "START recalculate_user_lock_credit ...", "name": "app.tts_common.services.story_service", "filename": "story_service.py", "lineno": 655, "module": "story_service", "funcName": "recalculate_user_lock_credit", "process": 7, "thread": 140314149652288}

{"asctime": "2024-09-01 17:17:02,340", "levelname": "INFO", "message": "Update locking credits: 0", "name": "app.tts_common.services.story_service", "filename": "story_service.py", "lineno": 659, "module": "story_service", "funcName": "recalculate_user_lock_credit", "process": 7, "thread": 140314149652288}

{"asctime": "2024-09-01 17:17:02,490", "levelname": "INFO", "message": "Tracing request: PUT /api/v1/voice-library/webhook/inference/0f1c42c6-576d-4fb1-b735-24f54e3e2396", "name": "app.main", "filename": "main.py", "lineno": 63, "module": "main", "funcName": "dispatch", "process": 7, "thread": 140314149652288, "client-ip": "10.42.0.113", "path": "/api/v1/voice-library/webhook/inference/0f1c42c6-576d-4fb1-b735-24f54e3e2396", "user-agent": "python-requests/2.31.0", "response-time": 996.3150024414062, "response-code": 200}

{"asctime": "2024-09-01 17:17:02,491", "levelname": "INFO", "message": "10.42.0.113:35518 - \"PUT /api/v1/voice-library/webhook/inference/0f1c42c6-576d-4fb1-b735-24f54e3e2396 HTTP/1.1\" 200", "name": "uvicorn.access", "filename": "h11_impl.py", "lineno": 498, "module": "h11_impl", "funcName": "send", "process": 7, "thread": 140314149652288}

{"asctime": "2024-09-01 17:17:06,992", "levelname": "INFO", "message": "Tracing request: GET /api/v1/products", "name": "app.main", "filename": "main.py", "lineno": 63, "module": "main", "funcName": "dispatch", "process": 9, "thread": 140314149652288, "client-ip": "10.42.0.113", "path": "/api/v1/products", "user-agent": "HetrixTools Uptime Monitoring Bot. https://hetrix.tools/uptime-monitoring-bot.html", "response-time": 43.39265823364258, "response-code": 200}

{"asctime": "2024-09-01 17:17:07,006", "levelname": "INFO", "message": "10.42.0.113:48334 - \"GET /api/v1/products HTTP/1.1\" 200", "name": "uvicorn.access", "filename": "h11_impl.py", "lineno": 498, "module": "h11_impl", "funcName": "send", "process": 9, "thread": 140314149652288}

{"asctime": "2024-09-01 17:17:13,032", "levelname": "INFO", "message": "Tracing request: GET /api/v1/products", "name": "app.main", "filename": "main.py", "lineno": 63, "module": "main", "funcName": "dispatch", "process": 9, "thread": 140314149652288, "client-ip": "10.42.0.113", "path": "/api/v1/products", "user-agent": "HetrixTools Uptime Monitoring Bot. https://hetrix.tools/uptime-monitoring-bot.html", "response-time": 10.348081588745117, "response-code": 200}

{"asctime": "2024-09-01 17:17:13,033", "levelname": "INFO", "message": "10.42.0.113:48348 - \"GET /api/v1/products HTTP/1.1\" 200", "name": "uvicorn.access", "filename": "h11_impl.py", "lineno": 498, "module": "h11_impl", "funcName": "send", "process": 9, "thread": 140314149652288}

{"asctime": "2024-09-01 17:17:13,836", "levelname": "INFO", "message": "Init key service with priorities: [94, 96, 97]", "name": "app.tts_common.services.key_service", "filename": "key_service.py", "lineno": 28, "module": "key_service", "funcName": "__init__", "process": 11, "thread": 140313628768000}

{"asctime": "2024-09-01 17:17:13,838", "levelname": "INFO", "message": "route: /story/block/0f1c42c6-576d-4fb1-b735-24f54e3e2396/retry-speech", "name": "app.api.api_v1.endpoints.story", "filename": "story.py", "lineno": 108, "module": "story", "funcName": "retry_speech_story_block_detail_by_uuid", "process": 11, "thread": 140314149652288}

{"asctime": "2024-09-01 17:17:13,847", "levelname": "INFO", "message": "current_model: tts-1-hd", "name": "app.tts_common.services.story_service", "filename": "story_service.py", "lineno": 722, "module": "story_service", "funcName": "retry_speech_single_block", "process": 11, "thread": 140314149652288}

{"asctime": "2024-09-01 17:17:13,868", "levelname": "INFO", "message": "block absolute_credit: 5004", "name": "app.tts_common.services.story_service", "filename": "story_service.py", "lineno": 767, "module": "story_service", "funcName": "retry_speech_single_block", "process": 11, "thread": 140314149652288}

{"asctime": "2024-09-01 17:17:13,874", "levelname": "INFO", "message": "running_estimated_credits: 0", "name": "app.tts_common.services.story_service", "filename": "story_service.py", "lineno": 774, "module": "story_service", "funcName": "retry_speech_single_block", "process": 11, "thread": 140314149652288}

{"asctime": "2024-09-01 17:17:13,875", "levelname": "INFO", "message": "estimated_credits: 2502", "name": "app.tts_common.services.story_service", "filename": "story_service.py", "lineno": 775, "module": "story_service", "funcName": "retry_speech_single_block", "process": 11, "thread": 140314149652288}

{"asctime": "2024-09-01 17:17:13,875", "levelname": "INFO", "message": "locked_credit: 2502", "name": "app.tts_common.services.story_service", "filename": "story_service.py", "lineno": 777, "module": "story_service", "funcName": "retry_speech_single_block", "process": 11, "thread": 140314149652288}

{"asctime": "2024-09-01 17:17:13,909", "levelname": "INFO", "message": "setup_api_key_and_client of model: tts-1-hd", "name": "app.tts_common.services.key_service", "filename": "key_service.py", "lineno": 54, "module": "key_service", "funcName": "setup_api_key_and_client", "process": 11, "thread": 140314149652288}

{"asctime": "2024-09-01 17:17:13,936", "levelname": "INFO", "message": "Finish setup_api_key_and_client of model: priority: 94, version:tts-1-hd key_type: AZURE, https://ttagsgasgssvv.openai.azure.com/, 2024-02-15-preview, tts-hd", "name": "app.tts_common.services.key_service", "filename": "key_service.py", "lineno": 109, "module": "key_service", "funcName": "setup_api_key_and_client", "process": 11, "thread": 140314149652288}

{"asctime": "2024-09-01 17:17:13,936", "levelname": "INFO", "message": "Try request_text_openai_by_piece 1/3", "name": "app.tts_common.services.story_service", "filename": "story_service.py", "lineno": 275, "module": "story_service", "funcName": "request_text_openai_by_piece", "process": 11, "thread": 140314149652288}

{"asctime": "2024-09-01 17:17:13,937", "levelname": "INFO", "message": "Requesting openAI key: ********************1b1f139fd859", "name": "app.tts_common.services.story_service", "filename": "story_service.py", "lineno": 278, "module": "story_service", "funcName": "request_text_openai_by_piece", "process": 11, "thread": 140314149652288}

{"asctime": "2024-09-01 17:17:13,937", "levelname": "INFO", "message": "Requesting openAI base_url: https://ttagsgasgssvv.openai.azure.com//openai/deployments/tts-hd/", "name": "app.tts_common.services.story_service", "filename": "story_service.py", "lineno": 279, "module": "story_service", "funcName": "request_text_openai_by_piece", "process": 11, "thread": 140314149652288}

{"asctime": "2024-09-01 17:17:18,166", "levelname": "INFO", "message": "Tracing request: GET /api/v1/products", "name": "app.main", "filename": "main.py", "lineno": 63, "module": "main", "funcName": "dispatch", "process": 9, "thread": 140314149652288, "client-ip": "10.42.0.113", "path": "/api/v1/products", "user-agent": "HetrixTools Uptime Monitoring Bot. https://hetrix.tools/uptime-monitoring-bot.html", "response-time": 18.15319061279297, "response-code": 200}

{"asctime": "2024-09-01 17:17:18,166", "levelname": "INFO", "message": "10.42.0.113:56026 - \"GET /api/v1/products HTTP/1.1\" 200", "name": "uvicorn.access", "filename": "h11_impl.py", "lineno": 498, "module": "h11_impl", "funcName": "send", "process": 9, "thread": 140314149652288}

{"asctime": "2024-09-01 17:17:20,900", "levelname": "INFO", "message": "HTTP Request: POST https://ttagsgasgssvv.openai.azure.com//openai/deployments/tts-hd/audio/speech?api-version=2024-02-15-preview \"HTTP/1.1 200 OK\"", "name": "httpx", "filename": "_client.py", "lineno": 1027, "module": "_client", "funcName": "_send_single_request", "process": 11, "thread": 140314149652288}

stream_to_file from openAI /tmp/flare_uploaded/204/20240901_081613_954102/Mỗi chúng ta khi sinh ra đời chúng ta._14077_retry.mp3

output_file_path /tmp/flare_uploaded/204/20240901_081613_954102/Mỗi chúng ta khi sinh ra đời chúng ta._14077_retry.mp3

The file /tmp/flare_uploaded/204/20240901_081613_954102/Mỗi chúng ta khi sinh ra đời chúng ta._14077_retry.mp3 exists. exiting waiting block 0f1c42c6-576d-4fb1-b735-24f54e3e2396

{"asctime": "2024-09-01 17:17:22,460", "levelname": "INFO", "message": "voice_library: id-PE0004 type system_voice", "name": "app.tts_common.services.story_service", "filename": "story_service.py", "lineno": 802, "module": "story_service", "funcName": "retry_speech_single_block", "process": 10, "thread": 140314149652288}

{"asctime": "2024-09-01 17:17:23,406", "levelname": "INFO", "message": "Successfully upload /tmp/flare_uploaded/204/20240901_081613_954102/M\u1ed7i ch\u00fang ta khi sinh ra \u0111\u1eddi ch\u00fang ta._14077_retry.mp3 to s3 bucket cdk-ttsopenai-gpt-dev-upload-bucket in flare_uploaded/204/20240901_081613_954102/M\u1ed7i ch\u00fang ta khi sinh ra \u0111\u1eddi ch\u00fang ta._14077_retry.mp3", "name": "app.tts_common.services.s3_client", "filename": "s3_client.py", "lineno": 51, "module": "s3_client", "funcName": "upload_file_to_s3", "process": 10, "thread": 140314149652288}

{"asctime": "2024-09-01 17:17:23,440", "levelname": "INFO", "message": "START block_process_inference ...", "name": "app.tts_common.helpers.tts_history_helper", "filename": "tts_history_helper.py", "lineno": 145, "module": "tts_history_helper", "funcName": "block_process_inference", "process": 10, "thread": 140314149652288}

{"asctime": "2024-09-01 17:17:23,504", "levelname": "INFO", "message": "Sending message to sqs", "name": "app.tts_common.helpers.tts_history_helper", "filename": "tts_history_helper.py", "lineno": 178, "module": "tts_history_helper", "funcName": "block_process_inference", "process": 10, "thread": 140314149652288}

{"asctime": "2024-09-01 17:17:23,504", "levelname": "INFO", "message": "", "name": "app.tts_common.helpers.tts_history_helper", "filename": "tts_history_helper.py", "lineno": 179, "module": "tts_history_helper", "funcName": "block_process_inference", "process": 10, "thread": 140314149652288, "trace_id": "0f1c42c6-576d-4fb1-b735-24f54e3e2396", "training_type": "sovit", "type": "SYSTEM_VOICE", "speaker": 4, "input_audio_path": "flare_uploaded/204/20240901_081613_954102/M\u1ed7i ch\u00fang ta khi sinh ra \u0111\u1eddi ch\u00fang ta._14077_retry.mp3", "output_audio_path": "flare_uploaded/204/20240901_081613_954102/M\u1ed7i ch\u00fang ta khi sinh ra \u0111\u1eddi ch\u00fang ta._14077_retry_inferred.mp3", "callback_endpoint": "https://api-dev.ttsopenai.com/api/v1/voice-library/webhook/inference/0f1c42c6-576d-4fb1-b735-24f54e3e2396"}

{"asctime": "2024-09-01 17:17:23,586", "levelname": "INFO", "message": "Message sent, response ...", "name": "app.tts_common.helpers.tts_history_helper", "filename": "tts_history_helper.py", "lineno": 184, "module": "tts_history_helper", "funcName": "block_process_inference", "process": 10, "thread": 140314149652288}

{"asctime": "2024-09-01 17:17:23,586", "levelname": "INFO", "message": "{\"MD5OfMessageBody\": \"006a5382967dce42fed73fdbe3ed0fc4\", \"MessageId\": \"4b051d72-7f48-4caf-af63-2567d9db8e05\", \"ResponseMetadata\": {\"RequestId\": \"88cc7e4d-2e9a-52c9-aa66-21030bc936b2\", \"HTTPStatusCode\": 200, \"HTTPHeaders\": {\"x-amzn-requestid\": \"88cc7e4d-2e9a-52c9-aa66-21030bc936b2\", \"date\": \"Sun, 01 Sep 2024 08:17:23 GMT\", \"content-type\": \"text/xml\", \"content-length\": \"378\", \"connection\": \"keep-alive\"}, \"RetryAttempts\": 0}}", "name": "app.tts_common.helpers.tts_history_helper", "filename": "tts_history_helper.py", "lineno": 185, "module": "tts_history_helper", "funcName": "block_process_inference", "process": 10, "thread": 140314149652288}

{"asctime": "2024-09-01 17:17:23,597", "levelname": "INFO", "message": "Tracing request: PUT /api/v1/story/block/0f1c42c6-576d-4fb1-b735-24f54e3e2396/retry-speech", "name": "app.main", "filename": "main.py", "lineno": 63, "module": "main", "funcName": "dispatch", "process": 10, "thread": 140314149652288, "client-ip": "10.42.0.113", "path": "/api/v1/story/block/0f1c42c6-576d-4fb1-b735-24f54e3e2396/retry-speech", "user-agent": "Mozilla/5.0 (Windows NT 10.0; Win64; x64) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/128.0.0.0 Safari/537.36 Edg/128.0.0.0", "response-time": 69798.28953742981, "response-code": 200}

{"asctime": "2024-09-01 17:17:28,340", "levelname": "INFO", "message": "Tracing request: GET /api/v1/products", "name": "app.main", "filename": "main.py", "lineno": 63, "module": "main", "funcName": "dispatch", "process": 7, "thread": 140314149652288, "client-ip": "10.42.0.113", "path": "/api/v1/products", "user-agent": "HetrixTools Uptime Monitoring Bot. https://hetrix.tools/uptime-monitoring-bot.html", "response-time": 13.923168182373047, "response-code": 200}

{"asctime": "2024-09-01 17:17:28,341", "levelname": "INFO", "message": "10.42.0.113:49966 - \"GET /api/v1/products HTTP/1.1\" 200", "name": "uvicorn.access", "filename": "h11_impl.py", "lineno": 498, "module": "h11_impl", "funcName": "send", "process": 7, "thread": 140314149652288}

{"asctime": "2024-09-01 17:18:01,963", "levelname": "INFO", "message": "Init key service with priorities: [94, 96, 97]", "name": "app.tts_common.services.key_service", "filename": "key_service.py", "lineno": 28, "module": "key_service", "funcName": "__init__", "process": 9, "thread": 140313995151104}

{"asctime": "2024-09-01 17:18:01,968", "levelname": "INFO", "message": "route /voice-library/webhook/inference/0f1c42c6-576d-4fb1-b735-24f54e3e2396", "name": "app.api.api_v1.endpoints.voice_library", "filename": "voice_library.py", "lineno": 122, "module": "voice_library", "funcName": "voice_inference_webhook", "process": 9, "thread": 140314149652288}

{"asctime": "2024-09-01 17:18:01,969", "levelname": "INFO", "message": "request body:", "name": "app.api.api_v1.endpoints.voice_library", "filename": "voice_library.py", "lineno": 125, "module": "voice_library", "funcName": "voice_inference_webhook", "process": 9, "thread": 140314149652288}

{"asctime": "2024-09-01 17:18:01,969", "levelname": "INFO", "message": "", "name": "app.api.api_v1.endpoints.voice_library", "filename": "voice_library.py", "lineno": 126, "module": "voice_library", "funcName": "voice_inference_webhook", "process": 9, "thread": 140314149652288, "status": "completed", "code": 200, "error": null}

status: completed

{"asctime": "2024-09-01 17:18:01,994", "levelname": "INFO", "message": "START update_tts_text_by_story_block", "name": "app.tts_common.services.story_service", "filename": "story_service.py", "lineno": 588, "module": "story_service", "funcName": "update_tts_text_by_story_block", "process": 9, "thread": 140314149652288}

{"asctime": "2024-09-01 17:18:01,995", "levelname": "INFO", "message": "Processing tts-text e0d45310-67a2-11ef-8348-72fb72429f3e", "name": "app.tts_common.services.story_service", "filename": "story_service.py", "lineno": 589, "module": "story_service", "funcName": "update_tts_text_by_story_block", "process": 9, "thread": 140314149652288}

{"asctime": "2024-09-01 17:18:01,995", "levelname": "INFO", "message": "tts-text is COMPLETED", "name": "app.tts_common.services.story_service", "filename": "story_service.py", "lineno": 592, "module": "story_service", "funcName": "update_tts_text_by_story_block", "process": 9, "thread": 140314149652288}

{"asctime": "2024-09-01 17:18:01,995", "levelname": "INFO", "message": "stop update tts-text e0d45310-67a2-11ef-8348-72fb72429f3e", "name": "app.tts_common.services.story_service", "filename": "story_service.py", "lineno": 593, "module": "story_service", "funcName": "update_tts_text_by_story_block", "process": 9, "thread": 140314149652288}

{"asctime": "2024-09-01 17:18:01,995", "levelname": "INFO", "message": "START deduct_retry_speech_block_credit", "name": "app.tts_common.services.story_service", "filename": "story_service.py", "lineno": 926, "module": "story_service", "funcName": "deduct_retry_speech_block_credit", "process": 9, "thread": 140314149652288}

{"asctime": "2024-09-01 17:18:01,996", "levelname": "INFO", "message": "processing block: 0f1c42c6-576d-4fb1-b735-24f54e3e2396", "name": "app.tts_common.services.story_service", "filename": "story_service.py", "lineno": 927, "module": "story_service", "funcName": "deduct_retry_speech_block_credit", "process": 9, "thread": 140314149652288}

{"asctime": "2024-09-01 17:18:01,996", "levelname": "INFO", "message": "Stop deduct: 0f1c42c6-576d-4fb1-b735-24f54e3e2396, estimated_credit is 0", "name": "app.tts_common.services.story_service", "filename": "story_service.py", "lineno": 935, "module": "story_service", "funcName": "deduct_retry_speech_block_credit", "process": 9, "thread": 140314149652288}

{"asctime": "2024-09-01 17:18:02,004", "levelname": "INFO", "message": "START recalculate_user_lock_credit ...", "name": "app.tts_common.services.story_service", "filename": "story_service.py", "lineno": 655, "module": "story_service", "funcName": "recalculate_user_lock_credit", "process": 9, "thread": 140314149652288}

{"asctime": "2024-09-01 17:18:02,012", "levelname": "INFO", "message": "Update locking credits: 0", "name": "app.tts_common.services.story_service", "filename": "story_service.py", "lineno": 659, "module": "story_service", "funcName": "recalculate_user_lock_credit", "process": 9, "thread": 140314149652288}

{"asctime": "2024-09-01 17:18:02,074", "levelname": "INFO", "message": "Tracing request: PUT /api/v1/voice-library/webhook/inference/0f1c42c6-576d-4fb1-b735-24f54e3e2396", "name": "app.main", "filename": "main.py", "lineno": 63, "module": "main", "funcName": "dispatch", "process": 9, "thread": 140314149652288, "client-ip": "10.42.0.113", "path": "/api/v1/voice-library/webhook/inference/0f1c42c6-576d-4fb1-b735-24f54e3e2396", "user-agent": "python-requests/2.31.0", "response-time": 169.27337646484375, "response-code": 200}

{"asctime": "2024-09-01 17:18:02,074", "levelname": "INFO", "message": "10.42.0.113:42306 - \"PUT /api/v1/voice-library/webhook/inference/0f1c42c6-576d-4fb1-b735-24f54e3e2396 HTTP/1.1\" 200", "name": "uvicorn.access", "filename": "h11_impl.py", "lineno": 498, "module": "h11_impl", "funcName": "send", "process": 9, "thread": 140314149652288}

{"asctime": "2024-09-01 17:18:05,485", "levelname": "INFO", "message": "Tracing request: GET /api/v1/products", "name": "app.main", "filename": "main.py", "lineno": 63, "module": "main", "funcName": "dispatch", "process": 8, "thread": 140314149652288, "client-ip": "10.42.0.113", "path": "/api/v1/products", "user-agent": "HetrixTools Uptime Monitoring Bot. https://hetrix.tools/uptime-monitoring-bot.html", "response-time": 23.560523986816406, "response-code": 200}

{"asctime": "2024-09-01 17:18:05,486", "levelname": "INFO", "message": "10.42.0.113:52082 - \"GET /api/v1/products HTTP/1.1\" 200", "name": "uvicorn.access", "filename": "h11_impl.py", "lineno": 498, "module": "h11_impl", "funcName": "send", "process": 8, "thread": 140314149652288}

{"asctime": "2024-09-01 17:18:11,355", "levelname": "INFO", "message": "Tracing request: GET /api/v1/products", "name": "app.main", "filename": "main.py", "lineno": 63, "module": "main", "funcName": "dispatch", "process": 9, "thread": 140314149652288, "client-ip": "10.42.0.113", "path": "/api/v1/products", "user-agent": "HetrixTools Uptime Monitoring Bot. https://hetrix.tools/uptime-monitoring-bot.html", "response-time": 13.251543045043945, "response-code": 200}

{"asctime": "2024-09-01 17:18:11,356", "levelname": "INFO", "message": "10.42.0.113:52092 - \"GET /api/v1/products HTTP/1.1\" 200", "name": "uvicorn.access", "filename": "h11_impl.py", "lineno": 498, "module": "h11_impl", "funcName": "send", "process": 9, "thread": 140314149652288}

{"asctime": "2024-09-01 17:18:17,468", "levelname": "INFO", "message": "Tracing request: GET /api/v1/products", "name": "app.main", "filename": "main.py", "lineno": 63, "module": "main", "funcName": "dispatch", "process": 8, "thread": 140314149652288, "client-ip": "10.42.0.113", "path": "/api/v1/products", "user-agent": "HetrixTools Uptime Monitoring Bot. https://hetrix.tools/uptime-monitoring-bot.html", "response-time": 11.93094253540039, "response-code": 200}

{"asctime": "2024-09-01 17:18:17,469", "levelname": "INFO", "message": "10.42.0.113:59568 - \"GET /api/v1/products HTTP/1.1\" 200", "name": "uvicorn.access", "filename": "h11_impl.py", "lineno": 498, "module": "h11_impl", "funcName": "send", "process": 8, "thread": 140314149652288}

{"asctime": "2024-09-01 17:18:18,676", "levelname": "INFO", "message": "Tracing request: GET /api/v1/products", "name": "app.main", "filename": "main.py", "lineno": 63, "module": "main", "funcName": "dispatch", "process": 9, "thread": 140314149652288, "client-ip": "10.42.0.113", "path": "/api/v1/products", "user-agent": "HetrixTools Uptime Monitoring Bot. https://hetrix.tools/uptime-monitoring-bot.html", "response-time": 14.203310012817383, "response-code": 200}

{"asctime": "2024-09-01 17:18:18,678", "levelname": "INFO", "message": "10.42.0.113:59584 - \"GET /api/v1/products HTTP/1.1\" 200", "name": "uvicorn.access", "filename": "h11_impl.py", "lineno": 498, "module": "h11_impl", "funcName": "send", "process": 9, "thread": 140314149652288}

stream_to_file from openAI /tmp/flare_uploaded/204/20240901_081713_906552/Mỗi chúng ta khi sinh ra đời chúng ta._14077_retry.mp3

output_file_path /tmp/flare_uploaded/204/20240901_081713_906552/Mỗi chúng ta khi sinh ra đời chúng ta._14077_retry.mp3

The file /tmp/flare_uploaded/204/20240901_081713_906552/Mỗi chúng ta khi sinh ra đời chúng ta._14077_retry.mp3 exists. exiting waiting block 0f1c42c6-576d-4fb1-b735-24f54e3e2396

{"asctime": "2024-09-01 17:18:21,515", "levelname": "INFO", "message": "voice_library: id-PE0004 type system_voice", "name": "app.tts_common.services.story_service", "filename": "story_service.py", "lineno": 802, "module": "story_service", "funcName": "retry_speech_single_block", "process": 11, "thread": 140314149652288}

{"asctime": "2024-09-01 17:18:22,352", "levelname": "INFO", "message": "Successfully upload /tmp/flare_uploaded/204/20240901_081713_906552/M\u1ed7i ch\u00fang ta khi sinh ra \u0111\u1eddi ch\u00fang ta._14077_retry.mp3 to s3 bucket cdk-ttsopenai-gpt-dev-upload-bucket in flare_uploaded/204/20240901_081713_906552/M\u1ed7i ch\u00fang ta khi sinh ra \u0111\u1eddi ch\u00fang ta._14077_retry.mp3", "name": "app.tts_common.services.s3_client", "filename": "s3_client.py", "lineno": 51, "module": "s3_client", "funcName": "upload_file_to_s3", "process": 11, "thread": 140314149652288}

{"asctime": "2024-09-01 17:18:22,393", "levelname": "INFO", "message": "START block_process_inference ...", "name": "app.tts_common.helpers.tts_history_helper", "filename": "tts_history_helper.py", "lineno": 145, "module": "tts_history_helper", "funcName": "block_process_inference", "process": 11, "thread": 140314149652288}

{"asctime": "2024-09-01 17:18:22,769", "levelname": "INFO", "message": "Sending message to sqs", "name": "app.tts_common.helpers.tts_history_helper", "filename": "tts_history_helper.py", "lineno": 178, "module": "tts_history_helper", "funcName": "block_process_inference", "process": 11, "thread": 140314149652288}

{"asctime": "2024-09-01 17:18:22,770", "levelname": "INFO", "message": "", "name": "app.tts_common.helpers.tts_history_helper", "filename": "tts_history_helper.py", "lineno": 179, "module": "tts_history_helper", "funcName": "block_process_inference", "process": 11, "thread": 140314149652288, "trace_id": "0f1c42c6-576d-4fb1-b735-24f54e3e2396", "training_type": "sovit", "type": "SYSTEM_VOICE", "speaker": 4, "input_audio_path": "flare_uploaded/204/20240901_081713_906552/M\u1ed7i ch\u00fang ta khi sinh ra \u0111\u1eddi ch\u00fang ta._14077_retry.mp3", "output_audio_path": "flare_uploaded/204/20240901_081713_906552/M\u1ed7i ch\u00fang ta khi sinh ra \u0111\u1eddi ch\u00fang ta._14077_retry_inferred.mp3", "callback_endpoint": "https://api-dev.ttsopenai.com/api/v1/voice-library/webhook/inference/0f1c42c6-576d-4fb1-b735-24f54e3e2396"}

{"asctime": "2024-09-01 17:18:22,909", "levelname": "INFO", "message": "Message sent, response ...", "name": "app.tts_common.helpers.tts_history_helper", "filename": "tts_history_helper.py", "lineno": 184, "module": "tts_history_helper", "funcName": "block_process_inference", "process": 11, "thread": 140314149652288}

{"asctime": "2024-09-01 17:18:22,910", "levelname": "INFO", "message": "{\"MD5OfMessageBody\": \"b0047885c1c186fcf1eb597a1291904d\", \"MessageId\": \"5558cb5c-ecb9-4d1b-a875-19dc36d5bedb\", \"ResponseMetadata\": {\"RequestId\": \"3e29a668-f29d-5b5c-be31-f926d713d123\", \"HTTPStatusCode\": 200, \"HTTPHeaders\": {\"x-amzn-requestid\": \"3e29a668-f29d-5b5c-be31-f926d713d123\", \"date\": \"Sun, 01 Sep 2024 08:18:22 GMT\", \"content-type\": \"text/xml\", \"content-length\": \"378\", \"connection\": \"keep-alive\"}, \"RetryAttempts\": 0}}", "name": "app.tts_common.helpers.tts_history_helper", "filename": "tts_history_helper.py", "lineno": 185, "module": "tts_history_helper", "funcName": "block_process_inference", "process": 11, "thread": 140314149652288}

{"asctime": "2024-09-01 17:18:22,917", "levelname": "INFO", "message": "Tracing request: PUT /api/v1/story/block/0f1c42c6-576d-4fb1-b735-24f54e3e2396/retry-speech", "name": "app.main", "filename": "main.py", "lineno": 63, "module": "main", "funcName": "dispatch", "process": 11, "thread": 140314149652288, "client-ip": "10.42.0.113", "path": "/api/v1/story/block/0f1c42c6-576d-4fb1-b735-24f54e3e2396/retry-speech", "user-agent": "Mozilla/5.0 (Windows NT 10.0; Win64; x64) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/128.0.0.0 Safari/537.36 Edg/128.0.0.0", "response-time": 69115.43822288513, "response-code": 200}

{"asctime": "2024-09-01 17:18:59,892", "levelname": "INFO", "message": "Init key service with priorities: [94, 96, 97]", "name": "app.tts_common.services.key_service", "filename": "key_service.py", "lineno": 28, "module": "key_service", "funcName": "__init__", "process": 10, "thread": 140314003539712}

{"asctime": "2024-09-01 17:18:59,896", "levelname": "INFO", "message": "route /voice-library/webhook/inference/0f1c42c6-576d-4fb1-b735-24f54e3e2396", "name": "app.api.api_v1.endpoints.voice_library", "filename": "voice_library.py", "lineno": 122, "module": "voice_library", "funcName": "voice_inference_webhook", "process": 10, "thread": 140314149652288}

{"asctime": "2024-09-01 17:18:59,896", "levelname": "INFO", "message": "request body:", "name": "app.api.api_v1.endpoints.voice_library", "filename": "voice_library.py", "lineno": 125, "module": "voice_library", "funcName": "voice_inference_webhook", "process": 10, "thread": 140314149652288}

{"asctime": "2024-09-01 17:18:59,896", "levelname": "INFO", "message": "", "name": "app.api.api_v1.endpoints.voice_library", "filename": "voice_library.py", "lineno": 126, "module": "voice_library", "funcName": "voice_inference_webhook", "process": 10, "thread": 140314149652288, "status": "completed", "code": 200, "error": null}

status: completed

{"asctime": "2024-09-01 17:18:59,910", "levelname": "INFO", "message": "Stop update, already processed: 0f1c42c6-576d-4fb1-b735-24f54e3e2396, current status is completed", "name": "app.tts_common.services.story_service", "filename": "story_service.py", "lineno": 427, "module": "story_service", "funcName": "update_story_block_by_inference_callback", "process": 10, "thread": 140314149652288}

{"asctime": "2024-09-01 17:18:59,914", "levelname": "INFO", "message": "Tracing request: PUT /api/v1/voice-library/webhook/inference/0f1c42c6-576d-4fb1-b735-24f54e3e2396", "name": "app.main", "filename": "main.py", "lineno": 63, "module": "main", "funcName": "dispatch", "process": 10, "thread": 140314149652288, "client-ip": "10.42.0.113", "path": "/api/v1/voice-library/webhook/inference/0f1c42c6-576d-4fb1-b735-24f54e3e2396", "user-agent": "python-requests/2.31.0", "response-time": 65.64497947692871, "response-code": 200}

{"asctime": "2024-09-01 17:18:59,915", "levelname": "INFO", "message": "10.42.0.113:34630 - \"PUT /api/v1/voice-library/webhook/inference/0f1c42c6-576d-4fb1-b735-24f54e3e2396 HTTP/1.1\" 200", "name": "uvicorn.access", "filename": "h11_impl.py", "lineno": 498, "module": "h11_impl", "funcName": "send", "process": 10, "thread": 140314149652288}

{"asctime": "2024-09-01 17:19:06,496", "levelname": "INFO", "message": "Tracing request: GET /api/v1/products", "name": "app.main", "filename": "main.py", "lineno": 63, "module": "main", "funcName": "dispatch", "process": 10, "thread": 140314149652288, "client-ip": "10.42.0.113", "path": "/api/v1/products", "user-agent": "HetrixTools Uptime Monitoring Bot. https://hetrix.tools/uptime-monitoring-bot.html", "response-time": 14.168977737426758, "response-code": 200}

{"asctime": "2024-09-01 17:19:06,497", "levelname": "INFO", "message": "10.42.0.113:51462 - \"GET /api/v1/products HTTP/1.1\" 200", "name": "uvicorn.access", "filename": "h11_impl.py", "lineno": 498, "module": "h11_impl", "funcName": "send", "process": 10, "thread": 140314149652288}

{"asctime": "2024-09-01 17:19:17,803", "levelname": "INFO", "message": "Tracing request: GET /api/v1/products", "name": "app.main", "filename": "main.py", "lineno": 63, "module": "main", "funcName": "dispatch", "process": 8, "thread": 140314149652288, "client-ip": "10.42.0.113", "path": "/api/v1/products", "user-agent": "HetrixTools Uptime Monitoring Bot. https://hetrix.tools/uptime-monitoring-bot.html", "response-time": 22.255420684814453, "response-code": 200}

{"asctime": "2024-09-01 17:19:17,805", "levelname": "INFO", "message": "10.42.0.113:59210 - \"GET /api/v1/products HTTP/1.1\" 200", "name": "uvicorn.access", "filename": "h11_impl.py", "lineno": 498, "module": "h11_impl", "funcName": "send", "process": 8, "thread": 140314149652288}

{"asctime": "2024-09-01 17:19:19,569", "levelname": "INFO", "message": "Tracing request: GET /api/v1/products", "name": "app.main", "filename": "main.py", "lineno": 63, "module": "main", "funcName": "dispatch", "process": 11, "thread": 140314149652288, "client-ip": "10.42.0.113", "path": "/api/v1/products", "user-agent": "HetrixTools Uptime Monitoring Bot. https://hetrix.tools/uptime-monitoring-bot.html", "response-time": 22.010326385498047, "response-code": 200}

{"asctime": "2024-09-01 17:19:19,570", "levelname": "INFO", "message": "10.42.0.113:59214 - \"GET /api/v1/products HTTP/1.1\" 200", "name": "uvicorn.access", "filename": "h11_impl.py", "lineno": 498, "module": "h11_impl", "funcName": "send", "process": 11, "thread": 140314149652288}

{"asctime": "2024-09-01 17:19:20,541", "levelname": "INFO", "message": "Tracing request: GET /api/v1/products", "name": "app.main", "filename": "main.py", "lineno": 63, "module": "main", "funcName": "dispatch", "process": 9, "thread": 140314149652288, "client-ip": "10.42.0.113", "path": "/api/v1/products", "user-agent": "HetrixTools Uptime Monitoring Bot. https://hetrix.tools/uptime-monitoring-bot.html", "response-time": 18.178701400756836, "response-code": 200}

{"asctime": "2024-09-01 17:19:20,542", "levelname": "INFO", "message": "10.42.0.113:59220 - \"GET /api/v1/products HTTP/1.1\" 200", "name": "uvicorn.access", "filename": "h11_impl.py", "lineno": 498, "module": "h11_impl", "funcName": "send", "process": 9, "thread": 140314149652288}

{"asctime": "2024-09-01 17:20:06,862", "levelname": "INFO", "message": "Tracing request: GET /api/v1/products", "name": "app.main", "filename": "main.py", "lineno": 63, "module": "main", "funcName": "dispatch", "process": 8, "thread": 140314149652288, "client-ip": "10.42.0.113", "path": "/api/v1/products", "user-agent": "HetrixTools Uptime Monitoring Bot. https://hetrix.tools/uptime-monitoring-bot.html", "response-time": 14.020919799804688, "response-code": 200}

{"asctime": "2024-09-01 17:20:06,863", "levelname": "INFO", "message": "10.42.0.113:43590 - \"GET /api/v1/products HTTP/1.1\" 200", "name": "uvicorn.access", "filename": "h11_impl.py", "lineno": 498, "module": "h11_impl", "funcName": "send", "process": 8, "thread": 140314149652288}

{"asctime": "2024-09-01 17:20:10,743", "levelname": "INFO", "message": "Tracing request: GET /api/v1/products", "name": "app.main", "filename": "main.py", "lineno": 63, "module": "main", "funcName": "dispatch", "process": 7, "thread": 140314149652288, "client-ip": "10.42.0.113", "path": "/api/v1/products", "user-agent": "HetrixTools Uptime Monitoring Bot. https://hetrix.tools/uptime-monitoring-bot.html", "response-time": 30.554533004760742, "response-code": 200}

{"asctime": "2024-09-01 17:20:10,745", "levelname": "INFO", "message": "10.42.0.113:43602 - \"GET /api/v1/products HTTP/1.1\" 200", "name": "uvicorn.access", "filename": "h11_impl.py", "lineno": 498, "module": "h11_impl", "funcName": "send", "process": 7, "thread": 140314149652288}

{"asctime": "2024-09-01 17:20:16,528", "levelname": "INFO", "message": "Tracing request: GET /api/v1/products", "name": "app.main", "filename": "main.py", "lineno": 63, "module": "main", "funcName": "dispatch", "process": 9, "thread": 140314149652288, "client-ip": "10.42.0.113", "path": "/api/v1/products", "user-agent": "HetrixTools Uptime Monitoring Bot. https://hetrix.tools/uptime-monitoring-bot.html", "response-time": 14.678478240966797, "response-code": 200}

{"asctime": "2024-09-01 17:20:16,529", "levelname": "INFO", "message": "10.42.0.113:47790 - \"GET /api/v1/products HTTP/1.1\" 200", "name": "uvicorn.access", "filename": "h11_impl.py", "lineno": 498, "module": "h11_impl", "funcName": "send", "process": 9, "thread": 140314149652288}

{"asctime": "2024-09-01 17:20:26,150", "levelname": "INFO", "message": "Tracing request: GET /api/v1/products", "name": "app.main", "filename": "main.py", "lineno": 63, "module": "main", "funcName": "dispatch", "process": 9, "thread": 140314149652288, "client-ip": "10.42.0.113", "path": "/api/v1/products", "user-agent": "HetrixTools Uptime Monitoring Bot. https://hetrix.tools/uptime-monitoring-bot.html", "response-time": 13.023853302001953, "response-code": 200}

{"asctime": "2024-09-01 17:20:26,151", "levelname": "INFO", "message": "10.42.0.113:39140 - \"GET /api/v1/products HTTP/1.1\" 200", "name": "uvicorn.access", "filename": "h11_impl.py", "lineno": 498, "module": "h11_impl", "funcName": "send", "process": 9, "thread": 140314149652288}

{"asctime": "2024-09-01 17:21:09,928", "levelname": "INFO", "message": "Tracing request: GET /api/v1/products", "name": "app.main", "filename": "main.py", "lineno": 63, "module": "main", "funcName": "dispatch", "process": 10, "thread": 140314149652288, "client-ip": "10.42.0.113", "path": "/api/v1/products", "user-agent": "HetrixTools Uptime Monitoring Bot. https://hetrix.tools/uptime-monitoring-bot.html", "response-time": 24.419784545898438, "response-code": 200}

{"asctime": "2024-09-01 17:21:09,929", "levelname": "INFO", "message": "10.42.0.113:32826 - \"GET /api/v1/products HTTP/1.1\" 200", "name": "uvicorn.access", "filename": "h11_impl.py", "lineno": 498, "module": "h11_impl", "funcName": "send", "process": 10, "thread": 140314149652288}

{"asctime": "2024-09-01 17:21:16,934", "levelname": "INFO", "message": "Tracing request: GET /api/v1/products", "name": "app.main", "filename": "main.py", "lineno": 63, "module": "main", "funcName": "dispatch", "process": 9, "thread": 140314149652288, "client-ip": "10.42.0.113", "path": "/api/v1/products", "user-agent": "HetrixTools Uptime Monitoring Bot. https://hetrix.tools/uptime-monitoring-bot.html", "response-time": 33.63513946533203, "response-code": 200}

{"asctime": "2024-09-01 17:21:16,935", "levelname": "INFO", "message": "10.42.0.113:43516 - \"GET /api/v1/products HTTP/1.1\" 200", "name": "uvicorn.access", "filename": "h11_impl.py", "lineno": 498, "module": "h11_impl", "funcName": "send", "process": 9, "thread": 140314149652288}

{"asctime": "2024-09-01 17:21:23,147", "levelname": "INFO", "message": "Tracing request: GET /api/v1/products", "name": "app.main", "filename": "main.py", "lineno": 63, "module": "main", "funcName": "dispatch", "process": 9, "thread": 140314149652288, "client-ip": "10.42.0.113", "path": "/api/v1/products", "user-agent": "HetrixTools Uptime Monitoring Bot. https://hetrix.tools/uptime-monitoring-bot.html", "response-time": 12.942075729370117, "response-code": 200}

{"asctime": "2024-09-01 17:21:23,148", "levelname": "INFO", "message": "10.42.0.113:43524 - \"GET /api/v1/products HTTP/1.1\" 200", "name": "uvicorn.access", "filename": "h11_impl.py", "lineno": 498, "module": "h11_impl", "funcName": "send", "process": 9, "thread": 140314149652288}

{"asctime": "2024-09-01 17:21:26,281", "levelname": "INFO", "message": "Tracing request: GET /api/v1/products", "name": "app.main", "filename": "main.py", "lineno": 63, "module": "main", "funcName": "dispatch", "process": 9, "thread": 140314149652288, "client-ip": "10.42.0.113", "path": "/api/v1/products", "user-agent": "HetrixTools Uptime Monitoring Bot. https://hetrix.tools/uptime-monitoring-bot.html", "response-time": 11.13271713256836, "response-code": 200}

{"asctime": "2024-09-01 17:21:26,282", "levelname": "INFO", "message": "10.42.0.113:45552 - \"GET /api/v1/products HTTP/1.1\" 200", "name": "uvicorn.access", "filename": "h11_impl.py", "lineno": 498, "module": "h11_impl", "funcName": "send", "process": 9, "thread": 140314149652288}

{"asctime": "2024-09-01 17:22:13,159", "levelname": "INFO", "message": "Tracing request: GET /api/v1/products", "name": "app.main", "filename": "main.py", "lineno": 63, "module": "main", "funcName": "dispatch", "process": 7, "thread": 140314149652288, "client-ip": "10.42.0.113", "path": "/api/v1/products", "user-agent": "HetrixTools Uptime Monitoring Bot. https://hetrix.tools/uptime-monitoring-bot.html", "response-time": 26.790618896484375, "response-code": 200}

{"asctime": "2024-09-01 17:22:13,160", "levelname": "INFO", "message": "10.42.0.113:44548 - \"GET /api/v1/products HTTP/1.1\" 200", "name": "uvicorn.access", "filename": "h11_impl.py", "lineno": 498, "module": "h11_impl", "funcName": "send", "process": 7, "thread": 140314149652288}

{"asctime": "2024-09-01 17:22:17,538", "levelname": "INFO", "message": "Tracing request: GET /api/v1/products", "name": "app.main", "filename": "main.py", "lineno": 63, "module": "main", "funcName": "dispatch", "process": 11, "thread": 140314149652288, "client-ip": "10.42.0.113", "path": "/api/v1/products", "user-agent": "HetrixTools Uptime Monitoring Bot. https://hetrix.tools/uptime-monitoring-bot.html", "response-time": 25.693893432617188, "response-code": 200}

{"asctime": "2024-09-01 17:22:17,540", "levelname": "INFO", "message": "10.42.0.113:54714 - \"GET /api/v1/products HTTP/1.1\" 200", "name": "uvicorn.access", "filename": "h11_impl.py", "lineno": 498, "module": "h11_impl", "funcName": "send", "process": 11, "thread": 140314149652288}

{"asctime": "2024-09-01 17:22:24,080", "levelname": "INFO", "message": "Tracing request: GET /api/v1/products", "name": "app.main", "filename": "main.py", "lineno": 63, "module": "main", "funcName": "dispatch", "process": 7, "thread": 140314149652288, "client-ip": "10.42.0.113", "path": "/api/v1/products", "user-agent": "HetrixTools Uptime Monitoring Bot. https://hetrix.tools/uptime-monitoring-bot.html", "response-time": 13.452529907226562, "response-code": 200}

{"asctime": "2024-09-01 17:22:24,081", "levelname": "INFO", "message": "10.42.0.113:54722 - \"GET /api/v1/products HTTP/1.1\" 200", "name": "uvicorn.access", "filename": "h11_impl.py", "lineno": 498, "module": "h11_impl", "funcName": "send", "process": 7, "thread": 140314149652288}

{"asctime": "2024-09-01 17:22:25,372", "levelname": "INFO", "message": "Tracing request: GET /api/v1/products", "name": "app.main", "filename": "main.py", "lineno": 63, "module": "main", "funcName": "dispatch", "process": 7, "thread": 140314149652288, "client-ip": "10.42.0.113", "path": "/api/v1/products", "user-agent": "HetrixTools Uptime Monitoring Bot. https://hetrix.tools/uptime-monitoring-bot.html", "response-time": 13.608217239379883, "response-code": 200}

{"asctime": "2024-09-01 17:22:25,373", "levelname": "INFO", "message": "10.42.0.113:52208 - \"GET /api/v1/products HTTP/1.1\" 200", "name": "uvicorn.access", "filename": "h11_impl.py", "lineno": 498, "module": "h11_impl", "funcName": "send", "process": 7, "thread": 140314149652288}

{"asctime": "2024-09-01 17:23:04,386", "levelname": "INFO", "message": "Tracing request: GET /api/v1/products", "name": "app.main", "filename": "main.py", "lineno": 63, "module": "main", "funcName": "dispatch", "process": 11, "thread": 140314149652288, "client-ip": "10.42.0.113", "path": "/api/v1/products", "user-agent": "HetrixTools Uptime Monitoring Bot. https://hetrix.tools/uptime-monitoring-bot.html", "response-time": 38.726806640625, "response-code": 200}

{"asctime": "2024-09-01 17:23:04,387", "levelname": "INFO", "message": "10.42.0.113:38336 - \"GET /api/v1/products HTTP/1.1\" 200", "name": "uvicorn.access", "filename": "h11_impl.py", "lineno": 498, "module": "h11_impl", "funcName": "send", "process": 11, "thread": 140314149652288}

{"asctime": "2024-09-01 17:23:06,390", "levelname": "INFO", "message": "Tracing request: GET /api/v1/products", "name": "app.main", "filename": "main.py", "lineno": 63, "module": "main", "funcName": "dispatch", "process": 11, "thread": 140314149652288, "client-ip": "10.42.0.113", "path": "/api/v1/products", "user-agent": "HetrixTools Uptime Monitoring Bot. https://hetrix.tools/uptime-monitoring-bot.html", "response-time": 13.662338256835938, "response-code": 200}

{"asctime": "2024-09-01 17:23:06,391", "levelname": "INFO", "message": "10.42.0.113:38336 - \"GET /api/v1/products HTTP/1.1\" 200", "name": "uvicorn.access", "filename": "h11_impl.py", "lineno": 498, "module": "h11_impl", "funcName": "send", "process": 11, "thread": 140314149652288}

{"asctime": "2024-09-01 17:23:08,291", "levelname": "INFO", "message": "Tracing request: GET /api/v1/products", "name": "app.main", "filename": "main.py", "lineno": 63, "module": "main", "funcName": "dispatch", "process": 7, "thread": 140314149652288, "client-ip": "10.42.0.113", "path": "/api/v1/products", "user-agent": "HetrixTools Uptime Monitoring Bot. https://hetrix.tools/uptime-monitoring-bot.html", "response-time": 25.420188903808594, "response-code": 200}

{"asctime": "2024-09-01 17:23:08,293", "levelname": "INFO", "message": "10.42.0.113:40872 - \"GET /api/v1/products HTTP/1.1\" 200", "name": "uvicorn.access", "filename": "h11_impl.py", "lineno": 498, "module": "h11_impl", "funcName": "send", "process": 7, "thread": 140314149652288}

{"asctime": "2024-09-01 17:23:12,987", "levelname": "INFO", "message": "Tracing request: GET /api/v1/products", "name": "app.main", "filename": "main.py", "lineno": 63, "module": "main", "funcName": "dispatch", "process": 11, "thread": 140314149652288, "client-ip": "10.42.0.113", "path": "/api/v1/products", "user-agent": "HetrixTools Uptime Monitoring Bot. https://hetrix.tools/uptime-monitoring-bot.html", "response-time": 14.318704605102539, "response-code": 200}

{"asctime": "2024-09-01 17:23:12,988", "levelname": "INFO", "message": "10.42.0.113:40884 - \"GET /api/v1/products HTTP/1.1\" 200", "name": "uvicorn.access", "filename": "h11_impl.py", "lineno": 498, "module": "h11_impl", "funcName": "send", "process": 11, "thread": 140314149652288}

{"asctime": "2024-09-01 17:24:06,504", "levelname": "INFO", "message": "Tracing request: GET /api/v1/products", "name": "app.main", "filename": "main.py", "lineno": 63, "module": "main", "funcName": "dispatch", "process": 10, "thread": 140314149652288, "client-ip": "10.42.0.113", "path": "/api/v1/products", "user-agent": "HetrixTools Uptime Monitoring Bot. https://hetrix.tools/uptime-monitoring-bot.html", "response-time": 50.360679626464844, "response-code": 200}

{"asctime": "2024-09-01 17:24:06,505", "levelname": "INFO", "message": "10.42.0.113:53674 - \"GET /api/v1/products HTTP/1.1\" 200", "name": "uvicorn.access", "filename": "h11_impl.py", "lineno": 498, "module": "h11_impl", "funcName": "send", "process": 10, "thread": 140314149652288}

{"asctime": "2024-09-01 17:24:12,719", "levelname": "INFO", "message": "Tracing request: GET /api/v1/products", "name": "app.main", "filename": "main.py", "lineno": 63, "module": "main", "funcName": "dispatch", "process": 9, "thread": 140314149652288, "client-ip": "10.42.0.113", "path": "/api/v1/products", "user-agent": "HetrixTools Uptime Monitoring Bot. https://hetrix.tools/uptime-monitoring-bot.html", "response-time": 41.414499282836914, "response-code": 200}

{"asctime": "2024-09-01 17:24:12,720", "levelname": "INFO", "message": "10.42.0.113:53690 - \"GET /api/v1/products HTTP/1.1\" 200", "name": "uvicorn.access", "filename": "h11_impl.py", "lineno": 498, "module": "h11_impl", "funcName": "send", "process": 9, "thread": 140314149652288}

{"asctime": "2024-09-01 17:24:13,188", "levelname": "INFO", "message": "Tracing request: GET /api/v1/products", "name": "app.main", "filename": "main.py", "lineno": 63, "module": "main", "funcName": "dispatch", "process": 8, "thread": 140314149652288, "client-ip": "10.42.0.113", "path": "/api/v1/products", "user-agent": "HetrixTools Uptime Monitoring Bot. https://hetrix.tools/uptime-monitoring-bot.html", "response-time": 53.20930480957031, "response-code": 200}

{"asctime": "2024-09-01 17:24:13,189", "levelname": "INFO", "message": "10.42.0.113:53694 - \"GET /api/v1/products HTTP/1.1\" 200", "name": "uvicorn.access", "filename": "h11_impl.py", "lineno": 498, "module": "h11_impl", "funcName": "send", "process": 8, "thread": 140314149652288}

{"asctime": "2024-09-01 17:24:22,551", "levelname": "INFO", "message": "Tracing request: GET /api/v1/products", "name": "app.main", "filename": "main.py", "lineno": 63, "module": "main", "funcName": "dispatch", "process": 11, "thread": 140314149652288, "client-ip": "10.42.0.113", "path": "/api/v1/products", "user-agent": "HetrixTools Uptime Monitoring Bot. https://hetrix.tools/uptime-monitoring-bot.html", "response-time": 16.402006149291992, "response-code": 200}

{"asctime": "2024-09-01 17:24:22,552", "levelname": "INFO", "message": "10.42.0.113:52532 - \"GET /api/v1/products HTTP/1.1\" 200", "name": "uvicorn.access", "filename": "h11_impl.py", "lineno": 498, "module": "h11_impl", "funcName": "send", "process": 11, "thread": 140314149652288}

{"asctime": "2024-09-01 17:25:11,318", "levelname": "INFO", "message": "Tracing request: GET /api/v1/products", "name": "app.main", "filename": "main.py", "lineno": 63, "module": "main", "funcName": "dispatch", "process": 10, "thread": 140314149652288, "client-ip": "10.42.0.113", "path": "/api/v1/products", "user-agent": "HetrixTools Uptime Monitoring Bot. https://hetrix.tools/uptime-monitoring-bot.html", "response-time": 27.990102767944336, "response-code": 200}

{"asctime": "2024-09-01 17:25:11,319", "levelname": "INFO", "message": "10.42.0.113:37904 - \"GET /api/v1/products HTTP/1.1\" 200", "name": "uvicorn.access", "filename": "h11_impl.py", "lineno": 498, "module": "h11_impl", "funcName": "send", "process": 10, "thread": 140314149652288}

{"asctime": "2024-09-01 17:25:12,536", "levelname": "INFO", "message": "Tracing request: GET /api/v1/products", "name": "app.main", "filename": "main.py", "lineno": 63, "module": "main", "funcName": "dispatch", "process": 7, "thread": 140314149652288, "client-ip": "10.42.0.113", "path": "/api/v1/products", "user-agent": "HetrixTools Uptime Monitoring Bot. https://hetrix.tools/uptime-monitoring-bot.html", "response-time": 21.69203758239746, "response-code": 200}

{"asctime": "2024-09-01 17:25:12,537", "levelname": "INFO", "message": "10.42.0.113:37918 - \"GET /api/v1/products HTTP/1.1\" 200", "name": "uvicorn.access", "filename": "h11_impl.py", "lineno": 498, "module": "h11_impl", "funcName": "send", "process": 7, "thread": 140314149652288}

{"asctime": "2024-09-01 17:25:14,841", "levelname": "INFO", "message": "Tracing request: GET /api/v1/products", "name": "app.main", "filename": "main.py", "lineno": 63, "module": "main", "funcName": "dispatch", "process": 9, "thread": 140314149652288, "client-ip": "10.42.0.113", "path": "/api/v1/products", "user-agent": "HetrixTools Uptime Monitoring Bot. https://hetrix.tools/uptime-monitoring-bot.html", "response-time": 14.361858367919922, "response-code": 200}

{"asctime": "2024-09-01 17:25:14,842", "levelname": "INFO", "message": "10.42.0.113:45308 - \"GET /api/v1/products HTTP/1.1\" 200", "name": "uvicorn.access", "filename": "h11_impl.py", "lineno": 498, "module": "h11_impl", "funcName": "send", "process": 9, "thread": 140314149652288}

{"asctime": "2024-09-01 17:25:21,186", "levelname": "INFO", "message": "Tracing request: GET /api/v1/products", "name": "app.main", "filename": "main.py", "lineno": 63, "module": "main", "funcName": "dispatch", "process": 9, "thread": 140314149652288, "client-ip": "10.42.0.113", "path": "/api/v1/products", "user-agent": "HetrixTools Uptime Monitoring Bot. https://hetrix.tools/uptime-monitoring-bot.html", "response-time": 16.2811279296875, "response-code": 200}

{"asctime": "2024-09-01 17:25:21,187", "levelname": "INFO", "message": "10.42.0.113:45310 - \"GET /api/v1/products HTTP/1.1\" 200", "name": "uvicorn.access", "filename": "h11_impl.py", "lineno": 498, "module": "h11_impl", "funcName": "send", "process": 9, "thread": 140314149652288}

{"asctime": "2024-09-01 17:26:05,128", "levelname": "INFO", "message": "Tracing request: GET /api/v1/products", "name": "app.main", "filename": "main.py", "lineno": 63, "module": "main", "funcName": "dispatch", "process": 9, "thread": 140314149652288, "client-ip": "10.42.0.113", "path": "/api/v1/products", "user-agent": "HetrixTools Uptime Monitoring Bot. https://hetrix.tools/uptime-monitoring-bot.html", "response-time": 30.54666519165039, "response-code": 200}

{"asctime": "2024-09-01 17:26:05,129", "levelname": "INFO", "message": "10.42.0.113:37790 - \"GET /api/v1/products HTTP/1.1\" 200", "name": "uvicorn.access", "filename": "h11_impl.py", "lineno": 498, "module": "h11_impl", "funcName": "send", "process": 9, "thread": 140314149652288}

{"asctime": "2024-09-01 17:26:05,228", "levelname": "INFO", "message": "Tracing request: GET /api/v1/products", "name": "app.main", "filename": "main.py", "lineno": 63, "module": "main", "funcName": "dispatch", "process": 11, "thread": 140314149652288, "client-ip": "10.42.0.113", "path": "/api/v1/products", "user-agent": "HetrixTools Uptime Monitoring Bot. https://hetrix.tools/uptime-monitoring-bot.html", "response-time": 26.464223861694336, "response-code": 200}

{"asctime": "2024-09-01 17:26:05,229", "levelname": "INFO", "message": "10.42.0.113:37802 - \"GET /api/v1/products HTTP/1.1\" 200", "name": "uvicorn.access", "filename": "h11_impl.py", "lineno": 498, "module": "h11_impl", "funcName": "send", "process": 11, "thread": 140314149652288}

{"asctime": "2024-09-01 17:26:09,863", "levelname": "INFO", "message": "Tracing request: GET /api/v1/products", "name": "app.main", "filename": "main.py", "lineno": 63, "module": "main", "funcName": "dispatch", "process": 10, "thread": 140314149652288, "client-ip": "10.42.0.113", "path": "/api/v1/products", "user-agent": "HetrixTools Uptime Monitoring Bot. https://hetrix.tools/uptime-monitoring-bot.html", "response-time": 20.904064178466797, "response-code": 200}

{"asctime": "2024-09-01 17:26:09,864", "levelname": "INFO", "message": "10.42.0.113:37816 - \"GET /api/v1/products HTTP/1.1\" 200", "name": "uvicorn.access", "filename": "h11_impl.py", "lineno": 498, "module": "h11_impl", "funcName": "send", "process": 10, "thread": 140314149652288}

{"asctime": "2024-09-01 17:26:14,009", "levelname": "INFO", "message": "Tracing request: GET /api/v1/products", "name": "app.main", "filename": "main.py", "lineno": 63, "module": "main", "funcName": "dispatch", "process": 7, "thread": 140314149652288, "client-ip": "10.42.0.113", "path": "/api/v1/products", "user-agent": "HetrixTools Uptime Monitoring Bot. https://hetrix.tools/uptime-monitoring-bot.html", "response-time": 35.86459159851074, "response-code": 200}

{"asctime": "2024-09-01 17:26:14,011", "levelname": "INFO", "message": "10.42.0.113:37828 - \"GET /api/v1/products HTTP/1.1\" 200", "name": "uvicorn.access", "filename": "h11_impl.py", "lineno": 498, "module": "h11_impl", "funcName": "send", "process": 7, "thread": 140314149652288}

{"asctime": "2024-09-01 17:27:03,589", "levelname": "INFO", "message": "Tracing request: GET /api/v1/products", "name": "app.main", "filename": "main.py", "lineno": 63, "module": "main", "funcName": "dispatch", "process": 9, "thread": 140314149652288, "client-ip": "10.42.0.113", "path": "/api/v1/products", "user-agent": "HetrixTools Uptime Monitoring Bot. https://hetrix.tools/uptime-monitoring-bot.html", "response-time": 21.07095718383789, "response-code": 200}

{"asctime": "2024-09-01 17:27:03,591", "levelname": "INFO", "message": "10.42.0.113:55886 - \"GET /api/v1/products HTTP/1.1\" 200", "name": "uvicorn.access", "filename": "h11_impl.py", "lineno": 498, "module": "h11_impl", "funcName": "send", "process": 9, "thread": 140314149652288}

{"asctime": "2024-09-01 17:27:08,131", "levelname": "INFO", "message": "Tracing request: GET /api/v1/products", "name": "app.main", "filename": "main.py", "lineno": 63, "module": "main", "funcName": "dispatch", "process": 9, "thread": 140314149652288, "client-ip": "10.42.0.113", "path": "/api/v1/products", "user-agent": "HetrixTools Uptime Monitoring Bot. https://hetrix.tools/uptime-monitoring-bot.html", "response-time": 7.860422134399414, "response-code": 200}

{"asctime": "2024-09-01 17:27:08,132", "levelname": "INFO", "message": "10.42.0.113:40698 - \"GET /api/v1/products HTTP/1.1\" 200", "name": "uvicorn.access", "filename": "h11_impl.py", "lineno": 498, "module": "h11_impl", "funcName": "send", "process": 9, "thread": 140314149652288}

{"asctime": "2024-09-01 17:27:12,774", "levelname": "INFO", "message": "Tracing request: GET /api/v1/products", "name": "app.main", "filename": "main.py", "lineno": 63, "module": "main", "funcName": "dispatch", "process": 10, "thread": 140314149652288, "client-ip": "10.42.0.113", "path": "/api/v1/products", "user-agent": "HetrixTools Uptime Monitoring Bot. https://hetrix.tools/uptime-monitoring-bot.html", "response-time": 13.080120086669922, "response-code": 200}

{"asctime": "2024-09-01 17:27:12,775", "levelname": "INFO", "message": "10.42.0.113:40702 - \"GET /api/v1/products HTTP/1.1\" 200", "name": "uvicorn.access", "filename": "h11_impl.py", "lineno": 498, "module": "h11_impl", "funcName": "send", "process": 10, "thread": 140314149652288}

{"asctime": "2024-09-01 17:27:17,823", "levelname": "INFO", "message": "Tracing request: GET /api/v1/products", "name": "app.main", "filename": "main.py", "lineno": 63, "module": "main", "funcName": "dispatch", "process": 9, "thread": 140314149652288, "client-ip": "10.42.0.113", "path": "/api/v1/products", "user-agent": "HetrixTools Uptime Monitoring Bot. https://hetrix.tools/uptime-monitoring-bot.html", "response-time": 14.104843139648438, "response-code": 200}

{"asctime": "2024-09-01 17:27:17,824", "levelname": "INFO", "message": "10.42.0.113:38988 - \"GET /api/v1/products HTTP/1.1\" 200", "name": "uvicorn.access", "filename": "h11_impl.py", "lineno": 498, "module": "h11_impl", "funcName": "send", "process": 9, "thread": 140314149652288}

{"asctime": "2024-09-01 17:27:24,470", "levelname": "INFO", "message": "10.42.0.113:38992 - \"OPTIONS /api/v1/story/block/0f1c42c6-576d-4fb1-b735-24f54e3e2396/retry-speech HTTP/1.1\" 200", "name": "uvicorn.access", "filename": "h11_impl.py", "lineno": 498, "module": "h11_impl", "funcName": "send", "process": 7, "thread": 140314149652288}

{"asctime": "2024-09-01 17:27:24,807", "levelname": "INFO", "message": "Init key service with priorities: [94, 96, 97]", "name": "app.tts_common.services.key_service", "filename": "key_service.py", "lineno": 28, "module": "key_service", "funcName": "__init__", "process": 7, "thread": 140314003539712}

{"asctime": "2024-09-01 17:27:24,809", "levelname": "INFO", "message": "route: /story/block/0f1c42c6-576d-4fb1-b735-24f54e3e2396/retry-speech", "name": "app.api.api_v1.endpoints.story", "filename": "story.py", "lineno": 108, "module": "story", "funcName": "retry_speech_story_block_detail_by_uuid", "process": 7, "thread": 140314149652288}

{"asctime": "2024-09-01 17:27:24,822", "levelname": "INFO", "message": "current_model: tts-1-hd", "name": "app.tts_common.services.story_service", "filename": "story_service.py", "lineno": 722, "module": "story_service", "funcName": "retry_speech_single_block", "process": 7, "thread": 140314149652288}

{"asctime": "2024-09-01 17:27:24,833", "levelname": "INFO", "message": "block absolute_credit: 5004", "name": "app.tts_common.services.story_service", "filename": "story_service.py", "lineno": 767, "module": "story_service", "funcName": "retry_speech_single_block", "process": 7, "thread": 140314149652288}

{"asctime": "2024-09-01 17:27:24,847", "levelname": "INFO", "message": "running_estimated_credits: 0", "name": "app.tts_common.services.story_service", "filename": "story_service.py", "lineno": 774, "module": "story_service", "funcName": "retry_speech_single_block", "process": 7, "thread": 140314149652288}

{"asctime": "2024-09-01 17:27:24,847", "levelname": "INFO", "message": "estimated_credits: 2502", "name": "app.tts_common.services.story_service", "filename": "story_service.py", "lineno": 775, "module": "story_service", "funcName": "retry_speech_single_block", "process": 7, "thread": 140314149652288}

{"asctime": "2024-09-01 17:27:24,848", "levelname": "INFO", "message": "locked_credit: 2502", "name": "app.tts_common.services.story_service", "filename": "story_service.py", "lineno": 777, "module": "story_service", "funcName": "retry_speech_single_block", "process": 7, "thread": 140314149652288}

{"asctime": "2024-09-01 17:27:24,887", "levelname": "INFO", "message": "setup_api_key_and_client of model: tts-1-hd", "name": "app.tts_common.services.key_service", "filename": "key_service.py", "lineno": 54, "module": "key_service", "funcName": "setup_api_key_and_client", "process": 7, "thread": 140314149652288}

{"asctime": "2024-09-01 17:27:24,919", "levelname": "INFO", "message": "Finish setup_api_key_and_client of model: priority: 94, version:tts-1-hd key_type: AZURE, https://ttadasbbhshdop.openai.azure.com/, 2024-02-15-preview, tts-hd", "name": "app.tts_common.services.key_service", "filename": "key_service.py", "lineno": 109, "module": "key_service", "funcName": "setup_api_key_and_client", "process": 7, "thread": 140314149652288}

{"asctime": "2024-09-01 17:27:24,919", "levelname": "INFO", "message": "Try request_text_openai_by_piece 1/3", "name": "app.tts_common.services.story_service", "filename": "story_service.py", "lineno": 275, "module": "story_service", "funcName": "request_text_openai_by_piece", "process": 7, "thread": 140314149652288}

{"asctime": "2024-09-01 17:27:24,919", "levelname": "INFO", "message": "Requesting openAI key: ********************b55ece21728f", "name": "app.tts_common.services.story_service", "filename": "story_service.py", "lineno": 278, "module": "story_service", "funcName": "request_text_openai_by_piece", "process": 7, "thread": 140314149652288}

{"asctime": "2024-09-01 17:27:24,920", "levelname": "INFO", "message": "Requesting openAI base_url: https://ttadasbbhshdop.openai.azure.com//openai/deployments/tts-hd/", "name": "app.tts_common.services.story_service", "filename": "story_service.py", "lineno": 279, "module": "story_service", "funcName": "request_text_openai_by_piece", "process": 7, "thread": 140314149652288}

{"asctime": "2024-09-01 17:27:32,350", "levelname": "INFO", "message": "HTTP Request: POST https://ttadasbbhshdop.openai.azure.com//openai/deployments/tts-hd/audio/speech?api-version=2024-02-15-preview \"HTTP/1.1 200 OK\"", "name": "httpx", "filename": "_client.py", "lineno": 1027, "module": "_client", "funcName": "_send_single_request", "process": 7, "thread": 140314149652288}

{"asctime": "2024-09-01 17:28:05,928", "levelname": "INFO", "message": "Tracing request: GET /api/v1/products", "name": "app.main", "filename": "main.py", "lineno": 63, "module": "main", "funcName": "dispatch", "process": 11, "thread": 140314149652288, "client-ip": "10.42.0.113", "path": "/api/v1/products", "user-agent": "HetrixTools Uptime Monitoring Bot. https://hetrix.tools/uptime-monitoring-bot.html", "response-time": 30.5173397064209, "response-code": 200}

{"asctime": "2024-09-01 17:28:05,929", "levelname": "INFO", "message": "10.42.0.113:33132 - \"GET /api/v1/products HTTP/1.1\" 200", "name": "uvicorn.access", "filename": "h11_impl.py", "lineno": 498, "module": "h11_impl", "funcName": "send", "process": 11, "thread": 140314149652288}

{"asctime": "2024-09-01 17:28:10,512", "levelname": "INFO", "message": "Tracing request: GET /api/v1/products", "name": "app.main", "filename": "main.py", "lineno": 63, "module": "main", "funcName": "dispatch", "process": 9, "thread": 140314149652288, "client-ip": "10.42.0.113", "path": "/api/v1/products", "user-agent": "HetrixTools Uptime Monitoring Bot. https://hetrix.tools/uptime-monitoring-bot.html", "response-time": 13.841629028320312, "response-code": 200}

{"asctime": "2024-09-01 17:28:10,513", "levelname": "INFO", "message": "10.42.0.113:33144 - \"GET /api/v1/products HTTP/1.1\" 200", "name": "uvicorn.access", "filename": "h11_impl.py", "lineno": 498, "module": "h11_impl", "funcName": "send", "process": 9, "thread": 140314149652288}

{"asctime": "2024-09-01 17:28:13,565", "levelname": "INFO", "message": "Tracing request: GET /api/v1/products", "name": "app.main", "filename": "main.py", "lineno": 63, "module": "main", "funcName": "dispatch", "process": 11, "thread": 140314149652288, "client-ip": "10.42.0.113", "path": "/api/v1/products", "user-agent": "HetrixTools Uptime Monitoring Bot. https://hetrix.tools/uptime-monitoring-bot.html", "response-time": 25.307416915893555, "response-code": 200}

{"asctime": "2024-09-01 17:28:13,566", "levelname": "INFO", "message": "10.42.0.113:33156 - \"GET /api/v1/products HTTP/1.1\" 200", "name": "uvicorn.access", "filename": "h11_impl.py", "lineno": 498, "module": "h11_impl", "funcName": "send", "process": 11, "thread": 140314149652288}

{"asctime": "2024-09-01 17:28:24,835", "levelname": "INFO", "message": "Init key service with priorities: [94, 96, 97]", "name": "app.tts_common.services.key_service", "filename": "key_service.py", "lineno": 28, "module": "key_service", "funcName": "__init__", "process": 10, "thread": 140314003539712}

{"asctime": "2024-09-01 17:28:24,838", "levelname": "INFO", "message": "route: /story/block/0f1c42c6-576d-4fb1-b735-24f54e3e2396/retry-speech", "name": "app.api.api_v1.endpoints.story", "filename": "story.py", "lineno": 108, "module": "story", "funcName": "retry_speech_story_block_detail_by_uuid", "process": 10, "thread": 140314149652288}

{"asctime": "2024-09-01 17:28:24,850", "levelname": "INFO", "message": "current_model: tts-1-hd", "name": "app.tts_common.services.story_service", "filename": "story_service.py", "lineno": 722, "module": "story_service", "funcName": "retry_speech_single_block", "process": 10, "thread": 140314149652288}

{"asctime": "2024-09-01 17:28:24,869", "levelname": "INFO", "message": "Tracing request: GET /api/v1/products", "name": "app.main", "filename": "main.py", "lineno": 63, "module": "main", "funcName": "dispatch", "process": 9, "thread": 140314149652288, "client-ip": "10.42.0.113", "path": "/api/v1/products", "user-agent": "HetrixTools Uptime Monitoring Bot. https://hetrix.tools/uptime-monitoring-bot.html", "response-time": 11.157512664794922, "response-code": 200}

{"asctime": "2024-09-01 17:28:24,870", "levelname": "INFO", "message": "10.42.0.113:49296 - \"GET /api/v1/products HTTP/1.1\" 200", "name": "uvicorn.access", "filename": "h11_impl.py", "lineno": 498, "module": "h11_impl", "funcName": "send", "process": 9, "thread": 140314149652288}

{"asctime": "2024-09-01 17:28:24,876", "levelname": "INFO", "message": "running_estimated_credits: 0", "name": "app.tts_common.services.story_service", "filename": "story_service.py", "lineno": 774, "module": "story_service", "funcName": "retry_speech_single_block", "process": 10, "thread": 140314149652288}

{"asctime": "2024-09-01 17:28:24,877", "levelname": "INFO", "message": "estimated_credits: 0", "name": "app.tts_common.services.story_service", "filename": "story_service.py", "lineno": 775, "module": "story_service", "funcName": "retry_speech_single_block", "process": 10, "thread": 140314149652288}

{"asctime": "2024-09-01 17:28:24,877", "levelname": "INFO", "message": "locked_credit: 0", "name": "app.tts_common.services.story_service", "filename": "story_service.py", "lineno": 777, "module": "story_service", "funcName": "retry_speech_single_block", "process": 10, "thread": 140314149652288}

{"asctime": "2024-09-01 17:28:24,932", "levelname": "INFO", "message": "setup_api_key_and_client of model: tts-1-hd", "name": "app.tts_common.services.key_service", "filename": "key_service.py", "lineno": 54, "module": "key_service", "funcName": "setup_api_key_and_client", "process": 10, "thread": 140314149652288}

{"asctime": "2024-09-01 17:28:24,962", "levelname": "INFO", "message": "Finish setup_api_key_and_client of model: priority: 94, version:tts-1-hd key_type: AZURE, https://ttawtwhunhg.openai.azure.com/, 2024-02-15-preview, tts-hd", "name": "app.tts_common.services.key_service", "filename": "key_service.py", "lineno": 109, "module": "key_service", "funcName": "setup_api_key_and_client", "process": 10, "thread": 140314149652288}

{"asctime": "2024-09-01 17:28:24,963", "levelname": "INFO", "message": "Try request_text_openai_by_piece 1/3", "name": "app.tts_common.services.story_service", "filename": "story_service.py", "lineno": 275, "module": "story_service", "funcName": "request_text_openai_by_piece", "process": 10, "thread": 140314149652288}

{"asctime": "2024-09-01 17:28:24,963", "levelname": "INFO", "message": "Requesting openAI key: ********************61c2d99174dd", "name": "app.tts_common.services.story_service", "filename": "story_service.py", "lineno": 278, "module": "story_service", "funcName": "request_text_openai_by_piece", "process": 10, "thread": 140314149652288}

{"asctime": "2024-09-01 17:28:24,964", "levelname": "INFO", "message": "Requesting openAI base_url: https://ttawtwhunhg.openai.azure.com//openai/deployments/tts-hd/", "name": "app.tts_common.services.story_service", "filename": "story_service.py", "lineno": 279, "module": "story_service", "funcName": "request_text_openai_by_piece", "process": 10, "thread": 140314149652288}

{"asctime": "2024-09-01 17:28:32,495", "levelname": "INFO", "message": "HTTP Request: POST https://ttawtwhunhg.openai.azure.com//openai/deployments/tts-hd/audio/speech?api-version=2024-02-15-preview \"HTTP/1.1 200 OK\"", "name": "httpx", "filename": "_client.py", "lineno": 1027, "module": "_client", "funcName": "_send_single_request", "process": 10, "thread": 140314149652288}

stream_to_file from openAI /tmp/flare_uploaded/204/20240901_082724_885299/Mỗi chúng ta khi sinh ra đời chúng ta._14077_retry.mp3

output_file_path /tmp/flare_uploaded/204/20240901_082724_885299/Mỗi chúng ta khi sinh ra đời chúng ta._14077_retry.mp3

The file /tmp/flare_uploaded/204/20240901_082724_885299/Mỗi chúng ta khi sinh ra đời chúng ta._14077_retry.mp3 exists. exiting waiting block 0f1c42c6-576d-4fb1-b735-24f54e3e2396

{"asctime": "2024-09-01 17:28:34,099", "levelname": "INFO", "message": "voice_library: id-PE0004 type system_voice", "name": "app.tts_common.services.story_service", "filename": "story_service.py", "lineno": 802, "module": "story_service", "funcName": "retry_speech_single_block", "process": 7, "thread": 140314149652288}

{"asctime": "2024-09-01 17:28:34,832", "levelname": "INFO", "message": "Successfully upload /tmp/flare_uploaded/204/20240901_082724_885299/M\u1ed7i ch\u00fang ta khi sinh ra \u0111\u1eddi ch\u00fang ta._14077_retry.mp3 to s3 bucket cdk-ttsopenai-gpt-dev-upload-bucket in flare_uploaded/204/20240901_082724_885299/M\u1ed7i ch\u00fang ta khi sinh ra \u0111\u1eddi ch\u00fang ta._14077_retry.mp3", "name": "app.tts_common.services.s3_client", "filename": "s3_client.py", "lineno": 51, "module": "s3_client", "funcName": "upload_file_to_s3", "process": 7, "thread": 140314149652288}

{"asctime": "2024-09-01 17:28:34,863", "levelname": "INFO", "message": "START block_process_inference ...", "name": "app.tts_common.helpers.tts_history_helper", "filename": "tts_history_helper.py", "lineno": 145, "module": "tts_history_helper", "funcName": "block_process_inference", "process": 7, "thread": 140314149652288}

{"asctime": "2024-09-01 17:28:34,928", "levelname": "INFO", "message": "Sending message to sqs", "name": "app.tts_common.helpers.tts_history_helper", "filename": "tts_history_helper.py", "lineno": 178, "module": "tts_history_helper", "funcName": "block_process_inference", "process": 7, "thread": 140314149652288}

{"asctime": "2024-09-01 17:28:34,929", "levelname": "INFO", "message": "", "name": "app.tts_common.helpers.tts_history_helper", "filename": "tts_history_helper.py", "lineno": 179, "module": "tts_history_helper", "funcName": "block_process_inference", "process": 7, "thread": 140314149652288, "trace_id": "0f1c42c6-576d-4fb1-b735-24f54e3e2396", "training_type": "sovit", "type": "SYSTEM_VOICE", "speaker": 4, "input_audio_path": "flare_uploaded/204/20240901_082724_885299/M\u1ed7i ch\u00fang ta khi sinh ra \u0111\u1eddi ch\u00fang ta._14077_retry.mp3", "output_audio_path": "flare_uploaded/204/20240901_082724_885299/M\u1ed7i ch\u00fang ta khi sinh ra \u0111\u1eddi ch\u00fang ta._14077_retry_inferred.mp3", "callback_endpoint": "https://api-dev.ttsopenai.com/api/v1/voice-library/webhook/inference/0f1c42c6-576d-4fb1-b735-24f54e3e2396"}

{"asctime": "2024-09-01 17:28:35,055", "levelname": "INFO", "message": "Message sent, response ...", "name": "app.tts_common.helpers.tts_history_helper", "filename": "tts_history_helper.py", "lineno": 184, "module": "tts_history_helper", "funcName": "block_process_inference", "process": 7, "thread": 140314149652288}

{"asctime": "2024-09-01 17:28:35,056", "levelname": "INFO", "message": "{\"MD5OfMessageBody\": \"459fc1b49d0f94afdf217b519830d03a\", \"MessageId\": \"6dfbc852-ae32-40aa-b0ff-59457a315782\", \"ResponseMetadata\": {\"RequestId\": \"002664b2-3a94-55c3-96e6-3bfc1d677c3e\", \"HTTPStatusCode\": 200, \"HTTPHeaders\": {\"x-amzn-requestid\": \"002664b2-3a94-55c3-96e6-3bfc1d677c3e\", \"date\": \"Sun, 01 Sep 2024 08:28:35 GMT\", \"content-type\": \"text/xml\", \"content-length\": \"378\", \"connection\": \"keep-alive\"}, \"RetryAttempts\": 0}}", "name": "app.tts_common.helpers.tts_history_helper", "filename": "tts_history_helper.py", "lineno": 185, "module": "tts_history_helper", "funcName": "block_process_inference", "process": 7, "thread": 140314149652288}

{"asctime": "2024-09-01 17:28:35,070", "levelname": "INFO", "message": "Tracing request: PUT /api/v1/story/block/0f1c42c6-576d-4fb1-b735-24f54e3e2396/retry-speech", "name": "app.main", "filename": "main.py", "lineno": 63, "module": "main", "funcName": "dispatch", "process": 7, "thread": 140314149652288, "client-ip": "10.42.0.113", "path": "/api/v1/story/block/0f1c42c6-576d-4fb1-b735-24f54e3e2396/retry-speech", "user-agent": "Mozilla/5.0 (Windows NT 10.0; Win64; x64) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/128.0.0.0 Safari/537.36 Edg/128.0.0.0", "response-time": 70316.69020652771, "response-code": 200}

{"asctime": "2024-09-01 17:29:03,197", "levelname": "INFO", "message": "Tracing request: GET /api/v1/products", "name": "app.main", "filename": "main.py", "lineno": 63, "module": "main", "funcName": "dispatch", "process": 8, "thread": 140314149652288, "client-ip": "10.42.0.113", "path": "/api/v1/products", "user-agent": "HetrixTools Uptime Monitoring Bot. https://hetrix.tools/uptime-monitoring-bot.html", "response-time": 28.922319412231445, "response-code": 200}

{"asctime": "2024-09-01 17:29:03,199", "levelname": "INFO", "message": "10.42.0.113:35024 - \"GET /api/v1/products HTTP/1.1\" 200", "name": "uvicorn.access", "filename": "h11_impl.py", "lineno": 498, "module": "h11_impl", "funcName": "send", "process": 8, "thread": 140314149652288}

{"asctime": "2024-09-01 17:29:10,075", "levelname": "INFO", "message": "Tracing request: GET /api/v1/products", "name": "app.main", "filename": "main.py", "lineno": 63, "module": "main", "funcName": "dispatch", "process": 8, "thread": 140314149652288, "client-ip": "10.42.0.113", "path": "/api/v1/products", "user-agent": "HetrixTools Uptime Monitoring Bot. https://hetrix.tools/uptime-monitoring-bot.html", "response-time": 23.501157760620117, "response-code": 200}

{"asctime": "2024-09-01 17:29:10,076", "levelname": "INFO", "message": "10.42.0.113:53470 - \"GET /api/v1/products HTTP/1.1\" 200", "name": "uvicorn.access", "filename": "h11_impl.py", "lineno": 498, "module": "h11_impl", "funcName": "send", "process": 8, "thread": 140314149652288}

{"asctime": "2024-09-01 17:29:12,379", "levelname": "INFO", "message": "Init key service with priorities: [94, 96, 97]", "name": "app.tts_common.services.key_service", "filename": "key_service.py", "lineno": 28, "module": "key_service", "funcName": "__init__", "process": 8, "thread": 140314003539712}

{"asctime": "2024-09-01 17:29:12,381", "levelname": "INFO", "message": "route /voice-library/webhook/inference/0f1c42c6-576d-4fb1-b735-24f54e3e2396", "name": "app.api.api_v1.endpoints.voice_library", "filename": "voice_library.py", "lineno": 122, "module": "voice_library", "funcName": "voice_inference_webhook", "process": 8, "thread": 140314149652288}

{"asctime": "2024-09-01 17:29:12,381", "levelname": "INFO", "message": "request body:", "name": "app.api.api_v1.endpoints.voice_library", "filename": "voice_library.py", "lineno": 125, "module": "voice_library", "funcName": "voice_inference_webhook", "process": 8, "thread": 140314149652288}

{"asctime": "2024-09-01 17:29:12,381", "levelname": "INFO", "message": "", "name": "app.api.api_v1.endpoints.voice_library", "filename": "voice_library.py", "lineno": 126, "module": "voice_library", "funcName": "voice_inference_webhook", "process": 8, "thread": 140314149652288, "status": "completed", "code": 200, "error": null}

status: completed

{"asctime": "2024-09-01 17:29:12,402", "levelname": "INFO", "message": "START update_tts_text_by_story_block", "name": "app.tts_common.services.story_service", "filename": "story_service.py", "lineno": 588, "module": "story_service", "funcName": "update_tts_text_by_story_block", "process": 8, "thread": 140314149652288}

{"asctime": "2024-09-01 17:29:12,402", "levelname": "INFO", "message": "Processing tts-text e0d45310-67a2-11ef-8348-72fb72429f3e", "name": "app.tts_common.services.story_service", "filename": "story_service.py", "lineno": 589, "module": "story_service", "funcName": "update_tts_text_by_story_block", "process": 8, "thread": 140314149652288}

{"asctime": "2024-09-01 17:29:12,402", "levelname": "INFO", "message": "tts-text is COMPLETED", "name": "app.tts_common.services.story_service", "filename": "story_service.py", "lineno": 592, "module": "story_service", "funcName": "update_tts_text_by_story_block", "process": 8, "thread": 140314149652288}

{"asctime": "2024-09-01 17:29:12,402", "levelname": "INFO", "message": "stop update tts-text e0d45310-67a2-11ef-8348-72fb72429f3e", "name": "app.tts_common.services.story_service", "filename": "story_service.py", "lineno": 593, "module": "story_service", "funcName": "update_tts_text_by_story_block", "process": 8, "thread": 140314149652288}

{"asctime": "2024-09-01 17:29:12,403", "levelname": "INFO", "message": "START deduct_retry_speech_block_credit", "name": "app.tts_common.services.story_service", "filename": "story_service.py", "lineno": 926, "module": "story_service", "funcName": "deduct_retry_speech_block_credit", "process": 8, "thread": 140314149652288}

{"asctime": "2024-09-01 17:29:12,403", "levelname": "INFO", "message": "processing block: 0f1c42c6-576d-4fb1-b735-24f54e3e2396", "name": "app.tts_common.services.story_service", "filename": "story_service.py", "lineno": 927, "module": "story_service", "funcName": "deduct_retry_speech_block_credit", "process": 8, "thread": 140314149652288}

{"asctime": "2024-09-01 17:29:12,418", "levelname": "INFO", "message": "user_id:204 - plan_id:PP0001", "name": "app.tts_common.services.story_service", "filename": "story_service.py", "lineno": 941, "module": "story_service", "funcName": "deduct_retry_speech_block_credit", "process": 8, "thread": 140314149652288}

{"asctime": "2024-09-01 17:29:12,419", "levelname": "INFO", "message": "processing update block 14077 block_used_credit: 22518", "name": "app.tts_common.services.story_service", "filename": "story_service.py", "lineno": 944, "module": "story_service", "funcName": "deduct_retry_speech_block_credit", "process": 8, "thread": 140314149652288}

{"asctime": "2024-09-01 17:29:12,447", "levelname": "INFO", "message": "processing update story 3587 story_used_credit: 37488", "name": "app.tts_common.services.story_service", "filename": "story_service.py", "lineno": 951, "module": "story_service", "funcName": "deduct_retry_speech_block_credit", "process": 8, "thread": 140314149652288}

{"asctime": "2024-09-01 17:29:12,470", "levelname": "INFO", "message": "Deduct user:204 Amount:2502", "name": "app.tts_common.services.story_service", "filename": "story_service.py", "lineno": 957, "module": "story_service", "funcName": "deduct_retry_speech_block_credit", "process": 8, "thread": 140314149652288}

{"asctime": "2024-09-01 17:29:12,475", "levelname": "INFO", "message": "Deduct user's credits: 2502", "name": "app.tts_common.services.user", "filename": "user.py", "lineno": 130, "module": "user", "funcName": "deduct_user_credits", "process": 8, "thread": 140314149652288}

{"asctime": "2024-09-01 17:29:12,500", "levelname": "INFO", "message": "Update user's credits completed: ", "name": "app.tts_common.services.user", "filename": "user.py", "lineno": 155, "module": "user", "funcName": "deduct_user_credits", "process": 8, "thread": 140314149652288}

{"asctime": "2024-09-01 17:29:12,507", "levelname": "INFO", "message": "START recalculate_user_lock_credit ...", "name": "app.tts_common.services.story_service", "filename": "story_service.py", "lineno": 655, "module": "story_service", "funcName": "recalculate_user_lock_credit", "process": 8, "thread": 140314149652288}

{"asctime": "2024-09-01 17:29:12,512", "levelname": "INFO", "message": "Update locking credits: 0", "name": "app.tts_common.services.story_service", "filename": "story_service.py", "lineno": 659, "module": "story_service", "funcName": "recalculate_user_lock_credit", "process": 8, "thread": 140314149652288}

{"asctime": "2024-09-01 17:29:12,542", "levelname": "INFO", "message": "Tracing request: PUT /api/v1/voice-library/webhook/inference/0f1c42c6-576d-4fb1-b735-24f54e3e2396", "name": "app.main", "filename": "main.py", "lineno": 63, "module": "main", "funcName": "dispatch", "process": 8, "thread": 140314149652288, "client-ip": "10.42.0.113", "path": "/api/v1/voice-library/webhook/inference/0f1c42c6-576d-4fb1-b735-24f54e3e2396", "user-agent": "python-requests/2.31.0", "response-time": 195.12391090393066, "response-code": 200}

{"asctime": "2024-09-01 17:29:12,543", "levelname": "INFO", "message": "10.42.0.113:53476 - \"PUT /api/v1/voice-library/webhook/inference/0f1c42c6-576d-4fb1-b735-24f54e3e2396 HTTP/1.1\" 200", "name": "uvicorn.access", "filename": "h11_impl.py", "lineno": 498, "module": "h11_impl", "funcName": "send", "process": 8, "thread": 140314149652288}

{"asctime": "2024-09-01 17:29:13,222", "levelname": "INFO", "message": "Tracing request: GET /api/v1/products", "name": "app.main", "filename": "main.py", "lineno": 63, "module": "main", "funcName": "dispatch", "process": 7, "thread": 140314149652288, "client-ip": "10.42.0.113", "path": "/api/v1/products", "user-agent": "HetrixTools Uptime Monitoring Bot. https://hetrix.tools/uptime-monitoring-bot.html", "response-time": 28.406620025634766, "response-code": 200}

{"asctime": "2024-09-01 17:29:13,223", "levelname": "INFO", "message": "10.42.0.113:53488 - \"GET /api/v1/products HTTP/1.1\" 200", "name": "uvicorn.access", "filename": "h11_impl.py", "lineno": 498, "module": "h11_impl", "funcName": "send", "process": 7, "thread": 140314149652288}