Stderr output

<core_client_version>8.0.2</core_client_version>
<![CDATA[
<stderr_txt>
cted. (old = 'paused', new = 'running')
2025-04-15 22:59:34 (6240): VM state change detected. (old = 'running', new = 'paused')
2025-04-15 22:59:54 (6240): VM state change detected. (old = 'paused', new = 'running')
2025-04-15 23:00:14 (6240): VM state change detected. (old = 'running', new = 'paused')
2025-04-15 23:00:34 (6240): VM state change detected. (old = 'paused', new = 'running')
2025-04-15 23:00:44 (6240): VM state change detected. (old = 'running', new = 'paused')
2025-04-15 23:01:04 (6240): VM state change detected. (old = 'paused', new = 'running')
2025-04-15 23:01:34 (6240): VM state change detected. (old = 'running', new = 'paused')
2025-04-15 23:01:54 (6240): VM state change detected. (old = 'paused', new = 'running')
2025-04-15 23:02:27 (6240): Status Report: Elapsed Time: '126052.000000'
2025-04-15 23:02:27 (6240): Status Report: CPU Time: '290222.546875'
2025-04-15 23:04:04 (6240): VM state change detected. (old = 'running', new = 'paused')
2025-04-15 23:04:24 (6240): VM state change detected. (old = 'paused', new = 'running')
2025-04-15 23:04:34 (6240): VM state change detected. (old = 'running', new = 'paused')
2025-04-15 23:04:55 (6240): VM state change detected. (old = 'paused', new = 'running')
2025-04-15 23:06:04 (6240): VM state change detected. (old = 'running', new = 'paused')
2025-04-15 23:06:24 (6240): VM state change detected. (old = 'paused', new = 'running')
2025-04-15 23:12:05 (6240): VM state change detected. (old = 'running', new = 'paused')
2025-04-15 23:12:25 (6240): VM state change detected. (old = 'paused', new = 'running')
2025-04-15 23:21:16 (6240): VM state change detected. (old = 'running', new = 'paused')
2025-04-15 23:21:36 (6240): VM state change detected. (old = 'paused', new = 'running')
2025-04-15 23:22:36 (6240): VM state change detected. (old = 'running', new = 'paused')
2025-04-15 23:22:56 (6240): VM state change detected. (old = 'paused', new = 'running')
2025-04-15 23:25:17 (6240): VM state change detected. (old = 'running', new = 'paused')
2025-04-15 23:25:37 (6240): VM state change detected. (old = 'paused', new = 'running')
2025-04-15 23:27:16 (6240): VM state change detected. (old = 'running', new = 'paused')
2025-04-15 23:27:36 (6240): VM state change detected. (old = 'paused', new = 'running')
2025-04-15 23:30:57 (6240): VM state change detected. (old = 'running', new = 'paused')
2025-04-15 23:31:17 (6240): VM state change detected. (old = 'paused', new = 'running')
2025-04-15 23:31:37 (6240): VM state change detected. (old = 'running', new = 'paused')
2025-04-15 23:31:57 (6240): VM state change detected. (old = 'paused', new = 'running')
2025-04-15 23:33:37 (6240): VM state change detected. (old = 'running', new = 'paused')
2025-04-15 23:33:57 (6240): VM state change detected. (old = 'paused', new = 'running')
2025-04-15 23:34:57 (6240): VM state change detected. (old = 'running', new = 'paused')
2025-04-15 23:35:37 (6240): VM state change detected. (old = 'paused', new = 'running')
2025-04-15 23:36:18 (6240): VM state change detected. (old = 'running', new = 'paused')
2025-04-15 23:36:38 (6240): VM state change detected. (old = 'paused', new = 'running')
2025-04-15 23:36:48 (6240): VM state change detected. (old = 'running', new = 'paused')
2025-04-15 23:37:07 (6240): VM state change detected. (old = 'paused', new = 'running')
2025-04-15 23:37:18 (6240): VM state change detected. (old = 'running', new = 'paused')
2025-04-15 23:37:37 (6240): VM state change detected. (old = 'paused', new = 'running')
2025-04-15 23:37:47 (6240): VM state change detected. (old = 'running', new = 'paused')
2025-04-15 23:38:08 (6240): VM state change detected. (old = 'paused', new = 'running')
2025-04-15 23:39:17 (6240): VM state change detected. (old = 'running', new = 'paused')
2025-04-15 23:39:37 (6240): VM state change detected. (old = 'paused', new = 'running')
2025-04-15 23:40:37 (6240): VM state change detected. (old = 'running', new = 'paused')
2025-04-15 23:40:57 (6240): VM state change detected. (old = 'paused', new = 'running')
2025-04-15 23:41:17 (6240): VM state change detected. (old = 'running', new = 'paused')
2025-04-15 23:41:37 (6240): VM state change detected. (old = 'paused', new = 'running')
2025-04-15 23:41:57 (6240): VM state change detected. (old = 'running', new = 'paused')
2025-04-15 23:42:17 (6240): VM state change detected. (old = 'paused', new = 'running')
2025-04-15 23:42:38 (6240): VM state change detected. (old = 'running', new = 'paused')
2025-04-15 23:42:58 (6240): VM state change detected. (old = 'paused', new = 'running')
2025-04-15 23:43:08 (6240): VM state change detected. (old = 'running', new = 'paused')
2025-04-15 23:43:28 (6240): VM state change detected. (old = 'paused', new = 'running')
2025-04-15 23:44:48 (6240): VM state change detected. (old = 'running', new = 'paused')
2025-04-15 23:45:08 (6240): VM state change detected. (old = 'paused', new = 'running')
2025-04-15 23:48:39 (6240): VM state change detected. (old = 'running', new = 'paused')
2025-04-15 23:48:40 (6240): VM state change detected. (old = 'paused', new = 'running')
2025-04-15 23:49:28 (6240): VM state change detected. (old = 'running', new = 'paused')
2025-04-15 23:49:49 (6240): VM state change detected. (old = 'paused', new = 'running')
2025-04-15 23:50:28 (6240): VM state change detected. (old = 'running', new = 'paused')
2025-04-15 23:50:48 (6240): VM state change detected. (old = 'paused', new = 'running')
2025-04-15 23:51:28 (6240): VM state change detected. (old = 'running', new = 'paused')
2025-04-15 23:51:48 (6240): VM state change detected. (old = 'paused', new = 'running')
2025-04-15 23:52:48 (6240): VM state change detected. (old = 'running', new = 'paused')
2025-04-15 23:53:08 (6240): VM state change detected. (old = 'paused', new = 'running')
2025-04-15 23:53:49 (6240): VM state change detected. (old = 'running', new = 'paused')
2025-04-15 23:54:09 (6240): VM state change detected. (old = 'paused', new = 'running')
2025-04-15 23:54:19 (6240): VM state change detected. (old = 'running', new = 'paused')
2025-04-15 23:54:39 (6240): VM state change detected. (old = 'paused', new = 'running')
2025-04-15 23:55:49 (6240): VM state change detected. (old = 'running', new = 'paused')
2025-04-15 23:56:09 (6240): VM state change detected. (old = 'paused', new = 'running')
2025-04-15 23:56:19 (6240): VM state change detected. (old = 'running', new = 'paused')
2025-04-15 23:56:39 (6240): VM state change detected. (old = 'paused', new = 'running')
2025-04-15 23:57:28 (6240): VM state change detected. (old = 'running', new = 'paused')
2025-04-15 23:57:48 (6240): VM state change detected. (old = 'paused', new = 'running')
2025-04-16 00:00:49 (6240): VM state change detected. (old = 'running', new = 'paused')
2025-04-16 00:01:09 (6240): VM state change detected. (old = 'paused', new = 'running')
2025-04-16 00:02:09 (6240): VM state change detected. (old = 'running', new = 'paused')
2025-04-16 00:02:29 (6240): VM state change detected. (old = 'paused', new = 'running')
2025-04-16 00:05:50 (6240): VM state change detected. (old = 'running', new = 'paused')
2025-04-16 00:06:10 (6240): VM state change detected. (old = 'paused', new = 'running')
2025-04-16 00:31:11 (6240): VM state change detected. (old = 'running', new = 'paused')
2025-04-16 00:31:31 (6240): VM state change detected. (old = 'paused', new = 'running')
2025-04-16 00:55:54 (6240): Status Report: Elapsed Time: '132052.000000'
2025-04-16 00:55:54 (6240): Status Report: CPU Time: '304837.515625'
2025-04-16 02:36:17 (6240): Status Report: Elapsed Time: '138052.000000'
2025-04-16 02:36:17 (6240): Status Report: CPU Time: '319363.937500'
2025-04-16 03:12:06 (6240): VM state change detected. (old = 'running', new = 'paused')
2025-04-16 03:12:26 (6240): VM state change detected. (old = 'paused', new = 'running')
2025-04-16 03:14:39 (6240): VM state change detected. (old = 'running', new = 'paused')
2025-04-16 03:14:56 (6240): VM state change detected. (old = 'paused', new = 'running')
2025-04-16 03:24:37 (6240): VM state change detected. (old = 'running', new = 'paused')
2025-04-16 03:24:57 (6240): VM state change detected. (old = 'paused', new = 'running')
2025-04-16 03:46:10 (6240): VM state change detected. (old = 'running', new = 'paused')
2025-04-16 03:46:30 (6240): VM state change detected. (old = 'paused', new = 'running')
2025-04-16 04:12:13 (6240): VM state change detected. (old = 'running', new = 'paused')
2025-04-16 04:12:33 (6240): VM state change detected. (old = 'paused', new = 'running')
2025-04-16 04:18:44 (6240): Status Report: Elapsed Time: '144052.000000'
2025-04-16 04:18:44 (6240): Status Report: CPU Time: '333858.125000'
2025-04-16 05:33:20 (6240): VM state change detected. (old = 'running', new = 'paused')
2025-04-16 05:33:40 (6240): VM state change detected. (old = 'paused', new = 'running')
2025-04-16 05:59:11 (6240): Status Report: Elapsed Time: '150052.000000'
2025-04-16 05:59:11 (6240): Status Report: CPU Time: '348416.593750'
2025-04-16 06:59:59 (6240): Stopping VM.
2025-04-16 07:00:15 (6240): Successfully stopped VM.
2025-04-16 08:53:07 (13604): Detected: vboxwrapper 26206
2025-04-16 08:53:07 (13604): Detected: BOINC client v8.0.2
2025-04-16 08:53:08 (13604): Detected: VirtualBox VboxManage Interface (Version: 7.0.6)
2025-04-16 08:53:08 (13604): Guest Log: BIOS: KBD: unsupported int 16h function 03
2025-04-16 08:53:08 (13604): Guest Log: BIOS: AX=0305 BX=0000 CX=0000 DX=0000 
2025-04-16 08:53:08 (13604): Guest Log: int13_harddisk_ext: function 41, unmapped device for ELDL=81
2025-04-16 08:53:08 (13604): Guest Log: int13_harddisk: function 02, unmapped device for ELDL=81
2025-04-16 08:53:08 (13604): Guest Log: int13_harddisk_ext: function 41, unmapped device for ELDL=82
2025-04-16 08:53:08 (13604): Guest Log: int13_harddisk: function 02, unmapped device for ELDL=82
2025-04-16 08:53:08 (13604): Guest Log: int13_harddisk_ext: function 41, unmapped device for ELDL=83
2025-04-16 08:53:08 (13604): Guest Log: int13_harddisk: function 02, unmapped device for ELDL=83
2025-04-16 08:53:08 (13604): Guest Log: int13_harddisk_ext: function 41, unmapped device for ELDL=84
2025-04-16 08:53:08 (13604): Guest Log: int13_harddisk: function 02, unmapped device for ELDL=84
2025-04-16 08:53:08 (13604): Guest Log: int13_harddisk_ext: function 41, unmapped device for ELDL=85
2025-04-16 08:53:08 (13604): Guest Log: int13_harddisk: function 02, unmapped device for ELDL=85
2025-04-16 08:53:08 (13604): Guest Log: int13_harddisk_ext: function 41, unmapped device for ELDL=86
2025-04-16 08:53:08 (13604): Guest Log: int13_harddisk: function 02, unmapped device for ELDL=86
2025-04-16 08:53:08 (13604): Guest Log: int13_harddisk_ext: function 41, unmapped device for ELDL=87
2025-04-16 08:53:08 (13604): Guest Log: int13_harddisk: function 02, unmapped device for ELDL=87
2025-04-16 08:53:08 (13604): Guest Log: int13_harddisk_ext: function 41, unmapped device for ELDL=88
2025-04-16 08:53:08 (13604): Guest Log: int13_harddisk: function 02, unmapped device for ELDL=88
2025-04-16 08:53:08 (13604): Guest Log: int13_harddisk_ext: function 41, unmapped device for ELDL=89
2025-04-16 08:53:08 (13604): Guest Log: int13_harddisk: function 02, unmapped device for ELDL=89
2025-04-16 08:53:08 (13604): Guest Log: int13_harddisk_ext: function 41, unmapped device for ELDL=8a
2025-04-16 08:53:08 (13604): Guest Log: int13_harddisk: function 02, unmapped device for ELDL=8a
2025-04-16 08:53:08 (13604): Guest Log: int13_harddisk_ext: function 41, unmapped device for ELDL=8b
2025-04-16 08:53:08 (13604): Guest Log: int13_harddisk: function 02, unmapped device for ELDL=8b
2025-04-16 08:53:08 (13604): Guest Log: int13_harddisk_ext: function 41, unmapped device for ELDL=8c
2025-04-16 08:53:08 (13604): Guest Log: int13_harddisk: function 02, unmapped device for ELDL=8c
2025-04-16 08:53:08 (13604): Guest Log: int13_harddisk_ext: function 41, unmapped device for ELDL=8d
2025-04-16 08:53:08 (13604): Guest Log: int13_harddisk: function 02, unmapped device for ELDL=8d
2025-04-16 08:53:08 (13604): Guest Log: int13_harddisk_ext: function 41, unmapped device for ELDL=8e
2025-04-16 08:53:08 (13604): Guest Log: int13_harddisk: function 02, unmapped device for ELDL=8e
2025-04-16 08:53:08 (13604): Guest Log: int13_harddisk_ext: function 41, unmapped device for ELDL=8f
2025-04-16 08:53:08 (13604): Guest Log: int13_harddisk: function 02, unmapped device for ELDL=8f
2025-04-16 08:53:08 (13604): Guest Log: vgdrvHeartbeatInit: Setting up heartbeat to trigger every 2000 milliseconds
2025-04-16 08:53:08 (13604): Guest Log: vboxguest: misc device minor 58, IRQ 20, I/O port d020, MMIO at 00000000f0400000 (size 0x400000)
2025-04-16 08:53:08 (13604): Guest Log: VBoxService 5.2.32 r132073 (verbosity: 0) linux.amd64 (Jul 12 2019 10:32:28) release log
2025-04-16 08:53:08 (13604): Guest Log: 00:00:00.000174 main     Log opened 2025-04-15T15:21:09.881424000Z
2025-04-16 08:53:08 (13604): Guest Log: 00:00:00.000268 main     OS Product: Linux
2025-04-16 08:53:08 (13604): Guest Log: 00:00:00.000304 main     OS Release: 3.10.0-957.27.2.el7.x86_64
2025-04-16 08:53:08 (13604): Guest Log: 00:00:00.000336 main     OS Version: #1 SMP Mon Jul 29 17:46:05 UTC 2019
2025-04-16 08:53:08 (13604): Guest Log: 00:00:00.000367 main     Executable: /opt/VBoxGuestAdditions-5.2.32/sbin/VBoxService
2025-04-16 08:53:08 (13604): Guest Log: 00:00:00.000368 main     Process ID: 1317
2025-04-16 08:53:08 (13604): Guest Log: 00:00:00.000369 main     Package type: LINUX_64BITS_GENERIC
2025-04-16 08:53:08 (13604): Guest Log: 00:00:00.001405 main     5.2.32 r132073 started. Verbose level = 0
2025-04-16 08:53:08 (13604): Guest Log: [INFO] Probing /cvmfs/atlas.cern.ch...
2025-04-16 08:53:08 (13604): Guest Log: [INFO] Mounting shared directory
2025-04-16 08:53:08 (13604): Guest Log: [INFO] Checking for init_data.xml
2025-04-16 08:53:08 (13604): Guest Log: [INFO] Probing /cvmfs/atlas.cern.ch... OK
2025-04-16 08:53:08 (13604): Guest Log: [INFO] Detected branch: prod
2025-04-16 08:53:08 (13604): Guest Log: This is the prod version of the ATLAS job wrapper
2025-04-16 08:53:08 (13604): Guest Log: Copying input files
2025-04-16 08:53:08 (13604): Guest Log: Copied input files into RunAtlas.
2025-04-16 08:53:08 (13604): Guest Log: This VM did not configure a local http proxy via BOINC.
2025-04-16 08:53:08 (13604): Guest Log: Small home clusters do not require a local http proxy but it is suggested if
2025-04-16 08:53:08 (13604): Guest Log: more than 10 cores throughout the same LAN segment are regularly running ATLAS like tasks.
2025-04-16 08:53:08 (13604): Guest Log: Further information can be found at the LHC@home message board.
2025-04-16 08:53:08 (13604): Guest Log: 00:00:10.003425 timesync vgsvcTimeSyncWorker: Radical guest time change: -10 613 136 230 000ns (GuestNow=1 744 719 856 747 705 000 ns GuestLast=1 744 730 469 883 935 000 ns fSetTimeLastLoop=true )
2025-04-16 08:53:08 (13604): Guest Log: Running cvmfs_config stat atlas.cern.ch
2025-04-16 08:53:08 (13604): 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
2025-04-16 08:53:08 (13604): Guest Log: 2.6.3.0 1592 0 32016 144888 4 1 2774402 4096000 0 65024 0 0 n/a 0 0 http://s1fnal-cvmfs.openhtc.io:8080/cvmfs/atlas.cern.ch DIRECT 1
2025-04-16 08:53:08 (13604): Guest Log: copied the webapp to /var/www
2025-04-16 08:53:08 (13604): Guest Log: ATHENA_PROC_NUMBER=4
2025-04-16 08:53:08 (13604): Guest Log: ATHENA_CORE_NUMBER=4
2025-04-16 08:53:08 (13604): 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 
2025-04-16 08:53:08 (13604): Guest Log:  *** Starting ATLAS job. (PandaID=6601718204 taskID=43926719) ***
2025-04-16 08:53:08 (13604): Starting VM using VBoxManage interface. (boinc_c97ae6877b4a9997, slot#0)
2025-04-16 08:53:26 (13604): Successfully started VM. (PID = '17972')
2025-04-16 08:53:26 (13604): Reporting VM Process ID to BOINC.
2025-04-16 08:53:26 (13604): Guest Log: 14:27:08.576836 timesync vgsvcTimeSyncWorker: Radical host time change: 6 813 538 000 000ns (HostNow=1 744 782 806 190 000 000 ns HostLast=1 744 775 992 652 000 000 ns)
2025-04-16 08:53:26 (13604): VM state change detected. (old = 'poweredoff', new = 'running')
2025-04-16 08:53:26 (13604): Detected: Web Application Enabled (http://localhost:65466)
2025-04-16 08:53:27 (13604): VM state change detected. (old = 'running', new = 'paused')
2025-04-16 08:53:36 (13604): Status Report: Elapsed Time: '153697.000000'
2025-04-16 08:53:36 (13604): Status Report: CPU Time: '357281.453125'
2025-04-16 08:53:36 (13604): Preference change detected
2025-04-16 08:53:36 (13604): Setting CPU throttle for VM. (50%)
2025-04-16 08:53:36 (13604): Setting checkpoint interval to 900 seconds. (Higher value of (Preference: 60 seconds) or (Vbox_job.xml: 900 seconds))
2025-04-16 08:53:37 (13604): VM state change detected. (old = 'paused', new = 'running')
2025-04-16 08:53:46 (13604): Guest Log: 14:27:18.664024 timesync vgsvcTimeSyncWorker: Radical guest time change: 7 317 599 631 000ns (GuestNow=1 744 782 816 325 916 000 ns GuestLast=1 744 775 498 726 285 000 ns fSetTimeLastLoop=true )
2025-04-16 09:09:48 (13604): VM state change detected. (old = 'running', new = 'paused')
2025-04-16 09:10:08 (13604): VM state change detected. (old = 'paused', new = 'running')
2025-04-16 09:10:38 (13604): VM state change detected. (old = 'running', new = 'paused')
2025-04-16 09:10:58 (13604): VM state change detected. (old = 'paused', new = 'running')
2025-04-16 09:11:08 (13604): VM state change detected. (old = 'running', new = 'paused')
2025-04-16 09:11:28 (13604): VM state change detected. (old = 'paused', new = 'running')
2025-04-16 09:31:29 (13604): VM state change detected. (old = 'running', new = 'paused')
2025-04-16 09:31:49 (13604): VM state change detected. (old = 'paused', new = 'running')
2025-04-16 09:53:02 (13604): VM state change detected. (old = 'running', new = 'paused')
2025-04-16 09:53:22 (13604): VM state change detected. (old = 'paused', new = 'running')
2025-04-16 09:53:42 (13604): VM state change detected. (old = 'running', new = 'paused')
2025-04-16 09:54:02 (13604): VM state change detected. (old = 'paused', new = 'running')
2025-04-16 09:58:42 (13604): VM state change detected. (old = 'running', new = 'paused')
2025-04-16 09:59:02 (13604): VM state change detected. (old = 'paused', new = 'running')
2025-04-16 09:59:12 (13604): VM state change detected. (old = 'running', new = 'paused')
2025-04-16 09:59:32 (13604): VM state change detected. (old = 'paused', new = 'running')
2025-04-16 09:59:52 (13604): VM state change detected. (old = 'running', new = 'paused')
2025-04-16 10:00:12 (13604): VM state change detected. (old = 'paused', new = 'running')
2025-04-16 10:00:22 (13604): VM state change detected. (old = 'running', new = 'paused')
2025-04-16 10:00:42 (13604): VM state change detected. (old = 'paused', new = 'running')
2025-04-16 10:01:42 (13604): VM state change detected. (old = 'running', new = 'paused')
2025-04-16 10:02:02 (13604): VM state change detected. (old = 'paused', new = 'running')
2025-04-16 10:02:22 (13604): VM state change detected. (old = 'running', new = 'paused')
2025-04-16 10:02:42 (13604): VM state change detected. (old = 'paused', new = 'running')
2025-04-16 10:02:52 (13604): VM state change detected. (old = 'running', new = 'paused')
2025-04-16 10:03:12 (13604): VM state change detected. (old = 'paused', new = 'running')
2025-04-16 10:03:32 (13604): VM state change detected. (old = 'running', new = 'paused')
2025-04-16 10:03:52 (13604): VM state change detected. (old = 'paused', new = 'running')
2025-04-16 10:04:13 (13604): VM state change detected. (old = 'running', new = 'paused')
2025-04-16 10:04:33 (13604): VM state change detected. (old = 'paused', new = 'running')
2025-04-16 10:04:53 (13604): VM state change detected. (old = 'running', new = 'paused')
2025-04-16 10:05:13 (13604): VM state change detected. (old = 'paused', new = 'running')
2025-04-16 10:10:24 (13604): VM state change detected. (old = 'running', new = 'paused')
2025-04-16 10:10:43 (13604): VM state change detected. (old = 'paused', new = 'running')
2025-04-16 10:25:45 (13604): VM state change detected. (old = 'running', new = 'paused')
2025-04-16 10:26:05 (13604): VM state change detected. (old = 'paused', new = 'running')
2025-04-16 10:40:02 (13604): Status Report: Elapsed Time: '159697.000000'
2025-04-16 10:40:02 (13604): Status Report: CPU Time: '371764.578125'
2025-04-16 10:52:59 (13604): VM state change detected. (old = 'running', new = 'paused')
2025-04-16 10:53:19 (13604): VM state change detected. (old = 'paused', new = 'running')
2025-04-16 10:53:21 (13604): VM state change detected. (old = 'running', new = 'paused')
2025-04-16 16:22:55 (13604): VM state change detected. (old = 'paused', new = 'running')
2025-04-16 16:22:59 (13604): Guest Log: 16:20:43.437763 timesync vgsvcTimeSyncWorker: Radical host time change: 19 804 221 000 000ns (HostNow=1 744 809 778 880 000 000 ns HostLast=1 744 789 974 659 000 000 ns)
2025-04-16 16:23:02 (13604): VM state change detected. (old = 'running', new = 'paused')
2025-04-16 16:23:22 (13604): VM state change detected. (old = 'paused', new = 'running')
2025-04-16 16:23:29 (13604): Guest Log: 16:20:53.455700 timesync vgsvcTimeSyncWorker: Radical guest time change: 20 167 873 123 000ns (GuestNow=1 744 809 788 935 357 000 ns GuestLast=1 744 789 621 062 234 000 ns fSetTimeLastLoop=true )
2025-04-16 16:48:16 (13604): VM state change detected. (old = 'running', new = 'paused')
2025-04-16 16:48:36 (13604): VM state change detected. (old = 'paused', new = 'running')
2025-04-16 16:49:16 (13604): VM state change detected. (old = 'running', new = 'paused')
2025-04-16 16:49:36 (13604): VM state change detected. (old = 'paused', new = 'running')
2025-04-16 17:01:11 (13604): VM state change detected. (old = 'running', new = 'paused')
2025-04-16 17:01:32 (13604): VM state change detected. (old = 'paused', new = 'running')
2025-04-16 17:01:37 (13604): VM state change detected. (old = 'running', new = 'paused')
2025-04-16 17:02:17 (13604): VM state change detected. (old = 'paused', new = 'running')
2025-04-16 17:52:26 (13604): Status Report: Elapsed Time: '165697.000000'
2025-04-16 17:52:26 (13604): Status Report: CPU Time: '386260.343750'
2025-04-16 18:22:14 (13604): VM state change detected. (old = 'running', new = 'paused')
2025-04-16 18:22:35 (13604): VM state change detected. (old = 'paused', new = 'running')
2025-04-16 18:28:35 (13604): VM state change detected. (old = 'running', new = 'paused')
2025-04-16 18:28:56 (13604): VM state change detected. (old = 'paused', new = 'running')
2025-04-16 18:33:05 (13604): VM state change detected. (old = 'running', new = 'paused')
2025-04-16 18:33:25 (13604): VM state change detected. (old = 'paused', new = 'running')
2025-04-16 18:34:16 (13604): VM state change detected. (old = 'running', new = 'paused')
2025-04-16 18:34:35 (13604): VM state change detected. (old = 'paused', new = 'running')
2025-04-16 18:34:55 (13604): VM state change detected. (old = 'running', new = 'paused')
2025-04-16 18:35:16 (13604): VM state change detected. (old = 'paused', new = 'running')
2025-04-16 18:36:16 (13604): VM state change detected. (old = 'running', new = 'paused')
2025-04-16 18:36:36 (13604): VM state change detected. (old = 'paused', new = 'running')
2025-04-16 18:36:46 (13604): VM state change detected. (old = 'running', new = 'paused')
2025-04-16 18:37:06 (13604): VM state change detected. (old = 'paused', new = 'running')
2025-04-16 18:38:05 (13604): VM state change detected. (old = 'running', new = 'paused')
2025-04-16 18:38:26 (13604): VM state change detected. (old = 'paused', new = 'running')
2025-04-16 18:38:56 (13604): VM state change detected. (old = 'running', new = 'paused')
2025-04-16 18:39:36 (13604): VM state change detected. (old = 'paused', new = 'running')
2025-04-16 18:39:46 (13604): VM state change detected. (old = 'running', new = 'paused')
2025-04-16 18:40:06 (13604): VM state change detected. (old = 'paused', new = 'running')
2025-04-16 18:40:36 (13604): VM state change detected. (old = 'running', new = 'paused')
2025-04-16 18:40:56 (13604): VM state change detected. (old = 'paused', new = 'running')
2025-04-16 18:42:06 (13604): VM state change detected. (old = 'running', new = 'paused')
2025-04-16 18:42:26 (13604): VM state change detected. (old = 'paused', new = 'running')
2025-04-16 18:42:36 (13604): VM state change detected. (old = 'running', new = 'paused')
2025-04-16 18:42:56 (13604): VM state change detected. (old = 'paused', new = 'running')
2025-04-16 18:43:06 (13604): VM state change detected. (old = 'running', new = 'paused')
2025-04-16 18:43:26 (13604): VM state change detected. (old = 'paused', new = 'running')
2025-04-16 18:43:36 (13604): VM state change detected. (old = 'running', new = 'paused')
2025-04-16 18:43:56 (13604): VM state change detected. (old = 'paused', new = 'running')
2025-04-16 18:44:06 (13604): VM state change detected. (old = 'running', new = 'paused')
2025-04-16 18:44:26 (13604): VM state change detected. (old = 'paused', new = 'running')
2025-04-16 18:44:46 (13604): VM state change detected. (old = 'running', new = 'paused')
2025-04-16 18:45:06 (13604): VM state change detected. (old = 'paused', new = 'running')
2025-04-16 18:45:26 (13604): VM state change detected. (old = 'running', new = 'paused')
2025-04-16 18:45:47 (13604): VM state change detected. (old = 'paused', new = 'running')
2025-04-16 18:46:06 (13604): VM state change detected. (old = 'running', new = 'paused')
2025-04-16 18:46:26 (13604): VM state change detected. (old = 'paused', new = 'running')
2025-04-16 18:46:36 (13604): VM state change detected. (old = 'running', new = 'paused')
2025-04-16 18:46:56 (13604): VM state change detected. (old = 'paused', new = 'running')
2025-04-16 18:48:28 (13604): VM state change detected. (old = 'running', new = 'paused')
2025-04-16 18:48:48 (13604): VM state change detected. (old = 'paused', new = 'running')
2025-04-16 18:48:56 (13604): VM state change detected. (old = 'running', new = 'paused')
2025-04-16 18:49:17 (13604): VM state change detected. (old = 'paused', new = 'running')
2025-04-16 18:51:07 (13604): VM state change detected. (old = 'running', new = 'paused')
2025-04-16 18:51:27 (13604): VM state change detected. (old = 'paused', new = 'running')
2025-04-16 18:51:47 (13604): VM state change detected. (old = 'running', new = 'paused')
2025-04-16 18:52:07 (13604): VM state change detected. (old = 'paused', new = 'running')
2025-04-16 18:52:17 (13604): VM state change detected. (old = 'running', new = 'paused')
2025-04-16 18:52:37 (13604): VM state change detected. (old = 'paused', new = 'running')
2025-04-16 18:52:56 (13604): VM state change detected. (old = 'running', new = 'paused')
2025-04-16 18:53:16 (13604): VM state change detected. (old = 'paused', new = 'running')
2025-04-16 18:54:07 (13604): VM state change detected. (old = 'running', new = 'paused')
2025-04-16 18:54:27 (13604): VM state change detected. (old = 'paused', new = 'running')
2025-04-16 19:11:29 (13604): VM state change detected. (old = 'running', new = 'paused')
2025-04-16 19:11:48 (13604): VM state change detected. (old = 'paused', new = 'running')
2025-04-16 19:11:58 (13604): VM state change detected. (old = 'running', new = 'paused')
2025-04-16 19:12:18 (13604): VM state change detected. (old = 'paused', new = 'running')
2025-04-16 19:12:38 (13604): VM state change detected. (old = 'running', new = 'paused')
2025-04-16 19:12:58 (13604): VM state change detected. (old = 'paused', new = 'running')
2025-04-16 19:13:08 (13604): VM state change detected. (old = 'running', new = 'paused')
2025-04-16 19:13:29 (13604): VM state change detected. (old = 'paused', new = 'running')
2025-04-16 19:13:59 (13604): VM state change detected. (old = 'running', new = 'paused')
2025-04-16 19:14:19 (13604): VM state change detected. (old = 'paused', new = 'running')
2025-04-16 19:14:49 (13604): VM state change detected. (old = 'running', new = 'paused')
2025-04-16 19:15:09 (13604): VM state change detected. (old = 'paused', new = 'running')
2025-04-16 19:15:38 (13604): VM state change detected. (old = 'running', new = 'paused')
2025-04-16 19:15:58 (13604): VM state change detected. (old = 'paused', new = 'running')
2025-04-16 19:16:08 (13604): VM state change detected. (old = 'running', new = 'paused')
2025-04-16 19:16:28 (13604): VM state change detected. (old = 'paused', new = 'running')
2025-04-16 19:16:38 (13604): VM state change detected. (old = 'running', new = 'paused')
2025-04-16 19:16:58 (13604): VM state change detected. (old = 'paused', new = 'running')
2025-04-16 19:17:09 (13604): VM state change detected. (old = 'running', new = 'paused')
2025-04-16 19:17:29 (13604): VM state change detected. (old = 'paused', new = 'running')
2025-04-16 19:19:09 (13604): VM state change detected. (old = 'running', new = 'paused')
2025-04-16 19:19:29 (13604): VM state change detected. (old = 'paused', new = 'running')
2025-04-16 19:19:49 (13604): VM state change detected. (old = 'running', new = 'paused')
2025-04-16 19:20:10 (13604): VM state change detected. (old = 'paused', new = 'running')
2025-04-16 19:20:29 (13604): VM state change detected. (old = 'running', new = 'paused')
2025-04-16 19:20:49 (13604): VM state change detected. (old = 'paused', new = 'running')
2025-04-16 19:21:10 (13604): VM state change detected. (old = 'running', new = 'paused')
2025-04-16 19:21:30 (13604): VM state change detected. (old = 'paused', new = 'running')
2025-04-16 19:21:50 (13604): VM state change detected. (old = 'running', new = 'paused')
2025-04-16 19:22:10 (13604): VM state change detected. (old = 'paused', new = 'running')
2025-04-16 19:25:19 (13604): VM state change detected. (old = 'running', new = 'paused')
2025-04-16 19:25:40 (13604): VM state change detected. (old = 'paused', new = 'running')
2025-04-16 19:28:09 (13604): VM state change detected. (old = 'running', new = 'paused')
2025-04-16 19:28:30 (13604): VM state change detected. (old = 'paused', new = 'running')
2025-04-16 19:28:49 (13604): VM state change detected. (old = 'running', new = 'paused')
2025-04-16 19:29:10 (13604): VM state change detected. (old = 'paused', new = 'running')
2025-04-16 19:29:19 (13604): VM state change detected. (old = 'running', new = 'paused')
2025-04-16 19:29:40 (13604): VM state change detected. (old = 'paused', new = 'running')
2025-04-16 19:29:49 (13604): VM state change detected. (old = 'running', new = 'paused')
2025-04-16 19:30:11 (13604): VM state change detected. (old = 'paused', new = 'running')
2025-04-16 19:30:50 (13604): VM state change detected. (old = 'running', new = 'paused')
2025-04-16 19:31:11 (13604): VM state change detected. (old = 'paused', new = 'running')
2025-04-16 19:41:31 (13604): VM state change detected. (old = 'running', new = 'paused')
2025-04-16 19:41:51 (13604): VM state change detected. (old = 'paused', new = 'running')
2025-04-16 19:45:12 (13604): VM state change detected. (old = 'running', new = 'paused')
2025-04-16 19:45:31 (13604): VM state change detected. (old = 'paused', new = 'running')
2025-04-16 19:45:41 (13604): VM state change detected. (old = 'running', new = 'paused')
2025-04-16 19:45:42 (13604): VM state change detected. (old = 'paused', new = 'running')
2025-04-16 19:51:08 (13604): Status Report: Elapsed Time: '171697.000000'
2025-04-16 19:51:08 (13604): Status Report: CPU Time: '400782.296875'
2025-04-16 20:13:34 (13604): VM state change detected. (old = 'running', new = 'paused')
2025-04-16 20:13:54 (13604): VM state change detected. (old = 'paused', new = 'running')
2025-04-16 20:14:04 (13604): VM state change detected. (old = 'running', new = 'paused')
2025-04-16 20:14:24 (13604): VM state change detected. (old = 'paused', new = 'running')
2025-04-16 20:19:04 (13604): VM state change detected. (old = 'running', new = 'paused')
2025-04-16 20:19:24 (13604): VM state change detected. (old = 'paused', new = 'running')
2025-04-16 20:19:34 (13604): VM state change detected. (old = 'running', new = 'paused')
2025-04-16 20:19:55 (13604): VM state change detected. (old = 'paused', new = 'running')
2025-04-16 20:20:34 (13604): VM state change detected. (old = 'running', new = 'paused')
2025-04-16 20:20:54 (13604): VM state change detected. (old = 'paused', new = 'running')
2025-04-16 20:21:04 (13604): VM state change detected. (old = 'running', new = 'paused')
2025-04-16 20:21:24 (13604): VM state change detected. (old = 'paused', new = 'running')
2025-04-16 20:21:34 (13604): VM state change detected. (old = 'running', new = 'paused')
2025-04-16 20:21:54 (13604): VM state change detected. (old = 'paused', new = 'running')
2025-04-16 20:22:04 (13604): VM state change detected. (old = 'running', new = 'paused')
2025-04-16 20:22:24 (13604): VM state change detected. (old = 'paused', new = 'running')
2025-04-16 20:57:27 (13604): VM state change detected. (old = 'running', new = 'paused')
2025-04-16 20:57:48 (13604): VM state change detected. (old = 'paused', new = 'running')
2025-04-16 20:59:38 (13604): VM state change detected. (old = 'running', new = 'paused')
2025-04-16 20:59:58 (13604): VM state change detected. (old = 'paused', new = 'running')
2025-04-16 21:03:48 (13604): VM state change detected. (old = 'running', new = 'paused')
2025-04-16 21:04:08 (13604): VM state change detected. (old = 'paused', new = 'running')
2025-04-16 21:12:18 (13604): VM state change detected. (old = 'running', new = 'paused')
2025-04-16 21:12:58 (13604): VM state change detected. (old = 'paused', new = 'running')
2025-04-16 21:13:20 (13604): VM state change detected. (old = 'running', new = 'paused')
2025-04-16 21:13:38 (13604): VM state change detected. (old = 'paused', new = 'running')
2025-04-16 21:24:39 (13604): VM state change detected. (old = 'running', new = 'paused')
2025-04-16 21:24:59 (13604): VM state change detected. (old = 'paused', new = 'running')
2025-04-16 21:25:09 (13604): VM state change detected. (old = 'running', new = 'paused')
2025-04-16 21:25:29 (13604): VM state change detected. (old = 'paused', new = 'running')
2025-04-16 21:27:09 (13604): VM state change detected. (old = 'running', new = 'paused')
2025-04-16 21:27:29 (13604): VM state change detected. (old = 'paused', new = 'running')
2025-04-16 21:27:39 (13604): VM state change detected. (old = 'running', new = 'paused')
2025-04-16 21:27:59 (13604): VM state change detected. (old = 'paused', new = 'running')
2025-04-16 21:28:09 (13604): VM state change detected. (old = 'running', new = 'paused')
2025-04-16 21:28:29 (13604): VM state change detected. (old = 'paused', new = 'running')
2025-04-16 21:28:39 (13604): VM state change detected. (old = 'running', new = 'paused')
2025-04-16 21:28:59 (13604): VM state change detected. (old = 'paused', new = 'running')
2025-04-16 21:29:50 (13604): VM state change detected. (old = 'running', new = 'paused')
2025-04-16 21:30:10 (13604): VM state change detected. (old = 'paused', new = 'running')
2025-04-16 21:30:21 (13604): VM state change detected. (old = 'running', new = 'paused')
2025-04-16 21:30:40 (13604): VM state change detected. (old = 'paused', new = 'running')
2025-04-16 21:30:50 (13604): VM state change detected. (old = 'running', new = 'paused')
2025-04-16 21:31:10 (13604): VM state change detected. (old = 'paused', new = 'running')
2025-04-16 21:31:30 (13604): VM state change detected. (old = 'running', new = 'paused')
2025-04-16 21:31:50 (13604): VM state change detected. (old = 'paused', new = 'running')
2025-04-16 21:32:00 (13604): VM state change detected. (old = 'running', new = 'paused')
2025-04-16 21:32:20 (13604): VM state change detected. (old = 'paused', new = 'running')
2025-04-16 21:32:50 (13604): VM state change detected. (old = 'running', new = 'paused')
2025-04-16 21:33:10 (13604): VM state change detected. (old = 'paused', new = 'running')
2025-04-16 21:33:20 (13604): VM state change detected. (old = 'running', new = 'paused')
2025-04-16 21:33:40 (13604): VM state change detected. (old = 'paused', new = 'running')
2025-04-16 21:34:00 (13604): VM state change detected. (old = 'running', new = 'paused')
2025-04-16 21:34:20 (13604): VM state change detected. (old = 'paused', new = 'running')
2025-04-16 21:39:41 (13604): VM state change detected. (old = 'running', new = 'paused')
2025-04-16 21:40:01 (13604): VM state change detected. (old = 'paused', new = 'running')
2025-04-16 21:40:51 (13604): VM state change detected. (old = 'running', new = 'paused')
2025-04-16 21:41:11 (13604): VM state change detected. (old = 'paused', new = 'running')
2025-04-16 21:41:21 (13604): VM state change detected. (old = 'running', new = 'paused')
2025-04-16 21:41:41 (13604): VM state change detected. (old = 'paused', new = 'running')
2025-04-16 21:42:21 (13604): Status Report: Elapsed Time: '177697.000000'
2025-04-16 21:42:21 (13604): Status Report: CPU Time: '415324.531250'
2025-04-16 21:45:31 (13604): VM state change detected. (old = 'running', new = 'paused')
2025-04-16 21:45:51 (13604): VM state change detected. (old = 'paused', new = 'running')
2025-04-16 21:46:01 (13604): VM state change detected. (old = 'running', new = 'paused')
2025-04-16 21:46:21 (13604): VM state change detected. (old = 'paused', new = 'running')
2025-04-16 21:47:21 (13604): VM state change detected. (old = 'running', new = 'paused')
2025-04-16 21:47:41 (13604): VM state change detected. (old = 'paused', new = 'running')
2025-04-16 21:49:41 (13604): VM state change detected. (old = 'running', new = 'paused')
2025-04-16 21:50:01 (13604): VM state change detected. (old = 'paused', new = 'running')
2025-04-16 21:50:41 (13604): VM state change detected. (old = 'running', new = 'paused')
2025-04-16 21:51:01 (13604): VM state change detected. (old = 'paused', new = 'running')
2025-04-16 21:52:42 (13604): VM state change detected. (old = 'running', new = 'paused')
2025-04-16 21:53:02 (13604): VM state change detected. (old = 'paused', new = 'running')
2025-04-16 21:53:22 (13604): VM state change detected. (old = 'running', new = 'paused')
2025-04-16 21:54:02 (13604): VM state change detected. (old = 'paused', new = 'running')
2025-04-16 21:54:12 (13604): VM state change detected. (old = 'running', new = 'paused')
2025-04-16 21:54:33 (13604): VM state change detected. (old = 'paused', new = 'running')
2025-04-16 21:55:02 (13604): VM state change detected. (old = 'running', new = 'paused')
2025-04-16 21:55:22 (13604): VM state change detected. (old = 'paused', new = 'running')
2025-04-16 21:55:32 (13604): VM state change detected. (old = 'running', new = 'paused')
2025-04-16 21:55:53 (13604): VM state change detected. (old = 'paused', new = 'running')
2025-04-16 21:59:33 (13604): VM state change detected. (old = 'running', new = 'paused')
2025-04-16 21:59:53 (13604): VM state change detected. (old = 'paused', new = 'running')
2025-04-16 22:03:52 (13604): VM state change detected. (old = 'running', new = 'paused')
2025-04-16 22:04:14 (13604): VM state change detected. (old = 'paused', new = 'running')
2025-04-16 22:05:33 (13604): VM state change detected. (old = 'running', new = 'paused')
2025-04-16 22:05:53 (13604): VM state change detected. (old = 'paused', new = 'running')
2025-04-16 22:07:23 (13604): VM state change detected. (old = 'running', new = 'paused')
2025-04-16 22:07:43 (13604): VM state change detected. (old = 'paused', new = 'running')
2025-04-16 22:09:04 (13604): VM state change detected. (old = 'running', new = 'paused')
2025-04-16 22:09:24 (13604): VM state change detected. (old = 'paused', new = 'running')
2025-04-16 22:11:03 (13604): VM state change detected. (old = 'running', new = 'paused')
2025-04-16 22:11:23 (13604): VM state change detected. (old = 'paused', new = 'running')
2025-04-16 22:17:14 (13604): VM state change detected. (old = 'running', new = 'paused')
2025-04-16 22:17:34 (13604): VM state change detected. (old = 'paused', new = 'running')
2025-04-16 22:25:05 (13604): VM state change detected. (old = 'running', new = 'paused')
2025-04-16 22:25:25 (13604): VM state change detected. (old = 'paused', new = 'running')
2025-04-16 23:25:09 (13604): VM state change detected. (old = 'running', new = 'paused')
2025-04-16 23:25:29 (13604): VM state change detected. (old = 'paused', new = 'running')
2025-04-16 23:28:50 (13604): VM state change detected. (old = 'running', new = 'paused')
2025-04-16 23:29:10 (13604): VM state change detected. (old = 'paused', new = 'running')
2025-04-16 23:30:14 (13604): Status Report: Elapsed Time: '183697.000000'
2025-04-16 23:30:14 (13604): Status Report: CPU Time: '429841.859375'
2025-04-17 00:01:23 (13604): VM state change detected. (old = 'running', new = 'paused')
2025-04-17 00:01:43 (13604): VM state change detected. (old = 'paused', new = 'running')
2025-04-17 00:07:56 (13604): VM state change detected. (old = 'running', new = 'paused')
2025-04-17 00:08:22 (13604): VM state change detected. (old = 'paused', new = 'running')
2025-04-17 01:11:26 (13604): Status Report: Elapsed Time: '189697.000000'
2025-04-17 01:11:26 (13604): Status Report: CPU Time: '444303.843750'
2025-04-17 01:25:23 (13604): VM state change detected. (old = 'running', new = 'paused')
2025-04-17 01:25:43 (13604): VM state change detected. (old = 'paused', new = 'running')
2025-04-17 01:27:43 (13604): VM state change detected. (old = 'running', new = 'paused')
2025-04-17 01:28:03 (13604): VM state change detected. (old = 'paused', new = 'running')
2025-04-17 01:51:45 (13604): VM state change detected. (old = 'running', new = 'paused')
2025-04-17 01:52:05 (13604): VM state change detected. (old = 'paused', new = 'running')
2025-04-17 02:09:08 (13604): VM state change detected. (old = 'running', new = 'paused')
2025-04-17 13:46:13 (13604): VM state change detected. (old = 'paused', new = 'running')
2025-04-17 13:46:19 (13604): VM state change detected. (old = 'running', new = 'paused')
2025-04-17 13:46:39 (13604): VM state change detected. (old = 'paused', new = 'running')
2025-04-17 13:46:41 (13604): Guest Log: 25:29:08.189469 timesync vgsvcTimeSyncWorker: Radical host time change: 41 855 008 000 000ns (HostNow=1 744 886 801 363 000 000 ns HostLast=1 744 844 946 355 000 000 ns)
2025-04-17 13:46:52 (13604): Guest Log: 25:29:18.231804 timesync vgsvcTimeSyncWorker: Radical guest time change: 42 908 535 085 000ns (GuestNow=1 744 886 811 574 551 000 ns GuestLast=1 744 843 903 039 466 000 ns fSetTimeLastLoop=true )
2025-04-17 14:09:47 (13604): VM state change detected. (old = 'running', new = 'paused')
2025-04-17 14:10:07 (13604): VM state change detected. (old = 'paused', new = 'running')
2025-04-17 14:30:25 (13604): Status Report: Elapsed Time: '195697.000000'
2025-04-17 14:30:25 (13604): Status Report: CPU Time: '458604.375000'
2025-04-17 15:09:56 (13604): VM state change detected. (old = 'running', new = 'paused')
2025-04-17 15:10:16 (13604): VM state change detected. (old = 'paused', new = 'running')
2025-04-17 15:10:46 (13604): VM state change detected. (old = 'running', new = 'paused')
2025-04-17 15:11:06 (13604): VM state change detected. (old = 'paused', new = 'running')
2025-04-17 15:32:34 (13604): Guest Log:  *** Job finished ***
2025-04-17 15:32:34 (13604): Guest Log: Failed to produce a result! Shutting down the machine.
2025-04-17 15:32:34 (13604): Guest Log: ++ pwd
2025-04-17 15:32:34 (13604): Guest Log: + export RUNTIME_CONFIG_DIR=/home/atlas/RunAtlas/
2025-04-17 15:32:34 (13604): Guest Log: + RUNTIME_CONFIG_DIR=/home/atlas/RunAtlas/
2025-04-17 15:32:34 (13604): Guest Log: + mv ATLAS.root_0 EVNT.43427814._000003.pool.root.1
2025-04-17 15:32:34 (13604): Guest Log: + tar --strip-components=5 -xvf input.tar.gz
2025-04-17 15:32:34 (13604): Guest Log: + umask 077
2025-04-17 15:32:34 (13604): Guest Log: ++ date +%s
2025-04-17 15:32:34 (13604): Guest Log: + ACCOUNTING_STARTTIME=1744719867
2025-04-17 15:32:34 (13604): Guest Log: + echo 'Detecting resource accounting method available for the job.'
2025-04-17 15:32:34 (13604): Guest Log: Detecting resource accounting method available for the job.
2025-04-17 15:32:34 (13604): Guest Log: + JOB_ACCOUNTING=
2025-04-17 15:32:34 (13604): Guest Log: + command -v arc-job-cgroup
2025-04-17 15:32:34 (13604): Guest Log: + '[' -z '' ']'
2025-04-17 15:32:34 (13604): Guest Log: + GNU_TIME=/usr/bin/time
2025-04-17 15:32:34 (13604): Guest Log: + echo 'Looking for /usr/bin/time tool for accounting measurements'
2025-04-17 15:32:34 (13604): Guest Log: Looking for /usr/bin/time tool for accounting measurements
2025-04-17 15:32:34 (13604): Guest Log: + '[' '!' -z /usr/bin/time ']'
2025-04-17 15:32:34 (13604): Guest Log: + /usr/bin/time --version
2025-04-17 15:32:34 (13604): Guest Log: + echo 'GNU time found and will be used for job accounting.'
2025-04-17 15:32:34 (13604): Guest Log: GNU time found and will be used for job accounting.
2025-04-17 15:32:34 (13604): Guest Log: + JOB_ACCOUNTING=gnutime
2025-04-17 15:32:34 (13604): Guest Log: + '[' -z gnutime ']'
2025-04-17 15:32:34 (13604): Guest Log: + export PANDA_JSID=harvester-CERN_central_ACTA
2025-04-17 15:32:34 (13604): Guest Log: + PANDA_JSID=harvester-CERN_central_ACTA
2025-04-17 15:32:34 (13604): Guest Log: + export GTAG=http://aipanda403.cern.ch/data/jobs/2025-04-13/BOINC_MCORE/6601718204.out
2025-04-17 15:32:34 (13604): Guest Log: + GTAG=http://aipanda403.cern.ch/data/jobs/2025-04-13/BOINC_MCORE/6601718204.out
2025-04-17 15:32:34 (13604): Guest Log: + export PILOT_NOKILL=YES
2025-04-17 15:32:34 (13604): Guest Log: + PILOT_NOKILL=YES
2025-04-17 15:32:34 (13604): Guest Log: + export GRID_GLOBAL_JOBID=yppNDmNYAO7nsSi4ap6QjLDmwznN0nGgGQJmkKkKDmqmTLDmyr6zlm
2025-04-17 15:32:34 (13604): Guest Log: + GRID_GLOBAL_JOBID=yppNDmNYAO7nsSi4ap6QjLDmwznN0nGgGQJmkKkKDmqmTLDmyr6zlm
2025-04-17 15:32:34 (13604): Guest Log: + export GRID_GLOBAL_JOBURL=https://arc-boinc-01.cern.ch:443/arex/yppNDmNYAO7nsSi4ap6QjLDmwznN0nGgGQJmkKkKDmqmTLDmyr6zlm
2025-04-17 15:32:34 (13604): Guest Log: + GRID_GLOBAL_JOBURL=https://arc-boinc-01.cern.ch:443/arex/yppNDmNYAO7nsSi4ap6QjLDmwznN0nGgGQJmkKkKDmqmTLDmyr6zlm
2025-04-17 15:32:34 (13604): Guest Log: + export GRID_GLOBAL_JOBINTERFACE=org.nordugrid.arcrest
2025-04-17 15:32:34 (13604): Guest Log: + GRID_GLOBAL_JOBINTERFACE=org.nordugrid.arcrest
2025-04-17 15:32:34 (13604): Guest Log: + export GRID_GLOBAL_JOBHOST=arc-boinc-01.cern.ch
2025-04-17 15:32:34 (13604): Guest Log: + GRID_GLOBAL_JOBHOST=arc-boinc-01.cern.ch
2025-04-17 15:32:34 (13604): Guest Log: ++ pwd
2025-04-17 15:32:34 (13604): Guest Log: + RUNTIME_JOB_DIR=/home/atlas/RunAtlas
2025-04-17 15:32:34 (13604): Guest Log: + RUNTIME_JOB_STDIN=/dev/null
2025-04-17 15:32:34 (13604): Guest Log: ++ pwd
2025-04-17 15:32:34 (13604): Guest Log: + RUNTIME_JOB_STDOUT=/home/atlas/RunAtlas/log.43926719._000021.job.log.1
2025-04-17 15:32:34 (13604): Guest Log: ++ pwd
2025-04-17 15:32:34 (13604): Guest Log: + RUNTIME_JOB_STDERR=/home/atlas/RunAtlas/log.43926719._000021.job.log.1
2025-04-17 15:32:34 (13604): Guest Log: ++ pwd
2025-04-17 15:32:34 (13604): Guest Log: + RUNTIME_JOB_DIAG=/home/atlas/RunAtlas.diag
2025-04-17 15:32:34 (13604): Guest Log: + '[' '!' -z '' ']'
2025-04-17 15:32:34 (13604): Guest Log: + RUNTIME_LOCAL_SCRATCH_DIR=
2025-04-17 15:32:34 (13604): Guest Log: + RUNTIME_LOCAL_SCRATCH_MOVE_TOOL=mv
2025-04-17 15:32:34 (13604): Guest Log: + RUNTIME_FRONTEND_SEES_NODE=
2025-04-17 15:32:34 (13604): Guest Log: + RUNTIME_NODE_SEES_FRONTEND=yes
2025-04-17 15:32:34 (13604): Guest Log: + '[' '!' -z '' ']'
2025-04-17 15:32:34 (13604): Guest Log: + '[' -z yes ']'
2025-04-17 15:32:34 (13604): Guest Log: ++ pwd
2025-04-17 15:32:34 (13604): Guest Log: + RUNTIME_JOB_DIAG=/home/atlas/RunAtlas/yppNDmNYAO7nsSi4ap6QjLDmwznN0nGgGQJmkKkKDmqmTLDmyr6zlm.diag
2025-04-17 15:32:34 (13604): Guest Log: + runtimeenvironments=
2025-04-17 15:32:34 (13604): Guest Log: + runtimeenvironments='APPS/HEP/ATLAS-SITE;'
2025-04-17 15:32:34 (13604): Guest Log: + RTE_function_0 1
2025-04-17 15:32:34 (13604): Guest Log: + export PROJECT_ROOT=/boincdata/boinc/project/lhcathome
2025-04-17 15:32:34 (13604): Guest Log: + PROJECT_ROOT=/boincdata/boinc/project/lhcathome
2025-04-17 15:32:34 (13604): Guest Log: + export BOINC_APP=ATLAS
2025-04-17 15:32:34 (13604): Guest Log: + BOINC_APP=ATLAS
2025-04-17 15:32:34 (13604): Guest Log: + export WU_TEMPLATE=templates/ATLAS_IN_DYNAMIC
2025-04-17 15:32:34 (13604): Guest Log: + WU_TEMPLATE=templates/ATLAS_IN_DYNAMIC
2025-04-17 15:32:34 (13604): Guest Log: + export RESULT_TEMPLATE=templates/ATLAS_OUT_2
2025-04-17 15:32:34 (13604): Guest Log: + RESULT_TEMPLATE=templates/ATLAS_OUT_2
2025-04-17 15:32:34 (13604): Guest Log: + '[' -z 1 ']'
2025-04-17 15:32:34 (13604): Guest Log: + '[' 1 == 1 ']'
2025-04-17 15:32:34 (13604): Guest Log: + shift
2025-04-17 15:32:34 (13604): Guest Log: + FRONTIER_SQUID_NDGF='(proxyurl=http://db-atlas-squid.ndgf.org:3128)(proxyurl=http://squid.vega.izum.si:3128)(proxyurl=http://grid-proxy.ijs.si:3128)(proxyurl=http://atlas-db-squid1.grid.uiocloud.no:3128)'
2025-04-17 15:32:34 (13604): Guest Log: + FRONTIER_BACKUP='(backupproxyurl=http://atlasbpfrontier.cern.ch:3127)(backupproxyurl=http://atlasbpfrontier.fnal.gov:3127)'
2025-04-17 15:32:34 (13604): Guest Log: + FRONTIER_WPAD='(proxyconfigurl=http://grid-wpad/wpad.dat)'
2025-04-17 15:32:34 (13604): Guest Log: + export ATLAS_LOCAL_AREA=/home/atlas/RunAtlas/
2025-04-17 15:32:34 (13604): Guest Log: + ATLAS_LOCAL_AREA=/home/atlas/RunAtlas/
2025-04-17 15:32:34 (13604): Guest Log: + '[' -e /home/atlas/RunAtlas/init_data.xml ']'
2025-04-17 15:32:34 (13604): Guest Log: + grep '<use_http_proxy/>' /home/atlas/RunAtlas/init_data.xml
2025-04-17 15:32:34 (13604): Guest Log: + '[' -e /home/atlas/RunAtlas/init_data.xml ']'
2025-04-17 15:32:34 (13604): Guest Log: + grep '.cern.ch</domain_name>' /home/atlas/RunAtlas/init_data.xml
2025-04-17 15:32:34 (13604): Guest Log: + FRONTIER_SERVER_URLS='(serverurl=http://atlascern-frontier.openhtc.io:8080/atlr)(serverurl=http://atlasfrontier-ai.cern.ch:8000/atlr)'
2025-04-17 15:32:34 (13604): Guest Log: + FRONTIER_PROXY_URLS='(proxyurl=http://db-atlas-squid.ndgf.org:3128)(proxyurl=http://squid.vega.izum.si:3128)(proxyurl=http://grid-proxy.ijs.si:3128)(proxyurl=http://atlas-db-squid1.grid.uiocloud.no:3128)(backupproxyurl=http://atlasbpfrontier.cern.ch:3127)(backupproxyurl=http://atlasbpfrontier.fnal.gov:3127)'
2025-04-17 15:32:34 (13604): Guest Log: + echo 'export FRONTIER_SERVER="(serverurl=http://atlascern-frontier.openhtc.io:8080/atlr)(serverurl=http://atlasfrontier-ai.cern.ch:8000/atlr)(proxyurl=http://db-atlas-squid.ndgf.org:3128)(proxyurl=http://squid.vega.izum.si:3128)(proxyurl=http://grid-proxy.ijs.si:3128)(proxyurl=http://atlas-db-squid1.grid.uiocloud.no:3128)(backupproxyurl=http://atlasbpfrontier.cern.ch:3127)(backupproxyurl=http://atlasbpfrontier.fnal.gov:3127)"'
2025-04-17 15:32:34 (13604): Guest Log: + export 'FRONTIER_SERVER=(serverurl=http://atlascern-frontier.openhtc.io:8080/atlr)(serverurl=http://atlasfrontier-ai.cern.ch:8000/atlr)(proxyurl=http://db-atlas-squid.ndgf.org:3128)(proxyurl=http://squid.vega.izum.si:3128)(proxyurl=http://grid-proxy.ijs.si:3128)(proxyurl=http://atlas-db-squid1.grid.uiocloud.no:3128)(backupproxyurl=http://atlasbpfrontier.cern.ch:3127)(backupproxyurl=http://atlasbpfrontier.fnal.gov:3127)'
2025-04-17 15:32:34 (13604): Guest Log: + FRONTIER_SERVER='(serverurl=http://atlascern-frontier.openhtc.io:8080/atlr)(serverurl=http://atlasfrontier-ai.cern.ch:8000/atlr)(proxyurl=http://db-atlas-squid.ndgf.org:3128)(proxyurl=http://squid.vega.izum.si:3128)(proxyurl=http://grid-proxy.ijs.si:3128)(proxyurl=http://atlas-db-squid1.grid.uiocloud.no:3128)(backupproxyurl=http://atlasbpfrontier.cern.ch:3127)(backupproxyurl=http://atlasbpfrontier.fnal.gov:3127)'
2025-04-17 15:32:34 (13604): Guest Log: + '[' 0 -ne 0 ']'
2025-04-17 15:32:34 (13604): Guest Log: + echo 'runtimeenvironments=APPS/HEP/ATLAS-SITE;'
2025-04-17 15:32:34 (13604): Guest Log: + '[' -f /etc/os-release ']'
2025-04-17 15:32:34 (13604): Guest Log: +++ cat /etc/os-release
2025-04-17 15:32:34 (13604): Guest Log: ++ eval 'NAME="CentOS' 'Linux"' 'VERSION="7' '(Core)"' 'ID="centos"' 'ID_LIKE="rhel' 'fedora"' 'VERSION_ID="7"' 'PRETTY_NAME="CentOS' Linux 7 '(Core)"' 'ANSI_COLOR="0;31"' 'CPE_NAME="cpe:/o:centos:centos:7"' 'HOME_URL="https://www.centos.org/"' 'BUG_REPORT_URL="https://bugs.centos.org/"' 'CENTOS_MANTISBT_PROJECT="CentOS-7"' 'CENTOS_MANTISBT_PROJECT_VERSION="7"' 'REDHAT_SUPPORT_PRODUCT="centos"' 'REDHAT_SUPPORT_PRODUCT_VERSION="7"'
2025-04-17 15:32:34 (13604): Guest Log: +++ NAME='CentOS Linux'
2025-04-17 15:32:34 (13604): Guest Log: +++ VERSION='7 (Core)'
2025-04-17 15:32:34 (13604): Guest Log: +++ ID=centos
2025-04-17 15:32:34 (13604): Guest Log: +++ ID_LIKE='rhel fedora'
2025-04-17 15:32:34 (13604): Guest Log: +++ VERSION_ID=7
2025-04-17 15:32:34 (13604): Guest Log: +++ PRETTY_NAME='CentOS Linux 7 (Core)'
2025-04-17 15:32:34 (13604): Guest Log: +++ ANSI_COLOR='0;31'
2025-04-17 15:32:34 (13604): Guest Log: +++ CPE_NAME=cpe:/o:centos:centos:7
2025-04-17 15:32:34 (13604): Guest Log: +++ HOME_URL=https://www.centos.org/
2025-04-17 15:32:34 (13604): Guest Log: +++ BUG_REPORT_URL=https://bugs.centos.org/
2025-04-17 15:32:34 (13604): Guest Log: +++ CENTOS_MANTISBT_PROJECT=CentOS-7
2025-04-17 15:32:34 (13604): Guest Log: +++ CENTOS_MANTISBT_PROJECT_VERSION=7
2025-04-17 15:32:34 (13604): Guest Log: +++ REDHAT_SUPPORT_PRODUCT=centos
2025-04-17 15:32:34 (13604): Guest Log: +++ REDHAT_SUPPORT_PRODUCT_VERSION=7
2025-04-17 15:32:34 (13604): Guest Log: ++ echo 'CentOS Linux 7 (Core)'
2025-04-17 15:32:34 (13604): Guest Log: + SYSTEM_SOFTWARE='CentOS Linux 7 (Core)'
2025-04-17 15:32:34 (13604): Guest Log: + '[' -n 'CentOS Linux 7 (Core)' ']'
2025-04-17 15:32:34 (13604): Guest Log: + echo 'systemsoftware=CentOS Linux 7 (Core)'
2025-04-17 15:32:34 (13604): Guest Log: + HOME=/home/atlas/RunAtlas
2025-04-17 15:32:34 (13604): Guest Log: + export HOME
2025-04-17 15:32:34 (13604): Guest Log: + cd /home/atlas/RunAtlas
2025-04-17 15:32:34 (13604): Guest Log: + '[' '!' -z '' ']'
2025-04-17 15:32:34 (13604): Guest Log: + '[' -z '' ']'
2025-04-17 15:32:34 (13604): Guest Log: ++ /bin/hostname -f
2025-04-17 15:32:34 (13604): Guest Log: + nodename=localhost
2025-04-17 15:32:34 (13604): Guest Log: + echo nodename=localhost
2025-04-17 15:32:34 (13604): Guest Log: + echo Processors=2
2025-04-17 15:32:34 (13604): Guest Log: + echo Nodecount=1
2025-04-17 15:32:34 (13604): Guest Log: + echo Benchmark=HEPSPEC:1.0
2025-04-17 15:32:34 (13604): Guest Log: + executable=./runpilot2-wrapper.sh
2025-04-17 15:32:34 (13604): Guest Log: + '[' '!' -f ./runpilot2-wrapper.sh ']'
2025-04-17 15:32:34 (13604): Guest Log: ++ dd if=./runpilot2-wrapper.sh count=1
2025-04-17 15:32:34 (13604): Guest Log: ++ head -n 1
2025-04-17 15:32:34 (13604): Guest Log: ++ tr -d '\0'
2025-04-17 15:32:34 (13604): Guest Log: + line1='#!/bin/bash'
2025-04-17 15:32:34 (13604): Guest Log: ++ echo '#!/bin/bash'
2025-04-17 15:32:34 (13604): Guest Log: ++ sed -n 's/^#! *//p'
2025-04-17 15:32:34 (13604): Guest Log: + shebang=/bin/bash
2025-04-17 15:32:34 (13604): Guest Log: ++ echo /bin/bash
2025-04-17 15:32:34 (13604): Guest Log: ++ awk '{print $1}'
2025-04-17 15:32:34 (13604): Guest Log: + interpreter=/bin/bash
2025-04-17 15:32:34 (13604): Guest Log: + '[' /bin/bash = /usr/bin/env ']'
2025-04-17 15:32:34 (13604): Guest Log: + '[' x/bin/bash = x ']'
2025-04-17 15:32:34 (13604): Guest Log: + type /bin/bash
2025-04-17 15:32:34 (13604): Guest Log: + '[' xgnutime = xgnutime ']'
2025-04-17 15:32:34 (13604): Guest Log: + /usr/bin/time -o /home/atlas/RunAtlas/yppNDmNYAO7nsSi4ap6QjLDmwznN0nGgGQJmkKkKDmqmTLDmyr6zlm.diag -a -f 'WallTime=%es\nKernelTime=%Ss\nUserTime=%Us\nCPUUsage=%P\nMaxResidentMemory=%MkB\nAverageResidentMemory=%tkB\nAverageTotalMemory=%KkB\nAverageUnsharedMemory=%DkB\nAverageUnsharedStack=%pkB\nAverageSharedMemory=%XkB\nPageSize=%ZB\nMajorPageFaults=%F\nMinorPageFaults=%R\nSwaps=%W\nForcedSwitches=%c\nWaitSwitches=%w\nInputs=%I\nOutputs=%O\nSocketReceived=%r\nSocketSent=%s\nSignals=%k\n' ./runpilot2-wrappe
2025-04-17 15:32:34 (13604): Guest Log: r.sh -q BOINC_MCORE -j managed --pilot-user ATLAS --harvester-submit-mode PUSH -w generic --job-type managed --resource-type MCORE --pilotversion 3.10.2.2 -z -t --piloturl local --mute --container
2025-04-17 15:32:34 (13604): Guest Log: + RESULT=81
2025-04-17 15:32:34 (13604): Guest Log: + sed -i -e /nodename=/d /home/atlas/RunAtlas/yppNDmNYAO7nsSi4ap6QjLDmwznN0nGgGQJmkKkKDmqmTLDmyr6zlm.diag
2025-04-17 15:32:34 (13604): Guest Log: ++ grep domain_name init_data.xml
2025-04-17 15:32:34 (13604): Guest Log: ++ awk -F '>' '{print $2}'
2025-04-17 15:32:34 (13604): Guest Log: ++ awk -F '<' '{print $1}'
2025-04-17 15:32:34 (13604): Guest Log: ++ sed -e 's# #_#g'
2025-04-17 15:32:34 (13604): Guest Log: + hostname=Home-WIN-PC
2025-04-17 15:32:34 (13604): Guest Log: ++ grep user_name init_data.xml
2025-04-17 15:32:34 (13604): Guest Log: ++ awk -F '>' '{print $2}'
2025-04-17 15:32:34 (13604): Guest Log: ++ awk -F '<' '{print $1}'
2025-04-17 15:32:34 (13604): Guest Log: ++ sed -e 's# #_#g'
2025-04-17 15:32:34 (13604): Guest Log: + username=SalaS
2025-04-17 15:32:34 (13604): Guest Log: + nodename=SalaS@Home-WIN-PC
2025-04-17 15:32:34 (13604): Guest Log: + echo nodename=SalaS@Home-WIN-PC
2025-04-17 15:32:34 (13604): Guest Log: + '[' -n 4 ']'
2025-04-17 15:32:34 (13604): Guest Log: + sed -i -e s/Processors=1/Processors=4/ /home/atlas/RunAtlas/yppNDmNYAO7nsSi4ap6QjLDmwznN0nGgGQJmkKkKDmqmTLDmyr6zlm.diag
2025-04-17 15:32:34 (13604): Guest Log: + echo exitcode=81
2025-04-17 15:32:34 (13604): Guest Log: + runtimeenvironments=
2025-04-17 15:32:34 (13604): Guest Log: + runtimeenvironments='APPS/HEP/ATLAS-SITE;'
2025-04-17 15:32:34 (13604): Guest Log: + RTE_function_0 2
2025-04-17 15:32:34 (13604): Guest Log: + export PROJECT_ROOT=/boincdata/boinc/project/lhcathome
2025-04-17 15:32:34 (13604): Guest Log: + PROJECT_ROOT=/boincdata/boinc/project/lhcathome
2025-04-17 15:32:34 (13604): Guest Log: + export BOINC_APP=ATLAS
2025-04-17 15:32:34 (13604): Guest Log: + BOINC_APP=ATLAS
2025-04-17 15:32:34 (13604): Guest Log: + export WU_TEMPLATE=templates/ATLAS_IN_DYNAMIC
2025-04-17 15:32:34 (13604): Guest Log: + WU_TEMPLATE=templates/ATLAS_IN_DYNAMIC
2025-04-17 15:32:34 (13604): Guest Log: + export RESULT_TEMPLATE=templates/ATLAS_OUT_2
2025-04-17 15:32:34 (13604): Guest Log: + RESULT_TEMPLATE=templates/ATLAS_OUT_2
2025-04-17 15:32:35 (13604): Guest Log: + '[' -z 2 ']'
2025-04-17 15:32:35 (13604): Guest Log: + '[' 2 == 1 ']'
2025-04-17 15:32:35 (13604): Guest Log: + '[' 0 -ne 0 ']'
2025-04-17 15:32:35 (13604): Guest Log: + echo 'zip all output files'
2025-04-17 15:32:35 (13604): Guest Log: + flist='*.diag '
2025-04-17 15:32:35 (13604): Guest Log: + for f in ./heartbeat.json ./output.list ./log.43926719._000021.job.log.1 ./log.43926719._000021.job.log.1 ./gmlog/
2025-04-17 15:32:35 (13604): Guest Log: + '[' -e ./heartbeat.json ']'
2025-04-17 15:32:35 (13604): Guest Log: + flist='*.diag  ./heartbeat.json'
2025-04-17 15:32:35 (13604): Guest Log: + for f in ./heartbeat.json ./output.list ./log.43926719._000021.job.log.1 ./log.43926719._000021.job.log.1 ./gmlog/
2025-04-17 15:32:35 (13604): Guest Log: + '[' -e ./output.list ']'
2025-04-17 15:32:35 (13604): Guest Log: + for f in ./heartbeat.json ./output.list ./log.43926719._000021.job.log.1 ./log.43926719._000021.job.log.1 ./gmlog/
2025-04-17 15:32:35 (13604): Guest Log: + '[' -e ./log.43926719._000021.job.log.1 ']'
2025-04-17 15:32:35 (13604): Guest Log: + flist='*.diag  ./heartbeat.json ./log.43926719._000021.job.log.1'
2025-04-17 15:32:35 (13604): Guest Log: + for f in ./heartbeat.json ./output.list ./log.43926719._000021.job.log.1 ./log.43926719._000021.job.log.1 ./gmlog/
2025-04-17 15:32:35 (13604): Guest Log: + '[' -e ./log.43926719._000021.job.log.1 ']'
2025-04-17 15:32:35 (13604): Guest Log: + flist='*.diag  ./heartbeat.json ./log.43926719._000021.job.log.1 ./log.43926719._000021.job.log.1'
2025-04-17 15:32:35 (13604): Guest Log: + for f in ./heartbeat.json ./output.list ./log.43926719._000021.job.log.1 ./log.43926719._000021.job.log.1 ./gmlog/
2025-04-17 15:32:35 (13604): Guest Log: + '[' -e ./gmlog/ ']'
2025-04-17 15:32:35 (13604): Guest Log: + '[' -f output.list ']'
2025-04-17 15:32:35 (13604): Guest Log: + tar cvf result.tar.gz yppNDmNYAO7nsSi4ap6QjLDmwznN0nGgGQJmkKkKDmqmTLDmyr6zlm.diag ./heartbeat.json ./log.43926719._000021.job.log.1 ./log.43926719._000021.job.log.1
2025-04-17 15:32:35 (13604): Guest Log: start_atlas.sh: line 298: /usr/bin/tar: Input/output error
2025-04-17 15:32:35 (13604): Guest Log: + '[' xgnutime = xcgroup ']'
2025-04-17 15:32:35 (13604): Guest Log: + '[' -n '' ']'
2025-04-17 15:32:35 (13604): Guest Log: + '[' -n '' ']'
2025-04-17 15:32:35 (13604): Guest Log: ++ date +%s
2025-04-17 15:32:35 (13604): Guest Log: + ACCOUNTING_ENDTIME=1744892900
2025-04-17 15:32:35 (13604): Guest Log: ++ date -d '1970-01-01 UTC 1744719867 seconds' +%Y%m%d%H%M%SZ
2025-04-17 15:32:35 (13604): Guest Log: + echo LRMSStartTime=20250415122427Z
2025-04-17 15:32:35 (13604): Guest Log: ++ date -d '1970-01-01 UTC 1744892900 seconds' +%Y%m%d%H%M%SZ
2025-04-17 15:32:35 (13604): Guest Log: + echo LRMSEndTime=20250417122820Z
2025-04-17 15:32:35 (13604): Guest Log: + echo walltime=173033
2025-04-17 15:32:35 (13604): Guest Log: + echo exitcode=81
2025-04-17 15:32:35 (13604): Guest Log: + exit 81
2025-04-17 15:32:35 (13604): Guest Log: boincdata/boinc/ATLAS/session/yppNDmNYAO7nsSi4ap6QjLDmwznN0nGgGQJmkKkKDmqmTLDmyr6zlm/pandaJobData.out
2025-04-17 15:32:35 (13604): Guest Log: boincdata/boinc/ATLAS/session/yppNDmNYAO7nsSi4ap6QjLDmwznN0nGgGQJmkKkKDmqmTLDmyr6zlm/pilot3.tar.gz
2025-04-17 15:32:35 (13604): Guest Log: boincdata/boinc/ATLAS/session/yppNDmNYAO7nsSi4ap6QjLDmwznN0nGgGQJmkKkKDmqmTLDmyr6zlm/queuedata.json
2025-04-17 15:32:35 (13604): Guest Log: boincdata/boinc/ATLAS/session/yppNDmNYAO7nsSi4ap6QjLDmwznN0nGgGQJmkKkKDmqmTLDmyr6zlm/runpilot2-wrapper.sh
2025-04-17 15:32:35 (13604): Guest Log: zip all output files
2025-04-17 15:35:55 (13604): Guest Log: 27:17:23.830284 control  Session 0 is about to close ...
2025-04-17 15:35:55 (13604): Guest Log: 27:17:23.830382 control  Stopping all guest processes ...
2025-04-17 15:35:55 (13604): Guest Log: 27:17:23.830435 control  Closing all guest files ...
2025-04-17 15:35:55 (13604): Guest Log: 27:17:23.830490 control  Guest control service stopped
2025-04-17 15:35:55 (13604): Guest Log: 27:17:23.830554 control  Guest control worker returned with rc=VINF_SUCCESS
2025-04-17 15:35:55

©2025 CERN