Skip to content
New issue

Have a question about this project? Sign up for a free GitHub account to open an issue and contact its maintainers and the community.

Sign up for GitHub

By clicking “Sign up for GitHub”, you agree to our terms of service and privacy statement. We’ll occasionally send you account related emails.

Already on GitHub? Sign in to your account

Jump to bottom

Issues when loading as dynamic module on macOS #51

Open
nemphys opened this issue Feb 28, 2021 · 8 comments
Open

Issues when loading as dynamic module on macOS #51

nemphys opened this issue Feb 28, 2021 · 8 comments

Comments

@nemphys
Copy link

nemphys commented Feb 28, 2021

I just compiled the module as a dynamic module on macOS (nginx 1.19.7 installed via Homebrew) and when I add the load_module directive in nginx.conf and start the server, the error log gets flooded with the following errors (with high CPU utilization):

2021/02/28 11:05:10 [alert] 42874#0: worker process 49555 exited on signal 11
2021/02/28 11:05:10 [alert] 42874#0: cache manager process 49558 exited on signal 11

Turning on debug logging produces the following (repeatedly):

2021/02/28 11:17:04 [debug] 81313#0: bind() 127.0.0.1:3333 #7
2021/02/28 11:17:04 [debug] 81313#0: bind() 0.0.0.0:80 #8
2021/02/28 11:17:04 [debug] 81313#0: bind() 0.0.0.0:443 #9
2021/02/28 11:17:04 [notice] 81313#0: using the "kqueue" event method
2021/02/28 11:17:04 [warn] 81313#0: 1024 worker_connections exceed open file resource limit: 256
2021/02/28 11:17:04 [debug] 81313#0: counter: 000000010396D080, 1
2021/02/28 11:17:04 [notice] 81313#0: nginx/1.19.7
2021/02/28 11:17:04 [notice] 81313#0: built by clang 12.0.0 (clang-1200.0.32.29)
2021/02/28 11:17:04 [notice] 81313#0: OS: Darwin 20.3.0
2021/02/28 11:17:04 [notice] 81313#0: hw.ncpu: 8
2021/02/28 11:17:04 [notice] 81313#0: net.inet.tcp.sendspace: 131072
2021/02/28 11:17:04 [notice] 81313#0: kern.ipc.somaxconn: 128
2021/02/28 11:17:04 [notice] 81313#0: getrlimit(RLIMIT_NOFILE): 256:9223372036854775807
2021/02/28 11:17:04 [debug] 81313#0: write: 10, 00007FFEEC455A70, 6, 0
2021/02/28 11:17:04 [debug] 81313#0: setproctitle: "nginx: master process /usr/local/opt/nginx/bin/nginx -g daemon off;"
2021/02/28 11:17:04 [notice] 81313#0: start worker processes
2021/02/28 11:17:04 [debug] 81313#0: channel 3:10
2021/02/28 11:17:04 [notice] 81313#0: start worker process 81326
2021/02/28 11:17:04 [debug] 81313#0: channel 11:12
2021/02/28 11:17:04 [debug] 81326#0: add cleanup: 00007F92E80DB508
2021/02/28 11:17:04 [debug] 81326#0: malloc: 00007F92DE704290:8
2021/02/28 11:17:04 [notice] 81313#0: start worker process 81327
2021/02/28 11:17:04 [debug] 81313#0: pass channel s:1 pid:81327 fd:11 to s:0 pid:81326 fd:3
2021/02/28 11:17:04 [debug] 81313#0: channel 13:14
2021/02/28 11:17:04 [debug] 81327#0: add cleanup: 00007F92E80DB508
2021/02/28 11:17:04 [debug] 81327#0: malloc: 00007F92DF004340:8
2021/02/28 11:17:04 [notice] 81313#0: start cache manager process 81328
2021/02/28 11:17:04 [debug] 81313#0: pass channel s:2 pid:81328 fd:13 to s:0 pid:81326 fd:3
2021/02/28 11:17:04 [debug] 81313#0: pass channel s:2 pid:81328 fd:13 to s:1 pid:81327 fd:11
2021/02/28 11:17:04 [debug] 81313#0: channel 15:16
2021/02/28 11:17:04 [debug] 81328#0: close listening 127.0.0.1:3333 #7
2021/02/28 11:17:04 [notice] 81313#0: start cache loader process 81330
2021/02/28 11:17:04 [debug] 81328#0: close listening 0.0.0.0:80 #8
2021/02/28 11:17:04 [debug] 81328#0: close listening 0.0.0.0:443 #9
2021/02/28 11:17:04 [debug] 81328#0: add cleanup: 00007F92E80DB508
2021/02/28 11:17:04 [debug] 81328#0: malloc: 00007F92DE6040A0:8
2021/02/28 11:17:04 [debug] 81313#0: pass channel s:3 pid:81330 fd:15 to s:0 pid:81326 fd:3
2021/02/28 11:17:04 [debug] 81313#0: pass channel s:3 pid:81330 fd:15 to s:1 pid:81327 fd:11
2021/02/28 11:17:04 [debug] 81313#0: pass channel s:3 pid:81330 fd:15 to s:2 pid:81328 fd:13
2021/02/28 11:17:04 [debug] 81313#0: sigsuspend
2021/02/28 11:17:04 [debug] 81330#0: close listening 127.0.0.1:3333 #7
2021/02/28 11:17:04 [debug] 81330#0: close listening 0.0.0.0:80 #8
2021/02/28 11:17:04 [debug] 81330#0: close listening 0.0.0.0:443 #9
2021/02/28 11:17:04 [debug] 81330#0: add cleanup: 00007F92E80DB508
2021/02/28 11:17:04 [debug] 81330#0: malloc: 00007F92DF004390:8
2021/02/28 11:17:04 [debug] 81326#0: malloc: 00007F92E80DC800:16384
2021/02/28 11:17:04 [debug] 81326#0: malloc: 00007F92E800C600:16384
2021/02/28 11:17:04 [debug] 81327#0: malloc: 00007F92CF808200:16384
2021/02/28 11:17:04 [debug] 81327#0: malloc: 00007F92E8811A00:16384
2021/02/28 11:17:04 [debug] 81326#0: malloc: 00007F92C0008000:237568
2021/02/28 11:17:04 [debug] 81327#0: malloc: 00007F92C0008000:237568
2021/02/28 11:17:04 [debug] 81327#0: malloc: 00007F92C0048000:106496
2021/02/28 11:17:04 [debug] 81326#0: malloc: 00007F92B0008000:106496
2021/02/28 11:17:04 [debug] 81327#0: malloc: 00007F92C0068000:106496
2021/02/28 11:17:04 [debug] 81326#0: malloc: 00007F92B8008000:106496
2021/02/28 11:17:04 [debug] 81328#0: malloc: 00007F92CF808200:16384
2021/02/28 11:17:04 [debug] 81328#0: malloc: 00007F92CF80C200:16384
2021/02/28 11:17:04 [debug] 81327#0: kevent set event: 7: ft:-1 fl:0005
2021/02/28 11:17:04 [debug] 81326#0: kevent set event: 7: ft:-1 fl:0005
2021/02/28 11:17:04 [debug] 81326#0: kevent set event: 8: ft:-1 fl:0005
2021/02/28 11:17:04 [debug] 81326#0: kevent set event: 9: ft:-1 fl:0005
2021/02/28 11:17:04 [debug] 81327#0: kevent set event: 8: ft:-1 fl:0005
2021/02/28 11:17:04 [debug] 81328#0: malloc: 00007F92C0008000:118784
2021/02/28 11:17:04 [debug] 81327#0: kevent set event: 9: ft:-1 fl:0005
2021/02/28 11:17:04 [debug] 81328#0: malloc: 00007F92B0008000:53248
2021/02/28 11:17:04 [debug] 81328#0: malloc: 00007F92C0028000:53248
2021/02/28 11:17:04 [notice] 81313#0: signal 20 (SIGCHLD) received from 81326
2021/02/28 11:17:04 [alert] 81313#0: worker process 81327 exited on signal 11
2021/02/28 11:17:04 [debug] 81313#0: shmtx forced unlock
2021/02/28 11:17:04 [debug] 81313#0: shmtx forced unlock
2021/02/28 11:17:04 [debug] 81313#0: shmtx forced unlock
2021/02/28 11:17:04 [alert] 81313#0: worker process 81326 exited on signal 11
2021/02/28 11:17:04 [debug] 81313#0: shmtx forced unlock
2021/02/28 11:17:04 [debug] 81313#0: shmtx forced unlock
2021/02/28 11:17:04 [debug] 81313#0: shmtx forced unlock
2021/02/28 11:17:04 [debug] 81330#0: malloc: 00007F92E8811A00:16384
2021/02/28 11:17:04 [debug] 81330#0: malloc: 00007F92E8815A00:16384
2021/02/28 11:17:04 [debug] 81313#0: wake up, sigio 0
2021/02/28 11:17:04 [debug] 81330#0: malloc: 00007F92C0008000:118784
2021/02/28 11:17:04 [debug] 81313#0: reap children
2021/02/28 11:17:04 [debug] 81330#0: malloc: 00007F92E0008000:53248
2021/02/28 11:17:04 [debug] 81313#0: child: 0 81326 e:0 t:1 d:0 r:1 j:0
2021/02/28 11:17:04 [debug] 81313#0: pass close channel s:0 pid:81326 to:81328
2021/02/28 11:17:04 [debug] 81330#0: malloc: 00007F92E0018000:53248
2021/02/28 11:17:04 [debug] 81313#0: pass close channel s:0 pid:81326 to:81330
2021/02/28 11:17:04 [debug] 81313#0: channel 3:10
2021/02/28 11:17:04 [notice] 81313#0: start worker process 81334
2021/02/28 11:17:04 [debug] 81313#0: pass channel s:0 pid:81334 fd:3 to s:1 pid:81327 fd:11
2021/02/28 11:17:04 [debug] 81313#0: pass channel s:0 pid:81334 fd:3 to s:2 pid:81328 fd:13
2021/02/28 11:17:04 [debug] 81313#0: pass channel s:0 pid:81334 fd:3 to s:3 pid:81330 fd:15
2021/02/28 11:17:04 [debug] 81313#0: child: 1 81327 e:0 t:1 d:0 r:1 j:0
2021/02/28 11:17:04 [debug] 81313#0: pass close channel s:1 pid:81327 to:81334
2021/02/28 11:17:04 [debug] 81313#0: pass close channel s:1 pid:81327 to:81328
2021/02/28 11:17:04 [debug] 81313#0: pass close channel s:1 pid:81327 to:81330
2021/02/28 11:17:04 [debug] 81313#0: channel 11:12
2021/02/28 11:17:04 [debug] 81334#0: add cleanup: 00007F92E80DB508
2021/02/28 11:17:04 [debug] 81334#0: malloc: 00007F92DE407CA0:8
2021/02/28 11:17:04 [notice] 81313#0: start worker process 81335
2021/02/28 11:17:04 [debug] 81313#0: pass channel s:1 pid:81335 fd:11 to s:0 pid:81334 fd:3
2021/02/28 11:17:04 [debug] 81313#0: pass channel s:1 pid:81335 fd:11 to s:2 pid:81328 fd:13
2021/02/28 11:17:04 [debug] 81313#0: pass channel s:1 pid:81335 fd:11 to s:3 pid:81330 fd:15
2021/02/28 11:17:04 [debug] 81313#0: child: 2 81328 e:0 t:0 d:0 r:1 j:0
2021/02/28 11:17:04 [debug] 81313#0: child: 3 81330 e:0 t:0 d:0 r:0 j:0
2021/02/28 11:17:04 [debug] 81313#0: sigsuspend
2021/02/28 11:17:04 [notice] 81313#0: signal 23 (SIGIO) received
2021/02/28 11:17:04 [notice] 81313#0: signal 20 (SIGCHLD) received from 81330
2021/02/28 11:17:04 [alert] 81313#0: cache loader process 81330 exited on signal 11
2021/02/28 11:17:04 [debug] 81313#0: shmtx forced unlock
2021/02/28 11:17:04 [debug] 81313#0: shmtx forced unlock
2021/02/28 11:17:04 [debug] 81313#0: shmtx forced unlock
2021/02/28 11:17:04 [alert] 81313#0: cache manager process 81328 exited on signal 11
2021/02/28 11:17:04 [debug] 81313#0: shmtx forced unlock
2021/02/28 11:17:04 [debug] 81313#0: shmtx forced unlock
2021/02/28 11:17:04 [debug] 81313#0: shmtx forced unlock
2021/02/28 11:17:04 [debug] 81313#0: wake up, sigio 0
2021/02/28 11:17:04 [debug] 81313#0: reap children
2021/02/28 11:17:04 [debug] 81313#0: child: 0 81334 e:0 t:0 d:0 r:1 j:0
2021/02/28 11:17:04 [debug] 81313#0: child: 1 81335 e:0 t:0 d:0 r:1 j:0
2021/02/28 11:17:04 [debug] 81313#0: child: 2 81328 e:0 t:1 d:0 r:1 j:0
2021/02/28 11:17:04 [debug] 81313#0: pass close channel s:2 pid:81328 to:81334
2021/02/28 11:17:04 [debug] 81313#0: pass close channel s:2 pid:81328 to:81335
2021/02/28 11:17:04 [debug] 81313#0: channel 13:14
2021/02/28 11:17:04 [debug] 81335#0: add cleanup: 00007F92E80DB508
2021/02/28 11:17:04 [debug] 81335#0: malloc: 00007F92DF1175D0:8
2021/02/28 11:17:04 [notice] 81313#0: start cache manager process 81336
2021/02/28 11:17:04 [debug] 81313#0: pass channel s:2 pid:81336 fd:13 to s:0 pid:81334 fd:3
2021/02/28 11:17:04 [debug] 81313#0: pass channel s:2 pid:81336 fd:13 to s:1 pid:81335 fd:11
2021/02/28 11:17:04 [debug] 81313#0: pass channel s:2 pid:81336 fd:13 to s:3 pid:81330 fd:15
2021/02/28 11:17:04 [debug] 81313#0: child: 3 81330 e:0 t:1 d:0 r:0 j:0
2021/02/28 11:17:04 [debug] 81313#0: pass close channel s:3 pid:81330 to:81334
2021/02/28 11:17:04 [debug] 81313#0: pass close channel s:3 pid:81330 to:81335
2021/02/28 11:17:04 [debug] 81313#0: pass close channel s:3 pid:81330 to:81336
2021/02/28 11:17:04 [debug] 81313#0: sigsuspend
2021/02/28 11:17:04 [debug] 81336#0: close listening 127.0.0.1:3333 #7
2021/02/28 11:17:04 [debug] 81336#0: close listening 0.0.0.0:80 #8
2021/02/28 11:17:04 [debug] 81336#0: close listening 0.0.0.0:443 #9
2021/02/28 11:17:04 [debug] 81336#0: add cleanup: 00007F92E80DB508
2021/02/28 11:17:04 [debug] 81336#0: malloc: 00007F92DF004330:8
2021/02/28 11:17:04 [debug] 81334#0: malloc: 00007F92E8811A00:16384
2021/02/28 11:17:04 [debug] 81334#0: malloc: 00007F92E8815A00:16384
2021/02/28 11:17:04 [debug] 81334#0: malloc: 00007F92C0008000:237568
2021/02/28 11:17:04 [debug] 81334#0: malloc: 00007F92C0048000:106496
2021/02/28 11:17:04 [debug] 81334#0: malloc: 00007F92C0068000:106496
2021/02/28 11:17:04 [debug] 81335#0: malloc: 00007F92CF008200:16384
2021/02/28 11:17:04 [debug] 81335#0: malloc: 00007F92CF00C200:16384
2021/02/28 11:17:04 [debug] 81335#0: malloc: 00007F92C0008000:237568
2021/02/28 11:17:04 [debug] 81335#0: malloc: 00007F92C0048000:106496
2021/02/28 11:17:04 [debug] 81334#0: kevent set event: 7: ft:-1 fl:0005
2021/02/28 11:17:04 [debug] 81334#0: kevent set event: 8: ft:-1 fl:0005
2021/02/28 11:17:04 [debug] 81334#0: kevent set event: 9: ft:-1 fl:0005
2021/02/28 11:17:04 [debug] 81335#0: malloc: 00007F92C0068000:106496
2021/02/28 11:17:04 [notice] 81313#0: signal 23 (SIGIO) received from 81334
2021/02/28 11:17:04 [debug] 81313#0: wake up, sigio 0
2021/02/28 11:17:04 [debug] 81313#0: sigsuspend
2021/02/28 11:17:04 [debug] 81335#0: kevent set event: 7: ft:-1 fl:0005
2021/02/28 11:17:04 [debug] 81335#0: kevent set event: 8: ft:-1 fl:0005
2021/02/28 11:17:04 [debug] 81335#0: kevent set event: 9: ft:-1 fl:0005
2021/02/28 11:17:04 [notice] 81313#0: signal 23 (SIGIO) received
2021/02/28 11:17:04 [notice] 81313#0: signal 20 (SIGCHLD) received from 81334
2021/02/28 11:17:04 [alert] 81313#0: worker process 81334 exited on signal 11
2021/02/28 11:17:04 [debug] 81313#0: shmtx forced unlock
2021/02/28 11:17:04 [debug] 81313#0: shmtx forced unlock
2021/02/28 11:17:04 [debug] 81313#0: shmtx forced unlock
2021/02/28 11:17:04 [debug] 81313#0: wake up, sigio 0
2021/02/28 11:17:04 [debug] 81313#0: reap children
2021/02/28 11:17:04 [debug] 81313#0: child: 0 81334 e:0 t:1 d:0 r:1 j:0
2021/02/28 11:17:04 [debug] 81313#0: pass close channel s:0 pid:81334 to:81335
2021/02/28 11:17:04 [debug] 81313#0: pass close channel s:0 pid:81334 to:81336
2021/02/28 11:17:04 [debug] 81313#0: channel 3:10
2021/02/28 11:17:04 [debug] 81336#0: malloc: 00007F92E8811A00:16384
2021/02/28 11:17:04 [debug] 81336#0: malloc: 00007F92E8815A00:16384
2021/02/28 11:17:04 [debug] 81336#0: malloc: 00007F92C0008000:118784
2021/02/28 11:17:04 [debug] 81336#0: malloc: 00007F92C0028000:53248
2021/02/28 11:17:04 [debug] 81336#0: malloc: 00007F92C0038000:53248
2021/02/28 11:17:04 [notice] 81313#0: start worker process 81338
2021/02/28 11:17:04 [debug] 81313#0: pass channel s:0 pid:81338 fd:3 to s:1 pid:81335 fd:11
2021/02/28 11:17:04 [debug] 81313#0: pass channel s:0 pid:81338 fd:3 to s:2 pid:81336 fd:13
2021/02/28 11:17:04 [debug] 81313#0: child: 1 81335 e:0 t:0 d:0 r:1 j:0
2021/02/28 11:17:04 [debug] 81313#0: child: 2 81336 e:0 t:0 d:0 r:1 j:0
2021/02/28 11:17:04 [debug] 81313#0: sigsuspend
2021/02/28 11:17:04 [notice] 81313#0: signal 23 (SIGIO) received
2021/02/28 11:17:04 [debug] 81338#0: add cleanup: 00007F92E80DB508
2021/02/28 11:17:04 [debug] 81338#0: malloc: 00007F92DE704290:8
2021/02/28 11:17:04 [notice] 81313#0: signal 20 (SIGCHLD) received from 81336
2021/02/28 11:17:04 [alert] 81313#0: cache manager process 81336 exited on signal 11
2021/02/28 11:17:04 [debug] 81313#0: shmtx forced unlock
2021/02/28 11:17:04 [debug] 81313#0: shmtx forced unlock
2021/02/28 11:17:04 [debug] 81313#0: shmtx forced unlock
2021/02/28 11:17:04 [alert] 81313#0: worker process 81335 exited on signal 11
2021/02/28 11:17:04 [debug] 81313#0: shmtx forced unlock
2021/02/28 11:17:04 [debug] 81313#0: shmtx forced unlock
2021/02/28 11:17:04 [debug] 81313#0: shmtx forced unlock
2021/02/28 11:17:04 [debug] 81313#0: wake up, sigio 0
2021/02/28 11:17:04 [debug] 81313#0: reap children
2021/02/28 11:17:04 [debug] 81313#0: child: 0 81338 e:0 t:0 d:0 r:1 j:0
2021/02/28 11:17:04 [debug] 81313#0: child: 1 81335 e:0 t:1 d:0 r:1 j:0
2021/02/28 11:17:04 [debug] 81313#0: pass close channel s:1 pid:81335 to:81338
2021/02/28 11:17:04 [debug] 81313#0: channel 11:12
2021/02/28 11:17:04 [notice] 81313#0: start worker process 81339
2021/02/28 11:17:04 [debug] 81313#0: pass channel s:1 pid:81339 fd:11 to s:0 pid:81338 fd:3
2021/02/28 11:17:04 [debug] 81313#0: pass channel s:1 pid:81339 fd:11 to s:2 pid:81336 fd:13
2021/02/28 11:17:04 [debug] 81313#0: child: 2 81336 e:0 t:1 d:0 r:1 j:0
2021/02/28 11:17:04 [debug] 81313#0: pass close channel s:2 pid:81336 to:81338
2021/02/28 11:17:04 [debug] 81313#0: pass close channel s:2 pid:81336 to:81339
2021/02/28 11:17:04 [debug] 81313#0: channel 13:14
2021/02/28 11:17:04 [debug] 81339#0: add cleanup: 00007F92E80DB508
2021/02/28 11:17:04 [debug] 81339#0: malloc: 00007F92DF004390:8
2021/02/28 11:17:04 [debug] 81338#0: malloc: 00007F92CF808200:16384
2021/02/28 11:17:04 [debug] 81338#0: malloc: 00007F92CF80C200:16384
2021/02/28 11:17:04 [debug] 81338#0: malloc: 00007F92C0008000:237568
2021/02/28 11:17:04 [debug] 81338#0: malloc: 00007F92C0048000:106496
2021/02/28 11:17:04 [debug] 81338#0: malloc: 00007F92C0068000:106496
2021/02/28 11:17:04 [debug] 81338#0: kevent set event: 7: ft:-1 fl:0005
2021/02/28 11:17:04 [debug] 81338#0: kevent set event: 8: ft:-1 fl:0005
2021/02/28 11:17:04 [debug] 81338#0: kevent set event: 9: ft:-1 fl:0005
2021/02/28 11:17:04 [notice] 81313#0: start cache manager process 81340
2021/02/28 11:17:04 [debug] 81313#0: pass channel s:2 pid:81340 fd:13 to s:0 pid:81338 fd:3
2021/02/28 11:17:04 [debug] 81313#0: pass channel s:2 pid:81340 fd:13 to s:1 pid:81339 fd:11
2021/02/28 11:17:04 [debug] 81313#0: sigsuspend
2021/02/28 11:17:04 [notice] 81313#0: signal 23 (SIGIO) received
2021/02/28 11:17:04 [notice] 81313#0: signal 20 (SIGCHLD) received from 81338
2021/02/28 11:17:04 [alert] 81313#0: worker process 81338 exited on signal 11
2021/02/28 11:17:04 [debug] 81313#0: shmtx forced unlock
2021/02/28 11:17:04 [debug] 81313#0: shmtx forced unlock
2021/02/28 11:17:04 [debug] 81313#0: shmtx forced unlock
2021/02/28 11:17:04 [debug] 81313#0: wake up, sigio 0
2021/02/28 11:17:04 [debug] 81313#0: reap children
2021/02/28 11:17:04 [debug] 81313#0: child: 0 81338 e:0 t:1 d:0 r:1 j:0
2021/02/28 11:17:04 [debug] 81313#0: pass close channel s:0 pid:81338 to:81339
2021/02/28 11:17:04 [debug] 81313#0: pass close channel s:0 pid:81338 to:81340
2021/02/28 11:17:04 [debug] 81340#0: close listening 127.0.0.1:3333 #7
2021/02/28 11:17:04 [debug] 81313#0: channel 3:10
2021/02/28 11:17:04 [debug] 81339#0: malloc: 00007F92CF008200:16384
2021/02/28 11:17:04 [debug] 81339#0: malloc: 00007F92CF00C200:16384
2021/02/28 11:17:04 [debug] 81340#0: close listening 0.0.0.0:80 #8
2021/02/28 11:17:04 [debug] 81339#0: malloc: 00007F92C0008000:237568
2021/02/28 11:17:04 [debug] 81339#0: malloc: 00007F92C0048000:106496
2021/02/28 11:17:04 [debug] 81340#0: close listening 0.0.0.0:443 #9
2021/02/28 11:17:04 [debug] 81339#0: malloc: 00007F92C0068000:106496
2021/02/28 11:17:04 [debug] 81340#0: add cleanup: 00007F92E80DB508
2021/02/28 11:17:04 [debug] 81340#0: malloc: 00007F92DF1175D0:8
2021/02/28 11:17:04 [debug] 81339#0: kevent set event: 7: ft:-1 fl:0005
2021/02/28 11:17:04 [debug] 81339#0: kevent set event: 8: ft:-1 fl:0005
2021/02/28 11:17:04 [debug] 81339#0: kevent set event: 9: ft:-1 fl:0005
2021/02/28 11:17:04 [notice] 81313#0: start worker process 81342
2021/02/28 11:17:04 [debug] 81313#0: pass channel s:0 pid:81342 fd:3 to s:1 pid:81339 fd:11
2021/02/28 11:17:04 [debug] 81313#0: pass channel s:0 pid:81342 fd:3 to s:2 pid:81340 fd:13
2021/02/28 11:17:04 [debug] 81313#0: child: 1 81339 e:0 t:0 d:0 r:1 j:0
2021/02/28 11:17:04 [debug] 81313#0: child: 2 81340 e:0 t:0 d:0 r:1 j:0
2021/02/28 11:17:04 [debug] 81313#0: sigsuspend
2021/02/28 11:17:04 [notice] 81313#0: signal 23 (SIGIO) received
2021/02/28 11:17:04 [notice] 81313#0: signal 20 (SIGCHLD) received from 81339
2021/02/28 11:17:04 [alert] 81313#0: worker process 81339 exited on signal 11
2021/02/28 11:17:04 [debug] 81313#0: shmtx forced unlock
2021/02/28 11:17:04 [debug] 81313#0: shmtx forced unlock
2021/02/28 11:17:04 [debug] 81313#0: shmtx forced unlock
2021/02/28 11:17:04 [debug] 81313#0: wake up, sigio 0
2021/02/28 11:17:04 [debug] 81313#0: reap children
2021/02/28 11:17:04 [debug] 81313#0: child: 0 81342 e:0 t:0 d:0 r:1 j:0
2021/02/28 11:17:04 [debug] 81313#0: child: 1 81339 e:0 t:1 d:0 r:1 j:0
2021/02/28 11:17:04 [debug] 81313#0: pass close channel s:1 pid:81339 to:81342
2021/02/28 11:17:04 [debug] 81313#0: pass close channel s:1 pid:81339 to:81340
2021/02/28 11:17:04 [debug] 81313#0: channel 11:12
2021/02/28 11:17:04 [debug] 81342#0: add cleanup: 00007F92E80DB508
2021/02/28 11:17:04 [debug] 81342#0: malloc: 00007F92DE6040A0:8
2021/02/28 11:17:04 [debug] 81340#0: malloc: 00007F92CF808200:16384
2021/02/28 11:17:04 [debug] 81340#0: malloc: 00007F92CF80C200:16384
2021/02/28 11:17:04 [debug] 81340#0: malloc: 00007F92C0008000:118784
2021/02/28 11:17:04 [debug] 81340#0: malloc: 00007F92C0028000:53248
2021/02/28 11:17:04 [debug] 81340#0: malloc: 00007F92C0038000:53248
2021/02/28 11:17:04 [notice] 81313#0: start worker process 81344
2021/02/28 11:17:04 [debug] 81313#0: pass channel s:1 pid:81344 fd:11 to s:0 pid:81342 fd:3
2021/02/28 11:17:04 [debug] 81313#0: pass channel s:1 pid:81344 fd:11 to s:2 pid:81340 fd:13
2021/02/28 11:17:04 [debug] 81313#0: child: 2 81340 e:0 t:0 d:0 r:1 j:0
2021/02/28 11:17:04 [debug] 81313#0: sigsuspend
2021/02/28 11:17:04 [notice] 81313#0: signal 23 (SIGIO) received from 81340
2021/02/28 11:17:04 [debug] 81313#0: wake up, sigio 0
2021/02/28 11:17:04 [debug] 81313#0: sigsuspend
2021/02/28 11:17:04 [notice] 81313#0: signal 23 (SIGIO) received
2021/02/28 11:17:04 [notice] 81313#0: signal 20 (SIGCHLD) received from 81340
2021/02/28 11:17:04 [alert] 81313#0: cache manager process 81340 exited on signal 11
2021/02/28 11:17:04 [debug] 81313#0: shmtx forced unlock
2021/02/28 11:17:04 [debug] 81313#0: shmtx forced unlock
2021/02/28 11:17:04 [debug] 81313#0: shmtx forced unlock
2021/02/28 11:17:04 [debug] 81344#0: add cleanup: 00007F92E80DB508
2021/02/28 11:17:04 [debug] 81313#0: wake up, sigio 0
2021/02/28 11:17:04 [debug] 81313#0: reap children
2021/02/28 11:17:04 [debug] 81313#0: child: 0 81342 e:0 t:0 d:0 r:1 j:0
2021/02/28 11:17:04 [debug] 81313#0: child: 1 81344 e:0 t:0 d:0 r:1 j:0
2021/02/28 11:17:04 [debug] 81313#0: child: 2 81340 e:0 t:1 d:0 r:1 j:0
2021/02/28 11:17:04 [debug] 81313#0: pass close channel s:2 pid:81340 to:81342
2021/02/28 11:17:04 [debug] 81313#0: pass close channel s:2 pid:81340 to:81344
2021/02/28 11:17:04 [debug] 81344#0: malloc: 00007F92DE407CA0:8
2021/02/28 11:17:04 [debug] 81313#0: channel 13:14
2021/02/28 11:17:04 [debug] 81342#0: malloc: 00007F92DF82CE00:16384
2021/02/28 11:17:04 [debug] 81342#0: malloc: 00007F92DF830E00:16384
2021/02/28 11:17:04 [debug] 81342#0: malloc: 00007F92C0008000:237568
2021/02/28 11:17:04 [debug] 81342#0: malloc: 00007F92C0048000:106496
2021/02/28 11:17:04 [debug] 81342#0: malloc: 00007F92C0068000:106496
2021/02/28 11:17:04 [debug] 81342#0: kevent set event: 7: ft:-1 fl:0005
2021/02/28 11:17:04 [debug] 81342#0: kevent set event: 8: ft:-1 fl:0005
2021/02/28 11:17:04 [debug] 81342#0: kevent set event: 9: ft:-1 fl:0005
2021/02/28 11:17:04 [debug] 81344#0: malloc: 00007F92CF008200:16384
2021/02/28 11:17:04 [debug] 81344#0: malloc: 00007F92CF00C200:16384
2021/02/28 11:17:04 [debug] 81344#0: malloc: 00007F92C0008000:237568
2021/02/28 11:17:04 [debug] 81344#0: malloc: 00007F92C0048000:106496
2021/02/28 11:17:04 [notice] 81313#0: start cache manager process 81346
2021/02/28 11:17:04 [debug] 81313#0: pass channel s:2 pid:81346 fd:13 to s:0 pid:81342 fd:3
2021/02/28 11:17:04 [debug] 81344#0: malloc: 00007F92C0068000:106496
2021/02/28 11:17:04 [debug] 81313#0: pass channel s:2 pid:81346 fd:13 to s:1 pid:81344 fd:11
2021/02/28 11:17:04 [debug] 81313#0: sigsuspend
2021/02/28 11:17:04 [notice] 81313#0: signal 23 (SIGIO) received
2021/02/28 11:17:04 [notice] 81313#0: signal 20 (SIGCHLD) received from 81342
2021/02/28 11:17:04 [alert] 81313#0: worker process 81342 exited on signal 11
2021/02/28 11:17:04 [debug] 81313#0: shmtx forced unlock
2021/02/28 11:17:04 [debug] 81313#0: shmtx forced unlock
2021/02/28 11:17:04 [debug] 81313#0: shmtx forced unlock
2021/02/28 11:17:04 [debug] 81344#0: kevent set event: 7: ft:-1 fl:0005
2021/02/28 11:17:04 [debug] 81344#0: kevent set event: 8: ft:-1 fl:0005
2021/02/28 11:17:04 [debug] 81344#0: kevent set event: 9: ft:-1 fl:0005
2021/02/28 11:17:04 [debug] 81313#0: wake up, sigio 0
2021/02/28 11:17:04 [debug] 81313#0: reap children
2021/02/28 11:17:04 [debug] 81313#0: child: 0 81342 e:0 t:1 d:0 r:1 j:0
2021/02/28 11:17:04 [debug] 81313#0: pass close channel s:0 pid:81342 to:81344
2021/02/28 11:17:04 [debug] 81346#0: close listening 127.0.0.1:3333 #7
2021/02/28 11:17:04 [debug] 81313#0: pass close channel s:0 pid:81342 to:81346
2021/02/28 11:17:04 [debug] 81346#0: close listening 0.0.0.0:80 #8
2021/02/28 11:17:04 [debug] 81346#0: close listening 0.0.0.0:443 #9
2021/02/28 11:17:04 [debug] 81313#0: channel 3:10
2021/02/28 11:17:04 [debug] 81346#0: add cleanup: 00007F92E80DB508
2021/02/28 11:17:04 [debug] 81346#0: malloc: 00007F92DF1175D0:8
2021/02/28 11:17:04 [notice] 81313#0: start worker process 81348
2021/02/28 11:17:04 [debug] 81313#0: pass channel s:0 pid:81348 fd:3 to s:1 pid:81344 fd:11
2021/02/28 11:17:04 [debug] 81313#0: pass channel s:0 pid:81348 fd:3 to s:2 pid:81346 fd:13
2021/02/28 11:17:04 [debug] 81313#0: child: 1 81344 e:0 t:0 d:0 r:1 j:0
2021/02/28 11:17:04 [debug] 81313#0: child: 2 81346 e:0 t:0 d:0 r:1 j:0
2021/02/28 11:17:04 [debug] 81313#0: sigsuspend
2021/02/28 11:17:04 [notice] 81313#0: signal 23 (SIGIO) received
2021/02/28 11:17:04 [notice] 81313#0: signal 20 (SIGCHLD) received from 81344
2021/02/28 11:17:04 [alert] 81313#0: worker process 81344 exited on signal 11
2021/02/28 11:17:04 [debug] 81313#0: shmtx forced unlock
2021/02/28 11:17:04 [debug] 81313#0: shmtx forced unlock
2021/02/28 11:17:04 [debug] 81313#0: shmtx forced unlock
2021/02/28 11:17:04 [debug] 81313#0: wake up, sigio 0
2021/02/28 11:17:04 [debug] 81313#0: reap children
2021/02/28 11:17:04 [debug] 81313#0: child: 0 81348 e:0 t:0 d:0 r:1 j:0
2021/02/28 11:17:04 [debug] 81348#0: add cleanup: 00007F92E80DB508
2021/02/28 11:17:04 [debug] 81348#0: malloc: 00007F92DE6040A0:8
2021/02/28 11:17:04 [debug] 81313#0: child: 1 81344 e:0 t:1 d:0 r:1 j:0
2021/02/28 11:17:04 [debug] 81313#0: pass close channel s:1 pid:81344 to:81348
2021/02/28 11:17:04 [debug] 81313#0: pass close channel s:1 pid:81344 to:81346
2021/02/28 11:17:04 [debug] 81313#0: channel 11:12
2021/02/28 11:17:04 [debug] 81346#0: malloc: 00007F92CE808600:16384
2021/02/28 11:17:04 [debug] 81346#0: malloc: 00007F92CE80C600:16384
2021/02/28 11:17:04 [notice] 81313#0: start worker process 81350
2021/02/28 11:17:04 [debug] 81313#0: pass channel s:1 pid:81350 fd:11 to s:0 pid:81348 fd:3
2021/02/28 11:17:04 [debug] 81313#0: pass channel s:1 pid:81350 fd:11 to s:2 pid:81346 fd:13
2021/02/28 11:17:04 [debug] 81313#0: child: 2 81346 e:0 t:0 d:0 r:1 j:0
2021/02/28 11:17:04 [debug] 81313#0: sigsuspend
2021/02/28 11:17:04 [debug] 81346#0: malloc: 00007F92C0008000:118784
2021/02/28 11:17:04 [debug] 81346#0: malloc: 00007F92B0008000:53248
2021/02/28 11:17:04 [debug] 81346#0: malloc: 00007F92B0018000:53248
2021/02/28 11:17:04 [debug] 81350#0: add cleanup: 00007F92E80DB508
2021/02/28 11:17:04 [debug] 81350#0: malloc: 00007F92DF1175D0:8
2021/02/28 11:17:04 [notice] 81313#0: signal 23 (SIGIO) received from 81346
2021/02/28 11:17:04 [debug] 81313#0: wake up, sigio 0
2021/02/28 11:17:04 [debug] 81313#0: sigsuspend
2021/02/28 11:17:04 [notice] 81313#0: signal 23 (SIGIO) received
2021/02/28 11:17:04 [notice] 81313#0: signal 20 (SIGCHLD) received from 81346
2021/02/28 11:17:04 [alert] 81313#0: cache manager process 81346 exited on signal 11

