[Bug 256352] website build: hugo hangs sometimes forever

From: <bugzilla-noreply_at_freebsd.org>
Date: Tue, 01 Jun 2021 20:10:39 UTC
https://bugs.freebsd.org/bugzilla/show_bug.cgi?id=256352

--- Comment #2 from Wolfram Schneider <wosch@FreeBSD.org> ---
I was able to run the whole build process with truss(1). This takes time. Here
is the output before and when it starts to run in an endless loop. (the full
log is 800MB)

 7680:
fstatat(AT_FDCWD,"/usr/local/freebsd/doc/website/static/security/so_public_key.asc",{
mode=-rw-rw-r-- ,inode=936130,size=4369,blksize=4608 },AT_SYMLINK_NOFOLLOW) = 0
(0x0)
 7680:
fstatat(AT_FDCWD,"/usr/local/freebsd/doc/website/public/security/so_public_key.asc",{
mode=-rw-rw-r-- ,inode=940726,size=4369,blksize=4608 },0x0) = 0 (0x0)
 7680: nanosleep({ 0.000020000 })                = 0 (0x0)
 7680:
fstatat(AT_FDCWD,"/usr/local/freebsd/doc/website/static/security/so_public_key.asc",{
mode=-rw-rw-r-- ,inode=936130,size=4369,blksize=4608 },AT_SYMLINK_NOFOLLOW) = 0
(0x0)
 7680:
open("/usr/local/freebsd/doc/website/public/security/so_public_key.asc",O_RDONLY|O_CLOEXEC,00)
= 7 (0x7)
 7680: nanosleep({ 0.000020000 })                = 0 (0x0)
 7680: fstat(7,{ mode=-rw-rw-r-- ,inode=940726,size=4369,blksize=4608 }) = 0
(0x0)
 7680:
fstatat(AT_FDCWD,"/usr/local/freebsd/doc/website/static/security/so_public_key.asc",{
mode=-rw-rw-r-- ,inode=936130,size=4369,blksize=4608 },AT_SYMLINK_NOFOLLOW) = 0
(0x0)
 7680: nanosleep({ 0.000020000 })                = 0 (0x0)
 7680:
fstatat(AT_FDCWD,"/usr/local/freebsd/doc/website/static/security/so_public_key.asc",{
mode=-rw-rw-r-- ,inode=936130,size=4369,blksize=4608 },AT_SYMLINK_NOFOLLOW) = 0
(0x0)
 7680:
fstatat(AT_FDCWD,"/usr/local/freebsd/doc/website/static/security/so_public_key.asc",{
mode=-rw-rw-r-- ,inode=936130,size=4369,blksize=4608 },AT_SYMLINK_NOFOLLOW) = 0
(0x0)
 7680: nanosleep({ 0.000020000 })                = 0 (0x0)
 7680:
fstatat(AT_FDCWD,"/usr/local/freebsd/doc/website/static/security/so_public_key.asc",{
mode=-rw-rw-r-- ,inode=936130,size=4369,blksize=4608 },AT_SYMLINK_NOFOLLOW) = 0
(0x0)
 7680:
open("/usr/local/freebsd/doc/website/static/security/so_public_key.asc",O_RDONLY|O_CLOEXEC,00)
= 8 (0x8)
 7680: thr_kill(105085,SIGURG)                   = 0 (0x0)
 7680: fstat(8,{ mode=-rw-rw-r-- ,inode=936130,size=4369,blksize=4608 }) = 0
