Candump dont show delta #469

Kuzma30 · 2023-10-17T09:45:13Z

My system is CM4 with MCP2515.
Linux b2qt-raspberrypi4 6.1.54-rt15-v7l #1 SMP PREEMPT_RT Wed Sep 20 14:13:53 UTC 2023 armv7l GNU/Linux
Example of my log. (with -t delta option it show 0)
candump -t a -a can0

 (1697535023.000000)  can0  18EF8382   [7]  01 11 00 00 00 80 4F      '......O'
 (1697535023.000000)  can0  18EF8382   [7]  01 12 00 00 00 80 4F      '......O'
 (1697535023.000000)  can0  18EF8382   [7]  01 13 00 00 00 80 4F      '......O'
 (1697535023.000000)  can0  18EF8382   [7]  01 14 00 00 00 80 4F      '......O'
 (1697535023.000000)  can0  18EF8382   [7]  01 15 00 00 00 80 4F      '......O'
 (1697535023.000000)  can0  18EF8382   [7]  01 16 00 00 00 80 4F      '......O'
 (1697535023.000000)  can0  18EF8382   [7]  01 17 00 00 00 80 4F      '......O'
 (1697535023.000000)  can0  18EF8382   [7]  01 18 00 00 00 80 4F      '......O'
 (1697535023.000000)  can0  18EF8382   [7]  01 91 00 00 00 00 00      '.......'

But in real packet receive with delays. And I want to measure it. Such error I start receive after system update.

The text was updated successfully, but these errors were encountered:

marckleinebudde · 2023-10-17T09:51:00Z

What was your previous kernel version?

Kuzma30 · 2023-10-17T10:29:55Z

6.1.28

marckleinebudde · 2023-10-17T10:47:58Z

There was no change in the mcp251x driver between these 2 kernel versions.

hartkopp · 2023-10-17T14:11:25Z

Can you try to set arm_64bit=0 in config.txt if this changes the behaviour?

hardbyte/python-can#1652 (comment)

Kuzma30 · 2023-10-17T15:56:11Z

do not help

hartkopp · 2023-10-17T16:19:14Z

As you are using a RealTime kernel (b2qt-raspberrypi4 6.1.54-rt15-v7l) ... is it possible that the RT kernel has another timer infrastructure, that does not provide the former syscall interface candumpis using?

This is a really weird behaviour.

Maybe uninstalling the can-utils with apt remove can-utils and build your own binaries from this repository is an approach.

Kuzma30 · 2023-10-19T07:16:24Z

I check with latest non-RT Rasbain 32-bit on Rpi4b. candump works fine (show delta).

marckleinebudde · 2023-10-19T07:21:46Z

b2qt-raspberrypi4 6.1.54-rt15-v7l looks like 32 bit, as well.

marckleinebudde · 2023-10-19T07:22:40Z

can you only update the kernel to b2qt-raspberrypi4 6.1.54-rt15-v7l keeping the same root file system?

Kuzma30 · 2023-10-19T08:08:59Z

b2qt is Yocto based distro.
I rebuild my image without RT-patch and get same results - no delta info.
Linux b2qt-raspberrypi4 6.1.54-v7l #1 SMP PREEMPT Wed Sep 20 14:13:53 UTC 2023 armv7l GNU/Linux

I use custom config for kernel. What options I must check in kernel. (Or I can upload my current config)

marckleinebudde · 2023-10-19T08:22:12Z

Can you compile 2qt-raspberrypi4 6.1.54-v7l with the problematic config and install it on the raspian image?

Kuzma30 · 2023-10-19T08:32:47Z

This can be problematic(

marckleinebudde · 2023-10-19T08:56:12Z

Another option is to make sure, that you are using the latest can-utils in your yocto system.

Kuzma30 · 2023-10-19T09:20:54Z

I use can-utils with SRCREV = "41ea759237bbd156d753251c573c280d96873528" as latest commit to build.

Kuzma30 · 2023-10-19T10:14:33Z

I make small patch to output debug info

diff --git a/candump.c b/candump.c
index 8e4444f..680dd60 100644
--- a/candump.c
+++ b/candump.c
@@ -766,6 +766,7 @@ int main(int argc, char **argv)
                                         */
                                        tv.tv_sec = stamp[2].tv_sec;
                                        tv.tv_usec = stamp[2].tv_nsec / 1000;
+                                       fprintf(stdout,"stamp[0].tv_nsec = %lld\nstamp[1].tv_nsec = %lld\n nstamp[2].tv_nsec = %lld\n", stamp[0].tv_nsec,stamp[1].tv_nsec,stamp[2].tv_nsec);
                                } else if (cmsg->cmsg_type == SO_RXQ_OVFL) {
                                        memcpy(&obj->dropcnt, CMSG_DATA(cmsg), sizeof(__u32));
                                }

When I run
candump -t delta -H can0
I see such log

 (000.000000)  can0  18EF83EF   [7]  01 36 00 00 00 00 00
stamp[0].tv_nsec = 276327893
stamp[1].tv_nsec = 0
 nstamp[2].tv_nsec = 0
 (000.000000)  can0  18EF83EF   [7]  01 37 00 00 00 00 00
stamp[0].tv_nsec = 277147204
stamp[1].tv_nsec = 0
 nstamp[2].tv_nsec = 0
 (000.000000)  can0  18EF83EF   [7]  01 61 00 BA A8 FF 3F
stamp[0].tv_nsec = 278121161
stamp[1].tv_nsec = 0
 nstamp[2].tv_nsec = 0
 (000.000000)  can0  18EF83EF   [7]  01 52 00 B1 68 DB 41
stamp[0].tv_nsec = 279125952
stamp[1].tv_nsec = 0
 nstamp[2].tv_nsec = 0
 (000.000000)  can0  18EF83EF   [7]  01 64 00 8F 39 19 40
stamp[0].tv_nsec = 280117373
stamp[1].tv_nsec = 0
 nstamp[2].tv_nsec = 0
 (000.000000)  can0  18EF83EF   [7]  01 53 00 8F 39 19 40
stamp[0].tv_nsec = 281221274
stamp[1].tv_nsec = 0
 nstamp[2].tv_nsec = 0
 (000.000000)  can0  18EF83EF   [7]  01 71 00 66 C6 C3 42
stamp[0].tv_nsec = 282229417
stamp[1].tv_nsec = 0
 nstamp[2].tv_nsec = 0
 (000.000000)  can0  18EF83EF   [7]  01 78 00 00 00 00 00
stamp[0].tv_nsec = 283140856
stamp[1].tv_nsec = 0
 nstamp[2].tv_nsec = 0
 (000.000000)  can0  18EF83EF   [7]  01 74 00 00 00 00 00
stamp[0].tv_nsec = 284144610
stamp[1].tv_nsec = 0
 nstamp[2].tv_nsec = 0
 (000.000000)  can0  18EF83EF   [7]  01 83 00 00 00 00 00

May be this will be usefull

marckleinebudde · 2023-10-19T10:36:33Z

The driver doesn't support hardware timestamps. This is why you get (000.000000) as the delta timestamp if you start with the -H option.

marckleinebudde · 2023-10-19T10:41:17Z

stamp[0].tv_nsec = 276327893
stamp[0].tv_nsec = 277147204
stamp[0].tv_nsec = 278121161
stamp[0].tv_nsec = 279125952
stamp[0].tv_nsec = 280117373
stamp[0].tv_nsec = 281221274
stamp[0].tv_nsec = 282229417
stamp[0].tv_nsec = 283140856
stamp[0].tv_nsec = 284144610

What's the supposed delay between 2 CAN frames?

Kuzma30 · 2023-10-19T10:54:47Z

Delay - 1 ms.
When I run without -H option I get 0 in delta

candump -t delta can0
 (000.000000)  can0  18EF8283   [3]  03 FF 00
 (000.000000)  can0  18EF8382   [7]  01 11 00 00 00 80 4F
 (000.000000)  can0  18EF8382   [7]  01 12 00 00 00 80 4F
 (000.000000)  can0  18EF8382   [7]  01 13 00 00 00 80 4F
 (000.000000)  can0  18EF8382   [7]  01 14 00 00 00 80 4F
 (000.000000)  can0  18EF8382   [7]  01 15 00 00 00 80 4F
 (000.000000)  can0  18EF8382   [7]  01 16 00 00 00 80 4F
 (000.000000)  can0  18EF8382   [7]  01 17 00 00 00 80 4F
 (000.000000)  can0  18EF8382   [7]  01 18 00 00 00 80 4F
 (000.000000)  can0  18EF8382   [7]  01 91 00 00 00 00 00
 (000.000000)  can0  18EFEF83   [3]  03 00 00

marckleinebudde · 2023-10-19T11:04:03Z

Can you re-run with your debug output enabled?

Kuzma30 · 2023-10-19T11:10:12Z

#469 (comment)
Logs from here is with debug output enabled.
Additional log out only show with -H option

marckleinebudde · 2023-10-19T11:22:04Z

Please run strace -o /tmp/log ./candump any,0:0,#FFFFFFFF -cexdtA and send me the log output, it's in /tmp/log.

Kuzma30 · 2023-10-19T11:32:34Z

strace -o /tmp/log candump any,0:0,#FFFFFFFF -cexdtA
 (2023-10-19 11:31:44.4294967295)  can0  TX - -  18EF8183   [3]  03 FF 00
 (2023-10-19 11:31:44.3068705531)  can0  RX - -  18EF8381   [7]  01 11 00 00 00 80 4F
 (2023-10-19 11:31:44.3068705531)  can0  RX - -  18EF8381   [7]  01 12 00 00 00 80 4F
 (2023-10-19 11:31:44.3068705531)  can0  RX - -  18EF8381   [7]  01 13 00 00 00 80 4F
 (2023-10-19 11:31:44.3068705531)  can0  RX - -  18EF8381   [7]  01 14 00 00 00 80 4F
 (2023-10-19 11:31:44.3068705531)  can0  RX - -  18EF8381   [7]  01 15 00 00 00 80 4F
 (2023-10-19 11:31:44.3068705531)  can0  RX - -  18EF8381   [7]  01 16 00 00 00 80 4F
 (2023-10-19 11:31:44.3068705531)  can0  RX - -  18EF8381   [7]  01 17 00 00 00 80 4F
 (2023-10-19 11:31:44.3068705531)  can0  RX - -  18EF8381   [7]  01 18 00 00 00 80 4F
 (2023-10-19 11:31:44.3068705531)  can0  RX - -  18EF8381   [7]  01 91 00 00 00 00 00
 (2023-10-19 11:31:44.3068705531)  can0  TX - -  18EF8483   [3]  03 FF 00
 (2023-10-19 11:31:44.3068705531)  can0  RX - -  18EF8384   [7]  01 11 00 00 00 80 4F
 (2023-10-19 11:31:44.3068705531)  can0  RX - -  18EF8384   [7]  01 12 00 00 00 80 4F
 (2023-10-19 11:31:44.3068705531)  can0  RX - -  18EF8384   [7]  01 13 00 00 00 80 4F
 (2023-10-19 11:31:44.3068705531)  can0  RX - -  18EF8384   [7]  01 14 00 00 00 80 4F
 (2023-10-19 11:31:44.3068705531)  can0  RX - -  18EF8384   [7]  01 15 00 00 00 80 4F
 (2023-10-19 11:31:44.3068705531)  can0  RX - -  18EF8384   [7]  01 16 00 00 00 80 4F
 (2023-10-19 11:31:44.3068705531)  can0  RX - -  18EF8384   [7]  01 17 00 00 00 80 4F
 (2023-10-19 11:31:44.3068705531)  can0  RX - -  18EF8384   [7]  01 18 00 00 00 80 4F
 (2023-10-19 11:31:44.3068705531)  can0  RX - -  18EF8384   [7]  01 91 00 00 00 00 00
 (2023-10-19 11:31:44.3068705531)  can0  TX - -  18EF8283   [3]  03 FF 00
 (2023-10-19 11:31:44.3068705531)  can0  RX - -  18EF8382   [7]  01 11 00 00 00 80 4F
 (2023-10-19 11:31:44.3068705531)  can0  RX - -  18EF8382   [7]  01 12 00 00 00 80 4F
 (2023-10-19 11:31:44.3068705531)  can0  RX - -  18EF8382   [7]  01 13 00 00 00 80 4F
 (2023-10-19 11:31:44.3068705531)  can0  RX - -  18EF8382   [7]  01 14 00 00 00 80 4F
 (2023-10-19 11:31:44.3068705531)  can0  RX - -  18EF8382   [7]  01 15 00 00 00 80 4F
 (2023-10-19 11:31:44.3068705531)  can0  RX - -  18EF8382   [7]  01 16 00 00 00 80 4F
 (2023-10-19 11:31:44.3068705531)  can0  RX - -  18EF8382   [7]  01 17 00 00 00 80 4F
 (2023-10-19 11:31:44.3068705531)  can0  RX - -  18EF8382   [7]  01 18 00 00 00 80 4F
 (2023-10-19 11:31:44.3068705531)  can0  RX - -  18EF8382   [7]  01 91 00 00 00 00 00
 (2023-10-19 11:31:44.3068705531)  can0  TX - -  18EFEF83   [3]  03 00 00
 (2023-10-19 11:31:44.3068705531)  can0  RX - -  18EF83EF   [7]  01 35 00 BB BD BF 40
 (2023-10-19 11:31:44.3068705531)  can0  RX - -  18EF83EF   [7]  01 36 00 00 00 00 00
 (2023-10-19 11:31:44.3068705531)  can0  RX - -  18EF83EF   [7]  01 37 00 00 00 00 00
 (2023-10-19 11:31:44.3068705531)  can0  RX - -  18EF83EF   [7]  01 61 00 A4 A7 FF 3F
 (2023-10-19 11:31:44.3068705531)  can0  RX - -  18EF83EF   [7]  01 52 00 2F 18 0D 42
 (2023-10-19 11:31:44.3068705531)  can0  RX - -  18EF83EF   [7]  01 64 00 8F 39 19 40
 (2023-10-19 11:31:44.3068705531)  can0  RX - -  18EF83EF   [7]  01 53 00 8F 39 19 40
 (2023-10-19 11:31:44.3068705531)  can0  RX - -  18EF83EF   [7]  01 71 00 66 C6 C3 42
 (2023-10-19 11:31:44.3068705531)  can0  RX - -  18EF83EF   [7]  01 78 00 00 00 00 00
 (2023-10-19 11:31:44.3068705531)  can0  RX - -  18EF83EF   [7]  01 74 00 00 00 00 00
 (2023-10-19 11:31:44.3068705531)  can0  RX - -  18EF83EF   [7]  01 83 00 00 00 00 00
