More debugging:
Strace of process when sending a password reset:
firefly:/usr/share/agent-smith# strace -p 24317 Process 24317 attached - interrupt to quit restart_syscall(<... resuming interrupted call ...>) = 1 read(5, "d", 1) = 1 time([1283208534]) = 1283208534 sendto(3, "<26>Aug 30 22:48:54 agent-smith:"..., 110, MSG_NOSIGNAL, NULL, 0) = 110 rt_sigaction(SIGPIPE, {SIG_IGN, [], SA_RESTORER, 0x7f8ee7e171f0}, {0x402c00, [], SA_RESTORER, 0x7f8ee7e171f0}, 8) = 0 write(4, "\6\0\0\0\0\0\0\0\0\0\0\0\1\0\0\0", 16) = 16 write(4, "\0", 1) = 1 futex(0x607414, FUTEX_WAIT_PRIVATE, 15, NULL) = 0 futex(0x6073e8, FUTEX_WAKE_PRIVATE, 1) = 0 rt_sigaction(SIGPIPE, {0x402c00, [], SA_RESTORER, 0x7f8ee7e171f0}, NULL, 8) = 0 rt_sigaction(SIGPIPE, {SIG_IGN, [], SA_RESTORER, 0x7f8ee7e171f0}, {0x402c00, [], SA_RESTORER, 0x7f8ee7e171f0}, 8) = 0 write(4, "\2\0\0\0\0\0\0\0\333\4\0\0/\0\0\0", 16) = 16 write(4, "data/host/7c7dd0d8-05b0-102e-bbd"..., 47) = 47 futex(0x607414, FUTEX_WAIT_PRIVATE, 17, NULL) = 0 futex(0x6073e8, FUTEX_WAKE_PRIVATE, 1) = 0 rt_sigaction(SIGPIPE, {0x402c00, [], SA_RESTORER, 0x7f8ee7e171f0}, NULL, 8) = 0 rt_sigaction(SIGPIPE, {SIG_IGN, [], SA_RESTORER, 0x7f8ee7e171f0}, {0x402c00, [], SA_RESTORER, 0x7f8ee7e171f0}, 8) = 0 write(4, "\7\0\0\0\0\0\0\0\333\4\0\0\2\0\0\0", 16) = 16 write(4, "T\0", 2) = 2 futex(0x607414, FUTEX_WAIT_PRIVATE, 19, NULL) = 0 futex(0x6073e8, FUTEX_WAKE_PRIVATE, 1) = 0 rt_sigaction(SIGPIPE, {0x402c00, [], SA_RESTORER, 0x7f8ee7e171f0}, NULL, 8) = 0 stat("/var/spool/agent/outgoing", {st_mode=S_IFDIR|0755, st_size=4096, ...}) = 0 stat("/var/spool/agent/outgoing", {st_mode=S_IFDIR|0755, st_size=4096, ...}) = 0 open("/var/spool/agent/outgoing/7c7dd0d8-05b0-102e-bbd2-0050568d2864", O_WRONLY|O_CREAT|O_EXCL|O_TRUNC, 0666) = 8 fstat(8, {st_mode=S_IFREG|0644, st_size=0, ...}) = 0 mmap(NULL, 4096, PROT_READ|PROT_WRITE, MAP_PRIVATE|MAP_ANONYMOUS, -1, 0) = 0x7f8ee8568000 write(8, "{\"name\":\"keyinit\",\"value\":\"97656"..., 36) = 36 close(8) = 0 munmap(0x7f8ee8568000, 4096) = 0 clone(child_stack=0, flags=CLONE_CHILD_CLEARTID|CLONE_CHILD_SETTID|SIGCHLD, child_tidptr=0x7f8ee85649d0) = 24886 --- SIGCHLD (Child exited) @ 0 (0) --- wait4(-1, NULL, WNOHANG, NULL) = 24886 wait4(-1, NULL, WNOHANG, NULL) = -1 ECHILD (No child processes) rt_sigreturn(0) = 24886 read(7, 0x60501c, 4112) = -1 EAGAIN (Resource temporarily unavailable) poll([{fd=7, events=POLLIN}, {fd=5, events=POLLIN}], 2, -1^C <unfinished ...>
It appears the message is received and written but no actions occur on it.
More debugging:
Strace of process when sending a password reset:
firefly: /usr/share/ agent-smith# strace -p 24317 syscall( <... resuming interrupted call ...>) = 1 SIGPIPE, {SIG_IGN, [], SA_RESTORER, 0x7f8ee7e171f0}, {0x402c00, [], SA_RESTORER, 0x7f8ee7e171f0}, 8) = 0 0\0\0\0\ 0\0\0\0\ 0\1\0\0\ 0", 16) = 16 SIGPIPE, {0x402c00, [], SA_RESTORER, 0x7f8ee7e171f0}, NULL, 8) = 0 SIGPIPE, {SIG_IGN, [], SA_RESTORER, 0x7f8ee7e171f0}, {0x402c00, [], SA_RESTORER, 0x7f8ee7e171f0}, 8) = 0 0\0\0\0\ 0\333\4\ 0\0/\0\ 0\0", 16) = 16 7c7dd0d8- 05b0-102e- bbd"... , 47) = 47 SIGPIPE, {0x402c00, [], SA_RESTORER, 0x7f8ee7e171f0}, NULL, 8) = 0 SIGPIPE, {SIG_IGN, [], SA_RESTORER, 0x7f8ee7e171f0}, {0x402c00, [], SA_RESTORER, 0x7f8ee7e171f0}, 8) = 0 0\0\0\0\ 0\333\4\ 0\0\2\0\ 0\0", 16) = 16 SIGPIPE, {0x402c00, [], SA_RESTORER, 0x7f8ee7e171f0}, NULL, 8) = 0 var/spool/ agent/outgoing" , {st_mode= S_IFDIR| 0755, st_size=4096, ...}) = 0 var/spool/ agent/outgoing" , {st_mode= S_IFDIR| 0755, st_size=4096, ...}) = 0 var/spool/ agent/outgoing/ 7c7dd0d8- 05b0-102e- bbd2-0050568d28 64", O_WRONLY| O_CREAT| O_EXCL| O_TRUNC, 0666) = 8 S_IFREG| 0644, st_size=0, ...}) = 0 PROT_WRITE, MAP_PRIVATE| MAP_ANONYMOUS, -1, 0) = 0x7f8ee8568000 ":\"keyinit\ ",\"value\ ":\"97656" ..., 36) = 36 0x7f8ee8568000, 4096) = 0 stack=0, flags=CLONE_ CHILD_CLEARTID| CLONE_CHILD_ SETTID| SIGCHLD, child_tidptr= 0x7f8ee85649d0) = 24886
Process 24317 attached - interrupt to quit
restart_
read(5, "d", 1) = 1
time([1283208534]) = 1283208534
sendto(3, "<26>Aug 30 22:48:54 agent-smith:"..., 110, MSG_NOSIGNAL, NULL, 0) = 110
rt_sigaction(
write(4, "\6\0\0\
write(4, "\0", 1) = 1
futex(0x607414, FUTEX_WAIT_PRIVATE, 15, NULL) = 0
futex(0x6073e8, FUTEX_WAKE_PRIVATE, 1) = 0
rt_sigaction(
rt_sigaction(
write(4, "\2\0\0\
write(4, "data/host/
futex(0x607414, FUTEX_WAIT_PRIVATE, 17, NULL) = 0
futex(0x6073e8, FUTEX_WAKE_PRIVATE, 1) = 0
rt_sigaction(
rt_sigaction(
write(4, "\7\0\0\
write(4, "T\0", 2) = 2
futex(0x607414, FUTEX_WAIT_PRIVATE, 19, NULL) = 0
futex(0x6073e8, FUTEX_WAKE_PRIVATE, 1) = 0
rt_sigaction(
stat("/
stat("/
open("/
fstat(8, {st_mode=
mmap(NULL, 4096, PROT_READ|
write(8, "{\"name\
close(8) = 0
munmap(
clone(child_
--- SIGCHLD (Child exited) @ 0 (0) ---
wait4(-1, NULL, WNOHANG, NULL) = 24886
wait4(-1, NULL, WNOHANG, NULL) = -1 ECHILD (No child processes)
rt_sigreturn(0) = 24886
read(7, 0x60501c, 4112) = -1 EAGAIN (Resource temporarily unavailable)
poll([{fd=7, events=POLLIN}, {fd=5, events=POLLIN}], 2, -1^C <unfinished ...>
It appears the message is received and written but no actions occur on it.