(0x0)
 7680: SIGNAL 16 (SIGURG) code=SI_LWP pid=7680 uid=1024
 7680: sigprocmask(SIG_SETMASK,{
SIGHUP|SIGINT|SIGQUIT|SIGILL|SIGTRAP|SIGABRT|SIGEMT|SIGFPE|SIGKILL|SIGBUS|SIGSEGV|SIGSYS|SIGPIPE|SIGALRM|SIGTERM|SIGURG|SIGSTOP|SIGTSTP|SIGCONT|SIGCHLD|SIGTTIN|SIGTTOU|SIGIO|SIGXCPU|SIGXFSZ|SIGVTALRM|SIGPROF|SIGWINCH|SIGINFO|SIGUSR1|SIGUSR2
},0x0) = 0 (0x0)
 7680: sigreturn(0xc0001076c0)                   EJUSTRETURN
 7680: nanosleep({ 0.000020000 })                = 0 (0x0)
 7680: nanosleep({ 0.000020000 })                = 0 (0x0)
 7680: read(7,"-----BEGIN PGP PUBLIC KEY BLOCK-"...,1000) = 1000 (0x3e8)
 7680: read(8,"-----BEGIN PGP PUBLIC KEY BLOCK-"...,1000) = 1000 (0x3e8)
 7680: nanosleep({ 0.000020000 })                = 0 (0x0)
 7680: read(7,"lwCeNtPmA+g5\ncn24psuzOeh1tRElIm"...,1000) = 1000 (0x3e8)
 7680: read(8,"lwCeNtPmA+g5\ncn24psuzOeh1tRElIm"...,1000) = 1000 (0x3e8)
 7680: nanosleep({ 0.000020000 })                = 0 (0x0)
 7680: read(7,"IXlXJR0TvuDuJOaLNvTOC3OI8L97fdBc"...,1000) = 1000 (0x3e8)
 7680: read(8,"IXlXJR0TvuDuJOaLNvTOC3OI8L97fdBc"...,1000) = 1000 (0x3e8)
 7680: nanosleep({ 0.000040000 })                = 0 (0x0)
 7680: read(7,"TECRuM2/T2zHHr0AdKuBPF28U+H\nTxy"...,1000) = 1000 (0x3e8)
 7680: nanosleep({ 0.000080000 })                = 0 (0x0)
 7680: read(8,"TECRuM2/T2zHHr0AdKuBPF28U+H\nTxy"...,1000) = 1000 (0x3e8)
 7680: read(7,"0A\nUEzs6oMF5YOFE8LmykesbUHAbC07"...,1000) = 369 (0x171)
 7680: read(8,"0A\nUEzs6oMF5YOFE8LmykesbUHAbC07"...,1000) = 369 (0x171)
 7680: nanosleep({ 0.000160000 })                = 0 (0x0)
 7680: read(7,0xc00096e400,1000)                 = 0 (0x0)
 7680: read(8,0xc00096e800,1000)                 = 0 (0x0)
 7680: close(8)                                  = 0 (0x0)
 7680: close(7)                                  = 0 (0x0)
 7680:
fstatat(AT_FDCWD,"/usr/local/freebsd/doc/website/public/security/so_public_key.asc",{
mode=-rw-rw-r-- ,inode=940726,size=4369,blksize=4608 },0x0) = 0 (0x0)
 7680: nanosleep({ 0.000320000 })                = 0 (0x0)
 7680:
fstatat(AT_FDCWD,"/usr/local/freebsd/doc/website/static/security/so_public_key.asc",{
mode=-rw-rw-r-- ,inode=936130,size=4369,blksize=4608 },AT_SYMLINK_NOFOLLOW) = 0
(0x0)
 7680: fstatat(AT_FDCWD,"/usr/local/freebsd/doc/website/public/security",{
mode=drwxr-xr-x ,inode=936779,size=13,blksize=131072 },0x0) = 0 (0x0)
 7680: fstatat(AT_FDCWD,"/usr/local/freebsd/doc/website/static/security",{
mode=drwxrwxr-x ,inode=932802,size=7,blksize=131072 },AT_SYMLINK_NOFOLLOW) = 0
(0x0)
 7680: fstatat(AT_FDCWD,"/usr/local/freebsd/doc/website/public/",{
mode=drwxr-xr-x ,inode=936173,size=68,blksize=131072 },0x0) = 0 (0x0)
 7680: utimensat(AT_FDCWD,"/usr/local/freebsd/doc/website/public/",{
-6795364579.128654848, -6795364579.128654848 },0x0) = 0 (0x0)
 7680: nanosleep({ 0.000640000 })                = 0 (0x0)
 7680: _umtx_op(0x2e45a18,UMTX_OP_WAIT_UINT_PRIVATE,0x0,0x18,0x7fffdfffcdc8)