^Croot@b2qt-raspberrypi4:~cat /tmp/log
execve("/usr/bin/candump", ["candump", "any,0:0,#FFFFFFFF", "-cexdtA"], 0xbef47d00 /* 17 vars */) = 0
brk(NULL)                               = 0x223a000
mmap2(NULL, 8192, PROT_READ|PROT_WRITE, MAP_PRIVATE|MAP_ANONYMOUS, -1, 0) = 0xb6f62000
access("/etc/ld.so.preload", R_OK)      = -1 ENOENT (No such file or directory)
openat(AT_FDCWD, "/etc/ld.so.cache", O_RDONLY|O_LARGEFILE|O_CLOEXEC) = 3
statx(3, "", AT_STATX_SYNC_AS_STAT|AT_NO_AUTOMOUNT|AT_EMPTY_PATH, STATX_BASIC_STATS, {stx_mask=STATX_BASIC_STATS|STATX_MNT_ID, stx_attributes=0, stx_mode=S_IFREG|0644, stx_size=31226, ...}) = 0
mmap2(NULL, 31226, PROT_READ, MAP_PRIVATE, 3, 0) = 0xb6f5a000
close(3)                                = 0
openat(AT_FDCWD, "/usr/lib/libc.so.6", O_RDONLY|O_LARGEFILE|O_CLOEXEC) = 3
read(3, "\177ELF\1\1\1\0\0\0\0\0\0\0\0\0\3\0(\0\1\0\0\0\271\346\1\0004\0\0\0"..., 512) = 512
statx(3, "", AT_STATX_SYNC_AS_STAT|AT_NO_AUTOMOUNT|AT_EMPTY_PATH, STATX_BASIC_STATS, {stx_mask=STATX_BASIC_STATS|STATX_MNT_ID, stx_attributes=0, stx_mode=S_IFREG|0755, stx_size=1146976, ...}) = 0
mmap2(NULL, 1184344, PROT_READ|PROT_EXEC, MAP_PRIVATE|MAP_DENYWRITE, 3, 0) = 0xb6e38000
mmap2(0xb6f35000, 110592, PROT_READ|PROT_WRITE, MAP_PRIVATE|MAP_FIXED|MAP_DENYWRITE, 3, 0xfc000) = 0xb6f35000
mmap2(0xb6f50000, 37464, PROT_READ|PROT_WRITE, MAP_PRIVATE|MAP_FIXED|MAP_ANONYMOUS, -1, 0) = 0xb6f50000
close(3)                                = 0
set_tls(0xb6f630a0)                     = 0
set_tid_address(0xb6f62c08)             = 20953
set_robust_list(0xb6f62c0c, 12)         = 0
rseq(0xb6f63080, 0x20, 0, 0xe7f5def3)   = 0
mprotect(0xb6f35000, 106496, PROT_READ) = 0
mprotect(0x4d6000, 4096, PROT_READ)     = 0
mprotect(0xb6f7f000, 8192, PROT_READ)   = 0
ugetrlimit(RLIMIT_STACK, {rlim_cur=8192*1024, rlim_max=RLIM_INFINITY}) = 0
munmap(0xb6f5a000, 31226)               = 0
rt_sigaction(SIGTERM, {sa_handler=0x4d305d, sa_mask=[TERM], sa_flags=SA_RESTORER|SA_RESTART, sa_restorer=0xb6e65031}, {sa_handler=SIG_DFL, sa_mask=[], sa_flags=0}, 8) = 0
rt_sigaction(SIGHUP, {sa_handler=0x4d305d, sa_mask=[HUP], sa_flags=SA_RESTORER|SA_RESTART, sa_restorer=0xb6e65031}, {sa_handler=SIG_DFL, sa_mask=[], sa_flags=0}, 8) = 0
rt_sigaction(SIGINT, {sa_handler=0x4d305d, sa_mask=[INT], sa_flags=SA_RESTORER|SA_RESTART, sa_restorer=0xb6e65031}, {sa_handler=SIG_DFL, sa_mask=[], sa_flags=0}, 8) = 0
epoll_create(1)                         = 3
socket(AF_CAN, SOCK_RAW, CAN_RAW)       = 4
epoll_ctl(3, EPOLL_CTL_ADD, 4, {events=EPOLLIN, data={u32=5075040, u64=5075040}}) = 0
getrandom("\xef\x44\x3b\xb3", 4, GRND_NONBLOCK) = 4
brk(NULL)                               = 0x223a000
brk(0x225b000)                          = 0x225b000
setsockopt(4, SOL_CAN_RAW, CAN_RAW_ERR_FILTER, [-1], 4) = 0
setsockopt(4, SOL_CAN_RAW, CAN_RAW_FILTER, "\0\0\0\0\0\0\0\0", 8) = 0
setsockopt(4, SOL_CAN_RAW, CAN_RAW_FD_FRAMES, [1], 4) = 0
setsockopt(4, SOL_SOCKET, SO_TIMESTAMP_NEW, [1], 4) = 0
setsockopt(4, SOL_SOCKET, SO_RXQ_OVFL, [1], 4) = 0
bind(4, {sa_family=AF_CAN, sa_data="\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0"}, 24) = 0
epoll_wait(3, [{events=EPOLLIN, data={u32=5075040, u64=5075040}}], 1, -1) = 1
recvmsg(4, {msg_name={sa_family=AF_CAN, sa_data="\0\0\2\0\0\0"}, msg_namelen=24 => 8, msg_iov=[{iov_base="\203\201\357\230\3\0\0\0\3\377\0\0\0\0\0\0", iov_len=72}], msg_iovlen=1, msg_control=[{cmsg_len=28, cmsg_level=SOL_SOCKET, cmsg_type=SO_TIMESTAMP_NEW, cmsg_data={tv_sec=1697715104, tv_usec=123196}}], msg_controllen=28, msg_flags=MSG_DONTROUTE}, 0) = 16
ioctl(4, SIOCGIFNAME, {ifr_ifindex=2, ifr_name="can0"}) = 0
statx(1, "", AT_STATX_SYNC_AS_STAT|AT_NO_AUTOMOUNT|AT_EMPTY_PATH, STATX_BASIC_STATS, {stx_mask=STATX_BASIC_STATS|STATX_MNT_ID, stx_attributes=0, stx_mode=S_IFCHR|0620, stx_size=0, ...}) = 0
openat(AT_FDCWD, "/etc/localtime", O_RDONLY|O_CLOEXEC) = 5
statx(5, "", AT_STATX_SYNC_AS_STAT|AT_NO_AUTOMOUNT|AT_EMPTY_PATH, STATX_BASIC_STATS, {stx_mask=STATX_BASIC_STATS|STATX_MNT_ID, stx_attributes=0, stx_mode=S_IFREG|0644, stx_size=111, ...}) = 0
statx(5, "", AT_STATX_SYNC_AS_STAT|AT_NO_AUTOMOUNT|AT_EMPTY_PATH, STATX_BASIC_STATS, {stx_mask=STATX_BASIC_STATS|STATX_MNT_ID, stx_attributes=0, stx_mode=S_IFREG|0644, stx_size=111, ...}) = 0
read(5, "TZif2\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0"..., 4096) = 111
_llseek(5, -60, [51], SEEK_CUR)         = 0
read(5, "TZif2\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0"..., 4096) = 60
close(5)                                = 0
write(1, " (2023-10-19 11:31:44.4294967295"..., 87) = 87
epoll_wait(3, [{events=EPOLLIN, data={u32=5075040, u64=5075040}}], 1, -1) = 1
recvmsg(4, {msg_name={sa_family=AF_CAN, sa_data="\0\0\2\0\0\0"}, msg_namelen=24 => 8, msg_iov=[{iov_base="\201\203\357\230\7\0\0\0\1\21\0\0\0\200O\0", iov_len=72}], msg_iovlen=1, msg_control=[{cmsg_len=28, cmsg_level=SOL_SOCKET, cmsg_type=SO_TIMESTAMP_NEW, cmsg_data={tv_sec=1697715104, tv_usec=123893}}], msg_controllen=28, msg_flags=0}, 0) = 16
statx(AT_FDCWD, "/etc/localtime", AT_STATX_SYNC_AS_STAT|AT_NO_AUTOMOUNT, STATX_BASIC_STATS, {stx_mask=STATX_BASIC_STATS|STATX_MNT_ID, stx_attributes=0, stx_mode=S_IFREG|0644, stx_size=111, ...}) = 0
write(1, " (2023-10-19 11:31:44.3068705531"..., 99) = 99
epoll_wait(3, [{events=EPOLLIN, data={u32=5075040, u64=5075040}}], 1, -1) = 1
recvmsg(4, {msg_name={sa_family=AF_CAN, sa_data="\0\0\2\0\0\0"}, msg_namelen=24 => 8, msg_iov=[{iov_base="\201\203\357\230\7\0\0\0\1\22\0\0\0\200O\0", iov_len=72}], msg_iovlen=1, msg_control=[{cmsg_len=28, cmsg_level=SOL_SOCKET, cmsg_type=SO_TIMESTAMP_NEW, cmsg_data={tv_sec=1697715104, tv_usec=124949}}], msg_controllen=28, msg_flags=0}, 0) = 16
statx(AT_FDCWD, "/etc/localtime", AT_STATX_SYNC_AS_STAT|AT_NO_AUTOMOUNT, STATX_BASIC_STATS, {stx_mask=STATX_BASIC_STATS|STATX_MNT_ID, stx_attributes=0, stx_mode=S_IFREG|0644, stx_size=111, ...}) = 0
write(1, " (2023-10-19 11:31:44.3068705531"..., 99) = 99
epoll_wait(3, [{events=EPOLLIN, data={u32=5075040, u64=5075040}}], 1, -1) = 1
recvmsg(4, {msg_name={sa_family=AF_CAN, sa_data="\0\0\2\0\0\0"}, msg_namelen=24 => 8, msg_iov=[{iov_base="\201\203\357\230\7\0\0\0\1\23\0\0\0\200O\0", iov_len=72}], msg_iovlen=1, msg_control=[{cmsg_len=28, cmsg_level=SOL_SOCKET, cmsg_type=SO_TIMESTAMP_NEW, cmsg_data={tv_sec=1697715104, tv_usec=125998}}], msg_controllen=28, msg_flags=0}, 0) = 16
statx(AT_FDCWD, "/etc/localtime", AT_STATX_SYNC_AS_STAT|AT_NO_AUTOMOUNT, STATX_BASIC_STATS, {stx_mask=STATX_BASIC_STATS|STATX_MNT_ID, stx_attributes=0, stx_mode=S_IFREG|0644, stx_size=111, ...}) = 0
write(1, " (2023-10-19 11:31:44.3068705531"..., 99) = 99
epoll_wait(3, [{events=EPOLLIN, data={u32=5075040, u64=5075040}}], 1, -1) = 1
recvmsg(4, {msg_name={sa_family=AF_CAN, sa_data="\0\0\2\0\0\0"}, msg_namelen=24 => 8, msg_iov=[{iov_base="\201\203\357\230\7\0\0\0\1\24\0\0\0\200O\0", iov_len=72}], msg_iovlen=1, msg_control=[{cmsg_len=28, cmsg_level=SOL_SOCKET, cmsg_type=SO_TIMESTAMP_NEW, cmsg_data={tv_sec=1697715104, tv_usec=127059}}], msg_controllen=28, msg_flags=0}, 0) = 16
statx(AT_FDCWD, "/etc/localtime", AT_STATX_SYNC_AS_STAT|AT_NO_AUTOMOUNT, STATX_BASIC_STATS, {stx_mask=STATX_BASIC_STATS|STATX_MNT_ID, stx_attributes=0, stx_mode=S_IFREG|0644, stx_size=111, ...}) = 0
write(1, " (2023-10-19 11:31:44.3068705531"..., 99) = 99
epoll_wait(3, [{events=EPOLLIN, data={u32=5075040, u64=5075040}}], 1, -1) = 1
recvmsg(4, {msg_name={sa_family=AF_CAN, sa_data="\0\0\2\0\0\0"}, msg_namelen=24 => 8, msg_iov=[{iov_base="\201\203\357\230\7\0\0\0\1\25\0\0\0\200O\0", iov_len=72}], msg_iovlen=1, msg_control=[{cmsg_len=28, cmsg_level=SOL_SOCKET, cmsg_type=SO_TIMESTAMP_NEW, cmsg_data={tv_sec=1697715104, tv_usec=128106}}], msg_controllen=28, msg_flags=0}, 0) = 16
statx(AT_FDCWD, "/etc/localtime", AT_STATX_SYNC_AS_STAT|AT_NO_AUTOMOUNT, STATX_BASIC_STATS, {stx_mask=STATX_BASIC_STATS|STATX_MNT_ID, stx_attributes=0, stx_mode=S_IFREG|0644, stx_size=111, ...}) = 0
write(1, " (2023-10-19 11:31:44.3068705531"..., 99) = 99
epoll_wait(3, [{events=EPOLLIN, data={u32=5075040, u64=5075040}}], 1, -1) = 1
recvmsg(4, {msg_name={sa_family=AF_CAN, sa_data="\0\0\2\0\0\0"}, msg_namelen=24 => 8, msg_iov=[{iov_base="\201\203\357\230\7\0\0\0\1\26\0\0\0\200O\0", iov_len=72}], msg_iovlen=1, msg_control=[{cmsg_len=28, cmsg_level=SOL_SOCKET, cmsg_type=SO_TIMESTAMP_NEW, cmsg_data={tv_sec=1697715104, tv_usec=129159}}], msg_controllen=28, msg_flags=0}, 0) = 16
statx(AT_FDCWD, "/etc/localtime", AT_STATX_SYNC_AS_STAT|AT_NO_AUTOMOUNT, STATX_BASIC_STATS, {stx_mask=STATX_BASIC_STATS|STATX_MNT_ID, stx_attributes=0, stx_mode=S_IFREG|0644, stx_size=111, ...}) = 0
write(1, " (2023-10-19 11:31:44.3068705531"..., 99) = 99
epoll_wait(3, [{events=EPOLLIN, data={u32=5075040, u64=5075040}}], 1, -1) = 1
recvmsg(4, {msg_name={sa_family=AF_CAN, sa_data="\0\0\2\0\0\0"}, msg_namelen=24 => 8, msg_iov=[{iov_base="\201\203\357\230\7\0\0\0\1\27\0\0\0\200O\0", iov_len=72}], msg_iovlen=1, msg_control=[{cmsg_len=28, cmsg_level=SOL_SOCKET, cmsg_type=SO_TIMESTAMP_NEW, cmsg_data={tv_sec=1697715104, tv_usec=130206}}], msg_controllen=28, msg_flags=0}, 0) = 16
statx(AT_FDCWD, "/etc/localtime", AT_STATX_SYNC_AS_STAT|AT_NO_AUTOMOUNT, STATX_BASIC_STATS, {stx_mask=STATX_BASIC_STATS|STATX_MNT_ID, stx_attributes=0, stx_mode=S_IFREG|0644, stx_size=111, ...}) = 0
write(1, " (2023-10-19 11:31:44.3068705531"..., 99) = 99
epoll_wait(3, [{events=EPOLLIN, data={u32=5075040, u64=5075040}}], 1, -1) = 1
recvmsg(4, {msg_name={sa_family=AF_CAN, sa_data="\0\0\2\0\0\0"}, msg_namelen=24 => 8, msg_iov=[{iov_base="\201\203\357\230\7\0\0\0\1\30\0\0\0\200O\0", iov_len=72}], msg_iovlen=1, msg_control=[{cmsg_len=28, cmsg_level=SOL_SOCKET, cmsg_type=SO_TIMESTAMP_NEW, cmsg_data={tv_sec=1697715104, tv_usec=131249}}], msg_controllen=28, msg_flags=0}, 0) = 16
statx(AT_FDCWD, "/etc/localtime", AT_STATX_SYNC_AS_STAT|AT_NO_AUTOMOUNT, STATX_BASIC_STATS, {stx_mask=STATX_BASIC_STATS|STATX_MNT_ID, stx_attributes=0, stx_mode=S_IFREG|0644, stx_size=111, ...}) = 0
write(1, " (2023-10-19 11:31:44.3068705531"..., 99) = 99
epoll_wait(3, [{events=EPOLLIN, data={u32=5075040, u64=5075040}}], 1, -1) = 1
recvmsg(4, {msg_name={sa_family=AF_CAN, sa_data="\0\0\2\0\0\0"}, msg_namelen=24 => 8, msg_iov=[{iov_base="\201\203\357\230\7\0\0\0\1\221\0\0\0\0\0\0", iov_len=72}], msg_iovlen=1, msg_control=[{cmsg_len=28, cmsg_level=SOL_SOCKET, cmsg_type=SO_TIMESTAMP_NEW, cmsg_data={tv_sec=1697715104, tv_usec=132310}}], msg_controllen=28, msg_flags=0}, 0) = 16
statx(AT_FDCWD, "/etc/localtime", AT_STATX_SYNC_AS_STAT|AT_NO_AUTOMOUNT, STATX_BASIC_STATS, {stx_mask=STATX_BASIC_STATS|STATX_MNT_ID, stx_attributes=0, stx_mode=S_IFREG|0644, stx_size=111, ...}) = 0
write(1, " (2023-10-19 11:31:44.3068705531"..., 99) = 99
epoll_wait(3, [{events=EPOLLIN, data={u32=5075040, u64=5075040}}], 1, -1) = 1
recvmsg(4, {msg_name={sa_family=AF_CAN, sa_data="\0\0\2\0\0\0"}, msg_namelen=24 => 8, msg_iov=[{iov_base="\203\204\357\230\3\0\0\0\3\377\0\0\0\0\0\0", iov_len=72}], msg_iovlen=1, msg_control=[{cmsg_len=28, cmsg_level=SOL_SOCKET, cmsg_type=SO_TIMESTAMP_NEW, cmsg_data={tv_sec=1697715104, tv_usec=173363}}], msg_controllen=28, msg_flags=MSG_DONTROUTE}, 0) = 16
statx(AT_FDCWD, "/etc/localtime", AT_STATX_SYNC_AS_STAT|AT_NO_AUTOMOUNT, STATX_BASIC_STATS, {stx_mask=STATX_BASIC_STATS|STATX_MNT_ID, stx_attributes=0, stx_mode=S_IFREG|0644, stx_size=111, ...}) = 0
write(1, " (2023-10-19 11:31:44.3068705531"..., 87) = 87
epoll_wait(3, [{events=EPOLLIN, data={u32=5075040, u64=5075040}}], 1, -1) = 1
recvmsg(4, {msg_name={sa_family=AF_CAN, sa_data="\0\0\2\0\0\0"}, msg_namelen=24 => 8, msg_iov=[{iov_base="\204\203\357\230\7\0\0\0\1\21\0\0\0\200O\0", iov_len=72}], msg_iovlen=1, msg_control=[{cmsg_len=28, cmsg_level=SOL_SOCKET, cmsg_type=SO_TIMESTAMP_NEW, cmsg_data={tv_sec=1697715104, tv_usec=174065}}], msg_controllen=28, msg_flags=0}, 0) = 16
statx(AT_FDCWD, "/etc/localtime", AT_STATX_SYNC_AS_STAT|AT_NO_AUTOMOUNT, STATX_BASIC_STATS, {stx_mask=STATX_BASIC_STATS|STATX_MNT_ID, stx_attributes=0, stx_mode=S_IFREG|0644, stx_size=111, ...}) = 0
write(1, " (2023-10-19 11:31:44.3068705531"..., 99) = 99
epoll_wait(3, [{events=EPOLLIN, data={u32=5075040, u64=5075040}}], 1, -1) = 1
recvmsg(4, {msg_name={sa_family=AF_CAN, sa_data="\0\0\2\0\0\0"}, msg_namelen=24 => 8, msg_iov=[{iov_base="\204\203\357\230\7\0\0\0\1\22\0\0\0\200O\0", iov_len=72}], msg_iovlen=1, msg_control=[{cmsg_len=28, cmsg_level=SOL_SOCKET, cmsg_type=SO_TIMESTAMP_NEW, cmsg_data={tv_sec=1697715104, tv_usec=175120}}], msg_controllen=28, msg_flags=0}, 0) = 16
statx(AT_FDCWD, "/etc/localtime", AT_STATX_SYNC_AS_STAT|AT_NO_AUTOMOUNT, STATX_BASIC_STATS, {stx_mask=STATX_BASIC_STATS|STATX_MNT_ID, stx_attributes=0, stx_mode=S_IFREG|0644, stx_size=111, ...}) = 0
write(1, " (2023-10-19 11:31:44.3068705531"..., 99) = 99
epoll_wait(3, [{events=EPOLLIN, data={u32=5075040, u64=5075040}}], 1, -1) = 1
recvmsg(4, {msg_name={sa_family=AF_CAN, sa_data="\0\0\2\0\0\0"}, msg_namelen=24 => 8, msg_iov=[{iov_base="\204\203\357\230\7\0\0\0\1\23\0\0\0\200O\0", iov_len=72}], msg_iovlen=1, msg_control=[{cmsg_len=28, cmsg_level=SOL_SOCKET, cmsg_type=SO_TIMESTAMP_NEW, cmsg_data={tv_sec=1697715104, tv_usec=176170}}], msg_controllen=28, msg_flags=0}, 0) = 16
statx(AT_FDCWD, "/etc/localtime", AT_STATX_SYNC_AS_STAT|AT_NO_AUTOMOUNT, STATX_BASIC_STATS, {stx_mask=STATX_BASIC_STATS|STATX_MNT_ID, stx_attributes=0, stx_mode=S_IFREG|0644, stx_size=111, ...}) = 0
write(1, " (2023-10-19 11:31:44.3068705531"..., 99) = 99
epoll_wait(3, [{events=EPOLLIN, data={u32=5075040, u64=5075040}}], 1, -1) = 1
recvmsg(4, {msg_name={sa_family=AF_CAN, sa_data="\0\0\2\0\0\0"}, msg_namelen=24 => 8, msg_iov=[{iov_base="\204\203\357\230\7\0\0\0\1\24\0\0\0\200O\0", iov_len=72}], msg_iovlen=1, msg_control=[{cmsg_len=28, cmsg_level=SOL_SOCKET, cmsg_type=SO_TIMESTAMP_NEW, cmsg_data={tv_sec=1697715104, tv_usec=177228}}], msg_controllen=28, msg_flags=0}, 0) = 16
statx(AT_FDCWD, "/etc/localtime", AT_STATX_SYNC_AS_STAT|AT_NO_AUTOMOUNT, STATX_BASIC_STATS, {stx_mask=STATX_BASIC_STATS|STATX_MNT_ID, stx_attributes=0, stx_mode=S_IFREG|0644, stx_size=111, ...}) = 0
write(1, " (2023-10-19 11:31:44.3068705531"..., 99) = 99
epoll_wait(3, [{events=EPOLLIN, data={u32=5075040, u64=5075040}}], 1, -1) = 1
recvmsg(4, {msg_name={sa_family=AF_CAN, sa_data="\0\0\2\0\0\0"}, msg_namelen=24 => 8, msg_iov=[{iov_base="\204\203\357\230\7\0\0\0\1\25\0\0\0\200O\0", iov_len=72}], msg_iovlen=1, msg_control=[{cmsg_len=28, cmsg_level=SOL_SOCKET, cmsg_type=SO_TIMESTAMP_NEW, cmsg_data={tv_sec=1697715104, tv_usec=178271}}], msg_controllen=28, msg_flags=0}, 0) = 16
statx(AT_FDCWD, "/etc/localtime", AT_STATX_SYNC_AS_STAT|AT_NO_AUTOMOUNT, STATX_BASIC_STATS, {stx_mask=STATX_BASIC_STATS|STATX_MNT_ID, stx_attributes=0, stx_mode=S_IFREG|0644, stx_size=111, ...}) = 0
write(1, " (2023-10-19 11:31:44.3068705531"..., 99) = 99
epoll_wait(3, [{events=EPOLLIN, data={u32=5075040, u64=5075040}}], 1, -1) = 1
recvmsg(4, {msg_name={sa_family=AF_CAN, sa_data="\0\0\2\0\0\0"}, msg_namelen=24 => 8, msg_iov=[{iov_base="\204\203\357\230\7\0\0\0\1\26\0\0\0\200O\0", iov_len=72}], msg_iovlen=1, msg_control=[{cmsg_len=28, cmsg_level=SOL_SOCKET, cmsg_type=SO_TIMESTAMP_NEW, cmsg_data={tv_sec=1697715104, tv_usec=179323}}], msg_controllen=28, msg_flags=0}, 0) = 16
statx(AT_FDCWD, "/etc/localtime", AT_STATX_SYNC_AS_STAT|AT_NO_AUTOMOUNT, STATX_BASIC_STATS, {stx_mask=STATX_BASIC_STATS|STATX_MNT_ID, stx_attributes=0, stx_mode=S_IFREG|0644, stx_size=111, ...}) = 0
write(1, " (2023-10-19 11:31:44.3068705531"..., 99) = 99
epoll_wait(3, [{events=EPOLLIN, data={u32=5075040, u64=5075040}}], 1, -1) = 1
recvmsg(4, {msg_name={sa_family=AF_CAN, sa_data="\0\0\2\0\0\0"}, msg_namelen=24 => 8, msg_iov=[{iov_base="\204\203\357\230\7\0\0\0\1\27\0\0\0\200O\0", iov_len=72}], msg_iovlen=1, msg_control=[{cmsg_len=28, cmsg_level=SOL_SOCKET, cmsg_type=SO_TIMESTAMP_NEW, cmsg_data={tv_sec=1697715104, tv_usec=180366}}], msg_controllen=28, msg_flags=0}, 0) = 16
statx(AT_FDCWD, "/etc/localtime", AT_STATX_SYNC_AS_STAT|AT_NO_AUTOMOUNT, STATX_BASIC_STATS, {stx_mask=STATX_BASIC_STATS|STATX_MNT_ID, stx_attributes=0, stx_mode=S_IFREG|0644, stx_size=111, ...}) = 0
write(1, " (2023-10-19 11:31:44.3068705531"..., 99) = 99
epoll_wait(3, [{events=EPOLLIN, data={u32=5075040, u64=5075040}}], 1, -1) = 1
recvmsg(4, {msg_name={sa_family=AF_CAN, sa_data="\0\0\2\0\0\0"}, msg_namelen=24 => 8, msg_iov=[{iov_base="\204\203\357\230\7\0\0\0\1\30\0\0\0\200O\0", iov_len=72}], msg_iovlen=1, msg_control=[{cmsg_len=28, cmsg_level=SOL_SOCKET, cmsg_type=SO_TIMESTAMP_NEW, cmsg_data={tv_sec=1697715104, tv_usec=181426}}], msg_controllen=28, msg_flags=0}, 0) = 16
statx(AT_FDCWD, "/etc/localtime", AT_STATX_SYNC_AS_STAT|AT_NO_AUTOMOUNT, STATX_BASIC_STATS, {stx_mask=STATX_BASIC_STATS|STATX_MNT_ID, stx_attributes=0, stx_mode=S_IFREG|0644, stx_size=111, ...}) = 0
write(1, " (2023-10-19 11:31:44.3068705531"..., 99) = 99
epoll_wait(3, [{events=EPOLLIN, data={u32=5075040, u64=5075040}}], 1, -1) = 1
recvmsg(4, {msg_name={sa_family=AF_CAN, sa_data="\0\0\2\0\0\0"}, msg_namelen=24 => 8, msg_iov=[{iov_base="\204\203\357\230\7\0\0\0\1\221\0\0\0\0\0\0", iov_len=72}], msg_iovlen=1, msg_control=[{cmsg_len=28, cmsg_level=SOL_SOCKET, cmsg_type=SO_TIMESTAMP_NEW, cmsg_data={tv_sec=1697715104, tv_usec=182487}}], msg_controllen=28, msg_flags=0}, 0) = 16
statx(AT_FDCWD, "/etc/localtime", AT_STATX_SYNC_AS_STAT|AT_NO_AUTOMOUNT, STATX_BASIC_STATS, {stx_mask=STATX_BASIC_STATS|STATX_MNT_ID, stx_attributes=0, stx_mode=S_IFREG|0644, stx_size=111, ...}) = 0
write(1, " (2023-10-19 11:31:44.3068705531"..., 99) = 99
epoll_wait(3, [{events=EPOLLIN, data={u32=5075040, u64=5075040}}], 1, -1) = 1
recvmsg(4, {msg_name={sa_family=AF_CAN, sa_data="\0\0\2\0\0\0"}, msg_namelen=24 => 8, msg_iov=[{iov_base="\203\202\357\230\3\0\0\0\3\377\0\0\0\0\0\0", iov_len=72}], msg_iovlen=1, msg_control=[{cmsg_len=28, cmsg_level=SOL_SOCKET, cmsg_type=SO_TIMESTAMP_NEW, cmsg_data={tv_sec=1697715104, tv_usec=223554}}], msg_controllen=28, msg_flags=MSG_DONTROUTE}, 0) = 16
statx(AT_FDCWD, "/etc/localtime", AT_STATX_SYNC_AS_STAT|AT_NO_AUTOMOUNT, STATX_BASIC_STATS, {stx_mask=STATX_BASIC_STATS|STATX_MNT_ID, stx_attributes=0, stx_mode=S_IFREG|0644, stx_size=111, ...}) = 0
write(1, " (2023-10-19 11:31:44.3068705531"..., 87) = 87
epoll_wait(3, [{events=EPOLLIN, data={u32=5075040, u64=5075040}}], 1, -1) = 1
recvmsg(4, {msg_name={sa_family=AF_CAN, sa_data="\0\0\2\0\0\0"}, msg_namelen=24 => 8, msg_iov=[{iov_base="\202\203\357\230\7\0\0\0\1\21\0\0\0\200O\0", iov_len=72}], msg_iovlen=1, msg_control=[{cmsg_len=28, cmsg_level=SOL_SOCKET, cmsg_type=SO_TIMESTAMP_NEW, cmsg_data={tv_sec=1697715104, tv_usec=224266}}], msg_controllen=28, msg_flags=0}, 0) = 16
statx(AT_FDCWD, "/etc/localtime", AT_STATX_SYNC_AS_STAT|AT_NO_AUTOMOUNT, STATX_BASIC_STATS, {stx_mask=STATX_BASIC_STATS|STATX_MNT_ID, stx_attributes=0, stx_mode=S_IFREG|0644, stx_size=111, ...}) = 0
write(1, " (2023-10-19 11:31:44.3068705531"..., 99) = 99
epoll_wait(3, [{events=EPOLLIN, data={u32=5075040, u64=5075040}}], 1, -1) = 1
recvmsg(4, {msg_name={sa_family=AF_CAN, sa_data="\0\0\2\0\0\0"}, msg_namelen=24 => 8, msg_iov=[{iov_base="\202\203\357\230\7\0\0\0\1\22\0\0\0\200O\0", iov_len=72}], msg_iovlen=1, msg_control=[{cmsg_len=28, cmsg_level=SOL_SOCKET, cmsg_type=SO_TIMESTAMP_NEW, cmsg_data={tv_sec=1697715104, tv_usec=225319}}], msg_controllen=28, msg_flags=0}, 0) = 16
statx(AT_FDCWD, "/etc/localtime", AT_STATX_SYNC_AS_STAT|AT_NO_AUTOMOUNT, STATX_BASIC_STATS, {stx_mask=STATX_BASIC_STATS|STATX_MNT_ID, stx_attributes=0, stx_mode=S_IFREG|0644, stx_size=111, ...}) = 0
write(1, " (2023-10-19 11:31:44.3068705531"..., 99) = 99
epoll_wait(3, [{events=EPOLLIN, data={u32=5075040, u64=5075040}}], 1, -1) = 1
recvmsg(4, {msg_name={sa_family=AF_CAN, sa_data="\0\0\2\0\0\0"}, msg_namelen=24 => 8, msg_iov=[{iov_base="\202\203\357\230\7\0\0\0\1\23\0\0\0\200O\0", iov_len=72}], msg_iovlen=1, msg_control=[{cmsg_len=28, cmsg_level=SOL_SOCKET, cmsg_type=SO_TIMESTAMP_NEW, cmsg_data={tv_sec=1697715104, tv_usec=226363}}], msg_controllen=28, msg_flags=0}, 0) = 16
statx(AT_FDCWD, "/etc/localtime", AT_STATX_SYNC_AS_STAT|AT_NO_AUTOMOUNT, STATX_BASIC_STATS, {stx_mask=STATX_BASIC_STATS|STATX_MNT_ID, stx_attributes=0, stx_mode=S_IFREG|0644, stx_size=111, ...}) = 0
write(1, " (2023-10-19 11:31:44.3068705531"..., 99) = 99
epoll_wait(3, [{events=EPOLLIN, data={u32=5075040, u64=5075040}}], 1, -1) = 1
recvmsg(4, {msg_name={sa_family=AF_CAN, sa_data="\0\0\2\0\0\0"}, msg_namelen=24 => 8, msg_iov=[{iov_base="\202\203\357\230\7\0\0\0\1\24\0\0\0\200O\0", iov_len=72}], msg_iovlen=1, msg_control=[{cmsg_len=28, cmsg_level=SOL_SOCKET, cmsg_type=SO_TIMESTAMP_NEW, cmsg_data={tv_sec=1697715104, tv_usec=227426}}], msg_controllen=28, msg_flags=0}, 0) = 16
statx(AT_FDCWD, "/etc/localtime", AT_STATX_SYNC_AS_STAT|AT_NO_AUTOMOUNT, STATX_BASIC_STATS, {stx_mask=STATX_BASIC_STATS|STATX_MNT_ID, stx_attributes=0, stx_mode=S_IFREG|0644, stx_size=111, ...}) = 0
write(1, " (2023-10-19 11:31:44.3068705531"..., 99) = 99
epoll_wait(3, [{events=EPOLLIN, data={u32=5075040, u64=5075040}}], 1, -1) = 1
recvmsg(4, {msg_name={sa_family=AF_CAN, sa_data="\0\0\2\0\0\0"}, msg_namelen=24 => 8, msg_iov=[{iov_base="\202\203\357\230\7\0\0\0\1\25\0\0\0\200O\0", iov_len=72}], msg_iovlen=1, msg_control=[{cmsg_len=28, cmsg_level=SOL_SOCKET, cmsg_type=SO_TIMESTAMP_NEW, cmsg_data={tv_sec=1697715104, tv_usec=228470}}], msg_controllen=28, msg_flags=0}, 0) = 16
statx(AT_FDCWD, "/etc/localtime", AT_STATX_SYNC_AS_STAT|AT_NO_AUTOMOUNT, STATX_BASIC_STATS, {stx_mask=STATX_BASIC_STATS|STATX_MNT_ID, stx_attributes=0, stx_mode=S_IFREG|0644, stx_size=111, ...}) = 0
write(1, " (2023-10-19 11:31:44.3068705531"..., 99) = 99
epoll_wait(3, [{events=EPOLLIN, data={u32=5075040, u64=5075040}}], 1, -1) = 1
recvmsg(4, {msg_name={sa_family=AF_CAN, sa_data="\0\0\2\0\0\0"}, msg_namelen=24 => 8, msg_iov=[{iov_base="\202\203\357\230\7\0\0\0\1\26\0\0\0\200O\0", iov_len=72}], msg_iovlen=1, msg_control=[{cmsg_len=28, cmsg_level=SOL_SOCKET, cmsg_type=SO_TIMESTAMP_NEW, cmsg_data={tv_sec=1697715104, tv_usec=229529}}], msg_controllen=28, msg_flags=0}, 0) = 16
statx(AT_FDCWD, "/etc/localtime", AT_STATX_SYNC_AS_STAT|AT_NO_AUTOMOUNT, STATX_BASIC_STATS, {stx_mask=STATX_BASIC_STATS|STATX_MNT_ID, stx_attributes=0, stx_mode=S_IFREG|0644, stx_size=111, ...}) = 0
write(1, " (2023-10-19 11:31:44.3068705531"..., 99) = 99
epoll_wait(3, [{events=EPOLLIN, data={u32=5075040, u64=5075040}}], 1, -1) = 1
recvmsg(4, {msg_name={sa_family=AF_CAN, sa_data="\0\0\2\0\0\0"}, msg_namelen=24 => 8, msg_iov=[{iov_base="\202\203\357\230\7\0\0\0\1\27\0\0\0\200O\0", iov_len=72}], msg_iovlen=1, msg_control=[{cmsg_len=28, cmsg_level=SOL_SOCKET, cmsg_type=SO_TIMESTAMP_NEW, cmsg_data={tv_sec=1697715104, tv_usec=230570}}], msg_controllen=28, msg_flags=0}, 0) = 16
statx(AT_FDCWD, "/etc/localtime", AT_STATX_SYNC_AS_STAT|AT_NO_AUTOMOUNT, STATX_BASIC_STATS, {stx_mask=STATX_BASIC_STATS|STATX_MNT_ID, stx_attributes=0, stx_mode=S_IFREG|0644, stx_size=111, ...}) = 0
write(1, " (2023-10-19 11:31:44.3068705531"..., 99) = 99
epoll_wait(3, [{events=EPOLLIN, data={u32=5075040, u64=5075040}}], 1, -1) = 1
recvmsg(4, {msg_name={sa_family=AF_CAN, sa_data="\0\0\2\0\0\0"}, msg_namelen=24 => 8, msg_iov=[{iov_base="\202\203\357\230\7\0\0\0\1\30\0\0\0\200O\0", iov_len=72}], msg_iovlen=1, msg_control=[{cmsg_len=28, cmsg_level=SOL_SOCKET, cmsg_type=SO_TIMESTAMP_NEW, cmsg_data={tv_sec=1697715104, tv_usec=231626}}], msg_controllen=28, msg_flags=0}, 0) = 16
statx(AT_FDCWD, "/etc/localtime", AT_STATX_SYNC_AS_STAT|AT_NO_AUTOMOUNT, STATX_BASIC_STATS, {stx_mask=STATX_BASIC_STATS|STATX_MNT_ID, stx_attributes=0, stx_mode=S_IFREG|0644, stx_size=111, ...}) = 0
write(1, " (2023-10-19 11:31:44.3068705531"..., 99) = 99
epoll_wait(3, [{events=EPOLLIN, data={u32=5075040, u64=5075040}}], 1, -1) = 1
recvmsg(4, {msg_name={sa_family=AF_CAN, sa_data="\0\0\2\0\0\0"}, msg_namelen=24 => 8, msg_iov=[{iov_base="\202\203\357\230\7\0\0\0\1\221\0\0\0\0\0\0", iov_len=72}], msg_iovlen=1, msg_control=[{cmsg_len=28, cmsg_level=SOL_SOCKET, cmsg_type=SO_TIMESTAMP_NEW, cmsg_data={tv_sec=1697715104, tv_usec=232683}}], msg_controllen=28, msg_flags=0}, 0) = 16
statx(AT_FDCWD, "/etc/localtime", AT_STATX_SYNC_AS_STAT|AT_NO_AUTOMOUNT, STATX_BASIC_STATS, {stx_mask=STATX_BASIC_STATS|STATX_MNT_ID, stx_attributes=0, stx_mode=S_IFREG|0644, stx_size=111, ...}) = 0
write(1, " (2023-10-19 11:31:44.3068705531"..., 99) = 99
epoll_wait(3, [{events=EPOLLIN, data={u32=5075040, u64=5075040}}], 1, -1) = 1
recvmsg(4, {msg_name={sa_family=AF_CAN, sa_data="\0\0\2\0\0\0"}, msg_namelen=24 => 8, msg_iov=[{iov_base="\203\357\357\230\3\0\0\0\3\0\0\0\0\0\0\0", iov_len=72}], msg_iovlen=1, msg_control=[{cmsg_len=28, cmsg_level=SOL_SOCKET, cmsg_type=SO_TIMESTAMP_NEW, cmsg_data={tv_sec=1697715104, tv_usec=274006}}], msg_controllen=28, msg_flags=MSG_DONTROUTE}, 0) = 16
statx(AT_FDCWD, "/etc/localtime", AT_STATX_SYNC_AS_STAT|AT_NO_AUTOMOUNT, STATX_BASIC_STATS, {stx_mask=STATX_BASIC_STATS|STATX_MNT_ID, stx_attributes=0, stx_mode=S_IFREG|0644, stx_size=111, ...}) = 0
write(1, " (2023-10-19 11:31:44.3068705531"..., 87) = 87
epoll_wait(3, [{events=EPOLLIN, data={u32=5075040, u64=5075040}}], 1, -1) = 1
recvmsg(4, {msg_name={sa_family=AF_CAN, sa_data="\0\0\2\0\0\0"}, msg_namelen=24 => 8, msg_iov=[{iov_base="\357\203\357\230\7\0\0\0\0015\0\273\275\277@\0", iov_len=72}], msg_iovlen=1, msg_control=[{cmsg_len=28, cmsg_level=SOL_SOCKET, cmsg_type=SO_TIMESTAMP_NEW, cmsg_data={tv_sec=1697715104, tv_usec=274793}}], msg_controllen=28, msg_flags=0}, 0) = 16
statx(AT_FDCWD, "/etc/localtime", AT_STATX_SYNC_AS_STAT|AT_NO_AUTOMOUNT, STATX_BASIC_STATS, {stx_mask=STATX_BASIC_STATS|STATX_MNT_ID, stx_attributes=0, stx_mode=S_IFREG|0644, stx_size=111, ...}) = 0
write(1, " (2023-10-19 11:31:44.3068705531"..., 99) = 99
epoll_wait(3, [{events=EPOLLIN, data={u32=5075040, u64=5075040}}], 1, -1) = 1
recvmsg(4, {msg_name={sa_family=AF_CAN, sa_data="\0\0\2\0\0\0"}, msg_namelen=24 => 8, msg_iov=[{iov_base="\357\203\357\230\7\0\0\0\0016\0\0\0\0\0\0", iov_len=72}], msg_iovlen=1, msg_control=[{cmsg_len=28, cmsg_level=SOL_SOCKET, cmsg_type=SO_TIMESTAMP_NEW, cmsg_data={tv_sec=1697715104, tv_usec=275333}}], msg_controllen=28, msg_flags=0}, 0) = 16
statx(AT_FDCWD, "/etc/localtime", AT_STATX_SYNC_AS_STAT|AT_NO_AUTOMOUNT, STATX_BASIC_STATS, {stx_mask=STATX_BASIC_STATS|STATX_MNT_ID, stx_attributes=0, stx_mode=S_IFREG|0644, stx_size=111, ...}) = 0
write(1, " (2023-10-19 11:31:44.3068705531"..., 99) = 99
epoll_wait(3, [{events=EPOLLIN, data={u32=5075040, u64=5075040}}], 1, -1) = 1
recvmsg(4, {msg_name={sa_family=AF_CAN, sa_data="\0\0\2\0\0\0"}, msg_namelen=24 => 8, msg_iov=[{iov_base="\357\203\357\230\7\0\0\0\0017\0\0\0\0\0\0", iov_len=72}], msg_iovlen=1, msg_control=[{cmsg_len=28, cmsg_level=SOL_SOCKET, cmsg_type=SO_TIMESTAMP_NEW, cmsg_data={tv_sec=1697715104, tv_usec=276235}}], msg_controllen=28, msg_flags=0}, 0) = 16
statx(AT_FDCWD, "/etc/localtime", AT_STATX_SYNC_AS_STAT|AT_NO_AUTOMOUNT, STATX_BASIC_STATS, {stx_mask=STATX_BASIC_STATS|STATX_MNT_ID, stx_attributes=0, stx_mode=S_IFREG|0644, stx_size=111, ...}) = 0
write(1, " (2023-10-19 11:31:44.3068705531"..., 99) = 99
epoll_wait(3, [{events=EPOLLIN, data={u32=5075040, u64=5075040}}], 1, -1) = 1
recvmsg(4, {msg_name={sa_family=AF_CAN, sa_data="\0\0\2\0\0\0"}, msg_namelen=24 => 8, msg_iov=[{iov_base="\357\203\357\230\7\0\0\0\1a\0\244\247\377?\0", iov_len=72}], msg_iovlen=1, msg_control=[{cmsg_len=28, cmsg_level=SOL_SOCKET, cmsg_type=SO_TIMESTAMP_NEW, cmsg_data={tv_sec=1697715104, tv_usec=277215}}], msg_controllen=28, msg_flags=0}, 0) = 16
statx(AT_FDCWD, "/etc/localtime", AT_STATX_SYNC_AS_STAT|AT_NO_AUTOMOUNT, STATX_BASIC_STATS, {stx_mask=STATX_BASIC_STATS|STATX_MNT_ID, stx_attributes=0, stx_mode=S_IFREG|0644, stx_size=111, ...}) = 0
write(1, " (2023-10-19 11:31:44.3068705531"..., 99) = 99
epoll_wait(3, [{events=EPOLLIN, data={u32=5075040, u64=5075040}}], 1, -1) = 1
recvmsg(4, {msg_name={sa_family=AF_CAN, sa_data="\0\0\2\0\0\0"}, msg_namelen=24 => 8, msg_iov=[{iov_base="\357\203\357\230\7\0\0\0\1R\0/\30\rB\0", iov_len=72}], msg_iovlen=1, msg_control=[{cmsg_len=28, cmsg_level=SOL_SOCKET, cmsg_type=SO_TIMESTAMP_NEW, cmsg_data={tv_sec=1697715104, tv_usec=278207}}], msg_controllen=28, msg_flags=0}, 0) = 16
statx(AT_FDCWD, "/etc/localtime", AT_STATX_SYNC_AS_STAT|AT_NO_AUTOMOUNT, STATX_BASIC_STATS, {stx_mask=STATX_BASIC_STATS|STATX_MNT_ID, stx_attributes=0, stx_mode=S_IFREG|0644, stx_size=111, ...}) = 0
write(1, " (2023-10-19 11:31:44.3068705531"..., 99) = 99
epoll_wait(3, [{events=EPOLLIN, data={u32=5075040, u64=5075040}}], 1, -1) = 1
recvmsg(4, {msg_name={sa_family=AF_CAN, sa_data="\0\0\2\0\0\0"}, msg_namelen=24 => 8, msg_iov=[{iov_base="\357\203\357\230\7\0\0\0\1d\0\2179\31@\0", iov_len=72}], msg_iovlen=1, msg_control=[{cmsg_len=28, cmsg_level=SOL_SOCKET, cmsg_type=SO_TIMESTAMP_NEW, cmsg_data={tv_sec=1697715104, tv_usec=279217}}], msg_controllen=28, msg_flags=0}, 0) = 16
statx(AT_FDCWD, "/etc/localtime", AT_STATX_SYNC_AS_STAT|AT_NO_AUTOMOUNT, STATX_BASIC_STATS, {stx_mask=STATX_BASIC_STATS|STATX_MNT_ID, stx_attributes=0, stx_mode=S_IFREG|0644, stx_size=111, ...}) = 0
write(1, " (2023-10-19 11:31:44.3068705531"..., 99) = 99
epoll_wait(3, [{events=EPOLLIN, data={u32=5075040, u64=5075040}}], 1, -1) = 1
recvmsg(4, {msg_name={sa_family=AF_CAN, sa_data="\0\0\2\0\0\0"}, msg_namelen=24 => 8, msg_iov=[{iov_base="\357\203\357\230\7\0\0\0\1S\0\2179\31@\0", iov_len=72}], msg_iovlen=1, msg_control=[{cmsg_len=28, cmsg_level=SOL_SOCKET, cmsg_type=SO_TIMESTAMP_NEW, cmsg_data={tv_sec=1697715104, tv_usec=280379}}], msg_controllen=28, msg_flags=0}, 0) = 16
statx(AT_FDCWD, "/etc/localtime", AT_STATX_SYNC_AS_STAT|AT_NO_AUTOMOUNT, STATX_BASIC_STATS, {stx_mask=STATX_BASIC_STATS|STATX_MNT_ID, stx_attributes=0, stx_mode=S_IFREG|0644, stx_size=111, ...}) = 0
write(1, " (2023-10-19 11:31:44.3068705531"..., 99) = 99
epoll_wait(3, [{events=EPOLLIN, data={u32=5075040, u64=5075040}}], 1, -1) = 1
recvmsg(4, {msg_name={sa_family=AF_CAN, sa_data="\0\0\2\0\0\0"}, msg_namelen=24 => 8, msg_iov=[{iov_base="\357\203\357\230\7\0\0\0\1q\0f\306\303B\0", iov_len=72}], msg_iovlen=1, msg_control=[{cmsg_len=28, cmsg_level=SOL_SOCKET, cmsg_type=SO_TIMESTAMP_NEW, cmsg_data={tv_sec=1697715104, tv_usec=281205}}], msg_controllen=28, msg_flags=0}, 0) = 16
statx(AT_FDCWD, "/etc/localtime", AT_STATX_SYNC_AS_STAT|AT_NO_AUTOMOUNT, STATX_BASIC_STATS, {stx_mask=STATX_BASIC_STATS|STATX_MNT_ID, stx_attributes=0, stx_mode=S_IFREG|0644, stx_size=111, ...}) = 0
write(1, " (2023-10-19 11:31:44.3068705531"..., 99) = 99
epoll_wait(3, [{events=EPOLLIN, data={u32=5075040, u64=5075040}}], 1, -1) = 1
recvmsg(4, {msg_name={sa_family=AF_CAN, sa_data="\0\0\2\0\0\0"}, msg_namelen=24 => 8, msg_iov=[{iov_base="\357\203\357\230\7\0\0\0\1x\0\0\0\0\0\0", iov_len=72}], msg_iovlen=1, msg_control=[{cmsg_len=28, cmsg_level=SOL_SOCKET, cmsg_type=SO_TIMESTAMP_NEW, cmsg_data={tv_sec=1697715104, tv_usec=282228}}], msg_controllen=28, msg_flags=0}, 0) = 16
statx(AT_FDCWD, "/etc/localtime", AT_STATX_SYNC_AS_STAT|AT_NO_AUTOMOUNT, STATX_BASIC_STATS, {stx_mask=STATX_BASIC_STATS|STATX_MNT_ID, stx_attributes=0, stx_mode=S_IFREG|0644, stx_size=111, ...}) = 0
write(1, " (2023-10-19 11:31:44.3068705531"..., 99) = 99
epoll_wait(3, [{events=EPOLLIN, data={u32=5075040, u64=5075040}}], 1, -1) = 1
recvmsg(4, {msg_name={sa_family=AF_CAN, sa_data="\0\0\2\0\0\0"}, msg_namelen=24 => 8, msg_iov=[{iov_base="\357\203\357\230\7\0\0\0\1t\0\0\0\0\0\0", iov_len=72}], msg_iovlen=1, msg_control=[{cmsg_len=28, cmsg_level=SOL_SOCKET, cmsg_type=SO_TIMESTAMP_NEW, cmsg_data={tv_sec=1697715104, tv_usec=283227}}], msg_controllen=28, msg_flags=0}, 0) = 16
statx(AT_FDCWD, "/etc/localtime", AT_STATX_SYNC_AS_STAT|AT_NO_AUTOMOUNT, STATX_BASIC_STATS, {stx_mask=STATX_BASIC_STATS|STATX_MNT_ID, stx_attributes=0, stx_mode=S_IFREG|0644, stx_size=111, ...}) = 0
write(1, " (2023-10-19 11:31:44.3068705531"..., 99) = 99
epoll_wait(3, [{events=EPOLLIN, data={u32=5075040, u64=5075040}}], 1, -1) = 1
recvmsg(4, {msg_name={sa_family=AF_CAN, sa_data="\0\0\2\0\0\0"}, msg_namelen=24 => 8, msg_iov=[{iov_base="\357\203\357\230\7\0\0\0\1\203\0\0\0\0\0\0", iov_len=72}], msg_iovlen=1, msg_control=[{cmsg_len=28, cmsg_level=SOL_SOCKET, cmsg_type=SO_TIMESTAMP_NEW, cmsg_data={tv_sec=1697715104, tv_usec=284233}}], msg_controllen=28, msg_flags=0}, 0) = 16
statx(AT_FDCWD, "/etc/localtime", AT_STATX_SYNC_AS_STAT|AT_NO_AUTOMOUNT, STATX_BASIC_STATS, {stx_mask=STATX_BASIC_STATS|STATX_MNT_ID, stx_attributes=0, stx_mode=S_IFREG|0644, stx_size=111, ...}) = 0
write(1, " (2023-10-19 11:31:44.3068705531"..., 99) = 99
epoll_wait(3, 0xbecaf860, 1, -1)        = -1 EINTR (Interrupted system call)
--- SIGINT {si_signo=SIGINT, si_code=SI_KERNEL} ---
sigreturn({mask=[]})                    = -1 EINTR (Interrupted system call)
close(4)                                = 0
close(3)                                = 0
exit_group(130)                         = ?
+++ exited with 130 +++