Any ideas?
@nemphys
Copy link
Author

nemphys commented Mar 2, 2021

I just realised that my issue is the same as issue #39 (outstanding since 2019), so I guess it will never be solved (project seems to be abandoned?)
I tried building v1.3 and at least it seems to work (no streams support).

@Lax
Copy link
Owner

Lax commented Mar 3, 2021

@nemphys can you show the ./configure parameters, I will try to reproduce the issue first

@nemphys
Copy link
Author

nemphys commented Mar 3, 2021

The installation is the default current Homebrew installation of 1.19.7 under Big Sur.
Configure parameters:
--prefix=/usr/local/Cellar/nginx/1.19.7 --sbin-path=/usr/local/Cellar/nginx/1.19.7/bin/nginx --with-cc-opt='-I/usr/local/opt/pcre/include -I/usr/local/opt/openssl@1.1/include' --with-ld-opt='-L/usr/local/opt/pcre/lib -L/usr/local/opt/openssl@1.1/lib' --conf-path=/usr/local/etc/nginx/nginx.conf --pid-path=/usr/local/var/run/nginx.pid --lock-path=/usr/local/var/run/nginx.lock --http-client-body-temp-path=/usr/local/var/run/nginx/client_body_temp --http-proxy-temp-path=/usr/local/var/run/nginx/proxy_temp --http-fastcgi-temp-path=/usr/local/var/run/nginx/fastcgi_temp --http-uwsgi-temp-path=/usr/local/var/run/nginx/uwsgi_temp --http-scgi-temp-path=/usr/local/var/run/nginx/scgi_temp --http-log-path=/usr/local/var/log/nginx/access.log --error-log-path=/usr/local/var/log/nginx/error.log --with-compat --with-debug --with-http_addition_module --with-http_auth_request_module --with-http_dav_module --with-http_degradation_module --with-http_flv_module --with-http_gunzip_module --with-http_gzip_static_module --with-http_mp4_module --with-http_random_index_module --with-http_realip_module --with-http_secure_link_module --with-http_slice_module --with-http_ssl_module --with-http_stub_status_module --with-http_sub_module --with-http_v2_module --with-ipv6 --with-mail --with-mail_ssl_module --with-pcre --with-pcre-jit --with-stream --with-stream_realip_module --with-stream_ssl_module --with-stream_ssl_preread_module

