python app under 1.26.0 issue

[lhmwzy]

I think is releated with the following commit:
https://github.com/nginx/unit/commit/ff6a7053f500414dc74568a4e49adbac7f0cf634




At 2021-11-19 10:58:56, "lhmwzy" <lhmwzy at 126.com> wrote:

run https://unit.nginx.org/configuration/#python under 1.26.0
the unitd hangs.
the console output:
2021/11/19 10:53:58.239 [debug] 52506#34365452480 kevent(3): 1
2021/11/19 10:53:58.239 [debug] 52506#34365452480 kevent: id:15 ft:-6 fl:0021 ff:0 d:1 ud:467A28
2021/11/19 10:53:58.239 [debug] 52506#34365452480 timer expire minimum: 719467235:633189665
2021/11/19 10:53:58.239 [debug] 52506#34365452480 work queue: fast
2021/11/19 10:53:58.239 [debug] 52506#34365452480 sigterm handler signo:15 (SIGTERM)
2021/11/19 10:53:58.239 [debug] 52506#34365452480 exiting
2021/11/19 10:53:58.239 [debug] 52506#34365452480 close idle connections
2021/11/19 10:53:58.239 [debug] 52506#34365452480 work queue: fast
2021/11/19 10:53:58.239 [debug] 52506#34365452480 thread pools: 0
2021/11/19 10:53:58.239 [debug] 52506#34365452480 unlink("/usr/local/nginxunittest/unit.pid")
2021/11/19 10:53:58.239 [debug] 52506#34365452480 unlink("/usr/local/nginxunittest/control.unit.sock")
2021/11/19 10:53:58.239 [debug] 52506#34365452480 pthread_mutex_lock(800654270) enter
2021/11/19 10:53:58.239 [debug] 52506#34365452480 process 52506 removed
2021/11/19 10:53:58.239 [debug] 52506#34365452480 pthread_mutex_unlock(800654270) exit
2021/11/19 10:53:58.239 [debug] 52506#34365452480 port 800572DC0 52506:0 close, type 0
2021/11/19 10:53:58.239 [debug] 52506#34365452480 close(6)
2021/11/19 10:53:58.239 [debug] 52506#34365452480 close(7)
2021/11/19 10:53:58.239 [debug] 52506#34365452480 pthread_mutex_lock(800654270) enter
2021/11/19 10:53:58.239 [debug] 52506#34365452480 free(800EB0B00)
2021/11/19 10:53:58.239 [debug] 52506#34365452480 process 52509 removed
2021/11/19 10:53:58.239 [debug] 52506#34365452480 pthread_mutex_unlock(800654270) exit
2021/11/19 10:53:58.239 [debug] 52506#34365452480 port 800572AC0 52509:0 close, type 2
2021/11/19 10:53:58.239 [debug] 52506#34365452480 close(10)
2021/11/19 10:53:58.239 [debug] 52506#34365452480 free(800EB0A80)
2021/11/19 10:53:58.239 [debug] 52506#34365452480 port 800572AC0 52509:0 release, type 2
2021/11/19 10:53:58.239 [debug] 52506#34365452480 free(0)
2021/11/19 10:53:58.239 [debug] 52506#34365452480 pthread_mutex_destroy(800686828)
2021/11/19 10:53:58.239 [debug] 52506#34365452480 free(800670FF0)
2021/11/19 10:53:58.239 [debug] 52506#34365452480 free(800686800)
2021/11/19 10:53:58.239 [debug] 52506#34365452480 mp 800611400 release: 0
2021/11/19 10:53:58.239 [debug] 52506#34365452480 pthread_mutex_destroy(800572B78)
2021/11/19 10:53:58.239 [debug] 52506#34365452480 free(800572AC0)
2021/11/19 10:53:58.239 [debug] 52506#34365452480 free(800670F60)
2021/11/19 10:53:58.239 [debug] 52506#34365452480 free(800686400)
2021/11/19 10:53:58.239 [debug] 52506#34365452480 free(800611400)
2021/11/19 10:53:58.239 [debug] 52506#34365452480 pthread_mutex_destroy(800654270)
2021/11/19 10:53:58.239 [debug] 52506#34365452480 free(800654200)
2021/11/19 10:53:58.239 [debug] 52506#34365452480 free(8006668C0)
2021/11/19 10:53:58.239 [debug] 52506#34365452480 free(800671110)
2021/11/19 10:53:58.239 [debug] 52506#34365452480 free(800687000)
2021/11/19 10:53:58.239 [debug] 52506#34365452480 free(800671230)
2021/11/19 10:53:58.239 [debug] 52506#34365452480 free(800687C00)
2021/11/19 10:53:58.239 [debug] 52506#34365452480 free(8006712C0)
2021/11/19 10:53:58.239 [debug] 52506#34365452480 free(800688400)
2021/11/19 10:53:58.239 [debug] 52506#34365452480 free(8006116C0)
2021/11/19 10:53:58.239 [debug] 52928#34365452480 close(10)
2021/11/19 10:53:58.239 [debug] 52927#34365452480 free(800611350)
2021/11/19 10:53:58.239 [debug] 52927#34365452480 pthread_mutex_destroy(800654270)
2021/11/19 10:53:58.239 [alert] 52928#34365452480 close(10) failed (9: Bad file descriptor)
2021/11/19 10:53:58.239 [debug] 52928#34365452480 free(800EB0A80)
2021/11/19 10:53:58.239 [debug] 52927#34365452480 free(800654200)
2021/11/19 10:53:58.239 [debug] 52928#34365452480 port 800572AC0 52927:0 release, type 2
2021/11/19 10:53:58.239 [debug] 52928#34365452480 free(0)
2021/11/19 10:53:58.239 [debug] 52928#34365452480 pthread_mutex_destroy(800686828)
2021/11/19 10:53:58.239 [debug] 52928#34365452480 free(800670FF0)
2021/11/19 10:53:58.239 [debug] 52928#34365452480 free(800686800)
2021/11/19 10:53:58.239 [debug] 52928#34365452480 mp 8006112A0 release: 0
2021/11/19 10:53:58.239 [debug] 52928#34365452480 pthread_mutex_destroy(800572B78)
2021/11/19 10:53:58.239 [debug] 52928#34365452480 free(800572AC0)
2021/11/19 10:53:58.239 [debug] 52927#34365452480 free(8006668C0)
2021/11/19 10:53:58.239 [debug] 52928#34365452480 free(800670F60)
2021/11/19 10:53:58.239 [debug] 52928#34365452480 free(800686400)
2021/11/19 10:53:58.239 [debug] 52928#34365452480 free(8006112A0)
2021/11/19 10:53:58.239 [debug] 52928#34365452480 pthread_mutex_destroy(800654270)
2021/11/19 10:53:58.239 [debug] 52927#34365452480 free(800671110)
2021/11/19 10:53:58.239 [debug] 52927#34365452480 free(800687000)
2021/11/19 10:53:58.239 [debug] 52928#34365452480 free(800654200)
2021/11/19 10:53:58.239 [debug] 52927#34365452480 free(800671230)
2021/11/19 10:53:58.239 [debug] 52927#34365452480 free(800687C00)
2021/11/19 10:53:58.239 [debug] 52927#34365452480 free(8006712C0)
2021/11/19 10:53:58.239 [debug] 52927#34365452480 free(800688400)
2021/11/19 10:53:58.239 [debug] 52927#34365452480 free(8006116C0)
2021/11/19 10:53:58.239 [debug] 52927#34365452480 exit: 0
2021/11/19 10:53:58.239 [debug] 52928#34365452480 free(8006668C0)
2021/11/19 10:53:58.239 [debug] 52928#34365452480 free(800671110)
2021/11/19 10:53:58.239 [debug] 52928#34365452480 free(800687000)
2021/11/19 10:53:58.239 [debug] 52928#34365452480 free(800671230)
2021/11/19 10:53:58.239 [debug] 52928#34365452480 free(800687C00)
2021/11/19 10:53:58.239 [debug] 52928#34365452480 free(8006712C0)
2021/11/19 10:53:58.239 [debug] 52928#34365452480 free(800688400)
2021/11/19 10:53:58.239 [debug] 52928#34365452480 free(8006116C0)
2021/11/19 10:53:58.239 [debug] 52928#34365452480 exit: 0
2021/11/19 10:53:58.239 [debug] 52924#34365452480 kevent(3): 1
2021/11/19 10:53:58.239 [debug] 52924#34365452480 kevent: id:20 ft:-6 fl:0021 ff:0 d:1 ud:467A40
2021/11/19 10:53:58.239 [debug] 52924#34365452480 timer expire minimum: 719589665:633189665
2021/11/19 10:53:58.239 [debug] 52924#34365452480 work queue: fast
2021/11/19 10:53:58.239 [debug] 52924#34365452480 sigchld handler signo:20 (SIGCHLD)
2021/11/19 10:53:58.239 [debug] 52924#34365452480 waitpid(): 52928
2021/11/19 10:53:58.239 [notice] 52924#34365452480 process 52928 exited with code 0
2021/11/19 10:53:58.239 [debug] 52924#34365452480 pthread_mutex_lock(800654270) enter
2021/11/19 10:53:58.239 [debug] 52924#34365452480 pthread_mutex_unlock(800654270) exit
2021/11/19 10:53:58.239 [debug] 52924#34365452480 port 800572940 52928:0 close, type 3
2021/11/19 10:53:58.239 [debug] 52924#34365452480 close(11)
2021/11/19 10:53:58.239 [debug] 52924#34365452480 port 800572940 52928:0 release, type 3
2021/11/19 10:53:58.239 [debug] 52924#34365452480 pthread_mutex_lock(800654270) enter
2021/11/19 10:53:58.239 [debug] 52924#34365452480 process 52928 removed
2021/11/19 10:53:58.239 [debug] 52924#34365452480 pthread_mutex_unlock(800654270) exit
2021/11/19 10:53:58.239 [debug] 52924#34365452480 free(0)
2021/11/19 10:53:58.239 [debug] 52924#34365452480 pthread_mutex_destroy(800686928)
2021/11/19 10:53:58.239 [debug] 52924#34365452480 mp 800611350 release: 0
2021/11/19 10:53:58.239 [debug] 52924#34365452480 pthread_mutex_destroy(8005729F8)
2021/11/19 10:53:58.239 [debug] 52924#34365452480 free(800572940)
2021/11/19 10:53:58.239 [debug] 52924#34365452480 free(800670ED0)
2021/11/19 10:53:58.239 [debug] 52924#34365452480 free(800686000)
2021/11/19 10:53:58.239 [debug] 52924#34365452480 free(800611350)
2021/11/19 10:53:58.239 [debug] 52924#34365452480 kevent(3) changes:0 timeout:-1
2021/11/19 10:53:58.239 [debug] 52924#34365452480 kevent(3): 1
2021/11/19 10:53:58.239 [debug] 52924#34365452480 kevent: id:20 ft:-6 fl:0021 ff:0 d:1 ud:467A40
2021/11/19 10:53:58.239 [debug] 52924#34365452480 timer expire minimum: 719589665:633189665
2021/11/19 10:53:58.239 [debug] 52924#34365452480 work queue: fast
2021/11/19 10:53:58.239 [debug] 52924#34365452480 sigchld handler signo:20 (SIGCHLD)
2021/11/19 10:53:58.239 [debug] 52924#34365452480 waitpid(): 52927
2021/11/19 10:53:58.239 [notice] 52924#34365452480 process 52927 exited with code 0
2021/11/19 10:53:58.239 [debug] 52924#34365452480 pthread_mutex_lock(800654270) enter
2021/11/19 10:53:58.239 [debug] 52924#34365452480 pthread_mutex_unlock(800654270) exit
2021/11/19 10:53:58.239 [debug] 52924#34365452480 port 800572AC0 52927:0 close, type 2
2021/11/19 10:53:58.239 [debug] 52924#34365452480 close(10)
2021/11/19 10:53:58.239 [debug] 52924#34365452480 port 800572AC0 52927:0 release, type 2
2021/11/19 10:53:58.239 [debug] 52924#34365452480 pthread_mutex_lock(800654270) enter
2021/11/19 10:53:58.239 [debug] 52924#34365452480 process 52927 removed
2021/11/19 10:53:58.239 [debug] 52924#34365452480 pthread_mutex_unlock(800654270) exit
2021/11/19 10:53:58.239 [debug] 52924#34365452480 free(0)
2021/11/19 10:53:58.239 [debug] 52924#34365452480 pthread_mutex_destroy(800686828)
2021/11/19 10:53:58.239 [debug] 52924#34365452480 free(800670FF0)
2021/11/19 10:53:58.239 [debug] 52924#34365452480 free(800686800)
2021/11/19 10:53:58.239 [debug] 52924#34365452480 mp 800611400 release: 0
2021/11/19 10:53:58.239 [debug] 52924#34365452480 pthread_mutex_destroy(800572B78)
2021/11/19 10:53:58.239 [debug] 52924#34365452480 free(800572AC0)
2021/11/19 10:53:58.239 [debug] 52924#34365452480 free(800670F60)
2021/11/19 10:53:58.239 [debug] 52924#34365452480 free(800686400)
2021/11/19 10:53:58.239 [debug] 52924#34365452480 free(800611400)
2021/11/19 10:53:58.239 [debug] 52924#34365452480 exiting
2021/11/19 10:53:58.239 [debug] 52924#34365452480 close idle connections
2021/11/19 10:53:58.239 [debug] 52924#34365452480 work queue: fast
2021/11/19 10:53:58.239 [debug] 52924#34365452480 thread pools: 0
2021/11/19 10:53:58.239 [debug] 52924#34365452480 unlink("/usr/local/nginxunittest/unit.pid")
2021/11/19 10:53:58.239 [alert] 52924#34365452480 unlink("/usr/local/nginxunittest/unit.pid") failed (2: No such file or directory)
2021/11/19 10:53:58.239 [debug] 52924#34365452480 unlink("/usr/local/nginxunittest/control.unit.sock")
2021/11/19 10:53:58.239 [alert] 52924#34365452480 unlink("/usr/local/nginxunittest/control.unit.sock") failed (2: No such file or directory)
2021/11/19 10:53:58.239 [debug] 52924#34365452480 pthread_mutex_lock(800654270) enter
2021/11/19 10:53:58.239 [debug] 52924#34365452480 free(800EB0B00)
2021/11/19 10:53:58.239 [debug] 52924#34365452480 process 52924 removed
2021/11/19 10:53:58.239 [debug] 52924#34365452480 pthread_mutex_unlock(800654270) exit
2021/11/19 10:53:58.239 [debug] 52924#34365452480 port 800572DC0 52924:0 close, type 0
2021/11/19 10:53:58.239 [debug] 52924#34365452480 close(6)
2021/11/19 10:53:58.239 [debug] 52924#34365452480 close(7)
2021/11/19 10:53:58.239 [debug] 52924#34365452480 free(800EB0A80)
2021/11/19 10:53:58.239 [debug] 52924#34365452480 pthread_mutex_destroy(800654270)
2021/11/19 10:53:58.239 [debug] 52924#34365452480 free(800654200)
2021/11/19 10:53:58.239 [debug] 52924#34365452480 free(8006668C0)
2021/11/19 10:53:58.239 [debug] 52924#34365452480 free(800671110)
2021/11/19 10:53:58.239 [debug] 52924#34365452480 free(800687000)
2021/11/19 10:53:58.239 [debug] 52924#34365452480 free(800671230)
2021/11/19 10:53:58.239 [debug] 52924#34365452480 free(800687C00)
2021/11/19 10:53:58.239 [debug] 52924#34365452480 free(8006712C0)
2021/11/19 10:53:58.239 [debug] 52924#34365452480 free(800688400)
2021/11/19 10:53:58.239 [debug] 52924#34365452480 free(8006116C0)
2021/11/19 10:53:58.239 [debug] 52924#34365452480 exit: 0
2021/11/19 10:54:03.259 [debug] 53276#34365452480 thread pool destroy: 0
2021/11/19 10:54:03.259 [debug] 53276#34365452480 work queue: fast
2021/11/19 10:54:03.259 [debug] 53276#34365452480 thread pools: 1
2021/11/19 10:54:03.259 [debug] 53276#34365452480 free(800E91AC0)
2021/11/19 10:54:03.259 [debug] 53276#34365452480 fork(): 53277
2021/11/19 10:54:03.259 [debug] 53277#34365452480 daemon
2021/11/19 10:54:03.259 [debug] 53277#34365452480 close(3)
2021/11/19 10:54:03.259 [debug] 53277#34365452480 kqueue 3 free
2021/11/19 10:54:03.259 [debug] 53277#34365452480 free(800688000)
2021/11/19 10:54:03.259 [debug] 53277#34365452480 free(80069F000)
2021/11/19 10:54:03.259 [debug] 53277#34365452480 malloc(4096): 80069F000
2021/11/19 10:54:03.259 [debug] 53277#34365452480 malloc(1024): 800688000
2021/11/19 10:54:03.259 [debug] 53277#34365452480 kqueue(): 3
2021/11/19 10:54:03.259 [debug] 53277#34365452480 kevent(3) signo:1 (SIGHUP)
2021/11/19 10:54:03.259 [debug] 53277#34365452480 kevent(3) signo:2 (SIGINT)
2021/11/19 10:54:03.259 [debug] 53277#34365452480 kevent(3) signo:3 (SIGQUIT)
2021/11/19 10:54:03.259 [debug] 53277#34365452480 kevent(3) signo:15 (SIGTERM)
2021/11/19 10:54:03.259 [debug] 53277#34365452480 kevent(3) signo:20 (SIGCHLD)
2021/11/19 10:54:03.259 [debug] 53277#34365452480 kevent(3) signo:30 (SIGUSR1)
2021/11/19 10:54:03.259 [debug] 53277#34365452480 open("/usr/local/nginxunittest/unit.pid", 0x605, 0x1A4): 6 err:0
2021/11/19 10:54:03.259 [debug] 53277#34365452480 pwrite(6, 7FFFFFDFD5A0, 6, 0): 6
2021/11/19 10:54:03.259 [debug] 53277#34365452480 close(6)
2021/11/19 10:54:03.259 [debug] 53277#34365452480 pthread_mutex_lock(800654270) enter
2021/11/19 10:54:03.259 [debug] 53277#34365452480 pthread_mutex_init(800687F28)
2021/11/19 10:54:03.259 [debug] 53277#34365452480 posix_memalign(128, 128): 800EB0B00
2021/11/19 10:54:03.259 [debug] 53277#34365452480 process 53277 insert
2021/11/19 10:54:03.259 [debug] 53277#34365452480 pthread_mutex_unlock(800654270) exit
2021/11/19 10:54:03.259 [debug] 53277#34365452480 malloc(168): 800611560
2021/11/19 10:54:03.259 [debug] 53277#34365452480 posix_memalign(16, 368): 800572DC0
2021/11/19 10:54:03.259 [debug] 53277#34365452480 malloc(136): 8006711A0
2021/11/19 10:54:03.259 [debug] 53277#34365452480 posix_memalign(128, 1024): 800687400
2021/11/19 10:54:03.259 [debug] 53277#34365452480 pthread_mutex_init(800572E78)
2021/11/19 10:54:03.259 [debug] 53277#34365452480 port 800572DC0 53277:0 new, type 0
2021/11/19 10:54:03.259 [debug] 53277#34365452480 posix_memalign(128, 128): 800EB0A80
2021/11/19 10:54:03.259 [debug] 53277#34365452480 socketpair(): 6:7
2021/11/19 10:54:03.259 [debug] 53277#34365452480 getsockopt(7, 65535, SO_SNDBUF): 65536
2021/11/19 10:54:03.259 [debug] 53277#34365452480 getsockopt(6, 65535, SO_RCVBUF): 65536
2021/11/19 10:54:03.259 [debug] 53277#34365452480 kevent(3) set event: id:6 ft:-1 fl:0025
2021/11/19 10:54:03.259 [debug] 53277#34365452480 malloc(136): 800671110
2021/11/19 10:54:03.259 [debug] 53277#34365452480 posix_memalign(128, 1024): 800687000
2021/11/19 10:54:03.259 [debug] 53277#34365452480 pthread_mutex_init(800687028)
2021/11/19 10:54:03.259 [debug] 53277#34365452480 malloc(168): 8006114B0
2021/11/19 10:54:03.259 [debug] 53277#34365452480 posix_memalign(16, 368): 800572C40
2021/11/19 10:54:03.259 [debug] 53277#34365452480 malloc(136): 800671080
2021/11/19 10:54:03.259 [debug] 53277#34365452480 posix_memalign(128, 1024): 800686C00
2021/11/19 10:54:03.259 [debug] 53277#34365452480 pthread_mutex_init(800572CF8)
2021/11/19 10:54:03.259 [debug] 53277#34365452480 port 800572C40 0:0 new, type 1
2021/11/19 10:54:03.259 [debug] 53277#34365452480 socketpair(): 8:9
2021/11/19 10:54:03.259 [debug] 53277#34365452480 getsockopt(9, 65535, SO_SNDBUF): 65536
2021/11/19 10:54:03.259 [debug] 53277#34365452480 getsockopt(8, 65535, SO_RCVBUF): 65536
2021/11/19 10:54:03.259 [debug] 53277#34365452480 malloc(168): 800611400
2021/11/19 10:54:03.259 [debug] 53277#34365452480 fork(discovery): 53279
2021/11/19 10:54:03.259 [debug] 53277#34365452480 pthread_mutex_lock(800654270) enter
2021/11/19 10:54:03.259 [debug] 53277#34365452480 process 53279 added
2021/11/19 10:54:03.259 [debug] 53277#34365452480 pthread_mutex_unlock(800654270) exit
2021/11/19 10:54:03.259 [debug] 53277#34365452480 socket close(8)
2021/11/19 10:54:03.259 [debug] 53277#34365452480 free(800611400)
2021/11/19 10:54:03.259 [debug] 53277#34365452480 kevent(3) changes:1 timeout:-1
2021/11/19 10:54:03.259 [debug] 53279#34365452480 discovery setup
2021/11/19 10:54:03.259 [debug] 53279#34365452480 kqueue 3 free
2021/11/19 10:54:03.259 [debug] 53279#34365452480 free(800688000)
2021/11/19 10:54:03.259 [debug] 53279#34365452480 free(80069F000)
2021/11/19 10:54:03.259 [debug] 53279#34365452480 malloc(4096): 80069F000
2021/11/19 10:54:03.259 [debug] 53279#34365452480 malloc(1024): 800688000
2021/11/19 10:54:03.259 [debug] 53279#34365452480 kqueue(): 3
2021/11/19 10:54:03.259 [debug] 53279#34365452480 kevent(3) signo:1 (SIGHUP)
2021/11/19 10:54:03.259 [debug] 53279#34365452480 kevent(3) signo:2 (SIGINT)
2021/11/19 10:54:03.259 [debug] 53279#34365452480 kevent(3) signo:3 (SIGQUIT)
2021/11/19 10:54:03.259 [debug] 53279#34365452480 kevent(3) signo:15 (SIGTERM)
2021/11/19 10:54:03.259 [debug] 53279#34365452480 kevent(3) signo:20 (SIGCHLD)
2021/11/19 10:54:03.259 [debug] 53279#34365452480 kevent(3) signo:30 (SIGUSR1)
2021/11/19 10:54:03.259 [debug] 53279#34365452480 kevent(3) signo:31 (SIGUSR2)
2021/11/19 10:54:03.259 [debug] 53279#34365452480 malloc(208): 800E91AC0
2021/11/19 10:54:03.259 [debug] 53279#34365452480 socket close(6)
2021/11/19 10:54:03.259 [debug] 53279#34365452480 pthread_mutex_lock(800654270) enter
2021/11/19 10:54:03.259 [debug] 53279#34365452480 process 53279 added
2021/11/19 10:54:03.269 [debug] 53279#34365452480 pthread_mutex_unlock(800654270) exit
2021/11/19 10:54:03.269 [debug] 53279#34365452480 kevent(3) set event: id:8 ft:-1 fl:0025
2021/11/19 10:54:03.269 [debug] 53279#34365452480 user cred set gids: base gid:65534, ngroups: 1
2021/11/19 10:54:03.269 [debug] 53279#34365452480 user cred set: "nobody" uid:65534
2021/11/19 10:54:03.269 [debug] 53279#34365452480 pthread_mutex_lock(800572E78) enter
2021/11/19 10:54:03.269 [debug] 53279#34365452480 pthread_mutex_unlock(800572E78) exit
2021/11/19 10:54:03.269 [debug] 53279#34365452480 sendmsg(7, -1, -1, 1): 16
2021/11/19 10:54:03.269 [debug] 53279#34365452480 discovery sent ready
2021/11/19 10:54:03.269 [info] 53279#34365452480 discovery started
2021/11/19 10:54:03.269 [debug] 53279#34365452480 malloc(168): 800611350
2021/11/19 10:54:03.259 [debug] 53277#34365452480 kevent(3): 1
2021/11/19 10:54:03.259 [debug] 53277#34365452480 kevent: id:6 ft:-1 fl:0025 ff:0 d:120 ud:800572DC0
2021/11/19 10:54:03.259 [debug] 53277#34365452480 timer expire minimum: 719594698:633194695
2021/11/19 10:54:03.259 [debug] 53277#34365452480 work queue: fast
2021/11/19 10:54:03.259 [debug] 53277#34365452480 posix_memalign(16, 16496): 800630000
2021/11/19 10:54:03.259 [debug] 53277#34365452480 recvmsg(6, 2, 104): 16
2021/11/19 10:54:03.259 [debug] 53277#34365452480 port 6: message type:16
2021/11/19 10:54:03.259 [debug] 53277#34365452480 pthread_mutex_lock(800654270) enter
2021/11/19 10:54:03.259 [debug] 53277#34365452480 pthread_mutex_unlock(800654270) exit
2021/11/19 10:54:03.259 [debug] 53277#34365452480 process 53279 ready
2021/11/19 10:54:03.259 [debug] 53277#34365452480 new port 9 for process 53279
2021/11/19 10:54:03.259 [debug] 53277#34365452480 recvmsg(6, 2, 104): -1
2021/11/19 10:54:03.259 [debug] 53277#34365452480 recvmsg(6) not ready
2021/11/19 10:54:03.259 [debug] 53277#34365452480 kevent(3) changes:0 timeout:-1
2021/11/19 10:54:03.269 [debug] 53279#34365452480 malloc(136): 800670FF0
2021/11/19 10:54:03.269 [debug] 53279#34365452480 posix_memalign(128, 1024): 800686800
2021/11/19 10:54:03.269 [notice] 53279#34365452480 module: python 3.6.12 "/usr/local/nginxunittest/modules/py36.unit.so"
2021/11/19 10:54:03.269 [debug] 53279#34365452480 malloc(136): 800670F60
2021/11/19 10:54:03.269 [debug] 53279#34365452480 posix_memalign(128, 1024): 800686400
2021/11/19 10:54:03.269 [debug] 53279#34365452480 module: 1 3.6.12 /usr/local/nginxunittest/modules/py36.unit.so
2021/11/19 10:54:03.269 [debug] 53279#34365452480 posix_memalign(16, 520): 800F248C0
2021/11/19 10:54:03.269 [debug] 53279#34365452480 posix_memalign(128, 128): 800EB0A00
2021/11/19 10:54:03.269 [debug] 53279#34365452480 rpc: stream #1 registered
2021/11/19 10:54:03.269 [debug] 53279#34365452480 posix_memalign(128, 128): 800EB0980
2021/11/19 10:54:03.269 [debug] 53279#34365452480 rpc: stream #1 assigned uniq pid 53277 (800686D08)
2021/11/19 10:54:03.269 [debug] 53279#34365452480 pthread_mutex_lock(800572E78) enter
2021/11/19 10:54:03.269 [debug] 53279#34365452480 pthread_mutex_unlock(800572E78) exit
2021/11/19 10:54:03.269 [debug] 53279#34365452480 using plain mode
2021/11/19 10:54:03.269 [debug] 53279#34365452480 sendbuf: 0, 800F24908, 356
2021/11/19 10:54:03.269 [debug] 53279#34365452480 sendmsg(7, -1, -1, 2): 372
2021/11/19 10:54:03.259 [debug] 53277#34365452480 kevent(3): 1
2021/11/19 10:54:03.269 [debug] 53279#34365452480 socket close(9)
2021/11/19 10:54:03.269 [debug] 53279#34365452480 free(800611400)
2021/11/19 10:54:03.259 [debug] 53277#34365452480 kevent: id:6 ft:-1 fl:0025 ff:0 d:476 ud:800572DC0
2021/11/19 10:54:03.259 [debug] 53277#34365452480 timer expire minimum: 719594695:633194695
2021/11/19 10:54:03.269 [debug] 53279#34365452480 work queue: fast
2021/11/19 10:54:03.269 [debug] 53279#34365452480 free(800670F60)
2021/11/19 10:54:03.269 [debug] 53279#34365452480 free(800686400)
2021/11/19 10:54:03.259 [debug] 53277#34365452480 work queue: fast
2021/11/19 10:54:03.269 [debug] 53279#34365452480 free(800670FF0)
2021/11/19 10:54:03.269 [debug] 53279#34365452480 free(800686800)
2021/11/19 10:54:03.259 [debug] 53277#34365452480 recvmsg(6, 2, 104): 372
2021/11/19 10:54:03.259 [debug] 53277#34365452480 port 6: message type:4
2021/11/19 10:54:03.269 [debug] 53279#34365452480 free(800F248C0)
2021/11/19 10:54:03.259 [debug] 53277#34365452480 process port (53279, 0) found
2021/11/19 10:54:03.259 [debug] 53277#34365452480 pthread_mutex_lock(800572CF8) enter
2021/11/19 10:54:03.259 [debug] 53277#34365452480 pthread_mutex_unlock(800572CF8) exit
2021/11/19 10:54:03.269 [debug] 53279#34365452480 free(800611350)
2021/11/19 10:54:03.269 [debug] 53279#34365452480 kevent(3) changes:1 timeout:-1
2021/11/19 10:54:03.259 [debug] 53277#34365452480 sendmsg(9, -1, -1, 1): 16
2021/11/19 10:54:03.259 [debug] 53277#34365452480 malloc(168): 800611400
2021/11/19 10:54:03.259 [debug] 53277#34365452480 application languages: "[{"type": 1, "version": "3.6.12", "file": "/usr/local/nginxunittest/modules/py36.unit.so", "mounts": [{"src": "/usr/local/lib/python3.6", "dst": "/usr/local/lib/python3.6", "name": "bind", "type": 1, "flags": 0, "data": ""},{"src": "/usr/local/lib/python36.zip", "dst": "/usr/local/lib/python36.zip", "name": "bind", "type": 1, "flags": 0, "data": ""},]},]"
2021/11/19 10:54:03.269 [debug] 53279#34365452480 kevent(3): 1
2021/11/19 10:54:03.269 [debug] 53279#34365452480 kevent: id:8 ft:-1 fl:0025 ff:0 d:120 ud:800572C40
2021/11/19 10:54:03.269 [debug] 53279#34365452480 timer expire minimum: 719594698:633194695
2021/11/19 10:54:03.269 [debug] 53279#34365452480 work queue: fast
2021/11/19 10:54:03.259 [debug] 53277#34365452480 malloc(136): 800670FF0
2021/11/19 10:54:03.269 [debug] 53279#34365452480 posix_memalign(16, 16496): 800630000
2021/11/19 10:54:03.269 [debug] 53279#34365452480 recvmsg(8, 2, 104): 16
2021/11/19 10:54:03.269 [debug] 53279#34365452480 port 8: message type:1
2021/11/19 10:54:03.259 [debug] 53277#34365452480 posix_memalign(128, 1024): 800686800
2021/11/19 10:54:03.269 [debug] 53279#34365452480 free(800EB0A00)
2021/11/19 10:54:03.259 [debug] 53277#34365452480 malloc(168): 800611350
2021/11/19 10:54:03.269 [debug] 53279#34365452480 rpc: stream #1 last handler, type 1
2021/11/19 10:54:03.269 [debug] 53279#34365452480 close listen connections
2021/11/19 10:54:03.259 [debug] 53277#34365452480 malloc(136): 800670F60
2021/11/19 10:54:03.259 [debug] 53277#34365452480 posix_memalign(128, 1024): 800686400
2021/11/19 10:54:03.269 [debug] 53279#34365452480 exiting
2021/11/19 10:54:03.269 [debug] 53279#34365452480 thread pool destroy: 0
2021/11/19 10:54:03.259 [debug] 53277#34365452480 malloc(168): 8006112A0
2021/11/19 10:54:03.259 [debug] 53277#34365452480 malloc(136): 800670ED0
2021/11/19 10:54:03.269 [debug] 53279#34365452480 close idle connections
2021/11/19 10:54:03.259 [debug] 53277#34365452480 posix_memalign(128, 1024): 800686000
2021/11/19 10:54:03.269 [debug] 53279#34365452480 rpc: stream #1 remove first and last pid 53277 registration (800686D08)
2021/11/19 10:54:03.269 [debug] 53279#34365452480 free(800EB0980)
2021/11/19 10:54:03.269 [debug] 53279#34365452480 rpc: stream #1 free registration
2021/11/19 10:54:03.269 [debug] 53279#34365452480 recvmsg(8, 2, 104): -1
2021/11/19 10:54:03.269 [debug] 53279#34365452480 recvmsg(8) not ready
2021/11/19 10:54:03.269 [debug] 53279#34365452480 work queue: fast
2021/11/19 10:54:03.269 [debug] 53279#34365452480 thread pools: 1
2021/11/19 10:54:03.269 [debug] 53279#34365452480 free(800E91AC0)
2021/11/19 10:54:03.259 [debug] 53277#34365452480 malloc(168): 8006111F0
2021/11/19 10:54:03.269 [debug] 53279#34365452480 exiting
2021/11/19 10:54:03.259 [debug] 53277#34365452480 malloc(136): 800670E40
2021/11/19 10:54:03.259 [debug] 53277#34365452480 posix_memalign(128, 1024): 800685C00
2021/11/19 10:54:03.269 [debug] 53279#34365452480 close idle connections
2021/11/19 10:54:03.269 [debug] 53279#34365452480 work queue: fast
2021/11/19 10:54:03.269 [debug] 53279#34365452480 thread pools: 0
2021/11/19 10:54:03.269 [debug] 53279#34365452480 pthread_mutex_lock(800654270) enter
2021/11/19 10:54:03.259 [debug] 53277#34365452480 malloc(168): 800611140
2021/11/19 10:54:03.259 [debug] 53277#34365452480 malloc(136): 800670DB0
2021/11/19 10:54:03.259 [debug] 53277#34365452480 posix_memalign(128, 1024): 800685800
2021/11/19 10:54:03.269 [debug] 53279#34365452480 process 53277 removed
2021/11/19 10:54:03.269 [debug] 53279#34365452480 pthread_mutex_unlock(800654270) exit
2021/11/19 10:54:03.259 [debug] 53277#34365452480 free(800670DB0)
2021/11/19 10:54:03.259 [debug] 53277#34365452480 free(800685800)
2021/11/19 10:54:03.269 [debug] 53279#34365452480 port 800572DC0 53277:0 close, type 0
2021/11/19 10:54:03.269 [debug] 53279#34365452480 close(7)
2021/11/19 10:54:03.259 [debug] 53277#34365452480 free(800611140)
2021/11/19 10:54:03.259 [debug] 53277#34365452480 malloc(168): 800611140
2021/11/19 10:54:03.269 [debug] 53279#34365452480 port 800572DC0 53277:0 release, type 0
2021/11/19 10:54:03.259 [debug] 53277#34365452480 malloc(136): 800670DB0
2021/11/19 10:54:03.259 [debug] 53277#34365452480 posix_memalign(128, 1024): 800685800
2021/11/19 10:54:03.269 [debug] 53279#34365452480 free(0)
2021/11/19 10:54:03.259 [debug] 53277#34365452480 free(800670DB0)
2021/11/19 10:54:03.269 [debug] 53279#34365452480 pthread_mutex_destroy(800687F28)
2021/11/19 10:54:03.269 [debug] 53279#34365452480 mp 800611560 release: 0
2021/11/19 10:54:03.269 [debug] 53279#34365452480 pthread_mutex_destroy(800572E78)
2021/11/19 10:54:03.269 [debug] 53279#34365452480 free(800572DC0)
2021/11/19 10:54:03.259 [debug] 53277#34365452480 free(800685800)
2021/11/19 10:54:03.259 [debug] 53277#34365452480 free(800611140)
2021/11/19 10:54:03.269 [debug] 53279#34365452480 free(8006711A0)
2021/11/19 10:54:03.269 [debug] 53279#34365452480 free(800687400)
2021/11/19 10:54:03.259 [debug] 53277#34365452480 free(800670E40)
2021/11/19 10:54:03.259 [debug] 53277#34365452480 free(800685C00)
2021/11/19 10:54:03.269 [debug] 53279#34365452480 free(800611560)
2021/11/19 10:54:03.269 [debug] 53279#34365452480 pthread_mutex_lock(800654270) enter
2021/11/19 10:54:03.269 [debug] 53279#34365452480 free(800EB0B00)
2021/11/19 10:54:03.269 [debug] 53279#34365452480 process 53279 removed
2021/11/19 10:54:03.259 [debug] 53277#34365452480 free(8006111F0)
2021/11/19 10:54:03.259 [debug] 53277#34365452480 free(800670ED0)
2021/11/19 10:54:03.259 [debug] 53277#34365452480 free(800686000)
2021/11/19 10:54:03.269 [debug] 53279#34365452480 pthread_mutex_unlock(800654270) exit
2021/11/19 10:54:03.269 [debug] 53279#34365452480 port 800572C40 53279:0 close, type 1
2021/11/19 10:54:03.259 [debug] 53277#34365452480 free(8006112A0)
2021/11/19 10:54:03.259 [debug] 53277#34365452480 free(800670F60)
2021/11/19 10:54:03.259 [debug] 53277#34365452480 free(800686400)
2021/11/19 10:54:03.269 [debug] 53279#34365452480 close(8)
2021/11/19 10:54:03.259 [debug] 53277#34365452480 free(800611350)
2021/11/19 10:54:03.269 [debug] 53279#34365452480 free(800EB0A80)
2021/11/19 10:54:03.269 [debug] 53279#34365452480 port 800572C40 53279:0 release, type 1
2021/11/19 10:54:03.269 [debug] 53279#34365452480 free(0)
2021/11/19 10:54:03.259 [debug] 53277#34365452480 lang 1 3.6.12 "/usr/local/nginxunittest/modules/py36.unit.so" (2 mounts)
2021/11/19 10:54:03.269 [debug] 53279#34365452480 pthread_mutex_destroy(800687028)
2021/11/19 10:54:03.269 [debug] 53279#34365452480 free(800671110)
2021/11/19 10:54:03.269 [debug] 53279#34365452480 free(800687000)
2021/11/19 10:54:03.269 [debug] 53279#34365452480 mp 8006114B0 release: 0
2021/11/19 10:54:03.259 [debug] 53277#34365452480 free(800670FF0)
2021/11/19 10:54:03.259 [debug] 53277#34365452480 free(800686800)
2021/11/19 10:54:03.269 [debug] 53279#34365452480 pthread_mutex_destroy(800572CF8)
2021/11/19 10:54:03.269 [debug] 53279#34365452480 free(800572C40)
2021/11/19 10:54:03.269 [debug] 53279#34365452480 free(800630000)
2021/11/19 10:54:03.259 [debug] 53277#34365452480 free(800611400)
2021/11/19 10:54:03.259 [debug] 53277#34365452480 malloc(136): 800670FF0
2021/11/19 10:54:03.259 [debug] 53277#34365452480 posix_memalign(128, 1024): 800686800
2021/11/19 10:54:03.269 [debug] 53279#34365452480 free(800671080)
2021/11/19 10:54:03.269 [debug] 53279#34365452480 free(800686C00)
2021/11/19 10:54:03.269 [debug] 53279#34365452480 free(8006114B0)
2021/11/19 10:54:03.269 [debug] 53279#34365452480 pthread_mutex_destroy(800654270)
2021/11/19 10:54:03.269 [debug] 53279#34365452480 free(800654200)
2021/11/19 10:54:03.269 [debug] 53279#34365452480 free(8006668C0)
2021/11/19 10:54:03.259 [debug] 53277#34365452480 pthread_mutex_init(800686828)
2021/11/19 10:54:03.259 [debug] 53277#34365452480 malloc(168): 800611400
2021/11/19 10:54:03.269 [debug] 53279#34365452480 free(800671230)
2021/11/19 10:54:03.269 [debug] 53279#34365452480 free(800687C00)
2021/11/19 10:54:03.269 [debug] 53279#34365452480 free(8006712C0)
2021/11/19 10:54:03.269 [debug] 53279#34365452480 free(800688400)
2021/11/19 10:54:03.269 [debug] 53279#34365452480 free(8006116C0)
2021/11/19 10:54:03.269 [debug] 53279#34365452480 exit: 0
2021/11/19 10:54:03.259 [debug] 53277#34365452480 posix_memalign(16, 368): 800572AC0
2021/11/19 10:54:03.259 [debug] 53277#34365452480 malloc(136): 800670F60
2021/11/19 10:54:03.259 [debug] 53277#34365452480 posix_memalign(128, 1024): 800686400
2021/11/19 10:54:03.259 [debug] 53277#34365452480 pthread_mutex_init(800572B78)
2021/11/19 10:54:03.259 [debug] 53277#34365452480 port 800572AC0 0:0 new, type 2
2021/11/19 10:54:03.259 [debug] 53277#34365452480 socketpair(): 8:10
2021/11/19 10:54:03.259 [debug] 53277#34365452480 getsockopt(10, 65535, SO_SNDBUF): 65536
2021/11/19 10:54:03.259 [debug] 53277#34365452480 getsockopt(8, 65535, SO_RCVBUF): 65536
2021/11/19 10:54:03.259 [debug] 53277#34365452480 malloc(168): 800611350
2021/11/19 10:54:03.259 [info] 53277#34365452480 controller started
2021/11/19 10:54:03.259 [debug] 53277#34365452480 open("/usr/local/nginxunittest/state/conf.json", 0x4, 0x0): 11 err:0
2021/11/19 10:54:03.259 [debug] 53277#34365452480 fstat(11): 0
2021/11/19 10:54:03.259 [debug] 53277#34365452480 malloc(136): 800670ED0
2021/11/19 10:54:03.259 [debug] 53277#34365452480 posix_memalign(128, 1024): 800686000
2021/11/19 10:54:03.259 [debug] 53277#34365452480 pread(11, 800686000, 163, 0): 163
2021/11/19 10:54:03.259 [debug] 53277#34365452480 close(11)
2021/11/19 10:54:03.259 [debug] 53277#34365452480 open("/usr/local/nginxunittest/state/version", 0x4, 0x0): -1 err:2
2021/11/19 10:54:03.259 [debug] 53277#34365452480 fork(controller): 53280
2021/11/19 10:54:03.259 [debug] 53277#34365452480 pthread_mutex_lock(800654270) enter
2021/11/19 10:54:03.259 [debug] 53277#34365452480 process 53280 added
2021/11/19 10:54:03.259 [debug] 53277#34365452480 pthread_mutex_unlock(800654270) exit
2021/11/19 10:54:03.259 [debug] 53277#34365452480 socket close(8)
2021/11/19 10:54:03.259 [debug] 53277#34365452480 free(800670ED0)
2021/11/19 10:54:03.259 [debug] 53277#34365452480 free(800686000)
2021/11/19 10:54:03.259 [debug] 53277#34365452480 free(800611350)
2021/11/19 10:54:03.259 [debug] 53277#34365452480 pthread_mutex_init(800686928)
2021/11/19 10:54:03.259 [debug] 53277#34365452480 malloc(168): 800611350
2021/11/19 10:54:03.259 [debug] 53277#34365452480 posix_memalign(16, 368): 800572940
2021/11/19 10:54:03.259 [debug] 53277#34365452480 malloc(136): 800670ED0
2021/11/19 10:54:03.259 [debug] 53277#34365452480 posix_memalign(128, 1024): 800686000
2021/11/19 10:54:03.259 [debug] 53277#34365452480 pthread_mutex_init(8005729F8)
2021/11/19 10:54:03.259 [debug] 53277#34365452480 port 800572940 0:0 new, type 3
2021/11/19 10:54:03.259 [debug] 53277#34365452480 socketpair(): 8:11
2021/11/19 10:54:03.259 [debug] 53277#34365452480 getsockopt(11, 65535, SO_SNDBUF): 65536
2021/11/19 10:54:03.259 [debug] 53277#34365452480 getsockopt(8, 65535, SO_RCVBUF): 65536
2021/11/19 10:54:03.259 [debug] 53277#34365452480 malloc(168): 8006112A0
2021/11/19 10:54:03.259 [debug] 53280#34365452480 remove not required process 53279
2021/11/19 10:54:03.259 [debug] 53280#34365452480 port 800572C40 53279:0 close, type 1
2021/11/19 10:54:03.259 [debug] 53280#34365452480 close(9)
2021/11/19 10:54:03.259 [debug] 53280#34365452480 port 800572C40 53279:0 release, type 1
2021/11/19 10:54:03.259 [debug] 53280#34365452480 pthread_mutex_lock(800654270) enter
2021/11/19 10:54:03.259 [debug] 53280#34365452480 process 53279 removed
2021/11/19 10:54:03.259 [debug] 53280#34365452480 pthread_mutex_unlock(800654270) exit
2021/11/19 10:54:03.259 [debug] 53280#34365452480 free(0)
2021/11/19 10:54:03.259 [debug] 53277#34365452480 fork(router): 53281
2021/11/19 10:54:03.259 [debug] 53277#34365452480 pthread_mutex_lock(800654270) enter
2021/11/19 10:54:03.259 [debug] 53280#34365452480 pthread_mutex_destroy(800687028)
2021/11/19 10:54:03.259 [debug] 53277#34365452480 process 53281 added
2021/11/19 10:54:03.259 [debug] 53277#34365452480 pthread_mutex_unlock(800654270) exit
2021/11/19 10:54:03.259 [debug] 53277#34365452480 socket close(8)
2021/11/19 10:54:03.259 [debug] 53280#34365452480 mp 8006114B0 release: 0
2021/11/19 10:54:03.259 [debug] 53280#34365452480 pthread_mutex_destroy(800572CF8)
2021/11/19 10:54:03.259 [debug] 53277#34365452480 free(8006112A0)
2021/11/19 10:54:03.259 [debug] 53280#34365452480 free(800572C40)
2021/11/19 10:54:03.259 [debug] 53280#34365452480 free(800671080)
2021/11/19 10:54:03.259 [debug] 53277#34365452480 recvmsg(6, 2, 104): -1
2021/11/19 10:54:03.259 [debug] 53277#34365452480 recvmsg(6) not ready
2021/11/19 10:54:03.259 [debug] 53277#34365452480 kevent(3) changes:0 timeout:-1
2021/11/19 10:54:03.259 [debug] 53280#34365452480 free(800686C00)
2021/11/19 10:54:03.259 [debug] 53277#34365452480 kevent(3): 1
2021/11/19 10:54:03.259 [debug] 53277#34365452480 kevent: id:20 ft:-6 fl:0021 ff:0 d:1 ud:467A40
2021/11/19 10:54:03.259 [debug] 53280#34365452480 free(8006114B0)
2021/11/19 10:54:03.259 [debug] 53277#34365452480 timer expire minimum: 719594695:633194695
2021/11/19 10:54:03.259 [debug] 53277#34365452480 work queue: fast
2021/11/19 10:54:03.259 [debug] 53277#34365452480 sigchld handler signo:20 (SIGCHLD)
2021/11/19 10:54:03.259 [debug] 53280#34365452480 controller setup
2021/11/19 10:54:03.259 [debug] 53281#34365452480 remove not required process 53279
2021/11/19 10:54:03.259 [debug] 53281#34365452480 port 800572C40 53279:0 close, type 1
2021/11/19 10:54:03.259 [debug] 53281#34365452480 close(9)
2021/11/19 10:54:03.259 [debug] 53277#34365452480 waitpid(): 53279
2021/11/19 10:54:03.259 [notice] 53277#34365452480 process 53279 exited with code 0
2021/11/19 10:54:03.259 [debug] 53277#34365452480 pthread_mutex_lock(800654270) enter
2021/11/19 10:54:03.259 [debug] 53277#34365452480 pthread_mutex_unlock(800654270) exit
2021/11/19 10:54:03.259 [debug] 53281#34365452480 port 800572C40 53279:0 release, type 1
2021/11/19 10:54:03.259 [debug] 53281#34365452480 pthread_mutex_lock(800654270) enter
2021/11/19 10:54:03.259 [debug] 53277#34365452480 port 800572C40 53279:0 close, type 1
2021/11/19 10:54:03.259 [debug] 53277#34365452480 close(9)
2021/11/19 10:54:03.259 [debug] 53281#34365452480 process 53279 removed
2021/11/19 10:54:03.259 [debug] 53277#34365452480 port 800572C40 53279:0 release, type 1
2021/11/19 10:54:03.259 [debug] 53281#34365452480 pthread_mutex_unlock(800654270) exit
2021/11/19 10:54:03.259 [debug] 53281#34365452480 free(0)
2021/11/19 10:54:03.259 [debug] 53277#34365452480 pthread_mutex_lock(800654270) enter
2021/11/19 10:54:03.259 [debug] 53277#34365452480 process 53279 removed
2021/11/19 10:54:03.259 [debug] 53277#34365452480 pthread_mutex_unlock(800654270) exit
2021/11/19 10:54:03.259 [debug] 53277#34365452480 free(0)
2021/11/19 10:54:03.259 [debug] 53280#34365452480 kqueue 3 free
2021/11/19 10:54:03.259 [debug] 53277#34365452480 pthread_mutex_destroy(800687028)
2021/11/19 10:54:03.259 [debug] 53280#34365452480 free(800688000)
2021/11/19 10:54:03.259 [debug] 53277#34365452480 mp 8006114B0 release: 0
2021/11/19 10:54:03.259 [debug] 53280#34365452480 free(80069F000)
2021/11/19 10:54:03.259 [debug] 53277#34365452480 pthread_mutex_destroy(800572CF8)
2021/11/19 10:54:03.259 [debug] 53277#34365452480 free(800572C40)
2021/11/19 10:54:03.259 [debug] 53281#34365452480 pthread_mutex_destroy(800687028)
2021/11/19 10:54:03.259 [debug] 53277#34365452480 free(800671080)
2021/11/19 10:54:03.259 [debug] 53280#34365452480 malloc(4096): 80069F000
2021/11/19 10:54:03.259 [debug] 53280#34365452480 malloc(1024): 800688000
2021/11/19 10:54:03.259 [debug] 53277#34365452480 free(800686C00)
2021/11/19 10:54:03.259 [debug] 53280#34365452480 kqueue(): 3
2021/11/19 10:54:03.259 [debug] 53281#34365452480 mp 8006114B0 release: 0
2021/11/19 10:54:03.259 [debug] 53277#34365452480 free(8006114B0)
2021/11/19 10:54:03.259 [debug] 53281#34365452480 pthread_mutex_destroy(800572CF8)
2021/11/19 10:54:03.259 [debug] 53280#34365452480 kevent(3) signo:1 (SIGHUP)
2021/11/19 10:54:03.259 [debug] 53281#34365452480 free(800572C40)
2021/11/19 10:54:03.259 [debug] 53277#34365452480 waitpid(): 0
2021/11/19 10:54:03.259 [debug] 53281#34365452480 free(800671080)
2021/11/19 10:54:03.259 [debug] 53280#34365452480 kevent(3) signo:2 (SIGINT)
2021/11/19 10:54:03.259 [debug] 53277#34365452480 kevent(3) changes:0 timeout:-1
2021/11/19 10:54:03.259 [debug] 53281#34365452480 free(800686C00)
2021/11/19 10:54:03.259 [debug] 53280#34365452480 kevent(3) signo:3 (SIGQUIT)
2021/11/19 10:54:03.259 [debug] 53280#34365452480 kevent(3) signo:15 (SIGTERM)
2021/11/19 10:54:03.259 [debug] 53281#34365452480 free(8006114B0)
2021/11/19 10:54:03.259 [debug] 53280#34365452480 kevent(3) signo:20 (SIGCHLD)
2021/11/19 10:54:03.259 [debug] 53280#34365452480 kevent(3) signo:30 (SIGUSR1)
2021/11/19 10:54:03.259 [debug] 53281#34365452480 remove not ready process 53280
2021/11/19 10:54:03.259 [debug] 53281#34365452480 port 800572AC0 53280:0 close, type 2
2021/11/19 10:54:03.259 [debug] 53281#34365452480 close(10)
2021/11/19 10:54:03.259 [debug] 53280#34365452480 kevent(3) signo:31 (SIGUSR2)
2021/11/19 10:54:03.259 [debug] 53281#34365452480 port 800572AC0 53280:0 release, type 2
2021/11/19 10:54:03.259 [debug] 53281#34365452480 pthread_mutex_lock(800654270) enter
2021/11/19 10:54:03.259 [debug] 53281#34365452480 process 53280 removed
2021/11/19 10:54:03.259 [debug] 53281#34365452480 pthread_mutex_unlock(800654270) exit
2021/11/19 10:54:03.259 [debug] 53281#34365452480 free(0)
2021/11/19 10:54:03.259 [debug] 53281#34365452480 pthread_mutex_destroy(800686828)
2021/11/19 10:54:03.259 [debug] 53281#34365452480 mp 800611400 release: 0
2021/11/19 10:54:03.259 [debug] 53281#34365452480 pthread_mutex_destroy(800572B78)
2021/11/19 10:54:03.259 [debug] 53281#34365452480 free(800572AC0)
2021/11/19 10:54:03.259 [debug] 53280#34365452480 malloc(208): 800E91AC0
2021/11/19 10:54:03.259 [debug] 53281#34365452480 free(800670F60)
2021/11/19 10:54:03.259 [debug] 53281#34365452480 free(800686400)
2021/11/19 10:54:03.259 [debug] 53280#34365452480 socket close(6)
2021/11/19 10:54:03.259 [debug] 53280#34365452480 pthread_mutex_lock(800654270) enter
2021/11/19 10:54:03.259 [debug] 53281#34365452480 free(800611400)
2021/11/19 10:54:03.259 [debug] 53281#34365452480 router setup
2021/11/19 10:54:03.259 [debug] 53280#34365452480 process 53280 added
2021/11/19 10:54:03.259 [debug] 53280#34365452480 pthread_mutex_unlock(800654270) exit
2021/11/19 10:54:03.259 [debug] 53280#34365452480 kevent(3) set event: id:8 ft:-1 fl:0025
2021/11/19 10:54:03.259 [debug] 53280#34365452480 user cred set gids: base gid:65534, ngroups: 1
2021/11/19 10:54:03.259 [debug] 53280#34365452480 user cred set: "nobody" uid:65534
2021/11/19 10:54:03.259 [debug] 53280#34365452480 pthread_mutex_lock(800572E78) enter
2021/11/19 10:54:03.259 [debug] 53280#34365452480 pthread_mutex_unlock(800572E78) exit
2021/11/19 10:54:03.259 [debug] 53281#34365452480 kqueue 3 free
2021/11/19 10:54:03.259 [debug] 53281#34365452480 free(800688000)
2021/11/19 10:54:03.259 [debug] 53280#34365452480 sendmsg(7, -1, -1, 1): 16
2021/11/19 10:54:03.259 [debug] 53277#34365452480 kevent(3): 1
2021/11/19 10:54:03.259 [debug] 53281#34365452480 free(80069F000)
2021/11/19 10:54:03.259 [debug] 53277#34365452480 kevent: id:6 ft:-1 fl:0025 ff:0 d:120 ud:800572DC0
2021/11/19 10:54:03.259 [debug] 53280#34365452480 controller sent ready
2021/11/19 10:54:03.259 [debug] 53277#34365452480 timer expire minimum: 719594695:633194695
2021/11/19 10:54:03.259 [debug] 53277#34365452480 work queue: fast
2021/11/19 10:54:03.259 [debug] 53281#34365452480 malloc(4096): 80069F000
2021/11/19 10:54:03.259 [debug] 53281#34365452480 malloc(1024): 800688000
2021/11/19 10:54:03.259 [debug] 53277#34365452480 recvmsg(6, 2, 104): 16
2021/11/19 10:54:03.259 [debug] 53280#34365452480 posix_memalign(64, 64): 8005F0800
2021/11/19 10:54:03.259 [debug] 53277#34365452480 port 6: message type:16
2021/11/19 10:54:03.259 [debug] 53277#34365452480 pthread_mutex_lock(800654270) enter
2021/11/19 10:54:03.259 [debug] 53281#34365452480 kqueue(): 3
2021/11/19 10:54:03.259 [debug] 53277#34365452480 pthread_mutex_unlock(800654270) exit
2021/11/19 10:54:03.259 [debug] 53281#34365452480 kevent(3) signo:1 (SIGHUP)
2021/11/19 10:54:03.259 [debug] 53280#34365452480 malloc(168): 8006114B0
2021/11/19 10:54:03.259 [debug] 53277#34365452480 process 53280 ready
2021/11/19 10:54:03.259 [debug] 53281#34365452480 kevent(3) signo:2 (SIGINT)
2021/11/19 10:54:03.259 [debug] 53280#34365452480 malloc(136): 800671080
2021/11/19 10:54:03.259 [debug] 53280#34365452480 posix_memalign(128, 1024): 800686C00
2021/11/19 10:54:03.259 [debug] 53281#34365452480 kevent(3) signo:3 (SIGQUIT)
2021/11/19 10:54:03.259 [debug] 53277#34365452480 new port 10 for process 53280
2021/11/19 10:54:03.259 [debug] 53280#34365452480 malloc(168): 8006112A0
2021/11/19 10:54:03.259 [debug] 53280#34365452480 malloc(136): 800670E40
2021/11/19 10:54:03.259 [debug] 53277#34365452480 malloc(136): 800671080
2021/11/19 10:54:03.259 [debug] 53280#34365452480 posix_memalign(128, 1024): 800685C00
2021/11/19 10:54:03.259 [debug] 53281#34365452480 kevent(3) signo:15 (SIGTERM)
2021/11/19 10:54:03.259 [debug] 53277#34365452480 posix_memalign(128, 1024): 800686C00
2021/11/19 10:54:03.259 [debug] 53280#34365452480 malloc(168): 8006111F0
2021/11/19 10:54:03.259 [debug] 53277#34365452480 mp 800611610 retain: 2
2021/11/19 10:54:03.259 [debug] 53280#34365452480 malloc(136): 800670DB0
2021/11/19 10:54:03.259 [debug] 53281#34365452480 kevent(3) signo:20 (SIGCHLD)
2021/11/19 10:54:03.259 [debug] 53280#34365452480 posix_memalign(128, 1024): 800685800
2021/11/19 10:54:03.259 [debug] 53277#34365452480 send port 10 to process 53281
2021/11/19 10:54:03.259 [debug] 53280#34365452480 malloc(168): 800611140
2021/11/19 10:54:03.259 [debug] 53281#34365452480 kevent(3) signo:30 (SIGUSR1)
2021/11/19 10:54:03.259 [debug] 53280#34365452480 malloc(136): 800670D20
2021/11/19 10:54:03.259 [debug] 53277#34365452480 pthread_mutex_lock(8005729F8) enter
2021/11/19 10:54:03.259 [debug] 53281#34365452480 kevent(3) signo:31 (SIGUSR2)
2021/11/19 10:54:03.259 [debug] 53280#34365452480 posix_memalign(128, 1024): 800685400
2021/11/19 10:54:03.259 [debug] 53280#34365452480 free(800670D20)
2021/11/19 10:54:03.259 [debug] 53280#34365452480 free(800685400)
2021/11/19 10:54:03.259 [debug] 53277#34365452480 pthread_mutex_unlock(8005729F8) exit
2021/11/19 10:54:03.259 [debug] 53280#34365452480 free(800611140)
2021/11/19 10:54:03.259 [debug] 53281#34365452480 malloc(208): 800E91AC0
2021/11/19 10:54:03.259 [debug] 53280#34365452480 free(800670DB0)
2021/11/19 10:54:03.259 [debug] 53281#34365452480 socket close(6)
2021/11/19 10:54:03.259 [debug] 53280#34365452480 free(800685800)
2021/11/19 10:54:03.259 [debug] 53277#34365452480 using plain mode
2021/11/19 10:54:03.259 [debug] 53281#34365452480 pthread_mutex_lock(800654270) enter
2021/11/19 10:54:03.259 [debug] 53281#34365452480 process 53281 added
2021/11/19 10:54:03.259 [debug] 53277#34365452480 sendbuf: 0, 800686C78, 32
2021/11/19 10:54:03.259 [debug] 53280#34365452480 free(8006111F0)
2021/11/19 10:54:03.259 [debug] 53281#34365452480 pthread_mutex_unlock(800654270) exit
2021/11/19 10:54:03.259 [debug] 53277#34365452480 sendmsg(11, 10, -1, 2): 48
2021/11/19 10:54:03.259 [debug] 53277#34365452480 recvmsg(6, 2, 104): -1
2021/11/19 10:54:03.259 [debug] 53280#34365452480 malloc(168): 8006111F0
2021/11/19 10:54:03.259 [debug] 53277#34365452480 recvmsg(6) not ready
2021/11/19 10:54:03.259 [debug] 53280#34365452480 malloc(136): 800670DB0
2021/11/19 10:54:03.259 [debug] 53277#34365452480 work queue: fast
2021/11/19 10:54:03.259 [debug] 53277#34365452480 buf ts completion: 800686C00 800686C78
2021/11/19 10:54:03.259 [debug] 53280#34365452480 posix_memalign(128, 1024): 800685800
2021/11/19 10:54:03.259 [debug] 53277#34365452480 free(800671080)
2021/11/19 10:54:03.259 [debug] 53281#34365452480 kevent(3) set event: id:8 ft:-1 fl:0025
2021/11/19 10:54:03.259 [debug] 53277#34365452480 free(800686C00)
2021/11/19 10:54:03.259 [debug] 53281#34365452480 user cred set gids: base gid:65534, ngroups: 1
2021/11/19 10:54:03.259 [debug] 53277#34365452480 mp 800611610 release: 1
2021/11/19 10:54:03.259 [debug] 53277#34365452480 kevent(3) changes:0 timeout:-1
2021/11/19 10:54:03.259 [debug] 53280#34365452480 malloc(168): 800611140
2021/11/19 10:54:03.259 [debug] 53280#34365452480 malloc(136): 800670D20
2021/11/19 10:54:03.259 [debug] 53280#34365452480 posix_memalign(128, 1024): 800685400
2021/11/19 10:54:03.259 [debug] 53280#34365452480 free(800670D20)
2021/11/19 10:54:03.259 [debug] 53280#34365452480 free(800685400)
2021/11/19 10:54:03.259 [debug] 53280#34365452480 free(800611140)
2021/11/19 10:54:03.259 [debug] 53280#34365452480 free(800670DB0)
2021/11/19 10:54:03.259 [debug] 53280#34365452480 free(800685800)
2021/11/19 10:54:03.259 [debug] 53281#34365452480 user cred set: "nobody" uid:65534
2021/11/19 10:54:03.259 [debug] 53280#34365452480 free(8006111F0)
2021/11/19 10:54:03.259 [debug] 53281#34365452480 pthread_mutex_lock(800572E78) enter
2021/11/19 10:54:03.259 [debug] 53281#34365452480 pthread_mutex_unlock(800572E78) exit
2021/11/19 10:54:03.259 [debug] 53280#34365452480 free(800670E40)
2021/11/19 10:54:03.259 [debug] 53280#34365452480 free(800685C00)
2021/11/19 10:54:03.259 [debug] 53280#34365452480 free(8006112A0)
2021/11/19 10:54:03.259 [debug] 53280#34365452480 malloc(168): 8006112A0
2021/11/19 10:54:03.259 [debug] 53277#34365452480 kevent(3): 1
2021/11/19 10:54:03.259 [debug] 53277#34365452480 kevent: id:6 ft:-1 fl:0025 ff:0 d:120 ud:800572DC0
2021/11/19 10:54:03.259 [debug] 53281#34365452480 sendmsg(7, -1, -1, 1): 16
2021/11/19 10:54:03.259 [debug] 53280#34365452480 malloc(136): 800670E40
2021/11/19 10:54:03.259 [debug] 53277#34365452480 timer expire minimum: 719594695:633194695
2021/11/19 10:54:03.259 [debug] 53280#34365452480 posix_memalign(128, 1024): 800685C00
2021/11/19 10:54:03.259 [debug] 53281#34365452480 router sent ready
2021/11/19 10:54:03.259 [info] 53281#34365452480 router started
2021/11/19 10:54:03.259 [debug] 53277#34365452480 work queue: fast
2021/11/19 10:54:03.259 [debug] 53277#34365452480 recvmsg(6, 2, 104): 16
2021/11/19 10:54:03.259 [debug] 53277#34365452480 port 6: message type:16
2021/11/19 10:54:03.259 [debug] 53277#34365452480 pthread_mutex_lock(800654270) enter
2021/11/19 10:54:03.259 [debug] 53277#34365452480 pthread_mutex_unlock(800654270) exit
2021/11/19 10:54:03.259 [debug] 53277#34365452480 process 53281 ready
2021/11/19 10:54:03.259 [debug] 53280#34365452480 free(800670E40)
2021/11/19 10:54:03.259 [debug] 53277#34365452480 new port 11 for process 53281
2021/11/19 10:54:03.259 [debug] 53281#34365452480 posix_memalign(64, 64): 8005F0800
2021/11/19 10:54:03.259 [debug] 53277#34365452480 malloc(136): 800671080
2021/11/19 10:54:03.259 [debug] 53277#34365452480 posix_memalign(128, 1024): 800686C00
2021/11/19 10:54:03.259 [debug] 53280#34365452480 free(800685C00)
2021/11/19 10:54:03.259 [debug] 53280#34365452480 free(8006112A0)
2021/11/19 10:54:03.259 [debug] 53277#34365452480 mp 800611610 retain: 2
2021/11/19 10:54:03.259 [debug] 53277#34365452480 send port 11 to process 53280
2021/11/19 10:54:03.259 [debug] 53280#34365452480 socket close(10)
2021/11/19 10:54:03.259 [debug] 53281#34365452480 posix_memalign(256, 256): 800F22100
2021/11/19 10:54:03.259 [debug] 53280#34365452480 free(800670ED0)
2021/11/19 10:54:03.259 [debug] 53280#34365452480 free(800686000)
2021/11/19 10:54:03.259 [debug] 53281#34365452480 posix_memalign(64, 64): 8005F07C0
2021/11/19 10:54:03.259 [debug] 53277#34365452480 pthread_mutex_lock(800572B78) enter
2021/11/19 10:54:03.259 [debug] 53280#34365452480 free(800611350)
2021/11/19 10:54:03.259 [debug] 53277#34365452480 pthread_mutex_unlock(800572B78) exit
2021/11/19 10:54:03.259 [debug] 53277#34365452480 using plain mode
2021/11/19 10:54:03.259 [debug] 53281#34365452480 posix_memalign(64, 64): 8005F0780
2021/11/19 10:54:03.259 [debug] 53280#34365452480 kevent(3) changes:1 timeout:-1
2021/11/19 10:54:03.259 [debug] 53277#34365452480 sendbuf: 0, 800686C78, 32
2021/11/19 10:54:03.259 [debug] 53281#34365452480 posix_memalign(64, 64): 8005F0740
2021/11/19 10:54:03.259 [debug] 53280#34365452480 kevent(3): 1
2021/11/19 10:54:03.259 [debug] 53277#34365452480 sendmsg(10, 11, -1, 2): 48
2021/11/19 10:54:03.259 [debug] 53280#34365452480 kevent: id:8 ft:-1 fl:0025 ff:0 d:176 ud:800572AC0
2021/11/19 10:54:03.259 [debug] 53277#34365452480 recvmsg(6, 2, 104): -1
2021/11/19 10:54:03.259 [debug] 53281#34365452480 posix_memalign(64, 64): 8005F0700
2021/11/19 10:54:03.259 [debug] 53280#34365452480 timer expire minimum: 719594695:633194695
2021/11/19 10:54:03.259 [debug] 53277#34365452480 recvmsg(6) not ready
2021/11/19 10:54:03.259 [debug] 53280#34365452480 work queue: fast
2021/11/19 10:54:03.259 [debug] 53277#34365452480 work queue: fast
2021/11/19 10:54:03.259 [debug] 53277#34365452480 buf ts completion: 800686C00 800686C78
2021/11/19 10:54:03.259 [debug] 53277#34365452480 free(800671080)
2021/11/19 10:54:03.259 [debug] 53277#34365452480 free(800686C00)
2021/11/19 10:54:03.259 [debug] 53277#34365452480 mp 800611610 release: 1
2021/11/19 10:54:03.259 [debug] 53280#34365452480 posix_memalign(16, 16496): 800640000
2021/11/19 10:54:03.259 [debug] 53277#34365452480 kevent(3) changes:0 timeout:-1
2021/11/19 10:54:03.259 [debug] 53281#34365452480 free(8005F0800)
2021/11/19 10:54:03.259 [debug] 53280#34365452480 recvmsg(8, 2, 128): 48
2021/11/19 10:54:03.259 [debug] 53280#34365452480 port 8: message type:10
2021/11/19 10:54:03.259 [debug] 53280#34365452480 new port 11 received for process 53281:0
2021/11/19 10:54:03.259 [debug] 53281#34365452480 posix_memalign(64, 64): 8005F0800
2021/11/19 10:54:03.259 [debug] 53281#34365452480 posix_memalign(64, 64): 8005F06C0
2021/11/19 10:54:03.259 [debug] 53280#34365452480 process port (53281, 0) not found
2021/11/19 10:54:03.259 [debug] 53280#34365452480 pthread_mutex_lock(800654270) enter
2021/11/19 10:54:03.259 [debug] 53281#34365452480 posix_memalign(64, 64): 8005F0680
2021/11/19 10:54:03.259 [debug] 53281#34365452480 posix_memalign(64, 64): 8005F0640
2021/11/19 10:54:03.259 [debug] 53281#34365452480 posix_memalign(64, 64): 8005F0600
2021/11/19 10:54:03.259 [debug] 53281#34365452480 posix_memalign(64, 64): 8005F05C0
2021/11/19 10:54:03.259 [debug] 53281#34365452480 posix_memalign(64, 64): 8005F0580
2021/11/19 10:54:03.259 [debug] 53280#34365452480 pthread_mutex_init(800687028)
2021/11/19 10:54:03.259 [debug] 53280#34365452480 process 53281 insert
2021/11/19 10:54:03.259 [debug] 53281#34365452480 posix_memalign(256, 256): 800F22000
2021/11/19 10:54:03.259 [debug] 53281#34365452480 posix_memalign(64, 64): 8005F0540
2021/11/19 10:54:03.259 [debug] 53280#34365452480 pthread_mutex_unlock(800654270) exit
2021/11/19 10:54:03.259 [debug] 53280#34365452480 malloc(168): 800611350
2021/11/19 10:54:03.259 [debug] 53280#34365452480 posix_memalign(16, 368): 800572C40
2021/11/19 10:54:03.259 [debug] 53281#34365452480 posix_memalign(64, 64): 8005F0500
2021/11/19 10:54:03.259 [debug] 53281#34365452480 posix_memalign(64, 64): 8005F04C0
2021/11/19 10:54:03.259 [debug] 53280#34365452480 malloc(136): 800670ED0
2021/11/19 10:54:03.259 [debug] 53280#34365452480 posix_memalign(128, 1024): 800686000
2021/11/19 10:54:03.259 [debug] 53281#34365452480 posix_memalign(64, 64): 8005F0480
2021/11/19 10:54:03.259 [debug] 53280#34365452480 pthread_mutex_init(800572CF8)
2021/11/19 10:54:03.259 [debug] 53281#34365452480 free(8005F0580)
2021/11/19 10:54:03.259 [debug] 53280#34365452480 port 800572C40 53281:0 new, type 3
2021/11/19 10:54:03.259 [debug] 53281#34365452480 posix_memalign(64, 64): 8005F0580
2021/11/19 10:54:03.259 [debug] 53281#34365452480 posix_memalign(64, 64): 8005F0440
2021/11/19 10:54:03.259 [debug] 53281#34365452480 posix_memalign(256, 256): 800F21F00
2021/11/19 10:54:03.259 [alert] 53280#34365452480 ioctl(11, FIONBIO) failed (9: Bad file descriptor)
2021/11/19 10:54:03.259 [debug] 53281#34365452480 posix_memalign(64, 64): 8005F0400
2021/11/19 10:54:03.259 [debug] 53281#34365452480 posix_memalign(64, 64): 8005F03C0
2021/11/19 10:54:03.259 [debug] 53281#34365452480 posix_memalign(64, 64): 8005F0380
2021/11/19 10:54:03.259 [debug] 53281#34365452480 posix_memalign(64, 64): 8005F0340
2021/11/19 10:54:03.259 [debug] 53280#34365452480 recvmsg(8, 2, 128): -1
2021/11/19 10:54:03.259 [debug] 53280#34365452480 recvmsg(8) not ready
2021/11/19 10:54:03.259 [debug] 53280#34365452480 kevent(3) changes:0 timeout:-1
2021/11/19 10:54:03.259 [debug] 53281#34365452480 free(8005F0440)
2021/11/19 10:54:03.259 [debug] 53281#34365452480 posix_memalign(64, 64): 8005F0440
2021/11/19 10:54:03.259 [debug] 53281#34365452480 posix_memalign(64, 64): 8005F0300
2021/11/19 10:54:03.259 [debug] 53281#34365452480 malloc(64): 8005F02C0
2021/11/19 10:54:03.259 [debug] 53281#34365452480 socket close(11)
2021/11/19 10:54:03.259 [debug] 53281#34365452480 free(8006112A0)
2021/11/19 10:54:03.259 [debug] 53281#34365452480 kevent(3) changes:1 timeout:-1
2021/11/19 10:54:03.259 [debug] 53281#34365452480 kevent(3): 1
2021/11/19 10:54:03.259 [debug] 53281#34365452480 kevent: id:8 ft:-1 fl:0025 ff:0 d:176 ud:800572940
2021/11/19 10:54:03.259 [debug] 53281#34365452480 timer expire minimum: 719594695:633194695
2021/11/19 10:54:03.259 [debug] 53281#34365452480 work queue: fast
2021/11/19 10:54:03.259 [debug] 53281#34365452480 posix_memalign(16, 16496): 800640000
2021/11/19 10:54:03.259 [debug] 53281#34365452480 recvmsg(8, 2, 128): 48
2021/11/19 10:54:03.259 [debug] 53281#34365452480 port 8: message type:10
2021/11/19 10:54:03.259 [debug] 53281#34365452480 new port 10 received for process 53280:0
2021/11/19 10:54:03.259 [debug] 53281#34365452480 process port (53280, 0) not found
2021/11/19 10:54:03.259 [debug] 53281#34365452480 pthread_mutex_lock(800654270) enter
2021/11/19 10:54:03.259 [debug] 53281#34365452480 pthread_mutex_init(800686828)
2021/11/19 10:54:03.259 [debug] 53281#34365452480 process 53280 insert
2021/11/19 10:54:03.259 [debug] 53281#34365452480 pthread_mutex_unlock(800654270) exit
2021/11/19 10:54:03.259 [debug] 53281#34365452480 malloc(168): 8006112A0
2021/11/19 10:54:03.259 [debug] 53281#34365452480 posix_memalign(16, 368): 800572AC0
2021/11/19 10:54:03.259 [debug] 53281#34365452480 malloc(136): 800670F60
2021/11/19 10:54:03.259 [debug] 53281#34365452480 posix_memalign(128, 1024): 800686400
2021/11/19 10:54:03.259 [debug] 53281#34365452480 pthread_mutex_init(800572B78)
2021/11/19 10:54:03.259 [debug] 53281#34365452480 port 800572AC0 53280:0 new, type 2
2021/11/19 10:54:03.259 [alert] 53281#34365452480 ioctl(10, FIONBIO) failed (9: Bad file descriptor)
2021/11/19 10:54:03.259 [debug] 53281#34365452480 pthread_mutex_lock(800572B78) enter
2021/11/19 10:54:03.259 [debug] 53281#34365452480 pthread_mutex_unlock(800572B78) exit
2021/11/19 10:54:03.259 [debug] 53281#34365452480 sendmsg(10, -1, -1, 1): -1
2021/11/19 10:54:03.259 [alert] 53281#34365452480 sendmsg(10, -1, -1, 1) failed (9: Bad file descriptor)
2021/11/19 10:54:03.259 [debug] 53281#34365452480 recvmsg(8, 2, 128): -1
2021/11/19 10:54:03.259 [debug] 53281#34365452480 recvmsg(8) not ready
2021/11/19 10:54:03.259 [debug] 53281#34365452480 work queue: fast
2021/11/19 10:54:03.259 [debug] 53281#34365452480 port error handler 800572AC0
2021/11/19 10:54:03.259 [debug] 53281#34365452480 pthread_mutex_lock(800572B78) enter
2021/11/19 10:54:03.259 [debug] 53281#34365452480 pthread_mutex_unlock(800572B78) exit
2021/11/19 10:54:03.259 [debug] 53281#34365452480 kevent(3) changes:0 timeout:-1