marckleinebudde · 2023-10-19T11:49:14Z

The timestamps that recvmsg got look correct to me:

$ grep recvmsg can.log | sed -e "s/.*\(tv_sec=[^}]*\).*/\1/"
tv_sec=1697715104, tv_usec=123196
tv_sec=1697715104, tv_usec=123893
tv_sec=1697715104, tv_usec=124949
tv_sec=1697715104, tv_usec=125998
tv_sec=1697715104, tv_usec=127059
tv_sec=1697715104, tv_usec=128106
tv_sec=1697715104, tv_usec=129159
tv_sec=1697715104, tv_usec=130206
tv_sec=1697715104, tv_usec=131249
tv_sec=1697715104, tv_usec=132310
tv_sec=1697715104, tv_usec=173363
tv_sec=1697715104, tv_usec=174065
tv_sec=1697715104, tv_usec=175120
tv_sec=1697715104, tv_usec=176170
tv_sec=1697715104, tv_usec=177228
tv_sec=1697715104, tv_usec=178271
tv_sec=1697715104, tv_usec=179323
tv_sec=1697715104, tv_usec=180366
tv_sec=1697715104, tv_usec=181426
tv_sec=1697715104, tv_usec=182487
tv_sec=1697715104, tv_usec=223554
tv_sec=1697715104, tv_usec=224266
tv_sec=1697715104, tv_usec=225319
tv_sec=1697715104, tv_usec=226363
tv_sec=1697715104, tv_usec=227426
tv_sec=1697715104, tv_usec=228470
tv_sec=1697715104, tv_usec=229529
tv_sec=1697715104, tv_usec=230570
tv_sec=1697715104, tv_usec=231626
tv_sec=1697715104, tv_usec=232683
tv_sec=1697715104, tv_usec=274006
tv_sec=1697715104, tv_usec=274793
tv_sec=1697715104, tv_usec=275333
tv_sec=1697715104, tv_usec=276235
tv_sec=1697715104, tv_usec=277215
tv_sec=1697715104, tv_usec=278207
tv_sec=1697715104, tv_usec=279217
tv_sec=1697715104, tv_usec=280379
tv_sec=1697715104, tv_usec=281205
tv_sec=1697715104, tv_usec=282228
tv_sec=1697715104, tv_usec=283227
tv_sec=1697715104, tv_usec=284233

Can you confirm, that this version is 41ea759?

marckleinebudde · 2023-10-19T11:56:45Z

Which C library are you using? glibc? Which version?

marckleinebudde · 2023-10-19T12:00:56Z

The difference between your strace output and mine is the different cmsg_type=SO_TIMESTAMP*. You have cmsg_type=SO_TIMESTAMP_NEW, I have cmsg_type=SO_TIMESTAMP_OLD.

recvmsg(4, {msg_name={sa_family=AF_CAN, sa_data="\0\0\10\0\0\0"}, msg_namelen=24 => 8, msg_iov=[{iov_base="\2\0\0\0\1\0\0\0\22\0\0\0\0\0\0\0", iov_len=72}], msg_iovlen=1, msg_control=[{cmsg_len=32, cmsg_level=SOL_SOCKET, cmsg_type=SO_TIMESTAMP_OLD, cmsg_data={tv_sec=1697716746, tv_usec=662521}}], msg_controllen=32, msg_flags=MSG_DONTROUTE}, 0) = 16

Kuzma30 · 2023-10-19T12:07:49Z

glibc 2.38

cat glibc-version.inc 
SRCBRANCH ?= "release/2.38/master"
PV = "2.38+git"
SRCREV_glibc ?= "1aed90c9c8f8be9f68b58e96b6e4cd0fc08eb2b1"
SRCREV_localedef ?= "e0eca29583b9e0f62645c4316ced93cf4e4e26e1"

GLIBC_GIT_URI ?= "git://sourceware.org/git/glibc.git;protocol=https"

UPSTREAM_CHECK_GITTAGREGEX = "(?P<pver>\d+\.\d+(\.(?!90)\d+)*)"

marckleinebudde · 2023-10-19T12:22:31Z

Can you add this patch, rerun with strace like before and the the output.

