| Name | MltKDmGc766n9Rq4apOajLDm4fhM0noT9bVoFjIUDmOOfKDm6Qttlm_1 |
| Workunit | 230550089 |
| Created | 25 Feb 2025, 11:33:21 UTC |
| Sent | 25 Feb 2025, 11:33:30 UTC |
| Report deadline | 5 Mar 2025, 11:33:30 UTC |
| Received | 26 Feb 2025, 6:01:39 UTC |
| Server state | Over |
| Outcome | Success |
| Client state | Done |
| Exit status | 0 (0x00000000) |
| Computer ID | 10862817 |
| Run time | 9 hours 4 min 32 sec |
| CPU time | 2 hours 32 min 28 sec |
| Validate state | Valid |
| Credit | 757.31 |
| Device peak FLOPS | 2.81 GFLOPS |
| Application version | ATLAS Simulation v3.01 (vbox64_mt_mcore_atlas) windows_x86_64 |
| Peak working set size | 78.20 MB |
| Peak swap size | 83.38 MB |
| Peak disk usage | 1.88 GB |
Stderr output
<core_client_version>8.0.2</core_client_version> <![CDATA[ <stderr_txt> est Log: 00:00:00.001856 main OS Release: 3.10.0-957.27.2.el7.x86_64 2025-02-25 18:19:34 (8496): Guest Log: 00:00:00.002044 main OS Version: #1 SMP Mon Jul 29 17:46:05 UTC 2019 2025-02-25 18:19:34 (8496): Guest Log: 00:00:00.002168 main Executable: /opt/VBoxGuestAdditions-5.2.32/sbin/VBoxService 2025-02-25 18:19:34 (8496): Guest Log: 00:00:00.002172 main Process ID: 1290 2025-02-25 18:19:34 (8496): Guest Log: 00:00:00.002174 main Package type: LINUX_64BITS_GENERIC 2025-02-25 18:19:34 (8496): Guest Log: 00:00:00.052962 main 5.2.32 r132073 started. Verbose level = 0 2025-02-25 18:19:38 (8496): VM state change detected. (old = 'running', new = 'paused') 2025-02-25 18:19:58 (8496): VM state change detected. (old = 'paused', new = 'running') 2025-02-25 18:20:02 (8496): Guest Log: [INFO] Probing /cvmfs/atlas.cern.ch... 2025-02-25 18:20:02 (8496): Guest Log: [INFO] Mounting shared directory 2025-02-25 18:20:05 (8496): Guest Log: 00:00:10.548651 timesync vgsvcTimeSyncWorker: Radical guest time change: -2 934 970 639 000ns (GuestNow=1 740 503 983 935 667 000 ns GuestLast=1 740 506 918 906 306 000 ns fSetTimeLastLoop=true ) 2025-02-25 18:20:08 (8496): Guest Log: [INFO] Checking for init_data.xml 2025-02-25 18:20:17 (8496): VM state change detected. (old = 'running', new = 'paused') 2025-02-25 18:20:58 (8496): VM state change detected. (old = 'paused', new = 'running') 2025-02-25 18:21:38 (8496): Guest Log: [INFO] Probing /cvmfs/atlas.cern.ch... OK 2025-02-25 18:21:38 (8496): Guest Log: [INFO] Detected branch: prod 2025-02-25 18:21:43 (8496): Guest Log: This is the prod version of the ATLAS job wrapper 2025-02-25 18:21:43 (8496): Guest Log: Copying input files 2025-02-25 18:22:08 (8496): VM state change detected. (old = 'running', new = 'paused') 2025-02-25 18:22:28 (8496): VM state change detected. (old = 'paused', new = 'running') 2025-02-25 18:22:38 (8496): VM state change detected. (old = 'running', new = 'paused') 2025-02-25 18:22:58 (8496): VM state change detected. (old = 'paused', new = 'running') 2025-02-25 18:23:08 (8496): VM state change detected. (old = 'running', new = 'paused') 2025-02-25 18:23:28 (8496): VM state change detected. (old = 'paused', new = 'running') 2025-02-25 18:24:07 (8496): Guest Log: Copied input files into RunAtlas. 2025-02-25 18:24:08 (8496): VM state change detected. (old = 'running', new = 'paused') 2025-02-25 18:24:28 (8496): VM state change detected. (old = 'paused', new = 'running') 2025-02-25 18:24:31 (8496): Guest Log: This VM did not configure a local http proxy via BOINC. 2025-02-25 18:24:31 (8496): Guest Log: Small home clusters do not require a local http proxy but it is suggested if 2025-02-25 18:24:31 (8496): Guest Log: more than 10 cores throughout the same LAN segment are regularly running ATLAS like tasks. 2025-02-25 18:24:31 (8496): Guest Log: Further information can be found at the LHC@home message board. 2025-02-25 18:25:10 (8496): Guest Log: Running cvmfs_config stat atlas.cern.ch 2025-02-25 18:25:21 (8496): 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-02-25 18:25:21 (8496): Guest Log: 2.6.3.0 1601 2 30056 143046 3 1 3117296 4096000 0 65024 0 0 n/a 0 0 http://s1cern-cvmfs.openhtc.io/cvmfs/atlas.cern.ch DIRECT 1 2025-02-25 18:25:57 (8496): Guest Log: copied the webapp to /var/www 2025-02-25 18:26:00 (8496): Guest Log: ATHENA_PROC_NUMBER=2 2025-02-25 18:26:00 (8496): Guest Log: ATHENA_CORE_NUMBER=2 2025-02-25 18:26:03 (8496): 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-02-25 18:26:05 (8496): Guest Log: *** Starting ATLAS job. (PandaID=6530099498 taskID=43401121) *** 2025-02-25 18:32:08 (8496): VM state change detected. (old = 'running', new = 'paused') 2025-02-25 18:32:29 (8496): VM state change detected. (old = 'paused', new = 'running') 2025-02-25 18:33:29 (8496): VM state change detected. (old = 'running', new = 'paused') 2025-02-25 18:33:49 (8496): VM state change detected. (old = 'paused', new = 'running') 2025-02-25 18:34:20 (8496): VM state change detected. (old = 'running', new = 'paused') 2025-02-25 18:34:39 (8496): VM state change detected. (old = 'paused', new = 'running') 2025-02-25 18:34:59 (8496): VM state change detected. (old = 'running', new = 'paused') 2025-02-25 18:35:19 (8496): VM state change detected. (old = 'paused', new = 'running') 2025-02-25 18:35:30 (8496): VM state change detected. (old = 'running', new = 'paused') 2025-02-25 18:35:49 (8496): VM state change detected. (old = 'paused', new = 'running') 2025-02-25 18:36:10 (8496): VM state change detected. (old = 'running', new = 'paused') 2025-02-25 18:36:29 (8496): VM state change detected. (old = 'paused', new = 'running') 2025-02-25 18:36:59 (8496): VM state change detected. (old = 'running', new = 'paused') 2025-02-25 18:37:19 (8496): VM state change detected. (old = 'paused', new = 'running') 2025-02-25 18:37:40 (8496): VM state change detected. (old = 'running', new = 'paused') 2025-02-25 18:37:59 (8496): VM state change detected. (old = 'paused', new = 'running') 2025-02-25 18:38:10 (8496): VM state change detected. (old = 'running', new = 'paused') 2025-02-25 18:38:29 (8496): VM state change detected. (old = 'paused', new = 'running') 2025-02-25 18:38:39 (8496): VM state change detected. (old = 'running', new = 'paused') 2025-02-25 18:39:00 (8496): VM state change detected. (old = 'paused', new = 'running') 2025-02-25 18:39:29 (8496): VM state change detected. (old = 'running', new = 'paused') 2025-02-25 18:40:09 (8496): VM state change detected. (old = 'paused', new = 'running') 2025-02-25 18:40:20 (8496): VM state change detected. (old = 'running', new = 'paused') 2025-02-25 18:40:39 (8496): VM state change detected. (old = 'paused', new = 'running') 2025-02-25 18:40:50 (8496): VM state change detected. (old = 'running', new = 'paused') 2025-02-25 18:41:09 (8496): VM state change detected. (old = 'paused', new = 'running') 2025-02-25 18:42:20 (8496): VM state change detected. (old = 'running', new = 'paused') 2025-02-25 18:42:40 (8496): VM state change detected. (old = 'paused', new = 'running') 2025-02-25 18:44:10 (8496): VM state change detected. (old = 'running', new = 'paused') 2025-02-25 18:44:31 (8496): VM state change detected. (old = 'paused', new = 'running') 2025-02-25 18:44:50 (8496): VM state change detected. (old = 'running', new = 'paused') 2025-02-25 18:45:11 (8496): VM state change detected. (old = 'paused', new = 'running') 2025-02-25 18:46:12 (8496): VM state change detected. (old = 'running', new = 'paused') 2025-02-25 18:46:51 (8496): VM state change detected. (old = 'paused', new = 'running') 2025-02-25 18:47:21 (8496): VM state change detected. (old = 'running', new = 'paused') 2025-02-25 18:47:40 (8496): VM state change detected. (old = 'paused', new = 'running') 2025-02-25 18:48:10 (8496): VM state change detected. (old = 'running', new = 'paused') 2025-02-25 18:48:31 (8496): VM state change detected. (old = 'paused', new = 'running') 2025-02-25 18:49:11 (8496): VM state change detected. (old = 'running', new = 'paused') 2025-02-25 18:49:31 (8496): VM state change detected. (old = 'paused', new = 'running') 2025-02-25 18:49:51 (8496): VM state change detected. (old = 'running', new = 'paused') 2025-02-25 18:50:31 (8496): VM state change detected. (old = 'paused', new = 'running') 2025-02-25 18:50:51 (8496): VM state change detected. (old = 'running', new = 'paused') 2025-02-25 18:51:11 (8496): VM state change detected. (old = 'paused', new = 'running') 2025-02-25 18:51:21 (8496): VM state change detected. (old = 'running', new = 'paused') 2025-02-25 18:51:41 (8496): VM state change detected. (old = 'paused', new = 'running') 2025-02-25 18:53:01 (8496): VM state change detected. (old = 'running', new = 'paused') 2025-02-25 18:53:21 (8496): VM state change detected. (old = 'paused', new = 'running') 2025-02-25 18:56:01 (8496): VM state change detected. (old = 'running', new = 'paused') 2025-02-25 18:56:21 (8496): VM state change detected. (old = 'paused', new = 'running') 2025-02-25 18:59:12 (8496): VM state change detected. (old = 'running', new = 'paused') 2025-02-25 18:59:31 (8496): VM state change detected. (old = 'paused', new = 'running') 2025-02-25 19:00:02 (8496): VM state change detected. (old = 'running', new = 'paused') 2025-02-25 19:00:23 (8496): VM state change detected. (old = 'paused', new = 'running') 2025-02-25 19:02:33 (8496): VM state change detected. (old = 'running', new = 'paused') 2025-02-25 19:02:52 (8496): VM state change detected. (old = 'paused', new = 'running') 2025-02-25 19:05:53 (8496): VM state change detected. (old = 'running', new = 'paused') 2025-02-25 19:06:12 (8496): VM state change detected. (old = 'paused', new = 'running') 2025-02-25 19:15:14 (8496): VM state change detected. (old = 'running', new = 'paused') 2025-02-25 19:15:34 (8496): VM state change detected. (old = 'paused', new = 'running') 2025-02-25 19:15:54 (8496): VM state change detected. (old = 'running', new = 'paused') 2025-02-25 19:16:14 (8496): VM state change detected. (old = 'paused', new = 'running') 2025-02-25 19:16:24 (8496): VM state change detected. (old = 'running', new = 'paused') 2025-02-25 19:16:45 (8496): VM state change detected. (old = 'paused', new = 'running') 2025-02-25 19:16:54 (8496): VM state change detected. (old = 'running', new = 'paused') 2025-02-25 19:17:15 (8496): VM state change detected. (old = 'paused', new = 'running') 2025-02-25 19:17:26 (8496): VM state change detected. (old = 'running', new = 'paused') 2025-02-25 19:23:05 (8496): VM state change detected. (old = 'paused', new = 'running') 2025-02-25 19:23:15 (8496): VM state change detected. (old = 'running', new = 'paused') 2025-02-25 19:24:15 (8496): VM state change detected. (old = 'paused', new = 'running') 2025-02-25 19:24:25 (8496): VM state change detected. (old = 'running', new = 'paused') 2025-02-25 19:24:45 (8496): VM state change detected. (old = 'paused', new = 'running') 2025-02-25 19:25:06 (8496): VM state change detected. (old = 'running', new = 'paused') 2025-02-25 19:25:25 (8496): VM state change detected. (old = 'paused', new = 'running') 2025-02-25 19:25:45 (8496): VM state change detected. (old = 'running', new = 'paused') 2025-02-25 19:26:06 (8496): VM state change detected. (old = 'paused', new = 'running') 2025-02-25 19:26:15 (8496): VM state change detected. (old = 'running', new = 'paused') 2025-02-25 19:26:55 (8496): VM state change detected. (old = 'paused', new = 'running') 2025-02-25 19:27:05 (8496): VM state change detected. (old = 'running', new = 'paused') 2025-02-25 19:27:25 (8496): VM state change detected. (old = 'paused', new = 'running') 2025-02-25 19:27:35 (8496): VM state change detected. (old = 'running', new = 'paused') 2025-02-25 19:27:55 (8496): VM state change detected. (old = 'paused', new = 'running') 2025-02-25 19:28:55 (8496): VM state change detected. (old = 'running', new = 'paused') 2025-02-25 19:29:15 (8496): VM state change detected. (old = 'paused', new = 'running') 2025-02-25 19:29:35 (8496): VM state change detected. (old = 'running', new = 'paused') 2025-02-25 19:29:56 (8496): VM state change detected. (old = 'paused', new = 'running') 2025-02-25 19:30:05 (8496): VM state change detected. (old = 'running', new = 'paused') 2025-02-25 19:30:26 (8496): VM state change detected. (old = 'paused', new = 'running') 2025-02-25 19:30:35 (8496): VM state change detected. (old = 'running', new = 'paused') 2025-02-25 19:31:17 (8496): VM state change detected. (old = 'paused', new = 'running') 2025-02-25 19:31:26 (8496): VM state change detected. (old = 'running', new = 'paused') 2025-02-25 19:31:45 (8496): VM state change detected. (old = 'paused', new = 'running') 2025-02-25 19:32:06 (8496): VM state change detected. (old = 'running', new = 'paused') 2025-02-25 19:32:25 (8496): VM state change detected. (old = 'paused', new = 'running') 2025-02-25 19:32:46 (8496): VM state change detected. (old = 'running', new = 'paused') 2025-02-25 19:33:06 (8496): VM state change detected. (old = 'paused', new = 'running') 2025-02-25 19:33:16 (8496): VM state change detected. (old = 'running', new = 'paused') 2025-02-25 19:33:36 (8496): VM state change detected. (old = 'paused', new = 'running') 2025-02-25 19:33:55 (8496): VM state change detected. (old = 'running', new = 'paused') 2025-02-25 19:34:16 (8496): VM state change detected. (old = 'paused', new = 'running') 2025-02-25 19:34:46 (8496): VM state change detected. (old = 'running', new = 'paused') 2025-02-25 19:35:07 (8496): VM state change detected. (old = 'paused', new = 'running') 2025-02-25 19:35:25 (8496): VM state change detected. (old = 'running', new = 'paused') 2025-02-25 19:35:46 (8496): VM state change detected. (old = 'paused', new = 'running') 2025-02-25 19:35:56 (8496): VM state change detected. (old = 'running', new = 'paused') 2025-02-25 19:36:17 (8496): VM state change detected. (old = 'paused', new = 'running') 2025-02-25 19:36:26 (8496): VM state change detected. (old = 'running', new = 'paused') 2025-02-25 19:36:46 (8496): VM state change detected. (old = 'paused', new = 'running') 2025-02-25 19:36:56 (8496): VM state change detected. (old = 'running', new = 'paused') 2025-02-25 19:37:16 (8496): VM state change detected. (old = 'paused', new = 'running') 2025-02-25 19:46:38 (8496): VM state change detected. (old = 'running', new = 'paused') 2025-02-25 19:46:58 (8496): VM state change detected. (old = 'paused', new = 'running') 2025-02-25 19:56:28 (8496): VM state change detected. (old = 'running', new = 'paused') 2025-02-25 19:56:48 (8496): VM state change detected. (old = 'paused', new = 'running') 2025-02-25 20:14:11 (8496): VM state change detected. (old = 'running', new = 'paused') 2025-02-25 20:14:31 (8496): VM state change detected. (old = 'paused', new = 'running') 2025-02-25 20:25:51 (8496): Status Report: Elapsed Time: '6000.307465' 2025-02-25 20:25:51 (8496): Status Report: CPU Time: '1736.750000' 2025-02-25 20:32:13 (8496): VM state change detected. (old = 'running', new = 'paused') 2025-02-25 20:32:33 (8496): VM state change detected. (old = 'paused', new = 'running') 2025-02-25 20:33:33 (8496): VM state change detected. (old = 'running', new = 'paused') 2025-02-25 20:33:53 (8496): VM state change detected. (old = 'paused', new = 'running') 2025-02-25 20:36:54 (8496): VM state change detected. (old = 'running', new = 'paused') 2025-02-25 20:37:14 (8496): VM state change detected. (old = 'paused', new = 'running') 2025-02-25 20:37:34 (8496): VM state change detected. (old = 'running', new = 'paused') 2025-02-25 20:37:54 (8496): VM state change detected. (old = 'paused', new = 'running') 2025-02-25 20:38:54 (8496): VM state change detected. (old = 'running', new = 'paused') 2025-02-25 20:39:14 (8496): VM state change detected. (old = 'paused', new = 'running') 2025-02-25 20:39:44 (8496): VM state change detected. (old = 'running', new = 'paused') 2025-02-25 20:40:04 (8496): VM state change detected. (old = 'paused', new = 'running') 2025-02-25 20:44:05 (8496): VM state change detected. (old = 'running', new = 'paused') 2025-02-25 20:44:24 (8496): VM state change detected. (old = 'paused', new = 'running') 2025-02-25 20:44:35 (8496): VM state change detected. (old = 'running', new = 'paused') 2025-02-25 20:44:55 (8496): VM state change detected. (old = 'paused', new = 'running') 2025-02-25 20:45:55 (8496): VM state change detected. (old = 'running', new = 'paused') 2025-02-25 20:46:35 (8496): VM state change detected. (old = 'paused', new = 'running') 2025-02-25 20:48:04 (8496): VM state change detected. (old = 'running', new = 'paused') 2025-02-25 20:48:25 (8496): VM state change detected. (old = 'paused', new = 'running') 2025-02-25 20:51:06 (8496): VM state change detected. (old = 'running', new = 'paused') 2025-02-25 20:53:26 (8496): VM state change detected. (old = 'paused', new = 'running') 2025-02-25 20:54:06 (8496): VM state change detected. (old = 'running', new = 'paused') 2025-02-25 20:54:26 (8496): VM state change detected. (old = 'paused', new = 'running') 2025-02-25 20:55:59 (8496): VM state change detected. (old = 'running', new = 'paused') 2025-02-25 20:56:16 (8496): VM state change detected. (old = 'paused', new = 'running') 2025-02-25 21:00:37 (8496): VM state change detected. (old = 'running', new = 'paused') 2025-02-25 21:00:39 (8496): VM state change detected. (old = 'paused', new = 'running') 2025-02-25 21:05:07 (8496): VM state change detected. (old = 'running', new = 'paused') 2025-02-25 21:05:21 (8496): VM state change detected. (old = 'paused', new = 'running') 2025-02-25 21:07:00 (8496): VM state change detected. (old = 'running', new = 'paused') 2025-02-25 21:07:21 (8496): VM state change detected. (old = 'paused', new = 'running') 2025-02-25 21:09:01 (8496): VM state change detected. (old = 'running', new = 'paused') 2025-02-25 21:09:21 (8496): VM state change detected. (old = 'paused', new = 'running') 2025-02-25 21:15:41 (8496): VM state change detected. (old = 'running', new = 'paused') 2025-02-25 21:16:02 (8496): VM state change detected. (old = 'paused', new = 'running') 2025-02-25 21:16:22 (8496): VM state change detected. (old = 'running', new = 'paused') 2025-02-25 21:17:24 (8496): VM state change detected. (old = 'paused', new = 'running') 2025-02-25 21:17:35 (8496): VM state change detected. (old = 'running', new = 'paused') 2025-02-25 21:23:52 (8496): VM state change detected. (old = 'paused', new = 'running') 2025-02-25 21:24:02 (8496): VM state change detected. (old = 'running', new = 'paused') 2025-02-25 21:24:23 (8496): VM state change detected. (old = 'paused', new = 'running') 2025-02-25 21:24:33 (8496): VM state change detected. (old = 'running', new = 'paused') 2025-02-25 21:25:13 (8496): VM state change detected. (old = 'paused', new = 'running') 2025-02-25 21:25:23 (8496): VM state change detected. (old = 'running', new = 'paused') 2025-02-25 21:25:44 (8496): VM state change detected. (old = 'paused', new = 'running') 2025-02-25 21:26:13 (8496): VM state change detected. (old = 'running', new = 'paused') 2025-02-25 21:26:34 (8496): VM state change detected. (old = 'paused', new = 'running') 2025-02-25 21:26:54 (8496): VM state change detected. (old = 'running', new = 'paused') 2025-02-25 21:27:13 (8496): VM state change detected. (old = 'paused', new = 'running') 2025-02-25 21:28:43 (8496): VM state change detected. (old = 'running', new = 'paused') 2025-02-25 21:29:03 (8496): VM state change detected. (old = 'paused', new = 'running') 2025-02-25 21:29:34 (8496): VM state change detected. (old = 'running', new = 'paused') 2025-02-25 21:29:53 (8496): VM state change detected. (old = 'paused', new = 'running') 2025-02-25 21:30:23 (8496): VM state change detected. (old = 'running', new = 'paused') 2025-02-25 21:30:44 (8496): VM state change detected. (old = 'paused', new = 'running') 2025-02-25 21:31:03 (8496): VM state change detected. (old = 'running', new = 'paused') 2025-02-25 21:31:24 (8496): VM state change detected. (old = 'paused', new = 'running') 2025-02-25 21:31:34 (8496): VM state change detected. (old = 'running', new = 'paused') 2025-02-25 21:32:13 (8496): VM state change detected. (old = 'paused', new = 'running') 2025-02-25 21:32:24 (8496): VM state change detected. (old = 'running', new = 'paused') 2025-02-25 21:32:44 (8496): VM state change detected. (old = 'paused', new = 'running') 2025-02-25 21:32:54 (8496): VM state change detected. (old = 'running', new = 'paused') 2025-02-25 21:33:13 (8496): VM state change detected. (old = 'paused', new = 'running') 2025-02-25 21:33:26 (8496): VM state change detected. (old = 'running', new = 'paused') 2025-02-25 21:33:43 (8496): VM state change detected. (old = 'paused', new = 'running') 2025-02-25 21:34:44 (8496): VM state change detected. (old = 'running', new = 'paused') 2025-02-25 21:35:04 (8496): VM state change detected. (old = 'paused', new = 'running') 2025-02-25 21:35:24 (8496): VM state change detected. (old = 'running', new = 'paused') 2025-02-25 21:35:45 (8496): VM state change detected. (old = 'paused', new = 'running') 2025-02-25 21:35:54 (8496): VM state change detected. (old = 'running', new = 'paused') 2025-02-25 21:36:15 (8496): VM state change detected. (old = 'paused', new = 'running') 2025-02-25 21:36:25 (8496): VM state change detected. (old = 'running', new = 'paused') 2025-02-25 21:37:25 (8496): VM state change detected. (old = 'paused', new = 'running') 2025-02-25 21:38:15 (8496): VM state change detected. (old = 'running', new = 'paused') 2025-02-25 21:38:34 (8496): VM state change detected. (old = 'paused', new = 'running') 2025-02-25 21:39:35 (8496): VM state change detected. (old = 'running', new = 'paused') 2025-02-25 21:39:54 (8496): VM state change detected. (old = 'paused', new = 'running') 2025-02-25 21:40:05 (8496): VM state change detected. (old = 'running', new = 'paused') 2025-02-25 21:40:24 (8496): VM state change detected. (old = 'paused', new = 'running') 2025-02-25 21:40:45 (8496): VM state change detected. (old = 'running', new = 'paused') 2025-02-25 21:41:05 (8496): VM state change detected. (old = 'paused', new = 'running') 2025-02-25 21:41:24 (8496): VM state change detected. (old = 'running', new = 'paused') 2025-02-25 21:41:45 (8496): VM state change detected. (old = 'paused', new = 'running') 2025-02-25 21:42:25 (8496): VM state change detected. (old = 'running', new = 'paused') 2025-02-25 21:42:45 (8496): VM state change detected. (old = 'paused', new = 'running') 2025-02-25 21:46:15 (8496): VM state change detected. (old = 'running', new = 'paused') 2025-02-25 21:46:35 (8496): VM state change detected. (old = 'paused', new = 'running') 2025-02-25 21:46:46 (8496): VM state change detected. (old = 'running', new = 'paused') 2025-02-25 21:47:06 (8496): VM state change detected. (old = 'paused', new = 'running') 2025-02-25 21:47:35 (8496): VM state change detected. (old = 'running', new = 'paused') 2025-02-25 21:47:55 (8496): VM state change detected. (old = 'paused', new = 'running') 2025-02-25 21:51:27 (8496): VM state change detected. (old = 'running', new = 'paused') 2025-02-25 21:51:47 (8496): VM state change detected. (old = 'paused', new = 'running') 2025-02-25 21:54:17 (8496): VM state change detected. (old = 'running', new = 'paused') 2025-02-25 21:54:37 (8496): VM state change detected. (old = 'paused', new = 'running') 2025-02-25 21:57:37 (8496): VM state change detected. (old = 'running', new = 'paused') 2025-02-25 21:57:57 (8496): VM state change detected. (old = 'paused', new = 'running') 2025-02-25 22:07:59 (8496): VM state change detected. (old = 'running', new = 'paused') 2025-02-25 22:08:18 (8496): VM state change detected. (old = 'paused', new = 'running') 2025-02-25 22:08:48 (8496): VM state change detected. (old = 'running', new = 'paused') 2025-02-25 22:09:09 (8496): VM state change detected. (old = 'paused', new = 'running') 2025-02-25 22:09:29 (8496): VM state change detected. (old = 'running', new = 'paused') 2025-02-25 22:09:48 (8496): VM state change detected. (old = 'paused', new = 'running') 2025-02-25 22:09:59 (8496): VM state change detected. (old = 'running', new = 'paused') 2025-02-25 22:10:19 (8496): VM state change detected. (old = 'paused', new = 'running') 2025-02-25 22:10:28 (8496): VM state change detected. (old = 'running', new = 'paused') 2025-02-25 22:11:09 (8496): VM state change detected. (old = 'paused', new = 'running') 2025-02-25 22:11:19 (8496): VM state change detected. (old = 'running', new = 'paused') 2025-02-25 22:11:39 (8496): VM state change detected. (old = 'paused', new = 'running') 2025-02-25 22:12:08 (8496): VM state change detected. (old = 'running', new = 'paused') 2025-02-25 22:12:49 (8496): VM state change detected. (old = 'paused', new = 'running') 2025-02-25 22:12:59 (8496): VM state change detected. (old = 'running', new = 'paused') 2025-02-25 22:13:20 (8496): VM state change detected. (old = 'paused', new = 'running') 2025-02-25 22:13:29 (8496): VM state change detected. (old = 'running', new = 'paused') 2025-02-25 22:14:09 (8496): VM state change detected. (old = 'paused', new = 'running') 2025-02-25 22:14:19 (8496): VM state change detected. (old = 'running', new = 'paused') 2025-02-25 22:15:59 (8496): VM state change detected. (old = 'paused', new = 'running') 2025-02-25 22:16:09 (8496): VM state change detected. (old = 'running', new = 'paused') 2025-02-25 22:16:30 (8496): VM state change detected. (old = 'paused', new = 'running') 2025-02-25 22:16:39 (8496): VM state change detected. (old = 'running', new = 'paused') 2025-02-25 22:17:01 (8496): VM state change detected. (old = 'paused', new = 'running') 2025-02-25 22:17:10 (8496): VM state change detected. (old = 'running', new = 'paused') 2025-02-25 22:17:29 (8496): VM state change detected. (old = 'paused', new = 'running') 2025-02-25 22:17:39 (8496): VM state change detected. (old = 'running', new = 'paused') 2025-02-25 22:17:59 (8496): VM state change detected. (old = 'paused', new = 'running') 2025-02-25 22:18:09 (8496): VM state change detected. (old = 'running', new = 'paused') 2025-02-25 22:18:30 (8496): VM state change detected. (old = 'paused', new = 'running') 2025-02-25 22:18:40 (8496): VM state change detected. (old = 'running', new = 'paused') 2025-02-25 22:18:59 (8496): VM state change detected. (old = 'paused', new = 'running') 2025-02-25 22:19:30 (8496): VM state change detected. (old = 'running', new = 'paused') 2025-02-25 22:19:49 (8496): VM state change detected. (old = 'paused', new = 'running') 2025-02-25 22:20:10 (8496): VM state change detected. (old = 'running', new = 'paused') 2025-02-25 22:20:30 (8496): VM state change detected. (old = 'paused', new = 'running') 2025-02-25 22:24:20 (8496): VM state change detected. (old = 'running', new = 'paused') 2025-02-25 22:24:41 (8496): VM state change detected. (old = 'paused', new = 'running') 2025-02-25 22:37:32 (8496): VM state change detected. (old = 'running', new = 'paused') 2025-02-25 22:37:52 (8496): VM state change detected. (old = 'paused', new = 'running') 2025-02-25 22:39:42 (8496): VM state change detected. (old = 'running', new = 'paused') 2025-02-25 22:40:02 (8496): VM state change detected. (old = 'paused', new = 'running') 2025-02-25 22:40:11 (8496): VM state change detected. (old = 'running', new = 'paused') 2025-02-25 22:40:32 (8496): VM state change detected. (old = 'paused', new = 'running') 2025-02-25 22:44:43 (8496): VM state change detected. (old = 'running', new = 'paused') 2025-02-25 22:45:03 (8496): VM state change detected. (old = 'paused', new = 'running') 2025-02-25 22:45:44 (8496): VM state change detected. (old = 'running', new = 'paused') 2025-02-25 22:46:03 (8496): VM state change detected. (old = 'paused', new = 'running') 2025-02-25 22:46:33 (8496): VM state change detected. (old = 'running', new = 'paused') 2025-02-25 22:46:53 (8496): VM state change detected. (old = 'paused', new = 'running') 2025-02-25 22:47:04 (8496): VM state change detected. (old = 'running', new = 'paused') 2025-02-25 22:47:23 (8496): VM state change detected. (old = 'paused', new = 'running') 2025-02-25 22:47:33 (8496): VM state change detected. (old = 'running', new = 'paused') 2025-02-25 22:49:34 (8496): VM state change detected. (old = 'paused', new = 'running') 2025-02-25 22:49:43 (8496): VM state change detected. (old = 'running', new = 'paused') 2025-02-25 22:50:03 (8496): VM state change detected. (old = 'paused', new = 'running') 2025-02-25 22:50:13 (8496): VM state change detected. (old = 'running', new = 'paused') 2025-02-25 22:50:47 (8496): VM state change detected. (old = 'paused', new = 'running') 2025-02-25 22:51:53 (8496): VM state change detected. (old = 'running', new = 'paused') 2025-02-25 22:52:13 (8496): VM state change detected. (old = 'paused', new = 'running') 2025-02-25 22:52:49 (8496): Status Report: Elapsed Time: '12001.120081' 2025-02-25 22:52:49 (8496): Status Report: CPU Time: '3519.250000' 2025-02-25 22:53:54 (8496): VM state change detected. (old = 'running', new = 'paused') 2025-02-25 22:54:14 (8496): VM state change detected. (old = 'paused', new = 'running') 2025-02-25 23:16:56 (8496): VM state change detected. (old = 'running', new = 'paused') 2025-02-25 23:17:17 (8496): VM state change detected. (old = 'paused', new = 'running') 2025-02-25 23:17:27 (8496): VM state change detected. (old = 'running', new = 'paused') 2025-02-25 23:17:46 (8496): VM state change detected. (old = 'paused', new = 'running') 2025-02-25 23:17:56 (8496): VM state change detected. (old = 'running', new = 'paused') 2025-02-25 23:18:17 (8496): VM state change detected. (old = 'paused', new = 'running') 2025-02-25 23:18:27 (8496): VM state change detected. (old = 'running', new = 'paused') 2025-02-25 23:28:50 (8496): VM state change detected. (old = 'paused', new = 'running') 2025-02-25 23:29:00 (8496): VM state change detected. (old = 'running', new = 'paused') 2025-02-25 23:29:20 (8496): VM state change detected. (old = 'paused', new = 'running') 2025-02-25 23:29:30 (8496): VM state change detected. (old = 'running', new = 'paused') 2025-02-25 23:29:50 (8496): VM state change detected. (old = 'paused', new = 'running') 2025-02-25 23:30:01 (8496): VM state change detected. (old = 'running', new = 'paused') 2025-02-25 23:33:01 (8496): VM state change detected. (old = 'paused', new = 'running') 2025-02-25 23:33:11 (8496): VM state change detected. (old = 'running', new = 'paused') 2025-02-25 23:33:31 (8496): VM state change detected. (old = 'paused', new = 'running') 2025-02-25 23:33:41 (8496): VM state change detected. (old = 'running', new = 'paused') 2025-02-25 23:34:01 (8496): VM state change detected. (old = 'paused', new = 'running') 2025-02-25 23:34:21 (8496): VM state change detected. (old = 'running', new = 'paused') 2025-02-25 23:34:41 (8496): VM state change detected. (old = 'paused', new = 'running') 2025-02-25 23:34:51 (8496): VM state change detected. (old = 'running', new = 'paused') 2025-02-25 23:35:10 (8496): VM state change detected. (old = 'paused', new = 'running') 2025-02-25 23:35:20 (8496): VM state change detected. (old = 'running', new = 'paused') 2025-02-25 23:35:40 (8496): VM state change detected. (old = 'paused', new = 'running') 2025-02-25 23:36:01 (8496): VM state change detected. (old = 'running', new = 'paused') 2025-02-25 23:36:21 (8496): VM state change detected. (old = 'paused', new = 'running') 2025-02-25 23:36:31 (8496): VM state change detected. (old = 'running', new = 'paused') 2025-02-25 23:36:51 (8496): VM state change detected. (old = 'paused', new = 'running') 2025-02-25 23:37:11 (8496): VM state change detected. (old = 'running', new = 'paused') 2025-02-25 23:37:31 (8496): VM state change detected. (old = 'paused', new = 'running') 2025-02-25 23:37:41 (8496): VM state change detected. (old = 'running', new = 'paused') 2025-02-25 23:38:01 (8496): VM state change detected. (old = 'paused', new = 'running') 2025-02-25 23:38:31 (8496): VM state change detected. (old = 'running', new = 'paused') 2025-02-25 23:38:52 (8496): VM state change detected. (old = 'paused', new = 'running') 2025-02-25 23:39:01 (8496): VM state change detected. (old = 'running', new = 'paused') 2025-02-25 23:39:21 (8496): VM state change detected. (old = 'paused', new = 'running') 2025-02-25 23:40:01 (8496): VM state change detected. (old = 'running', new = 'paused') 2025-02-25 23:40:21 (8496): VM state change detected. (old = 'paused', new = 'running') 2025-02-25 23:43:51 (8496): VM state change detected. (old = 'running', new = 'paused') 2025-02-25 23:44:32 (8496): VM state change detected. (old = 'paused', new = 'running') 2025-02-25 23:44:42 (8496): VM state change detected. (old = 'running', new = 'paused') 2025-02-25 23:45:02 (8496): VM state change detected. (old = 'paused', new = 'running') 2025-02-25 23:47:53 (8496): VM state change detected. (old = 'running', new = 'paused') 2025-02-25 23:48:13 (8496): VM state change detected. (old = 'paused', new = 'running') 2025-02-25 23:52:32 (8496): VM state change detected. (old = 'running', new = 'paused') 2025-02-25 23:52:52 (8496): VM state change detected. (old = 'paused', new = 'running') 2025-02-25 23:54:53 (8496): VM state change detected. (old = 'running', new = 'paused') 2025-02-25 23:55:13 (8496): VM state change detected. (old = 'paused', new = 'running') 2025-02-25 23:57:54 (8496): VM state change detected. (old = 'running', new = 'paused') 2025-02-25 23:58:14 (8496): VM state change detected. (old = 'paused', new = 'running') 2025-02-26 00:03:55 (8496): VM state change detected. (old = 'running', new = 'paused') 2025-02-26 00:04:15 (8496): VM state change detected. (old = 'paused', new = 'running') 2025-02-26 00:09:05 (8496): VM state change detected. (old = 'running', new = 'paused') 2025-02-26 00:09:25 (8496): VM state change detected. (old = 'paused', new = 'running') 2025-02-26 00:09:45 (8496): VM state change detected. (old = 'running', new = 'paused') 2025-02-26 00:10:05 (8496): VM state change detected. (old = 'paused', new = 'running') 2025-02-26 00:12:55 (8496): VM state change detected. (old = 'running', new = 'paused') 2025-02-26 00:13:15 (8496): VM state change detected. (old = 'paused', new = 'running') 2025-02-26 00:17:26 (8496): VM state change detected. (old = 'running', new = 'paused') 2025-02-26 00:17:46 (8496): VM state change detected. (old = 'paused', new = 'running') 2025-02-26 00:18:06 (8496): VM state change detected. (old = 'running', new = 'paused') 2025-02-26 00:18:25 (8496): VM state change detected. (old = 'paused', new = 'running') 2025-02-26 00:22:36 (8496): VM state change detected. (old = 'running', new = 'paused') 2025-02-26 00:22:56 (8496): VM state change detected. (old = 'paused', new = 'running') 2025-02-26 00:24:17 (8496): VM state change detected. (old = 'running', new = 'paused') 2025-02-26 00:24:37 (8496): VM state change detected. (old = 'paused', new = 'running') 2025-02-26 00:25:56 (8496): VM state change detected. (old = 'running', new = 'paused') 2025-02-26 00:26:16 (8496): VM state change detected. (old = 'paused', new = 'running') 2025-02-26 00:30:37 (8496): VM state change detected. (old = 'running', new = 'paused') 2025-02-26 00:30:57 (8496): VM state change detected. (old = 'paused', new = 'running') 2025-02-26 00:31:48 (8496): VM state change detected. (old = 'running', new = 'paused') 2025-02-26 00:32:08 (8496): VM state change detected. (old = 'paused', new = 'running') 2025-02-26 00:33:18 (8496): VM state change detected. (old = 'running', new = 'paused') 2025-02-26 00:33:38 (8496): VM state change detected. (old = 'paused', new = 'running') 2025-02-26 00:33:58 (8496): VM state change detected. (old = 'running', new = 'paused') 2025-02-26 00:34:38 (8496): VM state change detected. (old = 'paused', new = 'running') 2025-02-26 00:34:48 (8496): VM state change detected. (old = 'running', new = 'paused') 2025-02-26 00:35:08 (8496): VM state change detected. (old = 'paused', new = 'running') 2025-02-26 00:35:18 (8496): VM state change detected. (old = 'running', new = 'paused') 2025-02-26 00:35:38 (8496): VM state change detected. (old = 'paused', new = 'running') 2025-02-26 00:36:18 (8496): VM state change detected. (old = 'running', new = 'paused') 2025-02-26 00:36:38 (8496): VM state change detected. (old = 'paused', new = 'running') 2025-02-26 00:36:48 (8496): VM state change detected. (old = 'running', new = 'paused') 2025-02-26 00:37:08 (8496): VM state change detected. (old = 'paused', new = 'running') 2025-02-26 00:37:18 (8496): VM state change detected. (old = 'running', new = 'paused') 2025-02-26 00:37:38 (8496): VM state change detected. (old = 'paused', new = 'running') 2025-02-26 00:38:08 (8496): VM state change detected. (old = 'running', new = 'paused') 2025-02-26 00:38:28 (8496): VM state change detected. (old = 'paused', new = 'running') 2025-02-26 00:38:59 (8496): VM state change detected. (old = 'running', new = 'paused') 2025-02-26 00:39:19 (8496): VM state change detected. (old = 'paused', new = 'running') 2025-02-26 00:39:39 (8496): VM state change detected. (old = 'running', new = 'paused') 2025-02-26 00:39:58 (8496): VM state change detected. (old = 'paused', new = 'running') 2025-02-26 00:40:08 (8496): VM state change detected. (old = 'running', new = 'paused') 2025-02-26 00:40:28 (8496): VM state change detected. (old = 'paused', new = 'running') 2025-02-26 00:40:48 (8496): VM state change detected. (old = 'running', new = 'paused') 2025-02-26 00:41:28 (8496): VM state change detected. (old = 'paused', new = 'running') 2025-02-26 00:41:39 (8496): VM state change detected. (old = 'running', new = 'paused') 2025-02-26 00:41:59 (8496): VM state change detected. (old = 'paused', new = 'running') 2025-02-26 00:42:09 (8496): VM state change detected. (old = 'running', new = 'paused') 2025-02-26 00:42:29 (8496): VM state change detected. (old = 'paused', new = 'running') 2025-02-26 00:42:49 (8496): VM state change detected. (old = 'running', new = 'paused') 2025-02-26 00:43:09 (8496): VM state change detected. (old = 'paused', new = 'running') 2025-02-26 00:43:39 (8496): VM state change detected. (old = 'running', new = 'paused') 2025-02-26 00:43:59 (8496): VM state change detected. (old = 'paused', new = 'running') 2025-02-26 00:44:09 (8496): VM state change detected. (old = 'running', new = 'paused') 2025-02-26 00:44:29 (8496): VM state change detected. (old = 'paused', new = 'running') 2025-02-26 00:44:39 (8496): VM state change detected. (old = 'running', new = 'paused') 2025-02-26 00:44:59 (8496): VM state change detected. (old = 'paused', new = 'running') 2025-02-26 00:47:29 (8496): VM state change detected. (old = 'running', new = 'paused') 2025-02-26 00:47:49 (8496): VM state change detected. (old = 'paused', new = 'running') 2025-02-26 00:56:20 (8496): VM state change detected. (old = 'running', new = 'paused') 2025-02-26 00:56:40 (8496): VM state change detected. (old = 'paused', new = 'running') 2025-02-26 00:57:11 (8496): VM state change detected. (old = 'running', new = 'paused') 2025-02-26 00:57:31 (8496): VM state change detected. (old = 'paused', new = 'running') 2025-02-26 00:59:01 (8496): VM state change detected. (old = 'running', new = 'paused') 2025-02-26 00:59:20 (8496): VM state change detected. (old = 'paused', new = 'running') 2025-02-26 00:59:32 (8496): VM state change detected. (old = 'running', new = 'paused') 2025-02-26 01:04:51 (8496): VM state change detected. (old = 'paused', new = 'running') 2025-02-26 01:05:02 (8496): VM state change detected. (old = 'running', new = 'paused') 2025-02-26 01:13:43 (8496): VM state change detected. (old = 'paused', new = 'running') 2025-02-26 01:13:53 (8496): VM state change detected. (old = 'running', new = 'paused') 2025-02-26 01:38:36 (8496): VM state change detected. (old = 'paused', new = 'running') 2025-02-26 01:38:53 (8496): Guest Log: 04:57:58.280949 timesync vgsvcTimeSyncWorker: Radical guest time change: 2 015 212 174 000ns (GuestNow=1 740 530 333 040 794 000 ns GuestLast=1 740 528 317 828 620 000 ns fSetTimeLastLoop=true ) 2025-02-26 01:40:57 (8496): VM state change detected. (old = 'running', new = 'paused') 2025-02-26 01:41:17 (8496): VM state change detected. (old = 'paused', new = 'running') 2025-02-26 01:46:42 (8496): Status Report: Elapsed Time: '18001.607962' 2025-02-26 01:46:42 (8496): Status Report: CPU Time: '5251.593750' 2025-02-26 01:49:08 (8496): VM state change detected. (old = 'running', new = 'paused') 2025-02-26 01:49:28 (8496): VM state change detected. (old = 'paused', new = 'running') 2025-02-26 01:49:38 (8496): VM state change detected. (old = 'running', new = 'paused') 2025-02-26 01:49:58 (8496): VM state change detected. (old = 'paused', new = 'running') 2025-02-26 01:50:57 (8496): VM state change detected. (old = 'running', new = 'paused') 2025-02-26 01:51:18 (8496): VM state change detected. (old = 'paused', new = 'running') 2025-02-26 01:55:19 (8496): VM state change detected. (old = 'running', new = 'paused') 2025-02-26 01:55:38 (8496): VM state change detected. (old = 'paused', new = 'running') 2025-02-26 01:59:19 (8496): VM state change detected. (old = 'running', new = 'paused') 2025-02-26 01:59:40 (8496): VM state change detected. (old = 'paused', new = 'running') 2025-02-26 02:01:34 (8496): VM state change detected. (old = 'running', new = 'paused') 2025-02-26 02:01:54 (8496): VM state change detected. (old = 'paused', new = 'running') 2025-02-26 02:04:44 (8496): VM state change detected. (old = 'running', new = 'paused') 2025-02-26 02:05:04 (8496): VM state change detected. (old = 'paused', new = 'running') 2025-02-26 02:12:16 (8496): VM state change detected. (old = 'running', new = 'paused') 2025-02-26 02:12:35 (8496): VM state change detected. (old = 'paused', new = 'running') 2025-02-26 02:13:45 (8496): VM state change detected. (old = 'running', new = 'paused') 2025-02-26 02:14:06 (8496): VM state change detected. (old = 'paused', new = 'running') 2025-02-26 02:14:35 (8496): VM state change detected. (old = 'running', new = 'paused') 2025-02-26 02:14:56 (8496): VM state change detected. (old = 'paused', new = 'running') 2025-02-26 02:20:23 (8496): VM state change detected. (old = 'running', new = 'paused') 2025-02-26 02:20:36 (8496): VM state change detected. (old = 'paused', new = 'running') 2025-02-26 02:35:18 (8496): VM state change detected. (old = 'running', new = 'paused') 2025-02-26 02:35:38 (8496): VM state change detected. (old = 'paused', new = 'running') 2025-02-26 02:36:28 (8496): VM state change detected. (old = 'running', new = 'paused') 2025-02-26 02:36:47 (8496): VM state change detected. (old = 'paused', new = 'running') 2025-02-26 02:37:58 (8496): VM state change detected. (old = 'running', new = 'paused') 2025-02-26 02:38:17 (8496): VM state change detected. (old = 'paused', new = 'running') 2025-02-26 02:38:38 (8496): VM state change detected. (old = 'running', new = 'paused') 2025-02-26 02:38:58 (8496): VM state change detected. (old = 'paused', new = 'running') 2025-02-26 02:39:08 (8496): VM state change detected. (old = 'running', new = 'paused') 2025-02-26 02:39:28 (8496): VM state change detected. (old = 'paused', new = 'running') 2025-02-26 02:41:18 (8496): VM state change detected. (old = 'running', new = 'paused') 2025-02-26 02:41:39 (8496): VM state change detected. (old = 'paused', new = 'running') 2025-02-26 02:46:19 (8496): VM state change detected. (old = 'running', new = 'paused') 2025-02-26 02:46:38 (8496): VM state change detected. (old = 'paused', new = 'running') 2025-02-26 02:48:59 (8496): VM state change detected. (old = 'running', new = 'paused') 2025-02-26 02:49:19 (8496): VM state change detected. (old = 'paused', new = 'running') 2025-02-26 02:50:29 (8496): VM state change detected. (old = 'running', new = 'paused') 2025-02-26 02:50:49 (8496): VM state change detected. (old = 'paused', new = 'running') 2025-02-26 03:03:50 (8496): VM state change detected. (old = 'running', new = 'paused') 2025-02-26 03:04:11 (8496): VM state change detected. (old = 'paused', new = 'running') 2025-02-26 03:04:22 (8496): VM state change detected. (old = 'running', new = 'paused') 2025-02-26 03:04:41 (8496): VM state change detected. (old = 'paused', new = 'running') 2025-02-26 03:14:22 (8496): VM state change detected. (old = 'running', new = 'paused') 2025-02-26 03:14:42 (8496): VM state change detected. (old = 'paused', new = 'running') 2025-02-26 03:18:02 (8496): VM state change detected. (old = 'running', new = 'paused') 2025-02-26 03:18:22 (8496): VM state change detected. (old = 'paused', new = 'running') 2025-02-26 03:18:32 (8496): VM state change detected. (old = 'running', new = 'paused') 2025-02-26 03:19:12 (8496): VM state change detected. (old = 'paused', new = 'running') 2025-02-26 03:19:23 (8496): VM state change detected. (old = 'running', new = 'paused') 2025-02-26 03:24:46 (8496): VM state change detected. (old = 'paused', new = 'running') 2025-02-26 03:24:53 (8496): VM state change detected. (old = 'running', new = 'paused') 2025-02-26 03:25:13 (8496): VM state change detected. (old = 'paused', new = 'running') 2025-02-26 03:25:23 (8496): VM state change detected. (old = 'running', new = 'paused') 2025-02-26 03:25:43 (8496): VM state change detected. (old = 'paused', new = 'running') 2025-02-26 03:25:53 (8496): VM state change detected. (old = 'running', new = 'paused') 2025-02-26 03:26:14 (8496): VM state change detected. (old = 'paused', new = 'running') 2025-02-26 03:26:33 (8496): VM state change detected. (old = 'running', new = 'paused') 2025-02-26 03:26:53 (8496): VM state change detected. (old = 'paused', new = 'running') 2025-02-26 03:27:13 (8496): VM state change detected. (old = 'running', new = 'paused') 2025-02-26 03:27:33 (8496): VM state change detected. (old = 'paused', new = 'running') 2025-02-26 03:28:24 (8496): VM state change detected. (old = 'running', new = 'paused') 2025-02-26 03:28:43 (8496): VM state change detected. (old = 'paused', new = 'running') 2025-02-26 03:28:53 (8496): VM state change detected. (old = 'running', new = 'paused') 2025-02-26 03:29:14 (8496): VM state change detected. (old = 'paused', new = 'running') 2025-02-26 03:29:23 (8496): VM state change detected. (old = 'running', new = 'paused') 2025-02-26 03:29:43 (8496): VM state change detected. (old = 'paused', new = 'running') 2025-02-26 03:30:03 (8496): VM state change detected. (old = 'running', new = 'paused') 2025-02-26 03:31:24 (8496): VM state change detected. (old = 'paused', new = 'running') 2025-02-26 03:31:33 (8496): VM state change detected. (old = 'running', new = 'paused') 2025-02-26 03:31:55 (8496): VM state change detected. (old = 'paused', new = 'running') 2025-02-26 03:32:05 (8496): VM state change detected. (old = 'running', new = 'paused') 2025-02-26 03:32:24 (8496): VM state change detected. (old = 'paused', new = 'running') 2025-02-26 03:32:44 (8496): VM state change detected. (old = 'running', new = 'paused') 2025-02-26 03:33:04 (8496): VM state change detected. (old = 'paused', new = 'running') 2025-02-26 03:33:14 (8496): VM state change detected. (old = 'running', new = 'paused') 2025-02-26 03:33:35 (8496): VM state change detected. (old = 'paused', new = 'running') 2025-02-26 03:33:44 (8496): VM state change detected. (old = 'running', new = 'paused') 2025-02-26 03:34:04 (8496): VM state change detected. (old = 'paused', new = 'running') 2025-02-26 03:34:14 (8496): VM state change detected. (old = 'running', new = 'paused') 2025-02-26 03:39:15 (8496): VM state change detected. (old = 'paused', new = 'running') 2025-02-26 03:39:25 (8496): VM state change detected. (old = 'running', new = 'paused') 2025-02-26 03:39:46 (8496): VM state change detected. (old = 'paused', new = 'running') 2025-02-26 03:39:56 (8496): VM state change detected. (old = 'running', new = 'paused') 2025-02-26 03:40:18 (8496): VM state change detected. (old = 'paused', new = 'running') 2025-02-26 03:40:25 (8496): VM state change detected. (old = 'running', new = 'paused') 2025-02-26 03:40:45 (8496): VM state change detected. (old = 'paused', new = 'running') 2025-02-26 03:41:15 (8496): VM state change detected. (old = 'running', new = 'paused') 2025-02-26 03:41:35 (8496): VM state change detected. (old = 'paused', new = 'running') 2025-02-26 03:53:16 (8496): VM state change detected. (old = 'running', new = 'paused') 2025-02-26 03:53:36 (8496): VM state change detected. (old = 'paused', new = 'running') 2025-02-26 03:53:56 (8496): VM state change detected. (old = 'running', new = 'paused') 2025-02-26 03:54:16 (8496): VM state change detected. (old = 'paused', new = 'running') 2025-02-26 03:54:56 (8496): VM state change detected. (old = 'running', new = 'paused') 2025-02-26 03:55:16 (8496): VM state change detected. (old = 'paused', new = 'running') 2025-02-26 04:00:11 (8496): Status Report: Elapsed Time: '24002.476200' 2025-02-26 04:00:11 (8496): Status Report: CPU Time: '7039.828125' 2025-02-26 04:05:10 (8496): VM state change detected. (old = 'running', new = 'paused') 2025-02-26 04:06:28 (8496): VM state change detected. (old = 'paused', new = 'running') 2025-02-26 04:11:29 (8496): VM state change detected. (old = 'running', new = 'paused') 2025-02-26 04:11:49 (8496): VM state change detected. (old = 'paused', new = 'running') 2025-02-26 04:15:29 (8496): VM state change detected. (old = 'running', new = 'paused') 2025-02-26 04:15:49 (8496): VM state change detected. (old = 'paused', new = 'running') 2025-02-26 04:18:30 (8496): VM state change detected. (old = 'running', new = 'paused') 2025-02-26 04:18:50 (8496): VM state change detected. (old = 'paused', new = 'running') 2025-02-26 04:22:40 (8496): VM state change detected. (old = 'running', new = 'paused') 2025-02-26 04:23:00 (8496): VM state change detected. (old = 'paused', new = 'running') 2025-02-26 04:23:31 (8496): VM state change detected. (old = 'running', new = 'paused') 2025-02-26 04:23:51 (8496): VM state change detected. (old = 'paused', new = 'running') 2025-02-26 04:24:51 (8496): VM state change detected. (old = 'running', new = 'paused') 2025-02-26 04:25:11 (8496): VM state change detected. (old = 'paused', new = 'running') 2025-02-26 04:27:11 (8496): VM state change detected. (old = 'running', new = 'paused') 2025-02-26 04:27:31 (8496): VM state change detected. (old = 'paused', new = 'running') 2025-02-26 04:28:01 (8496): VM state change detected. (old = 'running', new = 'paused') 2025-02-26 04:29:01 (8496): VM state change detected. (old = 'paused', new = 'running') 2025-02-26 04:31:12 (8496): VM state change detected. (old = 'running', new = 'paused') 2025-02-26 04:31:32 (8496): VM state change detected. (old = 'paused', new = 'running') 2025-02-26 04:32:22 (8496): VM state change detected. (old = 'running', new = 'paused') 2025-02-26 04:32:42 (8496): VM state change detected. (old = 'paused', new = 'running') 2025-02-26 04:36:43 (8496): VM state change detected. (old = 'running', new = 'paused') 2025-02-26 04:37:02 (8496): VM state change detected. (old = 'paused', new = 'running') 2025-02-26 04:39:33 (8496): VM state change detected. (old = 'running', new = 'paused') 2025-02-26 04:39:53 (8496): VM state change detected. (old = 'paused', new = 'running') 2025-02-26 04:40:43 (8496): VM state change detected. (old = 'running', new = 'paused') 2025-02-26 04:41:03 (8496): VM state change detected. (old = 'paused', new = 'running') 2025-02-26 04:41:53 (8496): VM state change detected. (old = 'running', new = 'paused') 2025-02-26 04:42:13 (8496): VM state change detected. (old = 'paused', new = 'running') 2025-02-26 04:43:03 (8496): VM state change detected. (old = 'running', new = 'paused') 2025-02-26 04:43:23 (8496): VM state change detected. (old = 'paused', new = 'running') 2025-02-26 04:43:33 (8496): VM state change detected. (old = 'running', new = 'paused') 2025-02-26 04:43:54 (8496): VM state change detected. (old = 'paused', new = 'running') 2025-02-26 04:44:03 (8496): VM state change detected. (old = 'running', new = 'paused') 2025-02-26 04:44:43 (8496): VM state change detected. (old = 'paused', new = 'running') 2025-02-26 04:51:30 (8496): VM state change detected. (old = 'running', new = 'paused') 2025-02-26 04:51:44 (8496): VM state change detected. (old = 'paused', new = 'running') 2025-02-26 05:07:56 (8496): VM state change detected. (old = 'running', new = 'paused') 2025-02-26 05:08:36 (8496): VM state change detected. (old = 'paused', new = 'running') 2025-02-26 05:18:37 (8496): VM state change detected. (old = 'running', new = 'paused') 2025-02-26 05:18:57 (8496): VM state change detected. (old = 'paused', new = 'running') 2025-02-26 05:19:08 (8496): VM state change detected. (old = 'running', new = 'paused') 2025-02-26 05:19:28 (8496): VM state change detected. (old = 'paused', new = 'running') 2025-02-26 05:19:48 (8496): VM state change detected. (old = 'running', new = 'paused') 2025-02-26 05:20:09 (8496): VM state change detected. (old = 'paused', new = 'running') 2025-02-26 05:20:19 (8496): VM state change detected. (old = 'running', new = 'paused') 2025-02-26 05:20:39 (8496): VM state change detected. (old = 'paused', new = 'running') 2025-02-26 05:20:47 (8496): VM state change detected. (old = 'running', new = 'paused') 2025-02-26 05:25:08 (8496): VM state change detected. (old = 'paused', new = 'running') 2025-02-26 05:25:18 (8496): VM state change detected. (old = 'running', new = 'paused') 2025-02-26 05:25:38 (8496): VM state change detected. (old = 'paused', new = 'running') 2025-02-26 05:25:51 (8496): VM state change detected. (old = 'running', new = 'paused') 2025-02-26 05:26:28 (8496): VM state change detected. (old = 'paused', new = 'running') 2025-02-26 05:26:38 (8496): VM state change detected. (old = 'running', new = 'paused') 2025-02-26 05:26:58 (8496): VM state change detected. (old = 'paused', new = 'running') 2025-02-26 05:27:08 (8496): VM state change detected. (old = 'running', new = 'paused') 2025-02-26 05:27:28 (8496): VM state change detected. (old = 'paused', new = 'running') 2025-02-26 05:27:49 (8496): VM state change detected. (old = 'running', new = 'paused') 2025-02-26 05:28:38 (8496): VM state change detected. (old = 'paused', new = 'running') 2025-02-26 05:28:59 (8496): VM state change detected. (old = 'running', new = 'paused') 2025-02-26 05:29:19 (8496): VM state change detected. (old = 'paused', new = 'running') 2025-02-26 05:29:29 (8496): VM state change detected. (old = 'running', new = 'paused') 2025-02-26 05:29:50 (8496): VM state change detected. (old = 'paused', new = 'running') 2025-02-26 05:30:59 (8496): VM state change detected. (old = 'running', new = 'paused') 2025-02-26 05:31:19 (8496): VM state change detected. (old = 'paused', new = 'running') 2025-02-26 05:31:29 (8496): VM state change detected. (old = 'running', new = 'paused') 2025-02-26 05:31:49 (8496): VM state change detected. (old = 'paused', new = 'running') 2025-02-26 05:32:09 (8496): VM state change detected. (old = 'running', new = 'paused') 2025-02-26 05:32:29 (8496): VM state change detected. (old = 'paused', new = 'running') 2025-02-26 05:33:00 (8496): VM state change detected. (old = 'running', new = 'paused') 2025-02-26 05:33:20 (8496): VM state change detected. (old = 'paused', new = 'running') 2025-02-26 05:33:29 (8496): VM state change detected. (old = 'running', new = 'paused') 2025-02-26 05:34:09 (8496): VM state change detected. (old = 'paused', new = 'running') 2025-02-26 05:34:29 (8496): VM state change detected. (old = 'running', new = 'paused') 2025-02-26 05:34:50 (8496): VM state change detected. (old = 'paused', new = 'running') 2025-02-26 05:35:10 (8496): VM state change detected. (old = 'running', new = 'paused') 2025-02-26 05:35:30 (8496): VM state change detected. (old = 'paused', new = 'running') 2025-02-26 05:36:30 (8496): VM state change detected. (old = 'running', new = 'paused') 2025-02-26 05:36:50 (8496): VM state change detected. (old = 'paused', new = 'running') 2025-02-26 05:42:21 (8496): VM state change detected. (old = 'running', new = 'paused') 2025-02-26 05:42:40 (8496): VM state change detected. (old = 'paused', new = 'running') 2025-02-26 05:57:52 (8496): VM state change detected. (old = 'running', new = 'paused') 2025-02-26 05:58:34 (8496): VM state change detected. (old = 'paused', new = 'running') 2025-02-26 06:02:57 (8496): VM state change detected. (old = 'running', new = 'paused') 2025-02-26 06:03:54 (8496): VM state change detected. (old = 'paused', new = 'running') 2025-02-26 06:04:04 (8496): VM state change detected. (old = 'running', new = 'paused') 2025-02-26 06:04:24 (8496): VM state change detected. (old = 'paused', new = 'running') 2025-02-26 06:07:32 (8496): Status Report: Elapsed Time: '30002.798401' 2025-02-26 06:07:32 (8496): Status Report: CPU Time: '8836.265625' 2025-02-26 06:08:44 (8496): VM state change detected. (old = 'running', new = 'paused') 2025-02-26 06:09:05 (8496): VM state change detected. (old = 'paused', new = 'running') 2025-02-26 06:15:12 (8496): VM state change detected. (old = 'running', new = 'paused') 2025-02-26 06:15:45 (8496): VM state change detected. (old = 'paused', new = 'running') 2025-02-26 06:22:41 (8496): VM state change detected. (old = 'running', new = 'paused') 2025-02-26 06:23:06 (8496): VM state change detected. (old = 'paused', new = 'running') 2025-02-26 06:23:28 (8496): VM state change detected. (old = 'running', new = 'paused') 2025-02-26 06:24:05 (8496): VM state change detected. (old = 'paused', new = 'running') 2025-02-26 06:30:26 (8496): Guest Log: *** Job finished *** 2025-02-26 06:30:27 (8496): Guest Log: *** The last 20 lines of the pilot log: *** 2025-02-26 06:30:27 (8496): Guest Log: 2025-02-26 05:22:45,248 | INFO | [data] queue_monitor thread has finished 2025-02-26 06:30:27 (8496): Guest Log: 2025-02-26 05:22:45,687 | INFO | only monitor.control thread still running - safe to abort: ['<_MainThread(MainThread, started 140434616457024)>', '<ExcThread(monitor, started 140434173040384)>'] 2025-02-26 06:30:27 (8496): Guest Log: 2025-02-26 05:22:46,263 | WARNING | job_aborted has been set - aborting pilot monitoring 2025-02-26 06:30:27 (8496): Guest Log: 2025-02-26 05:22:46,264 | INFO | [monitor] control thread has ended 2025-02-26 06:30:27 (8496): Guest Log: 2025-02-26 05:22:50,711 | INFO | all workflow threads have been joined 2025-02-26 06:30:27 (8496): Guest Log: 2025-02-26 05:22:50,712 | INFO | end of generic workflow (traces error code: 1150) 2025-02-26 06:30:27 (8496): Guest Log: 2025-02-26 05:22:50,714 | INFO | traces error code: 1150 2025-02-26 06:30:27 (8496): Guest Log: 2025-02-26 05:22:50,715 | INFO | an exit code was already set: 1150 (will be converted to a standard shell code) 2025-02-26 06:30:27 (8496): Guest Log: no translation to shell exit code for error code 1150 2025-02-26 06:30:27 (8496): Guest Log: 2025-02-26 05:22:50,717 | INFO | pilot has finished (exit code=1150, shell exit code=1) 2025-02-26 06:30:27 (8496): Guest Log: 2025-02-26 05:22:58,539 [wrapper] ==== pilot stdout END ==== 2025-02-26 06:30:27 (8496): Guest Log: 2025-02-26 05:22:58,817 [wrapper] ==== wrapper stdout RESUME ==== 2025-02-26 06:30:27 (8496): Guest Log: 2025-02-26 05:22:59,064 [wrapper] pilotpid: 6220 2025-02-26 06:30:27 (8496): Guest Log: 2025-02-26 05:22:59,467 [wrapper] Pilot exit status: 1 2025-02-26 06:30:27 (8496): Guest Log: 2025-02-26 05:23:01,337 [wrapper] pandaids: 6530099498 2025-02-26 06:30:27 (8496): Guest Log: 2025-02-26 05:23:03,421 [wrapper] cleanup supervisor_pilot 1385 6221 2025-02-26 06:30:27 (8496): Guest Log: 2025-02-26 05:23:03,940 [wrapper] Test setup, not cleaning 2025-02-26 06:30:27 (8496): Guest Log: 2025-02-26 05:23:04,157 [wrapper] apfmon messages muted 2025-02-26 06:30:28 (8496): Guest Log: 2025-02-26 05:23:04,563 [wrapper] ==== wrapper stdout END ==== 2025-02-26 06:30:28 (8496): Guest Log: 2025-02-26 05:23:04,879 [wrapper] ==== wrapper stderr END ==== 2025-02-26 06:30:28 (8496): Guest Log: *** Error codes and diagnostics *** 2025-02-26 06:30:28 (8496): Guest Log: "exeErrorCode": 0, 2025-02-26 06:30:28 (8496): Guest Log: "exeErrorDiag": "", 2025-02-26 06:30:28 (8496): Guest Log: "pilotErrorCode": 1150, 2025-02-26 06:30:28 (8496): Guest Log: "pilotErrorDiag": "Looping job killed by pilot", 2025-02-26 06:30:28 (8496): Guest Log: *** Listing of results directory *** 2025-02-26 06:30:29 (8496): Guest Log: total 6784 2025-02-26 06:30:29 (8496): Guest Log: -rw-r--r--. 1 atlas atlas 491065 Feb 25 10:12 pilot3.tar.gz 2025-02-26 06:30:29 (8496): Guest Log: -rw-r--r--. 1 atlas atlas 5118 Feb 25 10:45 queuedata.json 2025-02-26 06:30:29 (8496): Guest Log: -rwx------. 1 atlas atlas 35865 Feb 25 10:45 runpilot2-wrapper.sh 2025-02-26 06:30:29 (8496): Guest Log: -rwxr-xr-x. 1 atlas atlas 8885 Feb 25 17:21 init_data.xml 2025-02-26 06:30:29 (8496): Guest Log: -rwxr-xr-x. 1 atlas atlas 503550 Feb 25 17:21 input.tar.gz 2025-02-26 06:30:29 (8496): Guest Log: -rwxr-xr-x. 1 atlas atlas 17569 Feb 25 17:21 start_atlas.sh 2025-02-26 06:30:29 (8496): Guest Log: lrwxrwxrwx. 1 atlas atlas 20 Feb 25 17:22 EVNT.43401119._000025.pool.root.1 -> /data/./ATLAS.root_0 2025-02-26 06:30:29 (8496): Guest Log: -rw-r--r--. 1 atlas atlas 2543 Feb 25 17:23 pandaJob.out 2025-02-26 06:30:29 (8496): Guest Log: -rw-------. 1 atlas atlas 424 Feb 25 17:24 setup.sh.local 2025-02-26 06:30:29 (8496): Guest Log: -rw-------. 1 atlas atlas 988274 Feb 25 17:46 agis_schedconf.cvmfs.json 2025-02-26 06:30:29 (8496): Guest Log: drwx------. 4 atlas atlas 4096 Feb 25 17:46 pilot3 2025-02-26 06:30:29 (8496): Guest Log: -rw-------. 1 atlas atlas 1038 Feb 26 05:00 memory_monitor_summary.json 2025-02-26 06:30:29 (8496): Guest Log: -rw-------. 1 atlas atlas 261949 Feb 26 05:11 log.43401121._000651.job.log.tgz.1 2025-02-26 06:30:29 (8496): Guest Log: -rw-------. 1 atlas atlas 1573632 Feb 26 05:11 agis_ddmendpoints.agis.ALL.json 2025-02-26 06:30:29 (8496): Guest Log: -rw-------. 1 atlas atlas 2724 Feb 26 05:22 heartbeat.json 2025-02-26 06:30:29 (8496): Guest Log: -rw-------. 1 atlas atlas 97 Feb 26 05:22 pilot_heartbeat.json 2025-02-26 06:30:29 (8496): Guest Log: -rw-------. 1 atlas atlas 4587 Feb 26 05:22 pilotlog.txt 2025-02-26 06:30:29 (8496): Guest Log: -rw-------. 1 atlas atlas 1351513 Feb 26 05:23 log.43401121._000651.job.log.1 2025-02-26 06:30:29 (8496): Guest Log: -rw-------. 1 atlas atlas 188 Feb 26 05:23 output.list 2025-02-26 06:30:29 (8496): Guest Log: -rw-r--r--. 1 atlas atlas 620 Feb 26 05:23 runtime_log 2025-02-26 06:30:29 (8496): Guest Log: -rw-------. 1 atlas atlas 1628160 Feb 26 05:23 result.tar.gz 2025-02-26 06:30:29 (8496): Guest Log: -rw-r--r--. 1 atlas atlas 10862 Feb 26 05:23 runtime_log.err 2025-02-26 06:30:29 (8496): Guest Log: -rw-------. 1 atlas atlas 678 Feb 26 05:23 MltKDmGc766n9Rq4apOajLDm4fhM0noT9bVoF
©2025 CERN