By type
*** Starting uWSGI 2.0.19.1 (64bit) on [Wed Jul 7 07:06:15 2021] ***
compiled with version: 9.3.0 on 16 March 2021 05:56:01
os: Linux-4.19.0-13-cloud-amd64 #1 SMP Debian 4.19.160-2 (2020-11-28)
nodename: onap-oof-has-api-7fbfc68cfb-7xcq5
machine: x86_64
clock source: unix
pcre jit disabled
detected number of CPU cores: 16
current working directory: /app
writing pidfile to /run/conductor/conductor-uwsgi.pid
detected binary path: /usr/local/bin/uwsgi
your memory page size is 4096 bytes
detected max file descriptor number: 1048576
lock engine: pthread robust mutexes
thunder lock: disabled (you can enable it with --thunder-lock)
uwsgi socket 0 bound to UNIX address /run/conductor/uwsgi.sock fd 3
uwsgi socket 1 bound to TCP address 0.0.0.0:8080 fd 4
Python version: 3.9.1 (default, Dec 11 2020, 14:29:41) [GCC 9.3.0]
Python main interpreter initialized at 0x561ba84a08e0
python threads support enabled
your server socket listen backlog is limited to 100 connections
your mercy for graceful operations on workers is 60 seconds
mapped 510440 bytes (498 KB) for 6 cores
*** Operational MODE: preforking ***
2021-07-07 07:06:18,048||140533991710024|INFO|app|conductor.api.app: [-] Full WSGI config used: /usr/local/etc/conductor/api_paste.ini
2021-07-07 07:06:18,050||140533991710024|INFO|api|conductor.common.music.api: [-] Initializing Music API
WSGI app 0 (mountpoint='') ready in 3 seconds on interpreter 0x561ba84a08e0 pid: 1 (default app)
spawned uWSGI master process (pid: 1)
spawned uWSGI worker 1 (pid: 142, cores: 1)
spawned uWSGI worker 2 (pid: 143, cores: 1)
spawned uWSGI worker 3 (pid: 144, cores: 1)
spawned uWSGI worker 4 (pid: 145, cores: 1)
spawned uWSGI worker 5 (pid: 146, cores: 1)
spawned uWSGI worker 6 (pid: 147, cores: 1)
worker 1 lifetime reached, it was running for 301 second(s)
worker 2 lifetime reached, it was running for 301 second(s)
worker 3 lifetime reached, it was running for 301 second(s)
worker 4 lifetime reached, it was running for 301 second(s)
worker 5 lifetime reached, it was running for 301 second(s)
worker 6 lifetime reached, it was running for 301 second(s)
Respawned uWSGI worker 1 (new pid: 148)
Respawned uWSGI worker 2 (new pid: 149)
Respawned uWSGI worker 3 (new pid: 150)
Respawned uWSGI worker 4 (new pid: 151)
Respawned uWSGI worker 5 (new pid: 152)
Respawned uWSGI worker 6 (new pid: 153)
worker 1 lifetime reached, it was running for 301 second(s)
worker 2 lifetime reached, it was running for 301 second(s)
worker 3 lifetime reached, it was running for 301 second(s)
worker 4 lifetime reached, it was running for 301 second(s)
worker 5 lifetime reached, it was running for 301 second(s)
worker 6 lifetime reached, it was running for 301 second(s)
Respawned uWSGI worker 1 (new pid: 154)
Respawned uWSGI worker 2 (new pid: 155)
Respawned uWSGI worker 3 (new pid: 156)
Respawned uWSGI worker 4 (new pid: 157)
Respawned uWSGI worker 5 (new pid: 158)
Respawned uWSGI worker 6 (new pid: 159)
worker 1 lifetime reached, it was running for 301 second(s)
worker 2 lifetime reached, it was running for 301 second(s)
worker 3 lifetime reached, it was running for 301 second(s)
worker 4 lifetime reached, it was running for 301 second(s)
worker 5 lifetime reached, it was running for 301 second(s)
worker 6 lifetime reached, it was running for 301 second(s)
Respawned uWSGI worker 1 (new pid: 160)
Respawned uWSGI worker 2 (new pid: 161)
Respawned uWSGI worker 3 (new pid: 162)
Respawned uWSGI worker 4 (new pid: 163)
Respawned uWSGI worker 5 (new pid: 164)
Respawned uWSGI worker 6 (new pid: 165)
worker 1 lifetime reached, it was running for 301 second(s)
worker 2 lifetime reached, it was running for 301 second(s)
worker 3 lifetime reached, it was running for 301 second(s)
worker 4 lifetime reached, it was running for 301 second(s)
worker 5 lifetime reached, it was running for 301 second(s)
worker 6 lifetime reached, it was running for 301 second(s)
Respawned uWSGI worker 1 (new pid: 166)
Respawned uWSGI worker 2 (new pid: 167)
Respawned uWSGI worker 3 (new pid: 168)
Respawned uWSGI worker 4 (new pid: 169)
Respawned uWSGI worker 5 (new pid: 170)
Respawned uWSGI worker 6 (new pid: 171)
worker 1 lifetime reached, it was running for 301 second(s)
worker 2 lifetime reached, it was running for 301 second(s)
worker 3 lifetime reached, it was running for 301 second(s)
worker 4 lifetime reached, it was running for 301 second(s)
worker 5 lifetime reached, it was running for 301 second(s)
worker 6 lifetime reached, it was running for 301 second(s)
Respawned uWSGI worker 1 (new pid: 172)
Respawned uWSGI worker 2 (new pid: 173)
Respawned uWSGI worker 3 (new pid: 174)
Respawned uWSGI worker 4 (new pid: 175)
Respawned uWSGI worker 5 (new pid: 176)
Respawned uWSGI worker 6 (new pid: 177)
worker 1 lifetime reached, it was running for 301 second(s)
worker 2 lifetime reached, it was running for 301 second(s)
worker 3 lifetime reached, it was running for 301 second(s)
worker 4 lifetime reached, it was running for 301 second(s)
worker 5 lifetime reached, it was running for 301 second(s)
worker 6 lifetime reached, it was running for 301 second(s)
Respawned uWSGI worker 1 (new pid: 178)
Respawned uWSGI worker 2 (new pid: 179)
Respawned uWSGI worker 3 (new pid: 180)
Respawned uWSGI worker 4 (new pid: 181)
Respawned uWSGI worker 5 (new pid: 182)
Respawned uWSGI worker 6 (new pid: 183)
worker 1 lifetime reached, it was running for 301 second(s)
worker 2 lifetime reached, it was running for 301 second(s)
worker 3 lifetime reached, it was running for 301 second(s)
worker 4 lifetime reached, it was running for 301 second(s)
worker 5 lifetime reached, it was running for 301 second(s)
worker 6 lifetime reached, it was running for 301 second(s)
Respawned uWSGI worker 1 (new pid: 184)
Respawned uWSGI worker 2 (new pid: 185)
Respawned uWSGI worker 3 (new pid: 186)
Respawned uWSGI worker 4 (new pid: 187)
Respawned uWSGI worker 5 (new pid: 188)
Respawned uWSGI worker 6 (new pid: 189)
worker 1 lifetime reached, it was running for 301 second(s)
worker 2 lifetime reached, it was running for 301 second(s)
worker 3 lifetime reached, it was running for 301 second(s)
worker 4 lifetime reached, it was running for 301 second(s)
worker 5 lifetime reached, it was running for 301 second(s)
worker 6 lifetime reached, it was running for 301 second(s)
Respawned uWSGI worker 1 (new pid: 190)
Respawned uWSGI worker 2 (new pid: 191)
Respawned uWSGI worker 3 (new pid: 192)
Respawned uWSGI worker 4 (new pid: 193)
Respawned uWSGI worker 5 (new pid: 194)
Respawned uWSGI worker 6 (new pid: 195)
worker 1 lifetime reached, it was running for 301 second(s)
worker 2 lifetime reached, it was running for 301 second(s)
worker 3 lifetime reached, it was running for 301 second(s)
worker 4 lifetime reached, it was running for 301 second(s)
worker 5 lifetime reached, it was running for 301 second(s)
worker 6 lifetime reached, it was running for 301 second(s)
Respawned uWSGI worker 1 (new pid: 196)
Respawned uWSGI worker 2 (new pid: 197)
Respawned uWSGI worker 3 (new pid: 198)
Respawned uWSGI worker 4 (new pid: 199)
Respawned uWSGI worker 5 (new pid: 200)
Respawned uWSGI worker 6 (new pid: 201)
worker 1 lifetime reached, it was running for 301 second(s)
worker 2 lifetime reached, it was running for 301 second(s)
worker 3 lifetime reached, it was running for 301 second(s)
worker 4 lifetime reached, it was running for 301 second(s)
worker 5 lifetime reached, it was running for 301 second(s)
worker 6 lifetime reached, it was running for 301 second(s)
Respawned uWSGI worker 1 (new pid: 202)
Respawned uWSGI worker 2 (new pid: 203)
Respawned uWSGI worker 3 (new pid: 204)
Respawned uWSGI worker 4 (new pid: 205)
Respawned uWSGI worker 5 (new pid: 206)
Respawned uWSGI worker 6 (new pid: 207)
worker 1 lifetime reached, it was running for 301 second(s)
worker 2 lifetime reached, it was running for 301 second(s)
worker 3 lifetime reached, it was running for 301 second(s)
worker 4 lifetime reached, it was running for 301 second(s)
worker 5 lifetime reached, it was running for 301 second(s)
worker 6 lifetime reached, it was running for 301 second(s)
Respawned uWSGI worker 1 (new pid: 208)
Respawned uWSGI worker 2 (new pid: 209)
Respawned uWSGI worker 3 (new pid: 210)
Respawned uWSGI worker 4 (new pid: 211)
Respawned uWSGI worker 5 (new pid: 212)
Respawned uWSGI worker 6 (new pid: 213)
worker 1 lifetime reached, it was running for 301 second(s)
worker 2 lifetime reached, it was running for 301 second(s)
worker 3 lifetime reached, it was running for 301 second(s)
worker 4 lifetime reached, it was running for 301 second(s)
worker 5 lifetime reached, it was running for 301 second(s)
worker 6 lifetime reached, it was running for 301 second(s)
Respawned uWSGI worker 1 (new pid: 214)
Respawned uWSGI worker 2 (new pid: 215)
Respawned uWSGI worker 3 (new pid: 216)
Respawned uWSGI worker 4 (new pid: 217)
Respawned uWSGI worker 5 (new pid: 218)
Respawned uWSGI worker 6 (new pid: 219)
worker 1 lifetime reached, it was running for 301 second(s)
worker 2 lifetime reached, it was running for 301 second(s)
worker 3 lifetime reached, it was running for 301 second(s)
worker 4 lifetime reached, it was running for 301 second(s)
worker 5 lifetime reached, it was running for 301 second(s)
worker 6 lifetime reached, it was running for 301 second(s)
Respawned uWSGI worker 1 (new pid: 220)
Respawned uWSGI worker 2 (new pid: 221)
Respawned uWSGI worker 3 (new pid: 222)
Respawned uWSGI worker 4 (new pid: 223)
Respawned uWSGI worker 5 (new pid: 224)
Respawned uWSGI worker 6 (new pid: 225)
worker 1 lifetime reached, it was running for 301 second(s)
worker 2 lifetime reached, it was running for 301 second(s)
worker 3 lifetime reached, it was running for 301 second(s)
worker 4 lifetime reached, it was running for 301 second(s)
worker 5 lifetime reached, it was running for 301 second(s)
worker 6 lifetime reached, it was running for 301 second(s)
Respawned uWSGI worker 1 (new pid: 226)
Respawned uWSGI worker 2 (new pid: 227)
Respawned uWSGI worker 3 (new pid: 228)
Respawned uWSGI worker 4 (new pid: 229)
Respawned uWSGI worker 5 (new pid: 230)
Respawned uWSGI worker 6 (new pid: 231)
2021-07-07 08:18:36,027||140533991710024|INFO|component|conductor.common.music.messaging.component: [-] Message 8dd7e76a-fefa-4217-be2a-6fab51b11605 on topic controller enqueued.
2021-07-07 08:20:36,352||140533991710024|ERROR|component|conductor.common.music.messaging.component: [-] Message 8dd7e76a-fefa-4217-be2a-6fab51b11605 on topic controller timed out at 120 seconds
2021-07-07 08:20:36,354||140533991710024|CRITICAL|log|conductor: [-] Unhandled error
Traceback (most recent call last):
File "/usr/local/lib/python3.9/site-packages/pecan/routing.py", line 141, in lookup_controller
obj, remainder = find_object(obj, remainder, notfound_handlers,
File "/usr/local/lib/python3.9/site-packages/pecan/routing.py", line 197, in find_object
raise PecanNotFound
pecan.routing.PecanNotFound
During handling of the above exception, another exception occurred:
Traceback (most recent call last):
File "/usr/local/lib/python3.9/site-packages/webob/dec.py", line 129, in __call__
resp = self.call_func(req, *args, **kw)
File "/usr/local/lib/python3.9/site-packages/webob/dec.py", line 193, in call_func
return self.func(req, *args, **kwargs)
File "/usr/local/lib/python3.9/site-packages/oslo_middleware/base.py", line 124, in __call__
response = req.get_response(self.application)
File "/usr/local/lib/python3.9/site-packages/webob/request.py", line 1313, in send
status, headers, app_iter = self.call_application(
File "/usr/local/lib/python3.9/site-packages/webob/request.py", line 1278, in call_application
app_iter = application(self.environ, start_response)
File "/usr/local/lib/python3.9/site-packages/webob/dec.py", line 129, in __call__
resp = self.call_func(req, *args, **kw)
File "/usr/local/lib/python3.9/site-packages/webob/dec.py", line 193, in call_func
return self.func(req, *args, **kwargs)
File "/usr/local/lib/python3.9/site-packages/oslo_middleware/base.py", line 124, in __call__
response = req.get_response(self.application)
File "/usr/local/lib/python3.9/site-packages/webob/request.py", line 1313, in send
status, headers, app_iter = self.call_application(
File "/usr/local/lib/python3.9/site-packages/webob/request.py", line 1278, in call_application
app_iter = application(self.environ, start_response)
File "/usr/local/lib/python3.9/site-packages/pecan/middleware/recursive.py", line 56, in __call__
return self.application(environ, start_response)
File "/opt/has/conductor/conductor/api/middleware.py", line 130, in __call__
app_iter = self.app(environ, replacement_start_response)
File "/usr/local/lib/python3.9/site-packages/pecan/core.py", line 852, in __call__
return super(Pecan, self).__call__(environ, start_response)
File "/usr/local/lib/python3.9/site-packages/pecan/core.py", line 692, in __call__
controller, args, kwargs = self.find_controller(state)
File "/usr/local/lib/python3.9/site-packages/pecan/core.py", line 870, in find_controller
controller, args, kw = super(Pecan, self).find_controller(_state)
File "/usr/local/lib/python3.9/site-packages/pecan/core.py", line 460, in find_controller
controller, remainder = self.route(req, self.root, path)
File "/usr/local/lib/python3.9/site-packages/pecan/core.py", line 293, in route
node, remainder = lookup_controller(node, path, req)
File "/usr/local/lib/python3.9/site-packages/pecan/routing.py", line 158, in lookup_controller
result = handle_lookup_traversal(obj, remainder)
File "/usr/local/lib/python3.9/site-packages/pecan/routing.py", line 175, in handle_lookup_traversal
result = obj(*args)
File "/opt/has/conductor/conductor/api/controllers/v1/plans.py", line 311, in _lookup
return PlansItemController(uuid4), remainder
File "/opt/has/conductor/conductor/api/controllers/v1/plans.py", line 190, in __init__
self.plan = self.plans_get(plan_id=self.uuid)
File "/opt/has/conductor/conductor/api/controllers/v1/plans.py", line 95, in plans_get
return self.plan_getid(plan_id)
File "/opt/has/conductor/conductor/api/controllers/v1/plans.py", line 110, in plan_getid
result = client.call(ctx, method, args)
File "/opt/has/conductor/conductor/common/music/messaging/component.py", line 229, in call
response = rpc.response
AttributeError: 'NoneType' object has no attribute 'response'
[pid: 227|app: 0|req: 1/1] 10.233.77.241 () {46 vars in 589 bytes} [Wed Jul 7 08:18:35 2021] GET /v1/plans/healthcheck => generated 0 bytes in 120446 msecs (HTTP/1.1 500) 0 headers in 0 bytes (1 switches on core 0)
2021-07-07 08:21:21,954||140533991710024|INFO|component|conductor.common.music.messaging.component: [-] Message a8d8a678-aa58-473a-9626-22eca047b010 on topic controller enqueued.
[pid: 230|app: 0|req: 1/2] 10.233.67.83 () {46 vars in 586 bytes} [Wed Jul 7 08:21:18 2021] GET /v1/plans/healthcheck => generated 159 bytes in 10261 msecs (HTTP/1.1 200) 5 headers in 134 bytes (1 switches on core 0)
worker 1 lifetime reached, it was running for 301 second(s)
worker 2 lifetime reached, it was running for 301 second(s)
worker 3 lifetime reached, it was running for 301 second(s)
worker 4 lifetime reached, it was running for 301 second(s)
worker 5 lifetime reached, it was running for 301 second(s)
worker 6 lifetime reached, it was running for 301 second(s)
Respawned uWSGI worker 1 (new pid: 316)
Respawned uWSGI worker 2 (new pid: 317)
Respawned uWSGI worker 3 (new pid: 318)
Respawned uWSGI worker 4 (new pid: 319)
Respawned uWSGI worker 5 (new pid: 320)
Respawned uWSGI worker 6 (new pid: 321)
2021-07-07 08:23:14,351||140533991710024|INFO|component|conductor.common.music.messaging.component: [-] Message 9ada055e-c47c-4fde-94a9-fc2b8978c510 on topic controller enqueued.
[pid: 318|app: 0|req: 1/3] 10.233.67.12 () {46 vars in 586 bytes} [Wed Jul 7 08:23:07 2021] GET /v1/plans/healthcheck => generated 159 bytes in 18159 msecs (HTTP/1.1 200) 5 headers in 134 bytes (1 switches on core 0)
2021-07-07 08:25:11,799||140533991710024|INFO|component|conductor.common.music.messaging.component: [-] Message 5a9f6a6f-58d3-43ba-80b9-c350233086bb on topic controller enqueued.
[pid: 321|app: 0|req: 1/4] 10.233.77.190 () {46 vars in 589 bytes} [Wed Jul 7 08:25:11 2021] GET /v1/plans/healthcheck => generated 159 bytes in 2780 msecs (HTTP/1.1 200) 5 headers in 134 bytes (1 switches on core 0)
worker 1 lifetime reached, it was running for 301 second(s)
worker 2 lifetime reached, it was running for 301 second(s)
worker 3 lifetime reached, it was running for 301 second(s)
worker 4 lifetime reached, it was running for 301 second(s)
worker 5 lifetime reached, it was running for 301 second(s)
worker 6 lifetime reached, it was running for 301 second(s)
Respawned uWSGI worker 1 (new pid: 332)
Respawned uWSGI worker 2 (new pid: 333)
Respawned uWSGI worker 3 (new pid: 334)
Respawned uWSGI worker 4 (new pid: 335)
Respawned uWSGI worker 5 (new pid: 336)
Respawned uWSGI worker 6 (new pid: 337)
2021-07-07 08:26:35,685||140533991710024|INFO|component|conductor.common.music.messaging.component: [-] Message 51a57cf1-8bea-4e91-a463-58e8dfe4c419 on topic controller enqueued.
[pid: 332|app: 0|req: 1/5] 10.233.77.51 () {46 vars in 586 bytes} [Wed Jul 7 08:26:35 2021] GET /v1/plans/healthcheck => generated 159 bytes in 6364 msecs (HTTP/1.1 200) 5 headers in 134 bytes (1 switches on core 0)
2021-07-07 08:29:14,987||140533991710024|INFO|component|conductor.common.music.messaging.component: [-] Message d6f0353d-4d91-421d-9886-87bb8c562665 on topic controller enqueued.
[pid: 333|app: 0|req: 2/6] 10.233.77.42 () {46 vars in 586 bytes} [Wed Jul 7 08:29:14 2021] GET /v1/plans/healthcheck => generated 159 bytes in 6775 msecs (HTTP/1.1 200) 5 headers in 134 bytes (1 switches on core 0)
worker 1 lifetime reached, it was running for 301 second(s)
worker 2 lifetime reached, it was running for 301 second(s)
worker 3 lifetime reached, it was running for 301 second(s)
worker 4 lifetime reached, it was running for 301 second(s)
worker 5 lifetime reached, it was running for 301 second(s)
worker 6 lifetime reached, it was running for 301 second(s)
Respawned uWSGI worker 1 (new pid: 347)
Respawned uWSGI worker 2 (new pid: 348)
Respawned uWSGI worker 3 (new pid: 349)
Respawned uWSGI worker 4 (new pid: 350)
Respawned uWSGI worker 5 (new pid: 351)
Respawned uWSGI worker 6 (new pid: 352)
worker 1 lifetime reached, it was running for 301 second(s)
worker 2 lifetime reached, it was running for 301 second(s)
worker 3 lifetime reached, it was running for 301 second(s)
worker 4 lifetime reached, it was running for 301 second(s)
worker 5 lifetime reached, it was running for 301 second(s)
worker 6 lifetime reached, it was running for 301 second(s)
Respawned uWSGI worker 1 (new pid: 353)
Respawned uWSGI worker 2 (new pid: 354)
Respawned uWSGI worker 3 (new pid: 355)
Respawned uWSGI worker 4 (new pid: 356)
Respawned uWSGI worker 5 (new pid: 357)
Respawned uWSGI worker 6 (new pid: 358)
worker 1 lifetime reached, it was running for 301 second(s)
worker 2 lifetime reached, it was running for 301 second(s)
worker 3 lifetime reached, it was running for 301 second(s)
worker 4 lifetime reached, it was running for 301 second(s)
worker 5 lifetime reached, it was running for 301 second(s)
worker 6 lifetime reached, it was running for 301 second(s)
Respawned uWSGI worker 1 (new pid: 359)
Respawned uWSGI worker 2 (new pid: 360)
Respawned uWSGI worker 3 (new pid: 361)
Respawned uWSGI worker 4 (new pid: 362)
Respawned uWSGI worker 5 (new pid: 363)
Respawned uWSGI worker 6 (new pid: 364)
worker 1 lifetime reached, it was running for 301 second(s)
worker 2 lifetime reached, it was running for 301 second(s)
worker 3 lifetime reached, it was running for 301 second(s)
worker 4 lifetime reached, it was running for 301 second(s)
worker 5 lifetime reached, it was running for 301 second(s)
worker 6 lifetime reached, it was running for 301 second(s)
Respawned uWSGI worker 1 (new pid: 365)
Respawned uWSGI worker 2 (new pid: 366)
Respawned uWSGI worker 3 (new pid: 367)
Respawned uWSGI worker 4 (new pid: 368)
Respawned uWSGI worker 5 (new pid: 369)
Respawned uWSGI worker 6 (new pid: 370)
worker 1 lifetime reached, it was running for 301 second(s)
worker 2 lifetime reached, it was running for 301 second(s)
worker 3 lifetime reached, it was running for 301 second(s)
worker 4 lifetime reached, it was running for 301 second(s)
worker 5 lifetime reached, it was running for 301 second(s)
worker 6 lifetime reached, it was running for 301 second(s)
Respawned uWSGI worker 1 (new pid: 371)
Respawned uWSGI worker 2 (new pid: 372)
Respawned uWSGI worker 3 (new pid: 373)
Respawned uWSGI worker 4 (new pid: 374)
Respawned uWSGI worker 5 (new pid: 375)
Respawned uWSGI worker 6 (new pid: 376)