@Lax
Copy link
Owner

Lax commented Mar 4, 2021

cannot reproduce the issue.

configuration options and nginx.conf see below:

➜  nginx-1.19.7 ./objs/nginx -V
nginx version: nginx/1.19.7
built by clang 12.0.0 (clang-1200.0.32.29)
built with OpenSSL 1.1.1j  16 Feb 2021
TLS SNI support enabled
configure arguments: --prefix=/usr/local/Cellar/nginx/1.19.7 --sbin-path=/usr/local/Cellar/nginx/1.19.7/bin/nginx --with-cc-opt='-I/usr/local/opt/pcre/include -I/usr/local/opt/openssl@1.1/include' --with-ld-opt='-L/usr/local/opt/pcre/lib -L/usr/local/opt/openssl@1.1/lib' --conf-path=/usr/local/etc/nginx/nginx.conf --pid-path=/usr/local/var/run/nginx.pid --lock-path=/usr/local/var/run/nginx.lock --http-client-body-temp-path=/usr/local/var/run/nginx/client_body_temp --http-proxy-temp-path=/usr/local/var/run/nginx/proxy_temp --http-fastcgi-temp-path=/usr/local/var/run/nginx/fastcgi_temp --http-uwsgi-temp-path=/usr/local/var/run/nginx/uwsgi_temp --http-scgi-temp-path=/usr/local/var/run/nginx/scgi_temp --http-log-path=/usr/local/var/log/nginx/access.log --error-log-path=/usr/local/var/log/nginx/error.log --with-compat --with-debug --with-http_addition_module --with-http_auth_request_module --with-http_dav_module --with-http_degradation_module --with-http_flv_module --with-http_gunzip_module --with-http_gzip_static_module --with-http_mp4_module --with-http_random_index_module --with-http_realip_module --with-http_secure_link_module --with-http_slice_module --with-http_ssl_module --with-http_stub_status_module --with-http_sub_module --with-http_v2_module --with-ipv6 --with-mail --with-mail_ssl_module --with-pcre --with-pcre-jit --with-stream --with-stream_realip_module --with-stream_ssl_module --with-stream_ssl_preread_module --add-dynamic-module=traffic-accounting-nginx-module

