| Name | 3hGKDmNH3B9n9Rq4apOajLDm4fhM0noT9bVooX4SDmHHqKDmZhXOsm_1 |
| Workunit | 239196617 |
| Created | 16 Feb 2026, 8:33:39 UTC |
| Sent | 16 Feb 2026, 9:01:39 UTC |
| Report deadline | 24 Feb 2026, 9:01:39 UTC |
| Received | 21 Feb 2026, 10:40:55 UTC |
| Server state | Over |
| Outcome | Validate error |
| Client state | Done |
| Exit status | 0 (0x00000000) |
| Computer ID | 10740518 |
| Run time | 19 min 53 sec |
| CPU time | 10 min 52 sec |
| Priority | 28 |
| Validate state | Invalid |
| Credit | 0.00 |
| Device peak FLOPS | 16.56 GFLOPS |
| Application version | ATLAS Simulation v3.03 (vbox64_mt_mcore_atlas) windows_x86_64 |
| Peak working set size | 106.60 MB |
| Peak swap size | 127.44 MB |
| Peak disk usage | 2.46 GB |
Stderr output
<core_client_version>7.16.20</core_client_version> <![CDATA[ <stderr_txt> 026-02-18 02:00:54 (16284): VM state change detected. (old = 'running', new = 'paused') 2026-02-18 03:00:48 (16284): VM state change detected. (old = 'paused', new = 'running') 2026-02-18 03:00:50 (16284): Guest Log: 00:04:00.948035 timesync vgsvcTimeSyncWorker: Radical host time change: 3 604 100 000 000ns (HostNow=1 771 401 650 148 000 000 ns HostLast=1 771 398 046 048 000 000 ns) 2026-02-18 03:00:50 (16284): Guest Log: 00:04:00.948118 timesync vgsvcTimeSyncWorker: Radical guest time change: 3 603 855 740 000ns (GuestNow=1 771 398 056 301 228 000 ns GuestLast=1 771 394 452 445 488 000 ns fSetTimeLastLoop=true ) 2026-02-18 03:00:58 (16284): VM state change detected. (old = 'running', new = 'paused') 2026-02-18 04:00:42 (16284): VM state change detected. (old = 'paused', new = 'running') 2026-02-18 04:00:44 (16284): Guest Log: 00:04:10.948411 timesync vgsvcTimeSyncWorker: Radical host time change: 3 593 013 000 000ns (HostNow=1 771 405 243 161 000 000 ns HostLast=1 771 401 650 148 000 000 ns) 2026-02-18 04:00:44 (16284): Guest Log: 00:04:10.948484 timesync vgsvcTimeSyncWorker: Radical guest time change: 3 603 847 673 000ns (GuestNow=1 771 401 660 148 901 000 ns GuestLast=1 771 398 056 301 228 000 ns fSetTimeLastLoop=true ) 2026-02-18 04:00:52 (16284): VM state change detected. (old = 'running', new = 'paused') 2026-02-18 04:15:32 (16284): VM state change detected. (old = 'paused', new = 'running') 2026-02-18 04:15:33 (16284): Guest Log: 00:04:20.949262 timesync vgsvcTimeSyncWorker: Radical guest time change: 3 593 013 041 000ns (GuestNow=1 771 405 253 161 942 000 ns GuestLast=1 771 401 660 148 901 000 ns fSetTimeLastLoop=true ) 2026-02-18 04:15:42 (16284): VM state change detected. (old = 'running', new = 'paused') 2026-02-18 05:00:46 (16284): VM state change detected. (old = 'paused', new = 'running') 2026-02-18 05:00:47 (16284): Guest Log: 00:04:30.949892 timesync vgsvcTimeSyncWorker: Radical host time change: 2 713 476 000 000ns (HostNow=1 771 408 846 968 000 000 ns HostLast=1 771 406 133 492 000 000 ns) 2026-02-18 05:00:56 (16284): VM state change detected. (old = 'running', new = 'paused') 2026-02-18 06:00:39 (16284): VM state change detected. (old = 'paused', new = 'running') 2026-02-18 06:00:40 (16284): Guest Log: 00:04:41.341827 timesync vgsvcTimeSyncWorker: Radical host time change: 3 592 737 000 000ns (HostNow=1 771 412 439 705 000 000 ns HostLast=1 771 408 846 968 000 000 ns) 2026-02-18 06:00:40 (16284): Guest Log: 00:04:41.341948 timesync vgsvcTimeSyncWorker: Radical guest time change: 3 593 806 553 000ns (GuestNow=1 771 408 856 968 726 000 ns GuestLast=1 771 405 263 162 173 000 ns fSetTimeLastLoop=true ) 2026-02-18 06:00:49 (16284): VM state change detected. (old = 'running', new = 'paused') 2026-02-18 07:00:43 (16284): VM state change detected. (old = 'paused', new = 'running') 2026-02-18 07:00:44 (16284): Guest Log: 00:04:51.343251 timesync vgsvcTimeSyncWorker: Radical host time change: 3 604 198 000 000ns (HostNow=1 771 416 043 903 000 000 ns HostLast=1 771 412 439 705 000 000 ns) 2026-02-18 07:00:44 (16284): Guest Log: 00:04:51.343321 timesync vgsvcTimeSyncWorker: Radical guest time change: 3 593 128 963 000ns (GuestNow=1 771 412 450 097 689 000 ns GuestLast=1 771 408 856 968 726 000 ns fSetTimeLastLoop=true ) 2026-02-18 07:00:53 (16284): VM state change detected. (old = 'running', new = 'paused') 2026-02-18 20:00:35 (17424): vboxwrapper version 26210 2026-02-18 20:00:35 (17424): BOINC client version: 7.16.20 2026-02-18 20:00:38 (17424): Detected: VirtualBox VboxManage Interface (Version: 6.0.14) 2026-02-18 20:00:39 (17424): Guest Log: BIOS: VirtualBox 6.0.14 2026-02-18 20:00:39 (17424): Guest Log: CPUID EDX: 0x178bfbff 2026-02-18 20:00:39 (17424): Guest Log: BIOS: AHCI 0-P#0: PCHS=16383/16/63 LCHS=1024/255/63 0x0000000002800000 sectors 2026-02-18 20:00:39 (17424): Guest Log: BIOS: Boot : bseqnr=1, bootseq=0032 2026-02-18 20:00:39 (17424): Guest Log: BIOS: Booting from Hard Disk... 2026-02-18 20:00:39 (17424): Guest Log: BIOS: KBD: unsupported int 16h function 03 2026-02-18 20:00:39 (17424): Guest Log: BIOS: AX=0305 BX=0000 CX=0000 DX=0000 2026-02-18 20:00:39 (17424): Guest Log: int13_harddisk_ext: function 41, unmapped device for ELDL=81 2026-02-18 20:00:39 (17424): Guest Log: int13_harddisk: function 02, unmapped device for ELDL=81 2026-02-18 20:00:39 (17424): Guest Log: int13_harddisk_ext: function 41, unmapped device for ELDL=82 2026-02-18 20:00:39 (17424): Guest Log: int13_harddisk: function 02, unmapped device for ELDL=82 2026-02-18 20:00:39 (17424): Guest Log: int13_harddisk_ext: function 41, unmapped device for ELDL=83 2026-02-18 20:00:39 (17424): Guest Log: int13_harddisk: function 02, unmapped device for ELDL=83 2026-02-18 20:00:39 (17424): Guest Log: int13_harddisk_ext: function 41, unmapped device for ELDL=84 2026-02-18 20:00:39 (17424): Guest Log: int13_harddisk: function 02, unmapped device for ELDL=84 2026-02-18 20:00:39 (17424): Guest Log: int13_harddisk_ext: function 41, unmapped device for ELDL=85 2026-02-18 20:00:39 (17424): Guest Log: int13_harddisk: function 02, unmapped device for ELDL=85 2026-02-18 20:00:39 (17424): Guest Log: int13_harddisk_ext: function 41, unmapped device for ELDL=86 2026-02-18 20:00:39 (17424): Guest Log: int13_harddisk: function 02, unmapped device for ELDL=86 2026-02-18 20:00:39 (17424): Guest Log: int13_harddisk_ext: function 41, unmapped device for ELDL=87 2026-02-18 20:00:39 (17424): Guest Log: int13_harddisk: function 02, unmapped device for ELDL=87 2026-02-18 20:00:39 (17424): Guest Log: int13_harddisk_ext: function 41, unmapped device for ELDL=88 2026-02-18 20:00:39 (17424): Guest Log: int13_harddisk: function 02, unmapped device for ELDL=88 2026-02-18 20:00:39 (17424): Guest Log: int13_harddisk_ext: function 41, unmapped device for ELDL=89 2026-02-18 20:00:39 (17424): Guest Log: int13_harddisk: function 02, unmapped device for ELDL=89 2026-02-18 20:00:39 (17424): Guest Log: int13_harddisk_ext: function 41, unmapped device for ELDL=8a 2026-02-18 20:00:39 (17424): Guest Log: int13_harddisk: function 02, unmapped device for ELDL=8a 2026-02-18 20:00:39 (17424): Guest Log: int13_harddisk_ext: function 41, unmapped device for ELDL=8b 2026-02-18 20:00:39 (17424): Guest Log: int13_harddisk: function 02, unmapped device for ELDL=8b 2026-02-18 20:00:39 (17424): Guest Log: int13_harddisk_ext: function 41, unmapped device for ELDL=8c 2026-02-18 20:00:39 (17424): Guest Log: int13_harddisk: function 02, unmapped device for ELDL=8c 2026-02-18 20:00:39 (17424): Guest Log: int13_harddisk_ext: function 41, unmapped device for ELDL=8d 2026-02-18 20:00:39 (17424): Guest Log: int13_harddisk: function 02, unmapped device for ELDL=8d 2026-02-18 20:00:39 (17424): Guest Log: int13_harddisk_ext: function 41, unmapped device for ELDL=8e 2026-02-18 20:00:39 (17424): Guest Log: int13_harddisk: function 02, unmapped device for ELDL=8e 2026-02-18 20:00:39 (17424): Guest Log: int13_harddisk_ext: function 41, unmapped device for ELDL=8f 2026-02-18 20:00:39 (17424): Guest Log: int13_harddisk: function 02, unmapped device for ELDL=8f 2026-02-18 20:00:39 (17424): Guest Log: vgdrvHeartbeatInit: Setting up heartbeat to trigger every 2000 milliseconds 2026-02-18 20:00:39 (17424): Guest Log: vboxguest: misc device minor 58, IRQ 20, I/O port d020, MMIO at 00000000f0000000 (size 0x400000) 2026-02-18 20:00:39 (17424): Guest Log: VBoxService 5.2.32 r132073 (verbosity: 0) linux.amd64 (Jul 12 2019 10:32:28) release log 2026-02-18 20:00:39 (17424): Guest Log: 00:00:00.000178 main Log opened 2026-02-16T05:01:34.990810000Z 2026-02-18 20:00:39 (17424): Guest Log: 00:00:00.000340 main OS Product: Linux 2026-02-18 20:00:39 (17424): Guest Log: 00:00:00.000423 main OS Release: 3.10.0-957.27.2.el7.x86_64 2026-02-18 20:00:39 (17424): Guest Log: 00:00:00.000465 main OS Version: #1 SMP Mon Jul 29 17:46:05 UTC 2019 2026-02-18 20:00:39 (17424): Guest Log: 00:00:00.000502 main Executable: /opt/VBoxGuestAdditions-5.2.32/sbin/VBoxService 2026-02-18 20:00:39 (17424): Guest Log: 00:00:00.000503 main Process ID: 1301 2026-02-18 20:00:39 (17424): Guest Log: 00:00:00.000504 main Package type: LINUX_64BITS_GENERIC 2026-02-18 20:00:39 (17424): Guest Log: 00:00:00.001486 main 5.2.32 r132073 started. Verbose level = 0 2026-02-18 20:00:39 (17424): Guest Log: [INFO] Probing /cvmfs/atlas.cern.ch... 2026-02-18 20:00:39 (17424): Guest Log: [INFO] Mounting shared directory 2026-02-18 20:00:39 (17424): Guest Log: [INFO] Checking for init_data.xml 2026-02-18 20:00:39 (17424): Guest Log: 00:00:10.005896 timesync vgsvcTimeSyncWorker: Radical host time change: 3 393 030 000 000ns (HostNow=1 771 293 441 227 000 000 ns HostLast=1 771 290 048 197 000 000 ns) 2026-02-18 20:00:39 (17424): Guest Log: 00:00:10.005985 timesync vgsvcTimeSyncWorker: Radical guest time change: 71 963 202 017 000ns (GuestNow=1 771 290 058 197 709 000 ns GuestLast=1 771 218 094 995 692 000 ns fSetTimeLastLoop=true ) 2026-02-18 20:00:39 (17424): Guest Log: [INFO] Probing /cvmfs/atlas.cern.ch... OK 2026-02-18 20:00:39 (17424): Guest Log: [INFO] Detected branch: prod 2026-02-18 20:00:39 (17424): Guest Log: This is the prod version of the ATLAS job wrapper 2026-02-18 20:00:39 (17424): Guest Log: Copying input files 2026-02-18 20:00:39 (17424): Guest Log: 00:00:20.006395 timesync vgsvcTimeSyncWorker: Radical guest time change: 3 393 029 880 000ns (GuestNow=1 771 293 451 227 589 000 ns GuestLast=1 771 290 058 197 709 000 ns fSetTimeLastLoop=true ) 2026-02-18 20:00:39 (17424): Guest Log: 00:00:30.008169 timesync vgsvcTimeSyncWorker: Radical host time change: 3 602 860 000 000ns (HostNow=1 771 297 255 195 000 000 ns HostLast=1 771 293 652 335 000 000 ns) 2026-02-18 20:00:39 (17424): Guest Log: 00:00:40.009024 timesync vgsvcTimeSyncWorker: Radical host time change: 3 603 510 000 000ns (HostNow=1 771 300 858 705 000 000 ns HostLast=1 771 297 255 195 000 000 ns) 2026-02-18 20:00:39 (17424): Guest Log: 00:00:40.009141 timesync vgsvcTimeSyncWorker: Radical guest time change: 3 803 966 795 000ns (GuestNow=1 771 297 265 195 843 000 ns GuestLast=1 771 293 461 229 048 000 ns fSetTimeLastLoop=true ) 2026-02-18 20:00:39 (17424): Guest Log: 00:00:50.011174 timesync vgsvcTimeSyncWorker: Radical host time change: 3 592 646 000 000ns (HostNow=1 771 304 451 351 000 000 ns HostLast=1 771 300 858 705 000 000 ns) 2026-02-18 20:00:39 (17424): Guest Log: 00:00:50.011263 timesync vgsvcTimeSyncWorker: Radical guest time change: 3 603 511 272 000ns (GuestNow=1 771 300 868 707 115 000 ns GuestLast=1 771 297 265 195 843 000 ns fSetTimeLastLoop=true ) 2026-02-18 20:00:39 (17424): Guest Log: 00:01:00.011977 timesync vgsvcTimeSyncWorker: Radical host time change: 4 232 784 000 000ns (HostNow=1 771 308 684 135 000 000 ns HostLast=1 771 304 451 351 000 000 ns) 2026-02-18 20:00:39 (17424): Guest Log: 00:01:00.012045 timesync vgsvcTimeSyncWorker: Radical guest time change: 3 592 644 705 000ns (GuestNow=1 771 304 461 351 820 000 ns GuestLast=1 771 300 868 707 115 000 ns fSetTimeLastLoop=true ) 2026-02-18 20:00:39 (17424): Guest Log: Copied input files into RunAtlas. 2026-02-18 20:00:39 (17424): Guest Log: This VM did not configure a local http proxy via BOINC. 2026-02-18 20:00:39 (17424): Guest Log: Small home clusters do not require a local http proxy but it is suggested if 2026-02-18 20:00:39 (17424): Guest Log: more than 10 cores throughout the same LAN segment are regularly running ATLAS like tasks. 2026-02-18 20:00:39 (17424): Guest Log: Further information can be found at the LHC@home message board. 2026-02-18 20:00:39 (17424): Guest Log: 00:01:10.015778 timesync vgsvcTimeSyncWorker: Radical guest time change: 4 232 787 085 000ns (GuestNow=1 771 308 694 138 905 000 ns GuestLast=1 771 304 461 351 820 000 ns fSetTimeLastLoop=true ) 2026-02-18 20:00:39 (17424): Guest Log: 00:01:20.016648 timesync vgsvcTimeSyncWorker: Radical host time change: 2 131 625 000 000ns (HostNow=1 771 311 646 453 000 000 ns HostLast=1 771 309 514 828 000 000 ns) 2026-02-18 20:00:39 (17424): Guest Log: Running cvmfs_config stat atlas.cern.ch 2026-02-18 20:00:39 (17424): Guest Log: VERSION PID UPTIME(M) MEM(K) REVISION EXPIRES(M) NOCATALOGS CACHEUSE(K) CACHEMAX(K) NOFDUSE NOFDMAX NOIOERR NOOPEN HITRATE(%) RX(K) SPEED(K/S) HOST PROXY ONLINE 2026-02-18 20:00:39 (17424): Guest Log: 2.6.3.0 1590 303 30336 156314 3 1 3120738 4096000 0 65024 0 0 n/a 1336 914 http://s1cern-cvmfs.openhtc.io/cvmfs/atlas.cern.ch DIRECT 1 2026-02-18 20:00:39 (17424): Guest Log: 00:01:30.028018 timesync vgsvcTimeSyncWorker: Radical host time change: 3 603 956 000 000ns (HostNow=1 771 315 250 409 000 000 ns HostLast=1 771 311 646 453 000 000 ns) 2026-02-18 20:00:39 (17424): Guest Log: 00:01:30.028099 timesync vgsvcTimeSyncWorker: Radical guest time change: 2 952 324 724 000ns (GuestNow=1 771 311 656 464 398 000 ns GuestLast=1 771 308 704 139 674 000 ns fSetTimeLastLoop=true ) 2026-02-18 20:00:39 (17424): Guest Log: copied the webapp to /var/www 2026-02-18 20:00:39 (17424): Guest Log: ATHENA_PROC_NUMBER=4 2026-02-18 20:00:39 (17424): Guest Log: ATHENA_CORE_NUMBER=4 2026-02-18 20:00:39 (17424): Guest Log: Apptainer command /cvmfs/atlas.cern.ch/repo/containers/sw/apptainer/x86_64-el7/current/bin/apptainer exec -B /cvmfs,/data,/home/atlas/RunAtlas /cvmfs/atlas.cern.ch/repo/containers/fs/singularity/x86_64-centos7 2026-02-18 20:00:39 (17424): Guest Log: *** Starting ATLAS job. (PandaID=7011998333 taskID=48442098) *** 2026-02-18 20:00:39 (17424): Guest Log: 00:01:40.030611 timesync vgsvcTimeSyncWorker: Radical host time change: 3 603 526 000 000ns (HostNow=1 771 318 853 935 000 000 ns HostLast=1 771 315 250 409 000 000 ns) 2026-02-18 20:00:39 (17424): Guest Log: 00:01:40.030786 timesync vgsvcTimeSyncWorker: Radical guest time change: 3 603 945 459 000ns (GuestNow=1 771 315 260 409 857 000 ns GuestLast=1 771 311 656 464 398 000 ns fSetTimeLastLoop=true ) 2026-02-18 20:00:39 (17424): Guest Log: 00:01:50.031740 timesync vgsvcTimeSyncWorker: Radical host time change: 2 181 217 000 000ns (HostNow=1 771 321 035 152 000 000 ns HostLast=1 771 318 853 935 000 000 ns) 2026-02-18 20:00:39 (17424): Guest Log: 00:01:50.031813 timesync vgsvcTimeSyncWorker: Radical guest time change: 3 603 527 350 000ns (GuestNow=1 771 318 863 937 207 000 ns GuestLast=1 771 315 260 409 857 000 ns fSetTimeLastLoop=true ) 2026-02-18 20:00:39 (17424): Guest Log: 00:02:00.033218 timesync vgsvcTimeSyncWorker: Radical guest time change: 2 181 216 337 000ns (GuestNow=1 771 321 045 153 544 000 ns GuestLast=1 771 318 863 937 207 000 ns fSetTimeLastLoop=true ) 2026-02-18 20:00:39 (17424): Guest Log: 00:02:10.034005 timesync vgsvcTimeSyncWorker: Radical host time change: 3 602 762 000 000ns (HostNow=1 771 326 050 024 000 000 ns HostLast=1 771 322 447 262 000 000 ns) 2026-02-18 20:00:39 (17424): Guest Log: 00:02:20.061402 timesync vgsvcTimeSyncWorker: Radical host time change: 3 593 938 000 000ns (HostNow=1 771 329 643 962 000 000 ns HostLast=1 771 326 050 024 000 000 ns) 2026-02-18 20:00:39 (17424): Guest Log: 00:02:20.061466 timesync vgsvcTimeSyncWorker: Radical guest time change: 3 602 788 680 000ns (GuestNow=1 771 326 060 051 409 000 ns GuestLast=1 771 322 457 262 729 000 ns fSetTimeLastLoop=true ) 2026-02-18 20:00:39 (17424): Guest Log: 00:02:30.061763 timesync vgsvcTimeSyncWorker: Radical guest time change: 3 593 911 024 000ns (GuestNow=1 771 329 653 962 433 000 ns GuestLast=1 771 326 060 051 409 000 ns fSetTimeLastLoop=true ) 2026-02-18 20:00:39 (17424): Guest Log: 00:02:40.063478 timesync vgsvcTimeSyncWorker: Radical host time change: 45 658 226 000 000ns (HostNow=1 771 376 443 011 000 000 ns HostLast=1 771 330 784 785 000 000 ns) 2026-02-18 20:00:39 (17424): Guest Log: 00:02:50.072821 timesync vgsvcTimeSyncWorker: Radical host time change: 3 604 103 000 000ns (HostNow=1 771 380 047 114 000 000 ns HostLast=1 771 376 443 011 000 000 ns) 2026-02-18 20:00:39 (17424): Guest Log: 00:02:50.072918 timesync vgsvcTimeSyncWorker: Radical guest time change: 46 789 055 924 000ns (GuestNow=1 771 376 453 019 984 000 ns GuestLast=1 771 329 663 964 060 000 ns fSetTimeLastLoop=true ) 2026-02-18 20:00:39 (17424): Guest Log: 00:03:00.073632 timesync vgsvcTimeSyncWorker: Radical host time change: 3 593 520 000 000ns (HostNow=1 771 383 640 634 000 000 ns HostLast=1 771 380 047 114 000 000 ns) 2026-02-18 20:00:39 (17424): Guest Log: 00:03:00.073726 timesync vgsvcTimeSyncWorker: Radical guest time change: 3 604 094 627 000ns (GuestNow=1 771 380 057 114 611 000 ns GuestLast=1 771 376 453 019 984 000 ns fSetTimeLastLoop=true ) 2026-02-18 20:00:39 (17424): Guest Log: 00:03:10.293161 timesync vgsvcTimeSyncWorker: Radical host time change: 3 603 418 000 000ns (HostNow=1 771 387 244 052 000 000 ns HostLast=1 771 383 640 634 000 000 ns) 2026-02-18 20:00:39 (17424): Guest Log: 00:03:10.293259 timesync vgsvcTimeSyncWorker: Radical guest time change: 3 593 736 158 000ns (GuestNow=1 771 383 650 850 769 000 ns GuestLast=1 771 380 057 114 611 000 ns fSetTimeLastLoop=true ) 2026-02-18 20:00:39 (17424): Guest Log: 00:03:20.293842 timesync vgsvcTimeSyncWorker: Radical guest time change: 3 603 204 465 000ns (GuestNow=1 771 387 254 055 234 000 ns GuestLast=1 771 383 650 850 769 000 ns fSetTimeLastLoop=true ) 2026-02-18 20:00:39 (17424): Guest Log: 00:03:30.688275 timesync vgsvcTimeSyncWorker: Radical host time change: 2 793 509 000 000ns (HostNow=1 771 390 848 634 000 000 ns HostLast=1 771 388 055 125 000 000 ns) 2026-02-18 20:00:39 (17424): Guest Log: 00:03:40.693813 timesync vgsvcTimeSyncWorker: Radical host time change: 3 593 811 000 000ns (HostNow=1 771 394 442 445 000 000 ns HostLast=1 771 390 848 634 000 000 ns) 2026-02-18 20:00:39 (17424): Guest Log: 00:03:40.693905 timesync vgsvcTimeSyncWorker: Radical guest time change: 3 594 189 986 000ns (GuestNow=1 771 390 858 639 494 000 ns GuestLast=1 771 387 264 449 508 000 ns fSetTimeLastLoop=true ) 2026-02-18 20:00:39 (17424): Guest Log: 00:03:50.694299 timesync vgsvcTimeSyncWorker: Radical host time change: 3 603 603 000 000ns (HostNow=1 771 398 046 048 000 000 ns HostLast=1 771 394 442 445 000 000 ns) 2026-02-18 20:00:39 (17424): Guest Log: 00:03:50.694412 timesync vgsvcTimeSyncWorker: Radical guest time change: 3 593 805 994 000ns (GuestNow=1 771 394 452 445 488 000 ns GuestLast=1 771 390 858 639 494 000 ns fSetTimeLastLoop=true ) 2026-02-18 20:00:39 (17424): Guest Log: 00:04:00.948035 timesync vgsvcTimeSyncWorker: Radical host time change: 3 604 100 000 000ns (HostNow=1 771 401 650 148 000 000 ns HostLast=1 771 398 046 048 000 000 ns) 2026-02-18 20:00:39 (17424): Guest Log: 00:04:00.948118 timesync vgsvcTimeSyncWorker: Radical guest time change: 3 603 855 740 000ns (GuestNow=1 771 398 056 301 228 000 ns GuestLast=1 771 394 452 445 488 000 ns fSetTimeLastLoop=true ) 2026-02-18 20:00:39 (17424): Guest Log: 00:04:10.948411 timesync vgsvcTimeSyncWorker: Radical host time change: 3 593 013 000 000ns (HostNow=1 771 405 243 161 000 000 ns HostLast=1 771 401 650 148 000 000 ns) 2026-02-18 20:00:39 (17424): Guest Log: 00:04:10.948484 timesync vgsvcTimeSyncWorker: Radical guest time change: 3 603 847 673 000ns (GuestNow=1 771 401 660 148 901 000 ns GuestLast=1 771 398 056 301 228 000 ns fSetTimeLastLoop=true ) 2026-02-18 20:00:39 (17424): Guest Log: 00:04:20.949262 timesync vgsvcTimeSyncWorker: Radical guest time change: 3 593 013 041 000ns (GuestNow=1 771 405 253 161 942 000 ns GuestLast=1 771 401 660 148 901 000 ns fSetTimeLastLoop=true ) 2026-02-18 20:00:39 (17424): Guest Log: 00:04:30.949892 timesync vgsvcTimeSyncWorker: Radical host time change: 2 713 476 000 000ns (HostNow=1 771 408 846 968 000 000 ns HostLast=1 771 406 133 492 000 000 ns) 2026-02-18 20:00:39 (17424): Guest Log: 00:04:41.341827 timesync vgsvcTimeSyncWorker: Radical host time change: 3 592 737 000 000ns (HostNow=1 771 412 439 705 000 000 ns HostLast=1 771 408 846 968 000 000 ns) 2026-02-18 20:00:39 (17424): Guest Log: 00:04:41.341948 timesync vgsvcTimeSyncWorker: Radical guest time change: 3 593 806 553 000ns (GuestNow=1 771 408 856 968 726 000 ns GuestLast=1 771 405 263 162 173 000 ns fSetTimeLastLoop=true ) 2026-02-18 20:00:39 (17424): Guest Log: 00:04:51.343251 timesync vgsvcTimeSyncWorker: Radical host time change: 3 604 198 000 000ns (HostNow=1 771 416 043 903 000 000 ns HostLast=1 771 412 439 705 000 000 ns) 2026-02-18 20:00:39 (17424): Guest Log: 00:04:51.343321 timesync vgsvcTimeSyncWorker: Radical guest time change: 3 593 128 963 000ns (GuestNow=1 771 412 450 097 689 000 ns GuestLast=1 771 408 856 968 726 000 ns fSetTimeLastLoop=true ) 2026-02-18 20:00:39 (17424): Starting VM using VBoxManage interface. (boinc_ba8d52a11965eb45, slot#0) 2026-02-18 20:00:46 (17424): Successfully started VM. (PID = '18852') 2026-02-18 20:00:46 (17424): Reporting VM Process ID to BOINC. 2026-02-18 20:00:46 (17424): Guest Log: BIOS: VirtualBox 6.0.14 2026-02-18 20:00:46 (17424): Guest Log: CPUID EDX: 0x178bfbff 2026-02-18 20:00:46 (17424): Guest Log: BIOS: AHCI 0-P#0: PCHS=16383/16/63 LCHS=1024/255/63 0x0000000002800000 sectors 2026-02-18 20:00:46 (17424): VM state change detected. (old = 'poweredoff', new = 'running') 2026-02-18 20:00:46 (17424): Detected: Web Application Enabled (http://localhost:57315) 2026-02-18 20:00:47 (17424): VM state change detected. (old = 'running', new = 'paused') 2026-02-18 20:02:46 (17424): Preference change detected 2026-02-18 20:02:46 (17424): Setting CPU throttle for VM. (100%) 2026-02-18 20:02:47 (17424): Setting checkpoint interval to 900 seconds. (Higher value of (Preference: 60 seconds) or (Vbox_job.xml: 900 seconds)) 2026-02-18 20:02:47 (17424): VM state change detected. (old = 'paused', new = 'running') 2026-02-18 20:02:48 (17424): Guest Log: BIOS: Boot : bseqnr=1, bootseq=0032 2026-02-18 20:02:48 (17424): Guest Log: BIOS: Booting from Hard Disk... 2026-02-18 20:02:51 (17424): Guest Log: BIOS: KBD: unsupported int 16h function 03 2026-02-18 20:02:51 (17424): Guest Log: BIOS: AX=0305 BX=0000 CX=0000 DX=0000 2026-02-18 20:02:51 (17424): Guest Log: int13_harddisk_ext: function 41, unmapped device for ELDL=81 2026-02-18 20:02:51 (17424): Guest Log: int13_harddisk: function 02, unmapped device for ELDL=81 2026-02-18 20:02:51 (17424): Guest Log: int13_harddisk_ext: function 41, unmapped device for ELDL=82 2026-02-18 20:02:51 (17424): Guest Log: int13_harddisk: function 02, unmapped device for ELDL=82 2026-02-18 20:02:51 (17424): Guest Log: int13_harddisk_ext: function 41, unmapped device for ELDL=83 2026-02-18 20:02:51 (17424): Guest Log: int13_harddisk: function 02, unmapped device for ELDL=83 2026-02-18 20:02:51 (17424): Guest Log: int13_harddisk_ext: function 41, unmapped device for ELDL=84 2026-02-18 20:02:51 (17424): Guest Log: int13_harddisk: function 02, unmapped device for ELDL=84 2026-02-18 20:02:51 (17424): Guest Log: int13_harddisk_ext: function 41, unmapped device for ELDL=85 2026-02-18 20:02:51 (17424): Guest Log: int13_harddisk: function 02, unmapped device for ELDL=85 2026-02-18 20:02:51 (17424): Guest Log: int13_harddisk_ext: function 41, unmapped device for ELDL=86 2026-02-18 20:02:51 (17424): Guest Log: int13_harddisk: function 02, unmapped device for ELDL=86 2026-02-18 20:02:51 (17424): Guest Log: int13_harddisk_ext: function 41, unmapped device for ELDL=87 2026-02-18 20:02:51 (17424): Guest Log: int13_harddisk: function 02, unmapped device for ELDL=87 2026-02-18 20:02:51 (17424): Guest Log: int13_harddisk_ext: function 41, unmapped device for ELDL=88 2026-02-18 20:02:51 (17424): Guest Log: int13_harddisk: function 02, unmapped device for ELDL=88 2026-02-18 20:02:51 (17424): Guest Log: int13_harddisk_ext: function 41, unmapped device for ELDL=89 2026-02-18 20:02:51 (17424): Guest Log: int13_harddisk: function 02, unmapped device for ELDL=89 2026-02-18 20:02:51 (17424): Guest Log: int13_harddisk_ext: function 41, unmapped device for ELDL=8a 2026-02-18 20:02:51 (17424): Guest Log: int13_harddisk: function 02, unmapped device for ELDL=8a 2026-02-18 20:02:51 (17424): Guest Log: int13_harddisk_ext: function 41, unmapped device for ELDL=8b 2026-02-18 20:02:51 (17424): Guest Log: int13_harddisk: function 02, unmapped device for ELDL=8b 2026-02-18 20:02:51 (17424): Guest Log: int13_harddisk_ext: function 41, unmapped device for ELDL=8c 2026-02-18 20:02:51 (17424): Guest Log: int13_harddisk: function 02, unmapped device for ELDL=8c 2026-02-18 20:02:51 (17424): Guest Log: int13_harddisk_ext: function 41, unmapped device for ELDL=8d 2026-02-18 20:02:51 (17424): Guest Log: int13_harddisk: function 02, unmapped device for ELDL=8d 2026-02-18 20:02:51 (17424): Guest Log: int13_harddisk_ext: function 41, unmapped device for ELDL=8e 2026-02-18 20:02:51 (17424): Guest Log: int13_harddisk: function 02, unmapped device for ELDL=8e 2026-02-18 20:02:51 (17424): Guest Log: int13_harddisk_ext: function 41, unmapped device for ELDL=8f 2026-02-18 20:02:51 (17424): Guest Log: int13_harddisk: function 02, unmapped device for ELDL=8f 2026-02-18 20:02:57 (17424): VM state change detected. (old = 'running', new = 'paused') 2026-02-18 20:39:08 (17424): VM state change detected. (old = 'paused', new = 'running') 2026-02-18 20:39:13 (17424): Guest Log: vgdrvHeartbeatInit: Setting up heartbeat to trigger every 2000 milliseconds 2026-02-18 20:39:13 (17424): Guest Log: vboxguest: misc device minor 58, IRQ 20, I/O port d020, MMIO at 00000000f0000000 (size 0x400000) 2026-02-18 20:39:18 (17424): VM state change detected. (old = 'running', new = 'paused') 2026-02-18 21:00:40 (17424): VM state change detected. (old = 'paused', new = 'running') 2026-02-18 21:00:50 (17424): VM state change detected. (old = 'running', new = 'paused') 2026-02-18 21:02:00 (17424): VM state change detected. (old = 'paused', new = 'running') 2026-02-18 21:02:01 (17424): Guest Log: VBoxService 5.2.32 r132073 (verbosity: 0) linux.amd64 (Jul 12 2019 10:32:28) release log 2026-02-18 21:02:01 (17424): Guest Log: 00:00:00.000179 main Log opened 2026-02-18T20:01:17.445190000Z 2026-02-18 21:02:01 (17424): Guest Log: 00:00:00.000291 main OS Product: Linux 2026-02-18 21:02:01 (17424): Guest Log: 00:00:00.000342 main OS Release: 3.10.0-957.27.2.el7.x86_64 2026-02-18 21:02:01 (17424): Guest Log: 00:00:00.000416 main OS Version: #1 SMP Mon Jul 29 17:46:05 UTC 2019 2026-02-18 21:02:01 (17424): Guest Log: 00:00:00.000466 main Executable: /opt/VBoxGuestAdditions-5.2.32/sbin/VBoxService 2026-02-18 21:02:01 (17424): Guest Log: 00:00:00.000467 main Process ID: 1304 2026-02-18 21:02:01 (17424): Guest Log: 00:00:00.000468 main Package type: LINUX_64BITS_GENERIC 2026-02-18 21:02:01 (17424): Guest Log: 00:00:00.002233 main 5.2.32 r132073 started. Verbose level = 0 2026-02-18 21:02:02 (17424): Guest Log: [INFO] Probing /cvmfs/atlas.cern.ch... 2026-02-18 21:02:02 (17424): Guest Log: [INFO] Mounting shared directory 2026-02-18 21:02:02 (17424): Guest Log: [INFO] Checking for init_data.xml 2026-02-18 21:02:10 (17424): VM state change detected. (old = 'running', new = 'paused') 2026-02-18 21:23:41 (17424): VM state change detected. (old = 'paused', new = 'running') 2026-02-18 21:23:42 (17424): Guest Log: 00:00:10.007819 timesync vgsvcTimeSyncWorker: Radical guest time change: 21 653 690 913 000ns (GuestNow=1 771 466 531 140 881 000 ns GuestLast=1 771 444 877 449 968 000 ns fSetTimeLastLoop=true ) 2026-02-18 21:23:50 (17424): Guest Log: [INFO] Probing /cvmfs/atlas.cern.ch... OK 2026-02-18 21:23:50 (17424): Guest Log: [INFO] Detected branch: prod 2026-02-18 21:23:50 (17424): Guest Log: This is the prod version of the ATLAS job wrapper 2026-02-18 21:23:50 (17424): Guest Log: Copying input files 2026-02-18 21:23:51 (17424): VM state change detected. (old = 'running', new = 'paused') 2026-02-18 21:25:11 (17424): VM state change detected. (old = 'paused', new = 'running') 2026-02-18 21:25:21 (17424): VM state change detected. (old = 'running', new = 'paused') 2026-02-18 22:00:43 (17424): Guest Log: 00:00:30.021548 timesync vgsvcTimeSyncWorker: Radical host time change: 2 131 871 000 000ns (HostNow=1 771 470 043 429 000 000 ns HostLast=1 771 467 911 558 000 000 ns) 2026-02-18 22:00:43 (17424): VM state change detected. (old = 'paused', new = 'running') 2026-02-18 22:00:53 (17424): VM state change detected. (old = 'running', new = 'paused') 2026-02-18 22:39:14 (17424): Guest Log: 00:00:40.022798 timesync vgsvcTimeSyncWorker: Radical host time change: 2 310 767 000 000ns (HostNow=1 771 472 354 196 000 000 ns HostLast=1 771 470 043 429 000 000 ns) 2026-02-18 22:39:14 (17424): Guest Log: 00:00:40.022863 timesync vgsvcTimeSyncWorker: Radical guest time change: 2 211 390 363 000ns (GuestNow=1 771 470 053 430 182 000 ns GuestLast=1 771 467 842 039 819 000 ns fSetTimeLastLoop=true ) 2026-02-18 22:39:14 (17424): VM state change detected. (old = 'paused', new = 'running') 2026-02-18 22:39:19 (17424): Guest Log: Copied input files into RunAtlas. 2026-02-18 22:39:20 (17424): Guest Log: This VM did not configure a local http proxy via BOINC. 2026-02-18 22:39:20 (17424): Guest Log: Small home clusters do not require a local http proxy but it is suggested if 2026-02-18 22:39:20 (17424): Guest Log: more than 10 cores throughout the same LAN segment are regularly running ATLAS like tasks. 2026-02-18 22:39:20 (17424): Guest Log: Further information can be found at the LHC@home message board. 2026-02-18 22:39:24 (17424): VM state change detected. (old = 'running', new = 'paused') 2026-02-18 23:00:36 (17424): Guest Log: 00:00:50.024160 timesync vgsvcTimeSyncWorker: Radical guest time change: 2 310 767 194 000ns (GuestNow=1 771 472 364 197 376 000 ns GuestLast=1 771 470 053 430 182 000 ns fSetTimeLastLoop=true ) 2026-02-18 23:00:36 (17424): VM state change detected. (old = 'paused', new = 'running') 2026-02-18 23:00:46 (17424): VM state change detected. (old = 'running', new = 'paused') 2026-02-18 23:41:38 (17424): Guest Log: 00:01:00.026733 timesync vgsvcTimeSyncWorker: Radical host time change: 2 462 252 000 000ns (HostNow=1 771 476 097 973 000 000 ns HostLast=1 771 473 635 721 000 000 ns) 2026-02-18 23:41:38 (17424): VM state change detected. (old = 'paused', new = 'running') 2026-02-18 23:41:40 (17424): Guest Log: Running cvmfs_config stat atlas.cern.ch 2026-02-18 23:41:40 (17424): Guest Log: VERSION PID UPTIME(M) MEM(K) REVISION EXPIRES(M) NOCATALOGS CACHEUSE(K) CACHEMAX(K) NOFDUSE NOFDMAX NOIOERR NOOPEN HITRATE(%) RX(K) SPEED(K/S) HOST PROXY ONLINE 2026-02-18 23:41:40 (17424): Guest Log: 2.6.3.0 1587 159 30316 156394 4 1 3314618 4096001 0 65024 0 0 n/a 1336 1356 http://s1fnal-cvmfs.openhtc.io:8080/cvmfs/atlas.cern.ch DIRECT 1 2026-02-18 23:41:44 (17424): Guest Log: copied the webapp to /var/www 2026-02-18 23:41:44 (17424): Guest Log: ATHENA_PROC_NUMBER=4 2026-02-18 23:41:44 (17424): Guest Log: ATHENA_CORE_NUMBER=4 2026-02-18 23:41:44 (17424): Guest Log: Apptainer command /cvmfs/atlas.cern.ch/repo/containers/sw/apptainer/x86_64-el7/current/bin/apptainer exec -B /cvmfs,/data,/home/atlas/RunAtlas /cvmfs/atlas.cern.ch/repo/containers/fs/singularity/x86_64-centos7 2026-02-18 23:41:44 (17424): Guest Log: *** Starting ATLAS job. (PandaID=7011998333 taskID=48442098) *** 2026-02-18 23:41:48 (17424): VM state change detected. (old = 'running', new = 'paused') 2026-02-19 00:00:39 (17424): Guest Log: 00:01:10.031616 timesync vgsvcTimeSyncWorker: Radical guest time change: 2 462 254 444 000ns (GuestNow=1 771 476 107 978 001 000 ns GuestLast=1 771 473 645 723 557 000 ns fSetTimeLastLoop=true ) 2026-02-19 00:00:39 (17424): VM state change detected. (old = 'paused', new = 'running') 2026-02-19 00:00:49 (17424): VM state change detected. (old = 'running', new = 'paused') 2026-02-19 00:06:09 (17424): VM state change detected. (old = 'paused', new = 'running') 2026-02-19 00:06:19 (17424): VM state change detected. (old = 'running', new = 'paused') 2026-02-19 00:39:11 (17424): Guest Log: 00:01:30.332217 timesync vgsvcTimeSyncWorker: Radical host time change: 1 982 013 000 000ns (HostNow=1 771 479 550 640 000 000 ns HostLast=1 771 477 568 627 000 000 ns) 2026-02-19 00:39:11 (17424): VM state change detected. (old = 'paused', new = 'running') 2026-02-19 00:39:21 (17424): Guest Log: 00:01:40.332426 timesync vgsvcTimeSyncWorker: Radical guest time change: 1 981 860 022 000ns (GuestNow=1 771 479 560 640 268 000 ns GuestLast=1 771 477 578 780 246 000 ns fSetTimeLastLoop=true ) 2026-02-19 00:39:21 (17424): VM state change detected. (old = 'running', new = 'paused') 2026-02-19 01:00:42 (17424): VM state change detected. (old = 'paused', new = 'running') 2026-02-19 01:00:52 (17424): VM state change detected. (old = 'running', new = 'paused') 2026-02-19 01:02:32 (17424): VM state change detected. (old = 'paused', new = 'running') 2026-02-19 01:02:42 (17424): VM state change detected. (old = 'running', new = 'paused') 2026-02-19 01:11:52 (17424): VM state change detected. (old = 'paused', new = 'running') 2026-02-19 01:12:02 (17424): VM state change detected. (old = 'running', new = 'paused') 2026-02-19 01:56:54 (17424): VM state change detected. (old = 'paused', new = 'running') 2026-02-19 01:57:04 (17424): VM state change detected. (old = 'running', new = 'paused') 2026-02-19 02:00:34 (17424): Guest Log: 00:02:20.624191 timesync vgsvcTimeSyncWorker: Radical host time change: 2 701 947 000 000ns (HostNow=1 771 484 223 798 000 000 ns HostLast=1 771 481 521 851 000 000 ns) 2026-02-19 02:00:34 (17424): VM state change detected. (old = 'paused', new = 'running') 2026-02-19 02:00:44 (17424): Guest Log: 00:02:30.624560 timesync vgsvcTimeSyncWorker: Radical guest time change: 3 352 255 666 000ns (GuestNow=1 771 484 233 867 114 000 ns GuestLast=1 771 480 881 611 448 000 ns fSetTimeLastLoop=true ) 2026-02-19 02:00:44 (17424): VM state change detected. (old = 'running', new = 'paused') 2026-02-19 02:39:17 (17424): VM state change detected. (old = 'paused', new = 'running') 2026-02-19 02:39:27 (17424): Guest Log: 00:02:40.624932 timesync vgsvcTimeSyncWorker: Radical host time change: 2 322 199 000 000ns (HostNow=1 771 486 766 175 000 000 ns HostLast=1 771 484 443 976 000 000 ns) 2026-02-19 02:39:27 (17424): VM state change detected. (old = 'running', new = 'paused') 2026-02-19 02:51:47 (17424): VM state change detected. (old = 'paused', new = 'running') 2026-02-19 02:51:57 (17424): Guest Log: 00:02:50.626520 timesync vgsvcTimeSyncWorker: Radical guest time change: 2 532 309 248 000ns (GuestNow=1 771 486 776 176 647 000 ns GuestLast=1 771 484 243 867 399 000 ns fSetTimeLastLoop=true ) 2026-02-19 02:51:57 (17424): VM state change detected. (old = 'running', new = 'paused') 2026-02-19 03:00:37 (17424): VM state change detected. (old = 'paused', new = 'running') 2026-02-19 03:00:47 (17424): VM state change detected. (old = 'running', new = 'paused') 2026-02-19 03:01:37 (17424): VM state change detected. (old = 'paused', new = 'running') 2026-02-19 03:01:47 (17424): VM state change detected. (old = 'running', new = 'paused') 2026-02-19 03:28:09 (17424): VM state change detected. (old = 'paused', new = 'running') 2026-02-19 03:28:19 (17424): VM state change detected. (old = 'running', new = 'paused') 2026-02-19 03:41:30 (17424): VM state change detected. (old = 'paused', new = 'running') 2026-02-19 03:41:40 (17424): VM state change detected. (old = 'running', new = 'paused') 2026-02-19 04:00:41 (17424): VM state change detected. (old = 'paused', new = 'running') 2026-02-19 04:00:51 (17424): VM state change detected. (old = 'running', new = 'paused') 2026-02-19 04:33:03 (17424): VM state change detected. (old = 'paused', new = 'running') 2026-02-19 04:33:13 (17424): VM state change detected. (old = 'running', new = 'paused') 2026-02-19 04:39:13 (17424): Guest Log: 00:03:51.610460 timesync vgsvcTimeSyncWorker: Radical host time change: 2 301 770 000 000ns (HostNow=1 771 493 952 434 000 000 ns HostLast=1 771 491 650 664 000 000 ns) 2026-02-19 04:39:13 (17424): Guest Log: 00:03:51.610561 timesync vgsvcTimeSyncWorker: Radical guest time change: 1 942 378 139 000ns (GuestNow=1 771 491 661 235 875 000 ns GuestLast=1 771 489 718 857 736 000 ns fSetTimeLastLoop=true ) 2026-02-19 04:39:13 (17424): VM state change detected. (old = 'paused', new = 'running') 2026-02-19 04:39:23 (17424): VM state change detected. (old = 'running', new = 'paused') 2026-02-19 04:51:43 (17424): Guest Log: 00:04:01.662732 timesync vgsvcTimeSyncWorker: Radical guest time change: 2 301 251 568 000ns (GuestNow=1 771 493 962 487 443 000 ns GuestLast=1 771 491 661 235 875 000 ns fSetTimeLastLoop=true ) 2026-02-19 04:51:43 (17424): VM state change detected. (old = 'paused', new = 'running') 2026-02-19 04:51:53 (17424): VM state change detected. (old = 'running', new = 'paused') 2026-02-19 05:00:44 (17424): VM state change detected. (old = 'paused', new = 'running') 2026-02-19 05:00:54 (17424): VM state change detected. (old = 'running', new = 'paused') 2026-02-19 06:00:36 (17424): VM state change detected. (old = 'paused', new = 'running') 2026-02-19 06:00:45 (17424): Guest Log: 00:04:31.714695 timesync vgsvcTimeSyncWorker: Radical host time change: 3 592 765 000 000ns (HostNow=1 771 498 845 772 000 000 ns HostLast=1 771 495 253 007 000 000 ns) 2026-02-19 06:00:46 (17424): VM state change detected. (old = 'running', new = 'paused') 2026-02-19 06:08:37 (17424): VM state change detected. (old = 'paused', new = 'running') 2026-02-19 06:08:46 (17424): Guest Log: 00:04:41.715471 timesync vgsvcTimeSyncWorker: Radical guest time change: 3 592 763 888 000ns (GuestNow=1 771 498 855 772 568 000 ns GuestLast=1 771 495 263 008 680 000 ns fSetTimeLastLoop=true ) 2026-02-19 06:08:47 (17424): VM state change detected. (old = 'running', new = 'paused') 2026-02-19 06:39:09 (17424): VM state change detected. (old = 'paused', new = 'running') 2026-02-19 06:39:18 (17424): Guest Log: 00:04:51.715827 timesync vgsvcTimeSyncWorker: Radical host time change: 1 832 083 000 000ns (HostNow=1 771 501 158 035 000 000 ns HostLast=1 771 499 325 952 000 000 ns) 2026-02-19 06:39:19 (17424): VM state change detected. (old = 'running', new = 'paused') 2026-02-19 07:00:39 (17424): VM state change detected. (old = 'paused', new = 'running') 2026-02-19 07:00:48 (17424): Guest Log: 00:05:01.716719 timesync vgsvcTimeSyncWorker: Radical guest time change: 2 302 262 414 000ns (GuestNow=1 771 501 168 035 582 000 ns GuestLast=1 771 498 865 773 168 000 ns fSetTimeLastLoop=true ) 2026-02-19 07:00:49 (17424): VM state change detected. (old = 'running', new = 'paused') 2026-02-19 20:00:40 (17424): VM state change detected. (old = 'paused', new = 'running') 2026-02-19 20:00:50 (17424): VM state change detected. (old = 'running', new = 'paused') 2026-02-19 20:39:22 (17424): Guest Log: 00:05:11.717412 timesync vgsvcTimeSyncWorker: Radical host time change: 49 113 244 000 000ns (HostNow=1 771 551 561 963 000 000 ns HostLast=1 771 502 448 719 000 000 ns) 2026-02-19 20:39:22 (17424): VM state change detected. (old = 'paused', new = 'running') 2026-02-19 20:39:32 (17424): VM state change detected. (old = 'running', new = 'paused') 2026-02-19 20:51:33 (17424): Guest Log: 00:05:21.717933 timesync vgsvcTimeSyncWorker: Radical guest time change: 49 113 244 015 000ns (GuestNow=1 771 551 571 963 652 000 ns GuestLast=1 771 502 458 719 637 000 ns fSetTimeLastLoop=true ) 2026-02-19 20:51:33 (17424): VM state change detected. (old = 'paused', new = 'running') 2026-02-19 20:51:43 (17424): VM state change detected. (old = 'running', new = 'paused') 2026-02-19 21:00:43 (17424): VM state change detected. (old = 'paused', new = 'running') 2026-02-19 21:00:53 (17424): VM state change detected. (old = 'running', new = 'paused') 2026-02-19 22:00:36 (17424): Guest Log: 00:05:42.416802 timesync vgsvcTimeSyncWorker: Radical host time change: 3 593 315 000 000ns (HostNow=1 771 556 435 996 000 000 ns HostLast=1 771 552 842 681 000 000 ns) 2026-02-19 22:00:36 (17424): VM state change detected. (old = 'paused', new = 'running') 2026-02-19 22:00:46 (17424): VM state change detected. (old = 'running', new = 'paused') 2026-02-19 22:39:38 (17424): Guest Log: 00:05:52.469752 timesync vgsvcTimeSyncWorker: Radical host time change: 2 341 928 000 000ns (HostNow=1 771 558 777 924 000 000 ns HostLast=1 771 556 435 996 000 000 ns) 2026-02-19 22:39:38 (17424): Guest Log: 00:05:52.469837 timesync vgsvcTimeSyncWorker: Radical guest time change: 3 593 315 179 000ns (GuestNow=1 771 556 446 049 027 000 ns GuestLast=1 771 552 852 733 848 000 ns fSetTimeLastLoop=true ) 2026-02-19 22:39:38 (17424): VM state change detected. (old = 'paused', new = 'running') 2026-02-19 22:39:48 (17424): Guest Log: 00:06:02.470159 timesync vgsvcTimeSyncWorker: Radical guest time change: 2 341 875 618 000ns (GuestNow=1 771 558 787 924 645 000 ns GuestLast=1 771 556 446 049 027 000 ns fSetTimeLastLoop=true ) 2026-02-19 22:39:48 (17424): VM state change detected. (old = 'running', new = 'paused') 2026-02-19 22:43:48 (17424): VM state change detected. (old = 'paused', new = 'running') 2026-02-19 22:43:58 (17424): VM state change detected. (old = 'running', new = 'paused') 2026-02-19 23:00:39 (17424): VM state change detected. (old = 'paused', new = 'running') 2026-02-19 23:00:49 (17424): VM state change detected. (old = 'running', new = 'paused') 2026-02-19 23:27:10 (17424): VM state change detected. (old = 'paused', new = 'running') 2026-02-19 23:27:20 (17424): VM state change detected. (old = 'running', new = 'paused') 2026-02-19 23:37:31 (17424): VM state change detected. (old = 'paused', new = 'running') 2026-02-19 23:37:41 (17424): VM state change detected. (old = 'running', new = 'paused') 2026-02-20 00:00:43 (17424): VM state change detected. (old = 'paused', new = 'running') 2026-02-20 00:00:53 (17424): VM state change detected. (old = 'running', new = 'paused') 2026-02-20 00:39:34 (17424): VM state change detected. (old = 'paused', new = 'running') 2026-02-20 00:39:42 (17424): Guest Log: 00:07:02.477364 timesync vgsvcTimeSyncWorker: Radical host time change: 2 330 653 000 000ns (HostNow=1 771 565 982 528 000 000 ns HostLast=1 771 563 651 875 000 000 ns) 2026-02-20 00:39:42 (17424): Guest Log: 00:07:02.477432 timesync vgsvcTimeSyncWorker: Radical guest time change: 2 002 166 137 000ns (GuestNow=1 771 563 661 876 920 000 ns GuestLast=1 771 561 659 710 783 000 ns fSetTimeLastLoop=true ) 2026-02-20 00:39:44 (17424): VM state change detected. (old = 'running', new = 'paused') 2026-02-20 01:00:46 (17424): VM state change detected. (old = 'paused', new = 'running') 2026-02-20 01:00:54 (17424): Guest Log: 00:07:12.478451 timesync vgsvcTimeSyncWorker: Radical guest time change: 2 330 652 183 000ns (GuestNow=1 771 565 992 529 103 000 ns GuestLast=1 771 563 661 876 920 000 ns fSetTimeLastLoop=true ) 2026-02-20 01:00:56 (17424): VM state change detected. (old = 'running', new = 'paused') 2026-02-20 01:15:16 (17424): VM state change detected. (old = 'paused', new = 'running') 2026-02-20 01:15:26 (17424): VM state change detected. (old = 'running', new = 'paused') 2026-02-20 01:16:47 (17424): VM state change detected. (old = 'paused', new = 'running') 2026-02-20 01:16:57 (17424): VM state change detected. (old = 'running', new = 'paused') 2026-02-20 02:00:38 (17424): VM state change detected. (old = 'paused', new = 'running') 2026-02-20 02:00:46 (17424): Guest Log: 00:07:42.483057 timesync vgsvcTimeSyncWorker: Radical host time change: 2 631 511 000 000ns (HostNow=1 771 570 846 307 000 000 ns HostLast=1 771 568 214 796 000 000 ns) 2026-02-20 02:00:48 (17424): VM state change detected. (old = 'running', new = 'paused') 2026-02-20 02:39:31 (17424): VM state change detected. (old = 'paused', new = 'running') 2026-02-20 02:39:39 (17424): Guest Log: 00:07:52.485093 timesync vgsvcTimeSyncWorker: Radical host time change: 2 332 475 000 000ns (HostNow=1 771 573 178 782 000 000 ns HostLast=1 771 570 846 307 000 000 ns) 2026-02-20 02:39:39 (17424): Guest Log: 00:07:52.485179 timesync vgsvcTimeSyncWorker: Radical guest time change: 3 571 943 407 000ns (GuestNow=1 771 570 856 308 979 000 ns GuestLast=1 771 567 284 365 572 000 ns fSetTimeLastLoop=true ) 2026-02-20 02:39:41 (17424): VM state change detected. (old = 'running', new = 'paused') 2026-02-20 03:00:42 (17424): VM state change detected. (old = 'paused', new = 'running') 2026-02-20 03:00:50 (17424): Guest Log: 00:08:02.490709 timesync vgsvcTimeSyncWorker: Radical guest time change: 2 332 478 641 000ns (GuestNow=1 771 573 188 787 620 000 ns GuestLast=1 771 570 856 308 979 000 ns fSetTimeLastLoop=true ) 2026-02-20 03:00:52 (17424): VM state change detected. (old = 'running', new = 'paused') 2026-02-20 03:04:02 (17424): VM state change detected. (old = 'paused', new = 'running') 2026-02-20 03:04:12 (17424): VM state change detected. (old = 'running', new = 'paused') 2026-02-20 03:06:32 (17424): VM state change detected. (old = 'paused', new = 'running') 2026-02-20 03:06:42 (17424): VM state change detected. (old = 'running', new = 'paused') 2026-02-20 03:25:33 (17424): VM state change detected. (old = 'paused', new = 'running') 2026-02-20 03:25:43 (17424): VM state change detected. (old = 'running', new = 'paused') 2026-02-20 03:58:25 (17424): VM state change detected. (old = 'paused', new = 'running') 2026-02-20 03:58:33 (17424): Guest Log: 00:08:42.505316 timesync vgsvcTimeSyncWorker: Radical host time change: 1 972 215 000 000ns (HostNow=1 771 577 913 008 000 000 ns HostLast=1 771 575 940 793 000 000 ns) 2026-02-20 03:58:34 (17424): VM state change detected. (old = 'running', new = 'paused') 2026-02-20 04:00:45 (17424): VM state change detected. (old = 'paused', new = 'running') 2026-02-20 04:00:54 (17424): Guest Log: 00:08:52.508360 timesync vgsvcTimeSyncWorker: Radical guest time change: 1 972 214 939 000ns (GuestNow=1 771 577 923 011 127 000 ns GuestLast=1 771 575 950 796 188 000 ns fSetTimeLastLoop=true ) 2026-02-20 04:00:55 (17424): VM state change detected. (old = 'running', new = 'paused') 2026-02-20 04:39:37 (17424): VM state change detected. (old = 'paused', new = 'running') 2026-02-20 04:39:46 (17424): Guest Log: 00:09:02.514551 timesync vgsvcTimeSyncWorker: Radical host time change: 2 331 398 000 000ns (HostNow=1 771 580 385 447 000 000 ns HostLast=1 771 578 054 049 000 000 ns) 2026-02-20 04:39:47 (17424): VM state change detected. (old = 'running', new = 'paused') 2026-02-20 04:50:47 (17424): VM state change detected. (old = 'paused', new = 'running') 2026-02-20 04:50:56 (17424): Guest Log: 00:09:12.517084 timesync vgsvcTimeSyncWorker: Radical guest time change: 2 462 433 569 000ns (GuestNow=1 771 580 395 450 242 000 ns GuestLast=1 771 577 933 016 673 000 ns fSetTimeLastLoop=true ) 2026-02-20 04:50:57 (17424): VM state change detected. (old = 'running', new = 'paused') 2026-02-20 05:00:38 (17424): VM state change detected. (old = 'paused', new = 'running') 2026-02-20 05:00:48 (17424): VM state change detected. (old = 'running', new = 'paused') 2026-02-20 06:00:41 (17424): VM state change detected. (old = 'paused', new = 'running') 2026-02-20 06:00:50 (17424): Guest Log: 00:09:32.525368 timesync vgsvcTimeSyncWorker: Radical host time change: 3 603 305 000 000ns (HostNow=1 771 585 249 514 000 000 ns HostLast=1 771 581 646 209 000 000 ns) 2026-02-20 06:00:51 (17424): VM state change detected. (old = 'running', new = 'paused') 2026-02-20 06:18:12 (17424): VM state change detected. (old = 'paused', new = 'running') 2026-02-20 06:18:21 (17424): Guest Log: 00:09:42.526747 timesync vgsvcTimeSyncWorker: Radical guest time change: 3 603 302 195 000ns (GuestNow=1 771 585 259 515 503 000 ns GuestLast=1 771 581 656 213 308 000 ns fSetTimeLastLoop=true ) 2026-02-20 06:18:22 (17424): VM state change detected. (old = 'running', new = 'paused') 2026-02-20 06:39:34 (17424): VM state change detected. (old = 'paused', new = 'running') 2026-02-20 06:39:44 (17424): VM state change detected. (old = 'running', new = 'paused') 2026-02-20 07:00:44 (17424): VM state change detected. (old = 'paused', new = 'running') 2026-02-20 07:00:52 (17424): Guest Log: 00:10:02.533383 timesync vgsvcTimeSyncWorker: Radical guest time change: 2 322 539 900 000ns (GuestNow=1 771 587 592 058 864 000 ns GuestLast=1 771 585 269 518 964 000 ns fSetTimeLastLoop=true ) 2026-02-20 07:00:54 (17424): VM state change detected. (old = 'running', new = 'paused') 2026-02-20 07:45:47 (17424): VM state change detected. (old = 'paused', new = 'running') 2026-02-20 07:45:55 (17424): Guest Log: 00:10:12.534329 timesync vgsvcTimeSyncWorker: Radical host time change: 2 702 684 000 000ns (HostNow=1 771 591 555 371 000 000 ns HostLast=1 771 588 852 687 000 000 ns) 2026-02-20 07:45:57 (17424): VM state change detected. (old = 'running', new = 'paused') 2026-02-20 20:00:46 (17424): VM state change detected. (old = 'paused', new = 'running') 2026-02-20 20:00:55 (17424): Guest Log: 00:10:22.536322 timesync vgsvcTimeSyncWorker: Radical host time change: 44 099 706 000 000ns (HostNow=1 771 635 655 077 000 000 ns HostLast=1 771 591 555 371 000 000 ns) 2026-02-20 20:00:55 (17424): Guest Log: 00:10:22.536412 timesync vgsvcTimeSyncWorker: Radical guest time change: 2 702 684 446 000ns (GuestNow=1 771 591 565 372 597 000 ns GuestLast=1 771 588 862 688 151 000 ns fSetTimeLastLoop=true ) 2026-02-20 20:00:56 (17424): VM state change detected. (old = 'running', new = 'paused') 2026-02-20 20:39:48 (17424): VM state change detected. (old = 'paused', new = 'running') 2026-02-20 20:39:57 (17424): Guest Log: 00:10:32.536963 timesync vgsvcTimeSyncWorker: Radical host time change: 2 341 415 000 000ns (HostNow=1 771 637 996 492 000 000 ns HostLast=1 771 635 655 077 000 000 ns) 2026-02-20 20:39:57 (17424): Guest Log: 00:10:32.537027 timesync vgsvcTimeSyncWorker: Radical guest time change: 44 099 705 187 000ns (GuestNow=1 771 635 665 077 784 000 ns GuestLast=1 771 591 565 372 597 000 ns fSetTimeLastLoop=true ) 2026-02-20 20:39:58 (17424): VM state change detected. (old = 'running', new = 'paused') 2026-02-20 20:49:18 (17424): VM state change detected. (old = 'paused', new = 'running') 2026-02-20 20:49:27 (17424): Guest Log: 00:10:42.537187 timesync vgsvcTimeSyncWorker: Radical guest time change: 2 341 414 523 000ns (GuestNow=1 771 638 006 492 307 000 ns GuestLast=1 771 635 665 077 784 000 ns fSetTimeLastLoop=true ) 2026-02-20 20:49:28 (17424): VM state change detected. (old = 'running', new = 'paused') 2026-02-20 20:58:49 (17424): VM state change detected. (old = 'paused', new = 'running') 2026-02-20 20:58:59 (17424): VM state change detected. (old = 'running', new = 'paused') 2026-02-20 21:00:50 (17424): VM state change detected. (old = 'paused', new = 'running') 2026-02-20 21:00:59 (17424): VM state change detected. (old = 'running', new = 'paused') 2026-02-20 21:44:21 (17424): VM state change detected. (old = 'paused', new = 'running') 2026-02-20 21:44:30 (17424): Guest Log: 00:11:12.542545 timesync vgsvcTimeSyncWorker: Radical host time change: 2 611 730 000 000ns (HostNow=1 771 641 869 723 000 000 ns HostLast=1 771 639 257 993 000 000 ns) 2026-02-20 21:44:31 (17424): VM state change detected. (old = 'running', new = 'paused') 2026-02-20 22:00:43 (17424): VM state change detected. (old = 'paused', new = 'running') 2026-02-20 22:00:52 (17424): Guest Log: 00:11:22.545287 timesync vgsvcTimeSyncWorker: Radical guest time change: 2 611 730 018 000ns (GuestNow=1 771 641 879 725 573 000 ns GuestLast=1 771 639 267 995 555 000 ns fSetTimeLastLoop=true ) 2026-02-20 22:00:53 (17424): VM state change detected. (old = 'running', new = 'paused') 2026-02-20 22:39:55 (17424): VM state change detected. (old = 'paused', new = 'running') 2026-02-20 22:40:03 (17424): Guest Log: 00:11:32.546361 timesync vgsvcTimeSyncWorker: Radical host time change: 2 351 467 000 000ns (HostNow=1 771 645 202 723 000 000 ns HostLast=1 771 642 851 256 000 000 ns) 2026-02-20 22:40:05 (17424): VM state change detected. (old = 'running', new = 'paused') 2026-02-20 23:00:45 (17424): VM state change detected. (old = 'paused', new = 'running') 2026-02-20 23:00:53 (17424): Guest Log: 00:11:42.550485 timesync vgsvcTimeSyncWorker: Radical guest time change: 3 323 000 271 000ns (GuestNow=1 771 645 212 727 081 000 ns GuestLast=1 771 641 889 726 810 000 ns fSetTimeLastLoop=true ) 2026-02-20 23:00:55 (17424): VM state change detected. (old = 'running', new = 'paused') 2026-02-21 00:00:39 (17424): VM state change detected. (old = 'paused', new = 'running') 2026-02-21 00:00:47 (17424): Guest Log: 00:11:52.555280 timesync vgsvcTimeSyncWorker: Radical host time change: 3 593 575 000 000ns (HostNow=1 771 650 046 643 000 000 ns HostLast=1 771 646 453 068 000 000 ns) 2026-02-21 00:00:49 (17424): VM state change detected. (old = 'running', new = 'paused') 2026-02-21 00:04:19 (17424): VM state change detected. (old = 'paused', new = 'running') 2026-02-21 00:04:27 (17424): Guest Log: 00:12:02.557040 timesync vgsvcTimeSyncWorker: Radical guest time change: 3 593 572 563 000ns (GuestNow=1 771 650 056 644 968 000 ns GuestLast=1 771 646 463 072 405 000 ns fSetTimeLastLoop=true ) 2026-02-21 00:04:29 (17424): VM state change detected. (old = 'running', new = 'paused') 2026-02-21 00:39:50 (17424): VM state change detected. (old = 'paused', new = 'running') 2026-02-21 00:39:58 (17424): Guest Log: 00:12:12.557592 timesync vgsvcTimeSyncWorker: Radical host time change: 2 131 828 000 000ns (HostNow=1 771 652 398 638 000 000 ns HostLast=1 771 650 266 810 000 000 ns) 2026-02-21 00:40:01 (17424): VM state change detected. (old = 'running', new = 'paused') 2026-02-21 01:00:42 (17424): VM state change detected. (old = 'paused', new = 'running') 2026-02-21 01:00:49 (17424): Guest Log: 00:12:22.557815 timesync vgsvcTimeSyncWorker: Radical guest time change: 2 341 992 709 000ns (GuestNow=1 771 652 408 638 196 000 ns GuestLast=1 771 650 066 645 487 000 ns fSetTimeLastLoop=true ) 2026-02-21 01:00:52 (17424): VM state change detected. (old = 'running', new = 'paused') 2026-02-21 01:05:22 (17424): VM state change detected. (old = 'paused', new = 'running') 2026-02-21 01:05:32 (17424): VM state change detected. (old = 'running', new = 'paused') 2026-02-21 02:00:45 (17424): VM state change detected. (old = 'paused', new = 'running') 2026-02-21 02:00:52 (17424): Guest Log: 00:12:42.558976 timesync vgsvcTimeSyncWorker: Radical host time change: 3 323 070 000 000ns (HostNow=1 771 657 252 510 000 000 ns HostLast=1 771 653 929 440 000 000 ns) 2026-02-21 02:00:55 (17424): VM state change detected. (old = 'running', new = 'paused') 2026-02-21 02:04:56 (17424): VM state change detected. (old = 'paused', new = 'running') 2026-02-21 02:05:03 (17424): Guest Log: 00:12:52.559789 timesync vgsvcTimeSyncWorker: Radical guest time change: 3 593 093 781 000ns (GuestNow=1 771 657 262 510 919 000 ns GuestLast=1 771 653 669 417 138 000 ns fSetTimeLastLoop=true ) 2026-02-21 02:05:06 (17424): VM state change detected. (old = 'running', new = 'paused') 2026-02-21 02:39:57 (17424): VM state change detected. (old = 'paused', new = 'running') 2026-02-21 02:40:04 (17424): Guest Log: 00:13:02.560136 timesync vgsvcTimeSyncWorker: Radical host time change: 2 101 228 000 000ns (HostNow=1 771 659 603 853 000 000 ns HostLast=1 771 657 502 625 000 000 ns) 2026-02-21 02:40:07 (17424): VM state change detected. (old = 'running', new = 'paused') 2026-02-21 03:00:48 (17424): VM state change detected. (old = 'paused', new = 'running') 2026-02-21 03:00:55 (17424): Guest Log: 00:13:12.561436 timesync vgsvcTimeSyncWorker: Radical guest time change: 2 341 343 201 000ns (GuestNow=1 771 659 613 854 316 000 ns GuestLast=1 771 657 272 511 115 000 ns fSetTimeLastLoop=true ) 2026-02-21 03:00:58 (17424): VM state change detected. (old = 'running', new = 'paused') 2026-02-21 03:03:58 (17424): VM state change detected. (old = 'paused', new = 'running') 2026-02-21 03:04:08 (17424): VM state change detected. (old = 'running', new = 'paused') 2026-02-21 03:36:10 (17424): VM state change detected. (old = 'paused', new = 'running') 2026-02-21 03:36:17 (17424): Guest Log: 00:13:32.599960 timesync vgsvcTimeSyncWorker: Radical host time change: 1 932 056 000 000ns (HostNow=1 771 662 976 992 000 000 ns HostLast=1 771 661 044 936 000 000 ns) 2026-02-21 03:36:20 (17424): VM state change detected. (old = 'running', new = 'paused') 2026-02-21 04:00:41 (17424): VM state change detected. (old = 'paused', new = 'running') 2026-02-21 04:00:48 (17424): Guest Log: 00:13:42.667075 timesync vgsvcTimeSyncWorker: Radical guest time change: 2 112 327 351 000ns (GuestNow=1 771 662 987 060 011 000 ns GuestLast=1 771 660 874 732 660 000 ns fSetTimeLastLoop=true ) 2026-02-21 04:00:51 (17424): VM state change detected. (old = 'running', new = 'paused') 2026-02-21 04:39:54 (17424): VM state change detected. (old = 'paused', new = 'running') 2026-02-21 04:39:59 (17424): Guest Log: *** Job finished *** 2026-02-21 04:39:59 (17424): Guest Log: *** The last 20 lines of the pilot log: *** 2026-02-21 04:39:59 (17424): Guest Log: 2026-02-21 08:01:14,596 | INFO | waiting for thread to finish: ['<_MainThread(MainThread, started 140134231885632)>', '<ExcThread(cgroup_monitor, started 140133416290048)>'] 2026-02-21 04:39:59 (17424): Guest Log: 2026-02-21 08:36:18,989 | INFO | waiting for thread to finish: ['<_MainThread(MainThread, started 140134231885632)>', '<ExcThread(cgroup_monitor, started 140133416290048)>'] 2026-02-21 04:39:59 (17424): Guest Log: 2026-02-21 08:36:21,160 | INFO | waiting for thread to finish: ['<_MainThread(MainThread, started 140134231885632)>', '<ExcThread(cgroup_monitor, started 140133416290048)>'] 2026-02-21 04:39:59 (17424): Guest Log: 2026-02-21 08:36:23,296 | INFO | waiting for thread to finish: ['<_MainThread(MainThread, started 140134231885632)>', '<ExcThread(cgroup_monitor, started 140133416290048)>'] 2026-02-21 04:39:59 (17424): Guest Log: 2026-02-21 08:36:25,219 | INFO | [monitor] cgroup control has ended 2026-02-21 04:39:59 (17424): Guest Log: 2026-02-21 08:36:25,398 | INFO | caller=run is remaining thread - safe to abort (names=['<_MainThread(MainThread, started 140134231885632)>']) 2026-02-21 04:39:59 (17424): Guest Log: 2026-02-21 09:00:51,264 | INFO | all workflow threads have been joined 2026-02-21 04:39:59 (17424): Guest Log: 2026-02-21 09:00:51,264 | INFO | end of generic workflow (traces error code: 0) 2026-02-21 04:39:59 (17424): Guest Log: 2026-02-21 09:00:51,264 | INFO | traces error code: 0 2026-02-21 04:39:59 (17424): Guest Log: 2026-02-21 09:00:51,265 | INFO | pilot has finished (exit code=0, shell exit code=0) 2026-02-21 04:39:59 (17424): Guest Log: 2026-02-21 09:00:53,144 [wrapper] ==== pilot stdout END ==== 2026-02-21 04:39:59 (17424): Guest Log: 2026-02-21 09:00:53,149 [wrapper] ==== wrapper stdout RESUME ==== 2026-02-21 04:39:59 (17424): Guest Log: 2026-02-21 09:00:53,156 [wrapper] pilotpid: 6078 2026-02-21 04:39:59 (17424): Guest Log: 2026-02-21 09:00:53,162 [wrapper] Pilot exit status: 0 2026-02-21 04:39:59 (17424): Guest Log: 2026-02-21 09:00:53,298 [wrapper] pandaids: 7011998333 2026-02-21 04:39:59 (17424): Guest Log: 2026-02-21 09:00:53,346 [wrapper] cleanup supervisor_pilot 6084 6079 2026-02-21 04:39:59 (17424): Guest Log: 2026-02-21 09:00:53,351 [wrapper] Test setup, not cleaning 2026-02-21 04:39:59 (17424): Guest Log: 2026-02-21 09:00:53,358 [wrapper] apfmon messages muted 2026-02-21 04:39:59 (17424): Guest Log: 2026-02-21 09:00:53,364 [wrapper] ==== wrapper stdout END ==== 2026-02-21 04:39:59 (17424): Guest Log: 2026-02-21 09:00:53,370 [wrapper] ==== wrapper stderr END ==== 2026-02-21 04:39:59 (17424): Guest Log: *** Error codes and diagnostics *** 2026-02-21 04:39:59 (17424): Guest Log: "exeErrorCode": 0, 2026-02-21 04:39:59 (17424): Guest Log: "exeErrorDiag": "", 2026-02-21 04:39:59 (17424): Guest Log: "pilotErrorCode": 1150, 2026-02-21 04:39:59 (17424): Guest Log: "pilotErrorDiag": "Looping job killed by pilot", 2026-02-21 04:39:59 (17424): Guest Log: *** Listing of results directory *** 2026-02-21 04:39:59 (17424): Guest Log: total 4576 2026-02-21 04:39:59 (17424): Guest Log: -rw-r--r--. 1 atlas atlas 584627 Feb 16 02:08 pilot3.tar.gz 2026-02-21 04:39:59 (17424): Guest Log: -rwx------. 1 atlas atlas 36322 Feb 16 02:12 runpilot2-wrapper.sh 2026-02-21 04:39:59 (17424): Guest Log: -rw-r--r--. 1 atlas atlas 5111 Feb 16 02:15 queuedata.json 2026-02-21 04:39:59 (17424): Guest Log: -rwxr-xr-x. 1 atlas atlas 8615 Feb 19 03:00 init_data.xml 2026-02-21 04:39:59 (17424): Guest Log: -rwxr-xr-x. 1 atlas atlas 597953 Feb 19 03:00 input.tar.gz 2026-02-21 04:39:59 (17424): Guest Log: -rwxr-xr-x. 1 atlas atlas 15845 Feb 19 03:00 start_atlas.sh 2026-02-21 04:39:59 (17424): Guest Log: lrwxrwxrwx. 1 atlas atlas 20 Feb 19 03:39 EVNT.48442096._000204.pool.root.1 -> /data/./ATLAS.root_0 2026-02-21 04:39:59 (17424): Guest Log: -rw-r--r--. 1 atlas atlas 2531 Feb 19 04:41 pandaJob.out 2026-02-21 04:39:59 (17424): Guest Log: -rw-------. 1 atlas atlas 426 Feb 19 06:57 workernode_map.json 2026-02-21 04:39:59 (17424): Guest Log: -rw-------. 1 atlas atlas 1001042 Feb 19 07:39 agis_schedconf.cvmfs.json 2026-02-21 04:39:59 (17424): Guest Log: drwx------. 5 atlas atlas 4096 Feb 19 07:39 pilot3 2026-02-21 04:39:59 (17424): Guest Log: -rw-------. 1 atlas atlas 1025 Feb 21 06:00 memory_monitor_summary.json 2026-02-21 04:39:59 (17424): Guest Log: -rw-------. 1 atlas atlas 164421 Feb 21 06:00 log.48442098._011067.job.log.tgz.1 2026-02-21 04:39:59 (17424): Guest Log: -rw-------. 1 atlas atlas 1513015 Feb 21 06:00 agis_ddmendpoints.agis.ALL.json 2026-02-21 04:39:59 (17424): Guest Log: -rw-------. 1 atlas atlas 3221 Feb 21 07:00 heartbeat.json 2026-02-21 04:39:59 (17424): Guest Log: -rw-------. 1 atlas atlas 115 Feb 21 07:40 pilot_heartbeat.json 2026-02-21 04:39:59 (17424): Guest Log: -rw-------. 1 atlas atlas 6554 Feb 21 09:00 pilotlog.txt 2026-02-21 04:39:59 (17424): Guest Log: -rw-------. 1 atlas atlas 253891 Feb 21 09:00 log.48442098._011067.job.log.1 2026-02-21 04:39:59 (17424): Guest Log: -rw-------. 1 atlas atlas 188 Feb 21 09:00 output.list 2026-02-21 04:39:59 (17424): Guest Log: -rw-r--r--. 1 atlas atlas 620 Feb 21 09:00 runtime_log 2026-02-21 04:39:59 (17424): Guest Log: -rw-------. 1 atlas atlas 430080 Feb 21 09:00 result.tar.gz 2026-02-21 04:39:59 (17424): Guest Log: -rw-r--r--. 1 atlas atlas 8610 Feb 21 09:00 runtime_log.err 2026-02-21 04:39:59 (17424): Guest Log: -rw-------. 1 atlas atlas 649 Feb 21 09:00 3hGKDmNH3B9n9Rq4apOajLDm4fhM0noT9bVooX4SDmHHqKDmZhXOsm.diag 2026-02-21 04:39:59 (17424): Guest Log: Looking for outputfile HITS.48442098._011067.pool.root.1 2026-02-21 04:39:59 (17424): Guest Log: No HITS file was produced 2026-02-21 04:39:59 (17424): Guest Log: Successfully finished the ATLAS job! 2026-02-21 04:39:59 (17424): Guest Log: Copying the results back to the shared directory! 2026-02-21 04:39:59 (17424): Guest Log: *** Contents of shared directory: *** 2026-02-21 04:39:59 (17424): Guest Log: total 482324 2026-02-21 04:39:59 (17424): Guest Log: -rwxrwxrwx. 1 root root 492841504 Feb 16 10:00 ATLAS.root_0 2026-02-21 04:39:59 (17424): Guest Log: -rwxrwxrwx. 1 root root 8615 Feb 16 10:00 init_data.xml 2026-02-21 04:39:59 (17424): Guest Log: -rwxrwxrwx. 1 root root 597953 Feb 16 09:01 input.tar.gz 2026-02-21 04:39:59 (17424): Guest Log: -rwxrwxrwx. 1 root root 430080 Feb 21 2026 result.tar.gz 2026-02-21 04:39:59 (17424): Guest Log: -rwxrwxrwx. 1 root root 15845 Feb 16 09:01 start_atlas.sh 2026-02-21 04:39:59 (17424): Guest Log: *** Success! Shutting down the machine. *** 2026-02-21 04:39:59 (17424): VM Completion File Detected. 2026-02-21 04:39:59 (17424): Powering off VM. 2026-02-21 04:40:00 (17424): Successfully stopped VM. 2026-02-21 04:40:00 (17424): Deregistering VM. (boinc_ba8d52a11965eb45, slot#0) 2026-02-21 04:40:00 (17424): Removing network bandwidth throttle group from VM. 2026-02-21 04:40:00 (17424): Removing VM from VirtualBox. 2026-02-21 04:40:06 (17424): called boinc_finish(0) </stderr_txt> ]]>
©2026 CERN