cat unit.log:
2021/11/19 10:53:58.239 [debug] 52506#34365452480 kevent(3): 1
2021/11/19 10:53:58.239 [debug] 52506#34365452480 kevent: id:15 ft:-6 fl:0021 ff:0 d:1 ud:467A28
2021/11/19 10:53:58.239 [debug] 52506#34365452480 timer expire minimum: 719467235:633189665
2021/11/19 10:53:58.239 [debug] 52506#34365452480 work queue: fast
2021/11/19 10:53:58.239 [debug] 52506#34365452480 sigterm handler signo:15 (SIGTERM)
2021/11/19 10:53:58.239 [debug] 52506#34365452480 exiting
2021/11/19 10:53:58.239 [debug] 52506#34365452480 close idle connections
2021/11/19 10:53:58.239 [debug] 52506#34365452480 work queue: fast
2021/11/19 10:53:58.239 [debug] 52506#34365452480 thread pools: 0
2021/11/19 10:53:58.239 [debug] 52506#34365452480 unlink("/usr/local/nginxunittest/unit.pid")
2021/11/19 10:53:58.239 [debug] 52506#34365452480 unlink("/usr/local/nginxunittest/control.unit.sock")
2021/11/19 10:53:58.239 [debug] 52506#34365452480 pthread_mutex_lock(800654270) enter
2021/11/19 10:53:58.239 [debug] 52506#34365452480 process 52506 removed
2021/11/19 10:53:58.239 [debug] 52506#34365452480 pthread_mutex_unlock(800654270) exit
2021/11/19 10:53:58.239 [debug] 52506#34365452480 port 800572DC0 52506:0 close, type 0
2021/11/19 10:53:58.239 [debug] 52506#34365452480 close(6)
2021/11/19 10:53:58.239 [debug] 52506#34365452480 close(7)
2021/11/19 10:53:58.239 [debug] 52506#34365452480 pthread_mutex_lock(800654270) enter
2021/11/19 10:53:58.239 [debug] 52506#34365452480 free(800EB0B00)
2021/11/19 10:53:58.239 [debug] 52506#34365452480 process 52509 removed
2021/11/19 10:53:58.239 [debug] 52506#34365452480 pthread_mutex_unlock(800654270) exit
2021/11/19 10:53:58.239 [debug] 52506#34365452480 port 800572AC0 52509:0 close, type 2
2021/11/19 10:53:58.239 [debug] 52506#34365452480 close(10)
2021/11/19 10:53:58.239 [debug] 52506#34365452480 free(800EB0A80)
2021/11/19 10:53:58.239 [debug] 52506#34365452480 port 800572AC0 52509:0 release, type 2
2021/11/19 10:53:58.239 [debug] 52506#34365452480 free(0)
2021/11/19 10:53:58.239 [debug] 52506#34365452480 pthread_mutex_destroy(800686828)
2021/11/19 10:53:58.239 [debug] 52506#34365452480 free(800670FF0)
2021/11/19 10:53:58.239 [debug] 52506#34365452480 free(800686800)
2021/11/19 10:53:58.239 [debug] 52506#34365452480 mp 800611400 release: 0
2021/11/19 10:53:58.239 [debug] 52506#34365452480 pthread_mutex_destroy(800572B78)
2021/11/19 10:53:58.239 [debug] 52506#34365452480 free(800572AC0)
2021/11/19 10:53:58.239 [debug] 52506#34365452480 free(800670F60)
2021/11/19 10:53:58.239 [debug] 52506#34365452480 free(800686400)
2021/11/19 10:53:58.239 [debug] 52506#34365452480 free(800611400)
2021/11/19 10:53:58.239 [debug] 52506#34365452480 pthread_mutex_destroy(800654270)
2021/11/19 10:53:58.239 [debug] 52506#34365452480 free(800654200)
2021/11/19 10:53:58.239 [debug] 52506#34365452480 free(8006668C0)
2021/11/19 10:53:58.239 [debug] 52506#34365452480 free(800671110)
2021/11/19 10:53:58.239 [debug] 52506#34365452480 free(800687000)
2021/11/19 10:53:58.239 [debug] 52506#34365452480 free(800671230)
2021/11/19 10:53:58.239 [debug] 52506#34365452480 free(800687C00)
2021/11/19 10:53:58.239 [debug] 52506#34365452480 free(8006712C0)
2021/11/19 10:53:58.239 [debug] 52506#34365452480 free(800688400)
2021/11/19 10:53:58.239 [debug] 52506#34365452480 free(8006116C0)
2021/11/19 10:53:58.239 [debug] 52928#34365452480 close(10)
2021/11/19 10:53:58.239 [debug] 52927#34365452480 free(800611350)
2021/11/19 10:53:58.239 [debug] 52927#34365452480 pthread_mutex_destroy(800654270)
2021/11/19 10:53:58.239 [alert] 52928#34365452480 close(10) failed (9: Bad file descriptor)
2021/11/19 10:53:58.239 [debug] 52928#34365452480 free(800EB0A80)
2021/11/19 10:53:58.239 [debug] 52927#34365452480 free(800654200)
2021/11/19 10:53:58.239 [debug] 52928#34365452480 port 800572AC0 52927:0 release, type 2
2021/11/19 10:53:58.239 [debug] 52928#34365452480 free(0)
2021/11/19 10:53:58.239 [debug] 52928#34365452480 pthread_mutex_destroy(800686828)
2021/11/19 10:53:58.239 [debug] 52928#34365452480 free(800670FF0)
2021/11/19 10:53:58.239 [debug] 52928#34365452480 free(800686800)
2021/11/19 10:53:58.239 [debug] 52928#34365452480 mp 8006112A0 release: 0
2021/11/19 10:53:58.239 [debug] 52928#34365452480 pthread_mutex_destroy(800572B78)
2021/11/19 10:53:58.239 [debug] 52928#34365452480 free(800572AC0)
2021/11/19 10:53:58.239 [debug] 52927#34365452480 free(8006668C0)
2021/11/19 10:53:58.239 [debug] 52928#34365452480 free(800670F60)
2021/11/19 10:53:58.239 [debug] 52928#34365452480 free(800686400)
2021/11/19 10:53:58.239 [debug] 52928#34365452480 free(8006112A0)
2021/11/19 10:53:58.239 [debug] 52928#34365452480 pthread_mutex_destroy(800654270)
2021/11/19 10:53:58.239 [debug] 52927#34365452480 free(800671110)
2021/11/19 10:53:58.239 [debug] 52927#34365452480 free(800687000)
2021/11/19 10:53:58.239 [debug] 52928#34365452480 free(800654200)
2021/11/19 10:53:58.239 [debug] 52927#34365452480 free(800671230)
2021/11/19 10:53:58.239 [debug] 52927#34365452480 free(800687C00)
2021/11/19 10:53:58.239 [debug] 52927#34365452480 free(8006712C0)
2021/11/19 10:53:58.239 [debug] 52927#34365452480 free(800688400)
2021/11/19 10:53:58.239 [debug] 52927#34365452480 free(8006116C0)
2021/11/19 10:53:58.239 [debug] 52927#34365452480 exit: 0
2021/11/19 10:53:58.239 [debug] 52928#34365452480 free(8006668C0)
2021/11/19 10:53:58.239 [debug] 52928#34365452480 free(800671110)
2021/11/19 10:53:58.239 [debug] 52928#34365452480 free(800687000)
2021/11/19 10:53:58.239 [debug] 52928#34365452480 free(800671230)
2021/11/19 10:53:58.239 [debug] 52928#34365452480 free(800687C00)
2021/11/19 10:53:58.239 [debug] 52928#34365452480 free(8006712C0)
2021/11/19 10:53:58.239 [debug] 52928#34365452480 free(800688400)
2021/11/19 10:53:58.239 [debug] 52928#34365452480 free(8006116C0)
2021/11/19 10:53:58.239 [debug] 52928#34365452480 exit: 0
2021/11/19 10:53:58.239 [debug] 52924#34365452480 kevent(3): 1
2021/11/19 10:53:58.239 [debug] 52924#34365452480 kevent: id:20 ft:-6 fl:0021 ff:0 d:1 ud:467A40
2021/11/19 10:53:58.239 [debug] 52924#34365452480 timer expire minimum: 719589665:633189665
2021/11/19 10:53:58.239 [debug] 52924#34365452480 work queue: fast
2021/11/19 10:53:58.239 [debug] 52924#34365452480 sigchld handler signo:20 (SIGCHLD)
2021/11/19 10:53:58.239 [debug] 52924#34365452480 waitpid(): 52928
2021/11/19 10:53:58.239 [notice] 52924#34365452480 process 52928 exited with code 0
2021/11/19 10:53:58.239 [debug] 52924#34365452480 pthread_mutex_lock(800654270) enter
2021/11/19 10:53:58.239 [debug] 52924#34365452480 pthread_mutex_unlock(800654270) exit
2021/11/19 10:53:58.239 [debug] 52924#34365452480 port 800572940 52928:0 close, type 3
2021/11/19 10:53:58.239 [debug] 52924#34365452480 close(11)
2021/11/19 10:53:58.239 [debug] 52924#34365452480 port 800572940 52928:0 release, type 3
2021/11/19 10:53:58.239 [debug] 52924#34365452480 pthread_mutex_lock(800654270) enter
2021/11/19 10:53:58.239 [debug] 52924#34365452480 process 52928 removed
2021/11/19 10:53:58.239 [debug] 52924#34365452480 pthread_mutex_unlock(800654270) exit
2021/11/19 10:53:58.239 [debug] 52924#34365452480 free(0)
2021/11/19 10:53:58.239 [debug] 52924#34365452480 pthread_mutex_destroy(800686928)
2021/11/19 10:53:58.239 [debug] 52924#34365452480 mp 800611350 release: 0
2021/11/19 10:53:58.239 [debug] 52924#34365452480 pthread_mutex_destroy(8005729F8)
2021/11/19 10:53:58.239 [debug] 52924#34365452480 free(800572940)
2021/11/19 10:53:58.239 [debug] 52924#34365452480 free(800670ED0)
2021/11/19 10:53:58.239 [debug] 52924#34365452480 free(800686000)
2021/11/19 10:53:58.239 [debug] 52924#34365452480 free(800611350)
2021/11/19 10:53:58.239 [debug] 52924#34365452480 kevent(3) changes:0 timeout:-1
2021/11/19 10:53:58.239 [debug] 52924#34365452480 kevent(3): 1
2021/11/19 10:53:58.239 [debug] 52924#34365452480 kevent: id:20 ft:-6 fl:0021 ff:0 d:1 ud:467A40
2021/11/19 10:53:58.239 [debug] 52924#34365452480 timer expire minimum: 719589665:633189665
2021/11/19 10:53:58.239 [debug] 52924#34365452480 work queue: fast
2021/11/19 10:53:58.239 [debug] 52924#34365452480 sigchld handler signo:20 (SIGCHLD)
2021/11/19 10:53:58.239 [debug] 52924#34365452480 waitpid(): 52927
2021/11/19 10:53:58.239 [notice] 52924#34365452480 process 52927 exited with code 0
2021/11/19 10:53:58.239 [debug] 52924#34365452480 pthread_mutex_lock(800654270) enter
2021/11/19 10:53:58.239 [debug] 52924#34365452480 pthread_mutex_unlock(800654270) exit
2021/11/19 10:53:58.239 [debug] 52924#34365452480 port 800572AC0 52927:0 close, type 2
2021/11/19 10:53:58.239 [debug] 52924#34365452480 close(10)
2021/11/19 10:53:58.239 [debug] 52924#34365452480 port 800572AC0 52927:0 release, type 2
2021/11/19 10:53:58.239 [debug] 52924#34365452480 pthread_mutex_lock(800654270) enter
2021/11/19 10:53:58.239 [debug] 52924#34365452480 process 52927 removed
2021/11/19 10:53:58.239 [debug] 52924#34365452480 pthread_mutex_unlock(800654270) exit
2021/11/19 10:53:58.239 [debug] 52924#34365452480 free(0)
2021/11/19 10:53:58.239 [debug] 52924#34365452480 pthread_mutex_destroy(800686828)
2021/11/19 10:53:58.239 [debug] 52924#34365452480 free(800670FF0)
2021/11/19 10:53:58.239 [debug] 52924#34365452480 free(800686800)
2021/11/19 10:53:58.239 [debug] 52924#34365452480 mp 800611400 release: 0
2021/11/19 10:53:58.239 [debug] 52924#34365452480 pthread_mutex_destroy(800572B78)
2021/11/19 10:53:58.239 [debug] 52924#34365452480 free(800572AC0)
2021/11/19 10:53:58.239 [debug] 52924#34365452480 free(800670F60)
2021/11/19 10:53:58.239 [debug] 52924#34365452480 free(800686400)
2021/11/19 10:53:58.239 [debug] 52924#34365452480 free(800611400)
2021/11/19 10:53:58.239 [debug] 52924#34365452480 exiting
2021/11/19 10:53:58.239 [debug] 52924#34365452480 close idle connections
2021/11/19 10:53:58.239 [debug] 52924#34365452480 work queue: fast
2021/11/19 10:53:58.239 [debug] 52924#34365452480 thread pools: 0
2021/11/19 10:53:58.239 [debug] 52924#34365452480 unlink("/usr/local/nginxunittest/unit.pid")
2021/11/19 10:53:58.239 [alert] 52924#34365452480 unlink("/usr/local/nginxunittest/unit.pid") failed (2: No such file or directory)
2021/11/19 10:53:58.239 [debug] 52924#34365452480 unlink("/usr/local/nginxunittest/control.unit.sock")
2021/11/19 10:53:58.239 [alert] 52924#34365452480 unlink("/usr/local/nginxunittest/control.unit.sock") failed (2: No such file or directory)
2021/11/19 10:53:58.239 [debug] 52924#34365452480 pthread_mutex_lock(800654270) enter
2021/11/19 10:53:58.239 [debug] 52924#34365452480 free(800EB0B00)
2021/11/19 10:53:58.239 [debug] 52924#34365452480 process 52924 removed
2021/11/19 10:53:58.239 [debug] 52924#34365452480 pthread_mutex_unlock(800654270) exit
2021/11/19 10:53:58.239 [debug] 52924#34365452480 port 800572DC0 52924:0 close, type 0
2021/11/19 10:53:58.239 [debug] 52924#34365452480 close(6)
2021/11/19 10:53:58.239 [debug] 52924#34365452480 close(7)
2021/11/19 10:53:58.239 [debug] 52924#34365452480 free(800EB0A80)
2021/11/19 10:53:58.239 [debug] 52924#34365452480 pthread_mutex_destroy(800654270)
2021/11/19 10:53:58.239 [debug] 52924#34365452480 free(800654200)
2021/11/19 10:53:58.239 [debug] 52924#34365452480 free(8006668C0)
2021/11/19 10:53:58.239 [debug] 52924#34365452480 free(800671110)
2021/11/19 10:53:58.239 [debug] 52924#34365452480 free(800687000)
2021/11/19 10:53:58.239 [debug] 52924#34365452480 free(800671230)
2021/11/19 10:53:58.239 [debug] 52924#34365452480 free(800687C00)
2021/11/19 10:53:58.239 [debug] 52924#34365452480 free(8006712C0)
2021/11/19 10:53:58.239 [debug] 52924#34365452480 free(800688400)
2021/11/19 10:53:58.239 [debug] 52924#34365452480 free(8006116C0)
2021/11/19 10:53:58.239 [debug] 52924#34365452480 exit: 0
2021/11/19 10:54:03.259 [debug] 53276#34365452480 thread pool destroy: 0
2021/11/19 10:54:03.259 [debug] 53276#34365452480 work queue: fast
2021/11/19 10:54:03.259 [debug] 53276#34365452480 thread pools: 1
2021/11/19 10:54:03.259 [debug] 53276#34365452480 free(800E91AC0)
2021/11/19 10:54:03.259 [debug] 53276#34365452480 fork(): 53277
2021/11/19 10:54:03.259 [debug] 53277#34365452480 daemon
2021/11/19 10:54:03.259 [debug] 53277#34365452480 close(3)
2021/11/19 10:54:03.259 [debug] 53277#34365452480 kqueue 3 free
2021/11/19 10:54:03.259 [debug] 53277#34365452480 free(800688000)
2021/11/19 10:54:03.259 [debug] 53277#34365452480 free(80069F000)
2021/11/19 10:54:03.259 [debug] 53277#34365452480 malloc(4096): 80069F000
2021/11/19 10:54:03.259 [debug] 53277#34365452480 malloc(1024): 800688000
2021/11/19 10:54:03.259 [debug] 53277#34365452480 kqueue(): 3
2021/11/19 10:54:03.259 [debug] 53277#34365452480 kevent(3) signo:1 (SIGHUP)
2021/11/19 10:54:03.259 [debug] 53277#34365452480 kevent(3) signo:2 (SIGINT)
2021/11/19 10:54:03.259 [debug] 53277#34365452480 kevent(3) signo:3 (SIGQUIT)
2021/11/19 10:54:03.259 [debug] 53277#34365452480 kevent(3) signo:15 (SIGTERM)
2021/11/19 10:54:03.259 [debug] 53277#34365452480 kevent(3) signo:20 (SIGCHLD)
2021/11/19 10:54:03.259 [debug] 53277#34365452480 kevent(3) signo:30 (SIGUSR1)
2021/11/19 10:54:03.259 [debug] 53277#34365452480 open("/usr/local/nginxunittest/unit.pid", 0x605, 0x1A4): 6 err:0
2021/11/19 10:54:03.259 [debug] 53277#34365452480 pwrite(6, 7FFFFFDFD5A0, 6, 0): 6
2021/11/19 10:54:03.259 [debug] 53277#34365452480 close(6)
2021/11/19 10:54:03.259 [debug] 53277#34365452480 pthread_mutex_lock(800654270) enter
2021/11/19 10:54:03.259 [debug] 53277#34365452480 pthread_mutex_init(800687F28)
2021/11/19 10:54:03.259 [debug] 53277#34365452480 posix_memalign(128, 128): 800EB0B00
2021/11/19 10:54:03.259 [debug] 53277#34365452480 process 53277 insert
2021/11/19 10:54:03.259 [debug] 53277#34365452480 pthread_mutex_unlock(800654270) exit
2021/11/19 10:54:03.259 [debug] 53277#34365452480 malloc(168): 800611560
2021/11/19 10:54:03.259 [debug] 53277#34365452480 posix_memalign(16, 368): 800572DC0
2021/11/19 10:54:03.259 [debug] 53277#34365452480 malloc(136): 8006711A0
2021/11/19 10:54:03.259 [debug] 53277#34365452480 posix_memalign(128, 1024): 800687400
2021/11/19 10:54:03.259 [debug] 53277#34365452480 pthread_mutex_init(800572E78)
2021/11/19 10:54:03.259 [debug] 53277#34365452480 port 800572DC0 53277:0 new, type 0
2021/11/19 10:54:03.259 [debug] 53277#34365452480 posix_memalign(128, 128): 800EB0A80
2021/11/19 10:54:03.259 [debug] 53277#34365452480 socketpair(): 6:7
2021/11/19 10:54:03.259 [debug] 53277#34365452480 getsockopt(7, 65535, SO_SNDBUF): 65536
2021/11/19 10:54:03.259 [debug] 53277#34365452480 getsockopt(6, 65535, SO_RCVBUF): 65536
2021/11/19 10:54:03.259 [debug] 53277#34365452480 kevent(3) set event: id:6 ft:-1 fl:0025
2021/11/19 10:54:03.259 [debug] 53277#34365452480 malloc(136): 800671110
2021/11/19 10:54:03.259 [debug] 53277#34365452480 posix_memalign(128, 1024): 800687000
2021/11/19 10:54:03.259 [debug] 53277#34365452480 pthread_mutex_init(800687028)
2021/11/19 10:54:03.259 [debug] 53277#34365452480 malloc(168): 8006114B0
2021/11/19 10:54:03.259 [debug] 53277#34365452480 posix_memalign(16, 368): 800572C40
2021/11/19 10:54:03.259 [debug] 53277#34365452480 malloc(136): 800671080
2021/11/19 10:54:03.259 [debug] 53277#34365452480 posix_memalign(128, 1024): 800686C00
2021/11/19 10:54:03.259 [debug] 53277#34365452480 pthread_mutex_init(800572CF8)
2021/11/19 10:54:03.259 [debug] 53277#34365452480 port 800572C40 0:0 new, type 1
2021/11/19 10:54:03.259 [debug] 53277#34365452480 socketpair(): 8:9
2021/11/19 10:54:03.259 [debug] 53277#34365452480 getsockopt(9, 65535, SO_SNDBUF): 65536
2021/11/19 10:54:03.259 [debug] 53277#34365452480 getsockopt(8, 65535, SO_RCVBUF): 65536
2021/11/19 10:54:03.259 [debug] 53277#34365452480 malloc(168): 800611400
2021/11/19 10:54:03.259 [debug] 53277#34365452480 fork(discovery): 53279
2021/11/19 10:54:03.259 [debug] 53277#34365452480 pthread_mutex_lock(800654270) enter
2021/11/19 10:54:03.259 [debug] 53277#34365452480 process 53279 added
2021/11/19 10:54:03.259 [debug] 53277#34365452480 pthread_mutex_unlock(800654270) exit
2021/11/19 10:54:03.259 [debug] 53277#34365452480 socket close(8)
2021/11/19 10:54:03.259 [debug] 53277#34365452480 free(800611400)
2021/11/19 10:54:03.259 [debug] 53277#34365452480 kevent(3) changes:1 timeout:-1
2021/11/19 10:54:03.259 [debug] 53279#34365452480 discovery setup
2021/11/19 10:54:03.259 [debug] 53279#34365452480 kqueue 3 free
2021/11/19 10:54:03.259 [debug] 53279#34365452480 free(800688000)
2021/11/19 10:54:03.259 [debug] 53279#34365452480 free(80069F000)
2021/11/19 10:54:03.259 [debug] 53279#34365452480 malloc(4096): 80069F000
2021/11/19 10:54:03.259 [debug] 53279#34365452480 malloc(1024): 800688000
2021/11/19 10:54:03.259 [debug] 53279#34365452480 kqueue(): 3
2021/11/19 10:54:03.259 [debug] 53279#34365452480 kevent(3) signo:1 (SIGHUP)
2021/11/19 10:54:03.259 [debug] 53279#34365452480 kevent(3) signo:2 (SIGINT)
2021/11/19 10:54:03.259 [debug] 53279#34365452480 kevent(3) signo:3 (SIGQUIT)
2021/11/19 10:54:03.259 [debug] 53279#34365452480 kevent(3) signo:15 (SIGTERM)
2021/11/19 10:54:03.259 [debug] 53279#34365452480 kevent(3) signo:20 (SIGCHLD)
2021/11/19 10:54:03.259 [debug] 53279#34365452480 kevent(3) signo:30 (SIGUSR1)
2021/11/19 10:54:03.259 [debug] 53279#34365452480 kevent(3) signo:31 (SIGUSR2)
2021/11/19 10:54:03.259 [debug] 53279#34365452480 malloc(208): 800E91AC0
2021/11/19 10:54:03.259 [debug] 53279#34365452480 socket close(6)
2021/11/19 10:54:03.259 [debug] 53279#34365452480 pthread_mutex_lock(800654270) enter
2021/11/19 10:54:03.259 [debug] 53279#34365452480 process 53279 added
2021/11/19 10:54:03.269 [debug] 53279#34365452480 pthread_mutex_unlock(800654270) exit
2021/11/19 10:54:03.269 [debug] 53279#34365452480 kevent(3) set event: id:8 ft:-1 fl:0025
2021/11/19 10:54:03.269 [debug] 53279#34365452480 user cred set gids: base gid:65534, ngroups: 1
2021/11/19 10:54:03.269 [debug] 53279#34365452480 user cred set: "nobody" uid:65534
2021/11/19 10:54:03.269 [debug] 53279#34365452480 pthread_mutex_lock(800572E78) enter
2021/11/19 10:54:03.269 [debug] 53279#34365452480 pthread_mutex_unlock(800572E78) exit
2021/11/19 10:54:03.269 [debug] 53279#34365452480 sendmsg(7, -1, -1, 1): 16
2021/11/19 10:54:03.269 [debug] 53279#34365452480 discovery sent ready
2021/11/19 10:54:03.269 [info] 53279#34365452480 discovery started
2021/11/19 10:54:03.269 [debug] 53279#34365452480 malloc(168): 800611350
2021/11/19 10:54:03.259 [debug] 53277#34365452480 kevent(3): 1
2021/11/19 10:54:03.259 [debug] 53277#34365452480 kevent: id:6 ft:-1 fl:0025 ff:0 d:120 ud:800572DC0
2021/11/19 10:54:03.259 [debug] 53277#34365452480 timer expire minimum: 719594698:633194695
2021/11/19 10:54:03.259 [debug] 53277#34365452480 work queue: fast
2021/11/19 10:54:03.259 [debug] 53277#34365452480 posix_memalign(16, 16496): 800630000
2021/11/19 10:54:03.259 [debug] 53277#34365452480 recvmsg(6, 2, 104): 16
2021/11/19 10:54:03.259 [debug] 53277#34365452480 port 6: message type:16
2021/11/19 10:54:03.259 [debug] 53277#34365452480 pthread_mutex_lock(800654270) enter
2021/11/19 10:54:03.259 [debug] 53277#34365452480 pthread_mutex_unlock(800654270) exit
2021/11/19 10:54:03.259 [debug] 53277#34365452480 process 53279 ready
2021/11/19 10:54:03.259 [debug] 53277#34365452480 new port 9 for process 53279
2021/11/19 10:54:03.259 [debug] 53277#34365452480 recvmsg(6, 2, 104): -1
2021/11/19 10:54:03.259 [debug] 53277#34365452480 recvmsg(6) not ready
2021/11/19 10:54:03.259 [debug] 53277#34365452480 kevent(3) changes:0 timeout:-1
2021/11/19 10:54:03.269 [debug] 53279#34365452480 malloc(136): 800670FF0
2021/11/19 10:54:03.269 [debug] 53279#34365452480 posix_memalign(128, 1024): 800686800
2021/11/19 10:54:03.269 [notice] 53279#34365452480 module: python 3.6.12 "/usr/local/nginxunittest/modules/py36.unit.so"
2021/11/19 10:54:03.269 [debug] 53279#34365452480 malloc(136): 800670F60
2021/11/19 10:54:03.269 [debug] 53279#34365452480 posix_memalign(128, 1024): 800686400
2021/11/19 10:54:03.269 [debug] 53279#34365452480 module: 1 3.6.12 /usr/local/nginxunittest/modules/py36.unit.so
2021/11/19 10:54:03.269 [debug] 53279#34365452480 posix_memalign(16, 520): 800F248C0
2021/11/19 10:54:03.269 [debug] 53279#34365452480 posix_memalign(128, 128): 800EB0A00
2021/11/19 10:54:03.269 [debug] 53279#34365452480 rpc: stream #1 registered
2021/11/19 10:54:03.269 [debug] 53279#34365452480 posix_memalign(128, 128): 800EB0980
2021/11/19 10:54:03.269 [debug] 53279#34365452480 rpc: stream #1 assigned uniq pid 53277 (800686D08)
2021/11/19 10:54:03.269 [debug] 53279#34365452480 pthread_mutex_lock(800572E78) enter
2021/11/19 10:54:03.269 [debug] 53279#34365452480 pthread_mutex_unlock(800572E78) exit
2021/11/19 10:54:03.269 [debug] 53279#34365452480 using plain mode
2021/11/19 10:54:03.269 [debug] 53279#34365452480 sendbuf: 0, 800F24908, 356
2021/11/19 10:54:03.269 [debug] 53279#34365452480 sendmsg(7, -1, -1, 2): 372
2021/11/19 10:54:03.259 [debug] 53277#34365452480 kevent(3): 1
2021/11/19 10:54:03.269 [debug] 53279#34365452480 socket close(9)
2021/11/19 10:54:03.269 [debug] 53279#34365452480 free(800611400)
2021/11/19 10:54:03.259 [debug] 53277#34365452480 kevent: id:6 ft:-1 fl:0025 ff:0 d:476 ud:800572DC0
2021/11/19 10:54:03.259 [debug] 53277#34365452480 timer expire minimum: 719594695:633194695
2021/11/19 10:54:03.269 [debug] 53279#34365452480 work queue: fast
2021/11/19 10:54:03.269 [debug] 53279#34365452480 free(800670F60)
2021/11/19 10:54:03.269 [debug] 53279#34365452480 free(800686400)
2021/11/19 10:54:03.259 [debug] 53277#34365452480 work queue: fast
2021/11/19 10:54:03.269 [debug] 53279#34365452480 free(800670FF0)
2021/11/19 10:54:03.269 [debug] 53279#34365452480 free(800686800)
2021/11/19 10:54:03.259 [debug] 53277#34365452480 recvmsg(6, 2, 104): 372
2021/11/19 10:54:03.259 [debug] 53277#34365452480 port 6: message type:4
2021/11/19 10:54:03.269 [debug] 53279#34365452480 free(800F248C0)
2021/11/19 10:54:03.259 [debug] 53277#34365452480 process port (53279, 0) found
2021/11/19 10:54:03.259 [debug] 53277#34365452480 pthread_mutex_lock(800572CF8) enter
2021/11/19 10:54:03.259 [debug] 53277#34365452480 pthread_mutex_unlock(800572CF8) exit
2021/11/19 10:54:03.269 [debug] 53279#34365452480 free(800611350)
2021/11/19 10:54:03.269 [debug] 53279#34365452480 kevent(3) changes:1 timeout:-1
2021/11/19 10:54:03.259 [debug] 53277#34365452480 sendmsg(9, -1, -1, 1): 16
2021/11/19 10:54:03.259 [debug] 53277#34365452480 malloc(168): 800611400
2021/11/19 10:54:03.259 [debug] 53277#34365452480 application languages: "[{"type": 1, "version": "3.6.12", "file": "/usr/local/nginxunittest/modules/py36.unit.so", "mounts": [{"src": "/usr/local/lib/python3.6", "dst": "/usr/local/lib/python3.6", "name": "bind", "type": 1, "flags": 0, "data": ""},{"src": "/usr/local/lib/python36.zip", "dst": "/usr/local/lib/python36.zip", "name": "bind", "type": 1, "flags": 0, "data": ""},]},]"
2021/11/19 10:54:03.269 [debug] 53279#34365452480 kevent(3): 1
2021/11/19 10:54:03.269 [debug] 53279#34365452480 kevent: id:8 ft:-1 fl:0025 ff:0 d:120 ud:800572C40
2021/11/19 10:54:03.269 [debug] 53279#34365452480 timer expire minimum: 719594698:633194695
2021/11/19 10:54:03.269 [debug] 53279#34365452480 work queue: fast
2021/11/19 10:54:03.259 [debug] 53277#34365452480 malloc(136): 800670FF0
2021/11/19 10:54:03.269 [debug] 53279#34365452480 posix_memalign(16, 16496): 800630000
2021/11/19 10:54:03.269 [debug] 53279#34365452480 recvmsg(8, 2, 104): 16
2021/11/19 10:54:03.269 [debug] 53279#34365452480 port 8: message type:1
2021/11/19 10:54:03.259 [debug] 53277#34365452480 posix_memalign(128, 1024): 800686800
2021/11/19 10:54:03.269 [debug] 53279#34365452480 free(800EB0A00)
2021/11/19 10:54:03.259 [debug] 53277#34365452480 malloc(168): 800611350
2021/11/19 10:54:03.269 [debug] 53279#34365452480 rpc: stream #1 last handler, type 1
2021/11/19 10:54:03.269 [debug] 53279#34365452480 close listen connections
2021/11/19 10:54:03.259 [debug] 53277#34365452480 malloc(136): 800670F60
2021/11/19 10:54:03.259 [debug] 53277#34365452480 posix_memalign(128, 1024): 800686400
2021/11/19 10:54:03.269 [debug] 53279#34365452480 exiting
2021/11/19 10:54:03.269 [debug] 53279#34365452480 thread pool destroy: 0
2021/11/19 10:54:03.259 [debug] 53277#34365452480 malloc(168): 8006112A0
2021/11/19 10:54:03.259 [debug] 53277#34365452480 malloc(136): 800670ED0
2021/11/19 10:54:03.269 [debug] 53279#34365452480 close idle connections
2021/11/19 10:54:03.259 [debug] 53277#34365452480 posix_memalign(128, 1024): 800686000
2021/11/19 10:54:03.269 [debug] 53279#34365452480 rpc: stream #1 remove first and last pid 53277 registration (800686D08)
2021/11/19 10:54:03.269 [debug] 53279#34365452480 free(800EB0980)
2021/11/19 10:54:03.269 [debug] 53279#34365452480 rpc: stream #1 free registration
2021/11/19 10:54:03.269 [debug] 53279#34365452480 recvmsg(8, 2, 104): -1
2021/11/19 10:54:03.269 [debug] 53279#34365452480 recvmsg(8) not ready
2021/11/19 10:54:03.269 [debug] 53279#34365452480 work queue: fast
2021/11/19 10:54:03.269 [debug] 53279#34365452480 thread pools: 1
2021/11/19 10:54:03.269 [debug] 53279#34365452480 free(800E91AC0)
2021/11/19 10:54:03.259 [debug] 53277#34365452480 malloc(168): 8006111F0
2021/11/19 10:54:03.269 [debug] 53279#34365452480 exiting
2021/11/19 10:54:03.259 [debug] 53277#34365452480 malloc(136): 800670E40
2021/11/19 10:54:03.259 [debug] 53277#34365452480 posix_memalign(128, 1024): 800685C00
2021/11/19 10:54:03.269 [debug] 53279#34365452480 close idle connections
2021/11/19 10:54:03.269 [debug] 53279#34365452480 work queue: fast
2021/11/19 10:54:03.269 [debug] 53279#34365452480 thread pools: 0
2021/11/19 10:54:03.269 [debug] 53279#34365452480 pthread_mutex_lock(800654270) enter
2021/11/19 10:54:03.259 [debug] 53277#34365452480 malloc(168): 800611140
2021/11/19 10:54:03.259 [debug] 53277#34365452480 malloc(136): 800670DB0
2021/11/19 10:54:03.259 [debug] 53277#34365452480 posix_memalign(128, 1024): 800685800
2021/11/19 10:54:03.269 [debug] 53279#34365452480 process 53277 removed
2021/11/19 10:54:03.269 [debug] 53279#34365452480 pthread_mutex_unlock(800654270) exit
2021/11/19 10:54:03.259 [debug] 53277#34365452480 free(800670DB0)
2021/11/19 10:54:03.259 [debug] 53277#34365452480 free(800685800)
2021/11/19 10:54:03.269 [debug] 53279#34365452480 port 800572DC0 53277:0 close, type 0
2021/11/19 10:54:03.269 [debug] 53279#34365452480 close(7)
2021/11/19 10:54:03.259 [debug] 53277#34365452480 free(800611140)
2021/11/19 10:54:03.259 [debug] 53277#34365452480 malloc(168): 800611140
2021/11/19 10:54:03.269 [debug] 53279#34365452480 port 800572DC0 53277:0 release, type 0
2021/11/19 10:54:03.259 [debug] 53277#34365452480 malloc(136): 800670DB0
2021/11/19 10:54:03.259 [debug] 53277#34365452480 posix_memalign(128, 1024): 800685800
2021/11/19 10:54:03.269 [debug] 53279#34365452480 free(0)
2021/11/19 10:54:03.259 [debug] 53277#34365452480 free(800670DB0)
2021/11/19 10:54:03.269 [debug] 53279#34365452480 pthread_mutex_destroy(800687F28)
2021/11/19 10:54:03.269 [debug] 53279#34365452480 mp 800611560 release: 0
2021/11/19 10:54:03.269 [debug] 53279#34365452480 pthread_mutex_destroy(800572E78)
2021/11/19 10:54:03.269 [debug] 53279#34365452480 free(800572DC0)
2021/11/19 10:54:03.259 [debug] 53277#34365452480 free(800685800)
2021/11/19 10:54:03.259 [debug] 53277#34365452480 free(800611140)
2021/11/19 10:54:03.269 [debug] 53279#34365452480 free(8006711A0)
2021/11/19 10:54:03.269 [debug] 53279#34365452480 free(800687400)
2021/11/19 10:54:03.259 [debug] 53277#34365452480 free(800670E40)
2021/11/19 10:54:03.259 [debug] 53277#34365452480 free(800685C00)
2021/11/19 10:54:03.269 [debug] 53279#34365452480 free(800611560)
2021/11/19 10:54:03.269 [debug] 53279#34365452480 pthread_mutex_lock(800654270) enter
2021/11/19 10:54:03.269 [debug] 53279#34365452480 free(800EB0B00)
2021/11/19 10:54:03.269 [debug] 53279#34365452480 process 53279 removed
2021/11/19 10:54:03.259 [debug] 53277#34365452480 free(8006111F0)
2021/11/19 10:54:03.259 [debug] 53277#34365452480 free(800670ED0)
2021/11/19 10:54:03.259 [debug] 53277#34365452480 free(800686000)
2021/11/19 10:54:03.269 [debug] 53279#34365452480 pthread_mutex_unlock(800654270) exit
2021/11/19 10:54:03.269 [debug] 53279#34365452480 port 800572C40 53279:0 close, type 1
2021/11/19 10:54:03.259 [debug] 53277#34365452480 free(8006112A0)
2021/11/19 10:54:03.259 [debug] 53277#34365452480 free(800670F60)
2021/11/19 10:54:03.259 [debug] 53277#34365452480 free(800686400)
2021/11/19 10:54:03.269 [debug] 53279#34365452480 close(8)
2021/11/19 10:54:03.259 [debug] 53277#34365452480 free(800611350)
2021/11/19 10:54:03.269 [debug] 53279#34365452480 free(800EB0A80)
2021/11/19 10:54:03.269 [debug] 53279#34365452480 port 800572C40 53279:0 release, type 1
2021/11/19 10:54:03.269 [debug] 53279#34365452480 free(0)
2021/11/19 10:54:03.259 [debug] 53277#34365452480 lang 1 3.6.12 "/usr/local/nginxunittest/modules/py36.unit.so" (2 mounts)
2021/11/19 10:54:03.269 [debug] 53279#34365452480 pthread_mutex_destroy(800687028)
2021/11/19 10:54:03.269 [debug] 53279#34365452480 free(800671110)
2021/11/19 10:54:03.269 [debug] 53279#34365452480 free(800687000)
2021/11/19 10:54:03.269 [debug] 53279#34365452480 mp 8006114B0 release: 0
2021/11/19 10:54:03.259 [debug] 53277#34365452480 free(800670FF0)
2021/11/19 10:54:03.259 [debug] 53277#34365452480 free(800686800)
2021/11/19 10:54:03.269 [debug] 53279#34365452480 pthread_mutex_destroy(800572CF8)
2021/11/19 10:54:03.269 [debug] 53279#34365452480 free(800572C40)
2021/11/19 10:54:03.269 [debug] 53279#34365452480 free(800630000)
2021/11/19 10:54:03.259 [debug] 53277#34365452480 free(800611400)
2021/11/19 10:54:03.259 [debug] 53277#34365452480 malloc(136): 800670FF0
2021/11/19 10:54:03.259 [debug] 53277#34365452480 posix_memalign(128, 1024): 800686800
2021/11/19 10:54:03.269 [debug] 53279#34365452480 free(800671080)
2021/11/19 10:54:03.269 [debug] 53279#34365452480 free(800686C00)
2021/11/19 10:54:03.269 [debug] 53279#34365452480 free(8006114B0)
2021/11/19 10:54:03.269 [debug] 53279#34365452480 pthread_mutex_destroy(800654270)
2021/11/19 10:54:03.269 [debug] 53279#34365452480 free(800654200)
2021/11/19 10:54:03.269 [debug] 53279#34365452480 free(8006668C0)
2021/11/19 10:54:03.259 [debug] 53277#34365452480 pthread_mutex_init(800686828)
2021/11/19 10:54:03.259 [debug] 53277#34365452480 malloc(168): 800611400
2021/11/19 10:54:03.269 [debug] 53279#34365452480 free(800671230)
2021/11/19 10:54:03.269 [debug] 53279#34365452480 free(800687C00)
2021/11/19 10:54:03.269 [debug] 53279#34365452480 free(8006712C0)
2021/11/19 10:54:03.269 [debug] 53279#34365452480 free(800688400)
2021/11/19 10:54:03.269 [debug] 53279#34365452480 free(8006116C0)
2021/11/19 10:54:03.269 [debug] 53279#34365452480 exit: 0
2021/11/19 10:54:03.259 [debug] 53277#34365452480 posix_memalign(16, 368): 800572AC0
2021/11/19 10:54:03.259 [debug] 53277#34365452480 malloc(136): 800670F60
2021/11/19 10:54:03.259 [debug] 53277#34365452480 posix_memalign(128, 1024): 800686400
2021/11/19 10:54:03.259 [debug] 53277#34365452480 pthread_mutex_init(800572B78)
2021/11/19 10:54:03.259 [debug] 53277#34365452480 port 800572AC0 0:0 new, type 2
2021/11/19 10:54:03.259 [debug] 53277#34365452480 socketpair(): 8:10
2021/11/19 10:54:03.259 [debug] 53277#34365452480 getsockopt(10, 65535, SO_SNDBUF): 65536
2021/11/19 10:54:03.259 [debug] 53277#34365452480 getsockopt(8, 65535, SO_RCVBUF): 65536
2021/11/19 10:54:03.259 [debug] 53277#34365452480 malloc(168): 800611350
2021/11/19 10:54:03.259 [info] 53277#34365452480 controller started
2021/11/19 10:54:03.259 [debug] 53277#34365452480 open("/usr/local/nginxunittest/state/conf.json", 0x4, 0x0): 11 err:0
2021/11/19 10:54:03.259 [debug] 53277#34365452480 fstat(11): 0
2021/11/19 10:54:03.259 [debug] 53277#34365452480 malloc(136): 800670ED0
2021/11/19 10:54:03.259 [debug] 53277#34365452480 posix_memalign(128, 1024): 800686000
2021/11/19 10:54:03.259 [debug] 53277#34365452480 pread(11, 800686000, 163, 0): 163
2021/11/19 10:54:03.259 [debug] 53277#34365452480 close(11)
2021/11/19 10:54:03.259 [debug] 53277#34365452480 open("/usr/local/nginxunittest/state/version", 0x4, 0x0): -1 err:2
2021/11/19 10:54:03.259 [debug] 53277#34365452480 fork(controller): 53280
2021/11/19 10:54:03.259 [debug] 53277#34365452480 pthread_mutex_lock(800654270) enter
2021/11/19 10:54:03.259 [debug] 53277#34365452480 process 53280 added
2021/11/19 10:54:03.259 [debug] 53277#34365452480 pthread_mutex_unlock(800654270) exit
2021/11/19 10:54:03.259 [debug] 53277#34365452480 socket close(8)
2021/11/19 10:54:03.259 [debug] 53277#34365452480 free(800670ED0)
2021/11/19 10:54:03.259 [debug] 53277#34365452480 free(800686000)
2021/11/19 10:54:03.259 [debug] 53277#34365452480 free(800611350)
2021/11/19 10:54:03.259 [debug] 53277#34365452480 pthread_mutex_init(800686928)
2021/11/19 10:54:03.259 [debug] 53277#34365452480 malloc(168): 800611350
2021/11/19 10:54:03.259 [debug] 53277#34365452480 posix_memalign(16, 368): 800572940
2021/11/19 10:54:03.259 [debug] 53277#34365452480 malloc(136): 800670ED0
2021/11/19 10:54:03.259 [debug] 53277#34365452480 posix_memalign(128, 1024): 800686000
2021/11/19 10:54:03.259 [debug] 53277#34365452480 pthread_mutex_init(8005729F8)
2021/11/19 10:54:03.259 [debug] 53277#34365452480 port 800572940 0:0 new, type 3
2021/11/19 10:54:03.259 [debug] 53277#34365452480 socketpair(): 8:11
2021/11/19 10:54:03.259 [debug] 53277#34365452480 getsockopt(11, 65535, SO_SNDBUF): 65536
2021/11/19 10:54:03.259 [debug] 53277#34365452480 getsockopt(8, 65535, SO_RCVBUF): 65536
2021/11/19 10:54:03.259 [debug] 53277#34365452480 malloc(168): 8006112A0
2021/11/19 10:54:03.259 [debug] 53280#34365452480 remove not required process 53279
2021/11/19 10:54:03.259 [debug] 53280#34365452480 port 800572C40 53279:0 close, type 1
2021/11/19 10:54:03.259 [debug] 53280#34365452480 close(9)
2021/11/19 10:54:03.259 [debug] 53280#34365452480 port 800572C40 53279:0 release, type 1
2021/11/19 10:54:03.259 [debug] 53280#34365452480 pthread_mutex_lock(800654270) enter
2021/11/19 10:54:03.259 [debug] 53280#34365452480 process 53279 removed
2021/11/19 10:54:03.259 [debug] 53280#34365452480 pthread_mutex_unlock(800654270) exit
2021/11/19 10:54:03.259 [debug] 53280#34365452480 free(0)
2021/11/19 10:54:03.259 [debug] 53277#34365452480 fork(router): 53281
2021/11/19 10:54:03.259 [debug] 53277#34365452480 pthread_mutex_lock(800654270) enter
2021/11/19 10:54:03.259 [debug] 53280#34365452480 pthread_mutex_destroy(800687028)
2021/11/19 10:54:03.259 [debug] 53277#34365452480 process 53281 added
2021/11/19 10:54:03.259 [debug] 53277#34365452480 pthread_mutex_unlock(800654270) exit
2021/11/19 10:54:03.259 [debug] 53277#34365452480 socket close(8)
2021/11/19 10:54:03.259 [debug] 53280#34365452480 mp 8006114B0 release: 0
2021/11/19 10:54:03.259 [debug] 53280#34365452480 pthread_mutex_destroy(800572CF8)
2021/11/19 10:54:03.259 [debug] 53277#34365452480 free(8006112A0)
2021/11/19 10:54:03.259 [debug] 53280#34365452480 free(800572C40)
2021/11/19 10:54:03.259 [debug] 53280#34365452480 free(800671080)
2021/11/19 10:54:03.259 [debug] 53277#34365452480 recvmsg(6, 2, 104): -1
2021/11/19 10:54:03.259 [debug] 53277#34365452480 recvmsg(6) not ready
2021/11/19 10:54:03.259 [debug] 53277#34365452480 kevent(3) changes:0 timeout:-1
2021/11/19 10:54:03.259 [debug] 53280#34365452480 free(800686C00)
2021/11/19 10:54:03.259 [debug] 53277#34365452480 kevent(3): 1
2021/11/19 10:54:03.259 [debug] 53277#34365452480 kevent: id:20 ft:-6 fl:0021 ff:0 d:1 ud:467A40
2021/11/19 10:54:03.259 [debug] 53280#34365452480 free(8006114B0)
2021/11/19 10:54:03.259 [debug] 53277#34365452480 timer expire minimum: 719594695:633194695
2021/11/19 10:54:03.259 [debug] 53277#34365452480 work queue: fast
2021/11/19 10:54:03.259 [debug] 53277#34365452480 sigchld handler signo:20 (SIGCHLD)
2021/11/19 10:54:03.259 [debug] 53280#34365452480 controller setup
2021/11/19 10:54:03.259 [debug] 53281#34365452480 remove not required process 53279
2021/11/19 10:54:03.259 [debug] 53281#34365452480 port 800572C40 53279:0 close, type 1
2021/11/19 10:54:03.259 [debug] 53281#34365452480 close(9)
2021/11/19 10:54:03.259 [debug] 53277#34365452480 waitpid(): 53279
2021/11/19 10:54:03.259 [notice] 53277#34365452480 process 53279 exited with code 0
2021/11/19 10:54:03.259 [debug] 53277#34365452480 pthread_mutex_lock(800654270) enter
2021/11/19 10:54:03.259 [debug] 53277#34365452480 pthread_mutex_unlock(800654270) exit
2021/11/19 10:54:03.259 [debug] 53281#34365452480 port 800572C40 53279:0 release, type 1
2021/11/19 10:54:03.259 [debug] 53281#34365452480 pthread_mutex_lock(800654270) enter
2021/11/19 10:54:03.259 [debug] 53277#34365452480 port 800572C40 53279:0 close, type 1
2021/11/19 10:54:03.259 [debug] 53277#34365452480 close(9)
2021/11/19 10:54:03.259 [debug] 53281#34365452480 process 53279 removed
2021/11/19 10:54:03.259 [debug] 53277#34365452480 port 800572C40 53279:0 release, type 1
2021/11/19 10:54:03.259 [debug] 53281#34365452480 pthread_mutex_unlock(800654270) exit
2021/11/19 10:54:03.259 [debug] 53281#34365452480 free(0)
2021/11/19 10:54:03.259 [debug] 53277#34365452480 pthread_mutex_lock(800654270) enter
2021/11/19 10:54:03.259 [debug] 53277#34365452480 process 53279 removed
2021/11/19 10:54:03.259 [debug] 53277#34365452480 pthread_mutex_unlock(800654270) exit
2021/11/19 10:54:03.259 [debug] 53277#34365452480 free(0)
2021/11/19 10:54:03.259 [debug] 53280#34365452480 kqueue 3 free
2021/11/19 10:54:03.259 [debug] 53277#34365452480 pthread_mutex_destroy(800687028)
2021/11/19 10:54:03.259 [debug] 53280#34365452480 free(800688000)
2021/11/19 10:54:03.259 [debug] 53277#34365452480 mp 8006114B0 release: 0
2021/11/19 10:54:03.259 [debug] 53280#34365452480 free(80069F000)
2021/11/19 10:54:03.259 [debug] 53277#34365452480 pthread_mutex_destroy(800572CF8)
2021/11/19 10:54:03.259 [debug] 53277#34365452480 free(800572C40)
2021/11/19 10:54:03.259 [debug] 53281#34365452480 pthread_mutex_destroy(800687028)
2021/11/19 10:54:03.259 [debug] 53277#34365452480 free(800671080)
2021/11/19 10:54:03.259 [debug] 53280#34365452480 malloc(4096): 80069F000
2021/11/19 10:54:03.259 [debug] 53280#34365452480 malloc(1024): 800688000
2021/11/19 10:54:03.259 [debug] 53277#34365452480 free(800686C00)
2021/11/19 10:54:03.259 [debug] 53280#34365452480 kqueue(): 3
2021/11/19 10:54:03.259 [debug] 53281#34365452480 mp 8006114B0 release: 0
2021/11/19 10:54:03.259 [debug] 53277#34365452480 free(8006114B0)
2021/11/19 10:54:03.259 [debug] 53281#34365452480 pthread_mutex_destroy(800572CF8)
2021/11/19 10:54:03.259 [debug] 53280#34365452480 kevent(3) signo:1 (SIGHUP)
2021/11/19 10:54:03.259 [debug] 53281#34365452480 free(800572C40)
2021/11/19 10:54:03.259 [debug] 53277#34365452480 waitpid(): 0
2021/11/19 10:54:03.259 [debug] 53281#34365452480 free(800671080)
2021/11/19 10:54:03.259 [debug] 53280#34365452480 kevent(3) signo:2 (SIGINT)
2021/11/19 10:54:03.259 [debug] 53277#34365452480 kevent(3) changes:0 timeout:-1
2021/11/19 10:54:03.259 [debug] 53281#34365452480 free(800686C00)
2021/11/19 10:54:03.259 [debug] 53280#34365452480 kevent(3) signo:3 (SIGQUIT)
2021/11/19 10:54:03.259 [debug] 53280#34365452480 kevent(3) signo:15 (SIGTERM)
2021/11/19 10:54:03.259 [debug] 53281#34365452480 free(8006114B0)
2021/11/19 10:54:03.259 [debug] 53280#34365452480 kevent(3) signo:20 (SIGCHLD)
2021/11/19 10:54:03.259 [debug] 53280#34365452480 kevent(3) signo:30 (SIGUSR1)
2021/11/19 10:54:03.259 [debug] 53281#34365452480 remove not ready process 53280
2021/11/19 10:54:03.259 [debug] 53281#34365452480 port 800572AC0 53280:0 close, type 2
2021/11/19 10:54:03.259 [debug] 53281#34365452480 close(10)
2021/11/19 10:54:03.259 [debug] 53280#34365452480 kevent(3) signo:31 (SIGUSR2)
2021/11/19 10:54:03.259 [debug] 53281#34365452480 port 800572AC0 53280:0 release, type 2
2021/11/19 10:54:03.259 [debug] 53281#34365452480 pthread_mutex_lock(800654270) enter
2021/11/19 10:54:03.259 [debug] 53281#34365452480 process 53280 removed
2021/11/19 10:54:03.259 [debug] 53281#34365452480 pthread_mutex_unlock(800654270) exit
2021/11/19 10:54:03.259 [debug] 53281#34365452480 free(0)
2021/11/19 10:54:03.259 [debug] 53281#34365452480 pthread_mutex_destroy(800686828)
2021/11/19 10:54:03.259 [debug] 53281#34365452480 mp 800611400 release: 0
2021/11/19 10:54:03.259 [debug] 53281#34365452480 pthread_mutex_destroy(800572B78)
2021/11/19 10:54:03.259 [debug] 53281#34365452480 free(800572AC0)
2021/11/19 10:54:03.259 [debug] 53280#34365452480 malloc(208): 800E91AC0
2021/11/19 10:54:03.259 [debug] 53281#34365452480 free(800670F60)
2021/11/19 10:54:03.259 [debug] 53281#34365452480 free(800686400)
2021/11/19 10:54:03.259 [debug] 53280#34365452480 socket close(6)
2021/11/19 10:54:03.259 [debug] 53280#34365452480 pthread_mutex_lock(800654270) enter
2021/11/19 10:54:03.259 [debug] 53281#34365452480 free(800611400)
2021/11/19 10:54:03.259 [debug] 53281#34365452480 router setup
2021/11/19 10:54:03.259 [debug] 53280#34365452480 process 53280 added
2021/11/19 10:54:03.259 [debug] 53280#34365452480 pthread_mutex_unlock(800654270) exit
2021/11/19 10:54:03.259 [debug] 53280#34365452480 kevent(3) set event: id:8 ft:-1 fl:0025
2021/11/19 10:54:03.259 [debug] 53280#34365452480 user cred set gids: base gid:65534, ngroups: 1
2021/11/19 10:54:03.259 [debug] 53280#34365452480 user cred set: "nobody" uid:65534
2021/11/19 10:54:03.259 [debug] 53280#34365452480 pthread_mutex_lock(800572E78) enter
2021/11/19 10:54:03.259 [debug] 53280#34365452480 pthread_mutex_unlock(800572E78) exit
2021/11/19 10:54:03.259 [debug] 53281#34365452480 kqueue 3 free
2021/11/19 10:54:03.259 [debug] 53281#34365452480 free(800688000)
2021/11/19 10:54:03.259 [debug] 53280#34365452480 sendmsg(7, -1, -1, 1): 16
2021/11/19 10:54:03.259 [debug] 53277#34365452480 kevent(3): 1
2021/11/19 10:54:03.259 [debug] 53281#34365452480 free(80069F000)
2021/11/19 10:54:03.259 [debug] 53277#34365452480 kevent: id:6 ft:-1 fl:0025 ff:0 d:120 ud:800572DC0
2021/11/19 10:54:03.259 [debug] 53280#34365452480 controller sent ready
2021/11/19 10:54:03.259 [debug] 53277#34365452480 timer expire minimum: 719594695:633194695
2021/11/19 10:54:03.259 [debug] 53277#34365452480 work queue: fast
2021/11/19 10:54:03.259 [debug] 53281#34365452480 malloc(4096): 80069F000
2021/11/19 10:54:03.259 [debug] 53281#34365452480 malloc(1024): 800688000
2021/11/19 10:54:03.259 [debug] 53277#34365452480 recvmsg(6, 2, 104): 16
2021/11/19 10:54:03.259 [debug] 53280#34365452480 posix_memalign(64, 64): 8005F0800
2021/11/19 10:54:03.259 [debug] 53277#34365452480 port 6: message type:16
2021/11/19 10:54:03.259 [debug] 53277#34365452480 pthread_mutex_lock(800654270) enter
2021/11/19 10:54:03.259 [debug] 53281#34365452480 kqueue(): 3
2021/11/19 10:54:03.259 [debug] 53277#34365452480 pthread_mutex_unlock(800654270) exit
2021/11/19 10:54:03.259 [debug] 53281#34365452480 kevent(3) signo:1 (SIGHUP)
2021/11/19 10:54:03.259 [debug] 53280#34365452480 malloc(168): 8006114B0
2021/11/19 10:54:03.259 [debug] 53277#34365452480 process 53280 ready
2021/11/19 10:54:03.259 [debug] 53281#34365452480 kevent(3) signo:2 (SIGINT)
2021/11/19 10:54:03.259 [debug] 53280#34365452480 malloc(136): 800671080
2021/11/19 10:54:03.259 [debug] 53280#34365452480 posix_memalign(128, 1024): 800686C00
2021/11/19 10:54:03.259 [debug] 53281#34365452480 kevent(3) signo:3 (SIGQUIT)
2021/11/19 10:54:03.259 [debug] 53277#34365452480 new port 10 for process 53280
2021/11/19 10:54:03.259 [debug] 53280#34365452480 malloc(168): 8006112A0
2021/11/19 10:54:03.259 [debug] 53280#34365452480 malloc(136): 800670E40
2021/11/19 10:54:03.259 [debug] 53277#34365452480 malloc(136): 800671080
2021/11/19 10:54:03.259 [debug] 53280#34365452480 posix_memalign(128, 1024): 800685C00
2021/11/19 10:54:03.259 [debug] 53281#34365452480 kevent(3) signo:15 (SIGTERM)
2021/11/19 10:54:03.259 [debug] 53277#34365452480 posix_memalign(128, 1024): 800686C00
2021/11/19 10:54:03.259 [debug] 53280#34365452480 malloc(168): 8006111F0
2021/11/19 10:54:03.259 [debug] 53277#34365452480 mp 800611610 retain: 2
2021/11/19 10:54:03.259 [debug] 53280#34365452480 malloc(136): 800670DB0
2021/11/19 10:54:03.259 [debug] 53281#34365452480 kevent(3) signo:20 (SIGCHLD)
2021/11/19 10:54:03.259 [debug] 53280#34365452480 posix_memalign(128, 1024): 800685800
2021/11/19 10:54:03.259 [debug] 53277#34365452480 send port 10 to process 53281
2021/11/19 10:54:03.259 [debug] 53280#34365452480 malloc(168): 800611140
2021/11/19 10:54:03.259 [debug] 53281#34365452480 kevent(3) signo:30 (SIGUSR1)
2021/11/19 10:54:03.259 [debug] 53280#34365452480 malloc(136): 800670D20
2021/11/19 10:54:03.259 [debug] 53277#34365452480 pthread_mutex_lock(8005729F8) enter
2021/11/19 10:54:03.259 [debug] 53281#34365452480 kevent(3) signo:31 (SIGUSR2)
2021/11/19 10:54:03.259 [debug] 53280#34365452480 posix_memalign(128, 1024): 800685400
2021/11/19 10:54:03.259 [debug] 53280#34365452480 free(800670D20)
2021/11/19 10:54:03.259 [debug] 53280#34365452480 free(800685400)
2021/11/19 10:54:03.259 [debug] 53277#34365452480 pthread_mutex_unlock(8005729F8) exit
2021/11/19 10:54:03.259 [debug] 53280#34365452480 free(800611140)
2021/11/19 10:54:03.259 [debug] 53281#34365452480 malloc(208): 800E91AC0
2021/11/19 10:54:03.259 [debug] 53280#34365452480 free(800670DB0)
2021/11/19 10:54:03.259 [debug] 53281#34365452480 socket close(6)
2021/11/19 10:54:03.259 [debug] 53280#34365452480 free(800685800)
2021/11/19 10:54:03.259 [debug] 53277#34365452480 using plain mode
2021/11/19 10:54:03.259 [debug] 53281#34365452480 pthread_mutex_lock(800654270) enter
2021/11/19 10:54:03.259 [debug] 53281#34365452480 process 53281 added
2021/11/19 10:54:03.259 [debug] 53277#34365452480 sendbuf: 0, 800686C78, 32
2021/11/19 10:54:03.259 [debug] 53280#34365452480 free(8006111F0)
2021/11/19 10:54:03.259 [debug] 53281#34365452480 pthread_mutex_unlock(800654270) exit
2021/11/19 10:54:03.259 [debug] 53277#34365452480 sendmsg(11, 10, -1, 2): 48
2021/11/19 10:54:03.259 [debug] 53277#34365452480 recvmsg(6, 2, 104): -1
2021/11/19 10:54:03.259 [debug] 53280#34365452480 malloc(168): 8006111F0
2021/11/19 10:54:03.259 [debug] 53277#34365452480 recvmsg(6) not ready
2021/11/19 10:54:03.259 [debug] 53280#34365452480 malloc(136): 800670DB0
2021/11/19 10:54:03.259 [debug] 53277#34365452480 work queue: fast
2021/11/19 10:54:03.259 [debug] 53277#34365452480 buf ts completion: 800686C00 800686C78
2021/11/19 10:54:03.259 [debug] 53280#34365452480 posix_memalign(128, 1024): 800685800
2021/11/19 10:54:03.259 [debug] 53277#34365452480 free(800671080)
2021/11/19 10:54:03.259 [debug] 53281#34365452480 kevent(3) set event: id:8 ft:-1 fl:0025
2021/11/19 10:54:03.259 [debug] 53277#34365452480 free(800686C00)
2021/11/19 10:54:03.259 [debug] 53281#34365452480 user cred set gids: base gid:65534, ngroups: 1
2021/11/19 10:54:03.259 [debug] 53277#34365452480 mp 800611610 release: 1
2021/11/19 10:54:03.259 [debug] 53277#34365452480 kevent(3) changes:0 timeout:-1
2021/11/19 10:54:03.259 [debug] 53280#34365452480 malloc(168): 800611140
2021/11/19 10:54:03.259 [debug] 53280#34365452480 malloc(136): 800670D20
2021/11/19 10:54:03.259 [debug] 53280#34365452480 posix_memalign(128, 1024): 800685400
2021/11/19 10:54:03.259 [debug] 53280#34365452480 free(800670D20)
2021/11/19 10:54:03.259 [debug] 53280#34365452480 free(800685400)
2021/11/19 10:54:03.259 [debug] 53280#34365452480 free(800611140)
2021/11/19 10:54:03.259 [debug] 53280#34365452480 free(800670DB0)
2021/11/19 10:54:03.259 [debug] 53280#34365452480 free(800685800)
2021/11/19 10:54:03.259 [debug] 53281#34365452480 user cred set: "nobody" uid:65534
2021/11/19 10:54:03.259 [debug] 53280#34365452480 free(8006111F0)
2021/11/19 10:54:03.259 [debug] 53281#34365452480 pthread_mutex_lock(800572E78) enter
2021/11/19 10:54:03.259 [debug] 53281#34365452480 pthread_mutex_unlock(800572E78) exit
2021/11/19 10:54:03.259 [debug] 53280#34365452480 free(800670E40)
2021/11/19 10:54:03.259 [debug] 53280#34365452480 free(800685C00)
2021/11/19 10:54:03.259 [debug] 53280#34365452480 free(8006112A0)
2021/11/19 10:54:03.259 [debug] 53280#34365452480 malloc(168): 8006112A0
2021/11/19 10:54:03.259 [debug] 53277#34365452480 kevent(3): 1
2021/11/19 10:54:03.259 [debug] 53277#34365452480 kevent: id:6 ft:-1 fl:0025 ff:0 d:120 ud:800572DC0
2021/11/19 10:54:03.259 [debug] 53281#34365452480 sendmsg(7, -1, -1, 1): 16
2021/11/19 10:54:03.259 [debug] 53280#34365452480 malloc(136): 800670E40
2021/11/19 10:54:03.259 [debug] 53277#34365452480 timer expire minimum: 719594695:633194695
2021/11/19 10:54:03.259 [debug] 53280#34365452480 posix_memalign(128, 1024): 800685C00
2021/11/19 10:54:03.259 [debug] 53281#34365452480 router sent ready
2021/11/19 10:54:03.259 [info] 53281#34365452480 router started
2021/11/19 10:54:03.259 [debug] 53277#34365452480 work queue: fast
2021/11/19 10:54:03.259 [debug] 53277#34365452480 recvmsg(6, 2, 104): 16
2021/11/19 10:54:03.259 [debug] 53277#34365452480 port 6: message type:16
2021/11/19 10:54:03.259 [debug] 53277#34365452480 pthread_mutex_lock(800654270) enter
2021/11/19 10:54:03.259 [debug] 53277#34365452480 pthread_mutex_unlock(800654270) exit
2021/11/19 10:54:03.259 [debug] 53277#34365452480 process 53281 ready
2021/11/19 10:54:03.259 [debug] 53280#34365452480 free(800670E40)
2021/11/19 10:54:03.259 [debug] 53277#34365452480 new port 11 for process 53281
2021/11/19 10:54:03.259 [debug] 53281#34365452480 posix_memalign(64, 64): 8005F0800
2021/11/19 10:54:03.259 [debug] 53277#34365452480 malloc(136): 800671080
2021/11/19 10:54:03.259 [debug] 53277#34365452480 posix_memalign(128, 1024): 800686C00
2021/11/19 10:54:03.259 [debug] 53280#34365452480 free(800685C00)
2021/11/19 10:54:03.259 [debug] 53280#34365452480 free(8006112A0)
2021/11/19 10:54:03.259 [debug] 53277#34365452480 mp 800611610 retain: 2
2021/11/19 10:54:03.259 [debug] 53277#34365452480 send port 11 to process 53280
2021/11/19 10:54:03.259 [debug] 53280#34365452480 socket close(10)
2021/11/19 10:54:03.259 [debug] 53281#34365452480 posix_memalign(256, 256): 800F22100
2021/11/19 10:54:03.259 [debug] 53280#34365452480 free(800670ED0)
2021/11/19 10:54:03.259 [debug] 53280#34365452480 free(800686000)
2021/11/19 10:54:03.259 [debug] 53281#34365452480 posix_memalign(64, 64): 8005F07C0
2021/11/19 10:54:03.259 [debug] 53277#34365452480 pthread_mutex_lock(800572B78) enter
2021/11/19 10:54:03.259 [debug] 53280#34365452480 free(800611350)
2021/11/19 10:54:03.259 [debug] 53277#34365452480 pthread_mutex_unlock(800572B78) exit
2021/11/19 10:54:03.259 [debug] 53277#34365452480 using plain mode
2021/11/19 10:54:03.259 [debug] 53281#34365452480 posix_memalign(64, 64): 8005F0780
2021/11/19 10:54:03.259 [debug] 53280#34365452480 kevent(3) changes:1 timeout:-1
2021/11/19 10:54:03.259 [debug] 53277#34365452480 sendbuf: 0, 800686C78, 32
2021/11/19 10:54:03.259 [debug] 53281#34365452480 posix_memalign(64, 64): 8005F0740
2021/11/19 10:54:03.259 [debug] 53280#34365452480 kevent(3): 1
2021/11/19 10:54:03.259 [debug] 53277#34365452480 sendmsg(10, 11, -1, 2): 48
2021/11/19 10:54:03.259 [debug] 53280#34365452480 kevent: id:8 ft:-1 fl:0025 ff:0 d:176 ud:800572AC0
2021/11/19 10:54:03.259 [debug] 53277#34365452480 recvmsg(6, 2, 104): -1
2021/11/19 10:54:03.259 [debug] 53281#34365452480 posix_memalign(64, 64): 8005F0700
2021/11/19 10:54:03.259 [debug] 53280#34365452480 timer expire minimum: 719594695:633194695
2021/11/19 10:54:03.259 [debug] 53277#34365452480 recvmsg(6) not ready
2021/11/19 10:54:03.259 [debug] 53280#34365452480 work queue: fast
2021/11/19 10:54:03.259 [debug] 53277#34365452480 work queue: fast
2021/11/19 10:54:03.259 [debug] 53277#34365452480 buf ts completion: 800686C00 800686C78
2021/11/19 10:54:03.259 [debug] 53277#34365452480 free(800671080)
2021/11/19 10:54:03.259 [debug] 53277#34365452480 free(800686C00)
2021/11/19 10:54:03.259 [debug] 53277#34365452480 mp 800611610 release: 1
2021/11/19 10:54:03.259 [debug] 53280#34365452480 posix_memalign(16, 16496): 800640000
2021/11/19 10:54:03.259 [debug] 53277#34365452480 kevent(3) changes:0 timeout:-1
2021/11/19 10:54:03.259 [debug] 53281#34365452480 free(8005F0800)
2021/11/19 10:54:03.259 [debug] 53280#34365452480 recvmsg(8, 2, 128): 48
2021/11/19 10:54:03.259 [debug] 53280#34365452480 port 8: message type:10
2021/11/19 10:54:03.259 [debug] 53280#34365452480 new port 11 received for process 53281:0
2021/11/19 10:54:03.259 [debug] 53281#34365452480 posix_memalign(64, 64): 8005F0800
2021/11/19 10:54:03.259 [debug] 53281#34365452480 posix_memalign(64, 64): 8005F06C0
2021/11/19 10:54:03.259 [debug] 53280#34365452480 process port (53281, 0) not found
2021/11/19 10:54:03.259 [debug] 53280#34365452480 pthread_mutex_lock(800654270) enter
2021/11/19 10:54:03.259 [debug] 53281#34365452480 posix_memalign(64, 64): 8005F0680
2021/11/19 10:54:03.259 [debug] 53281#34365452480 posix_memalign(64, 64): 8005F0640
2021/11/19 10:54:03.259 [debug] 53281#34365452480 posix_memalign(64, 64): 8005F0600
2021/11/19 10:54:03.259 [debug] 53281#34365452480 posix_memalign(64, 64): 8005F05C0
2021/11/19 10:54:03.259 [debug] 53281#34365452480 posix_memalign(64, 64): 8005F0580
2021/11/19 10:54:03.259 [debug] 53280#34365452480 pthread_mutex_init(800687028)
2021/11/19 10:54:03.259 [debug] 53280#34365452480 process 53281 insert
2021/11/19 10:54:03.259 [debug] 53281#34365452480 posix_memalign(256, 256): 800F22000
2021/11/19 10:54:03.259 [debug] 53281#34365452480 posix_memalign(64, 64): 8005F0540
2021/11/19 10:54:03.259 [debug] 53280#34365452480 pthread_mutex_unlock(800654270) exit
2021/11/19 10:54:03.259 [debug] 53280#34365452480 malloc(168): 800611350
2021/11/19 10:54:03.259 [debug] 53280#34365452480 posix_memalign(16, 368): 800572C40
2021/11/19 10:54:03.259 [debug] 53281#34365452480 posix_memalign(64, 64): 8005F0500
2021/11/19 10:54:03.259 [debug] 53281#34365452480 posix_memalign(64, 64): 8005F04C0
2021/11/19 10:54:03.259 [debug] 53280#34365452480 malloc(136): 800670ED0
2021/11/19 10:54:03.259 [debug] 53280#34365452480 posix_memalign(128, 1024): 800686000
2021/11/19 10:54:03.259 [debug] 53281#34365452480 posix_memalign(64, 64): 8005F0480
2021/11/19 10:54:03.259 [debug] 53280#34365452480 pthread_mutex_init(800572CF8)
2021/11/19 10:54:03.259 [debug] 53281#34365452480 free(8005F0580)
2021/11/19 10:54:03.259 [debug] 53280#34365452480 port 800572C40 53281:0 new, type 3
2021/11/19 10:54:03.259 [debug] 53281#34365452480 posix_memalign(64, 64): 8005F0580
2021/11/19 10:54:03.259 [debug] 53281#34365452480 posix_memalign(64, 64): 8005F0440
2021/11/19 10:54:03.259 [debug] 53281#34365452480 posix_memalign(256, 256): 800F21F00
2021/11/19 10:54:03.259 [alert] 53280#34365452480 ioctl(11, FIONBIO) failed (9: Bad file descriptor)
2021/11/19 10:54:03.259 [debug] 53281#34365452480 posix_memalign(64, 64): 8005F0400
2021/11/19 10:54:03.259 [debug] 53281#34365452480 posix_memalign(64, 64): 8005F03C0
2021/11/19 10:54:03.259 [debug] 53281#34365452480 posix_memalign(64, 64): 8005F0380
2021/11/19 10:54:03.259 [debug] 53281#34365452480 posix_memalign(64, 64): 8005F0340
2021/11/19 10:54:03.259 [debug] 53280#34365452480 recvmsg(8, 2, 128): -1
2021/11/19 10:54:03.259 [debug] 53280#34365452480 recvmsg(8) not ready
2021/11/19 10:54:03.259 [debug] 53280#34365452480 kevent(3) changes:0 timeout:-1
2021/11/19 10:54:03.259 [debug] 53281#34365452480 free(8005F0440)
2021/11/19 10:54:03.259 [debug] 53281#34365452480 posix_memalign(64, 64): 8005F0440
2021/11/19 10:54:03.259 [debug] 53281#34365452480 posix_memalign(64, 64): 8005F0300
2021/11/19 10:54:03.259 [debug] 53281#34365452480 malloc(64): 8005F02C0
2021/11/19 10:54:03.259 [debug] 53281#34365452480 socket close(11)
2021/11/19 10:54:03.259 [debug] 53281#34365452480 free(8006112A0)
2021/11/19 10:54:03.259 [debug] 53281#34365452480 kevent(3) changes:1 timeout:-1
2021/11/19 10:54:03.259 [debug] 53281#34365452480 kevent(3): 1
2021/11/19 10:54:03.259 [debug] 53281#34365452480 kevent: id:8 ft:-1 fl:0025 ff:0 d:176 ud:800572940
2021/11/19 10:54:03.259 [debug] 53281#34365452480 timer expire minimum: 719594695:633194695
2021/11/19 10:54:03.259 [debug] 53281#34365452480 work queue: fast
2021/11/19 10:54:03.259 [debug] 53281#34365452480 posix_memalign(16, 16496): 800640000
2021/11/19 10:54:03.259 [debug] 53281#34365452480 recvmsg(8, 2, 128): 48
2021/11/19 10:54:03.259 [debug] 53281#34365452480 port 8: message type:10
2021/11/19 10:54:03.259 [debug] 53281#34365452480 new port 10 received for process 53280:0
2021/11/19 10:54:03.259 [debug] 53281#34365452480 process port (53280, 0) not found
2021/11/19 10:54:03.259 [debug] 53281#34365452480 pthread_mutex_lock(800654270) enter
2021/11/19 10:54:03.259 [debug] 53281#34365452480 pthread_mutex_init(800686828)
2021/11/19 10:54:03.259 [debug] 53281#34365452480 process 53280 insert
2021/11/19 10:54:03.259 [debug] 53281#34365452480 pthread_mutex_unlock(800654270) exit
2021/11/19 10:54:03.259 [debug] 53281#34365452480 malloc(168): 8006112A0
2021/11/19 10:54:03.259 [debug] 53281#34365452480 posix_memalign(16, 368): 800572AC0
2021/11/19 10:54:03.259 [debug] 53281#34365452480 malloc(136): 800670F60
2021/11/19 10:54:03.259 [debug] 53281#34365452480 posix_memalign(128, 1024): 800686400
2021/11/19 10:54:03.259 [debug] 53281#34365452480 pthread_mutex_init(800572B78)
2021/11/19 10:54:03.259 [debug] 53281#34365452480 port 800572AC0 53280:0 new, type 2
2021/11/19 10:54:03.259 [alert] 53281#34365452480 ioctl(10, FIONBIO) failed (9: Bad file descriptor)
2021/11/19 10:54:03.259 [debug] 53281#34365452480 pthread_mutex_lock(800572B78) enter
2021/11/19 10:54:03.259 [debug] 53281#34365452480 pthread_mutex_unlock(800572B78) exit
2021/11/19 10:54:03.259 [debug] 53281#34365452480 sendmsg(10, -1, -1, 1): -1
2021/11/19 10:54:03.259 [alert] 53281#34365452480 sendmsg(10, -1, -1, 1) failed (9: Bad file descriptor)
2021/11/19 10:54:03.259 [debug] 53281#34365452480 recvmsg(8, 2, 128): -1
2021/11/19 10:54:03.259 [debug] 53281#34365452480 recvmsg(8) not ready
2021/11/19 10:54:03.259 [debug] 53281#34365452480 work queue: fast
2021/11/19 10:54:03.259 [debug] 53281#34365452480 port error handler 800572AC0
2021/11/19 10:54:03.259 [debug] 53281#34365452480 pthread_mutex_lock(800572B78) enter
2021/11/19 10:54:03.259 [debug] 53281#34365452480 pthread_mutex_unlock(800572B78) exit
2021/11/19 10:54:03.259 [debug] 53281#34365452480 kevent(3) changes:0 timeout:-1










 
-------------- next part --------------
An HTML attachment was scrubbed...
URL: <http://mailman.nginx.org/pipermail/unit/attachments/20211119/0bb35eeb/attachment.htm>