ERR#60 'Operation timed out'
 7680: compat11.kevent(3,0x0,0,{ },64,{ 9.995060341 }) = 0 (0x0)
 7680: _umtx_op(0xc000060d58,UMTX_OP_WAKE_PRIVATE,0x1,0x0,0x0) = 0 (0x0)
 7680: _umtx_op(0xc000060d58,UMTX_OP_WAIT_UINT_PRIVATE,0x0,0x18,0x0) = 0 (0x0)
 7680: nanosleep({ 0.001280000 })                = 0 (0x0)
 7680: _umtx_op(0x2e45a18,UMTX_OP_WAIT_UINT_PRIVATE,0x0,0x18,0x7fffdfffcdc8)
ERR#60 'Operation timed out'
 7680: nanosleep({ 0.002560000 })                = 0 (0x0)
 7680: nanosleep({ 0.005120000 })                = 0 (0x0)
 7680: compat11.kevent(3,0x0,0,{ },64,{ 9.910313681 }) = 0 (0x0)
 7680: _umtx_op(0xc000088158,UMTX_OP_WAKE_PRIVATE,0x1,0x0,0x0) = 0 (0x0)
 7680: _umtx_op(0xc000088158,UMTX_OP_WAIT_UINT_PRIVATE,0x0,0x18,0x0) = 0 (0x0)
 7680: nanosleep({ 0.010000000 })                = 0 (0x0)
 7680: compat11.kevent(3,0x0,0,{ },64,{ 9.901809311 }) = 0 (0x0)
 7680: _umtx_op(0xc000088158,UMTX_OP_WAKE_PRIVATE,0x1,0x0,0x0) = 0 (0x0)
 7680: _umtx_op(0xc000088158,UMTX_OP_WAIT_UINT_PRIVATE,0x0,0x18,0x0) = 0 (0x0)
 7680: _umtx_op(0x2e45a18,UMTX_OP_WAIT_UINT_PRIVATE,0x0,0x18,0x7fffdfffcdc8)
ERR#60 'Operation timed out'
 7680: nanosleep({ 0.010000000 })                = 0 (0x0)
 7680: _umtx_op(0x2e45a18,UMTX_OP_WAIT_UINT_PRIVATE,0x0,0x18,0x7fffdfffcdc8)
ERR#60 'Operation timed out'
 7680: compat11.kevent(3,0x0,0,{ },64,{ 9.911707291 }) = 0 (0x0)
 7680: _umtx_op(0xc000088158,UMTX_OP_WAKE_PRIVATE,0x1,0x0,0x0) = 0 (0x0)
 7680: _umtx_op(0xc000088158,UMTX_OP_WAIT_UINT_PRIVATE,0x0,0x18,0x0) = 0 (0x0)
 7680: nanosleep({ 0.010000000 })                = 0 (0x0)
 7680: compat11.kevent(3,0x0,0,{ },64,{ 9.911323811 }) = 0 (0x0)

[...]

at least you can kill the process with ^C

 7680: _umtx_op(0x2e45a18,UMTX_OP_WAIT_UINT_PRIVATE,0x0,0x18,0x7fffdfffcdc8)
ERR#60 'Operation timed out'
 7680: _umtx_op(0x2e46478,UMTX_OP_WAKE_PRIVATE,0x1,0x0,0x0) = 0 (0x0)
 7680: _umtx_op(0x2e46478,UMTX_OP_WAIT_UINT_PRIVATE,0x0,0x18,0x0) = 0 (0x0)
 7680: nanosleep({ 0.010000000 })                = 0 (0x0)
 7680: _umtx_op(0x2e46478,UMTX_OP_WAIT_UINT_PRIVATE,0x0,0x18,0x0) ERR#4
