Diff of the two buildlogs: -- --- b1/build.log 2024-08-01 08:43:38.089301786 +0000 +++ b2/build.log 2024-08-01 08:51:43.016711373 +0000 @@ -1,6 +1,6 @@ I: pbuilder: network access will be disabled during build -I: Current time: Wed Jul 31 20:37:00 -12 2024 -I: pbuilder-time-stamp: 1722501420 +I: Current time: Thu Aug 1 22:43:49 +14 2024 +I: pbuilder-time-stamp: 1722501829 I: Building the build Environment I: extracting base tarball [/var/cache/pbuilder/unstable-reproducible-base.tgz] I: copying local configuration @@ -28,52 +28,84 @@ dpkg-source: info: applying 0001-Remove-bundler-setup-from-tests.patch I: using fakeroot in build. I: Installing the build-deps -I: user script /srv/workspace/pbuilder/5557/tmp/hooks/D02_print_environment starting +I: user script /srv/workspace/pbuilder/19189/tmp/hooks/D01_modify_environment starting +debug: Running on ff64a. +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 Aug 1 08:44 /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/19189/tmp/hooks/D01_modify_environment finished +I: user script /srv/workspace/pbuilder/19189/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='armhf' - DEBIAN_FRONTEND='noninteractive' - DEB_BUILD_OPTIONS='buildinfo=+all reproducible=+all parallel=3 ' - DISTRIBUTION='unstable' - HOME='/root' - HOST_ARCH='armhf' + 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]="21" [3]="1" [4]="release" [5]="arm-unknown-linux-gnueabihf") + BASH_VERSION='5.2.21(1)-release' + BUILDDIR=/build/reproducible-path + BUILDUSERGECOS='second user,second room,second work-phone,second home-phone,second other' + BUILDUSERNAME=pbuilder2 + BUILD_ARCH=armhf + DEBIAN_FRONTEND=noninteractive + DEB_BUILD_OPTIONS='buildinfo=+all reproducible=+all parallel=6 ' + DIRSTACK=() + DISTRIBUTION=unstable + EUID=0 + FUNCNAME=([0]="Echo" [1]="main") + GROUPS=() + HOME=/root + HOSTNAME=i-capture-the-hostname + HOSTTYPE=arm + HOST_ARCH=armhf IFS=' ' - INVOCATION_ID='7c9508c15e0a4a61bd449613ad9a8688' - LANG='C' - LANGUAGE='en_US:en' - LC_ALL='C' - 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='5557' - PS1='# ' - PS2='> ' + INVOCATION_ID=99cd552a491e4e5b837ede8fb93ec7eb + LANG=C + LANGUAGE=it_CH:it + LC_ALL=C + MACHTYPE=arm-unknown-linux-gnueabihf + MAIL=/var/mail/root + OPTERR=1 + OPTIND=1 + OSTYPE=linux-gnueabihf + 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=19189 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.ugqwOF7c/pbuilderrc_hlle --distribution unstable --hookdir /etc/pbuilder/first-build-hooks --debbuildopts -b --basetgz /var/cache/pbuilder/unstable-reproducible-base.tgz --buildresult /srv/reproducible-results/rbuild-debian/r-b-build.ugqwOF7c/b1 --logfile b1/build.log ruby-acts-as-list_1.0.4-1.dsc' - SUDO_GID='113' - SUDO_UID='107' - SUDO_USER='jenkins' - TERM='unknown' - TZ='/usr/share/zoneinfo/Etc/GMT+12' - USER='root' - _='/usr/bin/systemd-run' - http_proxy='http://10.0.0.15:3142/' + 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.ugqwOF7c/pbuilderrc_Fp3L --distribution unstable --hookdir /etc/pbuilder/rebuild-hooks --debbuildopts -b --basetgz /var/cache/pbuilder/unstable-reproducible-base.tgz --buildresult /srv/reproducible-results/rbuild-debian/r-b-build.ugqwOF7c/b2 --logfile b2/build.log ruby-acts-as-list_1.0.4-1.dsc' + SUDO_GID=114 + SUDO_UID=109 + SUDO_USER=jenkins + TERM=unknown + TZ=/usr/share/zoneinfo/Etc/GMT-14 + UID=0 + USER=root + _='I: set' + http_proxy=http://10.0.0.15:3142/ I: uname -a - Linux cbxi4a 6.1.0-23-armmp #1 SMP Debian 6.1.99-1 (2024-07-15) armv7l GNU/Linux + Linux i-capture-the-hostname 6.1.0-23-arm64 #1 SMP Debian 6.1.99-1 (2024-07-15) aarch64 GNU/Linux I: ls -l /bin lrwxrwxrwx 1 root root 7 Jun 5 22:35 /bin -> usr/bin -I: user script /srv/workspace/pbuilder/5557/tmp/hooks/D02_print_environment finished +I: user script /srv/workspace/pbuilder/19189/tmp/hooks/D02_print_environment finished -> Attempting to satisfy build-dependencies -> Creating pbuilder-satisfydepends-dummy package Package: pbuilder-satisfydepends-dummy @@ -251,7 +283,7 @@ Get: 130 http://deb.debian.org/debian unstable/main armhf ruby-mocha all 1.16.1-3 [158 kB] Get: 131 http://deb.debian.org/debian unstable/main armhf ruby-sqlite3 armhf 1.6.9-1 [3246 kB] Get: 132 http://deb.debian.org/debian unstable/main armhf ruby-timecop all 0.9.10-1 [12.1 kB] -Fetched 45.0 MB in 4s (11.8 MB/s) +Fetched 45.0 MB in 2s (21.7 MB/s) debconf: delaying package configuration, since apt-utils is not installed Selecting previously unselected package libpython3.12-minimal:armhf. (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 ... 19508 files and directories currently installed.) @@ -695,8 +727,8 @@ Setting up tzdata (2024a-4) ... Current default time zone: 'Etc/UTC' -Local time is now: Thu Aug 1 08:39:16 UTC 2024. -Universal Time is now: Thu Aug 1 08:39:16 UTC 2024. +Local time is now: Thu Aug 1 08:46:03 UTC 2024. +Universal Time is now: Thu Aug 1 08:46:03 UTC 2024. Run 'dpkg-reconfigure tzdata' if you wish to change it. Setting up autotools-dev (20220109.1) ... @@ -818,7 +850,11 @@ fakeroot is already the newest version (1.33-1). 0 upgraded, 0 newly installed, 0 to remove and 0 not upgraded. I: Building the package -I: Running cd /build/reproducible-path/ruby-acts-as-list-1.0.4/ && 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 > ../ruby-acts-as-list_1.0.4-1_source.changes +I: user script /srv/workspace/pbuilder/19189/tmp/hooks/A99_set_merged_usr starting +Not re-configuring usrmerge for unstable +I: user script /srv/workspace/pbuilder/19189/tmp/hooks/A99_set_merged_usr finished +hostname: Name or service not known +I: Running cd /build/reproducible-path/ruby-acts-as-list-1.0.4/ && 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 > ../ruby-acts-as-list_1.0.4-1_source.changes dpkg-buildpackage: info: source package ruby-acts-as-list dpkg-buildpackage: info: source version 1.0.4-1 dpkg-buildpackage: info: source distribution unstable @@ -883,206 +919,206 @@ RUBYLIB=/build/reproducible-path/ruby-acts-as-list-1.0.4/debian/ruby-acts-as-list/usr/lib/ruby/vendor_ruby:. GEM_PATH=/build/reproducible-path/ruby-acts-as-list-1.0.4/debian/ruby-acts-as-list/usr/share/rubygems-integration/all:/build/reproducible-path/ruby-acts-as-list-1.0.4/debian/.debhelper/generated/_source/home/.local/share/gem/ruby/3.1.0:/var/lib/gems/3.1.0:/usr/local/lib/ruby/gems/3.1.0:/usr/lib/ruby/gems/3.1.0:/usr/lib/arm-linux-gnueabihf/ruby/gems/3.1.0:/usr/share/rubygems-integration/3.1.0:/usr/share/rubygems-integration/all:/usr/lib/arm-linux-gnueabihf/rubygems-integration/3.1.0 ruby3.1 -S rake --rakelibdir /gem2deb-nonexistent -f debian/ruby-tests.rake /usr/bin/ruby3.1 -w -I"test" /usr/share/rubygems-integration/all/gems/rake-13.2.1/lib/rake/rake_test_loader.rb "test/test_default_scope_with_select.rb" "test/test_joined_list.rb" "test/test_list.rb" "test/test_no_update_for_extra_classes.rb" "test/test_no_update_for_scope_destruction.rb" "test/test_no_update_for_subclasses.rb" "test/test_scope_with_user_defined_foreign_key.rb" -v /usr/share/rubygems-integration/all/gems/activesupport-6.1.7.3/lib/active_support/core_ext/class/subclasses.rb:30: warning: method redefined; discarding old subclasses -Run options: -v --seed 36447 +Run options: -v --seed 40733 # Running: -DefaultScopeWithSelectTest#test_default_scope_with_select = 0.16 s = . -DefaultScopedWhereTest#test_find_or_create_doesnt_raise_deprecation_warning = 0.22 s = . -DefaultScopedWhereTest#test_update_position = 0.29 s = . -DefaultScopedWhereTest#test_reordering = 0.50 s = . -DefaultScopedWhereTest#test_insert = 0.25 s = . -DefaultScopedWhereTest#test_insert_at = 0.36 s = . -TouchDisabledTest#test_deleting_item_does_not_touch_higher_items = 0.20 s = . -NoUpdateForSubclassesTest#test_no_update_for_subclass_instances_with_no_update_on_subclass = 0.09 s = . -NoUpdateForSubclassesTest#test_no_update_for_subclass_instances_with_no_update_on_superclass = 0.08 s = . -NoUpdateForSubclassesTest#test_update = 0.08 s = . -ListSubTest#test_delete_middle = 0.39 s = . -ListSubTest#test_insert_at = 0.46 s = . -ListSubTest#test_move_to_bottom_with_next_to_last_item = 0.36 s = . -ListSubTest#test_next_prev = 0.33 s = . -ListSubTest#test_reordering = 0.55 s = . -ListSubTest#test_next_prev_groups_with_same_position = 0.35 s = . -ListSubTest#test_acts_as_list_class = 0.47 s = . -ListSubTest#test_next_prev_groups = 0.38 s = . -ListSubTest#test_injection = 0.50 s = . -ListSubTest#test_next_prev_not_regular_sequence = 0.60 s = . -TestHigherLowerItems#test_higher_items = 0.21 s = . -TestHigherLowerItems#test_lower_items = 0.11 s = . -SequentialUpdatesMixinNotNullUniquePositiveConstraintsTest::SequentialUpdatesAltIdTouchDisabledTest#test_sequential_updates_default_to_true_with_unique_index = 0.13 s = . -SequentialUpdatesMixinNotNullUniquePositiveConstraintsTest::SequentialUpdatesAltIdTouchDisabledTest#test_deleting_item_does_not_touch_higher_items = 0.08 s = . -ListTest#test_delete_middle = 0.24 s = . -ListTest#test_find_or_create_doesnt_raise_deprecation_warning = 0.22 s = . -ListTest#test_before_create_callback_adds_to_given_position = 0.24 s = . -ListTest#test_insert_race_condition = 86.67 s = . -ListTest#test_remove_from_list_should_then_fail_in_list? = 0.27 s = . -ListTest#test_with_string_based_scope = 0.30 s = . -ListTest#test_before_create_callback_adds_to_bottom = 0.26 s = . -ListTest#test_move_to_bottom_with_next_to_last_item = 0.27 s = . -ListTest#test_remove_before_destroy_does_not_shift_lower_items_twice = 0.30 s = . -ListTest#test_update_position_when_scope_changes = 0.38 s = . -ListTest#test_before_destroy_callbacks_do_not_update_position_to_nil_before_deleting_the_record = 0.26 s = . -ListTest#test_non_persisted_records_dont_get_lock_called = 0.22 s = . -ListTest#test_insert_at = 0.46 s = . -ListTest#test_invalid_records_dont_get_inserted = 0.28 s = . -ListTest#test_invalid_records_raise_error_with_insert_at! = 0.39 s = . -ListTest#test_remove_from_list_should_set_position_to_nil = 0.26 s = . -ListTest#test_nil_scope = 0.28 s = . -ListTest#test_reordering = 0.55 s = . -ListTest#test_next_prev = 0.25 s = . -ListTest#test_insert = 0.33 s = . -ListTest#test_insert_at_after_dup = 0.26 s = . -ListTest#test_current_position = 0.24 s = . -ListTest#test_injection = 0.20 s = . -MultipleListsArrayScopeTest#test_order_after_one_scope_property_is_changed = 0.41 s = . -MultipleListsArrayScopeTest#test_position_after_moving_to_empty_list = 0.42 s = . -MultipleListsArrayScopeTest#test_position_after_all_scope_properties_are_changed = 0.36 s = . -MultipleListsArrayScopeTest#test_order_after_moving_to_empty_list = 0.40 s = . -MultipleListsArrayScopeTest#test_order_after_all_scope_properties_are_changed = 0.37 s = . -MultipleListsArrayScopeTest#test_position_after_one_scope_property_is_changed = 0.36 s = . -NoAdditionTest#test_update_does_not_add_to_list = 0.22 s = . -NoAdditionTest#test_update_scope_does_not_add_to_list = 0.19 s = . -NoAdditionTest#test_insert = 0.18 s = . -TouchTest#test_moving_item_to_bottom_touches_all_other_items = 0.25 s = . -TouchTest#test_moving_item_lower_touches_self_and_lower_item = 0.27 s = . -TouchTest#test_removing_item_touches_all_lower_items = 0.21 s = . -TouchTest#test_moving_item_to_top_touches_all_other_items = 0.24 s = . -TouchTest#test_moving_item_higher_touches_self_and_higher_item = 0.25 s = . -SequentialUpdatesMixinNotNullUniquePositiveConstraintsTest#test_exception_on_wrong_position = 0.23 s = . -SequentialUpdatesMixinNotNullUniquePositiveConstraintsTest#test_move_to_bottom = 0.31 s = . -SequentialUpdatesMixinNotNullUniquePositiveConstraintsTest#test_insert_at = 0.37 s = . -SequentialUpdatesMixinNotNullUniquePositiveConstraintsTest#test_move_to_top = 0.29 s = . -SequentialUpdatesMixinNotNullUniquePositiveConstraintsTest#test_sequential_updates_option_override_with_false = 0.30 s = . -SequentialUpdatesMixinNotNullUniquePositiveConstraintsTest#test_destroy = 0.30 s = . -SequentialUpdatesMixinNotNullUniquePositiveConstraintsTest#test_sequential_updates_default_to_true_with_unique_index = 0.21 s = . -SequentialUpdatesMixinNotNullUniquePositiveConstraintsTest::SequentialUpdatesMixinNotNullUniquePositiveConstraintsTest#test_insert_at = 0.33 s = . -SequentialUpdatesMixinNotNullUniquePositiveConstraintsTest::SequentialUpdatesMixinNotNullUniquePositiveConstraintsTest#test_move_to_bottom = 0.18 s = . -SequentialUpdatesMixinNotNullUniquePositiveConstraintsTest::SequentialUpdatesMixinNotNullUniquePositiveConstraintsTest#test_destroy = 0.17 s = . -SequentialUpdatesMixinNotNullUniquePositiveConstraintsTest::SequentialUpdatesMixinNotNullUniquePositiveConstraintsTest#test_move_to_top = 0.15 s = . -SequentialUpdatesMixinNotNullUniquePositiveConstraintsTest::SequentialUpdatesMixinNotNullUniquePositiveConstraintsTest#test_create_at_top = 0.10 s = . -SequentialUpdatesMixinNotNullUniquePositiveConstraintsTest::SequentialUpdatesMixinNotNullUniquePositiveConstraintsTest#test_sequential_updates_default_to_true_with_unique_index = 0.08 s = . -MultipleListsTest#test_find_or_create_doesnt_raise_deprecation_warning = 0.26 s = . -MultipleListsTest#test_check_scope_order = 0.29 s = . -MultipleListsTest#test_check_scope_position = 0.28 s = . -ListSubTestWithDefault#test_injection = 0.33 s = . -ListSubTestWithDefault#test_insert_at = 0.63 s = . -ListSubTestWithDefault#test_reordering = 0.68 s = . -ListSubTestWithDefault#test_next_prev_groups_with_same_position = 0.42 s = . -ListSubTestWithDefault#test_delete_middle = 0.41 s = . -ListSubTestWithDefault#test_next_prev_not_regular_sequence = 0.69 s = . -ListSubTestWithDefault#test_acts_as_list_class = 0.36 s = . -ListSubTestWithDefault#test_move_to_bottom_with_next_to_last_item = 0.41 s = . -ListSubTestWithDefault#test_next_prev = 0.38 s = . -ListSubTestWithDefault#test_next_prev_groups = 0.52 s = . -NilPositionTest#test_nil_position_ordering = 0.33 s = . -TopAdditionTestWithDefault#test_setup_state = 0.20 s = . -TopAdditionTestWithDefault#test_insert_at = 0.31 s = . -TopAdditionTestWithDefault#test_reordering = 0.50 s = . -TopAdditionTestWithDefault#test_supplied_position = 0.22 s = . -TopAdditionTestWithDefault#test_delete_middle = 0.27 s = . -TopAdditionTestWithDefault#test_injection = 0.21 s = . -TopAdditionTestWithDefault#test_insert = 0.29 s = . -ArrayScopeListTestWithDefault#test_delete_middle = 0.33 s = . -ArrayScopeListTestWithDefault#test_remove_before_destroy_does_not_shift_lower_items_twice = 0.31 s = . -ArrayScopeListTestWithDefault#test_insert = 0.35 s = . -ArrayScopeListTestWithDefault#test_insert_at = 0.43 s = . -ArrayScopeListTestWithDefault#test_reordering = 0.62 s = . -ArrayScopeListTestWithDefault#test_remove_from_list_should_set_position_to_nil = 0.28 s = . -ArrayScopeListTestWithDefault#test_remove_from_list_should_then_fail_in_list? = 0.27 s = . -ArrayScopeListTestWithDefault#test_injection = 0.26 s = . -ArrayScopeListTestWithDefault#test_move_to_bottom_with_next_to_last_item = 0.30 s = . -ArrayScopeListTestWithDefault#test_next_prev = 0.29 s = . -MultiDestroyTest#test_destroy = 0.22 s = . -DefaultScopedTest#test_insert = 0.27 s = . -DefaultScopedTest#test_reordering = 0.46 s = . -DefaultScopedTest#test_update_position = 0.29 s = . -DefaultScopedTest#test_find_or_create_doesnt_raise_deprecation_warning = 0.22 s = . -DefaultScopedTest#test_insert_at = 0.36 s = . -NoUpdateForScopeDestructionTestCase::NoUpdateForScopeDestructionTest#test_no_update_children_when_parent_destroyed = 0.21 s = . -NoUpdateForScopeDestructionTestCase::NoUpdateForScopeDestructionTest#test_update_children_when_sibling_destroyed = 0.15 s = . -QuotingTestList#test_create = 0.08 s = . -QuotingTestList#test_moving = 0.08 s = . -TopAdditionTest#test_reordering = 0.51 s = . -TopAdditionTest#test_delete_middle = 0.56 s = . -TopAdditionTest#test_setup_state = 0.26 s = . -TopAdditionTest#test_supplied_position = 0.22 s = . -TopAdditionTest#test_injection = 0.21 s = . -TopAdditionTest#test_insert = 0.28 s = . -TopAdditionTest#test_insert_at = 0.29 s = . -ScopeWithUserDefinedForeignKeyTest#test_scope_with_user_defined_foreign_key = 0.11 s = . -ActsAsListTopTest#test_class_acts_as_list_top = 0.02 s = . -ActsAsListTopTest#test_acts_as_list_top = 0.16 s = . -NoUpdateForCollectionClassesTest#test_no_update_for_nested_blocks = 0.33 s = . -NoUpdateForCollectionClassesTest#test_non_disparity_classes_error = 0.20 s = . -NoUpdateForCollectionClassesTest#test_raising_array_type_error = 0.20 s = . -NoUpdateForCollectionClassesTest#test_no_update_for_single_class_instances = 0.20 s = . -NoUpdateForCollectionClassesTest#test_update = 0.20 s = . -NoUpdateForCollectionClassesTest#test_no_update_for_different_class_instances = 0.26 s = . -ZeroBasedTestWithDefault#test_insert = 0.34 s = . -ZeroBasedTestWithDefault#test_insert_at = 0.47 s = . -ZeroBasedTestWithDefault#test_reordering = 0.55 s = . -EnumArrayScopeListMixinTest#test_positions = 0.21 s = . -EnumArrayScopeListMixinTest#test_update_state = 0.24 s = . -ListTestWithDefault#test_insert_at_after_dup = 0.26 s = . -ListTestWithDefault#test_invalid_records_raise_error_with_insert_at! = 0.28 s = . -ListTestWithDefault#test_next_prev = 0.25 s = . -ListTestWithDefault#test_with_string_based_scope = 0.26 s = . -ListTestWithDefault#test_remove_before_destroy_does_not_shift_lower_items_twice = 0.24 s = . -ListTestWithDefault#test_current_position = 0.20 s = . -ListTestWithDefault#test_delete_middle = 0.26 s = . -ListTestWithDefault#test_find_or_create_doesnt_raise_deprecation_warning = 0.20 s = . -ListTestWithDefault#test_insert = 0.27 s = . -ListTestWithDefault#test_before_destroy_callbacks_do_not_update_position_to_nil_before_deleting_the_record = 0.24 s = . -ListTestWithDefault#test_move_to_bottom_with_next_to_last_item = 0.24 s = . -ListTestWithDefault#test_injection = 0.18 s = . -ListTestWithDefault#test_insert_at = 0.39 s = . -ListTestWithDefault#test_invalid_records_dont_get_inserted = 0.24 s = . -ListTestWithDefault#test_update_position_when_scope_changes = 0.28 s = . -ListTestWithDefault#test_before_create_callback_adds_to_bottom = 0.21 s = . -ListTestWithDefault#test_remove_from_list_should_set_position_to_nil = 0.22 s = . -ListTestWithDefault#test_reordering = 0.44 s = . -ListTestWithDefault#test_nil_scope = 0.26 s = . -ListTestWithDefault#test_before_create_callback_adds_to_given_position = 0.25 s = . -ListTestWithDefault#test_non_persisted_records_dont_get_lock_called = 0.19 s = . -ListTestWithDefault#test_remove_from_list_should_then_fail_in_list? = 0.21 s = . -ZeroBasedTest#test_insert = 0.29 s = . -ZeroBasedTest#test_insert_at = 0.43 s = . -ZeroBasedTest#test_reordering = 0.59 s = . -ArrayScopeListTest#test_remove_from_list_should_then_fail_in_list? = 0.30 s = . -ArrayScopeListTest#test_insert = 0.36 s = . -ArrayScopeListTest#test_delete_middle = 0.36 s = . -ArrayScopeListTest#test_remove_from_list_should_set_position_to_nil = 0.29 s = . -ArrayScopeListTest#test_injection = 0.26 s = . -ArrayScopeListTest#test_next_prev = 0.33 s = . -ArrayScopeListTest#test_remove_before_destroy_does_not_shift_lower_items_twice = 0.33 s = . -ArrayScopeListTest#test_reordering = 0.73 s = . -ArrayScopeListTest#test_insert_at = 0.51 s = . -ArrayScopeListTest#test_move_to_bottom_with_next_to_last_item = 0.35 s = . -SequentialUpdatesOptionDefaultTest#test_sequential_updates_default_to_false_without_unique_index = 0.16 s = . -ListWithCallbackTest#test_before_create_callback_adds_to_bottom = 0.29 s = . -ListWithCallbackTest#test_nil_scope = 0.34 s = . -ListWithCallbackTest#test_reordering = 0.56 s = . -ListWithCallbackTest#test_injection = 0.26 s = . -ListWithCallbackTest#test_remove_before_destroy_does_not_shift_lower_items_twice = 0.29 s = . -ListWithCallbackTest#test_insert_at_after_dup = 0.33 s = . -ListWithCallbackTest#test_update_position_when_scope_changes = 0.32 s = . -ListWithCallbackTest#test_insert_at = 0.50 s = . -ListWithCallbackTest#test_before_create_callback_adds_to_given_position = 0.32 s = . -ListWithCallbackTest#test_delete_middle = 0.30 s = . -ListWithCallbackTest#test_next_prev = 0.28 s = . -ListWithCallbackTest#test_non_persisted_records_dont_get_lock_called = 0.24 s = . -ListWithCallbackTest#test_invalid_records_dont_get_inserted = 0.33 s = . -ListWithCallbackTest#test_invalid_records_raise_error_with_insert_at! = 0.32 s = . -ListWithCallbackTest#test_find_or_create_doesnt_raise_deprecation_warning = 0.28 s = . -ListWithCallbackTest#test_move_to_bottom_with_next_to_last_item = 0.30 s = . -ListWithCallbackTest#test_with_string_based_scope = 0.32 s = . -ListWithCallbackTest#test_before_destroy_callbacks_do_not_update_position_to_nil_before_deleting_the_record = 0.31 s = . -ListWithCallbackTest#test_remove_from_list_should_set_position_to_nil = 0.28 s = . -ListWithCallbackTest#test_remove_from_list_should_then_fail_in_list? = 0.26 s = . -ListWithCallbackTest#test_insert = 0.38 s = . -ListWithCallbackTest#test_current_position = 0.29 s = . +ActsAsListTopTest#test_acts_as_list_top = 0.39 s = . +ActsAsListTopTest#test_class_acts_as_list_top = 0.03 s = . +ArrayScopeListTest#test_delete_middle = 0.48 s = . +ArrayScopeListTest#test_insert = 0.48 s = . +ArrayScopeListTest#test_remove_from_list_should_then_fail_in_list? = 0.32 s = . +ArrayScopeListTest#test_insert_at = 0.53 s = . +ArrayScopeListTest#test_remove_before_destroy_does_not_shift_lower_items_twice = 0.38 s = . +ArrayScopeListTest#test_remove_from_list_should_set_position_to_nil = 0.35 s = . +ArrayScopeListTest#test_reordering = 0.85 s = . +ArrayScopeListTest#test_next_prev = 0.41 s = . +ArrayScopeListTest#test_move_to_bottom_with_next_to_last_item = 0.60 s = . +ArrayScopeListTest#test_injection = 0.39 s = . +ListSubTestWithDefault#test_injection = 0.60 s = . +ListSubTestWithDefault#test_insert_at = 0.76 s = . +ListSubTestWithDefault#test_acts_as_list_class = 0.50 s = . +ListSubTestWithDefault#test_delete_middle = 0.54 s = . +ListSubTestWithDefault#test_next_prev_not_regular_sequence = 0.93 s = . +ListSubTestWithDefault#test_move_to_bottom_with_next_to_last_item = 0.35 s = . +ListSubTestWithDefault#test_next_prev = 0.26 s = . +ListSubTestWithDefault#test_next_prev_groups = 0.28 s = . +ListSubTestWithDefault#test_next_prev_groups_with_same_position = 0.26 s = . +ListSubTestWithDefault#test_reordering = 0.58 s = . +TestHigherLowerItems#test_lower_items = 0.20 s = . +TestHigherLowerItems#test_higher_items = 0.14 s = . +ListSubTest#test_acts_as_list_class = 0.36 s = . +ListSubTest#test_delete_middle = 0.26 s = . +ListSubTest#test_next_prev = 0.24 s = . +ListSubTest#test_next_prev_groups = 0.26 s = . +ListSubTest#test_reordering = 0.45 s = . +ListSubTest#test_insert_at = 0.36 s = . +ListSubTest#test_injection = 0.22 s = . +ListSubTest#test_next_prev_groups_with_same_position = 0.27 s = . +ListSubTest#test_move_to_bottom_with_next_to_last_item = 0.50 s = . +ListSubTest#test_next_prev_not_regular_sequence = 0.46 s = . +ListTestWithDefault#test_insert_at_after_dup = 0.18 s = . +ListTestWithDefault#test_remove_before_destroy_does_not_shift_lower_items_twice = 0.16 s = . +ListTestWithDefault#test_before_create_callback_adds_to_bottom = 0.14 s = . +ListTestWithDefault#test_injection = 0.13 s = . +ListTestWithDefault#test_non_persisted_records_dont_get_lock_called = 0.13 s = . +ListTestWithDefault#test_before_destroy_callbacks_do_not_update_position_to_nil_before_deleting_the_record = 0.15 s = . +ListTestWithDefault#test_nil_scope = 0.24 s = . +ListTestWithDefault#test_insert = 0.21 s = . +ListTestWithDefault#test_remove_from_list_should_then_fail_in_list? = 0.15 s = . +ListTestWithDefault#test_current_position = 0.16 s = . +ListTestWithDefault#test_remove_from_list_should_set_position_to_nil = 0.17 s = . +ListTestWithDefault#test_find_or_create_doesnt_raise_deprecation_warning = 0.15 s = . +ListTestWithDefault#test_invalid_records_dont_get_inserted = 0.18 s = . +ListTestWithDefault#test_move_to_bottom_with_next_to_last_item = 0.18 s = . +ListTestWithDefault#test_next_prev = 0.17 s = . +ListTestWithDefault#test_with_string_based_scope = 0.20 s = . +ListTestWithDefault#test_invalid_records_raise_error_with_insert_at! = 0.27 s = . +ListTestWithDefault#test_before_create_callback_adds_to_given_position = 0.38 s = . +ListTestWithDefault#test_insert_at = 0.60 s = . +ListTestWithDefault#test_reordering = 0.83 s = . +ListTestWithDefault#test_update_position_when_scope_changes = 0.36 s = . +ListTestWithDefault#test_delete_middle = 0.35 s = . +DefaultScopedWhereTest#test_insert = 0.34 s = . +DefaultScopedWhereTest#test_update_position = 0.42 s = . +DefaultScopedWhereTest#test_find_or_create_doesnt_raise_deprecation_warning = 0.28 s = . +DefaultScopedWhereTest#test_reordering = 0.66 s = . +DefaultScopedWhereTest#test_insert_at = 0.48 s = . +SequentialUpdatesMixinNotNullUniquePositiveConstraintsTest#test_move_to_bottom = 0.34 s = . +SequentialUpdatesMixinNotNullUniquePositiveConstraintsTest#test_move_to_top = 0.35 s = . +SequentialUpdatesMixinNotNullUniquePositiveConstraintsTest#test_insert_at = 0.81 s = . +SequentialUpdatesMixinNotNullUniquePositiveConstraintsTest#test_exception_on_wrong_position = 0.27 s = . +SequentialUpdatesMixinNotNullUniquePositiveConstraintsTest#test_destroy = 0.37 s = . +SequentialUpdatesMixinNotNullUniquePositiveConstraintsTest#test_sequential_updates_option_override_with_false = 0.28 s = . +SequentialUpdatesMixinNotNullUniquePositiveConstraintsTest#test_sequential_updates_default_to_true_with_unique_index = 0.26 s = . +DefaultScopedTest#test_insert_at = 0.43 s = . +DefaultScopedTest#test_insert = 0.18 s = . +DefaultScopedTest#test_find_or_create_doesnt_raise_deprecation_warning = 0.14 s = . +DefaultScopedTest#test_reordering = 0.36 s = . +DefaultScopedTest#test_update_position = 0.45 s = . +ListTest#test_find_or_create_doesnt_raise_deprecation_warning = 0.28 s = . +ListTest#test_injection = 0.26 s = . +ListTest#test_update_position_when_scope_changes = 0.39 s = . +ListTest#test_invalid_records_raise_error_with_insert_at! = 0.36 s = . +ListTest#test_invalid_records_dont_get_inserted = 0.18 s = . +ListTest#test_before_destroy_callbacks_do_not_update_position_to_nil_before_deleting_the_record = 0.17 s = . +ListTest#test_insert_at = 0.31 s = . +ListTest#test_non_persisted_records_dont_get_lock_called = 0.14 s = . +ListTest#test_insert_race_condition = 100.21 s = . +ListTest#test_next_prev = 0.16 s = . +ListTest#test_insert = 0.35 s = . +ListTest#test_insert_at_after_dup = 0.18 s = . +ListTest#test_remove_from_list_should_set_position_to_nil = 0.16 s = . +ListTest#test_nil_scope = 0.20 s = . +ListTest#test_remove_from_list_should_then_fail_in_list? = 0.15 s = . +ListTest#test_delete_middle = 0.19 s = . +ListTest#test_remove_before_destroy_does_not_shift_lower_items_twice = 0.16 s = . +ListTest#test_before_create_callback_adds_to_bottom = 0.15 s = . +ListTest#test_with_string_based_scope = 0.17 s = . +ListTest#test_before_create_callback_adds_to_given_position = 0.17 s = . +ListTest#test_reordering = 0.31 s = . +ListTest#test_move_to_bottom_with_next_to_last_item = 0.16 s = . +ListTest#test_current_position = 0.15 s = . +QuotingTestList#test_create = 0.05 s = . +QuotingTestList#test_moving = 0.05 s = . +DefaultScopeWithSelectTest#test_default_scope_with_select = 0.04 s = . +ScopeWithUserDefinedForeignKeyTest#test_scope_with_user_defined_foreign_key = 0.13 s = . +EnumArrayScopeListMixinTest#test_positions = 0.20 s = . +EnumArrayScopeListMixinTest#test_update_state = 0.14 s = . +SequentialUpdatesMixinNotNullUniquePositiveConstraintsTest::SequentialUpdatesMixinNotNullUniquePositiveConstraintsTest#test_move_to_bottom = 0.11 s = . +SequentialUpdatesMixinNotNullUniquePositiveConstraintsTest::SequentialUpdatesMixinNotNullUniquePositiveConstraintsTest#test_create_at_top = 0.07 s = . +SequentialUpdatesMixinNotNullUniquePositiveConstraintsTest::SequentialUpdatesMixinNotNullUniquePositiveConstraintsTest#test_destroy = 0.10 s = . +SequentialUpdatesMixinNotNullUniquePositiveConstraintsTest::SequentialUpdatesMixinNotNullUniquePositiveConstraintsTest#test_move_to_top = 0.09 s = . +SequentialUpdatesMixinNotNullUniquePositiveConstraintsTest::SequentialUpdatesMixinNotNullUniquePositiveConstraintsTest#test_sequential_updates_default_to_true_with_unique_index = 0.05 s = . +SequentialUpdatesMixinNotNullUniquePositiveConstraintsTest::SequentialUpdatesMixinNotNullUniquePositiveConstraintsTest#test_insert_at = 0.17 s = . +MultiDestroyTest#test_destroy = 0.15 s = . +NilPositionTest#test_nil_position_ordering = 0.17 s = . +ArrayScopeListTestWithDefault#test_insert_at = 0.31 s = . +ArrayScopeListTestWithDefault#test_remove_before_destroy_does_not_shift_lower_items_twice = 0.19 s = . +ArrayScopeListTestWithDefault#test_injection = 0.16 s = . +ArrayScopeListTestWithDefault#test_remove_from_list_should_then_fail_in_list? = 0.19 s = . +ArrayScopeListTestWithDefault#test_reordering = 0.41 s = . +ArrayScopeListTestWithDefault#test_next_prev = 0.19 s = . +ArrayScopeListTestWithDefault#test_delete_middle = 0.22 s = . +ArrayScopeListTestWithDefault#test_remove_from_list_should_set_position_to_nil = 0.19 s = . +ArrayScopeListTestWithDefault#test_insert = 0.23 s = . +ArrayScopeListTestWithDefault#test_move_to_bottom_with_next_to_last_item = 0.20 s = . +TouchDisabledTest#test_deleting_item_does_not_touch_higher_items = 0.14 s = . +NoUpdateForSubclassesTest#test_no_update_for_subclass_instances_with_no_update_on_subclass = 0.06 s = . +NoUpdateForSubclassesTest#test_no_update_for_subclass_instances_with_no_update_on_superclass = 0.06 s = . +NoUpdateForSubclassesTest#test_update = 0.06 s = . +SequentialUpdatesOptionDefaultTest#test_sequential_updates_default_to_false_without_unique_index = 0.10 s = . +ZeroBasedTestWithDefault#test_reordering = 0.37 s = . +ZeroBasedTestWithDefault#test_insert = 0.24 s = . +ZeroBasedTestWithDefault#test_insert_at = 0.32 s = . +TopAdditionTest#test_injection = 0.15 s = . +TopAdditionTest#test_insert_at = 0.20 s = . +TopAdditionTest#test_reordering = 0.35 s = . +TopAdditionTest#test_supplied_position = 0.14 s = . +TopAdditionTest#test_delete_middle = 0.17 s = . +TopAdditionTest#test_insert = 0.22 s = . +TopAdditionTest#test_setup_state = 0.13 s = . +TouchTest#test_moving_item_higher_touches_self_and_higher_item = 0.16 s = . +TouchTest#test_moving_item_lower_touches_self_and_lower_item = 0.16 s = . +TouchTest#test_moving_item_to_top_touches_all_other_items = 0.15 s = . +TouchTest#test_removing_item_touches_all_lower_items = 0.13 s = . +TouchTest#test_moving_item_to_bottom_touches_all_other_items = 0.16 s = . +ListWithCallbackTest#test_next_prev = 0.17 s = . +ListWithCallbackTest#test_remove_from_list_should_then_fail_in_list? = 0.15 s = . +ListWithCallbackTest#test_before_create_callback_adds_to_bottom = 0.16 s = . +ListWithCallbackTest#test_insert_at_after_dup = 0.19 s = . +ListWithCallbackTest#test_with_string_based_scope = 0.20 s = . +ListWithCallbackTest#test_insert_at = 0.31 s = . +ListWithCallbackTest#test_find_or_create_doesnt_raise_deprecation_warning = 0.15 s = . +ListWithCallbackTest#test_before_create_callback_adds_to_given_position = 0.20 s = . +ListWithCallbackTest#test_current_position = 0.16 s = . +ListWithCallbackTest#test_remove_before_destroy_does_not_shift_lower_items_twice = 0.17 s = . +ListWithCallbackTest#test_insert = 0.21 s = . +ListWithCallbackTest#test_non_persisted_records_dont_get_lock_called = 0.14 s = . +ListWithCallbackTest#test_update_position_when_scope_changes = 0.21 s = . +ListWithCallbackTest#test_before_destroy_callbacks_do_not_update_position_to_nil_before_deleting_the_record = 0.18 s = . +ListWithCallbackTest#test_remove_from_list_should_set_position_to_nil = 0.18 s = . +ListWithCallbackTest#test_move_to_bottom_with_next_to_last_item = 0.20 s = . +ListWithCallbackTest#test_injection = 0.16 s = . +ListWithCallbackTest#test_delete_middle = 0.22 s = . +ListWithCallbackTest#test_invalid_records_raise_error_with_insert_at! = 0.20 s = . +ListWithCallbackTest#test_invalid_records_dont_get_inserted = 0.19 s = . +ListWithCallbackTest#test_nil_scope = 0.22 s = . +ListWithCallbackTest#test_reordering = 0.38 s = . +NoUpdateForCollectionClassesTest#test_no_update_for_single_class_instances = 0.16 s = . +NoUpdateForCollectionClassesTest#test_no_update_for_different_class_instances = 0.16 s = . +NoUpdateForCollectionClassesTest#test_no_update_for_nested_blocks = 0.20 s = . +NoUpdateForCollectionClassesTest#test_raising_array_type_error = 0.12 s = . +NoUpdateForCollectionClassesTest#test_update = 0.15 s = . +NoUpdateForCollectionClassesTest#test_non_disparity_classes_error = 0.12 s = . +MultipleListsTest#test_find_or_create_doesnt_raise_deprecation_warning = 0.22 s = . +MultipleListsTest#test_check_scope_order = 0.23 s = . +MultipleListsTest#test_check_scope_position = 0.24 s = . +NoAdditionTest#test_update_does_not_add_to_list = 0.12 s = . +NoAdditionTest#test_update_scope_does_not_add_to_list = 0.12 s = . +NoAdditionTest#test_insert = 0.11 s = . +ZeroBasedTest#test_insert_at = 0.29 s = . +ZeroBasedTest#test_insert = 0.21 s = . +ZeroBasedTest#test_reordering = 0.36 s = . +SequentialUpdatesMixinNotNullUniquePositiveConstraintsTest::SequentialUpdatesAltIdTouchDisabledTest#test_deleting_item_does_not_touch_higher_items = 0.09 s = . +SequentialUpdatesMixinNotNullUniquePositiveConstraintsTest::SequentialUpdatesAltIdTouchDisabledTest#test_sequential_updates_default_to_true_with_unique_index = 0.04 s = . +TopAdditionTestWithDefault#test_supplied_position = 0.14 s = . +TopAdditionTestWithDefault#test_insert = 0.19 s = . +TopAdditionTestWithDefault#test_insert_at = 0.18 s = . +TopAdditionTestWithDefault#test_reordering = 0.32 s = . +TopAdditionTestWithDefault#test_setup_state = 0.13 s = . +TopAdditionTestWithDefault#test_injection = 0.12 s = . +TopAdditionTestWithDefault#test_delete_middle = 0.16 s = . +NoUpdateForScopeDestructionTestCase::NoUpdateForScopeDestructionTest#test_no_update_children_when_parent_destroyed = 0.13 s = . +NoUpdateForScopeDestructionTestCase::NoUpdateForScopeDestructionTest#test_update_children_when_sibling_destroyed = 0.09 s = . +MultipleListsArrayScopeTest#test_order_after_all_scope_properties_are_changed = 0.25 s = . +MultipleListsArrayScopeTest#test_order_after_moving_to_empty_list = 0.23 s = . +MultipleListsArrayScopeTest#test_position_after_all_scope_properties_are_changed = 0.24 s = . +MultipleListsArrayScopeTest#test_order_after_one_scope_property_is_changed = 0.24 s = . +MultipleListsArrayScopeTest#test_position_after_moving_to_empty_list = 0.24 s = . +MultipleListsArrayScopeTest#test_position_after_one_scope_property_is_changed = 0.23 s = . -Finished in 145.398659s, 1.3343 runs/s, 6.6988 assertions/s. +Finished in 148.659946s, 1.3050 runs/s, 6.5519 assertions/s. 194 runs, 974 assertions, 0 failures, 0 errors, 0 skips @@ -1115,12 +1151,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/19189/tmp/hooks/B01_cleanup starting +I: user script /srv/workspace/pbuilder/19189/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/5557 and its subdirectories -I: Current time: Wed Jul 31 20:43:33 -12 2024 -I: pbuilder-time-stamp: 1722501813 +I: removing directory /srv/workspace/pbuilder/19189 and its subdirectories +I: Current time: Thu Aug 1 22:51:38 +14 2024 +I: pbuilder-time-stamp: 1722502298