load_module objs/ngx_http_accounting_module.so;

#user  nobody;
worker_processes  1;

events {
    worker_connections  1024;
}


http {
    include       mime.types;
    default_type  application/octet-stream;

    sendfile        on;

    keepalive_timeout  65;

    accounting on;
    accounting_log  logs/http-accounting.log;

    server {
        listen       8081;
        server_name  localhost;

        location / {
            root   html;
            index  index.html index.htm;
        }

        error_page   500 502 503 504  /50x.html;
        location = /50x.html {
            root   html;
        }

    }
}

stream {
    accounting on;
    accounting_id 'STREAM';
    accounting_interval 60;
    accounting_perturb on;
    accounting_log logs/stream-accounting.log;
    
    upstream echo {
        server 127.0.0.1:8888   max_fails=3 fail_timeout=30s;
    }
    
    server {
        listen 9999;
        proxy_connect_timeout 1s;
        proxy_timeout 30s;
        proxy_pass echo;
        resolver 127.0.0.1;
        accounting_id "TCP_PROXY_ECHO";
    }
    
    
    upstream dns {
       server 8.8.8.8:53;
    }
    
    server {
        listen 53 udp;
        proxy_responses 1;
        proxy_timeout 20s;
        proxy_pass dns;
        accounting_id $remote_addr;
    }
}