index 8e4444fc51c4..6e6b21b5fe30 100644
--- a/candump.c
+++ b/candump.c
@@ -752,6 +752,7 @@ int main(int argc, char **argv)
                         for (cmsg = CMSG_FIRSTHDR(&msg);
                              cmsg && (cmsg->cmsg_level == SOL_SOCKET);
                              cmsg = CMSG_NXTHDR(&msg,cmsg)) {
+                                printf("%s: cmsg_type=%d, SO_TIMESTAMP=%d\n", __func__, cmsg->cmsg_type, SO_TIMESTAMP);
                                 if (cmsg->cmsg_type == SO_TIMESTAMP) {
                                         memcpy(&tv, CMSG_DATA(cmsg), sizeof(tv));
                                 } else if (cmsg->cmsg_type == SO_TIMESTAMPING) {

Kuzma30 · 2023-10-19T12:31:20Z

strace -o /tmp/log candump any,0:0,#FFFFFFFF -cexdtA
 (2023-10-19 12:29:43.4294967295)  can0  TX - -  18EF8183   [3]  03 FF 00
 (2023-10-19 12:29:43.3068803835)  can0  RX - -  18EF8381   [7]  01 11 00 00 00 80 4F
 (2023-10-19 12:29:43.3068803835)  can0  RX - -  18EF8381   [7]  01 12 00 00 00 80 4F
 (2023-10-19 12:29:43.3068803835)  can0  RX - -  18EF8381   [7]  01 13 00 00 00 80 4F
 (2023-10-19 12:29:43.3068803835)  can0  RX - -  18EF8381   [7]  01 14 00 00 00 80 4F
 (2023-10-19 12:29:43.3068803835)  can0  RX - -  18EF8381   [7]  01 15 00 00 00 80 4F
 (2023-10-19 12:29:43.3068803835)  can0  RX - -  18EF8381   [7]  01 16 00 00 00 80 4F
 (2023-10-19 12:29:43.3068803835)  can0  RX - -  18EF8381   [7]  01 17 00 00 00 80 4F
 (2023-10-19 12:29:43.3068803835)  can0  RX - -  18EF8381   [7]  01 18 00 00 00 80 4F
 (2023-10-19 12:29:43.3068803835)  can0  RX - -  18EF8381   [7]  01 91 00 00 00 00 00
 (2023-10-19 12:29:43.3068803835)  can0  TX - -  18EF8483   [3]  03 FF 00
 (2023-10-19 12:29:43.3068803835)  can0  RX - -  18EF8384   [7]  01 11 00 00 00 80 4F
 (2023-10-19 12:29:43.3068803835)  can0  RX - -  18EF8384   [7]  01 12 00 00 00 80 4F
 (2023-10-19 12:29:43.3068803835)  can0  RX - -  18EF8384   [7]  01 13 00 00 00 80 4F
 (2023-10-19 12:29:43.3068803835)  can0  RX - -  18EF8384   [7]  01 14 00 00 00 80 4F
 (2023-10-19 12:29:43.3068803835)  can0  RX - -  18EF8384   [7]  01 15 00 00 00 80 4F
 (2023-10-19 12:29:43.3068803835)  can0  RX - -  18EF8384   [7]  01 16 00 00 00 80 4F
 (2023-10-19 12:29:43.3068803835)  can0  RX - -  18EF8384   [7]  01 17 00 00 00 80 4F
 (2023-10-19 12:29:43.3068803835)  can0  RX - -  18EF8384   [7]  01 18 00 00 00 80 4F
 (2023-10-19 12:29:43.3068803835)  can0  RX - -  18EF8384   [7]  01 91 00 00 00 00 00
 (2023-10-19 12:29:43.3068803835)  can0  TX - -  18EF8283   [3]  03 FF 00
 (2023-10-19 12:29:43.3068803835)  can0  RX - -  18EF8382   [7]  01 11 00 00 00 80 4F
 (2023-10-19 12:29:43.3068803835)  can0  RX - -  18EF8382   [7]  01 12 00 00 00 80 4F
 (2023-10-19 12:29:43.3068803835)  can0  RX - -  18EF8382   [7]  01 13 00 00 00 80 4F
 (2023-10-19 12:29:43.3068803835)  can0  RX - -  18EF8382   [7]  01 14 00 00 00 80 4F
 (2023-10-19 12:29:43.3068803835)  can0  RX - -  18EF8382   [7]  01 15 00 00 00 80 4F
 (2023-10-19 12:29:43.3068803835)  can0  RX - -  18EF8382   [7]  01 16 00 00 00 80 4F
 (2023-10-19 12:29:43.3068803835)  can0  RX - -  18EF8382   [7]  01 17 00 00 00 80 4F
 (2023-10-19 12:29:43.3068803835)  can0  RX - -  18EF8382   [7]  01 18 00 00 00 80 4F
 (2023-10-19 12:29:43.3068803835)  can0  RX - -  18EF8382   [7]  01 91 00 00 00 00 00
 (2023-10-19 12:29:43.3068803835)  can0  TX - -  18EFEF83   [3]  03 00 00
 (2023-10-19 12:29:43.3068803835)  can0  RX - -  18EF83EF   [7]  01 35 00 78 BE BF 40
 (2023-10-19 12:29:43.3068803835)  can0  RX - -  18EF83EF   [7]  01 36 00 00 00 00 00
 (2023-10-19 12:29:43.3068803835)  can0  RX - -  18EF83EF   [7]  01 37 00 00 00 00 00
 (2023-10-19 12:29:43.3068803835)  can0  RX - -  18EF83EF   [7]  01 61 00 A0 A8 FF 3F
 (2023-10-19 12:29:43.3068803835)  can0  RX - -  18EF83EF   [7]  01 52 00 60 74 24 42
 (2023-10-19 12:29:43.3068803835)  can0  RX - -  18EF83EF   [7]  01 64 00 8F 39 19 40
 (2023-10-19 12:29:43.3068803835)  can0  RX - -  18EF83EF   [7]  01 53 00 8F 39 19 40
 (2023-10-19 12:29:43.3068803835)  can0  RX - -  18EF83EF   [7]  01 71 00 66 C6 C3 42
 (2023-10-19 12:29:43.3068803835)  can0  RX - -  18EF83EF   [7]  01 78 00 00 00 00 00
 (2023-10-19 12:29:43.3068803835)  can0  RX - -  18EF83EF   [7]  01 74 00 00 00 00 00
 (2023-10-19 12:29:43.3068803835)  can0  RX - -  18EF83EF   [7]  01 83 00 00 00 00 00
^Croot@b2qt-raspberrypi4:/lib# cat /tmp/log
execve("/usr/bin/candump", ["candump", "any,0:0,#FFFFFFFF", "-cexdtA"], 0xbe9bbd00 /* 18 vars */) = 0
brk(NULL)                               = 0x626000
mmap2(NULL, 8192, PROT_READ|PROT_WRITE, MAP_PRIVATE|MAP_ANONYMOUS, -1, 0) = 0xb6f7a000
access("/etc/ld.so.preload", R_OK)      = -1 ENOENT (No such file or directory)
openat(AT_FDCWD, "/etc/ld.so.cache", O_RDONLY|O_LARGEFILE|O_CLOEXEC) = 3
statx(3, "", AT_STATX_SYNC_AS_STAT|AT_NO_AUTOMOUNT|AT_EMPTY_PATH, STATX_BASIC_STATS, {stx_mask=STATX_BASIC_STATS|STATX_MNT_ID, stx_attributes=0, stx_mode=S_IFREG|0644, stx_size=31226, ...}) = 0
mmap2(NULL, 31226, PROT_READ, MAP_PRIVATE, 3, 0) = 0xb6f72000
close(3)                                = 0
openat(AT_FDCWD, "/usr/lib/libc.so.6", O_RDONLY|O_LARGEFILE|O_CLOEXEC) = 3
read(3, "\177ELF\1\1\1\0\0\0\0\0\0\0\0\0\3\0(\0\1\0\0\0\271\346\1\0004\0\0\0"..., 512) = 512
statx(3, "", AT_STATX_SYNC_AS_STAT|AT_NO_AUTOMOUNT|AT_EMPTY_PATH, STATX_BASIC_STATS, {stx_mask=STATX_BASIC_STATS|STATX_MNT_ID, stx_attributes=0, stx_mode=S_IFREG|0755, stx_size=1146976, ...}) = 0
mmap2(NULL, 1184344, PROT_READ|PROT_EXEC, MAP_PRIVATE|MAP_DENYWRITE, 3, 0) = 0xb6e50000
mmap2(0xb6f4d000, 110592, PROT_READ|PROT_WRITE, MAP_PRIVATE|MAP_FIXED|MAP_DENYWRITE, 3, 0xfc000) = 0xb6f4d000
mmap2(0xb6f68000, 37464, PROT_READ|PROT_WRITE, MAP_PRIVATE|MAP_FIXED|MAP_ANONYMOUS, -1, 0) = 0xb6f68000
close(3)                                = 0
set_tls(0xb6f7b0a0)                     = 0
set_tid_address(0xb6f7ac08)             = 32306
set_robust_list(0xb6f7ac0c, 12)         = 0
rseq(0xb6f7b080, 0x20, 0, 0xe7f5def3)   = 0
mprotect(0xb6f4d000, 106496, PROT_READ) = 0
mprotect(0x48c000, 4096, PROT_READ)     = 0
mprotect(0xb6f97000, 8192, PROT_READ)   = 0
ugetrlimit(RLIMIT_STACK, {rlim_cur=8192*1024, rlim_max=RLIM_INFINITY}) = 0
munmap(0xb6f72000, 31226)               = 0
rt_sigaction(SIGTERM, {sa_handler=0x48905d, sa_mask=[TERM], sa_flags=SA_RESTORER|SA_RESTART, sa_restorer=0xb6e7d031}, {sa_handler=SIG_DFL, sa_mask=[], sa_flags=0}, 8) = 0
rt_sigaction(SIGHUP, {sa_handler=0x48905d, sa_mask=[HUP], sa_flags=SA_RESTORER|SA_RESTART, sa_restorer=0xb6e7d031}, {sa_handler=SIG_DFL, sa_mask=[], sa_flags=0}, 8) = 0
rt_sigaction(SIGINT, {sa_handler=0x48905d, sa_mask=[INT], sa_flags=SA_RESTORER|SA_RESTART, sa_restorer=0xb6e7d031}, {sa_handler=SIG_DFL, sa_mask=[], sa_flags=0}, 8) = 0
epoll_create(1)                         = 3
socket(AF_CAN, SOCK_RAW, CAN_RAW)       = 4
epoll_ctl(3, EPOLL_CTL_ADD, 4, {events=EPOLLIN, data={u32=4771936, u64=4771936}}) = 0
getrandom("\xe9\xc2\x04\x17", 4, GRND_NONBLOCK) = 4
brk(NULL)                               = 0x626000
brk(0x647000)                           = 0x647000
setsockopt(4, SOL_CAN_RAW, CAN_RAW_ERR_FILTER, [-1], 4) = 0
setsockopt(4, SOL_CAN_RAW, CAN_RAW_FILTER, "\0\0\0\0\0\0\0\0", 8) = 0
setsockopt(4, SOL_CAN_RAW, CAN_RAW_FD_FRAMES, [1], 4) = 0
setsockopt(4, SOL_SOCKET, SO_TIMESTAMP_NEW, [1], 4) = 0
setsockopt(4, SOL_SOCKET, SO_RXQ_OVFL, [1], 4) = 0
bind(4, {sa_family=AF_CAN, sa_data="\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0"}, 24) = 0
epoll_wait(3, [{events=EPOLLIN, data={u32=4771936, u64=4771936}}], 1, -1) = 1
recvmsg(4, {msg_name={sa_family=AF_CAN, sa_data="\0\0\2\0\0\0"}, msg_namelen=24 => 8, msg_iov=[{iov_base="\203\201\357\230\3\0\0\0\3\377\0\0\0\0\0\0", iov_len=72}], msg_iovlen=1, msg_control=[{cmsg_len=28, cmsg_level=SOL_SOCKET, cmsg_type=SO_TIMESTAMP_NEW, cmsg_data={tv_sec=1697718583, tv_usec=122752}}], msg_controllen=28, msg_flags=MSG_DONTROUTE}, 0) = 16
ioctl(4, SIOCGIFNAME, {ifr_ifindex=2, ifr_name="can0"}) = 0
statx(1, "", AT_STATX_SYNC_AS_STAT|AT_NO_AUTOMOUNT|AT_EMPTY_PATH, STATX_BASIC_STATS, {stx_mask=STATX_BASIC_STATS|STATX_MNT_ID, stx_attributes=0, stx_mode=S_IFCHR|0620, stx_size=0, ...}) = 0
openat(AT_FDCWD, "/etc/localtime", O_RDONLY|O_CLOEXEC) = 5
statx(5, "", AT_STATX_SYNC_AS_STAT|AT_NO_AUTOMOUNT|AT_EMPTY_PATH, STATX_BASIC_STATS, {stx_mask=STATX_BASIC_STATS|STATX_MNT_ID, stx_attributes=0, stx_mode=S_IFREG|0644, stx_size=111, ...}) = 0
statx(5, "", AT_STATX_SYNC_AS_STAT|AT_NO_AUTOMOUNT|AT_EMPTY_PATH, STATX_BASIC_STATS, {stx_mask=STATX_BASIC_STATS|STATX_MNT_ID, stx_attributes=0, stx_mode=S_IFREG|0644, stx_size=111, ...}) = 0
read(5, "TZif2\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0"..., 4096) = 111
_llseek(5, -60, [51], SEEK_CUR)         = 0
read(5, "TZif2\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0"..., 4096) = 60
close(5)                                = 0
write(1, " (2023-10-19 12:29:43.4294967295"..., 87) = 87
epoll_wait(3, [{events=EPOLLIN, data={u32=4771936, u64=4771936}}], 1, -1) = 1
recvmsg(4, {msg_name={sa_family=AF_CAN, sa_data="\0\0\2\0\0\0"}, msg_namelen=24 => 8, msg_iov=[{iov_base="\201\203\357\230\7\0\0\0\1\21\0\0\0\200O\0", iov_len=72}], msg_iovlen=1, msg_control=[{cmsg_len=28, cmsg_level=SOL_SOCKET, cmsg_type=SO_TIMESTAMP_NEW, cmsg_data={tv_sec=1697718583, tv_usec=123449}}], msg_controllen=28, msg_flags=0}, 0) = 16
statx(AT_FDCWD, "/etc/localtime", AT_STATX_SYNC_AS_STAT|AT_NO_AUTOMOUNT, STATX_BASIC_STATS, {stx_mask=STATX_BASIC_STATS|STATX_MNT_ID, stx_attributes=0, stx_mode=S_IFREG|0644, stx_size=111, ...}) = 0
write(1, " (2023-10-19 12:29:43.3068803835"..., 99) = 99
epoll_wait(3, [{events=EPOLLIN, data={u32=4771936, u64=4771936}}], 1, -1) = 1
recvmsg(4, {msg_name={sa_family=AF_CAN, sa_data="\0\0\2\0\0\0"}, msg_namelen=24 => 8, msg_iov=[{iov_base="\201\203\357\230\7\0\0\0\1\22\0\0\0\200O\0", iov_len=72}], msg_iovlen=1, msg_control=[{cmsg_len=28, cmsg_level=SOL_SOCKET, cmsg_type=SO_TIMESTAMP_NEW, cmsg_data={tv_sec=1697718583, tv_usec=124509}}], msg_controllen=28, msg_flags=0}, 0) = 16
statx(AT_FDCWD, "/etc/localtime", AT_STATX_SYNC_AS_STAT|AT_NO_AUTOMOUNT, STATX_BASIC_STATS, {stx_mask=STATX_BASIC_STATS|STATX_MNT_ID, stx_attributes=0, stx_mode=S_IFREG|0644, stx_size=111, ...}) = 0
write(1, " (2023-10-19 12:29:43.3068803835"..., 99) = 99
epoll_wait(3, [{events=EPOLLIN, data={u32=4771936, u64=4771936}}], 1, -1) = 1
recvmsg(4, {msg_name={sa_family=AF_CAN, sa_data="\0\0\2\0\0\0"}, msg_namelen=24 => 8, msg_iov=[{iov_base="\201\203\357\230\7\0\0\0\1\23\0\0\0\200O\0", iov_len=72}], msg_iovlen=1, msg_control=[{cmsg_len=28, cmsg_level=SOL_SOCKET, cmsg_type=SO_TIMESTAMP_NEW, cmsg_data={tv_sec=1697718583, tv_usec=125556}}], msg_controllen=28, msg_flags=0}, 0) = 16
statx(AT_FDCWD, "/etc/localtime", AT_STATX_SYNC_AS_STAT|AT_NO_AUTOMOUNT, STATX_BASIC_STATS, {stx_mask=STATX_BASIC_STATS|STATX_MNT_ID, stx_attributes=0, stx_mode=S_IFREG|0644, stx_size=111, ...}) = 0
write(1, " (2023-10-19 12:29:43.3068803835"..., 99) = 99
epoll_wait(3, [{events=EPOLLIN, data={u32=4771936, u64=4771936}}], 1, -1) = 1
recvmsg(4, {msg_name={sa_family=AF_CAN, sa_data="\0\0\2\0\0\0"}, msg_namelen=24 => 8, msg_iov=[{iov_base="\201\203\357\230\7\0\0\0\1\24\0\0\0\200O\0", iov_len=72}], msg_iovlen=1, msg_control=[{cmsg_len=28, cmsg_level=SOL_SOCKET, cmsg_type=SO_TIMESTAMP_NEW, cmsg_data={tv_sec=1697718583, tv_usec=126614}}], msg_controllen=28, msg_flags=0}, 0) = 16
statx(AT_FDCWD, "/etc/localtime", AT_STATX_SYNC_AS_STAT|AT_NO_AUTOMOUNT, STATX_BASIC_STATS, {stx_mask=STATX_BASIC_STATS|STATX_MNT_ID, stx_attributes=0, stx_mode=S_IFREG|0644, stx_size=111, ...}) = 0
write(1, " (2023-10-19 12:29:43.3068803835"..., 99) = 99
epoll_wait(3, [{events=EPOLLIN, data={u32=4771936, u64=4771936}}], 1, -1) = 1
recvmsg(4, {msg_name={sa_family=AF_CAN, sa_data="\0\0\2\0\0\0"}, msg_namelen=24 => 8, msg_iov=[{iov_base="\201\203\357\230\7\0\0\0\1\25\0\0\0\200O\0", iov_len=72}], msg_iovlen=1, msg_control=[{cmsg_len=28, cmsg_level=SOL_SOCKET, cmsg_type=SO_TIMESTAMP_NEW, cmsg_data={tv_sec=1697718583, tv_usec=127656}}], msg_controllen=28, msg_flags=0}, 0) = 16
statx(AT_FDCWD, "/etc/localtime", AT_STATX_SYNC_AS_STAT|AT_NO_AUTOMOUNT, STATX_BASIC_STATS, {stx_mask=STATX_BASIC_STATS|STATX_MNT_ID, stx_attributes=0, stx_mode=S_IFREG|0644, stx_size=111, ...}) = 0
write(1, " (2023-10-19 12:29:43.3068803835"..., 99) = 99
epoll_wait(3, [{events=EPOLLIN, data={u32=4771936, u64=4771936}}], 1, -1) = 1
recvmsg(4, {msg_name={sa_family=AF_CAN, sa_data="\0\0\2\0\0\0"}, msg_namelen=24 => 8, msg_iov=[{iov_base="\201\203\357\230\7\0\0\0\1\26\0\0\0\200O\0", iov_len=72}], msg_iovlen=1, msg_control=[{cmsg_len=28, cmsg_level=SOL_SOCKET, cmsg_type=SO_TIMESTAMP_NEW, cmsg_data={tv_sec=1697718583, tv_usec=128716}}], msg_controllen=28, msg_flags=0}, 0) = 16
statx(AT_FDCWD, "/etc/localtime", AT_STATX_SYNC_AS_STAT|AT_NO_AUTOMOUNT, STATX_BASIC_STATS, {stx_mask=STATX_BASIC_STATS|STATX_MNT_ID, stx_attributes=0, stx_mode=S_IFREG|0644, stx_size=111, ...}) = 0
write(1, " (2023-10-19 12:29:43.3068803835"..., 99) = 99
epoll_wait(3, [{events=EPOLLIN, data={u32=4771936, u64=4771936}}], 1, -1) = 1
recvmsg(4, {msg_name={sa_family=AF_CAN, sa_data="\0\0\2\0\0\0"}, msg_namelen=24 => 8, msg_iov=[{iov_base="\201\203\357\230\7\0\0\0\1\27\0\0\0\200O\0", iov_len=72}], msg_iovlen=1, msg_control=[{cmsg_len=28, cmsg_level=SOL_SOCKET, cmsg_type=SO_TIMESTAMP_NEW, cmsg_data={tv_sec=1697718583, tv_usec=129758}}], msg_controllen=28, msg_flags=0}, 0) = 16
statx(AT_FDCWD, "/etc/localtime", AT_STATX_SYNC_AS_STAT|AT_NO_AUTOMOUNT, STATX_BASIC_STATS, {stx_mask=STATX_BASIC_STATS|STATX_MNT_ID, stx_attributes=0, stx_mode=S_IFREG|0644, stx_size=111, ...}) = 0
write(1, " (2023-10-19 12:29:43.3068803835"..., 99) = 99
epoll_wait(3, [{events=EPOLLIN, data={u32=4771936, u64=4771936}}], 1, -1) = 1
recvmsg(4, {msg_name={sa_family=AF_CAN, sa_data="\0\0\2\0\0\0"}, msg_namelen=24 => 8, msg_iov=[{iov_base="\201\203\357\230\7\0\0\0\1\30\0\0\0\200O\0", iov_len=72}], msg_iovlen=1, msg_control=[{cmsg_len=28, cmsg_level=SOL_SOCKET, cmsg_type=SO_TIMESTAMP_NEW, cmsg_data={tv_sec=1697718583, tv_usec=130806}}], msg_controllen=28, msg_flags=0}, 0) = 16
statx(AT_FDCWD, "/etc/localtime", AT_STATX_SYNC_AS_STAT|AT_NO_AUTOMOUNT, STATX_BASIC_STATS, {stx_mask=STATX_BASIC_STATS|STATX_MNT_ID, stx_attributes=0, stx_mode=S_IFREG|0644, stx_size=111, ...}) = 0
write(1, " (2023-10-19 12:29:43.3068803835"..., 99) = 99
epoll_wait(3, [{events=EPOLLIN, data={u32=4771936, u64=4771936}}], 1, -1) = 1
recvmsg(4, {msg_name={sa_family=AF_CAN, sa_data="\0\0\2\0\0\0"}, msg_namelen=24 => 8, msg_iov=[{iov_base="\201\203\357\230\7\0\0\0\1\221\0\0\0\0\0\0", iov_len=72}], msg_iovlen=1, msg_control=[{cmsg_len=28, cmsg_level=SOL_SOCKET, cmsg_type=SO_TIMESTAMP_NEW, cmsg_data={tv_sec=1697718583, tv_usec=131887}}], msg_controllen=28, msg_flags=0}, 0) = 16
statx(AT_FDCWD, "/etc/localtime", AT_STATX_SYNC_AS_STAT|AT_NO_AUTOMOUNT, STATX_BASIC_STATS, {stx_mask=STATX_BASIC_STATS|STATX_MNT_ID, stx_attributes=0, stx_mode=S_IFREG|0644, stx_size=111, ...}) = 0
write(1, " (2023-10-19 12:29:43.3068803835"..., 99) = 99
epoll_wait(3, [{events=EPOLLIN, data={u32=4771936, u64=4771936}}], 1, -1) = 1
recvmsg(4, {msg_name={sa_family=AF_CAN, sa_data="\0\0\2\0\0\0"}, msg_namelen=24 => 8, msg_iov=[{iov_base="\203\204\357\230\3\0\0\0\3\377\0\0\0\0\0\0", iov_len=72}], msg_iovlen=1, msg_control=[{cmsg_len=28, cmsg_level=SOL_SOCKET, cmsg_type=SO_TIMESTAMP_NEW, cmsg_data={tv_sec=1697718583, tv_usec=173156}}], msg_controllen=28, msg_flags=MSG_DONTROUTE}, 0) = 16
statx(AT_FDCWD, "/etc/localtime", AT_STATX_SYNC_AS_STAT|AT_NO_AUTOMOUNT, STATX_BASIC_STATS, {stx_mask=STATX_BASIC_STATS|STATX_MNT_ID, stx_attributes=0, stx_mode=S_IFREG|0644, stx_size=111, ...}) = 0
write(1, " (2023-10-19 12:29:43.3068803835"..., 87) = 87
epoll_wait(3, [{events=EPOLLIN, data={u32=4771936, u64=4771936}}], 1, -1) = 1
recvmsg(4, {msg_name={sa_family=AF_CAN, sa_data="\0\0\2\0\0\0"}, msg_namelen=24 => 8, msg_iov=[{iov_base="\204\203\357\230\7\0\0\0\1\21\0\0\0\200O\0", iov_len=72}], msg_iovlen=1, msg_control=[{cmsg_len=28, cmsg_level=SOL_SOCKET, cmsg_type=SO_TIMESTAMP_NEW, cmsg_data={tv_sec=1697718583, tv_usec=173863}}], msg_controllen=28, msg_flags=0}, 0) = 16
statx(AT_FDCWD, "/etc/localtime", AT_STATX_SYNC_AS_STAT|AT_NO_AUTOMOUNT, STATX_BASIC_STATS, {stx_mask=STATX_BASIC_STATS|STATX_MNT_ID, stx_attributes=0, stx_mode=S_IFREG|0644, stx_size=111, ...}) = 0
write(1, " (2023-10-19 12:29:43.3068803835"..., 99) = 99
epoll_wait(3, [{events=EPOLLIN, data={u32=4771936, u64=4771936}}], 1, -1) = 1
recvmsg(4, {msg_name={sa_family=AF_CAN, sa_data="\0\0\2\0\0\0"}, msg_namelen=24 => 8, msg_iov=[{iov_base="\204\203\357\230\7\0\0\0\1\22\0\0\0\200O\0", iov_len=72}], msg_iovlen=1, msg_control=[{cmsg_len=28, cmsg_level=SOL_SOCKET, cmsg_type=SO_TIMESTAMP_NEW, cmsg_data={tv_sec=1697718583, tv_usec=174917}}], msg_controllen=28, msg_flags=0}, 0) = 16
statx(AT_FDCWD, "/etc/localtime", AT_STATX_SYNC_AS_STAT|AT_NO_AUTOMOUNT, STATX_BASIC_STATS, {stx_mask=STATX_BASIC_STATS|STATX_MNT_ID, stx_attributes=0, stx_mode=S_IFREG|0644, stx_size=111, ...}) = 0
write(1, " (2023-10-19 12:29:43.3068803835"..., 99) = 99
epoll_wait(3, [{events=EPOLLIN, data={u32=4771936, u64=4771936}}], 1, -1) = 1
recvmsg(4, {msg_name={sa_family=AF_CAN, sa_data="\0\0\2\0\0\0"}, msg_namelen=24 => 8, msg_iov=[{iov_base="\204\203\357\230\7\0\0\0\1\23\0\0\0\200O\0", iov_len=72}], msg_iovlen=1, msg_control=[{cmsg_len=28, cmsg_level=SOL_SOCKET, cmsg_type=SO_TIMESTAMP_NEW, cmsg_data={tv_sec=1697718583, tv_usec=175964}}], msg_controllen=28, msg_flags=0}, 0) = 16
statx(AT_FDCWD, "/etc/localtime", AT_STATX_SYNC_AS_STAT|AT_NO_AUTOMOUNT, STATX_BASIC_STATS, {stx_mask=STATX_BASIC_STATS|STATX_MNT_ID, stx_attributes=0, stx_mode=S_IFREG|0644, stx_size=111, ...}) = 0
write(1, " (2023-10-19 12:29:43.3068803835"..., 99) = 99
epoll_wait(3, [{events=EPOLLIN, data={u32=4771936, u64=4771936}}], 1, -1) = 1
recvmsg(4, {msg_name={sa_family=AF_CAN, sa_data="\0\0\2\0\0\0"}, msg_namelen=24 => 8, msg_iov=[{iov_base="\204\203\357\230\7\0\0\0\1\24\0\0\0\200O\0", iov_len=72}], msg_iovlen=1, msg_control=[{cmsg_len=28, cmsg_level=SOL_SOCKET, cmsg_type=SO_TIMESTAMP_NEW, cmsg_data={tv_sec=1697718583, tv_usec=177025}}], msg_controllen=28, msg_flags=0}, 0) = 16
statx(AT_FDCWD, "/etc/localtime", AT_STATX_SYNC_AS_STAT|AT_NO_AUTOMOUNT, STATX_BASIC_STATS, {stx_mask=STATX_BASIC_STATS|STATX_MNT_ID, stx_attributes=0, stx_mode=S_IFREG|0644, stx_size=111, ...}) = 0
write(1, " (2023-10-19 12:29:43.3068803835"..., 99) = 99
epoll_wait(3, [{events=EPOLLIN, data={u32=4771936, u64=4771936}}], 1, -1) = 1
recvmsg(4, {msg_name={sa_family=AF_CAN, sa_data="\0\0\2\0\0\0"}, msg_namelen=24 => 8, msg_iov=[{iov_base="\204\203\357\230\7\0\0\0\1\25\0\0\0\200O\0", iov_len=72}], msg_iovlen=1, msg_control=[{cmsg_len=28, cmsg_level=SOL_SOCKET, cmsg_type=SO_TIMESTAMP_NEW, cmsg_data={tv_sec=1697718583, tv_usec=178068}}], msg_controllen=28, msg_flags=0}, 0) = 16
statx(AT_FDCWD, "/etc/localtime", AT_STATX_SYNC_AS_STAT|AT_NO_AUTOMOUNT, STATX_BASIC_STATS, {stx_mask=STATX_BASIC_STATS|STATX_MNT_ID, stx_attributes=0, stx_mode=S_IFREG|0644, stx_size=111, ...}) = 0
write(1, " (2023-10-19 12:29:43.3068803835"..., 99) = 99
epoll_wait(3, [{events=EPOLLIN, data={u32=4771936, u64=4771936}}], 1, -1) = 1
recvmsg(4, {msg_name={sa_family=AF_CAN, sa_data="\0\0\2\0\0\0"}, msg_namelen=24 => 8, msg_iov=[{iov_base="\204\203\357\230\7\0\0\0\1\26\0\0\0\200O\0", iov_len=72}], msg_iovlen=1, msg_control=[{cmsg_len=28, cmsg_level=SOL_SOCKET, cmsg_type=SO_TIMESTAMP_NEW, cmsg_data={tv_sec=1697718583, tv_usec=179118}}], msg_controllen=28, msg_flags=0}, 0) = 16
statx(AT_FDCWD, "/etc/localtime", AT_STATX_SYNC_AS_STAT|AT_NO_AUTOMOUNT, STATX_BASIC_STATS, {stx_mask=STATX_BASIC_STATS|STATX_MNT_ID, stx_attributes=0, stx_mode=S_IFREG|0644, stx_size=111, ...}) = 0
write(1, " (2023-10-19 12:29:43.3068803835"..., 99) = 99
epoll_wait(3, [{events=EPOLLIN, data={u32=4771936, u64=4771936}}], 1, -1) = 1
recvmsg(4, {msg_name={sa_family=AF_CAN, sa_data="\0\0\2\0\0\0"}, msg_namelen=24 => 8, msg_iov=[{iov_base="\204\203\357\230\7\0\0\0\1\27\0\0\0\200O\0", iov_len=72}], msg_iovlen=1, msg_control=[{cmsg_len=28, cmsg_level=SOL_SOCKET, cmsg_type=SO_TIMESTAMP_NEW, cmsg_data={tv_sec=1697718583, tv_usec=180166}}], msg_controllen=28, msg_flags=0}, 0) = 16
statx(AT_FDCWD, "/etc/localtime", AT_STATX_SYNC_AS_STAT|AT_NO_AUTOMOUNT, STATX_BASIC_STATS, {stx_mask=STATX_BASIC_STATS|STATX_MNT_ID, stx_attributes=0, stx_mode=S_IFREG|0644, stx_size=111, ...}) = 0
write(1, " (2023-10-19 12:29:43.3068803835"..., 99) = 99
epoll_wait(3, [{events=EPOLLIN, data={u32=4771936, u64=4771936}}], 1, -1) = 1
recvmsg(4, {msg_name={sa_family=AF_CAN, sa_data="\0\0\2\0\0\0"}, msg_namelen=24 => 8, msg_iov=[{iov_base="\204\203\357\230\7\0\0\0\1\30\0\0\0\200O\0", iov_len=72}], msg_iovlen=1, msg_control=[{cmsg_len=28, cmsg_level=SOL_SOCKET, cmsg_type=SO_TIMESTAMP_NEW, cmsg_data={tv_sec=1697718583, tv_usec=181226}}], msg_controllen=28, msg_flags=0}, 0) = 16
statx(AT_FDCWD, "/etc/localtime", AT_STATX_SYNC_AS_STAT|AT_NO_AUTOMOUNT, STATX_BASIC_STATS, {stx_mask=STATX_BASIC_STATS|STATX_MNT_ID, stx_attributes=0, stx_mode=S_IFREG|0644, stx_size=111, ...}) = 0
write(1, " (2023-10-19 12:29:43.3068803835"..., 99) = 99
epoll_wait(3, [{events=EPOLLIN, data={u32=4771936, u64=4771936}}], 1, -1) = 1
recvmsg(4, {msg_name={sa_family=AF_CAN, sa_data="\0\0\2\0\0\0"}, msg_namelen=24 => 8, msg_iov=[{iov_base="\204\203\357\230\7\0\0\0\1\221\0\0\0\0\0\0", iov_len=72}], msg_iovlen=1, msg_control=[{cmsg_len=28, cmsg_level=SOL_SOCKET, cmsg_type=SO_TIMESTAMP_NEW, cmsg_data={tv_sec=1697718583, tv_usec=182279}}], msg_controllen=28, msg_flags=0}, 0) = 16
statx(AT_FDCWD, "/etc/localtime", AT_STATX_SYNC_AS_STAT|AT_NO_AUTOMOUNT, STATX_BASIC_STATS, {stx_mask=STATX_BASIC_STATS|STATX_MNT_ID, stx_attributes=0, stx_mode=S_IFREG|0644, stx_size=111, ...}) = 0
write(1, " (2023-10-19 12:29:43.3068803835"..., 99) = 99
epoll_wait(3, [{events=EPOLLIN, data={u32=4771936, u64=4771936}}], 1, -1) = 1
recvmsg(4, {msg_name={sa_family=AF_CAN, sa_data="\0\0\2\0\0\0"}, msg_namelen=24 => 8, msg_iov=[{iov_base="\203\202\357\230\3\0\0\0\3\377\0\0\0\0\0\0", iov_len=72}], msg_iovlen=1, msg_control=[{cmsg_len=28, cmsg_level=SOL_SOCKET, cmsg_type=SO_TIMESTAMP_NEW, cmsg_data={tv_sec=1697718583, tv_usec=223527}}], msg_controllen=28, msg_flags=MSG_DONTROUTE}, 0) = 16
statx(AT_FDCWD, "/etc/localtime", AT_STATX_SYNC_AS_STAT|AT_NO_AUTOMOUNT, STATX_BASIC_STATS, {stx_mask=STATX_BASIC_STATS|STATX_MNT_ID, stx_attributes=0, stx_mode=S_IFREG|0644, stx_size=111, ...}) = 0
write(1, " (2023-10-19 12:29:43.3068803835"..., 87) = 87
epoll_wait(3, [{events=EPOLLIN, data={u32=4771936, u64=4771936}}], 1, -1) = 1
recvmsg(4, {msg_name={sa_family=AF_CAN, sa_data="\0\0\2\0\0\0"}, msg_namelen=24 => 8, msg_iov=[{iov_base="\202\203\357\230\7\0\0\0\1\21\0\0\0\200O\0", iov_len=72}], msg_iovlen=1, msg_control=[{cmsg_len=28, cmsg_level=SOL_SOCKET, cmsg_type=SO_TIMESTAMP_NEW, cmsg_data={tv_sec=1697718583, tv_usec=224233}}], msg_controllen=28, msg_flags=0}, 0) = 16
statx(AT_FDCWD, "/etc/localtime", AT_STATX_SYNC_AS_STAT|AT_NO_AUTOMOUNT, STATX_BASIC_STATS, {stx_mask=STATX_BASIC_STATS|STATX_MNT_ID, stx_attributes=0, stx_mode=S_IFREG|0644, stx_size=111, ...}) = 0
write(1, " (2023-10-19 12:29:43.3068803835"..., 99) = 99
epoll_wait(3, [{events=EPOLLIN, data={u32=4771936, u64=4771936}}], 1, -1) = 1
recvmsg(4, {msg_name={sa_family=AF_CAN, sa_data="\0\0\2\0\0\0"}, msg_namelen=24 => 8, msg_iov=[{iov_base="\202\203\357\230\7\0\0\0\1\22\0\0\0\200O\0", iov_len=72}], msg_iovlen=1, msg_control=[{cmsg_len=28, cmsg_level=SOL_SOCKET, cmsg_type=SO_TIMESTAMP_NEW, cmsg_data={tv_sec=1697718583, tv_usec=225292}}], msg_controllen=28, msg_flags=0}, 0) = 16
statx(AT_FDCWD, "/etc/localtime", AT_STATX_SYNC_AS_STAT|AT_NO_AUTOMOUNT, STATX_BASIC_STATS, {stx_mask=STATX_BASIC_STATS|STATX_MNT_ID, stx_attributes=0, stx_mode=S_IFREG|0644, stx_size=111, ...}) = 0
write(1, " (2023-10-19 12:29:43.3068803835"..., 99) = 99
epoll_wait(3, [{events=EPOLLIN, data={u32=4771936, u64=4771936}}], 1, -1) = 1
recvmsg(4, {msg_name={sa_family=AF_CAN, sa_data="\0\0\2\0\0\0"}, msg_namelen=24 => 8, msg_iov=[{iov_base="\202\203\357\230\7\0\0\0\1\23\0\0\0\200O\0", iov_len=72}], msg_iovlen=1, msg_control=[{cmsg_len=28, cmsg_level=SOL_SOCKET, cmsg_type=SO_TIMESTAMP_NEW, cmsg_data={tv_sec=1697718583, tv_usec=226337}}], msg_controllen=28, msg_flags=0}, 0) = 16
statx(AT_FDCWD, "/etc/localtime", AT_STATX_SYNC_AS_STAT|AT_NO_AUTOMOUNT, STATX_BASIC_STATS, {stx_mask=STATX_BASIC_STATS|STATX_MNT_ID, stx_attributes=0, stx_mode=S_IFREG|0644, stx_size=111, ...}) = 0
write(1, " (2023-10-19 12:29:43.3068803835"..., 99) = 99
epoll_wait(3, [{events=EPOLLIN, data={u32=4771936, u64=4771936}}], 1, -1) = 1
recvmsg(4, {msg_name={sa_family=AF_CAN, sa_data="\0\0\2\0\0\0"}, msg_namelen=24 => 8, msg_iov=[{iov_base="\202\203\357\230\7\0\0\0\1\24\0\0\0\200O\0", iov_len=72}], msg_iovlen=1, msg_control=[{cmsg_len=28, cmsg_level=SOL_SOCKET, cmsg_type=SO_TIMESTAMP_NEW, cmsg_data={tv_sec=1697718583, tv_usec=227400}}], msg_controllen=28, msg_flags=0}, 0) = 16
statx(AT_FDCWD, "/etc/localtime", AT_STATX_SYNC_AS_STAT|AT_NO_AUTOMOUNT, STATX_BASIC_STATS, {stx_mask=STATX_BASIC_STATS|STATX_MNT_ID, stx_attributes=0, stx_mode=S_IFREG|0644, stx_size=111, ...}) = 0
write(1, " (2023-10-19 12:29:43.3068803835"..., 99) = 99
epoll_wait(3, [{events=EPOLLIN, data={u32=4771936, u64=4771936}}], 1, -1) = 1
recvmsg(4, {msg_name={sa_family=AF_CAN, sa_data="\0\0\2\0\0\0"}, msg_namelen=24 => 8, msg_iov=[{iov_base="\202\203\357\230\7\0\0\0\1\25\0\0\0\200O\0", iov_len=72}], msg_iovlen=1, msg_control=[{cmsg_len=28, cmsg_level=SOL_SOCKET, cmsg_type=SO_TIMESTAMP_NEW, cmsg_data={tv_sec=1697718583, tv_usec=228443}}], msg_controllen=28, msg_flags=0}, 0) = 16
statx(AT_FDCWD, "/etc/localtime", AT_STATX_SYNC_AS_STAT|AT_NO_AUTOMOUNT, STATX_BASIC_STATS, {stx_mask=STATX_BASIC_STATS|STATX_MNT_ID, stx_attributes=0, stx_mode=S_IFREG|0644, stx_size=111, ...}) = 0
write(1, " (2023-10-19 12:29:43.3068803835"..., 99) = 99
epoll_wait(3, [{events=EPOLLIN, data={u32=4771936, u64=4771936}}], 1, -1) = 1
recvmsg(4, {msg_name={sa_family=AF_CAN, sa_data="\0\0\2\0\0\0"}, msg_namelen=24 => 8, msg_iov=[{iov_base="\202\203\357\230\7\0\0\0\1\26\0\0\0\200O\0", iov_len=72}], msg_iovlen=1, msg_control=[{cmsg_len=28, cmsg_level=SOL_SOCKET, cmsg_type=SO_TIMESTAMP_NEW, cmsg_data={tv_sec=1697718583, tv_usec=229503}}], msg_controllen=28, msg_flags=0}, 0) = 16
statx(AT_FDCWD, "/etc/localtime", AT_STATX_SYNC_AS_STAT|AT_NO_AUTOMOUNT, STATX_BASIC_STATS, {stx_mask=STATX_BASIC_STATS|STATX_MNT_ID, stx_attributes=0, stx_mode=S_IFREG|0644, stx_size=111, ...}) = 0
write(1, " (2023-10-19 12:29:43.3068803835"..., 99) = 99
epoll_wait(3, [{events=EPOLLIN, data={u32=4771936, u64=4771936}}], 1, -1) = 1
recvmsg(4, {msg_name={sa_family=AF_CAN, sa_data="\0\0\2\0\0\0"}, msg_namelen=24 => 8, msg_iov=[{iov_base="\202\203\357\230\7\0\0\0\1\27\0\0\0\200O\0", iov_len=72}], msg_iovlen=1, msg_control=[{cmsg_len=28, cmsg_level=SOL_SOCKET, cmsg_type=SO_TIMESTAMP_NEW, cmsg_data={tv_sec=1697718583, tv_usec=230543}}], msg_controllen=28, msg_flags=0}, 0) = 16
statx(AT_FDCWD, "/etc/localtime", AT_STATX_SYNC_AS_STAT|AT_NO_AUTOMOUNT, STATX_BASIC_STATS, {stx_mask=STATX_BASIC_STATS|STATX_MNT_ID, stx_attributes=0, stx_mode=S_IFREG|0644, stx_size=111, ...}) = 0
write(1, " (2023-10-19 12:29:43.3068803835"..., 99) = 99
epoll_wait(3, [{events=EPOLLIN, data={u32=4771936, u64=4771936}}], 1, -1) = 1
recvmsg(4, {msg_name={sa_family=AF_CAN, sa_data="\0\0\2\0\0\0"}, msg_namelen=24 => 8, msg_iov=[{iov_base="\202\203\357\230\7\0\0\0\1\30\0\0\0\200O\0", iov_len=72}], msg_iovlen=1, msg_control=[{cmsg_len=28, cmsg_level=SOL_SOCKET, cmsg_type=SO_TIMESTAMP_NEW, cmsg_data={tv_sec=1697718583, tv_usec=231598}}], msg_controllen=28, msg_flags=0}, 0) = 16
statx(AT_FDCWD, "/etc/localtime", AT_STATX_SYNC_AS_STAT|AT_NO_AUTOMOUNT, STATX_BASIC_STATS, {stx_mask=STATX_BASIC_STATS|STATX_MNT_ID, stx_attributes=0, stx_mode=S_IFREG|0644, stx_size=111, ...}) = 0
write(1, " (2023-10-19 12:29:43.3068803835"..., 99) = 99
epoll_wait(3, [{events=EPOLLIN, data={u32=4771936, u64=4771936}}], 1, -1) = 1
recvmsg(4, {msg_name={sa_family=AF_CAN, sa_data="\0\0\2\0\0\0"}, msg_namelen=24 => 8, msg_iov=[{iov_base="\202\203\357\230\7\0\0\0\1\221\0\0\0\0\0\0", iov_len=72}], msg_iovlen=1, msg_control=[{cmsg_len=28, cmsg_level=SOL_SOCKET, cmsg_type=SO_TIMESTAMP_NEW, cmsg_data={tv_sec=1697718583, tv_usec=232654}}], msg_controllen=28, msg_flags=0}, 0) = 16
statx(AT_FDCWD, "/etc/localtime", AT_STATX_SYNC_AS_STAT|AT_NO_AUTOMOUNT, STATX_BASIC_STATS, {stx_mask=STATX_BASIC_STATS|STATX_MNT_ID, stx_attributes=0, stx_mode=S_IFREG|0644, stx_size=111, ...}) = 0
write(1, " (2023-10-19 12:29:43.3068803835"..., 99) = 99
epoll_wait(3, [{events=EPOLLIN, data={u32=4771936, u64=4771936}}], 1, -1) = 1
recvmsg(4, {msg_name={sa_family=AF_CAN, sa_data="\0\0\2\0\0\0"}, msg_namelen=24 => 8, msg_iov=[{iov_base="\203\357\357\230\3\0\0\0\3\0\0\0\0\0\0\0", iov_len=72}], msg_iovlen=1, msg_control=[{cmsg_len=28, cmsg_level=SOL_SOCKET, cmsg_type=SO_TIMESTAMP_NEW, cmsg_data={tv_sec=1697718583, tv_usec=273736}}], msg_controllen=28, msg_flags=MSG_DONTROUTE}, 0) = 16
statx(AT_FDCWD, "/etc/localtime", AT_STATX_SYNC_AS_STAT|AT_NO_AUTOMOUNT, STATX_BASIC_STATS, {stx_mask=STATX_BASIC_STATS|STATX_MNT_ID, stx_attributes=0, stx_mode=S_IFREG|0644, stx_size=111, ...}) = 0
write(1, " (2023-10-19 12:29:43.3068803835"..., 87) = 87
epoll_wait(3, [{events=EPOLLIN, data={u32=4771936, u64=4771936}}], 1, -1) = 1
recvmsg(4, {msg_name={sa_family=AF_CAN, sa_data="\0\0\2\0\0\0"}, msg_namelen=24 => 8, msg_iov=[{iov_base="\357\203\357\230\7\0\0\0\0015\0x\276\277@\0", iov_len=72}], msg_iovlen=1, msg_control=[{cmsg_len=28, cmsg_level=SOL_SOCKET, cmsg_type=SO_TIMESTAMP_NEW, cmsg_data={tv_sec=1697718583, tv_usec=274528}}], msg_controllen=28, msg_flags=0}, 0) = 16
statx(AT_FDCWD, "/etc/localtime", AT_STATX_SYNC_AS_STAT|AT_NO_AUTOMOUNT, STATX_BASIC_STATS, {stx_mask=STATX_BASIC_STATS|STATX_MNT_ID, stx_attributes=0, stx_mode=S_IFREG|0644, stx_size=111, ...}) = 0
write(1, " (2023-10-19 12:29:43.3068803835"..., 99) = 99
epoll_wait(3, [{events=EPOLLIN, data={u32=4771936, u64=4771936}}], 1, -1) = 1
recvmsg(4, {msg_name={sa_family=AF_CAN, sa_data="\0\0\2\0\0\0"}, msg_namelen=24 => 8, msg_iov=[{iov_base="\357\203\357\230\7\0\0\0\0016\0\0\0\0\0\0", iov_len=72}], msg_iovlen=1, msg_control=[{cmsg_len=28, cmsg_level=SOL_SOCKET, cmsg_type=SO_TIMESTAMP_NEW, cmsg_data={tv_sec=1697718583, tv_usec=275553}}], msg_controllen=28, msg_flags=0}, 0) = 16
statx(AT_FDCWD, "/etc/localtime", AT_STATX_SYNC_AS_STAT|AT_NO_AUTOMOUNT, STATX_BASIC_STATS, {stx_mask=STATX_BASIC_STATS|STATX_MNT_ID, stx_attributes=0, stx_mode=S_IFREG|0644, stx_size=111, ...}) = 0
write(1, " (2023-10-19 12:29:43.3068803835"..., 99) = 99
epoll_wait(3, [{events=EPOLLIN, data={u32=4771936, u64=4771936}}], 1, -1) = 1
recvmsg(4, {msg_name={sa_family=AF_CAN, sa_data="\0\0\2\0\0\0"}, msg_namelen=24 => 8, msg_iov=[{iov_base="\357\203\357\230\7\0\0\0\0017\0\0\0\0\0\0", iov_len=72}], msg_iovlen=1, msg_control=[{cmsg_len=28, cmsg_level=SOL_SOCKET, cmsg_type=SO_TIMESTAMP_NEW, cmsg_data={tv_sec=1697718583, tv_usec=276458}}], msg_controllen=28, msg_flags=0}, 0) = 16
statx(AT_FDCWD, "/etc/localtime", AT_STATX_SYNC_AS_STAT|AT_NO_AUTOMOUNT, STATX_BASIC_STATS, {stx_mask=STATX_BASIC_STATS|STATX_MNT_ID, stx_attributes=0, stx_mode=S_IFREG|0644, stx_size=111, ...}) = 0
write(1, " (2023-10-19 12:29:43.3068803835"..., 99) = 99
epoll_wait(3, [{events=EPOLLIN, data={u32=4771936, u64=4771936}}], 1, -1) = 1
recvmsg(4, {msg_name={sa_family=AF_CAN, sa_data="\0\0\2\0\0\0"}, msg_namelen=24 => 8, msg_iov=[{iov_base="\357\203\357\230\7\0\0\0\1a\0\240\250\377?\0", iov_len=72}], msg_iovlen=1, msg_control=[{cmsg_len=28, cmsg_level=SOL_SOCKET, cmsg_type=SO_TIMESTAMP_NEW, cmsg_data={tv_sec=1697718583, tv_usec=277451}}], msg_controllen=28, msg_flags=0}, 0) = 16
statx(AT_FDCWD, "/etc/localtime", AT_STATX_SYNC_AS_STAT|AT_NO_AUTOMOUNT, STATX_BASIC_STATS, {stx_mask=STATX_BASIC_STATS|STATX_MNT_ID, stx_attributes=0, stx_mode=S_IFREG|0644, stx_size=111, ...}) = 0
write(1, " (2023-10-19 12:29:43.3068803835"..., 99) = 99
epoll_wait(3, [{events=EPOLLIN, data={u32=4771936, u64=4771936}}], 1, -1) = 1
recvmsg(4, {msg_name={sa_family=AF_CAN, sa_data="\0\0\2\0\0\0"}, msg_namelen=24 => 8, msg_iov=[{iov_base="\357\203\357\230\7\0\0\0\1R\0`t$B\0", iov_len=72}], msg_iovlen=1, msg_control=[{cmsg_len=28, cmsg_level=SOL_SOCKET, cmsg_type=SO_TIMESTAMP_NEW, cmsg_data={tv_sec=1697718583, tv_usec=278513}}], msg_controllen=28, msg_flags=0}, 0) = 16
statx(AT_FDCWD, "/etc/localtime", AT_STATX_SYNC_AS_STAT|AT_NO_AUTOMOUNT, STATX_BASIC_STATS, {stx_mask=STATX_BASIC_STATS|STATX_MNT_ID, stx_attributes=0, stx_mode=S_IFREG|0644, stx_size=111, ...}) = 0
write(1, " (2023-10-19 12:29:43.3068803835"..., 99) = 99
epoll_wait(3, [{events=EPOLLIN, data={u32=4771936, u64=4771936}}], 1, -1) = 1
recvmsg(4, {msg_name={sa_family=AF_CAN, sa_data="\0\0\2\0\0\0"}, msg_namelen=24 => 8, msg_iov=[{iov_base="\357\203\357\230\7\0\0\0\1d\0\2179\31@\0", iov_len=72}], msg_iovlen=1, msg_control=[{cmsg_len=28, cmsg_level=SOL_SOCKET, cmsg_type=SO_TIMESTAMP_NEW, cmsg_data={tv_sec=1697718583, tv_usec=279442}}], msg_controllen=28, msg_flags=0}, 0) = 16
statx(AT_FDCWD, "/etc/localtime", AT_STATX_SYNC_AS_STAT|AT_NO_AUTOMOUNT, STATX_BASIC_STATS, {stx_mask=STATX_BASIC_STATS|STATX_MNT_ID, stx_attributes=0, stx_mode=S_IFREG|0644, stx_size=111, ...}) = 0
write(1, " (2023-10-19 12:29:43.3068803835"..., 99) = 99
epoll_wait(3, [{events=EPOLLIN, data={u32=4771936, u64=4771936}}], 1, -1) = 1
recvmsg(4, {msg_name={sa_family=AF_CAN, sa_data="\0\0\2\0\0\0"}, msg_namelen=24 => 8, msg_iov=[{iov_base="\357\203\357\230\7\0\0\0\1S\0\2179\31@\0", iov_len=72}], msg_iovlen=1, msg_control=[{cmsg_len=28, cmsg_level=SOL_SOCKET, cmsg_type=SO_TIMESTAMP_NEW, cmsg_data={tv_sec=1697718583, tv_usec=280523}}], msg_controllen=28, msg_flags=0}, 0) = 16
statx(AT_FDCWD, "/etc/localtime", AT_STATX_SYNC_AS_STAT|AT_NO_AUTOMOUNT, STATX_BASIC_STATS, {stx_mask=STATX_BASIC_STATS|STATX_MNT_ID, stx_attributes=0, stx_mode=S_IFREG|0644, stx_size=111, ...}) = 0
write(1, " (2023-10-19 12:29:43.3068803835"..., 99) = 99
epoll_wait(3, [{events=EPOLLIN, data={u32=4771936, u64=4771936}}], 1, -1) = 1
recvmsg(4, {msg_name={sa_family=AF_CAN, sa_data="\0\0\2\0\0\0"}, msg_namelen=24 => 8, msg_iov=[{iov_base="\357\203\357\230\7\0\0\0\1q\0f\306\303B\0", iov_len=72}], msg_iovlen=1, msg_control=[{cmsg_len=28, cmsg_level=SOL_SOCKET, cmsg_type=SO_TIMESTAMP_NEW, cmsg_data={tv_sec=1697718583, tv_usec=281426}}], msg_controllen=28, msg_flags=0}, 0) = 16
statx(AT_FDCWD, "/etc/localtime", AT_STATX_SYNC_AS_STAT|AT_NO_AUTOMOUNT, STATX_BASIC_STATS, {stx_mask=STATX_BASIC_STATS|STATX_MNT_ID, stx_attributes=0, stx_mode=S_IFREG|0644, stx_size=111, ...}) = 0
write(1, " (2023-10-19 12:29:43.3068803835"..., 99) = 99
epoll_wait(3, [{events=EPOLLIN, data={u32=4771936, u64=4771936}}], 1, -1) = 1
recvmsg(4, {msg_name={sa_family=AF_CAN, sa_data="\0\0\2\0\0\0"}, msg_namelen=24 => 8, msg_iov=[{iov_base="\357\203\357\230\7\0\0\0\1x\0\0\0\0\0\0", iov_len=72}], msg_iovlen=1, msg_control=[{cmsg_len=28, cmsg_level=SOL_SOCKET, cmsg_type=SO_TIMESTAMP_NEW, cmsg_data={tv_sec=1697718583, tv_usec=282457}}], msg_controllen=28, msg_flags=0}, 0) = 16
statx(AT_FDCWD, "/etc/localtime", AT_STATX_SYNC_AS_STAT|AT_NO_AUTOMOUNT, STATX_BASIC_STATS, {stx_mask=STATX_BASIC_STATS|STATX_MNT_ID, stx_attributes=0, stx_mode=S_IFREG|0644, stx_size=111, ...}) = 0
write(1, " (2023-10-19 12:29:43.3068803835"..., 99) = 99
epoll_wait(3, [{events=EPOLLIN, data={u32=4771936, u64=4771936}}], 1, -1) = 1
recvmsg(4, {msg_name={sa_family=AF_CAN, sa_data="\0\0\2\0\0\0"}, msg_namelen=24 => 8, msg_iov=[{iov_base="\357\203\357\230\7\0\0\0\1t\0\0\0\0\0\0", iov_len=72}], msg_iovlen=1, msg_control=[{cmsg_len=28, cmsg_level=SOL_SOCKET, cmsg_type=SO_TIMESTAMP_NEW, cmsg_data={tv_sec=1697718583, tv_usec=283458}}], msg_controllen=28, msg_flags=0}, 0) = 16
statx(AT_FDCWD, "/etc/localtime", AT_STATX_SYNC_AS_STAT|AT_NO_AUTOMOUNT, STATX_BASIC_STATS, {stx_mask=STATX_BASIC_STATS|STATX_MNT_ID, stx_attributes=0, stx_mode=S_IFREG|0644, stx_size=111, ...}) = 0
write(1, " (2023-10-19 12:29:43.3068803835"..., 99) = 99
epoll_wait(3, [{events=EPOLLIN, data={u32=4771936, u64=4771936}}], 1, -1) = 1
recvmsg(4, {msg_name={sa_family=AF_CAN, sa_data="\0\0\2\0\0\0"}, msg_namelen=24 => 8, msg_iov=[{iov_base="\357\203\357\230\7\0\0\0\1\203\0\0\0\0\0\0", iov_len=72}], msg_iovlen=1, msg_control=[{cmsg_len=28, cmsg_level=SOL_SOCKET, cmsg_type=SO_TIMESTAMP_NEW, cmsg_data={tv_sec=1697718583, tv_usec=284538}}], msg_controllen=28, msg_flags=0}, 0) = 16
statx(AT_FDCWD, "/etc/localtime", AT_STATX_SYNC_AS_STAT|AT_NO_AUTOMOUNT, STATX_BASIC_STATS, {stx_mask=STATX_BASIC_STATS|STATX_MNT_ID, stx_attributes=0, stx_mode=S_IFREG|0644, stx_size=111, ...}) = 0
write(1, " (2023-10-19 12:29:43.3068803835"..., 99) = 99
epoll_wait(3, 0xbec53860, 1, -1)        = -1 EINTR (Interrupted system call)
--- SIGINT {si_signo=SIGINT, si_code=SI_KERNEL} ---
sigreturn({mask=[]})                    = -1 EINTR (Interrupted system call)
close(4)                                = 0
close(3)                                = 0
exit_group(130)                         = ?
+++ exited with 130 +++

marckleinebudde · 2023-10-19T12:35:01Z

please add the patch from #469 (comment), compile and re-run.

Kuzma30 · 2023-10-19T12:45:32Z

Sorry

strace -o /tmp/log candump any,0:0,#FFFFFFFF -cexdtA
main: cmsg_type=63, SO_TIMESTAMP=63
 (2023-10-19 12:43:41.4294967295)  can0  TX - -  18EF8183   [3]  03 FF 00
main: cmsg_type=63, SO_TIMESTAMP=63
 (2023-10-19 12:43:41.3068484347)  can0  RX - -  18EF8381   [7]  01 11 00 00 00 80 4F
main: cmsg_type=63, SO_TIMESTAMP=63
 (2023-10-19 12:43:41.3068484347)  can0  RX - -  18EF8381   [7]  01 12 00 00 00 80 4F
main: cmsg_type=63, SO_TIMESTAMP=63
 (2023-10-19 12:43:41.3068484347)  can0  RX - -  18EF8381   [7]  01 13 00 00 00 80 4F
main: cmsg_type=63, SO_TIMESTAMP=63
 (2023-10-19 12:43:41.3068484347)  can0  RX - -  18EF8381   [7]  01 14 00 00 00 80 4F
main: cmsg_type=63, SO_TIMESTAMP=63
 (2023-10-19 12:43:41.3068484347)  can0  RX - -  18EF8381   [7]  01 15 00 00 00 80 4F
main: cmsg_type=63, SO_TIMESTAMP=63
 (2023-10-19 12:43:41.3068484347)  can0  RX - -  18EF8381   [7]  01 16 00 00 00 80 4F
main: cmsg_type=63, SO_TIMESTAMP=63
 (2023-10-19 12:43:41.3068484347)  can0  RX - -  18EF8381   [7]  01 17 00 00 00 80 4F
main: cmsg_type=63, SO_TIMESTAMP=63
 (2023-10-19 12:43:41.3068484347)  can0  RX - -  18EF8381   [7]  01 18 00 00 00 80 4F
main: cmsg_type=63, SO_TIMESTAMP=63
 (2023-10-19 12:43:41.3068484347)  can0  RX - -  18EF8381   [7]  01 91 00 00 00 00 00
main: cmsg_type=63, SO_TIMESTAMP=63
 (2023-10-19 12:43:41.3068484347)  can0  TX - -  18EF8483   [3]  03 FF 00
main: cmsg_type=63, SO_TIMESTAMP=63
 (2023-10-19 12:43:41.3068484347)  can0  RX - -  18EF8384   [7]  01 11 00 00 00 80 4F
main: cmsg_type=63, SO_TIMESTAMP=63
 (2023-10-19 12:43:41.3068484347)  can0  RX - -  18EF8384   [7]  01 12 00 00 00 80 4F
main: cmsg_type=63, SO_TIMESTAMP=63
 (2023-10-19 12:43:41.3068484347)  can0  RX - -  18EF8384   [7]  01 13 00 00 00 80 4F
main: cmsg_type=63, SO_TIMESTAMP=63
 (2023-10-19 12:43:41.3068484347)  can0  RX - -  18EF8384   [7]  01 14 00 00 00 80 4F
main: cmsg_type=63, SO_TIMESTAMP=63
 (2023-10-19 12:43:41.3068484347)  can0  RX - -  18EF8384   [7]  01 15 00 00 00 80 4F
main: cmsg_type=63, SO_TIMESTAMP=63
 (2023-10-19 12:43:41.3068484347)  can0  RX - -  18EF8384   [7]  01 16 00 00 00 80 4F
main: cmsg_type=63, SO_TIMESTAMP=63
 (2023-10-19 12:43:41.3068484347)  can0  RX - -  18EF8384   [7]  01 17 00 00 00 80 4F
main: cmsg_type=63, SO_TIMESTAMP=63
 (2023-10-19 12:43:41.3068484347)  can0  RX - -  18EF8384   [7]  01 18 00 00 00 80 4F
main: cmsg_type=63, SO_TIMESTAMP=63
 (2023-10-19 12:43:41.3068484347)  can0  RX - -  18EF8384   [7]  01 91 00 00 00 00 00
main: cmsg_type=63, SO_TIMESTAMP=63
 (2023-10-19 12:43:41.3068484347)  can0  TX - -  18EF8283   [3]  03 FF 00
main: cmsg_type=63, SO_TIMESTAMP=63
 (2023-10-19 12:43:41.3068484347)  can0  RX - -  18EF8382   [7]  01 11 00 00 00 80 4F
main: cmsg_type=63, SO_TIMESTAMP=63
 (2023-10-19 12:43:41.3068484347)  can0  RX - -  18EF8382   [7]  01 12 00 00 00 80 4F
main: cmsg_type=63, SO_TIMESTAMP=63
 (2023-10-19 12:43:41.3068484347)  can0  RX - -  18EF8382   [7]  01 13 00 00 00 80 4F
main: cmsg_type=63, SO_TIMESTAMP=63
 (2023-10-19 12:43:41.3068484347)  can0  RX - -  18EF8382   [7]  01 14 00 00 00 80 4F
main: cmsg_type=63, SO_TIMESTAMP=63
 (2023-10-19 12:43:41.3068484347)  can0  RX - -  18EF8382   [7]  01 15 00 00 00 80 4F
main: cmsg_type=63, SO_TIMESTAMP=63
 (2023-10-19 12:43:41.3068484347)  can0  RX - -  18EF8382   [7]  01 16 00 00 00 80 4F
main: cmsg_type=63, SO_TIMESTAMP=63
 (2023-10-19 12:43:41.3068484347)  can0  RX - -  18EF8382   [7]  01 17 00 00 00 80 4F
main: cmsg_type=63, SO_TIMESTAMP=63
 (2023-10-19 12:43:41.3068484347)  can0  RX - -  18EF8382   [7]  01 18 00 00 00 80 4F
main: cmsg_type=63, SO_TIMESTAMP=63
 (2023-10-19 12:43:41.3068484347)  can0  RX - -  18EF8382   [7]  01 91 00 00 00 00 00
main: cmsg_type=63, SO_TIMESTAMP=63
 (2023-10-19 12:43:41.3068484347)  can0  TX - -  18EFEF83   [3]  03 00 00
main: cmsg_type=63, SO_TIMESTAMP=63
 (2023-10-19 12:43:41.3068484347)  can0  RX - -  18EF83EF   [7]  01 35 00 8C BE BF 40
main: cmsg_type=63, SO_TIMESTAMP=63
 (2023-10-19 12:43:41.3068484347)  can0  RX - -  18EF83EF   [7]  01 36 00 00 00 00 00
main: cmsg_type=63, SO_TIMESTAMP=63
 (2023-10-19 12:43:41.3068484347)  can0  RX - -  18EF83EF   [7]  01 37 00 00 00 00 00
main: cmsg_type=63, SO_TIMESTAMP=63
 (2023-10-19 12:43:41.3068484347)  can0  RX - -  18EF83EF   [7]  01 61 00 BA A8 FF 3F
main: cmsg_type=63, SO_TIMESTAMP=63
 (2023-10-19 12:43:41.3068484347)  can0  RX - -  18EF83EF   [7]  01 52 00 C3 14 2A 42
main: cmsg_type=63, SO_TIMESTAMP=63
 (2023-10-19 12:43:41.3068484347)  can0  RX - -  18EF83EF   [7]  01 64 00 8F 39 19 40
main: cmsg_type=63, SO_TIMESTAMP=63
 (2023-10-19 12:43:41.3068484347)  can0  RX - -  18EF83EF   [7]  01 53 00 8F 39 19 40
main: cmsg_type=63, SO_TIMESTAMP=63
 (2023-10-19 12:43:41.3068484347)  can0  RX - -  18EF83EF   [7]  01 71 00 66 C6 C3 42
main: cmsg_type=63, SO_TIMESTAMP=63
 (2023-10-19 12:43:41.3068484347)  can0  RX - -  18EF83EF   [7]  01 78 00 00 00 00 00
main: cmsg_type=63, SO_TIMESTAMP=63
 (2023-10-19 12:43:41.3068484347)  can0  RX - -  18EF83EF   [7]  01 74 00 00 00 00 00
main: cmsg_type=63, SO_TIMESTAMP=63
 (2023-10-19 12:43:41.3068484347)  can0  RX - -  18EF83EF   [7]  01 83 00 00 00 00 00
^Croot@b2qt-raspberrypi4:/libcat /tmp/log
execve("/usr/bin/candump", ["candump", "any,0:0,#FFFFFFFF", "-cexdtA"], 0xbe9a8d00 /* 18 vars */) = 0
brk(NULL)                               = 0x15d1000
mmap2(NULL, 8192, PROT_READ|PROT_WRITE, MAP_PRIVATE|MAP_ANONYMOUS, -1, 0) = 0xb6f2c000
access("/etc/ld.so.preload", R_OK)      = -1 ENOENT (No such file or directory)
openat(AT_FDCWD, "/etc/ld.so.cache", O_RDONLY|O_LARGEFILE|O_CLOEXEC) = 3
statx(3, "", AT_STATX_SYNC_AS_STAT|AT_NO_AUTOMOUNT|AT_EMPTY_PATH, STATX_BASIC_STATS, {stx_mask=STATX_BASIC_STATS|STATX_MNT_ID, stx_attributes=0, stx_mode=S_IFREG|0644, stx_size=31226, ...}) = 0
mmap2(NULL, 31226, PROT_READ, MAP_PRIVATE, 3, 0) = 0xb6f24000
close(3)                                = 0
openat(AT_FDCWD, "/usr/lib/libc.so.6", O_RDONLY|O_LARGEFILE|O_CLOEXEC) = 3
read(3, "\177ELF\1\1\1\0\0\0\0\0\0\0\0\0\3\0(\0\1\0\0\0\271\346\1\0004\0\0\0"..., 512) = 512
statx(3, "", AT_STATX_SYNC_AS_STAT|AT_NO_AUTOMOUNT|AT_EMPTY_PATH, STATX_BASIC_STATS, {stx_mask=STATX_BASIC_STATS|STATX_MNT_ID, stx_attributes=0, stx_mode=S_IFREG|0755, stx_size=1146976, ...}) = 0
mmap2(NULL, 1184344, PROT_READ|PROT_EXEC, MAP_PRIVATE|MAP_DENYWRITE, 3, 0) = 0xb6e02000
mmap2(0xb6eff000, 110592, PROT_READ|PROT_WRITE, MAP_PRIVATE|MAP_FIXED|MAP_DENYWRITE, 3, 0xfc000) = 0xb6eff000
mmap2(0xb6f1a000, 37464, PROT_READ|PROT_WRITE, MAP_PRIVATE|MAP_FIXED|MAP_ANONYMOUS, -1, 0) = 0xb6f1a000
close(3)                                = 0
set_tls(0xb6f2d0a0)                     = 0
set_tid_address(0xb6f2cc08)             = 2729
set_robust_list(0xb6f2cc0c, 12)         = 0
rseq(0xb6f2d080, 0x20, 0, 0xe7f5def3)   = 0
mprotect(0xb6eff000, 106496, PROT_READ) = 0
mprotect(0x4b3000, 4096, PROT_READ)     = 0
mprotect(0xb6f49000, 8192, PROT_READ)   = 0
ugetrlimit(RLIMIT_STACK, {rlim_cur=8192*1024, rlim_max=RLIM_INFINITY}) = 0
munmap(0xb6f24000, 31226)               = 0
rt_sigaction(SIGTERM, {sa_handler=0x4b005d, sa_mask=[TERM], sa_flags=SA_RESTORER|SA_RESTART, sa_restorer=0xb6e2f031}, {sa_handler=SIG_DFL, sa_mask=[], sa_flags=0}, 8) = 0
rt_sigaction(SIGHUP, {sa_handler=0x4b005d, sa_mask=[HUP], sa_flags=SA_RESTORER|SA_RESTART, sa_restorer=0xb6e2f031}, {sa_handler=SIG_DFL, sa_mask=[], sa_flags=0}, 8) = 0
rt_sigaction(SIGINT, {sa_handler=0x4b005d, sa_mask=[INT], sa_flags=SA_RESTORER|SA_RESTART, sa_restorer=0xb6e2f031}, {sa_handler=SIG_DFL, sa_mask=[], sa_flags=0}, 8) = 0
epoll_create(1)                         = 3
socket(AF_CAN, SOCK_RAW, CAN_RAW)       = 4
epoll_ctl(3, EPOLL_CTL_ADD, 4, {events=EPOLLIN, data={u32=4931680, u64=4931680}}) = 0
getrandom("\xeb\x12\x23\x8c", 4, GRND_NONBLOCK) = 4
brk(NULL)                               = 0x15d1000
brk(0x15f2000)                          = 0x15f2000
setsockopt(4, SOL_CAN_RAW, CAN_RAW_ERR_FILTER, [-1], 4) = 0
setsockopt(4, SOL_CAN_RAW, CAN_RAW_FILTER, "\0\0\0\0\0\0\0\0", 8) = 0
setsockopt(4, SOL_CAN_RAW, CAN_RAW_FD_FRAMES, [1], 4) = 0
setsockopt(4, SOL_SOCKET, SO_TIMESTAMP_NEW, [1], 4) = 0
setsockopt(4, SOL_SOCKET, SO_RXQ_OVFL, [1], 4) = 0
bind(4, {sa_family=AF_CAN, sa_data="\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0"}, 24) = 0
epoll_wait(3, [{events=EPOLLIN, data={u32=4931680, u64=4931680}}], 1, -1) = 1
recvmsg(4, {msg_name={sa_family=AF_CAN, sa_data="\0\0\2\0\0\0"}, msg_namelen=24 => 8, msg_iov=[{iov_base="\203\201\357\230\3\0\0\0\3\377\0\0\0\0\0\0", iov_len=72}], msg_iovlen=1, msg_control=[{cmsg_len=28, cmsg_level=SOL_SOCKET, cmsg_type=SO_TIMESTAMP_NEW, cmsg_data={tv_sec=1697719421, tv_usec=122536}}], msg_controllen=28, msg_flags=MSG_DONTROUTE}, 0) = 16
ioctl(4, SIOCGIFNAME, {ifr_ifindex=2, ifr_name="can0"}) = 0
statx(1, "", AT_STATX_SYNC_AS_STAT|AT_NO_AUTOMOUNT|AT_EMPTY_PATH, STATX_BASIC_STATS, {stx_mask=STATX_BASIC_STATS|STATX_MNT_ID, stx_attributes=0, stx_mode=S_IFCHR|0620, stx_size=0, ...}) = 0
write(1, "main: cmsg_type=63, SO_TIMESTAMP"..., 36) = 36
openat(AT_FDCWD, "/etc/localtime", O_RDONLY|O_CLOEXEC) = 5
statx(5, "", AT_STATX_SYNC_AS_STAT|AT_NO_AUTOMOUNT|AT_EMPTY_PATH, STATX_BASIC_STATS, {stx_mask=STATX_BASIC_STATS|STATX_MNT_ID, stx_attributes=0, stx_mode=S_IFREG|0644, stx_size=111, ...}) = 0
statx(5, "", AT_STATX_SYNC_AS_STAT|AT_NO_AUTOMOUNT|AT_EMPTY_PATH, STATX_BASIC_STATS, {stx_mask=STATX_BASIC_STATS|STATX_MNT_ID, stx_attributes=0, stx_mode=S_IFREG|0644, stx_size=111, ...}) = 0
read(5, "TZif2\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0"..., 4096) = 111
_llseek(5, -60, [51], SEEK_CUR)         = 0
read(5, "TZif2\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0\0"..., 4096) = 60
close(5)                                = 0
write(1, " (2023-10-19 12:43:41.4294967295"..., 87) = 87
epoll_wait(3, [{events=EPOLLIN, data={u32=4931680, u64=4931680}}], 1, -1) = 1
recvmsg(4, {msg_name={sa_family=AF_CAN, sa_data="\0\0\2\0\0\0"}, msg_namelen=24 => 8, msg_iov=[{iov_base="\201\203\357\230\7\0\0\0\1\21\0\0\0\200O\0", iov_len=72}], msg_iovlen=1, msg_control=[{cmsg_len=28, cmsg_level=SOL_SOCKET, cmsg_type=SO_TIMESTAMP_NEW, cmsg_data={tv_sec=1697719421, tv_usec=123233}}], msg_controllen=28, msg_flags=0}, 0) = 16
write(1, "main: cmsg_type=63, SO_TIMESTAMP"..., 36) = 36
statx(AT_FDCWD, "/etc/localtime", AT_STATX_SYNC_AS_STAT|AT_NO_AUTOMOUNT, STATX_BASIC_STATS, {stx_mask=STATX_BASIC_STATS|STATX_MNT_ID, stx_attributes=0, stx_mode=S_IFREG|0644, stx_size=111, ...}) = 0
write(1, " (2023-10-19 12:43:41.3068484347"..., 99) = 99
epoll_wait(3, [{events=EPOLLIN, data={u32=4931680, u64=4931680}}], 1, -1) = 1
recvmsg(4, {msg_name={sa_family=AF_CAN, sa_data="\0\0\2\0\0\0"}, msg_namelen=24 => 8, msg_iov=[{iov_base="\201\203\357\230\7\0\0\0\1\22\0\0\0\200O\0", iov_len=72}], msg_iovlen=1, msg_control=[{cmsg_len=28, cmsg_level=SOL_SOCKET, cmsg_type=SO_TIMESTAMP_NEW, cmsg_data={tv_sec=1697719421, tv_usec=124291}}], msg_controllen=28, msg_flags=0}, 0) = 16
write(1, "main: cmsg_type=63, SO_TIMESTAMP"..., 36) = 36
statx(AT_FDCWD, "/etc/localtime", AT_STATX_SYNC_AS_STAT|AT_NO_AUTOMOUNT, STATX_BASIC_STATS, {stx_mask=STATX_BASIC_STATS|STATX_MNT_ID, stx_attributes=0, stx_mode=S_IFREG|0644, stx_size=111, ...}) = 0
write(1, " (2023-10-19 12:43:41.3068484347"..., 99) = 99
epoll_wait(3, [{events=EPOLLIN, data={u32=4931680, u64=4931680}}], 1, -1) = 1
recvmsg(4, {msg_name={sa_family=AF_CAN, sa_data="\0\0\2\0\0\0"}, msg_namelen=24 => 8, msg_iov=[{iov_base="\201\203\357\230\7\0\0\0\1\23\0\0\0\200O\0", iov_len=72}], msg_iovlen=1, msg_control=[{cmsg_len=28, cmsg_level=SOL_SOCKET, cmsg_type=SO_TIMESTAMP_NEW, cmsg_data={tv_sec=1697719421, tv_usec=125337}}], msg_controllen=28, msg_flags=0}, 0) = 16
write(1, "main: cmsg_type=63, SO_TIMESTAMP"..., 36) = 36
statx(AT_FDCWD, "/etc/localtime", AT_STATX_SYNC_AS_STAT|AT_NO_AUTOMOUNT, STATX_BASIC_STATS, {stx_mask=STATX_BASIC_STATS|STATX_MNT_ID, stx_attributes=0, stx_mode=S_IFREG|0644, stx_size=111, ...}) = 0
write(1, " (2023-10-19 12:43:41.3068484347"..., 99) = 99
epoll_wait(3, [{events=EPOLLIN, data={u32=4931680, u64=4931680}}], 1, -1) = 1
recvmsg(4, {msg_name={sa_family=AF_CAN, sa_data="\0\0\2\0\0\0"}, msg_namelen=24 => 8, msg_iov=[{iov_base="\201\203\357\230\7\0\0\0\1\24\0\0\0\200O\0", iov_len=72}], msg_iovlen=1, msg_control=[{cmsg_len=28, cmsg_level=SOL_SOCKET, cmsg_type=SO_TIMESTAMP_NEW, cmsg_data={tv_sec=1697719421, tv_usec=126398}}], msg_controllen=28, msg_flags=0}, 0) = 16
write(1, "main: cmsg_type=63, SO_TIMESTAMP"..., 36) = 36
statx(AT_FDCWD, "/etc/localtime", AT_STATX_SYNC_AS_STAT|AT_NO_AUTOMOUNT, STATX_BASIC_STATS, {stx_mask=STATX_BASIC_STATS|STATX_MNT_ID, stx_attributes=0, stx_mode=S_IFREG|0644, stx_size=111, ...}) = 0
write(1, " (2023-10-19 12:43:41.3068484347"..., 99) = 99
epoll_wait(3, [{events=EPOLLIN, data={u32=4931680, u64=4931680}}], 1, -1) = 1
recvmsg(4, {msg_name={sa_family=AF_CAN, sa_data="\0\0\2\0\0\0"}, msg_namelen=24 => 8, msg_iov=[{iov_base="\201\203\357\230\7\0\0\0\1\25\0\0\0\200O\0", iov_len=72}], msg_iovlen=1, msg_control=[{cmsg_len=28, cmsg_level=SOL_SOCKET, cmsg_type=SO_TIMESTAMP_NEW, cmsg_data={tv_sec=1697719421, tv_usec=127438}}], msg_controllen=28, msg_flags=0}, 0) = 16
write(1, "main: cmsg_type=63, SO_TIMESTAMP"..., 36) = 36
statx(AT_FDCWD, "/etc/localtime", AT_STATX_SYNC_AS_STAT|AT_NO_AUTOMOUNT, STATX_BASIC_STATS, {stx_mask=STATX_BASIC_STATS|STATX_MNT_ID, stx_attributes=0, stx_mode=S_IFREG|0644, stx_size=111, ...}) = 0
write(1, " (2023-10-19 12:43:41.3068484347"..., 99) = 99
epoll_wait(3, [{events=EPOLLIN, data={u32=4931680, u64=4931680}}], 1, -1) = 1
recvmsg(4, {msg_name={sa_family=AF_CAN, sa_data="\0\0\2\0\0\0"}, msg_namelen=24 => 8, msg_iov=[{iov_base="\201\203\357\230\7\0\0\0\1\26\0\0\0\200O\0", iov_len=72}], msg_iovlen=1, msg_control=[{cmsg_len=28, cmsg_level=SOL_SOCKET, cmsg_type=SO_TIMESTAMP_NEW, cmsg_data={tv_sec=1697719421, tv_usec=128501}}], msg_controllen=28, msg_flags=0}, 0) = 16
write(1, "main: cmsg_type=63, SO_TIMESTAMP"..., 36) = 36
statx(AT_FDCWD, "/etc/localtime", AT_STATX_SYNC_AS_STAT|AT_NO_AUTOMOUNT, STATX_BASIC_STATS, {stx_mask=STATX_BASIC_STATS|STATX_MNT_ID, stx_attributes=0, stx_mode=S_IFREG|0644, stx_size=111, ...}) = 0
write(1, " (2023-10-19 12:43:41.3068484347"..., 99) = 99
epoll_wait(3, [{events=EPOLLIN, data={u32=4931680, u64=4931680}}], 1, -1) = 1
recvmsg(4, {msg_name={sa_family=AF_CAN, sa_data="\0\0\2\0\0\0"}, msg_namelen=24 => 8, msg_iov=[{iov_base="\201\203\357\230\7\0\0\0\1\27\0\0\0\200O\0", iov_len=72}], msg_iovlen=1, msg_control=[{cmsg_len=28, cmsg_level=SOL_SOCKET, cmsg_type=SO_TIMESTAMP_NEW, cmsg_data={tv_sec=1697719421, tv_usec=129543}}], msg_controllen=28, msg_flags=0}, 0) = 16
write(1, "main: cmsg_type=63, SO_TIMESTAMP"..., 36) = 36
statx(AT_FDCWD, "/etc/localtime", AT_STATX_SYNC_AS_STAT|AT_NO_AUTOMOUNT, STATX_BASIC_STATS, {stx_mask=STATX_BASIC_STATS|STATX_MNT_ID, stx_attributes=0, stx_mode=S_IFREG|0644, stx_size=111, ...}) = 0
write(1, " (2023-10-19 12:43:41.3068484347"..., 99) = 99
epoll_wait(3, [{events=EPOLLIN, data={u32=4931680, u64=4931680}}], 1, -1) = 1
recvmsg(4, {msg_name={sa_family=AF_CAN, sa_data="\0\0\2\0\0\0"}, msg_namelen=24 => 8, msg_iov=[{iov_base="\201\203\357\230\7\0\0\0\1\30\0\0\0\200O\0", iov_len=72}], msg_iovlen=1, msg_control=[{cmsg_len=28, cmsg_level=SOL_SOCKET, cmsg_type=SO_TIMESTAMP_NEW, cmsg_data={tv_sec=1697719421, tv_usec=130595}}], msg_controllen=28, msg_flags=0}, 0) = 16
write(1, "main: cmsg_type=63, SO_TIMESTAMP"..., 36) = 36
statx(AT_FDCWD, "/etc/localtime", AT_STATX_SYNC_AS_STAT|AT_NO_AUTOMOUNT, STATX_BASIC_STATS, {stx_mask=STATX_BASIC_STATS|STATX_MNT_ID, stx_attributes=0, stx_mode=S_IFREG|0644, stx_size=111, ...}) = 0
write(1, " (2023-10-19 12:43:41.3068484347"..., 99) = 99
epoll_wait(3, [{events=EPOLLIN, data={u32=4931680, u64=4931680}}], 1, -1) = 1
recvmsg(4, {msg_name={sa_family=AF_CAN, sa_data="\0\0\2\0\0\0"}, msg_namelen=24 => 8, msg_iov=[{iov_base="\201\203\357\230\7\0\0\0\1\221\0\0\0\0\0\0", iov_len=72}], msg_iovlen=1, msg_control=[{cmsg_len=28, cmsg_level=SOL_SOCKET, cmsg_type=SO_TIMESTAMP_NEW, cmsg_data={tv_sec=1697719421, tv_usec=131650}}], msg_controllen=28, msg_flags=0}, 0) = 16
write(1, "main: cmsg_type=63, SO_TIMESTAMP"..., 36) = 36
statx(AT_FDCWD, "/etc/localtime", AT_STATX_SYNC_AS_STAT|AT_NO_AUTOMOUNT, STATX_BASIC_STATS, {stx_mask=STATX_BASIC_STATS|STATX_MNT_ID, stx_attributes=0, stx_mode=S_IFREG|0644, stx_size=111, ...}) = 0
write(1, " (2023-10-19 12:43:41.3068484347"..., 99) = 99
epoll_wait(3, [{events=EPOLLIN, data={u32=4931680, u64=4931680}}], 1, -1) = 1
recvmsg(4, {msg_name={sa_family=AF_CAN, sa_data="\0\0\2\0\0\0"}, msg_namelen=24 => 8, msg_iov=[{iov_base="\203\204\357\230\3\0\0\0\3\377\0\0\0\0\0\0", iov_len=72}], msg_iovlen=1, msg_control=[{cmsg_len=28, cmsg_level=SOL_SOCKET, cmsg_type=SO_TIMESTAMP_NEW, cmsg_data={tv_sec=1697719421, tv_usec=172815}}], msg_controllen=28, msg_flags=MSG_DONTROUTE}, 0) = 16
write(1, "main: cmsg_type=63, SO_TIMESTAMP"..., 36) = 36
statx(AT_FDCWD, "/etc/localtime", AT_STATX_SYNC_AS_STAT|AT_NO_AUTOMOUNT, STATX_BASIC_STATS, {stx_mask=STATX_BASIC_STATS|STATX_MNT_ID, stx_attributes=0, stx_mode=S_IFREG|0644, stx_size=111, ...}) = 0
write(1, " (2023-10-19 12:43:41.3068484347"..., 87) = 87
epoll_wait(3, [{events=EPOLLIN, data={u32=4931680, u64=4931680}}], 1, -1) = 1
recvmsg(4, {msg_name={sa_family=AF_CAN, sa_data="\0\0\2\0\0\0"}, msg_namelen=24 => 8, msg_iov=[{iov_base="\204\203\357\230\7\0\0\0\1\21\0\0\0\200O\0", iov_len=72}], msg_iovlen=1, msg_control=[{cmsg_len=28, cmsg_level=SOL_SOCKET, cmsg_type=SO_TIMESTAMP_NEW, cmsg_data={tv_sec=1697719421, tv_usec=173525}}], msg_controllen=28, msg_flags=0}, 0) = 16
write(1, "main: cmsg_type=63, SO_TIMESTAMP"..., 36) = 36
statx(AT_FDCWD, "/etc/localtime", AT_STATX_SYNC_AS_STAT|AT_NO_AUTOMOUNT, STATX_BASIC_STATS, {stx_mask=STATX_BASIC_STATS|STATX_MNT_ID, stx_attributes=0, stx_mode=S_IFREG|0644, stx_size=111, ...}) = 0
write(1, " (2023-10-19 12:43:41.3068484347"..., 99) = 99
epoll_wait(3, [{events=EPOLLIN, data={u32=4931680, u64=4931680}}], 1, -1) = 1
recvmsg(4, {msg_name={sa_family=AF_CAN, sa_data="\0\0\2\0\0\0"}, msg_namelen=24 => 8, msg_iov=[{iov_base="\204\203\357\230\7\0\0\0\1\22\0\0\0\200O\0", iov_len=72}], msg_iovlen=1, msg_control=[{cmsg_len=28, cmsg_level=SOL_SOCKET, cmsg_type=SO_TIMESTAMP_NEW, cmsg_data={tv_sec=1697719421, tv_usec=174576}}], msg_controllen=28, msg_flags=0}, 0) = 16
write(1, "main: cmsg_type=63, SO_TIMESTAMP"..., 36) = 36
statx(AT_FDCWD, "/etc/localtime", AT_STATX_SYNC_AS_STAT|AT_NO_AUTOMOUNT, STATX_BASIC_STATS, {stx_mask=STATX_BASIC_STATS|STATX_MNT_ID, stx_attributes=0, stx_mode=S_IFREG|0644, stx_size=111, ...}) = 0
write(1, " (2023-10-19 12:43:41.3068484347"..., 99) = 99
epoll_wait(3, [{events=EPOLLIN, data={u32=4931680, u64=4931680}}], 1, -1) = 1
recvmsg(4, {msg_name={sa_family=AF_CAN, sa_data="\0\0\2\0\0\0"}, msg_namelen=24 => 8, msg_iov=[{iov_base="\204\203\357\230\7\0\0\0\1\23\0\0\0\200O\0", iov_len=72}], msg_iovlen=1, msg_control=[{cmsg_len=28, cmsg_level=SOL_SOCKET, cmsg_type=SO_TIMESTAMP_NEW, cmsg_data={tv_sec=1697719421, tv_usec=175622}}], msg_controllen=28, msg_flags=0}, 0) = 16
write(1, "main: cmsg_type=63, SO_TIMESTAMP"..., 36) = 36
statx(AT_FDCWD, "/etc/localtime", AT_STATX_SYNC_AS_STAT|AT_NO_AUTOMOUNT, STATX_BASIC_STATS, {stx_mask=STATX_BASIC_STATS|STATX_MNT_ID, stx_attributes=0, stx_mode=S_IFREG|0644, stx_size=111, ...}) = 0
write(1, " (2023-10-19 12:43:41.3068484347"..., 99) = 99
epoll_wait(3, [{events=EPOLLIN, data={u32=4931680, u64=4931680}}], 1, -1) = 1
recvmsg(4, {msg_name={sa_family=AF_CAN, sa_data="\0\0\2\0\0\0"}, msg_namelen=24 => 8, msg_iov=[{iov_base="\204\203\357\230\7\0\0\0\1\24\0\0\0\200O\0", iov_len=72}], msg_iovlen=1, msg_control=[{cmsg_len=28, cmsg_level=SOL_SOCKET, cmsg_type=SO_TIMESTAMP_NEW, cmsg_data={tv_sec=1697719421, tv_usec=176681}}], msg_controllen=28, msg_flags=0}, 0) = 16
write(1, "main: cmsg_type=63, SO_TIMESTAMP"..., 36) = 36
statx(AT_FDCWD, "/etc/localtime", AT_STATX_SYNC_AS_STAT|AT_NO_AUTOMOUNT, STATX_BASIC_STATS, {stx_mask=STATX_BASIC_STATS|STATX_MNT_ID, stx_attributes=0, stx_mode=S_IFREG|0644, stx_size=111, ...}) = 0
write(1, " (2023-10-19 12:43:41.3068484347"..., 99) = 99
epoll_wait(3, [{events=EPOLLIN, data={u32=4931680, u64=4931680}}], 1, -1) = 1
recvmsg(4, {msg_name={sa_family=AF_CAN, sa_data="\0\0\2\0\0\0"}, msg_namelen=24 => 8, msg_iov=[{iov_base="\204\203\357\230\7\0\0\0\1\25\0\0\0\200O\0", iov_len=72}], msg_iovlen=1, msg_control=[{cmsg_len=28, cmsg_level=SOL_SOCKET, cmsg_type=SO_TIMESTAMP_NEW, cmsg_data={tv_sec=1697719421, tv_usec=177725}}], msg_controllen=28, msg_flags=0}, 0) = 16
write(1, "main: cmsg_type=63, SO_TIMESTAMP"..., 36) = 36
statx(AT_FDCWD, "/etc/localtime", AT_STATX_SYNC_AS_STAT|AT_NO_AUTOMOUNT, STATX_BASIC_STATS, {stx_mask=STATX_BASIC_STATS|STATX_MNT_ID, stx_attributes=0, stx_mode=S_IFREG|0644, stx_size=111, ...}) = 0
write(1, " (2023-10-19 12:43:41.3068484347"..., 99) = 99
epoll_wait(3, [{events=EPOLLIN, data={u32=4931680, u64=4931680}}], 1, -1) = 1
recvmsg(4, {msg_name={sa_family=AF_CAN, sa_data="\0\0\2\0\0\0"}, msg_namelen=24 => 8, msg_iov=[{iov_base="\204\203\357\230\7\0\0\0\1\26\0\0\0\200O\0", iov_len=72}], msg_iovlen=1, msg_control=[{cmsg_len=28, cmsg_level=SOL_SOCKET, cmsg_type=SO_TIMESTAMP_NEW, cmsg_data={tv_sec=1697719421, tv_usec=178778}}], msg_controllen=28, msg_flags=0}, 0) = 16
write(1, "main: cmsg_type=63, SO_TIMESTAMP"..., 36) = 36
statx(AT_FDCWD, "/etc/localtime", AT_STATX_SYNC_AS_STAT|AT_NO_AUTOMOUNT, STATX_BASIC_STATS, {stx_mask=STATX_BASIC_STATS|STATX_MNT_ID, stx_attributes=0, stx_mode=S_IFREG|0644, stx_size=111, ...}) = 0
write(1, " (2023-10-19 12:43:41.3068484347"..., 99) = 99
epoll_wait(3, [{events=EPOLLIN, data={u32=4931680, u64=4931680}}], 1, -1) = 1
recvmsg(4, {msg_name={sa_family=AF_CAN, sa_data="\0\0\2\0\0\0"}, msg_namelen=24 => 8, msg_iov=[{iov_base="\204\203\357\230\7\0\0\0\1\27\0\0\0\200O\0", iov_len=72}], msg_iovlen=1, msg_control=[{cmsg_len=28, cmsg_level=SOL_SOCKET, cmsg_type=SO_TIMESTAMP_NEW, cmsg_data={tv_sec=1697719421, tv_usec=179824}}], msg_controllen=28, msg_flags=0}, 0) = 16
write(1, "main: cmsg_type=63, SO_TIMESTAMP"..., 36) = 36
statx(AT_FDCWD, "/etc/localtime", AT_STATX_SYNC_AS_STAT|AT_NO_AUTOMOUNT, STATX_BASIC_STATS, {stx_mask=STATX_BASIC_STATS|STATX_MNT_ID, stx_attributes=0, stx_mode=S_IFREG|0644, stx_size=111, ...}) = 0
write(1, " (2023-10-19 12:43:41.3068484347"..., 99) = 99
epoll_wait(3, [{events=EPOLLIN, data={u32=4931680, u64=4931680}}], 1, -1) = 1
recvmsg(4, {msg_name={sa_family=AF_CAN, sa_data="\0\0\2\0\0\0"}, msg_namelen=24 => 8, msg_iov=[{iov_base="\204\203\357\230\7\0\0\0\1\30\0\0\0\200O\0", iov_len=72}], msg_iovlen=1, msg_control=[{cmsg_len=28, cmsg_level=SOL_SOCKET, cmsg_type=SO_TIMESTAMP_NEW, cmsg_data={tv_sec=1697719421, tv_usec=180888}}], msg_controllen=28, msg_flags=0}, 0) = 16
write(1, "main: cmsg_type=63, SO_TIMESTAMP"..., 36) = 36
statx(AT_FDCWD, "/etc/localtime", AT_STATX_SYNC_AS_STAT|AT_NO_AUTOMOUNT, STATX_BASIC_STATS, {stx_mask=STATX_BASIC_STATS|STATX_MNT_ID, stx_attributes=0, stx_mode=S_IFREG|0644, stx_size=111, ...}) = 0
write(1, " (2023-10-19 12:43:41.3068484347"..., 99) = 99
epoll_wait(3, [{events=EPOLLIN, data={u32=4931680, u64=4931680}}], 1, -1) = 1
recvmsg(4, {msg_name={sa_family=AF_CAN, sa_data="\0\0\2\0\0\0"}, msg_namelen=24 => 8, msg_iov=[{iov_base="\204\203\357\230\7\0\0\0\1\221\0\0\0\0\0\0", iov_len=72}], msg_iovlen=1, msg_control=[{cmsg_len=28, cmsg_level=SOL_SOCKET, cmsg_type=SO_TIMESTAMP_NEW, cmsg_data={tv_sec=1697719421, tv_usec=181938}}], msg_controllen=28, msg_flags=0}, 0) = 16
write(1, "main: cmsg_type=63, SO_TIMESTAMP"..., 36) = 36
statx(AT_FDCWD, "/etc/localtime", AT_STATX_SYNC_AS_STAT|AT_NO_AUTOMOUNT, STATX_BASIC_STATS, {stx_mask=STATX_BASIC_STATS|STATX_MNT_ID, stx_attributes=0, stx_mode=S_IFREG|0644, stx_size=111, ...}) = 0
write(1, " (2023-10-19 12:43:41.3068484347"..., 99) = 99
epoll_wait(3, [{events=EPOLLIN, data={u32=4931680, u64=4931680}}], 1, -1) = 1
recvmsg(4, {msg_name={sa_family=AF_CAN, sa_data="\0\0\2\0\0\0"}, msg_namelen=24 => 8, msg_iov=[{iov_base="\203\202\357\230\3\0\0\0\3\377\0\0\0\0\0\0", iov_len=72}], msg_iovlen=1, msg_control=[{cmsg_len=28, cmsg_level=SOL_SOCKET, cmsg_type=SO_TIMESTAMP_NEW, cmsg_data={tv_sec=1697719421, tv_usec=223093}}], msg_controllen=28, msg_flags=MSG_DONTROUTE}, 0) = 16
write(1, "main: cmsg_type=63, SO_TIMESTAMP"..., 36) = 36
statx(AT_FDCWD, "/etc/localtime", AT_STATX_SYNC_AS_STAT|AT_NO_AUTOMOUNT, STATX_BASIC_STATS, {stx_mask=STATX_BASIC_STATS|STATX_MNT_ID, stx_attributes=0, stx_mode=S_IFREG|0644, stx_size=111, ...}) = 0
write(1, " (2023-10-19 12:43:41.3068484347"..., 87) = 87
epoll_wait(3, [{events=EPOLLIN, data={u32=4931680, u64=4931680}}], 1, -1) = 1
recvmsg(4, {msg_name={sa_family=AF_CAN, sa_data="\0\0\2\0\0\0"}, msg_namelen=24 => 8, msg_iov=[{iov_base="\202\203\357\230\7\0\0\0\1\21\0\0\0\200O\0", iov_len=72}], msg_iovlen=1, msg_control=[{cmsg_len=28, cmsg_level=SOL_SOCKET, cmsg_type=SO_TIMESTAMP_NEW, cmsg_data={tv_sec=1697719421, tv_usec=223805}}], msg_controllen=28, msg_flags=0}, 0) = 16
write(1, "main: cmsg_type=63, SO_TIMESTAMP"..., 36) = 36
statx(AT_FDCWD, "/etc/localtime", AT_STATX_SYNC_AS_STAT|AT_NO_AUTOMOUNT, STATX_BASIC_STATS, {stx_mask=STATX_BASIC_STATS|STATX_MNT_ID, stx_attributes=0, stx_mode=S_IFREG|0644, stx_size=111, ...}) = 0
write(1, " (2023-10-19 12:43:41.3068484347"..., 99) = 99
epoll_wait(3, [{events=EPOLLIN, data={u32=4931680, u64=4931680}}], 1, -1) = 1
recvmsg(4, {msg_name={sa_family=AF_CAN, sa_data="\0\0\2\0\0\0"}, msg_namelen=24 => 8, msg_iov=[{iov_base="\202\203\357\230\7\0\0\0\1\22\0\0\0\200O\0", iov_len=72}], msg_iovlen=1, msg_control=[{cmsg_len=28, cmsg_level=SOL_SOCKET, cmsg_type=SO_TIMESTAMP_NEW, cmsg_data={tv_sec=1697719421, tv_usec=224861}}], msg_controllen=28, msg_flags=0}, 0) = 16
write(1, "main: cmsg_type=63, SO_TIMESTAMP"..., 36) = 36
statx(AT_FDCWD, "/etc/localtime", AT_STATX_SYNC_AS_STAT|AT_NO_AUTOMOUNT, STATX_BASIC_STATS, {stx_mask=STATX_BASIC_STATS|STATX_MNT_ID, stx_attributes=0, stx_mode=S_IFREG|0644, stx_size=111, ...}) = 0
write(1, " (2023-10-19 12:43:41.3068484347"..., 99) = 99
epoll_wait(3, [{events=EPOLLIN, data={u32=4931680, u64=4931680}}], 1, -1) = 1
recvmsg(4, {msg_name={sa_family=AF_CAN, sa_data="\0\0\2\0\0\0"}, msg_namelen=24 => 8, msg_iov=[{iov_base="\202\203\357\230\7\0\0\0\1\23\0\0\0\200O\0", iov_len=72}], msg_iovlen=1, msg_control=[{cmsg_len=28, cmsg_level=SOL_SOCKET, cmsg_type=SO_TIMESTAMP_NEW, cmsg_data={tv_sec=1697719421, tv_usec=225904}}], msg_controllen=28, msg_flags=0}, 0) = 16
write(1, "main: cmsg_type=63, SO_TIMESTAMP"..., 36) = 36
statx(AT_FDCWD, "/etc/localtime", AT_STATX_SYNC_AS_STAT|AT_NO_AUTOMOUNT, STATX_BASIC_STATS, {stx_mask=STATX_BASIC_STATS|STATX_MNT_ID, stx_attributes=0, stx_mode=S_IFREG|0644, stx_size=111, ...}) = 0
write(1, " (2023-10-19 12:43:41.3068484347"..., 99) = 99
epoll_wait(3, [{events=EPOLLIN, data={u32=4931680, u64=4931680}}], 1, -1) = 1
recvmsg(4, {msg_name={sa_family=AF_CAN, sa_data="\0\0\2\0\0\0"}, msg_namelen=24 => 8, msg_iov=[{iov_base="\202\203\357\230\7\0\0\0\1\24\0\0\0\200O\0", iov_len=72}], msg_iovlen=1, msg_control=[{cmsg_len=28, cmsg_level=SOL_SOCKET, cmsg_type=SO_TIMESTAMP_NEW, cmsg_data={tv_sec=1697719421, tv_usec=226968}}], msg_controllen=28, msg_flags=0}, 0) = 16
write(1, "main: cmsg_type=63, SO_TIMESTAMP"..., 36) = 36
statx(AT_FDCWD, "/etc/localtime", AT_STATX_SYNC_AS_STAT|AT_NO_AUTOMOUNT, STATX_BASIC_STATS, {stx_mask=STATX_BASIC_STATS|STATX_MNT_ID, stx_attributes=0, stx_mode=S_IFREG|0644, stx_size=111, ...}) = 0
write(1, " (2023-10-19 12:43:41.3068484347"..., 99) = 99
epoll_wait(3, [{events=EPOLLIN, data={u32=4931680, u64=4931680}}], 1, -1) = 1
recvmsg(4, {msg_name={sa_family=AF_CAN, sa_data="\0\0\2\0\0\0"}, msg_namelen=24 => 8, msg_iov=[{iov_base="\202\203\357\230\7\0\0\0\1\25\0\0\0\200O\0", iov_len=72}], msg_iovlen=1, msg_control=[{cmsg_len=28, cmsg_level=SOL_SOCKET, cmsg_type=SO_TIMESTAMP_NEW, cmsg_data={tv_sec=1697719421, tv_usec=228009}}], msg_controllen=28, msg_flags=0}, 0) = 16
write(1, "main: cmsg_type=63, SO_TIMESTAMP"..., 36) = 36
statx(AT_FDCWD, "/etc/localtime", AT_STATX_SYNC_AS_STAT|AT_NO_AUTOMOUNT, STATX_BASIC_STATS, {stx_mask=STATX_BASIC_STATS|STATX_MNT_ID, stx_attributes=0, stx_mode=S_IFREG|0644, stx_size=111, ...}) = 0
write(1, " (2023-10-19 12:43:41.3068484347"..., 99) = 99
epoll_wait(3, [{events=EPOLLIN, data={u32=4931680, u64=4931680}}], 1, -1) = 1
recvmsg(4, {msg_name={sa_family=AF_CAN, sa_data="\0\0\2\0\0\0"}, msg_namelen=24 => 8, msg_iov=[{iov_base="\202\203\357\230\7\0\0\0\1\26\0\0\0\200O\0", iov_len=72}], msg_iovlen=1, msg_control=[{cmsg_len=28, cmsg_level=SOL_SOCKET, cmsg_type=SO_TIMESTAMP_NEW, cmsg_data={tv_sec=1697719421, tv_usec=229071}}], msg_controllen=28, msg_flags=0}, 0) = 16
write(1, "main: cmsg_type=63, SO_TIMESTAMP"..., 36) = 36
statx(AT_FDCWD, "/etc/localtime", AT_STATX_SYNC_AS_STAT|AT_NO_AUTOMOUNT, STATX_BASIC_STATS, {stx_mask=STATX_BASIC_STATS|STATX_MNT_ID, stx_attributes=0, stx_mode=S_IFREG|0644, stx_size=111, ...}) = 0
write(1, " (2023-10-19 12:43:41.3068484347"..., 99) = 99
epoll_wait(3, [{events=EPOLLIN, data={u32=4931680, u64=4931680}}], 1, -1) = 1
recvmsg(4, {msg_name={sa_family=AF_CAN, sa_data="\0\0\2\0\0\0"}, msg_namelen=24 => 8, msg_iov=[{iov_base="\202\203\357\230\7\0\0\0\1\27\0\0\0\200O\0", iov_len=72}], msg_iovlen=1, msg_control=[{cmsg_len=28, cmsg_level=SOL_SOCKET, cmsg_type=SO_TIMESTAMP_NEW, cmsg_data={tv_sec=1697719421, tv_usec=230111}}], msg_controllen=28, msg_flags=0}, 0) = 16
write(1, "main: cmsg_type=63, SO_TIMESTAMP"..., 36) = 36
statx(AT_FDCWD, "/etc/localtime", AT_STATX_SYNC_AS_STAT|AT_NO_AUTOMOUNT, STATX_BASIC_STATS, {stx_mask=STATX_BASIC_STATS|STATX_MNT_ID, stx_attributes=0, stx_mode=S_IFREG|0644, stx_size=111, ...}) = 0
write(1, " (2023-10-19 12:43:41.3068484347"..., 99) = 99
epoll_wait(3, [{events=EPOLLIN, data={u32=4931680, u64=4931680}}], 1, -1) = 1
recvmsg(4, {msg_name={sa_family=AF_CAN, sa_data="\0\0\2\0\0\0"}, msg_namelen=24 => 8, msg_iov=[{iov_base="\202\203\357\230\7\0\0\0\1\30\0\0\0\200O\0", iov_len=72}], msg_iovlen=1, msg_control=[{cmsg_len=28, cmsg_level=SOL_SOCKET, cmsg_type=SO_TIMESTAMP_NEW, cmsg_data={tv_sec=1697719421, tv_usec=231166}}], msg_controllen=28, msg_flags=0}, 0) = 16
write(1, "main: cmsg_type=63, SO_TIMESTAMP"..., 36) = 36
statx(AT_FDCWD, "/etc/localtime", AT_STATX_SYNC_AS_STAT|AT_NO_AUTOMOUNT, STATX_BASIC_STATS, {stx_mask=STATX_BASIC_STATS|STATX_MNT_ID, stx_attributes=0, stx_mode=S_IFREG|0644, stx_size=111, ...}) = 0
write(1, " (2023-10-19 12:43:41.3068484347"..., 99) = 99
epoll_wait(3, [{events=EPOLLIN, data={u32=4931680, u64=4931680}}], 1, -1) = 1
recvmsg(4, {msg_name={sa_family=AF_CAN, sa_data="\0\0\2\0\0\0"}, msg_namelen=24 => 8, msg_iov=[{iov_base="\202\203\357\230\7\0\0\0\1\221\0\0\0\0\0\0", iov_len=72}], msg_iovlen=1, msg_control=[{cmsg_len=28, cmsg_level=SOL_SOCKET, cmsg_type=SO_TIMESTAMP_NEW, cmsg_data={tv_sec=1697719421, tv_usec=232222}}], msg_controllen=28, msg_flags=0}, 0) = 16
write(1, "main: cmsg_type=63, SO_TIMESTAMP"..., 36) = 36
statx(AT_FDCWD, "/etc/localtime", AT_STATX_SYNC_AS_STAT|AT_NO_AUTOMOUNT, STATX_BASIC_STATS, {stx_mask=STATX_BASIC_STATS|STATX_MNT_ID, stx_attributes=0, stx_mode=S_IFREG|0644, stx_size=111, ...}) = 0
write(1, " (2023-10-19 12:43:41.3068484347"..., 99) = 99
epoll_wait(3, [{events=EPOLLIN, data={u32=4931680, u64=4931680}}], 1, -1) = 1
recvmsg(4, {msg_name={sa_family=AF_CAN, sa_data="\0\0\2\0\0\0"}, msg_namelen=24 => 8, msg_iov=[{iov_base="\203\357\357\230\3\0\0\0\3\0\0\0\0\0\0\0", iov_len=72}], msg_iovlen=1, msg_control=[{cmsg_len=28, cmsg_level=SOL_SOCKET, cmsg_type=SO_TIMESTAMP_NEW, cmsg_data={tv_sec=1697719421, tv_usec=273328}}], msg_controllen=28, msg_flags=MSG_DONTROUTE}, 0) = 16
write(1, "main: cmsg_type=63, SO_TIMESTAMP"..., 36) = 36
statx(AT_FDCWD, "/etc/localtime", AT_STATX_SYNC_AS_STAT|AT_NO_AUTOMOUNT, STATX_BASIC_STATS, {stx_mask=STATX_BASIC_STATS|STATX_MNT_ID, stx_attributes=0, stx_mode=S_IFREG|0644, stx_size=111, ...}) = 0
write(1, " (2023-10-19 12:43:41.3068484347"..., 87) = 87
epoll_wait(3, [{events=EPOLLIN, data={u32=4931680, u64=4931680}}], 1, -1) = 1
recvmsg(4, {msg_name={sa_family=AF_CAN, sa_data="\0\0\2\0\0\0"}, msg_namelen=24 => 8, msg_iov=[{iov_base="\357\203\357\230\7\0\0\0\0015\0\214\276\277@\0", iov_len=72}], msg_iovlen=1, msg_control=[{cmsg_len=28, cmsg_level=SOL_SOCKET, cmsg_type=SO_TIMESTAMP_NEW, cmsg_data={tv_sec=1697719421, tv_usec=274116}}], msg_controllen=28, msg_flags=0}, 0) = 16
write(1, "main: cmsg_type=63, SO_TIMESTAMP"..., 36) = 36
statx(AT_FDCWD, "/etc/localtime", AT_STATX_SYNC_AS_STAT|AT_NO_AUTOMOUNT, STATX_BASIC_STATS, {stx_mask=STATX_BASIC_STATS|STATX_MNT_ID, stx_attributes=0, stx_mode=S_IFREG|0644, stx_size=111, ...}) = 0
write(1, " (2023-10-19 12:43:41.3068484347"..., 99) = 99
epoll_wait(3, [{events=EPOLLIN, data={u32=4931680, u64=4931680}}], 1, -1) = 1
recvmsg(4, {msg_name={sa_family=AF_CAN, sa_data="\0\0\2\0\0\0"}, msg_namelen=24 => 8, msg_iov=[{iov_base="\357\203\357\230\7\0\0\0\0016\0\0\0\0\0\0", iov_len=72}], msg_iovlen=1, msg_control=[{cmsg_len=28, cmsg_level=SOL_SOCKET, cmsg_type=SO_TIMESTAMP_NEW, cmsg_data={tv_sec=1697719421, tv_usec=274657}}], msg_controllen=28, msg_flags=0}, 0) = 16
write(1, "main: cmsg_type=63, SO_TIMESTAMP"..., 36) = 36
statx(AT_FDCWD, "/etc/localtime", AT_STATX_SYNC_AS_STAT|AT_NO_AUTOMOUNT, STATX_BASIC_STATS, {stx_mask=STATX_BASIC_STATS|STATX_MNT_ID, stx_attributes=0, stx_mode=S_IFREG|0644, stx_size=111, ...}) = 0
write(1, " (2023-10-19 12:43:41.3068484347"..., 99) = 99
epoll_wait(3, [{events=EPOLLIN, data={u32=4931680, u64=4931680}}], 1, -1) = 1
recvmsg(4, {msg_name={sa_family=AF_CAN, sa_data="\0\0\2\0\0\0"}, msg_namelen=24 => 8, msg_iov=[{iov_base="\357\203\357\230\7\0\0\0\0017\0\0\0\0\0\0", iov_len=72}], msg_iovlen=1, msg_control=[{cmsg_len=28, cmsg_level=SOL_SOCKET, cmsg_type=SO_TIMESTAMP_NEW, cmsg_data={tv_sec=1697719421, tv_usec=275282}}], msg_controllen=28, msg_flags=0}, 0) = 16
write(1, "main: cmsg_type=63, SO_TIMESTAMP"..., 36) = 36
statx(AT_FDCWD, "/etc/localtime", AT_STATX_SYNC_AS_STAT|AT_NO_AUTOMOUNT, STATX_BASIC_STATS, {stx_mask=STATX_BASIC_STATS|STATX_MNT_ID, stx_attributes=0, stx_mode=S_IFREG|0644, stx_size=111, ...}) = 0
write(1, " (2023-10-19 12:43:41.3068484347"..., 99) = 99
epoll_wait(3, [{events=EPOLLIN, data={u32=4931680, u64=4931680}}], 1, -1) = 1
recvmsg(4, {msg_name={sa_family=AF_CAN, sa_data="\0\0\2\0\0\0"}, msg_namelen=24 => 8, msg_iov=[{iov_base="\357\203\357\230\7\0\0\0\1a\0\272\250\377?\0", iov_len=72}], msg_iovlen=1, msg_control=[{cmsg_len=28, cmsg_level=SOL_SOCKET, cmsg_type=SO_TIMESTAMP_NEW, cmsg_data={tv_sec=1697719421, tv_usec=276364}}], msg_controllen=28, msg_flags=0}, 0) = 16
write(1, "main: cmsg_type=63, SO_TIMESTAMP"..., 36) = 36
statx(AT_FDCWD, "/etc/localtime", AT_STATX_SYNC_AS_STAT|AT_NO_AUTOMOUNT, STATX_BASIC_STATS, {stx_mask=STATX_BASIC_STATS|STATX_MNT_ID, stx_attributes=0, stx_mode=S_IFREG|0644, stx_size=111, ...}) = 0
write(1, " (2023-10-19 12:43:41.3068484347"..., 99) = 99
epoll_wait(3, [{events=EPOLLIN, data={u32=4931680, u64=4931680}}], 1, -1) = 1
recvmsg(4, {msg_name={sa_family=AF_CAN, sa_data="\0\0\2\0\0\0"}, msg_namelen=24 => 8, msg_iov=[{iov_base="\357\203\357\230\7\0\0\0\1R\0\303\24*B\0", iov_len=72}], msg_iovlen=1, msg_control=[{cmsg_len=28, cmsg_level=SOL_SOCKET, cmsg_type=SO_TIMESTAMP_NEW, cmsg_data={tv_sec=1697719421, tv_usec=277328}}], msg_controllen=28, msg_flags=0}, 0) = 16
write(1, "main: cmsg_type=63, SO_TIMESTAMP"..., 36) = 36
statx(AT_FDCWD, "/etc/localtime", AT_STATX_SYNC_AS_STAT|AT_NO_AUTOMOUNT, STATX_BASIC_STATS, {stx_mask=STATX_BASIC_STATS|STATX_MNT_ID, stx_attributes=0, stx_mode=S_IFREG|0644, stx_size=111, ...}) = 0
write(1, " (2023-10-19 12:43:41.3068484347"..., 99) = 99
epoll_wait(3, [{events=EPOLLIN, data={u32=4931680, u64=4931680}}], 1, -1) = 1
recvmsg(4, {msg_name={sa_family=AF_CAN, sa_data="\0\0\2\0\0\0"}, msg_namelen=24 => 8, msg_iov=[{iov_base="\357\203\357\230\7\0\0\0\1d\0\2179\31@\0", iov_len=72}], msg_iovlen=1, msg_control=[{cmsg_len=28, cmsg_level=SOL_SOCKET, cmsg_type=SO_TIMESTAMP_NEW, cmsg_data={tv_sec=1697719421, tv_usec=278266}}], msg_controllen=28, msg_flags=0}, 0) = 16
write(1, "main: cmsg_type=63, SO_TIMESTAMP"..., 36) = 36
statx(AT_FDCWD, "/etc/localtime", AT_STATX_SYNC_AS_STAT|AT_NO_AUTOMOUNT, STATX_BASIC_STATS, {stx_mask=STATX_BASIC_STATS|STATX_MNT_ID, stx_attributes=0, stx_mode=S_IFREG|0644, stx_size=111, ...}) = 0
write(1, " (2023-10-19 12:43:41.3068484347"..., 99) = 99
epoll_wait(3, [{events=EPOLLIN, data={u32=4931680, u64=4931680}}], 1, -1) = 1
recvmsg(4, {msg_name={sa_family=AF_CAN, sa_data="\0\0\2\0\0\0"}, msg_namelen=24 => 8, msg_iov=[{iov_base="\357\203\357\230\7\0\0\0\1S\0\2179\31@\0", iov_len=72}], msg_iovlen=1, msg_control=[{cmsg_len=28, cmsg_level=SOL_SOCKET, cmsg_type=SO_TIMESTAMP_NEW, cmsg_data={tv_sec=1697719421, tv_usec=279252}}], msg_controllen=28, msg_flags=0}, 0) = 16
write(1, "main: cmsg_type=63, SO_TIMESTAMP"..., 36) = 36
statx(AT_FDCWD, "/etc/localtime", AT_STATX_SYNC_AS_STAT|AT_NO_AUTOMOUNT, STATX_BASIC_STATS, {stx_mask=STATX_BASIC_STATS|STATX_MNT_ID, stx_attributes=0, stx_mode=S_IFREG|0644, stx_size=111, ...}) = 0
write(1, " (2023-10-19 12:43:41.3068484347"..., 99) = 99
epoll_wait(3, [{events=EPOLLIN, data={u32=4931680, u64=4931680}}], 1, -1) = 1
recvmsg(4, {msg_name={sa_family=AF_CAN, sa_data="\0\0\2\0\0\0"}, msg_namelen=24 => 8, msg_iov=[{iov_base="\357\203\357\230\7\0\0\0\1q\0f\306\303B\0", iov_len=72}], msg_iovlen=1, msg_control=[{cmsg_len=28, cmsg_level=SOL_SOCKET, cmsg_type=SO_TIMESTAMP_NEW, cmsg_data={tv_sec=1697719421, tv_usec=280251}}], msg_controllen=28, msg_flags=0}, 0) = 16
write(1, "main: cmsg_type=63, SO_TIMESTAMP"..., 36) = 36
statx(AT_FDCWD, "/etc/localtime", AT_STATX_SYNC_AS_STAT|AT_NO_AUTOMOUNT, STATX_BASIC_STATS, {stx_mask=STATX_BASIC_STATS|STATX_MNT_ID, stx_attributes=0, stx_mode=S_IFREG|0644, stx_size=111, ...}) = 0
write(1, " (2023-10-19 12:43:41.3068484347"..., 99) = 99
epoll_wait(3, [{events=EPOLLIN, data={u32=4931680, u64=4931680}}], 1, -1) = 1
recvmsg(4, {msg_name={sa_family=AF_CAN, sa_data="\0\0\2\0\0\0"}, msg_namelen=24 => 8, msg_iov=[{iov_base="\357\203\357\230\7\0\0\0\1x\0\0\0\0\0\0", iov_len=72}], msg_iovlen=1, msg_control=[{cmsg_len=28, cmsg_level=SOL_SOCKET, cmsg_type=SO_TIMESTAMP_NEW, cmsg_data={tv_sec=1697719421, tv_usec=281371}}], msg_controllen=28, msg_flags=0}, 0) = 16
write(1, "main: cmsg_type=63, SO_TIMESTAMP"..., 36) = 36
statx(AT_FDCWD, "/etc/localtime", AT_STATX_SYNC_AS_STAT|AT_NO_AUTOMOUNT, STATX_BASIC_STATS, {stx_mask=STATX_BASIC_STATS|STATX_MNT_ID, stx_attributes=0, stx_mode=S_IFREG|0644, stx_size=111, ...}) = 0
write(1, " (2023-10-19 12:43:41.3068484347"..., 99) = 99
epoll_wait(3, [{events=EPOLLIN, data={u32=4931680, u64=4931680}}], 1, -1) = 1
recvmsg(4, {msg_name={sa_family=AF_CAN, sa_data="\0\0\2\0\0\0"}, msg_namelen=24 => 8, msg_iov=[{iov_base="\357\203\357\230\7\0\0\0\1t\0\0\0\0\0\0", iov_len=72}], msg_iovlen=1, msg_control=[{cmsg_len=28, cmsg_level=SOL_SOCKET, cmsg_type=SO_TIMESTAMP_NEW, cmsg_data={tv_sec=1697719421, tv_usec=282284}}], msg_controllen=28, msg_flags=0}, 0) = 16
write(1, "main: cmsg_type=63, SO_TIMESTAMP"..., 36) = 36
statx(AT_FDCWD, "/etc/localtime", AT_STATX_SYNC_AS_STAT|AT_NO_AUTOMOUNT, STATX_BASIC_STATS, {stx_mask=STATX_BASIC_STATS|STATX_MNT_ID, stx_attributes=0, stx_mode=S_IFREG|0644, stx_size=111, ...}) = 0
write(1, " (2023-10-19 12:43:41.3068484347"..., 99) = 99
epoll_wait(3, [{events=EPOLLIN, data={u32=4931680, u64=4931680}}], 1, -1) = 1
recvmsg(4, {msg_name={sa_family=AF_CAN, sa_data="\0\0\2\0\0\0"}, msg_namelen=24 => 8, msg_iov=[{iov_base="\357\203\357\230\7\0\0\0\1\203\0\0\0\0\0\0", iov_len=72}], msg_iovlen=1, msg_control=[{cmsg_len=28, cmsg_level=SOL_SOCKET, cmsg_type=SO_TIMESTAMP_NEW, cmsg_data={tv_sec=1697719421, tv_usec=283358}}], msg_controllen=28, msg_flags=0}, 0) = 16
write(1, "main: cmsg_type=63, SO_TIMESTAMP"..., 36) = 36
statx(AT_FDCWD, "/etc/localtime", AT_STATX_SYNC_AS_STAT|AT_NO_AUTOMOUNT, STATX_BASIC_STATS, {stx_mask=STATX_BASIC_STATS|STATX_MNT_ID, stx_attributes=0, stx_mode=S_IFREG|0644, stx_size=111, ...}) = 0
write(1, " (2023-10-19 12:43:41.3068484347"..., 99) = 99
epoll_wait(3, 0xbe8f5860, 1, -1)        = -1 EINTR (Interrupted system call)
--- SIGINT {si_signo=SIGINT, si_code=SI_KERNEL} ---
sigreturn({mask=[]})                    = -1 EINTR (Interrupted system call)
close(4)                                = 0
close(3)                                = 0
exit_group(130)                         = ?
+++ exited with 130 +++

Kuzma30 · 2023-10-19T13:33:18Z

I try your branch.
Still no delta info.

marckleinebudde · 2023-10-19T14:24:59Z

I've updated the branch, it should output some debug information.

main: sizeof(time_t)=8, sizeof(struct timeval)=16, sizeof(struct __kernel_old_timeval)=16, sizeof(struct __kernel_sock_timeval)=16
SO_TIMESTAMP_OLD=29: tv=1697725454.334298, c_tv=1697725454.334298
 (2023-10-19 16:24:14.334298)  vcan0  TX - -  002   [1]  00
SO_TIMESTAMP_OLD=29: tv=1697725462.246376, c_tv=1697725462.246376
 (2023-10-19 16:24:22.246376)  vcan0  TX - -  002   [1]  00

Kuzma30 · 2023-10-19T14:33:55Z

candump -t delta can0
main: sizeof(time_t)=8, sizeof(struct timeval)=16, sizeof(struct __kernel_old_timeval)=8, sizeof(struct __kernel_sock_timeval)=16
SO_TIMESTAMP_NEW=29: tv=28.1697726000, c_tv=122780.1697726000
 (000.000000)  can0  18EF8183   [3]  03 FF 00
SO_TIMESTAMP_NEW=29: tv=28.1697726000, c_tv=123478.1697726000
 (000.000000)  can0  18EF8381   [7]  01 11 00 00 00 80 4F
SO_TIMESTAMP_NEW=29: tv=28.1697726000, c_tv=124537.1697726000
 (000.000000)  can0  18EF8381   [7]  01 12 00 00 00 80 4F
SO_TIMESTAMP_NEW=29: tv=28.1697726000, c_tv=125589.1697726000
 (000.000000)  can0  18EF8381   [7]  01 13 00 00 00 80 4F
SO_TIMESTAMP_NEW=29: tv=28.1697726000, c_tv=126656.1697726000
 (000.000000)  can0  18EF8381   [7]  01 14 00 00 00 80 4F
SO_TIMESTAMP_NEW=29: tv=28.1697726000, c_tv=127699.1697726000
 (000.000000)  can0  18EF8381   [7]  01 15 00 00 00 80 4F
SO_TIMESTAMP_NEW=29: tv=28.1697726000, c_tv=128763.1697726000
 (000.000000)  can0  18EF8381   [7]  01 16 00 00 00 80 4F
SO_TIMESTAMP_NEW=29: tv=28.1697726000, c_tv=129812.1697726000
 (000.000000)  can0  18EF8381   [7]  01 17 00 00 00 80 4F
SO_TIMESTAMP_NEW=29: tv=28.1697726000, c_tv=130863.1697726000
 (000.000000)  can0  18EF8381   [7]  01 18 00 00 00 80 4F
SO_TIMESTAMP_NEW=29: tv=28.1697726000, c_tv=131930.1697726000
 (000.000000)  can0  18EF8381   [7]  01 91 00 00 00 00 00
SO_TIMESTAMP_NEW=29: tv=28.1697726000, c_tv=173302.1697726000
 (000.000000)  can0  18EF8483   [3]  03 FF 00

marckleinebudde · 2023-10-19T15:55:11Z

I've updated the branch, it should output some more debug information.

Kuzma30 · 2023-10-19T16:04:38Z

candump -t delta can0
main: sizeof(time_t)=8, sizeof(struct timeval)=16, sizeof(struct __kernel_old_timeval)=8, sizeof(struct __kernel_sock_timeval)=16
SO_TIMESTAMP_NEW=63: tv=4796948.1697731440, c_tv=496503.1697731440 0x00079377 0x00000000 0x65315370 0x00000000
 (000.000000)  can0  18EAFFFE   [3]  00 EE 00
SO_TIMESTAMP_NEW=63: tv=4796948.1697731440, c_tv=497153.1697731440 0x00079601 0x00000000 0x65315370 0x00000000
 (000.000000)  can0  18EEFF81   [8]  29 00 E0 FF 00 85 0A A0
SO_TIMESTAMP_NEW=63: tv=4796948.1697731440, c_tv=497712.1697731440 0x00079830 0x00000000 0x65315370 0x00000000
 (000.000000)  can0  18EEFF83   [8]  64 00 E0 FF 09 80 00 A0
SO_TIMESTAMP_NEW=63: tv=4796948.1697731441, c_tv=314122.1697731441 0x0004cb0a 0x00000000 0x65315371 0x00000000
 (000.000000)  can0  18EA8281   [3]  00 EE 00
SO_TIMESTAMP_NEW=63: tv=4796948.1697731441, c_tv=314488.1697731441 0x0004cc78 0x00000000 0x65315371 0x00000000
 (000.000000)  can0  18EA8284   [3]  00 EE 00
SO_TIMESTAMP_NEW=63: tv=4796948.1697731441, c_tv=314865.1697731441 0x0004cdf1 0x00000000 0x65315371 0x00000000
 (000.000000)  can0  18EAED84   [3]  00 EE 00
SO_TIMESTAMP_NEW=63: tv=4796948.1697731441, c_tv=315247.1697731441 0x0004cf6f 0x00000000 0x65315371 0x00000000
 (000.000000)  can0  18EAEF84   [3]  00 EE 00
SO_TIMESTAMP_NEW=63: tv=4796948.1697731441, c_tv=426721.1697731441 0x000682e1 0x00000000 0x65315371 0x00000000
 (000.000000)  can0  18EA82ED   [3]  00 EE 00
SO_TIMESTAMP_NEW=63: tv=4796948.1697731441, c_tv=427102.1697731441 0x0006845e 0x00000000 0x65315371 0x00000000
 (000.000000)  can0  18EAEFED   [3]  00 EE 00
SO_TIMESTAMP_NEW=63: tv=4796948.1697731441, c_tv=427670.1697731441 0x00068696 0x00000000 0x65315371 0x00000000
 (000.000000)  can0  18EEFF82   [8]  2C 00 F5 FF 00 85 0A A0
SO_TIMESTAMP_NEW=63: tv=4796948.1697731441, c_tv=676686.1697731441 0x000a534e 0x00000000 0x65315371 0x00000000
 (000.000000)  can0  18EAEF83   [3]  00 EE 00
SO_TIMESTAMP_NEW=63: tv=4796948.1697731441, c_tv=677160.1697731441 0x000a5528 0x00000000 0x65315371 0x00000000
 (000.000000)  can0  18EAED83   [3]  00 EE 00
SO_TIMESTAMP_NEW=63: tv=4796948.1697731441, c_tv=677790.1697731441 0x000a579e 0x00000000 0x65315371 0x00000000
 (000.000000)  can0  18EEFFED   [8]  2B 00 FD FF 00 81 0A A0
SO_TIMESTAMP_NEW=63: tv=4796948.1697731441, c_tv=756291.1697731441 0x000b8a43 0x00000000 0x65315371 0x00000000
 (000.000000)  can0  18EEFFEF   [8]  E9 03 E0 FF 00 80 0A A0

marckleinebudde · 2023-10-19T19:44:52Z

Can you send me the output of pahole candump.o. You can use pahole of your host distribution. I'm especially interested in the struct *timeval*.

struct timeval {
        __time_t                   tv_sec;               /*     0     8 */
        __suseconds_t              tv_usec;              /*     8     8 */

        /* size: 16, cachelines: 1, members: 2 */
        /* last cacheline: 16 bytes */
};
struct __kernel_old_timeval {
        __kernel_long_t            tv_sec;               /*     0     8 */
        __kernel_long_t            tv_usec;              /*     8     8 */

        /* size: 16, cachelines: 1, members: 2 */
        /* last cacheline: 16 bytes */
};
struct __kernel_sock_timeval {
        __s64                      tv_sec;               /*     0     8 */
        __s64                      tv_usec;              /*     8     8 */

        /* size: 16, cachelines: 1, members: 2 */
        /* last cacheline: 16 bytes */
};

Kuzma30 · 2023-10-20T05:36:24Z

struct timeval {
        __time64_t                 tv_sec;               /*     0     8 */
        __suseconds64_t            tv_usec;              /*     8     8 */

        /* size: 16, cachelines: 1, members: 2 */
        /* last cacheline: 16 bytes */
};
struct __kernel_old_timeval {
        __kernel_long_t            tv_sec;               /*     0     4 */
        __kernel_long_t            tv_usec;              /*     4     4 */

        /* size: 8, cachelines: 1, members: 2 */
        /* last cacheline: 8 bytes */
};
struct __kernel_sock_timeval {
        __s64                      tv_sec;               /*     0     8 */
        __s64                      tv_usec;              /*     8     8 */

        /* size: 16, cachelines: 1, members: 2 */
        /* last cacheline: 16 bytes */
};

marckleinebudde · 2023-10-20T06:53:33Z

I've updated the branch, it should output even more debug information.

Kuzma30 · 2023-10-20T07:08:31Z

candump -t delta can0
main: sizeof(time_t)=8, sizeof(struct timeval)=16, sizeof(struct __kernel_old_timeval)=8, sizeof(struct __kernel_sock_timeval)=16
SO_TIMESTAMP_NEW=63: tv=4911636.1697785647, c_tv=231528.1697785647 0x00038868 0x00000000 0x6532272f 0x00000000
 (000.000000)  can0  18EF8183   [3]  03 FF 00
SO_TIMESTAMP_NEW=63: tv=4911636.1697785647, c_tv=232241.1697785647 0x00038b31 0x00000000 0x6532272f 0x00000000
 (000.000000)  can0  18EF8381   [7]  01 11 00 00 00 80 4F
SO_TIMESTAMP_NEW=63: tv=4911636.1697785647, c_tv=233298.1697785647 0x00038f52 0x00000000 0x6532272f 0x00000000
 (000.000000)  can0  18EF8381   [7]  01 12 00 00 00 80 4F
SO_TIMESTAMP_NEW=63: tv=4911636.1697785647, c_tv=234352.1697785647 0x00039370 0x00000000 0x6532272f 0x00000000
 (000.000000)  can0  18EF8381   [7]  01 13 00 00 00 80 4F

marckleinebudde · 2023-10-20T07:23:29Z

yet another update

Kuzma30 · 2023-10-20T07:33:27Z

candump -t delta can0
main: sizeof(time_t)=8, sizeof(struct timeval)=16, sizeof(struct __kernel_old_timeval)=8, sizeof(struct __kernel_sock_timeval)=16 (memcpy)
SO_TIMESTAMP_NEW=63: tv=1697787182.1697787182, c_tv=730792.1697787182 0x000b26a8 0x00000000 0x65322d2e 0x00000000
 (000.000000)  can0  18EF8483   [3]  03 FF 00
SO_TIMESTAMP_NEW=63: tv=1697787182.1697787182, c_tv=731497.1697787182 0x000b2969 0x00000000 0x65322d2e 0x00000000
 (000.000000)  can0  18EF8384   [7]  01 11 00 00 00 80 4F
SO_TIMESTAMP_NEW=63: tv=1697787182.1697787182, c_tv=732557.1697787182 0x000b2d8d 0x00000000 0x65322d2e 0x00000000
 (000.000000)  can0  18EF8384   [7]  01 12 00 00 00 80 4F
SO_TIMESTAMP_NEW=63: tv=1697787182.1697787182, c_tv=733613.1697787182 0x000b31ad 0x00000000 0x65322d2e 0x00000000
 (000.000000)  can0  18EF8384   [7]  01 13 00 00 00 80 4F

marckleinebudde · 2023-10-20T07:55:33Z

yet another update

marckleinebudde · 2023-10-20T07:56:04Z

Can you give me access to your yocto?

Kuzma30 · 2023-10-20T08:20:35Z

https://doc.qt.io/Boot2Qt/b2qt-how-to-create-b2qt-image.html
I use dev.xml. There is update 1 hour ago. I recompute my rootfs now

marckleinebudde · 2023-10-20T08:41:05Z

Can you test my current branch?

Kuzma30 · 2023-10-20T10:11:16Z

candump -t delta can0
main: sizeof(time_t)=8, sizeof(struct timeval)=16, sizeof(struct __kernel_old_timeval)=8, sizeof(struct __kernel_sock_timeval)=16 (memcpy/print)
SO_TIMESTAMP_NEW=63: tv=-1092684128.1697796645, c_tv=290993.1697796645 0x000470b1 0x00000000 0x65325225 0x00000000
 (000.000000)  can0  18EF8183   [3]  03 FF 00
SO_TIMESTAMP_NEW=63: tv=-1092684128.1697796645, c_tv=291688.1697796645 0x00047368 0x00000000 0x65325225 0x00000000
 (000.000000)  can0  18EF8381   [7]  01 11 00 00 00 80 4F
SO_TIMESTAMP_NEW=63: tv=-1092684128.1697796645, c_tv=292760.1697796645 0x00047798 0x00000000 0x65325225 0x00000000
 (000.000000)  can0  18EF8381   [7]  01 12 00 00 00 80 4F

marckleinebudde · 2023-10-20T10:42:22Z

For whatever reason it seems that usec and sec are swapped. Please try again.

Kuzma30 · 2023-10-20T11:13:31Z

delta can0
main: sizeof(time_t)=8, sizeof(struct timeval)=16, sizeof(struct __kernel_old_timeval)=8, sizeof(struct __kernel_sock_timeval)=16 (memcpy/print/hack)
SO_TIMESTAMP_NEW=63: tv=1697800311.452331, c_tv=1697800311.1697800311 0x0006e6eb 0x00000000 0x65326077 0x00000000
 (000.000000)  can0  18EFEF83   [3]  03 00 00
SO_TIMESTAMP_NEW=63: tv=1697800311.453241, c_tv=1697800311.1697800311 0x0006ea79 0x00000000 0x65326077 0x00000000
 (910.000000)  can0  18EF83EF   [7]  01 35 00 81 BE BF 40
SO_TIMESTAMP_NEW=63: tv=1697800311.454218, c_tv=1697800311.1697800311 0x0006ee4a 0x00000000 0x65326077 0x00000000
 (977.000000)  can0  18EF83EF   [7]  01 36 00 1F EF FF 3F
SO_TIMESTAMP_NEW=63: tv=1697800311.455237, c_tv=1697800311.1697800311 0x0006f245 0x00000000 0x65326077 0x00000000
 (1019.000000)  can0  18EF83EF   [7]  01 37 00 00 00 00 00

marckleinebudde · 2023-10-20T11:35:47Z

https://doc.qt.io/Boot2Qt/b2qt-how-to-create-b2qt-image.html I use dev.xml. There is update 1 hour ago. I recompute my rootfs now

Which MACHINE are you using?

Kuzma30 · 2023-10-20T11:41:41Z

MACHINE=raspberrypi4

marckleinebudde · 2023-10-20T11:51:20Z

Ok, the website only lists raspberrypi4-64, will try raspberrypi4.

Kuzma30 · 2023-10-20T16:04:24Z

You reproduce problem on your system?

marckleinebudde · 2023-10-20T19:34:38Z

It failed to compile the whole system, but meta/conf/distro/defaultsetup.conf includes conf/distro/include/time64.inc which activates 64 bit time_t. I'll build a small yocto BSP next week.

Kuzma30 · 2023-10-21T15:48:41Z

https://sourceware.org/glibc/wiki/Y2038ProofnessDesign mb will be usefull

tisyang · 2023-11-27T01:01:48Z

It maybe only a sprint_timesamp bug on some platform, like alpine linux on armv7l/armhf.

I had meet same problem, candump -taonly show secs with sub-secs always be zero. If change printf formatter of struct timeval.tv_sec and struct timeval.tv_usec from %lu to %llu,
then program will print correct timestamps.

Alpine linux use musl-libc, and musl use time64, link musl time64 Release Notes, so time_t and struct timeval use 64bit, not 32bit on armv7/armhf. So maybe we should change timestamp formatter in can-utils source code.

This only affect 32bit platform, 64bit will all be fine.

tisyang · 2023-11-27T01:05:38Z

This screenshot shows compiling warning about candump.c on alpine armhf/armv7l, in fact it's in an alpine armhf lxc container.

tisyang · 2023-11-27T01:14:04Z

We should consider using C99 long long types for formatting timestamp:
example origin:

sprintf(ts_buffer, "(%010lu.%06lu) ", tv->tv_sec, tv->tv_usec);

example new with C99:

sprintf(ts_buffer, "(%010llu.%06llu) ", (unsigned long long)tv->tv_sec, (unsigned long long)tv->tv_usec);

Update:
I make a pr #473 to fix this, maybe ugly, but straightforward.

Kuzma30 · 2023-11-30T17:07:45Z

Fixed in #473

tisyang mentioned this issue Nov 27, 2023

timestamp formatting: always use 64-bit for timesstamp formatting. #473

Merged

Kuzma30 closed this as completed Nov 30, 2023

Candump dont show delta #469

Candump dont show delta #469

Comments

Kuzma30 commented Oct 17, 2023

marckleinebudde commented Oct 17, 2023

Kuzma30 commented Oct 17, 2023

marckleinebudde commented Oct 17, 2023

hartkopp commented Oct 17, 2023

Kuzma30 commented Oct 17, 2023

hartkopp commented Oct 17, 2023

Kuzma30 commented Oct 19, 2023

marckleinebudde commented Oct 19, 2023

marckleinebudde commented Oct 19, 2023

Kuzma30 commented Oct 19, 2023

marckleinebudde commented Oct 19, 2023 • edited Loading

Kuzma30 commented Oct 19, 2023

marckleinebudde commented Oct 19, 2023

Kuzma30 commented Oct 19, 2023

Kuzma30 commented Oct 19, 2023 • edited by marckleinebudde Loading

marckleinebudde commented Oct 19, 2023 • edited Loading

marckleinebudde commented Oct 19, 2023

Kuzma30 commented Oct 19, 2023

marckleinebudde commented Oct 19, 2023

Kuzma30 commented Oct 19, 2023 • edited Loading

marckleinebudde commented Oct 19, 2023

Kuzma30 commented Oct 19, 2023

marckleinebudde commented Oct 19, 2023 • edited Loading

marckleinebudde commented Oct 19, 2023

marckleinebudde commented Oct 19, 2023

Kuzma30 commented Oct 19, 2023

marckleinebudde commented Oct 19, 2023

Kuzma30 commented Oct 19, 2023

marckleinebudde commented Oct 19, 2023

Kuzma30 commented Oct 19, 2023

Kuzma30 commented Oct 19, 2023

marckleinebudde commented Oct 19, 2023

Kuzma30 commented Oct 19, 2023

marckleinebudde commented Oct 19, 2023

Kuzma30 commented Oct 19, 2023

marckleinebudde commented Oct 19, 2023

Kuzma30 commented Oct 20, 2023

marckleinebudde commented Oct 20, 2023

Kuzma30 commented Oct 20, 2023

marckleinebudde commented Oct 20, 2023

Kuzma30 commented Oct 20, 2023

marckleinebudde commented Oct 20, 2023

marckleinebudde commented Oct 20, 2023

Kuzma30 commented Oct 20, 2023

marckleinebudde commented Oct 20, 2023 • edited Loading

Kuzma30 commented Oct 20, 2023

marckleinebudde commented Oct 20, 2023

Kuzma30 commented Oct 20, 2023

marckleinebudde commented Oct 20, 2023

Kuzma30 commented Oct 20, 2023

marckleinebudde commented Oct 20, 2023

Kuzma30 commented Oct 20, 2023

marckleinebudde commented Oct 20, 2023

Kuzma30 commented Oct 21, 2023

tisyang commented Nov 27, 2023 • edited Loading

tisyang commented Nov 27, 2023

tisyang commented Nov 27, 2023 • edited Loading

Kuzma30 commented Nov 30, 2023

marckleinebudde commented Oct 19, 2023 •

edited

Loading

Kuzma30 commented Oct 19, 2023 •

edited by marckleinebudde

Loading

marckleinebudde commented Oct 19, 2023 •

edited

Loading

Kuzma30 commented Oct 19, 2023 •

edited

Loading

marckleinebudde commented Oct 19, 2023 •

edited

Loading

marckleinebudde commented Oct 20, 2023 •

edited

Loading

tisyang commented Nov 27, 2023 •

edited

Loading

tisyang commented Nov 27, 2023 •

edited

Loading