Diff of the two buildlogs: -- --- b1/build.log 2024-10-30 16:06:47.116516470 +0000 +++ b2/build.log 2024-10-30 16:08:42.624404721 +0000 @@ -1,6 +1,6 @@ I: pbuilder: network access will be disabled during build -I: Current time: Tue Dec 2 10:28:59 -12 2025 -I: pbuilder-time-stamp: 1764714539 +I: Current time: Thu Oct 31 06:06:51 +14 2024 +I: pbuilder-time-stamp: 1730304411 I: Building the build Environment I: extracting base tarball [/var/cache/pbuilder/trixie-reproducible-base.tgz] I: copying local configuration @@ -26,53 +26,85 @@ dpkg-source: info: unpacking golang-github-sasha-s-go-deadlock_0.3.3-1.debian.tar.xz I: Not using root during the build. I: Installing the build-deps -I: user script /srv/workspace/pbuilder/27525/tmp/hooks/D02_print_environment starting +I: user script /srv/workspace/pbuilder/3808/tmp/hooks/D01_modify_environment starting +debug: Running on infom07-i386. +I: Changing host+domainname to test build reproducibility +I: Adding a custom variable just for the fun of it... +I: Changing /bin/sh to bash +'/bin/sh' -> '/bin/bash' +lrwxrwxrwx 1 root root 9 Oct 30 16:07 /bin/sh -> /bin/bash +I: Setting pbuilder2's login shell to /bin/bash +I: Setting pbuilder2's GECOS to second user,second room,second work-phone,second home-phone,second other +I: user script /srv/workspace/pbuilder/3808/tmp/hooks/D01_modify_environment finished +I: user script /srv/workspace/pbuilder/3808/tmp/hooks/D02_print_environment starting I: set - BUILDDIR='/build/reproducible-path' - BUILDUSERGECOS='first user,first room,first work-phone,first home-phone,first other' - BUILDUSERNAME='pbuilder1' - BUILD_ARCH='i386' - DEBIAN_FRONTEND='noninteractive' - DEB_BUILD_OPTIONS='buildinfo=+all reproducible=+all parallel=6 ' - DISTRIBUTION='trixie' - HOME='/root' - HOST_ARCH='i386' + BASH=/bin/sh + BASHOPTS=checkwinsize:cmdhist:complete_fullquote:extquote:force_fignore:globasciiranges:globskipdots:hostcomplete:interactive_comments:patsub_replacement:progcomp:promptvars:sourcepath + BASH_ALIASES=() + BASH_ARGC=() + BASH_ARGV=() + BASH_CMDS=() + BASH_LINENO=([0]="12" [1]="0") + BASH_LOADABLES_PATH=/usr/local/lib/bash:/usr/lib/bash:/opt/local/lib/bash:/usr/pkg/lib/bash:/opt/pkg/lib/bash:. + BASH_SOURCE=([0]="/tmp/hooks/D02_print_environment" [1]="/tmp/hooks/D02_print_environment") + BASH_VERSINFO=([0]="5" [1]="2" [2]="32" [3]="1" [4]="release" [5]="i686-pc-linux-gnu") + BASH_VERSION='5.2.32(1)-release' + BUILDDIR=/build/reproducible-path + BUILDUSERGECOS='second user,second room,second work-phone,second home-phone,second other' + BUILDUSERNAME=pbuilder2 + BUILD_ARCH=i386 + DEBIAN_FRONTEND=noninteractive + DEB_BUILD_OPTIONS='buildinfo=+all reproducible=+all parallel=5 ' + DIRSTACK=() + DISTRIBUTION=trixie + EUID=0 + FUNCNAME=([0]="Echo" [1]="main") + GROUPS=() + HOME=/root + HOSTNAME=i-capture-the-hostname + HOSTTYPE=i686 + HOST_ARCH=i386 IFS=' ' - INVOCATION_ID='1dd92d4724cc4dac9486772ddb5f3d57' - LANG='C' - LANGUAGE='en_US:en' - LC_ALL='C' - LD_LIBRARY_PATH='/usr/lib/libeatmydata' - LD_PRELOAD='libeatmydata.so' - MAIL='/var/mail/root' - OPTIND='1' - PATH='/usr/sbin:/usr/bin:/sbin:/bin:/usr/games' - PBCURRENTCOMMANDLINEOPERATION='build' - PBUILDER_OPERATION='build' - PBUILDER_PKGDATADIR='/usr/share/pbuilder' - PBUILDER_PKGLIBDIR='/usr/lib/pbuilder' - PBUILDER_SYSCONFDIR='/etc' - PPID='27525' - PS1='# ' - PS2='> ' + INVOCATION_ID=be45da7310b94a1a94a4fb33c5e3907c + LANG=C + LANGUAGE=de_CH:de + LC_ALL=C + LD_LIBRARY_PATH=/usr/lib/libeatmydata + LD_PRELOAD=libeatmydata.so + MACHTYPE=i686-pc-linux-gnu + MAIL=/var/mail/root + OPTERR=1 + OPTIND=1 + OSTYPE=linux-gnu + PATH=/usr/sbin:/usr/bin:/sbin:/bin:/usr/games:/i/capture/the/path + PBCURRENTCOMMANDLINEOPERATION=build + PBUILDER_OPERATION=build + PBUILDER_PKGDATADIR=/usr/share/pbuilder + PBUILDER_PKGLIBDIR=/usr/lib/pbuilder + PBUILDER_SYSCONFDIR=/etc + PIPESTATUS=([0]="0") + POSIXLY_CORRECT=y + PPID=3808 PS4='+ ' - PWD='/' - SHELL='/bin/bash' - SHLVL='2' - SUDO_COMMAND='/usr/bin/timeout -k 18.1h 18h /usr/bin/ionice -c 3 /usr/bin/nice /usr/sbin/pbuilder --build --configfile /srv/reproducible-results/rbuild-debian/r-b-build.GnXK8yYA/pbuilderrc_Ddge --distribution trixie --hookdir /etc/pbuilder/first-build-hooks --debbuildopts -b --basetgz /var/cache/pbuilder/trixie-reproducible-base.tgz --buildresult /srv/reproducible-results/rbuild-debian/r-b-build.GnXK8yYA/b1 --logfile b1/build.log golang-github-sasha-s-go-deadlock_0.3.3-1.dsc' - SUDO_GID='111' - SUDO_UID='104' - SUDO_USER='jenkins' - TERM='unknown' - TZ='/usr/share/zoneinfo/Etc/GMT+12' - USER='root' - _='/usr/bin/systemd-run' + PWD=/ + SHELL=/bin/bash + SHELLOPTS=braceexpand:errexit:hashall:interactive-comments:posix + SHLVL=3 + SUDO_COMMAND='/usr/bin/timeout -k 24.1h 24h /usr/bin/ionice -c 3 /usr/bin/nice -n 11 /usr/bin/unshare --uts -- /usr/sbin/pbuilder --build --configfile /srv/reproducible-results/rbuild-debian/r-b-build.GnXK8yYA/pbuilderrc_UYZM --distribution trixie --hookdir /etc/pbuilder/rebuild-hooks --debbuildopts -b --basetgz /var/cache/pbuilder/trixie-reproducible-base.tgz --buildresult /srv/reproducible-results/rbuild-debian/r-b-build.GnXK8yYA/b2 --logfile b2/build.log golang-github-sasha-s-go-deadlock_0.3.3-1.dsc' + SUDO_GID=111 + SUDO_UID=104 + SUDO_USER=jenkins + TERM=unknown + TZ=/usr/share/zoneinfo/Etc/GMT-14 + UID=0 + USER=root + _='I: set' I: uname -a - Linux infom08-i386 6.10.11+bpo-amd64 #1 SMP PREEMPT_DYNAMIC Debian 6.10.11-1~bpo12+1 (2024-10-03) x86_64 GNU/Linux + Linux i-capture-the-hostname 6.1.0-26-amd64 #1 SMP PREEMPT_DYNAMIC Debian 6.1.112-1 (2024-09-30) x86_64 GNU/Linux I: ls -l /bin - lrwxrwxrwx 1 root root 7 Aug 4 2024 /bin -> usr/bin -I: user script /srv/workspace/pbuilder/27525/tmp/hooks/D02_print_environment finished + lrwxrwxrwx 1 root root 7 Aug 4 21:30 /bin -> usr/bin +I: user script /srv/workspace/pbuilder/3808/tmp/hooks/D02_print_environment finished -> Attempting to satisfy build-dependencies -> Creating pbuilder-satisfydepends-dummy package Package: pbuilder-satisfydepends-dummy @@ -150,7 +182,7 @@ Get: 34 http://deb.debian.org/debian trixie/main i386 golang-go i386 2:1.23~2 [44.3 kB] Get: 35 http://deb.debian.org/debian trixie/main i386 golang-any i386 2:1.23~2 [5168 B] Get: 36 http://deb.debian.org/debian trixie/main i386 golang-github-petermattis-goid-dev all 0.0~git20240813.4fcff4a-1 [4880 B] -Fetched 64.3 MB in 3s (22.0 MB/s) +Fetched 64.3 MB in 1s (75.3 MB/s) debconf: delaying package configuration, since apt-utils is not installed Selecting previously unselected package sensible-utils. (Reading database ... (Reading database ... 5% (Reading database ... 10% (Reading database ... 15% (Reading database ... 20% (Reading database ... 25% (Reading database ... 30% (Reading database ... 35% (Reading database ... 40% (Reading database ... 45% (Reading database ... 50% (Reading database ... 55% (Reading database ... 60% (Reading database ... 65% (Reading database ... 70% (Reading database ... 75% (Reading database ... 80% (Reading database ... 85% (Reading database ... 90% (Reading database ... 95% (Reading database ... 100% (Reading database ... 19936 files and directories currently installed.) @@ -309,7 +341,11 @@ Building tag database... -> Finished parsing the build-deps I: Building the package -I: Running cd /build/reproducible-path/golang-github-sasha-s-go-deadlock-0.3.3/ && env PATH="/usr/sbin:/usr/bin:/sbin:/bin:/usr/games" HOME="/nonexistent/first-build" dpkg-buildpackage -us -uc -b && env PATH="/usr/sbin:/usr/bin:/sbin:/bin:/usr/games" HOME="/nonexistent/first-build" dpkg-genchanges -S > ../golang-github-sasha-s-go-deadlock_0.3.3-1_source.changes +I: user script /srv/workspace/pbuilder/3808/tmp/hooks/A99_set_merged_usr starting +Not re-configuring usrmerge for trixie +I: user script /srv/workspace/pbuilder/3808/tmp/hooks/A99_set_merged_usr finished +hostname: Name or service not known +I: Running cd /build/reproducible-path/golang-github-sasha-s-go-deadlock-0.3.3/ && env PATH="/usr/sbin:/usr/bin:/sbin:/bin:/usr/games:/i/capture/the/path" HOME="/nonexistent/second-build" dpkg-buildpackage -us -uc -b && env PATH="/usr/sbin:/usr/bin:/sbin:/bin:/usr/games:/i/capture/the/path" HOME="/nonexistent/second-build" dpkg-genchanges -S > ../golang-github-sasha-s-go-deadlock_0.3.3-1_source.changes dpkg-buildpackage: info: source package golang-github-sasha-s-go-deadlock dpkg-buildpackage: info: source version 0.3.3-1 dpkg-buildpackage: info: source distribution unstable @@ -327,72 +363,72 @@ dh_autoreconf -O--buildsystem=golang dh_auto_configure -O--buildsystem=golang dh_auto_build -O--buildsystem=golang - cd obj-i686-linux-gnu && go install -trimpath -v -p 6 github.com/sasha-s/go-deadlock + cd obj-i686-linux-gnu && go install -trimpath -v -p 5 github.com/sasha-s/go-deadlock internal/unsafeheader -internal/godebugs internal/goarch internal/byteorder internal/coverage/rtcov +internal/godebugs internal/cpu -internal/goexperiment internal/abi +internal/goexperiment +internal/chacha8rand internal/goos internal/profilerecord -internal/chacha8rand internal/runtime/atomic internal/runtime/syscall +internal/bytealg runtime/internal/math runtime/internal/sys internal/race sync/atomic unicode -unicode/utf8 internal/runtime/exithook -internal/bytealg +internal/stringslite +unicode/utf8 cmp internal/itoa math/bits internal/asan internal/msan math -internal/stringslite runtime -iter internal/reflectlite sync +iter slices -internal/testlog internal/bisect -runtime/cgo +internal/testlog errors +runtime/cgo internal/godebug -internal/oserror io -path strconv +internal/oserror bytes strings -reflect +path syscall +reflect github.com/petermattis/goid bufio -internal/syscall/execenv internal/syscall/unix +internal/syscall/execenv time -internal/fmtsort -io/fs internal/poll +io/fs +internal/fmtsort internal/filepathlite os +fmt io/ioutil path/filepath -fmt os/user github.com/sasha-s/go-deadlock dh_auto_test -O--buildsystem=golang - cd obj-i686-linux-gnu && go test -vet=off -v -p 6 github.com/sasha-s/go-deadlock + cd obj-i686-linux-gnu && go test -vet=off -v -p 5 github.com/sasha-s/go-deadlock === RUN TestNoDeadlocks ---- PASS: TestNoDeadlocks (0.79s) +--- PASS: TestNoDeadlocks (0.95s) === RUN TestLockOrder POTENTIAL DEADLOCK: Inconsistent locking. saw this ordering in one goroutine: happened before @@ -412,7 +448,7 @@ deadlock.go:140 go-deadlock.(*RWMutex).RLock { func (m *RWMutex) RLock() { } Other goroutines holding locks: -goroutine 330 lock 0x98141f8 +goroutine 340 lock 0x8d80030 deadlock_test.go:84 go-deadlock.TestLockOrder.func3 { b.Lock() } <<<<< deadlock.go:87 go-deadlock.(*Mutex).Lock { func (m *Mutex) Lock() { } @@ -422,73 +458,73 @@ === RUN TestHardDeadlock POTENTIAL DEADLOCK: Previous place where the lock was grabbed -goroutine 331 lock 0x98142a8 +goroutine 341 lock 0x8d800e8 deadlock_test.go:104 go-deadlock.TestHardDeadlock { mu.Lock() } <<<<< deadlock.go:87 go-deadlock.(*Mutex).Lock { func (m *Mutex) Lock() { } Have been trying to lock it again for more than 20ms -goroutine 333 lock 0x98142a8 +goroutine 343 lock 0x8d800e8 deadlock_test.go:108 go-deadlock.TestHardDeadlock.func2 { mu.Lock() } <<<<< deadlock.go:87 go-deadlock.(*Mutex).Lock { func (m *Mutex) Lock() { } -Here is what goroutine 331 doing now -goroutine 331 [select]: -github.com/sasha-s/go-deadlock.TestHardDeadlock(0x992c408) +Here is what goroutine 341 doing now +goroutine 341 [select]: +github.com/sasha-s/go-deadlock.TestHardDeadlock(0x8d8c108) /build/reproducible-path/golang-github-sasha-s-go-deadlock-0.3.3/obj-i686-linux-gnu/src/github.com/sasha-s/go-deadlock/deadlock_test.go:111 +0x22a -testing.tRunner(0x992c408, 0x81b2660) +testing.tRunner(0x8d8c108, 0x81b2660) /usr/lib/go-1.23/src/testing/testing.go:1690 +0x119 created by testing.(*T).Run in goroutine 1 /usr/lib/go-1.23/src/testing/testing.go:1743 +0x3d1 -2025/12/02 22:29:40 **************** +2024/10/30 16:08:30 **************** --- PASS: TestHardDeadlock (0.10s) === RUN TestRWMutex POTENTIAL DEADLOCK: Previous place where the lock was grabbed -goroutine 341 lock 0x9a18018 +goroutine 320 lock 0x8c1e348 deadlock_test.go:131 go-deadlock.TestRWMutex { a.RLock() } <<<<< deadlock.go:140 go-deadlock.(*RWMutex).RLock { func (m *RWMutex) RLock() { } Have been trying to lock it again for more than 20ms -goroutine 343 lock 0x9a18018 +goroutine 354 lock 0x8c1e348 deadlock_test.go:134 go-deadlock.TestRWMutex.func2 { a.Lock() } <<<<< deadlock.go:119 go-deadlock.(*RWMutex).Lock { func (m *RWMutex) Lock() { } -Here is what goroutine 341 doing now -goroutine 341 [sleep]: +Here is what goroutine 320 doing now +goroutine 320 [sleep]: time.Sleep(0x5f5e100) /usr/lib/go-1.23/src/runtime/time.go:315 +0x119 -github.com/sasha-s/go-deadlock.TestRWMutex(0x9a36008) +github.com/sasha-s/go-deadlock.TestRWMutex(0x8caa308) /build/reproducible-path/golang-github-sasha-s-go-deadlock-0.3.3/obj-i686-linux-gnu/src/github.com/sasha-s/go-deadlock/deadlock_test.go:137 +0x194 -testing.tRunner(0x9a36008, 0x81b2678) +testing.tRunner(0x8caa308, 0x81b2678) /usr/lib/go-1.23/src/testing/testing.go:1690 +0x119 created by testing.(*T).Run in goroutine 1 /usr/lib/go-1.23/src/testing/testing.go:1743 +0x3d1 POTENTIAL DEADLOCK: Previous place where the lock was grabbed -goroutine 341 lock 0x9a18018 +goroutine 320 lock 0x8c1e348 deadlock_test.go:131 go-deadlock.TestRWMutex { a.RLock() } <<<<< deadlock.go:140 go-deadlock.(*RWMutex).RLock { func (m *RWMutex) RLock() { } Have been trying to lock it again for more than 20ms -goroutine 335 lock 0x9a18018 +goroutine 356 lock 0x8c1e348 deadlock_test.go:142 go-deadlock.TestRWMutex.func3 { a.RLock() } <<<<< deadlock.go:140 go-deadlock.(*RWMutex).RLock { func (m *RWMutex) RLock() { } -Here is what goroutine 341 doing now -goroutine 341 [select]: -github.com/sasha-s/go-deadlock.TestRWMutex(0x9a36008) +Here is what goroutine 320 doing now +goroutine 320 [select]: +github.com/sasha-s/go-deadlock.TestRWMutex(0x8caa308) /build/reproducible-path/golang-github-sasha-s-go-deadlock-0.3.3/obj-i686-linux-gnu/src/github.com/sasha-s/go-deadlock/deadlock_test.go:145 +0x27d -testing.tRunner(0x9a36008, 0x81b2678) +testing.tRunner(0x8caa308, 0x81b2678) /usr/lib/go-1.23/src/testing/testing.go:1690 +0x119 created by testing.(*T).Run in goroutine 1 /usr/lib/go-1.23/src/testing/testing.go:1743 +0x3d1 ---- PASS: TestRWMutex (0.15s) +--- PASS: TestRWMutex (0.16s) === RUN TestLockDuplicate POTENTIAL DEADLOCK: Recursive locking: -current goroutine 371 lock 0x98142c8 +current goroutine 360 lock 0x8c14238 deadlock_test.go:181 go-deadlock.TestLockDuplicate.func3 { b.Lock() } <<<<< deadlock.go:87 go-deadlock.(*Mutex).Lock { func (m *Mutex) Lock() { } @@ -497,7 +533,7 @@ deadlock.go:87 go-deadlock.(*Mutex).Lock { func (m *Mutex) Lock() { } POTENTIAL DEADLOCK: Recursive locking: -current goroutine 370 lock 0x981e390 +current goroutine 359 lock 0x8c1e360 deadlock_test.go:175 go-deadlock.TestLockDuplicate.func2 { a.Lock() } <<<<< deadlock.go:119 go-deadlock.(*RWMutex).Lock { func (m *RWMutex) Lock() { } @@ -506,14 +542,14 @@ deadlock.go:140 go-deadlock.(*RWMutex).RLock { func (m *RWMutex) RLock() { } Other goroutines holding locks: -goroutine 371 lock 0x98142c8 +goroutine 360 lock 0x8c14238 deadlock_test.go:180 go-deadlock.TestLockDuplicate.func3 { b.Lock() } <<<<< deadlock.go:87 go-deadlock.(*Mutex).Lock { func (m *Mutex) Lock() { } --- PASS: TestLockDuplicate (1.00s) === RUN TestTryLockNoDeadlocks ---- PASS: TestTryLockNoDeadlocks (0.04s) +--- PASS: TestTryLockNoDeadlocks (0.05s) === RUN TestTryLockOrder POTENTIAL DEADLOCK: Inconsistent locking. saw this ordering in one goroutine: happened before @@ -533,47 +569,47 @@ deadlock.go:140 go-deadlock.(*RWMutex).RLock { func (m *RWMutex) RLock() { } Other goroutines holding locks: -goroutine 370 lock 0x981e390 +goroutine 360 lock 0x8c14238 +deadlock_test.go:180 go-deadlock.TestLockDuplicate.func3 { b.Lock() } <<<<< +deadlock.go:87 go-deadlock.(*Mutex).Lock { func (m *Mutex) Lock() { } + +goroutine 359 lock 0x8c1e360 deadlock_test.go:174 go-deadlock.TestLockDuplicate.func2 { a.RLock() } <<<<< deadlock.go:140 go-deadlock.(*RWMutex).RLock { func (m *RWMutex) RLock() { } -goroutine 347 lock 0x9a1c0a0 +goroutine 363 lock 0x8c142d8 trylock_test.go:93 go-deadlock.TestTryLockOrder.func3 { b.Lock() } <<<<< deadlock.go:87 go-deadlock.(*Mutex).Lock { func (m *Mutex) Lock() { } -goroutine 371 lock 0x98142c8 -deadlock_test.go:180 go-deadlock.TestLockDuplicate.func3 { b.Lock() } <<<<< -deadlock.go:87 go-deadlock.(*Mutex).Lock { func (m *Mutex) Lock() { } - --- PASS: TestTryLockOrder (0.00s) === RUN TestHardDeadlockTryLock POTENTIAL DEADLOCK: Previous place where the lock was grabbed -goroutine 348 lock 0x9a1c158 +goroutine 364 lock 0x8c14388 trylock.go:7 go-deadlock.(*Mutex).TryLock { func (m *Mutex) TryLock() bool { } <<<<< trylock_test.go:112 go-deadlock.TestHardDeadlockTryLock { var mu Mutex } Have been trying to lock it again for more than 20ms -goroutine 349 lock 0x9a1c158 +goroutine 365 lock 0x8c14388 trylock_test.go:119 go-deadlock.TestHardDeadlockTryLock.func2 { mu.Lock() } <<<<< deadlock.go:87 go-deadlock.(*Mutex).Lock { func (m *Mutex) Lock() { } -Here is what goroutine 348 doing now -goroutine 348 [select]: -github.com/sasha-s/go-deadlock.TestHardDeadlockTryLock(0x9a36208) +Here is what goroutine 364 doing now +goroutine 364 [select]: +github.com/sasha-s/go-deadlock.TestHardDeadlockTryLock(0x8caa608) /build/reproducible-path/golang-github-sasha-s-go-deadlock-0.3.3/obj-i686-linux-gnu/src/github.com/sasha-s/go-deadlock/trylock_test.go:122 +0x278 -testing.tRunner(0x9a36208, 0x81b2664) +testing.tRunner(0x8caa608, 0x81b2664) /usr/lib/go-1.23/src/testing/testing.go:1690 +0x119 created by testing.(*T).Run in goroutine 1 /usr/lib/go-1.23/src/testing/testing.go:1743 +0x3d1 Other goroutines holding locks: -goroutine 371 lock 0x98142c8 +goroutine 360 lock 0x8c14238 deadlock_test.go:180 go-deadlock.TestLockDuplicate.func3 { b.Lock() } <<<<< deadlock.go:87 go-deadlock.(*Mutex).Lock { func (m *Mutex) Lock() { } -goroutine 370 lock 0x981e390 +goroutine 359 lock 0x8c1e360 deadlock_test.go:174 go-deadlock.TestLockDuplicate.func2 { a.RLock() } <<<<< deadlock.go:140 go-deadlock.(*RWMutex).RLock { func (m *RWMutex) RLock() { } @@ -585,31 +621,31 @@ === RUN TestRWMutexTryLock POTENTIAL DEADLOCK: Previous place where the lock was grabbed -goroutine 402 lock 0x99ac018 +goroutine 368 lock 0x8c1e3c0 trylock.go:19 go-deadlock.(*RWMutex).TryRLock { func (m *RWMutex) TryRLock() bool { } <<<<< trylock_test.go:153 go-deadlock.TestRWMutexTryLock { var a RWMutex } Have been trying to lock it again for more than 20ms -goroutine 403 lock 0x99ac018 +goroutine 369 lock 0x8c1e3c0 trylock_test.go:159 go-deadlock.TestRWMutexTryLock.func2 { a.Lock() } <<<<< deadlock.go:119 go-deadlock.(*RWMutex).Lock { func (m *RWMutex) Lock() { } -Here is what goroutine 402 doing now -goroutine 402 [sleep]: +Here is what goroutine 368 doing now +goroutine 368 [sleep]: time.Sleep(0x5f5e100) /usr/lib/go-1.23/src/runtime/time.go:315 +0x119 -github.com/sasha-s/go-deadlock.TestRWMutexTryLock(0x99c0108) +github.com/sasha-s/go-deadlock.TestRWMutexTryLock(0x8caa808) /build/reproducible-path/golang-github-sasha-s-go-deadlock-0.3.3/obj-i686-linux-gnu/src/github.com/sasha-s/go-deadlock/trylock_test.go:162 +0x1e2 -testing.tRunner(0x99c0108, 0x81b267c) +testing.tRunner(0x8caa808, 0x81b267c) /usr/lib/go-1.23/src/testing/testing.go:1690 +0x119 created by testing.(*T).Run in goroutine 1 /usr/lib/go-1.23/src/testing/testing.go:1743 +0x3d1 Other goroutines holding locks: -goroutine 371 lock 0x98142c8 +goroutine 360 lock 0x8c14238 deadlock_test.go:180 go-deadlock.TestLockDuplicate.func3 { b.Lock() } <<<<< deadlock.go:87 go-deadlock.(*Mutex).Lock { func (m *Mutex) Lock() { } -goroutine 370 lock 0x981e390 +goroutine 359 lock 0x8c1e360 deadlock_test.go:174 go-deadlock.TestLockDuplicate.func2 { a.RLock() } <<<<< deadlock.go:140 go-deadlock.(*RWMutex).RLock { func (m *RWMutex) RLock() { } @@ -617,38 +653,38 @@ POTENTIAL DEADLOCK: Previous place where the lock was grabbed -goroutine 402 lock 0x99ac018 +goroutine 368 lock 0x8c1e3c0 trylock.go:19 go-deadlock.(*RWMutex).TryRLock { func (m *RWMutex) TryRLock() bool { } <<<<< trylock_test.go:153 go-deadlock.TestRWMutexTryLock { var a RWMutex } Have been trying to lock it again for more than 20ms -goroutine 357 lock 0x99ac018 +goroutine 387 lock 0x8c1e3c0 trylock_test.go:167 go-deadlock.TestRWMutexTryLock.func3 { a.RLock() } <<<<< deadlock.go:140 go-deadlock.(*RWMutex).RLock { func (m *RWMutex) RLock() { } -Here is what goroutine 402 doing now -goroutine 402 [select]: -github.com/sasha-s/go-deadlock.TestRWMutexTryLock(0x99c0108) +Here is what goroutine 368 doing now +goroutine 368 [select]: +github.com/sasha-s/go-deadlock.TestRWMutexTryLock(0x8caa808) /build/reproducible-path/golang-github-sasha-s-go-deadlock-0.3.3/obj-i686-linux-gnu/src/github.com/sasha-s/go-deadlock/trylock_test.go:170 +0x2cb -testing.tRunner(0x99c0108, 0x81b267c) +testing.tRunner(0x8caa808, 0x81b267c) /usr/lib/go-1.23/src/testing/testing.go:1690 +0x119 created by testing.(*T).Run in goroutine 1 /usr/lib/go-1.23/src/testing/testing.go:1743 +0x3d1 Other goroutines holding locks: -goroutine 371 lock 0x98142c8 +goroutine 360 lock 0x8c14238 deadlock_test.go:180 go-deadlock.TestLockDuplicate.func3 { b.Lock() } <<<<< deadlock.go:87 go-deadlock.(*Mutex).Lock { func (m *Mutex) Lock() { } -goroutine 370 lock 0x981e390 +goroutine 359 lock 0x8c1e360 deadlock_test.go:174 go-deadlock.TestLockDuplicate.func2 { a.RLock() } <<<<< deadlock.go:140 go-deadlock.(*RWMutex).RLock { func (m *RWMutex) RLock() { } ---- PASS: TestRWMutexTryLock (0.15s) +--- PASS: TestRWMutexTryLock (0.16s) === RUN TestTryLockDuplicate POTENTIAL DEADLOCK: Recursive locking: -current goroutine 395 lock 0x9814418 +current goroutine 391 lock 0x8c143e0 trylock_test.go:203 go-deadlock.TestTryLockDuplicate.func3 { b.Lock() } <<<<< deadlock.go:87 go-deadlock.(*Mutex).Lock { func (m *Mutex) Lock() { } @@ -657,17 +693,17 @@ trylock_test.go:199 go-deadlock.TestTryLockDuplicate.func3 { go func() { } Other goroutines holding locks: -goroutine 371 lock 0x98142c8 +goroutine 360 lock 0x8c14238 deadlock_test.go:180 go-deadlock.TestLockDuplicate.func3 { b.Lock() } <<<<< deadlock.go:87 go-deadlock.(*Mutex).Lock { func (m *Mutex) Lock() { } -goroutine 370 lock 0x981e390 +goroutine 359 lock 0x8c1e360 deadlock_test.go:174 go-deadlock.TestLockDuplicate.func2 { a.RLock() } <<<<< deadlock.go:140 go-deadlock.(*RWMutex).RLock { func (m *RWMutex) RLock() { } POTENTIAL DEADLOCK: Recursive locking: -current goroutine 394 lock 0x981e3f0 +current goroutine 390 lock 0x8c1e3d8 trylock_test.go:195 go-deadlock.TestTryLockDuplicate.func2 { a.Lock() } <<<<< deadlock.go:119 go-deadlock.(*RWMutex).Lock { func (m *RWMutex) Lock() { } @@ -676,22 +712,22 @@ trylock_test.go:191 go-deadlock.TestTryLockDuplicate.func2 { go func() { } Other goroutines holding locks: -goroutine 371 lock 0x98142c8 +goroutine 391 lock 0x8c143e0 +trylock.go:7 go-deadlock.(*Mutex).TryLock { func (m *Mutex) TryLock() bool { } <<<<< +trylock_test.go:199 go-deadlock.TestTryLockDuplicate.func3 { go func() { } + +goroutine 360 lock 0x8c14238 deadlock_test.go:180 go-deadlock.TestLockDuplicate.func3 { b.Lock() } <<<<< deadlock.go:87 go-deadlock.(*Mutex).Lock { func (m *Mutex) Lock() { } -goroutine 370 lock 0x981e390 +goroutine 359 lock 0x8c1e360 deadlock_test.go:174 go-deadlock.TestLockDuplicate.func2 { a.RLock() } <<<<< deadlock.go:140 go-deadlock.(*RWMutex).RLock { func (m *RWMutex) RLock() { } -goroutine 395 lock 0x9814418 -trylock.go:7 go-deadlock.(*Mutex).TryLock { func (m *Mutex) TryLock() bool { } <<<<< -trylock_test.go:199 go-deadlock.TestTryLockDuplicate.func3 { go func() { } - --- PASS: TestTryLockDuplicate (1.00s) PASS -ok github.com/sasha-s/go-deadlock 3.337s +ok github.com/sasha-s/go-deadlock 3.556s create-stamp debian/debhelper-build-stamp dh_testroot -O--buildsystem=golang dh_prep -O--buildsystem=golang @@ -718,12 +754,14 @@ dpkg-buildpackage: info: binary-only upload (no source included) dpkg-genchanges: info: including full source code in upload I: copying local configuration +I: user script /srv/workspace/pbuilder/3808/tmp/hooks/B01_cleanup starting +I: user script /srv/workspace/pbuilder/3808/tmp/hooks/B01_cleanup finished I: unmounting dev/ptmx filesystem I: unmounting dev/pts filesystem I: unmounting dev/shm filesystem I: unmounting proc filesystem I: unmounting sys filesystem I: cleaning the build env -I: removing directory /srv/workspace/pbuilder/27525 and its subdirectories -I: Current time: Tue Dec 2 10:29:45 -12 2025 -I: pbuilder-time-stamp: 1764714585 +I: removing directory /srv/workspace/pbuilder/3808 and its subdirectories +I: Current time: Thu Oct 31 06:08:41 +14 2024 +I: pbuilder-time-stamp: 1730304521