'Interrupted system call'
 7680: SIGNAL 2 (SIGINT) code=SI_KERNEL
 7680: sigprocmask(SIG_SETMASK,{
SIGHUP|SIGINT|SIGQUIT|SIGILL|SIGTRAP|SIGABRT|SIGEMT|SIGFPE|SIGKILL|SIGBUS|SIGSEGV|SIGSYS|SIGPIPE|SIGALRM|SIGTERM|SIGURG|SIGSTOP|SIGTSTP|SIGCONT|SIGCHLD|SIGTTIN|SIGTTOU|SIGIO|SIGXCPU|SIGXFSZ|SIGVTALRM|SIGPROF|SIGWINCH|SIGINFO|SIGUSR1|SIGUSR2
},0x0) = 0 (0x0)
 7680: sigprocmask(SIG_UNBLOCK,{ SIGINT },0x0)   = 0 (0x0)
 7674: kill(-7680,SIGINT)                        ERR#3 'No such process'
 7680: thr_self(0xc000009510)                    = 0 (0x0)
 7680: thr_kill(100554,SIGINT)                   = 0 (0x0)
 7680: SIGNAL 2 (SIGINT) code=SI_LWP pid=7680 uid=1024
 7680: sigprocmask(SIG_SETMASK,{
SIGHUP|SIGINT|SIGQUIT|SIGILL|SIGTRAP|SIGABRT|SIGEMT|SIGFPE|SIGKILL|SIGBUS|SIGSEGV|SIGSYS|SIGPIPE|SIGALRM|SIGTERM|SIGURG|SIGSTOP|SIGTSTP|SIGCONT|SIGCHLD|SIGTTIN|SIGTTOU|SIGIO|SIGXCPU|SIGXFSZ|SIGVTALRM|SIGPROF|SIGWINCH|SIGINFO|SIGUSR1|SIGUSR2
},0x0) = 0 (0x0)
 7680: sigprocmask(SIG_SETMASK,{
SIGHUP|SIGINT|SIGQUIT|SIGILL|SIGTRAP|SIGABRT|SIGEMT|SIGFPE|SIGKILL|SIGBUS|SIGSEGV|SIGSYS|SIGPIPE|SIGALRM|SIGTERM|SIGURG|SIGSTOP|SIGTSTP|SIGCONT|SIGCHLD|SIGTTIN|SIGTTOU|SIGIO|SIGXCPU|SIGXFSZ|SIGVTALRM|SIGPROF|SIGWINCH|SIGINFO|SIGUSR1|SIGUSR2
},{
SIGHUP|SIGINT|SIGQUIT|SIGILL|SIGTRAP|SIGABRT|SIGEMT|SIGFPE|SIGBUS|SIGSEGV|SIGSYS|SIGPIPE|SIGALRM|SIGTERM|SIGURG|SIGTSTP|SIGCONT|SIGCHLD|SIGTTIN|SIGTTOU|SIGIO|SIGXCPU|SIGXFSZ|SIGVTALRM|SIGPROF|SIGWINCH|SIGINFO|SIGUSR1|SIGUSR2
}) = 0 (0x0)
 7680: sigaction(SIGINT,{ SIG_DFL SA_ONSTACK|SA_RESTART|SA_SIGINFO ss_t },{
0x802e0e410 SA_ONSTACK|SA_RESTART|SA_SIGINFO ss_t }) = 0 (0x0)
 7680: sigprocmask(SIG_SETMASK,{
SIGHUP|SIGINT|SIGQUIT|SIGILL|SIGTRAP|SIGABRT|SIGEMT|SIGFPE|SIGBUS|SIGSEGV|SIGSYS|SIGPIPE|SIGALRM|SIGTERM|SIGURG|SIGTSTP|SIGCONT|SIGCHLD|SIGTTIN|SIGTTOU|SIGIO|SIGXCPU|SIGXFSZ|SIGVTALRM|SIGPROF|SIGWINCH|SIGINFO|SIGUSR1|SIGUSR2
},0x0) = 0 (0x0)
 7680: sigprocmask(SIG_UNBLOCK,{ SIGINT },0x0)   = 0 (0x0)
 7680: thr_self(0xc0000089e8)                    = 0 (0x0)
 7680: thr_kill(100554,SIGINT)                   = 0 (0x0)
 7680: SIGNAL 2 (SIGINT) code=SI_LWP pid=7680 uid=1024
 7680: <thread 105085 exited>
 7680: <thread 105083 exited>
 7680: <thread 105086 exited>
 7680: <thread 105087 exited>
 7680: <thread 105088 exited>
 7680: <thread 105084 exited>
 7680: process killed, signal = 2

-- 
You are receiving this mail because:
You are the assignee for the bug.