@Lax
Copy link
Owner

Lax commented Mar 4, 2021 •
edited
Loading

I notice that there's a message cache manager process 81340 exited on signal 11 that may be related to cache configuration, can you show the nginx configuration @nemphys

@nemphys
Copy link
Author

nemphys commented Mar 4, 2021

Here is my config (please note that I am not using the stream module at all):

`load_module modules/ngx_http_accounting_module.so;

user nobody staff;
worker_processes 4;

error_log /usr/local/var/log/nginx/error.log;

events {
worker_connections 256;
}

http {
http_accounting on;
http_accounting_log /usr/local/var/log/nginx/http-accounting.log;
http_accounting_id $hostname;
http_accounting_interval 10;

include       mime.types;
default_type  application/octet-stream;

sendfile        on;
tcp_nodelay    on;
tcp_nopush     on;

keepalive_timeout  65;

client_max_body_size 512M;

gzip on;
gzip_http_version 1.1;
gzip_comp_level 5;
gzip_proxied any;
gzip_min_length  256;
gzip_buffers 16 8k;
gzip_vary on;
gzip_types
  application/atom+xml
  application/javascript
  application/x-javascript
  application/json
  application/rss+xml
  application/vnd.ms-fontobject
  application/x-font-ttf
  application/x-web-app-manifest+json
  application/xhtml+xml
  application/xml
  font/opentype
  image/svg+xml
  image/x-icon
  text/css
  text/plain
  text/x-component;

##
# SSL Settings
##

ssl_protocols TLSv1.2 TLSv1.3; # Dropping SSLv3, ref: POODLE
ssl_prefer_server_ciphers on;
ssl_ciphers TLS-CHACHA20-POLY1305-SHA256:TLS-AES-256-GCM-SHA384:TLS-AES-128-GCM-SHA256:ECDH+AESGCM:DH+AESGCM:ECDH+AES256:DH+AES256:ECDH+AES128:DH+AES:!aNULL:!MD5:!DSS; # TLS1.3
ssl_dhparam /usr/local/etc/nginx/ssl/dhparams.pem;

ssl_session_cache shared:SSL:32m;
ssl_session_timeout 180m;
ssl_buffer_size 8k;

map $scheme $fastcgi_https { ## Detect when HTTPS is used
    default off;
    https on;
}

proxy_cache_path /tmp/cache keys_zone=microcache:50m levels=1:2 inactive=600s max_size=100m;

server {
  listen 127.0.0.1:3333;
  proxy_http_version 1.1;
  proxy_set_header    Connection              "";
  proxy_set_header    Host                    $http_host;
  proxy_set_header    X-Forwarded-For         $proxy_add_x_forwarded_for;
  proxy_set_header    X-Forwarded-Proto       $scheme;
  proxy_set_header    X-Real-IP               $remote_addr;
  proxy_set_header    X-Real-PORT             $remote_port;
  proxy_buffers 32 4k;
  proxy_buffer_size 16k;
  http_accounting_id xxxxxxx;

  location / {
    proxy_cache microcache;
    proxy_cache_revalidate on;
    proxy_cache_valid 200 1s;
    proxy_cache_lock on;
    proxy_cache_use_stale updating;
    proxy_ignore_headers Set-Cookie;
    proxy_hide_header Set-Cookie;
    proxy_ignore_headers Cache-Control;
    add_header X-Cache-Status $upstream_cache_status;
    proxy_pass http://nodejs;
}

}
}`

@nemphys
Copy link
Author

nemphys commented Mar 8, 2021

Any news on this one?

@waster
Copy link

waster commented Jun 2, 2021 •
edited
Loading

The same issue for me trying to load dynamic module after compiling it with nginx 1.21.0-1~focal package from official repository on Ubuntu 20.04. Even with a sample minimal config:

http {
    include       /etc/nginx/mime.types;
    default_type  application/octet-stream;

    access_log  /var/log/nginx/access.log;
}

Sign up for free to join this conversation on GitHub. Already have an account? Sign in to comment
Assignees
No one assigned
Labels
None yet
Projects
None yet
Milestone
No milestone
Development

No branches or pull requests
3 participants
@Lax @nemphys @waster