Name | 0aQMDmD2FQ8nsSi4ap6QjLDmwznN0nGgGQJmUXzaDmiEWNDmMr741n_0 |
Workunit | 235577963 |
Created | 7 Oct 2025, 6:07:24 UTC |
Sent | 7 Oct 2025, 8:28:43 UTC |
Report deadline | 15 Oct 2025, 8:28:43 UTC |
Received | 7 Oct 2025, 23:03:38 UTC |
Server state | Over |
Outcome | Success |
Client state | Done |
Exit status | 0 (0x00000000) |
Computer ID | 10842387 |
Run time | 4 hours 55 min 26 sec |
CPU time | 8 hours 42 min 16 sec |
Validate state | Valid |
Credit | 287.88 |
Device peak FLOPS | 23.15 GFLOPS |
Application version | ATLAS Simulation v3.03 (vbox64_mt_mcore_atlas) windows_x86_64 |
Peak working set size | 75.61 MB |
Peak swap size | 88.73 MB |
Peak disk usage | 1.58 GB |
<core_client_version>8.2.4</core_client_version> <![CDATA[ <stderr_txt> pped device for ELDL=84 2025-10-07 17:31:29 (5548): Guest Log: int13_harddisk: function 02, unmapped device for ELDL=84 2025-10-07 17:31:29 (5548): Guest Log: int13_harddisk_ext: function 41, unmapped device for ELDL=85 2025-10-07 17:31:29 (5548): Guest Log: int13_harddisk: function 02, unmapped device for ELDL=85 2025-10-07 17:31:29 (5548): Guest Log: int13_harddisk_ext: function 41, unmapped device for ELDL=86 2025-10-07 17:31:29 (5548): Guest Log: int13_harddisk: function 02, unmapped device for ELDL=86 2025-10-07 17:31:29 (5548): Guest Log: int13_harddisk_ext: function 41, unmapped device for ELDL=87 2025-10-07 17:31:29 (5548): Guest Log: int13_harddisk: function 02, unmapped device for ELDL=87 2025-10-07 17:31:29 (5548): Guest Log: int13_harddisk_ext: function 41, unmapped device for ELDL=88 2025-10-07 17:31:29 (5548): Guest Log: int13_harddisk: function 02, unmapped device for ELDL=88 2025-10-07 17:31:29 (5548): Guest Log: int13_harddisk_ext: function 41, unmapped device for ELDL=89 2025-10-07 17:31:29 (5548): Guest Log: int13_harddisk: function 02, unmapped device for ELDL=89 2025-10-07 17:31:29 (5548): Guest Log: int13_harddisk_ext: function 41, unmapped device for ELDL=8a 2025-10-07 17:31:29 (5548): Guest Log: int13_harddisk: function 02, unmapped device for ELDL=8a 2025-10-07 17:31:29 (5548): Guest Log: int13_harddisk_ext: function 41, unmapped device for ELDL=8b 2025-10-07 17:31:29 (5548): Guest Log: int13_harddisk: function 02, unmapped device for ELDL=8b 2025-10-07 17:31:29 (5548): Guest Log: int13_harddisk_ext: function 41, unmapped device for ELDL=8c 2025-10-07 17:31:29 (5548): Guest Log: int13_harddisk: function 02, unmapped device for ELDL=8c 2025-10-07 17:31:29 (5548): Guest Log: int13_harddisk_ext: function 41, unmapped device for ELDL=8d 2025-10-07 17:31:29 (5548): Guest Log: int13_harddisk: function 02, unmapped device for ELDL=8d 2025-10-07 17:31:29 (5548): Guest Log: int13_harddisk_ext: function 41, unmapped device for ELDL=8e 2025-10-07 17:31:29 (5548): Guest Log: int13_harddisk: function 02, unmapped device for ELDL=8e 2025-10-07 17:31:29 (5548): Guest Log: int13_harddisk_ext: function 41, unmapped device for ELDL=8f 2025-10-07 17:31:29 (5548): Guest Log: int13_harddisk: function 02, unmapped device for ELDL=8f 2025-10-07 17:31:42 (5548): Guest Log: vgdrvHeartbeatInit: Setting up heartbeat to trigger every 2000 milliseconds 2025-10-07 17:31:42 (5548): Guest Log: vboxguest: misc device minor 58, IRQ 20, I/O port d020, MMIO at 00000000f0400000 (size 0x400000) 2025-10-07 17:32:31 (5548): Guest Log: VBoxService 5.2.32 r132073 (verbosity: 0) linux.amd64 (Jul 12 2019 10:32:28) release log 2025-10-07 17:32:31 (5548): Guest Log: 00:00:00.000573 main Log opened 2025-10-07T17:32:29.423130000Z 2025-10-07 17:32:31 (5548): Guest Log: 00:00:00.000801 main OS Product: Linux 2025-10-07 17:32:31 (5548): Guest Log: 00:00:00.000899 main OS Release: 3.10.0-957.27.2.el7.x86_64 2025-10-07 17:32:31 (5548): Guest Log: 00:00:00.000986 main OS Version: #1 SMP Mon Jul 29 17:46:05 UTC 2019 2025-10-07 17:32:31 (5548): Guest Log: 00:00:00.001074 main Executable: /opt/VBoxGuestAdditions-5.2.32/sbin/VBoxService 2025-10-07 17:32:31 (5548): Guest Log: 00:00:00.001078 main Process ID: 1337 2025-10-07 17:32:31 (5548): Guest Log: 00:00:00.001081 main Package type: LINUX_64BITS_GENERIC 2025-10-07 17:32:31 (5548): Guest Log: 00:00:00.005921 main 5.2.32 r132073 started. Verbose level = 0 2025-10-07 17:32:31 (5548): Guest Log: [INFO] Probing /cvmfs/atlas.cern.ch... 2025-10-07 17:32:31 (5548): Guest Log: [INFO] Mounting shared directory 2025-10-07 17:32:31 (5548): Guest Log: [INFO] Checking for init_data.xml 2025-10-07 17:32:41 (5548): Guest Log: 00:00:10.015816 timesync vgsvcTimeSyncWorker: Radical guest time change: -3 588 390 467 000ns (GuestNow=1 759 854 761 043 381 000 ns GuestLast=1 759 858 349 433 848 000 ns fSetTimeLastLoop=true ) 2025-10-07 17:33:45 (5548): VM state change detected. (old = 'running', new = 'paused') 2025-10-07 17:34:06 (5548): VM state change detected. (old = 'paused', new = 'running') 2025-10-07 17:34:48 (5548): Guest Log: [INFO] Probing /cvmfs/atlas.cern.ch... OK 2025-10-07 17:34:48 (5548): Guest Log: [INFO] Detected branch: prod 2025-10-07 17:34:48 (5548): Guest Log: This is the prod version of the ATLAS job wrapper 2025-10-07 17:34:48 (5548): Guest Log: Copying input files 2025-10-07 17:34:49 (5548): Guest Log: Copied input files into RunAtlas. 2025-10-07 17:34:50 (5548): Guest Log: This VM did not configure a local http proxy via BOINC. 2025-10-07 17:34:50 (5548): Guest Log: Small home clusters do not require a local http proxy but it is suggested if 2025-10-07 17:34:50 (5548): Guest Log: more than 10 cores throughout the same LAN segment are regularly running ATLAS like tasks. 2025-10-07 17:34:50 (5548): Guest Log: Further information can be found at the LHC@home message board. 2025-10-07 17:36:58 (5548): Guest Log: Running cvmfs_config stat atlas.cern.ch 2025-10-07 17:36:59 (5548): 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-10-07 17:36:59 (5548): Guest Log: 2.6.3.0 1642 3 32188 151441 3 1 3117639 4096000 0 65024 0 0 n/a 0 0 http://s1cern-cvmfs.openhtc.io/cvmfs/atlas.cern.ch DIRECT 1 2025-10-07 17:37:02 (5548): Guest Log: copied the webapp to /var/www 2025-10-07 17:37:02 (5548): Guest Log: ATHENA_PROC_NUMBER=4 2025-10-07 17:37:02 (5548): Guest Log: ATHENA_CORE_NUMBER=4 2025-10-07 17:37:03 (5548): 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-10-07 17:37:03 (5548): Guest Log: *** Starting ATLAS job. (PandaID=6833170310 taskID=46376905) *** 2025-10-07 17:57:47 (5548): VM state change detected. (old = 'running', new = 'paused') 2025-10-07 17:58:07 (5548): VM state change detected. (old = 'paused', new = 'running') 2025-10-07 17:59:37 (5548): VM state change detected. (old = 'running', new = 'paused') 2025-10-07 17:59:38 (5548): VM state change detected. (old = 'paused', new = 'running') 2025-10-07 18:00:48 (5548): VM state change detected. (old = 'running', new = 'paused') 2025-10-07 18:01:08 (5548): VM state change detected. (old = 'paused', new = 'running') 2025-10-07 18:04:58 (5548): VM state change detected. (old = 'running', new = 'paused') 2025-10-07 18:05:18 (5548): VM state change detected. (old = 'paused', new = 'running') 2025-10-07 18:07:08 (5548): VM state change detected. (old = 'running', new = 'paused') 2025-10-07 18:07:28 (5548): VM state change detected. (old = 'paused', new = 'running') 2025-10-07 18:07:38 (5548): VM state change detected. (old = 'running', new = 'paused') 2025-10-07 18:07:58 (5548): VM state change detected. (old = 'paused', new = 'running') 2025-10-07 18:10:18 (5548): VM state change detected. (old = 'running', new = 'paused') 2025-10-07 18:10:38 (5548): VM state change detected. (old = 'paused', new = 'running') 2025-10-07 18:10:48 (5548): VM state change detected. (old = 'running', new = 'paused') 2025-10-07 18:11:08 (5548): VM state change detected. (old = 'paused', new = 'running') 2025-10-07 18:11:18 (5548): VM state change detected. (old = 'running', new = 'paused') 2025-10-07 18:11:38 (5548): VM state change detected. (old = 'paused', new = 'running') 2025-10-07 18:11:48 (5548): VM state change detected. (old = 'running', new = 'paused') 2025-10-07 18:12:08 (5548): VM state change detected. (old = 'paused', new = 'running') 2025-10-07 18:12:48 (5548): VM state change detected. (old = 'running', new = 'paused') 2025-10-07 18:13:08 (5548): VM state change detected. (old = 'paused', new = 'running') 2025-10-07 18:13:18 (5548): VM state change detected. (old = 'running', new = 'paused') 2025-10-07 18:13:38 (5548): VM state change detected. (old = 'paused', new = 'running') 2025-10-07 18:13:48 (5548): VM state change detected. (old = 'running', new = 'paused') 2025-10-07 18:14:08 (5548): VM state change detected. (old = 'paused', new = 'running') 2025-10-07 18:14:58 (5548): VM state change detected. (old = 'running', new = 'paused') 2025-10-07 18:15:18 (5548): VM state change detected. (old = 'paused', new = 'running') 2025-10-07 18:16:28 (5548): VM state change detected. (old = 'running', new = 'paused') 2025-10-07 18:16:48 (5548): VM state change detected. (old = 'paused', new = 'running') 2025-10-07 18:17:08 (5548): VM state change detected. (old = 'running', new = 'paused') 2025-10-07 18:17:28 (5548): VM state change detected. (old = 'paused', new = 'running') 2025-10-07 18:20:08 (5548): VM state change detected. (old = 'running', new = 'paused') 2025-10-07 18:20:28 (5548): VM state change detected. (old = 'paused', new = 'running') 2025-10-07 18:20:38 (5548): VM state change detected. (old = 'running', new = 'paused') 2025-10-07 18:20:58 (5548): VM state change detected. (old = 'paused', new = 'running') 2025-10-07 18:23:08 (5548): VM state change detected. (old = 'running', new = 'paused') 2025-10-07 18:23:28 (5548): VM state change detected. (old = 'paused', new = 'running') 2025-10-07 18:24:28 (5548): VM state change detected. (old = 'running', new = 'paused') 2025-10-07 18:24:48 (5548): VM state change detected. (old = 'paused', new = 'running') 2025-10-07 18:24:58 (5548): VM state change detected. (old = 'running', new = 'paused') 2025-10-07 18:25:18 (5548): VM state change detected. (old = 'paused', new = 'running') 2025-10-07 18:25:28 (5548): VM state change detected. (old = 'running', new = 'paused') 2025-10-07 18:25:48 (5548): VM state change detected. (old = 'paused', new = 'running') 2025-10-07 18:27:18 (5548): VM state change detected. (old = 'running', new = 'paused') 2025-10-07 18:27:38 (5548): VM state change detected. (old = 'paused', new = 'running') 2025-10-07 18:27:48 (5548): VM state change detected. (old = 'running', new = 'paused') 2025-10-07 18:28:08 (5548): VM state change detected. (old = 'paused', new = 'running') 2025-10-07 18:28:29 (5548): VM state change detected. (old = 'running', new = 'paused') 2025-10-07 18:28:48 (5548): VM state change detected. (old = 'paused', new = 'running') 2025-10-07 18:28:58 (5548): VM state change detected. (old = 'running', new = 'paused') 2025-10-07 18:29:19 (5548): VM state change detected. (old = 'paused', new = 'running') 2025-10-07 18:29:59 (5548): VM state change detected. (old = 'running', new = 'paused') 2025-10-07 18:30:18 (5548): VM state change detected. (old = 'paused', new = 'running') 2025-10-07 18:32:09 (5548): VM state change detected. (old = 'running', new = 'paused') 2025-10-07 18:32:29 (5548): VM state change detected. (old = 'paused', new = 'running') 2025-10-07 18:32:40 (5548): VM state change detected. (old = 'running', new = 'paused') 2025-10-07 18:33:00 (5548): VM state change detected. (old = 'paused', new = 'running') 2025-10-07 18:34:10 (5548): VM state change detected. (old = 'running', new = 'paused') 2025-10-07 18:34:30 (5548): VM state change detected. (old = 'paused', new = 'running') 2025-10-07 18:35:10 (5548): VM state change detected. (old = 'running', new = 'paused') 2025-10-07 18:35:30 (5548): VM state change detected. (old = 'paused', new = 'running') 2025-10-07 18:35:50 (5548): VM state change detected. (old = 'running', new = 'paused') 2025-10-07 18:36:10 (5548): VM state change detected. (old = 'paused', new = 'running') 2025-10-07 18:38:10 (5548): VM state change detected. (old = 'running', new = 'paused') 2025-10-07 18:38:30 (5548): VM state change detected. (old = 'paused', new = 'running') 2025-10-07 18:39:00 (5548): VM state change detected. (old = 'running', new = 'paused') 2025-10-07 18:39:20 (5548): VM state change detected. (old = 'paused', new = 'running') 2025-10-07 18:39:40 (5548): VM state change detected. (old = 'running', new = 'paused') 2025-10-07 18:40:00 (5548): VM state change detected. (old = 'paused', new = 'running') 2025-10-07 18:40:20 (5548): VM state change detected. (old = 'running', new = 'paused') 2025-10-07 18:40:40 (5548): VM state change detected. (old = 'paused', new = 'running') 2025-10-07 18:41:00 (5548): VM state change detected. (old = 'running', new = 'paused') 2025-10-07 18:41:20 (5548): VM state change detected. (old = 'paused', new = 'running') 2025-10-07 18:43:10 (5548): VM state change detected. (old = 'running', new = 'paused') 2025-10-07 18:43:30 (5548): VM state change detected. (old = 'paused', new = 'running') 2025-10-07 18:43:50 (5548): VM state change detected. (old = 'running', new = 'paused') 2025-10-07 18:44:10 (5548): VM state change detected. (old = 'paused', new = 'running') 2025-10-07 18:44:30 (5548): VM state change detected. (old = 'running', new = 'paused') 2025-10-07 18:44:50 (5548): VM state change detected. (old = 'paused', new = 'running') 2025-10-07 18:45:40 (5548): VM state change detected. (old = 'running', new = 'paused') 2025-10-07 18:46:00 (5548): VM state change detected. (old = 'paused', new = 'running') 2025-10-07 18:46:30 (5548): VM state change detected. (old = 'running', new = 'paused') 2025-10-07 18:46:50 (5548): VM state change detected. (old = 'paused', new = 'running') 2025-10-07 18:48:10 (5548): VM state change detected. (old = 'running', new = 'paused') 2025-10-07 18:48:30 (5548): VM state change detected. (old = 'paused', new = 'running') 2025-10-07 18:48:40 (5548): VM state change detected. (old = 'running', new = 'paused') 2025-10-07 18:49:00 (5548): VM state change detected. (old = 'paused', new = 'running') 2025-10-07 18:49:20 (5548): VM state change detected. (old = 'running', new = 'paused') 2025-10-07 18:49:40 (5548): VM state change detected. (old = 'paused', new = 'running') 2025-10-07 18:50:00 (5548): VM state change detected. (old = 'running', new = 'paused') 2025-10-07 18:50:20 (5548): VM state change detected. (old = 'paused', new = 'running') 2025-10-07 18:50:40 (5548): VM state change detected. (old = 'running', new = 'paused') 2025-10-07 18:51:00 (5548): VM state change detected. (old = 'paused', new = 'running') 2025-10-07 18:51:20 (5548): VM state change detected. (old = 'running', new = 'paused') 2025-10-07 18:51:40 (5548): VM state change detected. (old = 'paused', new = 'running') 2025-10-07 18:51:50 (5548): VM state change detected. (old = 'running', new = 'paused') 2025-10-07 18:52:10 (5548): VM state change detected. (old = 'paused', new = 'running') 2025-10-07 18:52:20 (5548): VM state change detected. (old = 'running', new = 'paused') 2025-10-07 18:52:40 (5548): VM state change detected. (old = 'paused', new = 'running') 2025-10-07 18:55:00 (5548): VM state change detected. (old = 'running', new = 'paused') 2025-10-07 18:55:20 (5548): VM state change detected. (old = 'paused', new = 'running') 2025-10-07 18:56:40 (5548): VM state change detected. (old = 'running', new = 'paused') 2025-10-07 18:57:00 (5548): VM state change detected. (old = 'paused', new = 'running') 2025-10-07 18:57:10 (5548): VM state change detected. (old = 'running', new = 'paused') 2025-10-07 18:57:30 (5548): VM state change detected. (old = 'paused', new = 'running') 2025-10-07 18:58:30 (5548): VM state change detected. (old = 'running', new = 'paused') 2025-10-07 18:58:50 (5548): VM state change detected. (old = 'paused', new = 'running') 2025-10-07 18:59:40 (5548): VM state change detected. (old = 'running', new = 'paused') 2025-10-07 19:00:00 (5548): VM state change detected. (old = 'paused', new = 'running') 2025-10-07 19:00:20 (5548): VM state change detected. (old = 'running', new = 'paused') 2025-10-07 19:00:40 (5548): VM state change detected. (old = 'paused', new = 'running') 2025-10-07 19:02:30 (5548): VM state change detected. (old = 'running', new = 'paused') 2025-10-07 19:02:50 (5548): VM state change detected. (old = 'paused', new = 'running') 2025-10-07 19:05:01 (5548): VM state change detected. (old = 'running', new = 'paused') 2025-10-07 19:05:21 (5548): VM state change detected. (old = 'paused', new = 'running') 2025-10-07 19:05:31 (5548): VM state change detected. (old = 'running', new = 'paused') 2025-10-07 19:05:51 (5548): VM state change detected. (old = 'paused', new = 'running') 2025-10-07 19:06:11 (5548): VM state change detected. (old = 'running', new = 'paused') 2025-10-07 19:06:31 (5548): VM state change detected. (old = 'paused', new = 'running') 2025-10-07 19:06:41 (5548): VM state change detected. (old = 'running', new = 'paused') 2025-10-07 19:07:01 (5548): VM state change detected. (old = 'paused', new = 'running') 2025-10-07 19:07:11 (5548): VM state change detected. (old = 'running', new = 'paused') 2025-10-07 19:07:31 (5548): VM state change detected. (old = 'paused', new = 'running') 2025-10-07 19:07:41 (5548): VM state change detected. (old = 'running', new = 'paused') 2025-10-07 19:08:01 (5548): VM state change detected. (old = 'paused', new = 'running') 2025-10-07 19:08:11 (5548): VM state change detected. (old = 'running', new = 'paused') 2025-10-07 19:08:31 (5548): VM state change detected. (old = 'paused', new = 'running') 2025-10-07 19:08:41 (5548): VM state change detected. (old = 'running', new = 'paused') 2025-10-07 19:09:01 (5548): VM state change detected. (old = 'paused', new = 'running') 2025-10-07 19:09:41 (5548): VM state change detected. (old = 'running', new = 'paused') 2025-10-07 19:10:01 (5548): VM state change detected. (old = 'paused', new = 'running') 2025-10-07 19:10:41 (5548): VM state change detected. (old = 'running', new = 'paused') 2025-10-07 19:11:01 (5548): VM state change detected. (old = 'paused', new = 'running') 2025-10-07 19:11:21 (5548): VM state change detected. (old = 'running', new = 'paused') 2025-10-07 19:11:41 (5548): VM state change detected. (old = 'paused', new = 'running') 2025-10-07 19:12:01 (5548): VM state change detected. (old = 'running', new = 'paused') 2025-10-07 19:12:21 (5548): VM state change detected. (old = 'paused', new = 'running') 2025-10-07 19:12:31 (5548): VM state change detected. (old = 'running', new = 'paused') 2025-10-07 19:12:51 (5548): VM state change detected. (old = 'paused', new = 'running') 2025-10-07 19:13:01 (5548): VM state change detected. (old = 'running', new = 'paused') 2025-10-07 19:13:21 (5548): VM state change detected. (old = 'paused', new = 'running') 2025-10-07 19:14:02 (5548): VM state change detected. (old = 'running', new = 'paused') 2025-10-07 19:14:22 (5548): VM state change detected. (old = 'paused', new = 'running') 2025-10-07 19:15:21 (5548): VM state change detected. (old = 'running', new = 'paused') 2025-10-07 19:15:41 (5548): VM state change detected. (old = 'paused', new = 'running') 2025-10-07 19:15:52 (5548): VM state change detected. (old = 'running', new = 'paused') 2025-10-07 19:16:12 (5548): VM state change detected. (old = 'paused', new = 'running') 2025-10-07 19:18:12 (5548): VM state change detected. (old = 'running', new = 'paused') 2025-10-07 19:18:32 (5548): VM state change detected. (old = 'paused', new = 'running') 2025-10-07 19:18:52 (5548): VM state change detected. (old = 'running', new = 'paused') 2025-10-07 19:19:12 (5548): VM state change detected. (old = 'paused', new = 'running') 2025-10-07 19:19:32 (5548): VM state change detected. (old = 'running', new = 'paused') 2025-10-07 19:19:52 (5548): VM state change detected. (old = 'paused', new = 'running') 2025-10-07 19:20:32 (5548): VM state change detected. (old = 'running', new = 'paused') 2025-10-07 19:20:52 (5548): VM state change detected. (old = 'paused', new = 'running') 2025-10-07 19:21:22 (5548): VM state change detected. (old = 'running', new = 'paused') 2025-10-07 19:21:42 (5548): VM state change detected. (old = 'paused', new = 'running') 2025-10-07 19:22:02 (5548): VM state change detected. (old = 'running', new = 'paused') 2025-10-07 19:22:22 (5548): VM state change detected. (old = 'paused', new = 'running') 2025-10-07 19:22:42 (5548): VM state change detected. (old = 'running', new = 'paused') 2025-10-07 19:23:02 (5548): VM state change detected. (old = 'paused', new = 'running') 2025-10-07 19:23:22 (5548): VM state change detected. (old = 'running', new = 'paused') 2025-10-07 19:23:42 (5548): VM state change detected. (old = 'paused', new = 'running') 2025-10-07 19:27:02 (5548): VM state change detected. (old = 'running', new = 'paused') 2025-10-07 19:27:22 (5548): VM state change detected. (old = 'paused', new = 'running') 2025-10-07 19:28:52 (5548): VM state change detected. (old = 'running', new = 'paused') 2025-10-07 19:29:12 (5548): VM state change detected. (old = 'paused', new = 'running') 2025-10-07 19:29:32 (5548): VM state change detected. (old = 'running', new = 'paused') 2025-10-07 19:29:52 (5548): VM state change detected. (old = 'paused', new = 'running') 2025-10-07 19:30:42 (5548): VM state change detected. (old = 'running', new = 'paused') 2025-10-07 19:31:02 (5548): VM state change detected. (old = 'paused', new = 'running') 2025-10-07 19:31:12 (5548): VM state change detected. (old = 'running', new = 'paused') 2025-10-07 19:31:32 (5548): VM state change detected. (old = 'paused', new = 'running') 2025-10-07 19:31:42 (5548): VM state change detected. (old = 'running', new = 'paused') 2025-10-07 19:32:02 (5548): VM state change detected. (old = 'paused', new = 'running') 2025-10-07 19:33:53 (5548): VM state change detected. (old = 'running', new = 'paused') 2025-10-07 19:34:13 (5548): VM state change detected. (old = 'paused', new = 'running') 2025-10-07 19:35:23 (5548): VM state change detected. (old = 'running', new = 'paused') 2025-10-07 19:35:43 (5548): VM state change detected. (old = 'paused', new = 'running') 2025-10-07 19:37:03 (5548): VM state change detected. (old = 'running', new = 'paused') 2025-10-07 19:37:23 (5548): VM state change detected. (old = 'paused', new = 'running') 2025-10-07 19:39:23 (5548): VM state change detected. (old = 'running', new = 'paused') 2025-10-07 19:39:43 (5548): VM state change detected. (old = 'paused', new = 'running') 2025-10-07 19:41:13 (5548): VM state change detected. (old = 'running', new = 'paused') 2025-10-07 19:41:33 (5548): VM state change detected. (old = 'paused', new = 'running') 2025-10-07 19:41:43 (5548): VM state change detected. (old = 'running', new = 'paused') 2025-10-07 19:42:03 (5548): VM state change detected. (old = 'paused', new = 'running') 2025-10-07 19:42:23 (5548): VM state change detected. (old = 'running', new = 'paused') 2025-10-07 19:42:43 (5548): VM state change detected. (old = 'paused', new = 'running') 2025-10-07 19:43:03 (5548): VM state change detected. (old = 'running', new = 'paused') 2025-10-07 19:43:23 (5548): VM state change detected. (old = 'paused', new = 'running') 2025-10-07 19:43:53 (5548): VM state change detected. (old = 'running', new = 'paused') 2025-10-07 19:44:13 (5548): VM state change detected. (old = 'paused', new = 'running') 2025-10-07 19:44:23 (5548): VM state change detected. (old = 'running', new = 'paused') 2025-10-07 19:44:43 (5548): VM state change detected. (old = 'paused', new = 'running') 2025-10-07 19:45:46 (5548): Status Report: Elapsed Time: '6000.000000' 2025-10-07 19:45:46 (5548): Status Report: CPU Time: '9518.171875' 2025-10-07 19:46:33 (5548): VM state change detected. (old = 'running', new = 'paused') 2025-10-07 19:46:53 (5548): VM state change detected. (old = 'paused', new = 'running') 2025-10-07 19:48:03 (5548): VM state change detected. (old = 'running', new = 'paused') 2025-10-07 19:48:23 (5548): VM state change detected. (old = 'paused', new = 'running') 2025-10-07 19:50:53 (5548): VM state change detected. (old = 'running', new = 'paused') 2025-10-07 19:51:13 (5548): VM state change detected. (old = 'paused', new = 'running') 2025-10-07 19:51:23 (5548): VM state change detected. (old = 'running', new = 'paused') 2025-10-07 19:51:43 (5548): VM state change detected. (old = 'paused', new = 'running') 2025-10-07 19:52:13 (5548): VM state change detected. (old = 'running', new = 'paused') 2025-10-07 19:52:33 (5548): VM state change detected. (old = 'paused', new = 'running') 2025-10-07 19:52:53 (5548): VM state change detected. (old = 'running', new = 'paused') 2025-10-07 19:53:13 (5548): VM state change detected. (old = 'paused', new = 'running') 2025-10-07 19:53:53 (5548): VM state change detected. (old = 'running', new = 'paused') 2025-10-07 19:54:13 (5548): VM state change detected. (old = 'paused', new = 'running') 2025-10-07 19:54:33 (5548): VM state change detected. (old = 'running', new = 'paused') 2025-10-07 19:54:53 (5548): VM state change detected. (old = 'paused', new = 'running') 2025-10-07 19:55:23 (5548): VM state change detected. (old = 'running', new = 'paused') 2025-10-07 19:55:43 (5548): VM state change detected. (old = 'paused', new = 'running') 2025-10-07 19:55:53 (5548): VM state change detected. (old = 'running', new = 'paused') 2025-10-07 19:56:13 (5548): VM state change detected. (old = 'paused', new = 'running') 2025-10-07 19:57:33 (5548): VM state change detected. (old = 'running', new = 'paused') 2025-10-07 19:57:53 (5548): VM state change detected. (old = 'paused', new = 'running') 2025-10-07 19:59:53 (5548): VM state change detected. (old = 'running', new = 'paused') 2025-10-07 20:00:13 (5548): VM state change detected. (old = 'paused', new = 'running') 2025-10-07 20:00:53 (5548): VM state change detected. (old = 'running', new = 'paused') 2025-10-07 20:01:13 (5548): VM state change detected. (old = 'paused', new = 'running') 2025-10-07 20:04:13 (5548): VM state change detected. (old = 'running', new = 'paused') 2025-10-07 20:04:34 (5548): VM state change detected. (old = 'paused', new = 'running') 2025-10-07 20:04:44 (5548): VM state change detected. (old = 'running', new = 'paused') 2025-10-07 20:05:04 (5548): VM state change detected. (old = 'paused', new = 'running') 2025-10-07 20:06:15 (5548): VM state change detected. (old = 'running', new = 'paused') 2025-10-07 20:06:35 (5548): VM state change detected. (old = 'paused', new = 'running') 2025-10-07 20:08:35 (5548): VM state change detected. (old = 'running', new = 'paused') 2025-10-07 20:08:55 (5548): VM state change detected. (old = 'paused', new = 'running') 2025-10-07 20:09:55 (5548): VM state change detected. (old = 'running', new = 'paused') 2025-10-07 20:10:15 (5548): VM state change detected. (old = 'paused', new = 'running') 2025-10-07 20:11:05 (5548): VM state change detected. (old = 'running', new = 'paused') 2025-10-07 20:11:25 (5548): VM state change detected. (old = 'paused', new = 'running') 2025-10-07 20:11:45 (5548): VM state change detected. (old = 'running', new = 'paused') 2025-10-07 20:12:05 (5548): VM state change detected. (old = 'paused', new = 'running') 2025-10-07 20:12:55 (5548): VM state change detected. (old = 'running', new = 'paused') 2025-10-07 20:13:15 (5548): VM state change detected. (old = 'paused', new = 'running') 2025-10-07 20:15:05 (5548): VM state change detected. (old = 'running', new = 'paused') 2025-10-07 20:15:25 (5548): VM state change detected. (old = 'paused', new = 'running') 2025-10-07 20:17:55 (5548): VM state change detected. (old = 'running', new = 'paused') 2025-10-07 20:18:15 (5548): VM state change detected. (old = 'paused', new = 'running') 2025-10-07 20:20:45 (5548): VM state change detected. (old = 'running', new = 'paused') 2025-10-07 20:21:05 (5548): VM state change detected. (old = 'paused', new = 'running') 2025-10-07 20:22:45 (5548): VM state change detected. (old = 'running', new = 'paused') 2025-10-07 20:23:05 (5548): VM state change detected. (old = 'paused', new = 'running') 2025-10-07 20:24:35 (5548): VM state change detected. (old = 'running', new = 'paused') 2025-10-07 20:24:55 (5548): VM state change detected. (old = 'paused', new = 'running') 2025-10-07 20:26:15 (5548): VM state change detected. (old = 'running', new = 'paused') 2025-10-07 20:26:35 (5548): VM state change detected. (old = 'paused', new = 'running') 2025-10-07 20:26:55 (5548): VM state change detected. (old = 'running', new = 'paused') 2025-10-07 20:27:15 (5548): VM state change detected. (old = 'paused', new = 'running') 2025-10-07 20:28:05 (5548): VM state change detected. (old = 'running', new = 'paused') 2025-10-07 20:28:25 (5548): VM state change detected. (old = 'paused', new = 'running') 2025-10-07 20:30:45 (5548): VM state change detected. (old = 'running', new = 'paused') 2025-10-07 20:31:05 (5548): VM state change detected. (old = 'paused', new = 'running') 2025-10-07 20:31:25 (5548): VM state change detected. (old = 'running', new = 'paused') 2025-10-07 20:31:45 (5548): VM state change detected. (old = 'paused', new = 'running') 2025-10-07 20:33:55 (5548): VM state change detected. (old = 'running', new = 'paused') 2025-10-07 20:34:15 (5548): VM state change detected. (old = 'paused', new = 'running') 2025-10-07 20:34:55 (5548): VM state change detected. (old = 'running', new = 'paused') 2025-10-07 20:35:15 (5548): VM state change detected. (old = 'paused', new = 'running') 2025-10-07 20:36:35 (5548): VM state change detected. (old = 'running', new = 'paused') 2025-10-07 20:36:55 (5548): VM state change detected. (old = 'paused', new = 'running') 2025-10-07 20:37:15 (5548): VM state change detected. (old = 'running', new = 'paused') 2025-10-07 20:37:35 (5548): VM state change detected. (old = 'paused', new = 'running') 2025-10-07 20:38:25 (5548): VM state change detected. (old = 'running', new = 'paused') 2025-10-07 20:38:45 (5548): VM state change detected. (old = 'paused', new = 'running') 2025-10-07 20:39:16 (5548): VM state change detected. (old = 'running', new = 'paused') 2025-10-07 20:39:36 (5548): VM state change detected. (old = 'paused', new = 'running') 2025-10-07 20:39:46 (5548): VM state change detected. (old = 'running', new = 'paused') 2025-10-07 20:40:06 (5548): VM state change detected. (old = 'paused', new = 'running') 2025-10-07 20:40:26 (5548): VM state change detected. (old = 'running', new = 'paused') 2025-10-07 20:40:46 (5548): VM state change detected. (old = 'paused', new = 'running') 2025-10-07 20:41:06 (5548): VM state change detected. (old = 'running', new = 'paused') 2025-10-07 20:41:26 (5548): VM state change detected. (old = 'paused', new = 'running') 2025-10-07 20:41:36 (5548): VM state change detected. (old = 'running', new = 'paused') 2025-10-07 20:41:56 (5548): VM state change detected. (old = 'paused', new = 'running') 2025-10-07 20:43:16 (5548): VM state change detected. (old = 'running', new = 'paused') 2025-10-07 20:43:36 (5548): VM state change detected. (old = 'paused', new = 'running') 2025-10-07 20:43:56 (5548): VM state change detected. (old = 'running', new = 'paused') 2025-10-07 20:44:16 (5548): VM state change detected. (old = 'paused', new = 'running') 2025-10-07 20:48:26 (5548): VM state change detected. (old = 'running', new = 'paused') 2025-10-07 20:48:46 (5548): VM state change detected. (old = 'paused', new = 'running') 2025-10-07 20:48:56 (5548): VM state change detected. (old = 'running', new = 'paused') 2025-10-07 20:49:16 (5548): VM state change detected. (old = 'paused', new = 'running') 2025-10-07 20:49:26 (5548): VM state change detected. (old = 'running', new = 'paused') 2025-10-07 20:49:46 (5548): VM state change detected. (old = 'paused', new = 'running') 2025-10-07 20:50:56 (5548): VM state change detected. (old = 'running', new = 'paused') 2025-10-07 20:51:16 (5548): VM state change detected. (old = 'paused', new = 'running') 2025-10-07 20:52:06 (5548): VM state change detected. (old = 'running', new = 'paused') 2025-10-07 20:52:26 (5548): VM state change detected. (old = 'paused', new = 'running') 2025-10-07 20:52:46 (5548): VM state change detected. (old = 'running', new = 'paused') 2025-10-07 20:53:06 (5548): VM state change detected. (old = 'paused', new = 'running') 2025-10-07 20:53:16 (5548): VM state change detected. (old = 'running', new = 'paused') 2025-10-07 20:53:36 (5548): VM state change detected. (old = 'paused', new = 'running') 2025-10-07 20:56:06 (5548): VM state change detected. (old = 'running', new = 'paused') 2025-10-07 20:56:27 (5548): VM state change detected. (old = 'paused', new = 'running') 2025-10-07 20:57:07 (5548): VM state change detected. (old = 'running', new = 'paused') 2025-10-07 20:57:26 (5548): VM state change detected. (old = 'paused', new = 'running') 2025-10-07 20:57:46 (5548): VM state change detected. (old = 'running', new = 'paused') 2025-10-07 20:58:06 (5548): VM state change detected. (old = 'paused', new = 'running') 2025-10-07 20:58:17 (5548): VM state change detected. (old = 'running', new = 'paused') 2025-10-07 20:58:37 (5548): VM state change detected. (old = 'paused', new = 'running') 2025-10-07 21:06:07 (5548): VM state change detected. (old = 'running', new = 'paused') 2025-10-07 21:06:27 (5548): VM state change detected. (old = 'paused', new = 'running') 2025-10-07 21:06:47 (5548): VM state change detected. (old = 'running', new = 'paused') 2025-10-07 21:07:07 (5548): VM state change detected. (old = 'paused', new = 'running') 2025-10-07 21:07:37 (5548): VM state change detected. (old = 'running', new = 'paused') 2025-10-07 21:07:57 (5548): VM state change detected. (old = 'paused', new = 'running') 2025-10-07 21:08:17 (5548): VM state change detected. (old = 'running', new = 'paused') 2025-10-07 21:08:37 (5548): VM state change detected. (old = 'paused', new = 'running') 2025-10-07 21:08:57 (5548): VM state change detected. (old = 'running', new = 'paused') 2025-10-07 21:09:17 (5548): VM state change detected. (old = 'paused', new = 'running') 2025-10-07 21:10:17 (5548): VM state change detected. (old = 'running', new = 'paused') 2025-10-07 21:10:37 (5548): VM state change detected. (old = 'paused', new = 'running') 2025-10-07 21:12:28 (5548): VM state change detected. (old = 'running', new = 'paused') 2025-10-07 21:12:48 (5548): VM state change detected. (old = 'paused', new = 'running') 2025-10-07 21:12:58 (5548): VM state change detected. (old = 'running', new = 'paused') 2025-10-07 21:13:18 (5548): VM state change detected. (old = 'paused', new = 'running') 2025-10-07 21:13:48 (5548): VM state change detected. (old = 'running', new = 'paused') 2025-10-07 21:14:08 (5548): VM state change detected. (old = 'paused', new = 'running') 2025-10-07 21:18:58 (5548): VM state change detected. (old = 'running', new = 'paused') 2025-10-07 21:19:18 (5548): VM state change detected. (old = 'paused', new = 'running') 2025-10-07 21:22:48 (5548): VM state change detected. (old = 'running', new = 'paused') 2025-10-07 21:23:09 (5548): VM state change detected. (old = 'paused', new = 'running') 2025-10-07 21:24:38 (5548): VM state change detected. (old = 'running', new = 'paused') 2025-10-07 21:24:59 (5548): VM state change detected. (old = 'paused', new = 'running') 2025-10-07 21:25:28 (5548): VM state change detected. (old = 'running', new = 'paused') 2025-10-07 21:25:49 (5548): VM state change detected. (old = 'paused', new = 'running') 2025-10-07 21:26:08 (5548): VM state change detected. (old = 'running', new = 'paused') 2025-10-07 21:26:28 (5548): VM state change detected. (old = 'paused', new = 'running') 2025-10-07 21:26:58 (5548): VM state change detected. (old = 'running', new = 'paused') 2025-10-07 21:27:19 (5548): VM state change detected. (old = 'paused', new = 'running') 2025-10-07 21:27:38 (5548): VM state change detected. (old = 'running', new = 'paused') 2025-10-07 21:27:59 (5548): VM state change detected. (old = 'paused', new = 'running') 2025-10-07 21:28:18 (5548): VM state change detected. (old = 'running', new = 'paused') 2025-10-07 21:28:38 (5548): VM state change detected. (old = 'paused', new = 'running') 2025-10-07 21:29:08 (5548): VM state change detected. (old = 'running', new = 'paused') 2025-10-07 21:29:29 (5548): VM state change detected. (old = 'paused', new = 'running') 2025-10-07 21:31:48 (5548): VM state change detected. (old = 'running', new = 'paused') 2025-10-07 21:32:09 (5548): VM state change detected. (old = 'paused', new = 'running') 2025-10-07 21:32:28 (5548): VM state change detected. (old = 'running', new = 'paused') 2025-10-07 21:32:48 (5548): VM state change detected. (old = 'paused', new = 'running') 2025-10-07 21:33:18 (5548): VM state change detected. (old = 'running', new = 'paused') 2025-10-07 21:33:39 (5548): VM state change detected. (old = 'paused', new = 'running') 2025-10-07 21:33:48 (5548): VM state change detected. (old = 'running', new = 'paused') 2025-10-07 21:34:08 (5548): VM state change detected. (old = 'paused', new = 'running') 2025-10-07 21:34:18 (5548): VM state change detected. (old = 'running', new = 'paused') 2025-10-07 21:34:39 (5548): VM state change detected. (old = 'paused', new = 'running') 2025-10-07 21:35:38 (5548): VM state change detected. (old = 'running', new = 'paused') 2025-10-07 21:35:59 (5548): VM state change detected. (old = 'paused', new = 'running') 2025-10-07 21:36:19 (5548): VM state change detected. (old = 'running', new = 'paused') 2025-10-07 21:36:39 (5548): VM state change detected. (old = 'paused', new = 'running') 2025-10-07 21:37:18 (5548): VM state change detected. (old = 'running', new = 'paused') 2025-10-07 21:37:39 (5548): VM state change detected. (old = 'paused', new = 'running') 2025-10-07 21:37:58 (5548): VM state change detected. (old = 'running', new = 'paused') 2025-10-07 21:38:19 (5548): VM state change detected. (old = 'paused', new = 'running') 2025-10-07 21:38:29 (5548): VM state change detected. (old = 'running', new = 'paused') 2025-10-07 21:38:49 (5548): VM state change detected. (old = 'paused', new = 'running') 2025-10-07 21:43:19 (5548): VM state change detected. (old = 'running', new = 'paused') 2025-10-07 21:43:39 (5548): VM state change detected. (old = 'paused', new = 'running') 2025-10-07 21:43:59 (5548): VM state change detected. (old = 'running', new = 'paused') 2025-10-07 21:44:20 (5548): VM state change detected. (old = 'paused', new = 'running') 2025-10-07 21:45:30 (5548): VM state change detected. (old = 'running', new = 'paused') 2025-10-07 21:45:50 (5548): VM state change detected. (old = 'paused', new = 'running') 2025-10-07 21:46:50 (5548): VM state change detected. (old = 'running', new = 'paused') 2025-10-07 21:47:10 (5548): VM state change detected. (old = 'paused', new = 'running') 2025-10-07 21:47:30 (5548): VM state change detected. (old = 'running', new = 'paused') 2025-10-07 21:47:50 (5548): VM state change detected. (old = 'paused', new = 'running') 2025-10-07 21:48:10 (5548): VM state change detected. (old = 'running', new = 'paused') 2025-10-07 21:48:30 (5548): VM state change detected. (old = 'paused', new = 'running') 2025-10-07 21:49:10 (5548): VM state change detected. (old = 'running', new = 'paused') 2025-10-07 21:49:30 (5548): VM state change detected. (old = 'paused', new = 'running') 2025-10-07 21:50:00 (5548): VM state change detected. (old = 'running', new = 'paused') 2025-10-07 21:50:20 (5548): VM state change detected. (old = 'paused', new = 'running') 2025-10-07 21:50:50 (5548): VM state change detected. (old = 'running', new = 'paused') 2025-10-07 21:51:10 (5548): VM state change detected. (old = 'paused', new = 'running') 2025-10-07 21:51:30 (5548): VM state change detected. (old = 'running', new = 'paused') 2025-10-07 21:51:50 (5548): VM state change detected. (old = 'paused', new = 'running') 2025-10-07 21:52:00 (5548): VM state change detected. (old = 'running', new = 'paused') 2025-10-07 21:52:20 (5548): VM state change detected. (old = 'paused', new = 'running') 2025-10-07 21:54:40 (5548): VM state change detected. (old = 'running', new = 'paused') 2025-10-07 21:55:00 (5548): VM state change detected. (old = 'paused', new = 'running') 2025-10-07 21:56:10 (5548): VM state change detected. (old = 'running', new = 'paused') 2025-10-07 21:56:30 (5548): VM state change detected. (old = 'paused', new = 'running') 2025-10-07 21:56:50 (5548): VM state change detected. (old = 'running', new = 'paused') 2025-10-07 21:57:10 (5548): VM state change detected. (old = 'paused', new = 'running') 2025-10-07 21:57:30 (5548): VM state change detected. (old = 'running', new = 'paused') 2025-10-07 21:57:50 (5548): VM state change detected. (old = 'paused', new = 'running') 2025-10-07 21:58:30 (5548): VM state change detected. (old = 'running', new = 'paused') 2025-10-07 21:58:50 (5548): VM state change detected. (old = 'paused', new = 'running') 2025-10-07 22:00:20 (5548): VM state change detected. (old = 'running', new = 'paused') 2025-10-07 22:00:40 (5548): VM state change detected. (old = 'paused', new = 'running') 2025-10-07 22:00:42 (5548): Status Report: Elapsed Time: '12000.000000' 2025-10-07 22:00:42 (5548): Status Report: CPU Time: '21111.578125' 2025-10-07 22:00:50 (5548): VM state change detected. (old = 'running', new = 'paused') 2025-10-07 22:01:10 (5548): VM state change detected. (old = 'paused', new = 'running') 2025-10-07 22:01:30 (5548): VM state change detected. (old = 'running', new = 'paused') 2025-10-07 22:01:50 (5548): VM state change detected. (old = 'paused', new = 'running') 2025-10-07 22:02:10 (5548): VM state change detected. (old = 'running', new = 'paused') 2025-10-07 22:02:30 (5548): VM state change detected. (old = 'paused', new = 'running') 2025-10-07 22:03:30 (5548): VM state change detected. (old = 'running', new = 'paused') 2025-10-07 22:03:50 (5548): VM state change detected. (old = 'paused', new = 'running') 2025-10-07 22:06:10 (5548): VM state change detected. (old = 'running', new = 'paused') 2025-10-07 22:06:30 (5548): VM state change detected. (old = 'paused', new = 'running') 2025-10-07 22:07:00 (5548): VM state change detected. (old = 'running', new = 'paused') 2025-10-07 22:07:20 (5548): VM state change detected. (old = 'paused', new = 'running') 2025-10-07 22:08:10 (5548): VM state change detected. (old = 'running', new = 'paused') 2025-10-07 22:08:30 (5548): VM state change detected. (old = 'paused', new = 'running') 2025-10-07 22:08:40 (5548): VM state change detected. (old = 'running', new = 'paused') 2025-10-07 22:09:00 (5548): VM state change detected. (old = 'paused', new = 'running') 2025-10-07 22:09:20 (5548): VM state change detected. (old = 'running', new = 'paused') 2025-10-07 22:09:40 (5548): VM state change detected. (old = 'paused', new = 'running') 2025-10-07 22:09:50 (5548): VM state change detected. (old = 'running', new = 'paused') 2025-10-07 22:10:10 (5548): VM state change detected. (old = 'paused', new = 'running') 2025-10-07 22:10:30 (5548): VM state change detected. (old = 'running', new = 'paused') 2025-10-07 22:10:50 (5548): VM state change detected. (old = 'paused', new = 'running') 2025-10-07 22:11:20 (5548): VM state change detected. (old = 'running', new = 'paused') 2025-10-07 22:11:40 (5548): VM state change detected. (old = 'paused', new = 'running') 2025-10-07 22:11:50 (5548): VM state change detected. (old = 'running', new = 'paused') 2025-10-07 22:12:10 (5548): VM state change detected. (old = 'paused', new = 'running') 2025-10-07 22:15:31 (5548): VM state change detected. (old = 'running', new = 'paused') 2025-10-07 22:15:51 (5548): VM state change detected. (old = 'paused', new = 'running') 2025-10-07 22:16:01 (5548): VM state change detected. (old = 'running', new = 'paused') 2025-10-07 22:16:21 (5548): VM state change detected. (old = 'paused', new = 'running') 2025-10-07 22:16:31 (5548): VM state change detected. (old = 'running', new = 'paused') 2025-10-07 22:16:51 (5548): VM state change detected. (old = 'paused', new = 'running') 2025-10-07 22:18:41 (5548): VM state change detected. (old = 'running', new = 'paused') 2025-10-07 22:19:01 (5548): VM state change detected. (old = 'paused', new = 'running') 2025-10-07 22:19:11 (5548): VM state change detected. (old = 'running', new = 'paused') 2025-10-07 22:19:31 (5548): VM state change detected. (old = 'paused', new = 'running') 2025-10-07 22:22:51 (5548): VM state change detected. (old = 'running', new = 'paused') 2025-10-07 22:23:11 (5548): VM state change detected. (old = 'paused', new = 'running') 2025-10-07 22:23:31 (5548): VM state change detected. (old = 'running', new = 'paused') 2025-10-07 22:23:51 (5548): VM state change detected. (old = 'paused', new = 'running') 2025-10-07 22:27:51 (5548): VM state change detected. (old = 'running', new = 'paused') 2025-10-07 22:28:11 (5548): VM state change detected. (old = 'paused', new = 'running') 2025-10-07 22:28:21 (5548): VM state change detected. (old = 'running', new = 'paused') 2025-10-07 22:28:41 (5548): VM state change detected. (old = 'paused', new = 'running') 2025-10-07 22:29:01 (5548): VM state change detected. (old = 'running', new = 'paused') 2025-10-07 22:29:21 (5548): VM state change detected. (old = 'paused', new = 'running') 2025-10-07 22:29:41 (5548): VM state change detected. (old = 'running', new = 'paused') 2025-10-07 22:30:01 (5548): VM state change detected. (old = 'paused', new = 'running') 2025-10-07 22:30:21 (5548): VM state change detected. (old = 'running', new = 'paused') 2025-10-07 22:30:42 (5548): VM state change detected. (old = 'paused', new = 'running') 2025-10-07 22:32:12 (5548): VM state change detected. (old = 'running', new = 'paused') 2025-10-07 22:32:32 (5548): VM state change detected. (old = 'paused', new = 'running') 2025-10-07 22:34:33 (5548): VM state change detected. (old = 'running', new = 'paused') 2025-10-07 22:34:53 (5548): VM state change detected. (old = 'paused', new = 'running') 2025-10-07 22:35:43 (5548): VM state change detected. (old = 'running', new = 'paused') 2025-10-07 22:36:03 (5548): VM state change detected. (old = 'paused', new = 'running') 2025-10-07 22:37:23 (5548): VM state change detected. (old = 'running', new = 'paused') 2025-10-07 22:37:43 (5548): VM state change detected. (old = 'paused', new = 'running') 2025-10-07 22:39:23 (5548): VM state change detected. (old = 'running', new = 'paused') 2025-10-07 22:39:43 (5548): VM state change detected. (old = 'paused', new = 'running') 2025-10-07 22:40:03 (5548): VM state change detected. (old = 'running', new = 'paused') 2025-10-07 22:40:23 (5548): VM state change detected. (old = 'paused', new = 'running') 2025-10-07 22:40:43 (5548): VM state change detected. (old = 'running', new = 'paused') 2025-10-07 22:41:03 (5548): VM state change detected. (old = 'paused', new = 'running') 2025-10-07 22:41:23 (5548): VM state change detected. (old = 'running', new = 'paused') 2025-10-07 22:41:43 (5548): VM state change detected. (old = 'paused', new = 'running') 2025-10-07 22:44:53 (5548): VM state change detected. (old = 'running', new = 'paused') 2025-10-07 22:45:13 (5548): VM state change detected. (old = 'paused', new = 'running') 2025-10-07 22:45:33 (5548): VM state change detected. (old = 'running', new = 'paused') 2025-10-07 22:45:53 (5548): VM state change detected. (old = 'paused', new = 'running') 2025-10-07 22:46:13 (5548): VM state change detected. (old = 'running', new = 'paused') 2025-10-07 22:46:33 (5548): VM state change detected. (old = 'paused', new = 'running') 2025-10-07 22:47:44 (5548): VM state change detected. (old = 'running', new = 'paused') 2025-10-07 22:48:04 (5548): VM state change detected. (old = 'paused', new = 'running') 2025-10-07 22:48:44 (5548): VM state change detected. (old = 'running', new = 'paused') 2025-10-07 22:49:04 (5548): VM state change detected. (old = 'paused', new = 'running') 2025-10-07 22:49:14 (5548): VM state change detected. (old = 'running', new = 'paused') 2025-10-07 22:49:34 (5548): VM state change detected. (old = 'paused', new = 'running') 2025-10-07 22:50:54 (5548): VM state change detected. (old = 'running', new = 'paused') 2025-10-07 22:51:14 (5548): VM state change detected. (old = 'paused', new = 'running') 2025-10-07 22:53:24 (5548): VM state change detected. (old = 'running', new = 'paused') 2025-10-07 22:53:44 (5548): VM state change detected. (old = 'paused', new = 'running') 2025-10-07 22:56:14 (5548): VM state change detected. (old = 'running', new = 'paused') 2025-10-07 22:56:34 (5548): VM state change detected. (old = 'paused', new = 'running') 2025-10-07 22:57:24 (5548): VM state change detected. (old = 'running', new = 'paused') 2025-10-07 22:57:44 (5548): VM state change detected. (old = 'paused', new = 'running') 2025-10-07 22:57:54 (5548): VM state change detected. (old = 'running', new = 'paused') 2025-10-07 22:58:14 (5548): VM state change detected. (old = 'paused', new = 'running') 2025-10-07 22:59:34 (5548): VM state change detected. (old = 'running', new = 'paused') 2025-10-07 22:59:54 (5548): VM state change detected. (old = 'paused', new = 'running') 2025-10-07 23:00:44 (5548): VM state change detected. (old = 'running', new = 'paused') 2025-10-07 23:01:04 (5548): VM state change detected. (old = 'paused', new = 'running') 2025-10-07 23:02:34 (5548): VM state change detected. (old = 'running', new = 'paused') 2025-10-07 23:02:54 (5548): VM state change detected. (old = 'paused', new = 'running') 2025-10-07 23:03:54 (5548): VM state change detected. (old = 'running', new = 'paused') 2025-10-07 23:04:14 (5548): VM state change detected. (old = 'paused', new = 'running') 2025-10-07 23:04:24 (5548): VM state change detected. (old = 'running', new = 'paused') 2025-10-07 23:04:44 (5548): VM state change detected. (old = 'paused', new = 'running') 2025-10-07 23:04:54 (5548): VM state change detected. (old = 'running', new = 'paused') 2025-10-07 23:05:14 (5548): VM state change detected. (old = 'paused', new = 'running') 2025-10-07 23:06:04 (5548): VM state change detected. (old = 'running', new = 'paused') 2025-10-07 23:06:24 (5548): VM state change detected. (old = 'paused', new = 'running') 2025-10-07 23:06:34 (5548): VM state change detected. (old = 'running', new = 'paused') 2025-10-07 23:06:54 (5548): VM state change detected. (old = 'paused', new = 'running') 2025-10-07 23:07:14 (5548): VM state change detected. (old = 'running', new = 'paused') 2025-10-07 23:07:34 (5548): VM state change detected. (old = 'paused', new = 'running') 2025-10-07 23:07:44 (5548): VM state change detected. (old = 'running', new = 'paused') 2025-10-07 23:08:04 (5548): VM state change detected. (old = 'paused', new = 'running') 2025-10-07 23:08:24 (5548): VM state change detected. (old = 'running', new = 'paused') 2025-10-07 23:08:44 (5548): VM state change detected. (old = 'paused', new = 'running') 2025-10-07 23:09:34 (5548): VM state change detected. (old = 'running', new = 'paused') 2025-10-07 23:09:54 (5548): VM state change detected. (old = 'paused', new = 'running') 2025-10-07 23:10:04 (5548): VM state change detected. (old = 'running', new = 'paused') 2025-10-07 23:10:24 (5548): VM state change detected. (old = 'paused', new = 'running') 2025-10-07 23:10:34 (5548): VM state change detected. (old = 'running', new = 'paused') 2025-10-07 23:10:54 (5548): VM state change detected. (old = 'paused', new = 'running') 2025-10-07 23:11:04 (5548): VM state change detected. (old = 'running', new = 'paused') 2025-10-07 23:11:24 (5548): VM state change detected. (old = 'paused', new = 'running') 2025-10-07 23:11:34 (5548): VM state change detected. (old = 'running', new = 'paused') 2025-10-07 23:11:54 (5548): VM state change detected. (old = 'paused', new = 'running') 2025-10-07 23:12:25 (5548): VM state change detected. (old = 'running', new = 'paused') 2025-10-07 23:12:44 (5548): VM state change detected. (old = 'paused', new = 'running') 2025-10-07 23:12:55 (5548): VM state change detected. (old = 'running', new = 'paused') 2025-10-07 23:13:15 (5548): VM state change detected. (old = 'paused', new = 'running') 2025-10-07 23:13:55 (5548): VM state change detected. (old = 'running', new = 'paused') 2025-10-07 23:14:14 (5548): VM state change detected. (old = 'paused', new = 'running') 2025-10-07 23:14:25 (5548): VM state change detected. (old = 'running', new = 'paused') 2025-10-07 23:14:45 (5548): VM state change detected. (old = 'paused', new = 'running') 2025-10-07 23:16:16 (5548): VM state change detected. (old = 'running', new = 'paused') 2025-10-07 23:16:36 (5548): VM state change detected. (old = 'paused', new = 'running') 2025-10-07 23:17:56 (5548): VM state change detected. (old = 'running', new = 'paused') 2025-10-07 23:18:16 (5548): VM state change detected. (old = 'paused', new = 'running') 2025-10-07 23:18:36 (5548): VM state change detected. (old = 'running', new = 'paused') 2025-10-07 23:18:56 (5548): VM state change detected. (old = 'paused', new = 'running') 2025-10-07 23:19:16 (5548): VM state change detected. (old = 'running', new = 'paused') 2025-10-07 23:19:36 (5548): VM state change detected. (old = 'paused', new = 'running') 2025-10-07 23:19:46 (5548): VM state change detected. (old = 'running', new = 'paused') 2025-10-07 23:20:06 (5548): VM state change detected. (old = 'paused', new = 'running') 2025-10-07 23:22:16 (5548): VM state change detected. (old = 'running', new = 'paused') 2025-10-07 23:22:36 (5548): VM state change detected. (old = 'paused', new = 'running') 2025-10-07 23:22:56 (5548): VM state change detected. (old = 'running', new = 'paused') 2025-10-07 23:23:16 (5548): VM state change detected. (old = 'paused', new = 'running') 2025-10-07 23:24:56 (5548): VM state change detected. (old = 'running', new = 'paused') 2025-10-07 23:25:16 (5548): VM state change detected. (old = 'paused', new = 'running') 2025-10-07 23:25:36 (5548): VM state change detected. (old = 'running', new = 'paused') 2025-10-07 23:25:56 (5548): VM state change detected. (old = 'paused', new = 'running') 2025-10-07 23:30:46 (5548): VM state change detected. (old = 'running', new = 'paused') 2025-10-07 23:31:06 (5548): VM state change detected. (old = 'paused', new = 'running') 2025-10-07 23:34:36 (5548): VM state change detected. (old = 'running', new = 'paused') 2025-10-07 23:34:56 (5548): VM state change detected. (old = 'paused', new = 'running') 2025-10-07 23:35:36 (5548): VM state change detected. (old = 'running', new = 'paused') 2025-10-07 23:35:56 (5548): VM state change detected. (old = 'paused', new = 'running') 2025-10-07 23:37:26 (5548): VM state change detected. (old = 'running', new = 'paused') 2025-10-07 23:37:46 (5548): VM state change detected. (old = 'paused', new = 'running') 2025-10-07 23:38:06 (5548): VM state change detected. (old = 'running', new = 'paused') 2025-10-07 23:38:26 (5548): VM state change detected. (old = 'paused', new = 'running') 2025-10-07 23:38:36 (5548): VM state change detected. (old = 'running', new = 'paused') 2025-10-07 23:38:56 (5548): VM state change detected. (old = 'paused', new = 'running') 2025-10-07 23:39:26 (5548): VM state change detected. (old = 'running', new = 'paused') 2025-10-07 23:39:46 (5548): VM state change detected. (old = 'paused', new = 'running') 2025-10-07 23:42:16 (5548): VM state change detected. (old = 'running', new = 'paused') 2025-10-07 23:42:36 (5548): VM state change detected. (old = 'paused', new = 'running') 2025-10-07 23:43:06 (5548): VM state change detected. (old = 'running', new = 'paused') 2025-10-07 23:43:26 (5548): VM state change detected. (old = 'paused', new = 'running') 2025-10-07 23:43:46 (5548): VM state change detected. (old = 'running', new = 'paused') 2025-10-07 23:44:06 (5548): VM state change detected. (old = 'paused', new = 'running') 2025-10-07 23:48:36 (5548): VM state change detected. (old = 'running', new = 'paused') 2025-10-07 23:48:56 (5548): VM state change detected. (old = 'paused', new = 'running') 2025-10-07 23:52:27 (5548): VM state change detected. (old = 'running', new = 'paused') 2025-10-07 23:52:47 (5548): VM state change detected. (old = 'paused', new = 'running') 2025-10-07 23:54:27 (5548): VM state change detected. (old = 'running', new = 'paused') 2025-10-07 23:54:47 (5548): VM state change detected. (old = 'paused', new = 'running') 2025-10-07 23:56:47 (5548): VM state change detected. (old = 'running', new = 'paused') 2025-10-07 23:57:07 (5548): VM state change detected. (old = 'paused', new = 'running') 2025-10-07 23:57:17 (5548): VM state change detected. (old = 'running', new = 'paused') 2025-10-07 23:57:37 (5548): VM state change detected. (old = 'paused', new = 'running') 2025-10-07 23:59:17 (5548): VM state change detected. (old = 'running', new = 'paused') 2025-10-07 23:59:37 (5548): VM state change detected. (old = 'paused', new = 'running') 2025-10-08 00:02:30 (5548): Guest Log: *** Job finished *** 2025-10-08 00:02:30 (5548): Guest Log: *** The last 20 lines of the pilot log: *** 2025-10-08 00:02:30 (5548): Guest Log: 2025-10-07 22:47:20,014 | INFO | end of generic workflow (traces error code: 0) 2025-10-08 00:02:30 (5548): Guest Log: 2025-10-07 22:47:20,015 | INFO | traces error code: 0 2025-10-08 00:02:30 (5548): Guest Log: 2025-10-07 22:47:20,015 | INFO | pilot has finished (exit code=0, shell exit code=0) 2025-10-08 00:02:30 (5548): Guest Log: 2025-10-07 22:47:29,064 | INFO | PID=6119 has CPU usage=6.4% CMD=/cvmfs/atlas.cern.ch/repo/ATLASLocalRootBase/x86_64/python/3.9.20-x86_64-centos7/bin/python3 pilot3/pilot.py -q BOINC_MCORE -i PR -j managed --pilot-user ATLAS --harvester-submit-mode PUSH -w generic --job-type managed --resource-type MCORE -z -t 2025-10-08 00:02:30 (5548): Guest Log: 2025-10-07 22:47:29,064 | INFO | found 0 job(s) in 20 queues 2025-10-08 00:02:30 (5548): Guest Log: 2025-10-07 22:47:29,065 | WARNING | pilot monitor received instruction that args.graceful_stop has been set 2025-10-08 00:02:30 (5548): Guest Log: 2025-10-07 22:47:29,065 | WARNING | will wait for a maximum of 300 s for threads to finish 2025-10-08 00:02:30 (5548): Guest Log: 2025-10-07 22:47:29,065 | WARNING | job_aborted has been set - aborting pilot monitoring 2025-10-08 00:02:30 (5548): Guest Log: 2025-10-07 22:47:29,065 | CRITICAL | thread 'MainThread' is not alive 2025-10-08 00:02:30 (5548): Guest Log: 2025-10-07 22:47:29,065 | INFO | [monitor] control thread has ended 2025-10-08 00:02:30 (5548): Guest Log: 2025-10-07 22:47:29,330 [wrapper] ==== pilot stdout END ==== 2025-10-08 00:02:30 (5548): Guest Log: 2025-10-07 22:47:29,351 [wrapper] ==== wrapper stdout RESUME ==== 2025-10-08 00:02:30 (5548): Guest Log: 2025-10-07 22:47:29,358 [wrapper] pilotpid: 6119 2025-10-08 00:02:30 (5548): Guest Log: 2025-10-07 22:47:29,365 [wrapper] Pilot exit status: 0 2025-10-08 00:02:30 (5548): Guest Log: 2025-10-07 22:47:29,430 [wrapper] pandaids: 6833170310 2025-10-08 00:02:30 (5548): Guest Log: 2025-10-07 22:47:29,477 [wrapper] cleanup supervisor_pilot 23953 6120 2025-10-08 00:02:30 (5548): Guest Log: 2025-10-07 22:47:29,483 [wrapper] Test setup, not cleaning 2025-10-08 00:02:30 (5548): Guest Log: 2025-10-07 22:47:29,489 [wrapper] apfmon messages muted 2025-10-08 00:02:30 (5548): Guest Log: 2025-10-07 22:47:29,505 [wrapper] ==== wrapper stdout END ==== 2025-10-08 00:02:30 (5548): Guest Log: 2025-10-07 22:47:29,510 [wrapper] ==== wrapper stderr END ==== 2025-10-08 00:02:30 (5548): Guest Log: *** Error codes and diagnostics *** 2025-10-08 00:02:30 (5548): Guest Log: "exeErrorCode": 0, 2025-10-08 00:02:30 (5548): Guest Log: "exeErrorDiag": "", 2025-10-08 00:02:30 (5548): Guest Log: "pilotErrorCode": 0, 2025-10-08 00:02:30 (5548): Guest Log: "pilotErrorDiag": "", 2025-10-08 00:02:30 (5548): Guest Log: *** Listing of results directory *** 2025-10-08 00:02:30 (5548): Guest Log: total 177744 2025-10-08 00:02:30 (5548): Guest Log: -rw-r--r--. 1 atlas atlas 552446 Oct 7 05:44 pilot3.tar.gz 2025-10-08 00:02:30 (5548): Guest Log: -rw-r--r--. 1 atlas atlas 5112 Oct 7 06:06 queuedata.json 2025-10-08 00:02:30 (5548): Guest Log: -rwx------. 1 atlas atlas 36292 Oct 7 06:07 runpilot2-wrapper.sh 2025-10-08 00:02:30 (5548): Guest Log: -rwxr-xr-x. 1 atlas atlas 7889 Oct 7 16:34 init_data.xml 2025-10-08 00:02:30 (5548): Guest Log: -rwxr-xr-x. 1 atlas atlas 565605 Oct 7 16:34 input.tar.gz 2025-10-08 00:02:30 (5548): Guest Log: -rwxr-xr-x. 1 atlas atlas 15120 Oct 7 16:34 start_atlas.sh 2025-10-08 00:02:30 (5548): Guest Log: lrwxrwxrwx. 1 atlas atlas 20 Oct 7 16:34 EVNT.46376901._004811.pool.root.1 -> /data/./ATLAS.root_0 2025-10-08 00:02:30 (5548): Guest Log: -rw-r--r--. 1 atlas atlas 2520 Oct 7 16:36 pandaJob.out 2025-10-08 00:02:30 (5548): Guest Log: -rw-------. 1 atlas atlas 977512 Oct 7 16:41 agis_schedconf.cvmfs.json 2025-10-08 00:02:30 (5548): Guest Log: drwx------. 4 atlas atlas 4096 Oct 7 16:41 pilot3 2025-10-08 00:02:30 (5548): Guest Log: -rw-------. 1 atlas atlas 173136076 Oct 7 22:45 HITS.46376905._129230.pool.root.1 2025-10-08 00:02:30 (5548): Guest Log: -rw-------. 1 atlas atlas 1033 Oct 7 22:46 memory_monitor_summary.json 2025-10-08 00:02:30 (5548): Guest Log: -rw-------. 1 atlas atlas 1560401 Oct 7 22:46 agis_ddmendpoints.agis.ALL.json 2025-10-08 00:02:30 (5548): Guest Log: -rw-------. 1 atlas atlas 433573 Oct 7 22:46 log.46376905._129230.job.log.tgz.1 2025-10-08 00:02:30 (5548): Guest Log: -rw-------. 1 atlas atlas 7793 Oct 7 22:46 heartbeat.json 2025-10-08 00:02:30 (5548): Guest Log: -rw-------. 1 atlas atlas 97 Oct 7 22:46 pilot_heartbeat.json 2025-10-08 00:02:30 (5548): Guest Log: -rw-------. 1 atlas atlas 814 Oct 7 22:47 pilotlog.txt 2025-10-08 00:02:30 (5548): Guest Log: -rw-------. 1 atlas atlas 2097988 Oct 7 22:47 log.46376905._129230.job.log.1 2025-10-08 00:02:30 (5548): Guest Log: -rw-------. 1 atlas atlas 357 Oct 7 22:47 output.list 2025-10-08 00:02:30 (5548): Guest Log: -rw-r--r--. 1 atlas atlas 620 Oct 7 22:47 runtime_log 2025-10-08 00:02:30 (5548): Guest Log: -rw-------. 1 atlas atlas 2549760 Oct 7 22:47 result.tar.gz 2025-10-08 00:02:30 (5548): Guest Log: -rw-r--r--. 1 atlas atlas 8615 Oct 7 22:47 runtime_log.err 2025-10-08 00:02:30 (5548): Guest Log: -rw-------. 1 atlas atlas 654 Oct 7 22:47 0aQMDmD2FQ8nsSi4ap6QjLDmwznN0nGgGQJmUXzaDmiEWNDmMr741n.diag 2025-10-08 00:02:30 (5548): Guest Log: Looking for outputfile HITS.46376905._129230.pool.root.1 2025-10-08 00:02:30 (5548): Guest Log: HITS file was successfully produced 2025-10-08 00:02:30 (5548): Guest Log: -rw-------. 1 atlas atlas 173136076 Oct 7 22:45 /home/atlas/RunAtlas/HITS.46376905._129230.pool.root.1 2025-10-08 00:02:31 (5548): Guest Log: Successfully finished t
©2025 CERN