dhcpcd-discuss

On 10/29/20 12:15 PM, Roy Marples wrote:
> OK, that's totally nuts :)
>
> Based on what you said earlier:
>
>  > sending commands to dhcpcd process
>  > ps_seccomp_violation: unexpected syscall 41 (arch=0xc000003e)
>
> That looks like you're controlling a running instance.
> Can we try killing that and trying the git head as a fresh instance?
>
>
> rm /var/log/dhcpcd.log
> cd /path/to/dhcpcd/git/src
> ./dhcpcd -dB --logfile /var/log/dhcpcd.log
>
> Then email the logfile as an attachment.
>
> Roy

Sorry, ignore everything I said earlier. That was a user error. I was
running the wrong dhcpcd binary (aka the working one) through strace!
Okay attached is the actual strace output you probably wanted and I see
syscall errors in there again. Apologize for the detour there.

execve("./dhcpcd", ["./dhcpcd", "-M", "-B"], 0x7ffdadf66e50 /* 14 vars */) = 0
brk(NULL)                               = 0x55ea436fe000
arch_prctl(0x3001 /* ARCH_??? */, 0x7ffcf30a4b10) = -1 EINVAL (Invalid argument)
access("/etc/ld.so.preload", R_OK)      = -1 ENOENT (No such file or directory)
openat(AT_FDCWD, "/etc/ld.so.cache", O_RDONLY|O_CLOEXEC) = 3
fstat(3, {st_mode=S_IFREG|0644, st_size=159455, ...}) = 0
mmap(NULL, 159455, PROT_READ, MAP_PRIVATE, 3, 0) = 0x7ffa4f792000
close(3)                                = 0
openat(AT_FDCWD, "/usr/lib/libdl.so.2", O_RDONLY|O_CLOEXEC) = 3
read(3, "\177ELF\2\1\1\0\0\0\0\0\0\0\0\0\3\0>\0\1\0\0\0\20\22\0\0\0\0\0\0"..., 832) = 832
fstat(3, {st_mode=S_IFREG|0755, st_size=18608, ...}) = 0
mmap(NULL, 8192, PROT_READ|PROT_WRITE, MAP_PRIVATE|MAP_ANONYMOUS, -1, 0) = 0x7ffa4f790000
mmap(NULL, 20624, PROT_READ, MAP_PRIVATE|MAP_DENYWRITE, 3, 0) = 0x7ffa4f78a000
mmap(0x7ffa4f78b000, 8192, PROT_READ|PROT_EXEC, MAP_PRIVATE|MAP_FIXED|MAP_DENYWRITE, 3, 0x1000) = 0x7ffa4f78b000
mmap(0x7ffa4f78d000, 4096, PROT_READ, MAP_PRIVATE|MAP_FIXED|MAP_DENYWRITE, 3, 0x3000) = 0x7ffa4f78d000
mmap(0x7ffa4f78e000, 8192, PROT_READ|PROT_WRITE, MAP_PRIVATE|MAP_FIXED|MAP_DENYWRITE, 3, 0x3000) = 0x7ffa4f78e000
close(3)                                = 0
openat(AT_FDCWD, "/usr/lib/libc.so.6", O_RDONLY|O_CLOEXEC) = 3
read(3, "\177ELF\2\1\1\3\0\0\0\0\0\0\0\0\3\0>\0\1\0\0\0\220\202\2\0\0\0\0\0"..., 832) = 832
pread64(3, "\6\0\0\0\4\0\0\0@\0\0\0\0\0\0\0@\0\0\0\0\0\0\0@\0\0\0\0\0\0\0"..., 784, 64) = 784
pread64(3, "\4\0\0\0\20\0\0\0\5\0\0\0GNU\0\2\0\0\300\4\0\0\0\3\0\0\0\0\0\0\0", 32, 848) = 32
pread64(3, "\4\0\0\0\24\0\0\0\3\0\0\0GNU\0\207\360\21\247\344\314?\306\nT\320\323\335i\16t"..., 68, 880) = 68
fstat(3, {st_mode=S_IFREG|0755, st_size=2159552, ...}) = 0
pread64(3, "\6\0\0\0\4\0\0\0@\0\0\0\0\0\0\0@\0\0\0\0\0\0\0@\0\0\0\0\0\0\0"..., 784, 64) = 784
mmap(NULL, 1868448, PROT_READ, MAP_PRIVATE|MAP_DENYWRITE, 3, 0) = 0x7ffa4f5c1000
mmap(0x7ffa4f5e7000, 1363968, PROT_READ|PROT_EXEC, MAP_PRIVATE|MAP_FIXED|MAP_DENYWRITE, 3, 0x26000) = 0x7ffa4f5e7000
mmap(0x7ffa4f734000, 311296, PROT_READ, MAP_PRIVATE|MAP_FIXED|MAP_DENYWRITE, 3, 0x173000) = 0x7ffa4f734000
mmap(0x7ffa4f780000, 24576, PROT_READ|PROT_WRITE, MAP_PRIVATE|MAP_FIXED|MAP_DENYWRITE, 3, 0x1be000) = 0x7ffa4f780000
mmap(0x7ffa4f786000, 12960, PROT_READ|PROT_WRITE, MAP_PRIVATE|MAP_FIXED|MAP_ANONYMOUS, -1, 0) = 0x7ffa4f786000
close(3)                                = 0
mmap(NULL, 12288, PROT_READ|PROT_WRITE, MAP_PRIVATE|MAP_ANONYMOUS, -1, 0) = 0x7ffa4f5be000
arch_prctl(ARCH_SET_FS, 0x7ffa4f5be740) = 0
mprotect(0x7ffa4f780000, 12288, PROT_READ) = 0
mprotect(0x7ffa4f78e000, 4096, PROT_READ) = 0
mprotect(0x55ea428ed000, 8192, PROT_READ) = 0
mprotect(0x7ffa4f7e5000, 4096, PROT_READ) = 0
munmap(0x7ffa4f792000, 159455)          = 0
brk(NULL)                               = 0x55ea436fe000
brk(0x55ea4371f000)                     = 0x55ea4371f000
fcntl(0, F_GETFD)                       = 0
fcntl(1, F_GETFD)                       = 0
fcntl(2, F_GETFD)                       = 0
openat(AT_FDCWD, "/etc/localtime", O_RDONLY|O_CLOEXEC) = 3
fstat(3, {st_mode=S_IFREG|0644, st_size=3576, ...}) = 0
fstat(3, {st_mode=S_IFREG|0644, st_size=3576, ...}) = 0
read(3, "TZif2\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\7\0\0\0\7\0\0\0\0"..., 4096) = 3576
lseek(3, -2272, SEEK_CUR)               = 1304
read(3, "TZif2\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\7\0\0\0\7\0\0\0\0"..., 4096) = 2272
close(3)                                = 0
socket(AF_UNIX, SOCK_DGRAM|SOCK_CLOEXEC, 0) = 3
connect(3, {sa_family=AF_UNIX, sun_path="/dev/log"}, 110) = -1 ENOENT (No such file or directory)
close(3)                                = 0
socket(AF_INET, SOCK_DGRAM, IPPROTO_IP) = 3
close(3)                                = 0
socket(AF_INET6, SOCK_DGRAM, IPPROTO_IP) = 3
close(3)                                = 0
openat(AT_FDCWD, "/etc/dhcpcd.conf", O_RDONLY) = 3
read(3, "# A sample configuration for dhc"..., 65536) = 1438
close(3)                                = 0
stat("/etc/dhcpcd.conf", {st_mode=S_IFREG|0644, st_size=1438, ...}) = 0
chdir("/")                              = 0
rt_sigaction(SIGPIPE, {sa_handler=SIG_IGN, sa_mask=[PIPE], sa_flags=SA_RESTORER|SA_RESTART, sa_restorer=0x7ffa4f5fe6a0}, {sa_handler=SIG_DFL, sa_mask=[], sa_flags=0}, 8) = 0
rt_sigprocmask(SIG_SETMASK, [HUP INT USR1 USR2 ALRM TERM CHLD], [], 8) = 0
rt_sigaction(SIGTERM, {sa_handler=0x55ea428a3420, sa_mask=[], sa_flags=SA_RESTORER|SA_SIGINFO, sa_restorer=0x7ffa4f5fe6a0}, NULL, 8) = 0
rt_sigaction(SIGINT, {sa_handler=0x55ea428a3420, sa_mask=[], sa_flags=SA_RESTORER|SA_SIGINFO, sa_restorer=0x7ffa4f5fe6a0}, NULL, 8) = 0
rt_sigaction(SIGALRM, {sa_handler=0x55ea428a3420, sa_mask=[], sa_flags=SA_RESTORER|SA_SIGINFO, sa_restorer=0x7ffa4f5fe6a0}, NULL, 8) = 0
rt_sigaction(SIGHUP, {sa_handler=0x55ea428a3420, sa_mask=[], sa_flags=SA_RESTORER|SA_SIGINFO, sa_restorer=0x7ffa4f5fe6a0}, NULL, 8) = 0
rt_sigaction(SIGUSR1, {sa_handler=0x55ea428a3420, sa_mask=[], sa_flags=SA_RESTORER|SA_SIGINFO, sa_restorer=0x7ffa4f5fe6a0}, NULL, 8) = 0
rt_sigaction(SIGUSR2, {sa_handler=0x55ea428a3420, sa_mask=[], sa_flags=SA_RESTORER|SA_SIGINFO, sa_restorer=0x7ffa4f5fe6a0}, NULL, 8) = 0
rt_sigaction(SIGCHLD, {sa_handler=0x55ea428a3420, sa_mask=[], sa_flags=SA_RESTORER|SA_SIGINFO, sa_restorer=0x7ffa4f5fe6a0}, NULL, 8) = 0
socket(AF_UNIX, SOCK_STREAM|SOCK_CLOEXEC|SOCK_NONBLOCK, 0) = 3
connect(3, {sa_family=AF_UNIX, sun_path="/var/run/nscd/socket"}, 110) = -1 ENOENT (No such file or directory)
close(3)                                = 0
socket(AF_UNIX, SOCK_STREAM|SOCK_CLOEXEC|SOCK_NONBLOCK, 0) = 3
connect(3, {sa_family=AF_UNIX, sun_path="/var/run/nscd/socket"}, 110) = -1 ENOENT (No such file or directory)
close(3)                                = 0
openat(AT_FDCWD, "/etc/nsswitch.conf", O_RDONLY|O_CLOEXEC) = 3
fstat(3, {st_mode=S_IFREG|0644, st_size=274, ...}) = 0
read(3, "# Name Service Switch configurat"..., 4096) = 274
read(3, "", 4096)                       = 0
close(3)                                = 0
openat(AT_FDCWD, "/etc/ld.so.cache", O_RDONLY|O_CLOEXEC) = 3
fstat(3, {st_mode=S_IFREG|0644, st_size=159455, ...}) = 0
mmap(NULL, 159455, PROT_READ, MAP_PRIVATE, 3, 0) = 0x7ffa4f792000
close(3)                                = 0
openat(AT_FDCWD, "/usr/lib/libnss_files.so.2", O_RDONLY|O_CLOEXEC) = 3
read(3, "\177ELF\2\1\1\0\0\0\0\0\0\0\0\0\3\0>\0\1\0\0\0P5\0\0\0\0\0\0"..., 832) = 832
fstat(3, {st_mode=S_IFREG|0755, st_size=51376, ...}) = 0
mmap(NULL, 79320, PROT_READ, MAP_PRIVATE|MAP_DENYWRITE, 3, 0) = 0x7ffa4f5aa000
mmap(0x7ffa4f5ad000, 28672, PROT_READ|PROT_EXEC, MAP_PRIVATE|MAP_FIXED|MAP_DENYWRITE, 3, 0x3000) = 0x7ffa4f5ad000
mmap(0x7ffa4f5b4000, 8192, PROT_READ, MAP_PRIVATE|MAP_FIXED|MAP_DENYWRITE, 3, 0xa000) = 0x7ffa4f5b4000
mmap(0x7ffa4f5b6000, 8192, PROT_READ|PROT_WRITE, MAP_PRIVATE|MAP_FIXED|MAP_DENYWRITE, 3, 0xb000) = 0x7ffa4f5b6000
mmap(0x7ffa4f5b8000, 21976, PROT_READ|PROT_WRITE, MAP_PRIVATE|MAP_FIXED|MAP_ANONYMOUS, -1, 0) = 0x7ffa4f5b8000
close(3)                                = 0
mprotect(0x7ffa4f5b6000, 4096, PROT_READ) = 0
munmap(0x7ffa4f792000, 159455)          = 0
openat(AT_FDCWD, "/etc/passwd", O_RDONLY|O_CLOEXEC) = 3
fstat(3, {st_mode=S_IFREG|0644, st_size=1904, ...}) = 0
lseek(3, 0, SEEK_SET)                   = 0
read(3, "root:x:0:0:root:/root:/bin/bash\n"..., 4096) = 1904
close(3)                                = 0
stat("/var/lib/dhcpcd", {st_mode=S_IFDIR|0700, st_size=4096, ...}) = 0
socket(AF_UNIX, SOCK_STREAM|SOCK_CLOEXEC|SOCK_NONBLOCK, 0) = 3
connect(3, {sa_family=AF_UNIX, sun_path="/run/dhcpcd/sock"}, 18) = -1 ECONNREFUSED (Connection refused)
close(3)                                = 0
write(2, "main: control_open: Connection r"..., 39main: control_open: Connection refused
) = 39
getpid()                                = 2804
socket(AF_UNIX, SOCK_DGRAM|SOCK_CLOEXEC, 0) = 3
connect(3, {sa_family=AF_UNIX, sun_path="/dev/log"}, 110) = -1 ENOENT (No such file or directory)
close(3)                                = 0
mkdir("/var/lib/dhcpcd", 0750)          = -1 EEXIST (File exists)
mkdir("/run/dhcpcd", 0755)              = -1 EEXIST (File exists)
openat(AT_FDCWD, "/run/dhcpcd/pid", O_WRONLY|O_CREAT|O_NONBLOCK|O_CLOEXEC, 0644) = 3
flock(3, LOCK_EX|LOCK_NB)               = 0
getpid()                                = 2804
ftruncate(3, 0)                         = 0
lseek(3, 0, SEEK_SET)                   = 0
fstat(3, {st_mode=S_IFREG|0644, st_size=0, ...}) = 0
lseek(3, 0, SEEK_CUR)                   = 0
write(3, "2804\n", 5)                   = 5
write(2, "dhcpcd-9.3.1 starting\n", 22dhcpcd-9.3.1 starting
) = 22
getpid()                                = 2804
socket(AF_UNIX, SOCK_DGRAM|SOCK_CLOEXEC, 0) = 4
connect(4, {sa_family=AF_UNIX, sun_path="/dev/log"}, 110) = -1 ENOENT (No such file or directory)
close(4)                                = 0
openat(AT_FDCWD, "/dev/null", O_WRONLY|O_CREAT|O_TRUNC, 0666) = 4
dup3(4, 0, 0)                           = 0
close(4)                                = 0
socketpair(AF_UNIX, SOCK_DGRAM|SOCK_CLOEXEC|SOCK_NONBLOCK, 0, [4, 5]) = 0
socketpair(AF_UNIX, SOCK_DGRAM|SOCK_CLOEXEC|SOCK_NONBLOCK, 0, [6, 7]) = 0
clone(child_stack=NULL, flags=CLONE_CHILD_CLEARTID|CLONE_CHILD_SETTID|SIGCHLD, child_tidptr=0x7ffa4f5bea10) = 2805
close(5)                                = 0
close(7)                                = 0
chroot("/var/lib/dhcpcd")               = 0
chdir("/")                              = 0
setgroups(1, [986])                     = 0
setgid(986)                             = 0
setuid(986)                             = 0
getpid()                                = 2804
prlimit64(0, RLIMIT_NOFILE, {rlim_cur=3, rlim_max=3}, NULL) = 0
ioctl(2, TCGETS, 0x7ffcf30a4510)        = -1 ENOTTY (Inappropriate ioctl for device)
prlimit64(0, RLIMIT_NPROC, {rlim_cur=0, rlim_max=0}, NULL) = 0
rt_sigaction(SIGSYS, {sa_handler=0x55ea428d5250, sa_mask=[], sa_flags=SA_RESTORER|SA_SIGINFO, sa_restorer=0x7ffa4f5fe6a0}, NULL, 8) = 0
rt_sigprocmask(SIG_UNBLOCK, [SYS], NULL, 8) = 0
prctl(PR_SET_NO_NEW_PRIVS, 1, 0, 0, 0)  = 0
prctl(PR_SET_SECCOMP, SECCOMP_MODE_FILTER, {len=92, filter=0x55ea428f1520}) = 0
ppoll([{fd=6, events=POLLIN}, {fd=4, events=POLLIN}], 2, NULL, [], 8) = 1 ([{fd=6, revents=POLLIN}])
read(6, "dhcp6_openudp: Address already i"..., 8192) = 38
write(2, "dhcp6_openudp: Address already i"..., 38dhcp6_openudp: Address already in use
) = 38
ppoll([{fd=6, events=POLLIN}, {fd=4, events=POLLIN}], 2, NULL, [], 8) = 1 ([{fd=6, revents=POLLIN}])
read(6, "ps_inet_startcb: dhcp6_open: Add"..., 8192) = 52
write(2, "ps_inet_startcb: dhcp6_open: Add"..., 52ps_inet_startcb: dhcp6_open: Address already in use
) = 52
ppoll([{fd=6, events=POLLIN}, {fd=4, events=POLLIN}], 2, NULL, [], 8) = 1 ([{fd=6, revents=POLLIN}])
read(6, "dev: loaded udev\n", 8192)     = 17
write(2, "dev: loaded udev\n", 17dev: loaded udev
)      = 17
ppoll([{fd=6, events=POLLIN}, {fd=4, events=POLLIN}], 2, NULL, [], 8) = 1 ([{fd=6, revents=POLLIN}])
read(6, "DUID 00:01:00:01:22:2a:0f:14:74:"..., 8192) = 47
write(2, "DUID 00:01:00:01:22:2a:0f:14:74:"..., 47DUID 00:01:00:01:22:2a:0f:14:74:e5:0b:a1:b2:90
) = 47
ppoll([{fd=6, events=POLLIN}, {fd=4, events=POLLIN}], 2, NULL, [], 8) = ? ERESTARTNOHAND (To be restarted if no handler)
--- SIGCHLD {si_signo=SIGCHLD, si_code=CLD_EXITED, si_pid=2805, si_uid=0, si_status=0, si_utime=0, si_stime=0} ---
rt_sigreturn({mask=[HUP INT USR1 USR2 ALRM TERM CHLD]}) = -1 EINTR (Interrupted system call)
wait4(-1, NULL, WNOHANG, NULL)          = 2805
wait4(-1, NULL, WNOHANG, NULL)          = -1 ECHILD (No child processes)
ppoll([{fd=6, events=POLLIN}, {fd=4, events=POLLIN}], 2, NULL, [], 8) = 1 ([{fd=6, revents=POLLIN}])
read(6, "no interfaces have a carrier\n", 8192) = 29
write(2, "no interfaces have a carrier\n", 29no interfaces have a carrier
) = 29
ppoll([{fd=6, events=POLLIN}, {fd=4, events=POLLIN}], 2, NULL, [], 8) = 1 ([{fd=6, revents=POLLIN}])
read(6, "ps_seccomp_violation: unexpected"..., 8192) = 62
write(2, "ps_seccomp_violation: unexpected"..., 62ps_seccomp_violation: unexpected syscall 41 (arch=0xc000003e)
) = 62
ppoll([{fd=6, events=POLLIN}, {fd=4, events=POLLIN}], 2, NULL, [], 8) = 1 ([{fd=6, revents=POLLIN}])
read(6, "ps_ctl_listen: read: Success\n", 8192) = 29
write(2, "ps_ctl_listen: read: Success\n", 29ps_ctl_listen: read: Success
) = 29
ppoll([{fd=6, events=POLLIN}, {fd=4, events=POLLIN}], 2, NULL, [], 8) = 1 ([{fd=6, revents=POLLIN}])
read(6, "ps_seccomp_violation: unexpected"..., 8192) = 62
write(2, "ps_seccomp_violation: unexpected"..., 62ps_seccomp_violation: unexpected syscall 41 (arch=0xc000003e)
) = 62
ppoll([{fd=6, events=POLLIN}, {fd=4, events=POLLIN}], 2, NULL, [], 8) = ? ERESTARTNOHAND (To be restarted if no handler)
strace: Process 2804 detached
dhcpcd_signal_cb: write: Connection refused
ps_seccomp_violation: unexpected syscall 41 (arch=0xc000003e)