Name CMS_2889836_1736343177.135254_0
Workunit 229719517
Created 8 Jan 2025, 13:33:00 UTC
Sent 8 Jan 2025, 13:54:23 UTC
Report deadline 8 Feb 2025, 13:54:23 UTC
Received 22 Jan 2025, 14:52:16 UTC
Server state Over
Outcome Success
Client state Done
Exit status 0 (0x00000000)
Computer ID 10861531
Run time 5 hours 5 min 6 sec
CPU time 6 hours 33 min 46 sec
Validate state Valid
Credit 6,260.23
Device peak FLOPS 19.86 GFLOPS
Application version CMS Simulation v70.30 (vbox64_mt_mcore_cms)
windows_x86_64
Peak working set size 86.66 MB
Peak swap size 87.15 MB
Peak disk usage 3.33 GB

Stderr output

<core_client_version>8.0.2</core_client_version>
<![CDATA[
<stderr_txt>
'paused', new = 'running')
2025-01-20 21:25:59 (12876): VM state change detected. (old = 'running', new = 'paused')
2025-01-20 21:26:19 (12876): VM state change detected. (old = 'paused', new = 'running')
2025-01-20 21:26:39 (12876): VM state change detected. (old = 'running', new = 'paused')
2025-01-20 21:26:59 (12876): VM state change detected. (old = 'paused', new = 'running')
2025-01-20 21:27:19 (12876): VM state change detected. (old = 'running', new = 'paused')
2025-01-20 21:27:39 (12876): VM state change detected. (old = 'paused', new = 'running')
2025-01-20 21:27:59 (12876): VM state change detected. (old = 'running', new = 'paused')
2025-01-20 21:28:19 (12876): VM state change detected. (old = 'paused', new = 'running')
2025-01-20 21:28:39 (12876): VM state change detected. (old = 'running', new = 'paused')
2025-01-20 21:28:59 (12876): VM state change detected. (old = 'paused', new = 'running')
2025-01-20 21:29:09 (12876): VM state change detected. (old = 'running', new = 'paused')
2025-01-20 21:29:29 (12876): VM state change detected. (old = 'paused', new = 'running')
2025-01-20 21:29:39 (12876): VM state change detected. (old = 'running', new = 'paused')
2025-01-20 21:29:59 (12876): VM state change detected. (old = 'paused', new = 'running')
2025-01-20 21:30:19 (12876): VM state change detected. (old = 'running', new = 'paused')
2025-01-20 21:30:39 (12876): VM state change detected. (old = 'paused', new = 'running')
2025-01-20 21:31:09 (12876): VM state change detected. (old = 'running', new = 'paused')
2025-01-20 21:31:29 (12876): VM state change detected. (old = 'paused', new = 'running')
2025-01-20 21:32:09 (12876): VM state change detected. (old = 'running', new = 'paused')
2025-01-20 21:32:30 (12876): VM state change detected. (old = 'paused', new = 'running')
2025-01-20 21:32:40 (12876): VM state change detected. (old = 'running', new = 'paused')
2025-01-20 21:33:00 (12876): VM state change detected. (old = 'paused', new = 'running')
2025-01-20 21:33:10 (12876): VM state change detected. (old = 'running', new = 'paused')
2025-01-20 21:33:30 (12876): VM state change detected. (old = 'paused', new = 'running')
2025-01-20 21:33:50 (12876): VM state change detected. (old = 'running', new = 'paused')
2025-01-20 21:34:10 (12876): VM state change detected. (old = 'paused', new = 'running')
2025-01-20 21:34:20 (12876): VM state change detected. (old = 'running', new = 'paused')
2025-01-20 21:34:40 (12876): VM state change detected. (old = 'paused', new = 'running')
2025-01-20 21:35:00 (12876): VM state change detected. (old = 'running', new = 'paused')
2025-01-20 21:35:20 (12876): VM state change detected. (old = 'paused', new = 'running')
2025-01-20 21:35:30 (12876): VM state change detected. (old = 'running', new = 'paused')
2025-01-20 21:35:50 (12876): VM state change detected. (old = 'paused', new = 'running')
2025-01-20 21:36:00 (12876): VM state change detected. (old = 'running', new = 'paused')
2025-01-20 21:36:20 (12876): VM state change detected. (old = 'paused', new = 'running')
2025-01-20 21:36:30 (12876): VM state change detected. (old = 'running', new = 'paused')
2025-01-20 21:36:50 (12876): VM state change detected. (old = 'paused', new = 'running')
2025-01-20 21:37:30 (12876): VM state change detected. (old = 'running', new = 'paused')
2025-01-20 21:38:10 (12876): VM state change detected. (old = 'paused', new = 'running')
2025-01-20 21:38:20 (12876): VM state change detected. (old = 'running', new = 'paused')
2025-01-20 21:38:40 (12876): VM state change detected. (old = 'paused', new = 'running')
2025-01-20 21:38:50 (12876): VM state change detected. (old = 'running', new = 'paused')
2025-01-20 21:39:10 (12876): VM state change detected. (old = 'paused', new = 'running')
2025-01-20 21:39:30 (12876): VM state change detected. (old = 'running', new = 'paused')
2025-01-20 21:39:51 (12876): VM state change detected. (old = 'paused', new = 'running')
2025-01-20 21:40:01 (12876): VM state change detected. (old = 'running', new = 'paused')
2025-01-20 21:40:21 (12876): VM state change detected. (old = 'paused', new = 'running')
2025-01-20 21:40:31 (12876): VM state change detected. (old = 'running', new = 'paused')
2025-01-20 21:40:51 (12876): VM state change detected. (old = 'paused', new = 'running')
2025-01-20 21:41:11 (12876): VM state change detected. (old = 'running', new = 'paused')
2025-01-20 21:41:31 (12876): VM state change detected. (old = 'paused', new = 'running')
2025-01-20 21:41:41 (12876): VM state change detected. (old = 'running', new = 'paused')
2025-01-20 21:42:01 (12876): VM state change detected. (old = 'paused', new = 'running')
2025-01-20 21:42:21 (12876): VM state change detected. (old = 'running', new = 'paused')
2025-01-20 21:42:41 (12876): VM state change detected. (old = 'paused', new = 'running')
2025-01-20 21:43:01 (12876): VM state change detected. (old = 'running', new = 'paused')
2025-01-20 21:43:21 (12876): VM state change detected. (old = 'paused', new = 'running')
2025-01-20 21:43:51 (12876): VM state change detected. (old = 'running', new = 'paused')
2025-01-20 21:44:11 (12876): VM state change detected. (old = 'paused', new = 'running')
2025-01-20 21:44:21 (12876): VM state change detected. (old = 'running', new = 'paused')
2025-01-20 21:44:41 (12876): VM state change detected. (old = 'paused', new = 'running')
2025-01-20 21:44:51 (12876): VM state change detected. (old = 'running', new = 'paused')
2025-01-20 21:45:11 (12876): VM state change detected. (old = 'paused', new = 'running')
2025-01-20 21:45:21 (12876): VM state change detected. (old = 'running', new = 'paused')
2025-01-20 21:45:41 (12876): VM state change detected. (old = 'paused', new = 'running')
2025-01-20 21:46:11 (12876): VM state change detected. (old = 'running', new = 'paused')
2025-01-20 21:46:30 (12876): VM state change detected. (old = 'paused', new = 'running')
2025-01-20 21:46:40 (12876): VM state change detected. (old = 'running', new = 'paused')
2025-01-20 21:47:00 (12876): VM state change detected. (old = 'paused', new = 'running')
2025-01-20 21:47:20 (12876): VM state change detected. (old = 'running', new = 'paused')
2025-01-20 21:47:40 (12876): VM state change detected. (old = 'paused', new = 'running')
2025-01-20 21:47:50 (12876): VM state change detected. (old = 'running', new = 'paused')
2025-01-20 21:48:10 (12876): VM state change detected. (old = 'paused', new = 'running')
2025-01-20 21:48:30 (12876): VM state change detected. (old = 'running', new = 'paused')
2025-01-20 21:48:50 (12876): VM state change detected. (old = 'paused', new = 'running')
2025-01-20 21:49:01 (12876): VM state change detected. (old = 'running', new = 'paused')
2025-01-20 21:49:21 (12876): VM state change detected. (old = 'paused', new = 'running')
2025-01-20 21:49:30 (12876): VM state change detected. (old = 'running', new = 'paused')
2025-01-20 21:49:50 (12876): VM state change detected. (old = 'paused', new = 'running')
2025-01-20 21:50:00 (12876): VM state change detected. (old = 'running', new = 'paused')
2025-01-20 21:50:21 (12876): VM state change detected. (old = 'paused', new = 'running')
2025-01-20 21:50:30 (12876): VM state change detected. (old = 'running', new = 'paused')
2025-01-20 21:50:50 (12876): VM state change detected. (old = 'paused', new = 'running')
2025-01-20 21:51:11 (12876): VM state change detected. (old = 'running', new = 'paused')
2025-01-20 21:51:31 (12876): VM state change detected. (old = 'paused', new = 'running')
2025-01-20 21:51:42 (12876): VM state change detected. (old = 'running', new = 'paused')
2025-01-20 21:52:02 (12876): VM state change detected. (old = 'paused', new = 'running')
2025-01-20 21:52:12 (12876): VM state change detected. (old = 'running', new = 'paused')
2025-01-20 21:52:32 (12876): VM state change detected. (old = 'paused', new = 'running')
2025-01-20 21:52:41 (12876): VM state change detected. (old = 'running', new = 'paused')
2025-01-20 21:53:01 (12876): VM state change detected. (old = 'paused', new = 'running')
2025-01-20 21:53:12 (12876): VM state change detected. (old = 'running', new = 'paused')
2025-01-20 21:53:32 (12876): VM state change detected. (old = 'paused', new = 'running')
2025-01-20 21:53:52 (12876): VM state change detected. (old = 'running', new = 'paused')
2025-01-20 21:54:12 (12876): VM state change detected. (old = 'paused', new = 'running')
2025-01-20 21:54:22 (12876): VM state change detected. (old = 'running', new = 'paused')
2025-01-20 21:54:42 (12876): VM state change detected. (old = 'paused', new = 'running')
2025-01-20 21:55:02 (12876): VM state change detected. (old = 'running', new = 'paused')
2025-01-20 21:55:22 (12876): VM state change detected. (old = 'paused', new = 'running')
2025-01-20 21:55:32 (12876): VM state change detected. (old = 'running', new = 'paused')
2025-01-20 21:55:52 (12876): VM state change detected. (old = 'paused', new = 'running')
2025-01-20 21:56:12 (12876): VM state change detected. (old = 'running', new = 'paused')
2025-01-20 21:56:32 (12876): VM state change detected. (old = 'paused', new = 'running')
2025-01-20 21:56:42 (12876): VM state change detected. (old = 'running', new = 'paused')
2025-01-20 21:57:02 (12876): VM state change detected. (old = 'paused', new = 'running')
2025-01-20 21:57:12 (12876): VM state change detected. (old = 'running', new = 'paused')
2025-01-20 21:57:31 (12876): VM state change detected. (old = 'paused', new = 'running')
2025-01-20 21:58:11 (12876): VM state change detected. (old = 'running', new = 'paused')
2025-01-20 21:58:31 (12876): VM state change detected. (old = 'paused', new = 'running')
2025-01-20 21:58:51 (12876): VM state change detected. (old = 'running', new = 'paused')
2025-01-20 21:59:11 (12876): VM state change detected. (old = 'paused', new = 'running')
2025-01-20 21:59:21 (12876): VM state change detected. (old = 'running', new = 'paused')
2025-01-20 21:59:41 (12876): VM state change detected. (old = 'paused', new = 'running')
2025-01-20 21:59:51 (12876): VM state change detected. (old = 'running', new = 'paused')
2025-01-20 22:00:11 (12876): VM state change detected. (old = 'paused', new = 'running')
2025-01-20 22:00:21 (12876): VM state change detected. (old = 'running', new = 'paused')
2025-01-20 22:00:41 (12876): VM state change detected. (old = 'paused', new = 'running')
2025-01-20 22:01:01 (12876): VM state change detected. (old = 'running', new = 'paused')
2025-01-20 22:01:21 (12876): VM state change detected. (old = 'paused', new = 'running')
2025-01-20 22:01:31 (12876): VM state change detected. (old = 'running', new = 'paused')
2025-01-20 22:01:51 (12876): VM state change detected. (old = 'paused', new = 'running')
2025-01-20 22:02:01 (12876): VM state change detected. (old = 'running', new = 'paused')
2025-01-20 22:02:21 (12876): VM state change detected. (old = 'paused', new = 'running')
2025-01-20 22:02:31 (12876): VM state change detected. (old = 'running', new = 'paused')
2025-01-20 22:02:51 (12876): VM state change detected. (old = 'paused', new = 'running')
2025-01-20 22:03:02 (12876): VM state change detected. (old = 'running', new = 'paused')
2025-01-20 22:03:21 (12876): VM state change detected. (old = 'paused', new = 'running')
2025-01-20 22:03:52 (12876): VM state change detected. (old = 'running', new = 'paused')
2025-01-20 22:04:12 (12876): VM state change detected. (old = 'paused', new = 'running')
2025-01-20 22:04:42 (12876): VM state change detected. (old = 'running', new = 'paused')
2025-01-20 22:05:03 (12876): VM state change detected. (old = 'paused', new = 'running')
2025-01-20 22:05:23 (12876): VM state change detected. (old = 'running', new = 'paused')
2025-01-20 22:05:43 (12876): VM state change detected. (old = 'paused', new = 'running')
2025-01-20 22:06:03 (12876): VM state change detected. (old = 'running', new = 'paused')
2025-01-20 22:06:22 (12876): VM state change detected. (old = 'paused', new = 'running')
2025-01-20 22:06:32 (12876): VM state change detected. (old = 'running', new = 'paused')
2025-01-20 22:06:52 (12876): VM state change detected. (old = 'paused', new = 'running')
2025-01-20 22:07:12 (12876): VM state change detected. (old = 'running', new = 'paused')
2025-01-20 22:07:32 (12876): VM state change detected. (old = 'paused', new = 'running')
2025-01-20 22:07:42 (12876): VM state change detected. (old = 'running', new = 'paused')
2025-01-20 22:08:02 (12876): VM state change detected. (old = 'paused', new = 'running')
2025-01-20 22:08:12 (12876): VM state change detected. (old = 'running', new = 'paused')
2025-01-20 22:08:32 (12876): VM state change detected. (old = 'paused', new = 'running')
2025-01-20 22:08:42 (12876): VM state change detected. (old = 'running', new = 'paused')
2025-01-20 22:09:02 (12876): VM state change detected. (old = 'paused', new = 'running')
2025-01-20 22:09:12 (12876): VM state change detected. (old = 'running', new = 'paused')
2025-01-20 22:09:32 (12876): VM state change detected. (old = 'paused', new = 'running')
2025-01-20 22:09:52 (12876): VM state change detected. (old = 'running', new = 'paused')
2025-01-20 22:10:12 (12876): VM state change detected. (old = 'paused', new = 'running')
2025-01-20 22:10:22 (12876): VM state change detected. (old = 'running', new = 'paused')
2025-01-20 22:10:42 (12876): VM state change detected. (old = 'paused', new = 'running')
2025-01-20 22:10:52 (12876): VM state change detected. (old = 'running', new = 'paused')
2025-01-20 22:11:12 (12876): VM state change detected. (old = 'paused', new = 'running')
2025-01-20 22:11:22 (12876): VM state change detected. (old = 'running', new = 'paused')
2025-01-20 22:11:42 (12876): VM state change detected. (old = 'paused', new = 'running')
2025-01-20 22:12:02 (12876): VM state change detected. (old = 'running', new = 'paused')
2025-01-20 22:12:22 (12876): VM state change detected. (old = 'paused', new = 'running')
2025-01-20 22:12:32 (12876): VM state change detected. (old = 'running', new = 'paused')
2025-01-20 22:12:52 (12876): VM state change detected. (old = 'paused', new = 'running')
2025-01-20 22:13:12 (12876): VM state change detected. (old = 'running', new = 'paused')
2025-01-20 22:13:32 (12876): VM state change detected. (old = 'paused', new = 'running')
2025-01-20 22:13:42 (12876): VM state change detected. (old = 'running', new = 'paused')
2025-01-20 22:14:02 (12876): VM state change detected. (old = 'paused', new = 'running')
2025-01-20 22:14:22 (12876): VM state change detected. (old = 'running', new = 'paused')
2025-01-20 22:14:42 (12876): VM state change detected. (old = 'paused', new = 'running')
2025-01-20 22:15:02 (12876): VM state change detected. (old = 'running', new = 'paused')
2025-01-20 22:15:22 (12876): VM state change detected. (old = 'paused', new = 'running')
2025-01-20 22:16:13 (12876): VM state change detected. (old = 'running', new = 'paused')
2025-01-20 22:16:33 (12876): VM state change detected. (old = 'paused', new = 'running')
2025-01-20 22:16:53 (12876): VM state change detected. (old = 'running', new = 'paused')
2025-01-20 22:17:13 (12876): VM state change detected. (old = 'paused', new = 'running')
2025-01-20 22:17:23 (12876): VM state change detected. (old = 'running', new = 'paused')
2025-01-20 22:17:43 (12876): VM state change detected. (old = 'paused', new = 'running')
2025-01-20 22:18:03 (12876): VM state change detected. (old = 'running', new = 'paused')
2025-01-20 22:18:23 (12876): VM state change detected. (old = 'paused', new = 'running')
2025-01-20 22:18:31 (12876): Status Report: Job Duration: '64800.000000'
2025-01-20 22:18:31 (12876): Status Report: Elapsed Time: '13788.740156'
2025-01-20 22:18:31 (12876): Status Report: CPU Time: '19615.171875'
2025-01-20 22:18:43 (12876): VM state change detected. (old = 'running', new = 'paused')
2025-01-20 22:19:03 (12876): VM state change detected. (old = 'paused', new = 'running')
2025-01-20 22:19:33 (12876): VM state change detected. (old = 'running', new = 'paused')
2025-01-20 22:19:53 (12876): VM state change detected. (old = 'paused', new = 'running')
2025-01-20 22:20:13 (12876): VM state change detected. (old = 'running', new = 'paused')
2025-01-20 22:20:33 (12876): VM state change detected. (old = 'paused', new = 'running')
2025-01-20 22:20:43 (12876): VM state change detected. (old = 'running', new = 'paused')
2025-01-20 22:21:03 (12876): VM state change detected. (old = 'paused', new = 'running')
2025-01-20 22:21:13 (12876): VM state change detected. (old = 'running', new = 'paused')
2025-01-20 22:21:33 (12876): VM state change detected. (old = 'paused', new = 'running')
2025-01-20 22:21:53 (12876): VM state change detected. (old = 'running', new = 'paused')
2025-01-20 22:22:13 (12876): VM state change detected. (old = 'paused', new = 'running')
2025-01-20 22:22:23 (12876): VM state change detected. (old = 'running', new = 'paused')
2025-01-20 22:22:43 (12876): VM state change detected. (old = 'paused', new = 'running')
2025-01-20 22:22:53 (12876): VM state change detected. (old = 'running', new = 'paused')
2025-01-20 22:23:13 (12876): VM state change detected. (old = 'paused', new = 'running')
2025-01-20 22:23:23 (12876): VM state change detected. (old = 'running', new = 'paused')
2025-01-20 22:23:43 (12876): VM state change detected. (old = 'paused', new = 'running')
2025-01-20 22:24:13 (12876): VM state change detected. (old = 'running', new = 'paused')
2025-01-20 22:24:33 (12876): VM state change detected. (old = 'paused', new = 'running')
2025-01-20 22:25:04 (12876): VM state change detected. (old = 'running', new = 'paused')
2025-01-20 22:25:24 (12876): VM state change detected. (old = 'paused', new = 'running')
2025-01-20 22:25:34 (12876): VM state change detected. (old = 'running', new = 'paused')
2025-01-20 22:25:54 (12876): VM state change detected. (old = 'paused', new = 'running')
2025-01-20 22:26:04 (12876): VM state change detected. (old = 'running', new = 'paused')
2025-01-20 22:26:24 (12876): VM state change detected. (old = 'paused', new = 'running')
2025-01-20 22:26:44 (12876): VM state change detected. (old = 'running', new = 'paused')
2025-01-20 22:27:04 (12876): VM state change detected. (old = 'paused', new = 'running')
2025-01-20 22:27:34 (12876): VM state change detected. (old = 'running', new = 'paused')
2025-01-20 22:27:54 (12876): VM state change detected. (old = 'paused', new = 'running')
2025-01-20 22:28:13 (12876): VM state change detected. (old = 'running', new = 'paused')
2025-01-20 22:28:33 (12876): VM state change detected. (old = 'paused', new = 'running')
2025-01-20 22:28:43 (12876): VM state change detected. (old = 'running', new = 'paused')
2025-01-20 22:29:03 (12876): VM state change detected. (old = 'paused', new = 'running')
2025-01-20 22:29:13 (12876): VM state change detected. (old = 'running', new = 'paused')
2025-01-20 22:29:33 (12876): VM state change detected. (old = 'paused', new = 'running')
2025-01-20 22:29:43 (12876): VM state change detected. (old = 'running', new = 'paused')
2025-01-20 22:30:03 (12876): VM state change detected. (old = 'paused', new = 'running')
2025-01-20 22:30:13 (12876): VM state change detected. (old = 'running', new = 'paused')
2025-01-20 22:30:33 (12876): VM state change detected. (old = 'paused', new = 'running')
2025-01-20 22:30:53 (12876): VM state change detected. (old = 'running', new = 'paused')
2025-01-20 22:31:13 (12876): VM state change detected. (old = 'paused', new = 'running')
2025-01-20 22:31:33 (12876): VM state change detected. (old = 'running', new = 'paused')
2025-01-20 22:31:53 (12876): VM state change detected. (old = 'paused', new = 'running')
2025-01-20 22:32:13 (12876): VM state change detected. (old = 'running', new = 'paused')
2025-01-20 22:32:33 (12876): VM state change detected. (old = 'paused', new = 'running')
2025-01-20 22:32:43 (12876): VM state change detected. (old = 'running', new = 'paused')
2025-01-20 22:33:04 (12876): VM state change detected. (old = 'paused', new = 'running')
2025-01-20 22:33:14 (12876): VM state change detected. (old = 'running', new = 'paused')
2025-01-20 22:33:34 (12876): VM state change detected. (old = 'paused', new = 'running')
2025-01-20 22:33:54 (12876): VM state change detected. (old = 'running', new = 'paused')
2025-01-20 22:34:14 (12876): VM state change detected. (old = 'paused', new = 'running')
2025-01-20 22:35:24 (12876): VM state change detected. (old = 'running', new = 'paused')
2025-01-20 22:35:44 (12876): VM state change detected. (old = 'paused', new = 'running')
2025-01-20 22:36:04 (12876): VM state change detected. (old = 'running', new = 'paused')
2025-01-20 22:36:24 (12876): VM state change detected. (old = 'paused', new = 'running')
2025-01-20 22:36:34 (12876): VM state change detected. (old = 'running', new = 'paused')
2025-01-20 22:36:54 (12876): VM state change detected. (old = 'paused', new = 'running')
2025-01-20 22:37:04 (12876): VM state change detected. (old = 'running', new = 'paused')
2025-01-20 22:37:24 (12876): VM state change detected. (old = 'paused', new = 'running')
2025-01-20 22:37:34 (12876): VM state change detected. (old = 'running', new = 'paused')
2025-01-20 22:37:54 (12876): VM state change detected. (old = 'paused', new = 'running')
2025-01-20 22:38:04 (12876): VM state change detected. (old = 'running', new = 'paused')
2025-01-20 22:38:24 (12876): VM state change detected. (old = 'paused', new = 'running')
2025-01-20 22:38:34 (12876): VM state change detected. (old = 'running', new = 'paused')
2025-01-20 22:38:54 (12876): VM state change detected. (old = 'paused', new = 'running')
2025-01-20 22:39:04 (12876): VM state change detected. (old = 'running', new = 'paused')
2025-01-20 22:39:24 (12876): VM state change detected. (old = 'paused', new = 'running')
2025-01-20 22:39:54 (12876): VM state change detected. (old = 'running', new = 'paused')
2025-01-20 22:40:14 (12876): VM state change detected. (old = 'paused', new = 'running')
2025-01-20 22:40:34 (12876): VM state change detected. (old = 'running', new = 'paused')
2025-01-20 22:40:54 (12876): VM state change detected. (old = 'paused', new = 'running')
2025-01-20 22:41:05 (12876): VM state change detected. (old = 'running', new = 'paused')
2025-01-20 22:41:25 (12876): VM state change detected. (old = 'paused', new = 'running')
2025-01-20 22:41:55 (12876): VM state change detected. (old = 'running', new = 'paused')
2025-01-20 22:42:15 (12876): VM state change detected. (old = 'paused', new = 'running')
2025-01-20 22:42:35 (12876): VM state change detected. (old = 'running', new = 'paused')
2025-01-20 22:42:55 (12876): VM state change detected. (old = 'paused', new = 'running')
2025-01-20 22:43:35 (12876): VM state change detected. (old = 'running', new = 'paused')
2025-01-20 22:43:55 (12876): VM state change detected. (old = 'paused', new = 'running')
2025-01-20 22:44:05 (12876): VM state change detected. (old = 'running', new = 'paused')
2025-01-20 22:44:25 (12876): VM state change detected. (old = 'paused', new = 'running')
2025-01-20 22:44:35 (12876): VM state change detected. (old = 'running', new = 'paused')
2025-01-20 22:44:55 (12876): VM state change detected. (old = 'paused', new = 'running')
2025-01-20 22:45:05 (12876): VM state change detected. (old = 'running', new = 'paused')
2025-01-20 22:45:25 (12876): VM state change detected. (old = 'paused', new = 'running')
2025-01-20 22:46:25 (12876): VM state change detected. (old = 'running', new = 'paused')
2025-01-20 22:46:45 (12876): VM state change detected. (old = 'paused', new = 'running')
2025-01-20 22:46:55 (12876): VM state change detected. (old = 'running', new = 'paused')
2025-01-20 22:47:15 (12876): VM state change detected. (old = 'paused', new = 'running')
2025-01-20 22:47:25 (12876): VM state change detected. (old = 'running', new = 'paused')
2025-01-20 22:47:45 (12876): VM state change detected. (old = 'paused', new = 'running')
2025-01-20 22:50:45 (12876): VM state change detected. (old = 'running', new = 'paused')
2025-01-20 22:51:05 (12876): VM state change detected. (old = 'paused', new = 'running')
2025-01-20 22:52:15 (12876): VM state change detected. (old = 'running', new = 'paused')
2025-01-20 22:52:35 (12876): VM state change detected. (old = 'paused', new = 'running')
2025-01-20 22:53:55 (12876): VM state change detected. (old = 'running', new = 'paused')
2025-01-20 22:54:15 (12876): VM state change detected. (old = 'paused', new = 'running')
2025-01-20 22:55:05 (12876): VM state change detected. (old = 'running', new = 'paused')
2025-01-20 22:55:25 (12876): VM state change detected. (old = 'paused', new = 'running')
2025-01-20 22:55:36 (12876): VM state change detected. (old = 'running', new = 'paused')
2025-01-20 22:55:56 (12876): VM state change detected. (old = 'paused', new = 'running')
2025-01-20 22:56:16 (12876): VM state change detected. (old = 'running', new = 'paused')
2025-01-20 22:56:36 (12876): VM state change detected. (old = 'paused', new = 'running')
2025-01-20 22:56:46 (12876): VM state change detected. (old = 'running', new = 'paused')
2025-01-20 22:57:06 (12876): VM state change detected. (old = 'paused', new = 'running')
2025-01-20 22:57:16 (12876): VM state change detected. (old = 'running', new = 'paused')
2025-01-20 22:57:36 (12876): VM state change detected. (old = 'paused', new = 'running')
2025-01-20 22:57:56 (12876): VM state change detected. (old = 'running', new = 'paused')
2025-01-20 22:58:16 (12876): VM state change detected. (old = 'paused', new = 'running')
2025-01-20 22:58:26 (12876): VM state change detected. (old = 'running', new = 'paused')
2025-01-20 22:58:46 (12876): VM state change detected. (old = 'paused', new = 'running')
2025-01-20 22:59:26 (12876): VM state change detected. (old = 'running', new = 'paused')
2025-01-20 22:59:46 (12876): VM state change detected. (old = 'paused', new = 'running')
2025-01-20 23:00:26 (12876): VM state change detected. (old = 'running', new = 'paused')
2025-01-20 23:00:46 (12876): VM state change detected. (old = 'paused', new = 'running')
2025-01-20 23:01:46 (12876): VM state change detected. (old = 'running', new = 'paused')
2025-01-20 23:02:06 (12876): VM state change detected. (old = 'paused', new = 'running')
2025-01-20 23:02:46 (12876): VM state change detected. (old = 'running', new = 'paused')
2025-01-20 23:03:06 (12876): VM state change detected. (old = 'paused', new = 'running')
2025-01-20 23:03:56 (12876): VM state change detected. (old = 'running', new = 'paused')
2025-01-20 23:04:16 (12876): VM state change detected. (old = 'paused', new = 'running')
2025-01-20 23:04:56 (12876): VM state change detected. (old = 'running', new = 'paused')
2025-01-20 23:05:16 (12876): VM state change detected. (old = 'paused', new = 'running')
2025-01-20 23:07:06 (12876): VM state change detected. (old = 'running', new = 'paused')
2025-01-20 23:07:26 (12876): VM state change detected. (old = 'paused', new = 'running')
2025-01-20 23:08:16 (12876): VM state change detected. (old = 'running', new = 'paused')
2025-01-20 23:08:36 (12876): VM state change detected. (old = 'paused', new = 'running')
2025-01-20 23:09:16 (12876): VM state change detected. (old = 'running', new = 'paused')
2025-01-20 23:09:36 (12876): VM state change detected. (old = 'paused', new = 'running')
2025-01-20 23:09:46 (12876): VM state change detected. (old = 'running', new = 'paused')
2025-01-20 23:10:06 (12876): VM state change detected. (old = 'paused', new = 'running')
2025-01-20 23:10:26 (12876): VM state change detected. (old = 'running', new = 'paused')
2025-01-20 23:10:46 (12876): VM state change detected. (old = 'paused', new = 'running')
2025-01-20 23:11:37 (12876): VM state change detected. (old = 'running', new = 'paused')
2025-01-20 23:11:57 (12876): VM state change detected. (old = 'paused', new = 'running')
2025-01-20 23:12:37 (12876): VM state change detected. (old = 'running', new = 'paused')
2025-01-20 23:12:57 (12876): VM state change detected. (old = 'paused', new = 'running')
2025-01-20 23:13:37 (12876): VM state change detected. (old = 'running', new = 'paused')
2025-01-20 23:13:57 (12876): VM state change detected. (old = 'paused', new = 'running')
2025-01-20 23:14:17 (12876): VM state change detected. (old = 'running', new = 'paused')
2025-01-20 23:14:37 (12876): VM state change detected. (old = 'paused', new = 'running')
2025-01-20 23:14:47 (12876): VM state change detected. (old = 'running', new = 'paused')
2025-01-20 23:15:07 (12876): VM state change detected. (old = 'paused', new = 'running')
2025-01-20 23:15:57 (12876): VM state change detected. (old = 'running', new = 'paused')
2025-01-20 23:16:17 (12876): VM state change detected. (old = 'paused', new = 'running')
2025-01-20 23:16:57 (12876): VM state change detected. (old = 'running', new = 'paused')
2025-01-20 23:17:17 (12876): VM state change detected. (old = 'paused', new = 'running')
2025-01-20 23:17:27 (12876): VM state change detected. (old = 'running', new = 'paused')
2025-01-20 23:17:47 (12876): VM state change detected. (old = 'paused', new = 'running')
2025-01-20 23:18:07 (12876): VM state change detected. (old = 'running', new = 'paused')
2025-01-20 23:18:27 (12876): VM state change detected. (old = 'paused', new = 'running')
2025-01-20 23:18:47 (12876): VM state change detected. (old = 'running', new = 'paused')
2025-01-21 09:01:15 (292): vboxwrapper version 26207
2025-01-21 09:01:15 (292): BOINC client version: 8.0.2
2025-01-21 09:01:17 (292): Detected: VirtualBox VboxManage Interface (Version: 7.0.6)
2025-01-21 09:01:17 (292): Detected: Heartbeat check (file: 'heartbeat' every 1200.000000 seconds)
2025-01-21 09:01:18 (292): Guest Log: BIOS: VirtualBox 7.0.6
2025-01-21 09:01:18 (292): Guest Log: CPUID EDX: 0x178bfbff
2025-01-21 09:01:18 (292): Guest Log: BIOS: No PCI IDE controller, not probing IDE
2025-01-21 09:01:18 (292): Guest Log: BIOS: AHCI 0-P#0: PCHS=16383/16/63 LCHS=1024/255/63 0x0000000002800000 sectors
2025-01-21 09:01:18 (292): Guest Log: BIOS: Boot : bseqnr=1, bootseq=0032
2025-01-21 09:01:18 (292): Guest Log: BIOS: Booting from Hard Disk...
2025-01-21 09:01:18 (292): Guest Log: BIOS: KBD: unsupported int 16h function 03
2025-01-21 09:01:18 (292): Guest Log: BIOS: AX=0305 BX=0000 CX=0000 DX=0000 
2025-01-21 09:01:18 (292): Guest Log: vgdrvHeartbeatInit: Setting up heartbeat to trigger every 2000 milliseconds
2025-01-21 09:01:18 (292): Guest Log: vboxguest: misc device minor 56, IRQ 20, I/O port d020, MMIO at 00000000f0400000 (size 0x400000)
2025-01-21 09:01:18 (292): Guest Log: VBoxService 5.2.6 r120293 (verbosity: 0) linux.amd64 (Jan 15 2018 14:51:00) release log
2025-01-21 09:01:18 (292): Guest Log: 00:00:00.000065 main     Log opened 2025-01-20T17:30:14.713567000Z
2025-01-21 09:01:18 (292): Guest Log: 00:00:00.000135 main     OS Product: Linux
2025-01-21 09:01:18 (292): Guest Log: 00:00:00.000164 main     OS Release: 4.14.232-19.cernvm.x86_64
2025-01-21 09:01:18 (292): Guest Log: 00:00:00.000184 main     OS Version: #1 SMP Fri Apr 30 17:12:25 CEST 2021
2025-01-21 09:01:18 (292): Guest Log: 00:00:00.000204 main     Executable: /usr/sbin/VBoxService
2025-01-21 09:01:18 (292): Guest Log: 00:00:00.000204 main     Process ID: 2280
2025-01-21 09:01:18 (292): Guest Log: 00:00:00.000205 main     Package type: LINUX_64BITS_GENERIC
2025-01-21 09:01:18 (292): Guest Log: 00:00:00.000979 main     5.2.6 r120293 started. Verbose level = 0
2025-01-21 09:01:18 (292): Guest Log: [INFO] Mounting the shared directory
2025-01-21 09:01:18 (292): Guest Log: [INFO] Shared directory mounted, enabling vboxmonitor
2025-01-21 09:01:18 (292): Guest Log: [INFO] Sourcing essential functions from /cvmfs/grid.cern.ch
2025-01-21 09:01:18 (292): Guest Log: [INFO] Testing connection to cern.ch
2025-01-21 09:01:18 (292): Guest Log: [INFO] Testing connection to VCCS
2025-01-21 09:01:18 (292): Guest Log: [INFO] Testing connection to HTCondor
2025-01-21 09:01:18 (292): Guest Log: [INFO] Testing connection to WMAgent
2025-01-21 09:01:18 (292): Guest Log: [INFO] Testing connection to EOSCMS
2025-01-21 09:01:18 (292): Guest Log: [INFO] Testing connection to CMS-Factory
2025-01-21 09:01:18 (292): Guest Log: [INFO] Testing connection to CMS-Frontier
2025-01-21 09:01:18 (292): Guest Log: [INFO] Testing connection to Frontier
2025-01-21 09:01:18 (292): Guest Log: [INFO] Could not find a local HTTP proxy
2025-01-21 09:01:18 (292): Guest Log: [INFO] CVMFS and Frontier will have to use DIRECT connections
2025-01-21 09:01:18 (292): Guest Log: [INFO] This makes the application less efficient
2025-01-21 09:01:18 (292): Guest Log: [INFO] It also puts higher load on the project servers
2025-01-21 09:01:18 (292): Guest Log: [INFO] Setting up a local HTTP proxy is highly recommended
2025-01-21 09:01:18 (292): Guest Log: [INFO] Advice can be found in the project forum
2025-01-21 09:01:18 (292): Guest Log: [INFO] Reloading and probing the CVMFS configuration
2025-01-21 09:01:18 (292): Guest Log: [INFO] Probing /cvmfs/grid.cern.ch... OK
2025-01-21 09:01:18 (292): Guest Log: [INFO] Probing /cvmfs/singularity.opensciencegrid.org... OK
2025-01-21 09:01:18 (292): Guest Log: [INFO] Probing /cvmfs/oasis.opensciencegrid.org... OK
2025-01-21 09:01:18 (292): Guest Log: [INFO] Probing /cvmfs/cms-ib.cern.ch... OK
2025-01-21 09:01:18 (292): Guest Log: [INFO] Probing /cvmfs/cms.cern.ch... OK
2025-01-21 09:01:18 (292): Guest Log: [INFO] Excerpt from "cvmfs_config stat": VERSION HOST PROXY
2025-01-21 09:01:18 (292): Guest Log: [INFO] 2.7.2.0 http://s1cern-cvmfs.openhtc.io DIRECT
2025-01-21 09:01:18 (292): Guest Log: [INFO] Environment HTTP proxy: not set
2025-01-21 09:01:18 (292): Guest Log: [INFO] Reading volunteer information
2025-01-21 09:01:18 (292): Guest Log: [INFO] Using weak account key.
2025-01-21 09:01:18 (292): Guest Log: [INFO] Requesting an X509 credential from LHC@home
2025-01-21 09:01:18 (292): Guest Log: [INFO] Using weak account key.
2025-01-21 09:01:18 (292): Guest Log: [INFO] Requesting an idtoken from LHC@home
2025-01-21 09:01:18 (292): Guest Log: [INFO] CMS application starting. Check log files.
2025-01-21 09:01:18 (292): Starting VM using VBoxManage interface. (boinc_6c679e4d335afabf, slot#0)
2025-01-21 09:01:25 (292): Successfully started VM. (PID = '10456')
2025-01-21 09:01:25 (292): Reporting VM Process ID to BOINC.
2025-01-21 09:01:25 (292): Guest Log: BIOS: VirtualBox 7.0.6
2025-01-21 09:01:25 (292): Guest Log: CPUID EDX: 0x178bfbff
2025-01-21 09:01:25 (292): Guest Log: BIOS: No PCI IDE controller, not probing IDE
2025-01-21 09:01:25 (292): Guest Log: BIOS: AHCI 0-P#0: PCHS=16383/16/63 LCHS=1024/255/63 0x0000000002800000 sectors
2025-01-21 09:01:25 (292): VM state change detected. (old = 'poweredoff', new = 'running')
2025-01-21 09:01:25 (292): Detected: Web Application Enabled (http://localhost:53133)
2025-01-21 09:01:25 (292): Status Report: Job Duration: '64800.000000'
2025-01-21 09:01:25 (292): Status Report: Elapsed Time: '15781.740156'
2025-01-21 09:01:25 (292): Status Report: CPU Time: '22400.156250'
2025-01-21 09:01:25 (292): Preference change detected
2025-01-21 09:01:25 (292): Setting CPU throttle for VM. (100%)
2025-01-21 09:01:25 (292): Setting checkpoint interval to 600 seconds. (Higher value of (Preference: 60 seconds) or (Vbox_job.xml: 600 seconds))
2025-01-21 09:01:27 (292): Guest Log: BIOS: Boot : bseqnr=1, bootseq=0032
2025-01-21 09:01:27 (292): Guest Log: BIOS: Booting from Hard Disk...
2025-01-21 09:01:30 (292): Guest Log: BIOS: KBD: unsupported int 16h function 03
2025-01-21 09:01:30 (292): Guest Log: BIOS: AX=0305 BX=0000 CX=0000 DX=0000 
2025-01-21 09:02:00 (292): Guest Log: vgdrvHeartbeatInit: Setting up heartbeat to trigger every 2000 milliseconds
2025-01-21 09:02:00 (292): Guest Log: vboxguest: misc device minor 56, IRQ 20, I/O port d020, MMIO at 00000000f0400000 (size 0x400000)
2025-01-21 09:02:01 (292): Guest Log: VBoxService 5.2.6 r120293 (verbosity: 0) linux.amd64 (Jan 15 2018 14:51:00) release log
2025-01-21 09:02:01 (292): Guest Log: 00:00:00.000086 main     Log opened 2025-01-21T08:01:59.337408000Z
2025-01-21 09:02:01 (292): Guest Log: 00:00:00.000162 main     OS Product: Linux
2025-01-21 09:02:01 (292): Guest Log: 00:00:00.000187 main     OS Release: 4.14.232-19.cernvm.x86_64
2025-01-21 09:02:01 (292): Guest Log: 00:00:00.000206 main     OS Version: #1 SMP Fri Apr 30 17:12:25 CEST 2021
2025-01-21 09:02:01 (292): Guest Log: 00:00:00.000224 main     Executable: /usr/sbin/VBoxService
2025-01-21 09:02:01 (292): Guest Log: 00:00:00.000224 main     Process ID: 2281
2025-01-21 09:02:01 (292): Guest Log: 00:00:00.000225 main     Package type: LINUX_64BITS_GENERIC
2025-01-21 09:02:01 (292): Guest Log: 00:00:00.004407 main     5.2.6 r120293 started. Verbose level = 0
2025-01-21 09:02:11 (292): Guest Log: [INFO] Mounting the shared directory
2025-01-21 09:02:11 (292): Guest Log: [INFO] Shared directory mounted, enabling vboxmonitor
2025-01-21 09:02:11 (292): Guest Log: [INFO] Sourcing essential functions from /cvmfs/grid.cern.ch
2025-01-21 09:02:12 (292): Guest Log: [INFO] Testing connection to cern.ch
2025-01-21 09:02:12 (292): Guest Log: [INFO] Testing connection to VCCS
2025-01-21 09:02:12 (292): Guest Log: [INFO] Testing connection to HTCondor
2025-01-21 09:02:12 (292): Guest Log: [INFO] Testing connection to WMAgent
2025-01-21 09:02:12 (292): Guest Log: [INFO] Testing connection to EOSCMS
2025-01-21 09:02:12 (292): Guest Log: [INFO] Testing connection to CMS-Factory
2025-01-21 09:02:12 (292): Guest Log: [INFO] Testing connection to CMS-Frontier
2025-01-21 09:02:13 (292): Guest Log: [INFO] Testing connection to Frontier
2025-01-21 09:02:13 (292): Guest Log: [INFO] Could not find a local HTTP proxy
2025-01-21 09:02:13 (292): Guest Log: [INFO] CVMFS and Frontier will have to use DIRECT connections
2025-01-21 09:02:13 (292): Guest Log: [INFO] This makes the application less efficient
2025-01-21 09:02:13 (292): Guest Log: [INFO] It also puts higher load on the project servers
2025-01-21 09:02:13 (292): Guest Log: [INFO] Setting up a local HTTP proxy is highly recommended
2025-01-21 09:02:13 (292): Guest Log: [INFO] Advice can be found in the project forum
2025-01-21 09:02:13 (292): Guest Log: [INFO] Reloading and probing the CVMFS configuration
2025-01-21 09:02:21 (292): Guest Log: [INFO] Probing /cvmfs/grid.cern.ch... OK
2025-01-21 09:02:23 (292): Guest Log: [INFO] Probing /cvmfs/cms-ib.cern.ch... OK
2025-01-21 09:02:23 (292): Guest Log: [INFO] Probing /cvmfs/oasis.opensciencegrid.org... OK
2025-01-21 09:02:24 (292): Guest Log: [INFO] Probing /cvmfs/singularity.opensciencegrid.org... OK
2025-01-21 09:02:25 (292): Guest Log: [INFO] Probing /cvmfs/cms.cern.ch... OK
2025-01-21 09:02:25 (292): Guest Log: [INFO] Excerpt from "cvmfs_config stat": VERSION HOST PROXY
2025-01-21 09:02:26 (292): Guest Log: [INFO] 2.7.2.0 http://s1fnal-cvmfs.openhtc.io:8080 DIRECT
2025-01-21 09:02:26 (292): Guest Log: [INFO] Environment HTTP proxy: not set
2025-01-21 09:02:26 (292): Guest Log: [INFO] Reading volunteer information
2025-01-21 09:02:27 (292): VM state change detected. (old = 'running', new = 'paused')
2025-01-21 09:02:47 (292): VM state change detected. (old = 'paused', new = 'running')
2025-01-21 09:02:49 (292): Guest Log: [INFO] Using weak account key.
2025-01-21 09:02:49 (292): Guest Log: [INFO] Requesting an X509 credential from LHC@home
2025-01-21 09:02:50 (292): Guest Log: [INFO] Using weak account key.
2025-01-21 09:02:50 (292): Guest Log: [INFO] Requesting an idtoken from LHC@home
2025-01-21 09:02:51 (292): Guest Log: [INFO] CMS application starting. Check log files.
2025-01-21 09:06:58 (292): VM state change detected. (old = 'running', new = 'paused')
2025-01-21 09:07:18 (292): VM state change detected. (old = 'paused', new = 'running')
2025-01-21 09:07:47 (292): VM state change detected. (old = 'running', new = 'paused')
2025-01-21 09:08:07 (292): VM state change detected. (old = 'paused', new = 'running')
2025-01-21 09:08:17 (292): VM state change detected. (old = 'running', new = 'paused')
2025-01-21 09:08:37 (292): VM state change detected. (old = 'paused', new = 'running')
2025-01-21 09:08:58 (292): VM state change detected. (old = 'running', new = 'paused')
2025-01-21 09:09:18 (292): VM state change detected. (old = 'paused', new = 'running')
2025-01-21 09:09:48 (292): VM state change detected. (old = 'running', new = 'paused')
2025-01-21 09:10:08 (292): VM state change detected. (old = 'paused', new = 'running')
2025-01-21 09:10:18 (292): VM state change detected. (old = 'running', new = 'paused')
2025-01-21 09:10:38 (292): VM state change detected. (old = 'paused', new = 'running')
2025-01-21 09:11:07 (292): VM state change detected. (old = 'running', new = 'paused')
2025-01-21 09:11:28 (292): VM state change detected. (old = 'paused', new = 'running')
2025-01-21 09:12:18 (292): VM state change detected. (old = 'running', new = 'paused')
2025-01-21 09:12:38 (292): VM state change detected. (old = 'paused', new = 'running')
2025-01-21 09:13:18 (292): VM state change detected. (old = 'running', new = 'paused')
2025-01-21 09:13:38 (292): VM state change detected. (old = 'paused', new = 'running')
2025-01-21 09:13:48 (292): VM state change detected. (old = 'running', new = 'paused')
2025-01-21 09:14:08 (292): VM state change detected. (old = 'paused', new = 'running')
2025-01-21 09:14:18 (292): VM state change detected. (old = 'running', new = 'paused')
2025-01-21 09:14:38 (292): VM state change detected. (old = 'paused', new = 'running')
2025-01-21 09:14:58 (292): VM state change detected. (old = 'running', new = 'paused')
2025-01-21 09:15:18 (292): VM state change detected. (old = 'paused', new = 'running')
2025-01-21 09:15:29 (292): VM state change detected. (old = 'running', new = 'paused')
2025-01-21 09:15:48 (292): VM state change detected. (old = 'paused', new = 'running')
2025-01-21 09:16:38 (292): VM state change detected. (old = 'running', new = 'paused')
2025-01-21 09:16:58 (292): VM state change detected. (old = 'paused', new = 'running')
2025-01-21 09:17:28 (292): VM state change detected. (old = 'running', new = 'paused')
2025-01-21 09:17:48 (292): VM state change detected. (old = 'paused', new = 'running')
2025-01-21 09:18:19 (292): VM state change detected. (old = 'running', new = 'paused')
2025-01-21 09:18:39 (292): VM state change detected. (old = 'paused', new = 'running')
2025-01-21 09:18:49 (292): VM state change detected. (old = 'running', new = 'paused')
2025-01-21 09:19:09 (292): VM state change detected. (old = 'paused', new = 'running')
2025-01-21 09:19:39 (292): VM state change detected. (old = 'running', new = 'paused')
2025-01-21 09:19:59 (292): VM state change detected. (old = 'paused', new = 'running')
2025-01-21 09:20:09 (292): VM state change detected. (old = 'running', new = 'paused')
2025-01-21 09:20:29 (292): VM state change detected. (old = 'paused', new = 'running')
2025-01-21 09:20:49 (292): VM state change detected. (old = 'running', new = 'paused')
2025-01-21 09:21:09 (292): VM state change detected. (old = 'paused', new = 'running')
2025-01-21 09:21:19 (292): VM state change detected. (old = 'running', new = 'paused')
2025-01-21 09:21:39 (292): VM state change detected. (old = 'paused', new = 'running')
2025-01-21 09:21:59 (292): VM state change detected. (old = 'running', new = 'paused')
2025-01-21 09:22:19 (292): VM state change detected. (old = 'paused', new = 'running')
2025-01-21 09:23:09 (292): VM state change detected. (old = 'running', new = 'paused')
2025-01-21 09:23:29 (292): VM state change detected. (old = 'paused', new = 'running')
2025-01-21 09:23:49 (292): VM state change detected. (old = 'running', new = 'paused')
2025-01-21 09:24:09 (292): VM state change detected. (old = 'paused', new = 'running')
2025-01-21 09:24:19 (292): VM state change detected. (old = 'running', new = 'paused')
2025-01-21 09:24:40 (292): VM state change detected. (old = 'paused', new = 'running')
2025-01-21 13:55:34 (17420): vboxwrapper version 26207
2025-01-21 13:55:34 (17420): BOINC client version: 8.0.2
2025-01-21 13:55:36 (17420): Detected: VirtualBox VboxManage Interface (Version: 7.0.6)
2025-01-21 13:55:36 (17420): Detected: Heartbeat check (file: 'heartbeat' every 1200.000000 seconds)
2025-01-21 13:55:36 (17420): Guest Log: BIOS: VirtualBox 7.0.6
2025-01-21 13:55:36 (17420): Guest Log: CPUID EDX: 0x178bfbff
2025-01-21 13:55:36 (17420): Guest Log: BIOS: No PCI IDE controller, not probing IDE
2025-01-21 13:55:36 (17420): Guest Log: BIOS: AHCI 0-P#0: PCHS=16383/16/63 LCHS=1024/255/63 0x0000000002800000 sectors
2025-01-21 13:55:36 (17420): Guest Log: BIOS: Boot : bseqnr=1, bootseq=0032
2025-01-21 13:55:36 (17420): Guest Log: BIOS: Booting from Hard Disk...
2025-01-21 13:55:36 (17420): Guest Log: BIOS: KBD: unsupported int 16h function 03
2025-01-21 13:55:36 (17420): Guest Log: BIOS: AX=0305 BX=0000 CX=0000 DX=0000 
2025-01-21 13:55:36 (17420): Guest Log: vgdrvHeartbeatInit: Setting up heartbeat to trigger every 2000 milliseconds
2025-01-21 13:55:36 (17420): Guest Log: vboxguest: misc device minor 56, IRQ 20, I/O port d020, MMIO at 00000000f0400000 (size 0x400000)
2025-01-21 13:55:36 (17420): Guest Log: VBoxService 5.2.6 r120293 (verbosity: 0) linux.amd64 (Jan 15 2018 14:51:00) release log
2025-01-21 13:55:36 (17420): Guest Log: 00:00:00.000086 main     Log opened 2025-01-21T08:01:59.337408000Z
2025-01-21 13:55:36 (17420): Guest Log: 00:00:00.000162 main     OS Product: Linux
2025-01-21 13:55:36 (17420): Guest Log: 00:00:00.000187 main     OS Release: 4.14.232-19.cernvm.x86_64
2025-01-21 13:55:36 (17420): Guest Log: 00:00:00.000206 main     OS Version: #1 SMP Fri Apr 30 17:12:25 CEST 2021
2025-01-21 13:55:36 (17420): Guest Log: 00:00:00.000224 main     Executable: /usr/sbin/VBoxService
2025-01-21 13:55:36 (17420): Guest Log: 00:00:00.000224 main     Process ID: 2281
2025-01-21 13:55:36 (17420): Guest Log: 00:00:00.000225 main     Package type: LINUX_64BITS_GENERIC
2025-01-21 13:55:36 (17420): Guest Log: 00:00:00.004407 main     5.2.6 r120293 started. Verbose level = 0
2025-01-21 13:55:36 (17420): Guest Log: [INFO] Mounting the shared directory
2025-01-21 13:55:36 (17420): Guest Log: [INFO] Shared directory mounted, enabling vboxmonitor
2025-01-21 13:55:36 (17420): Guest Log: [INFO] Sourcing essential functions from /cvmfs/grid.cern.ch
2025-01-21 13:55:36 (17420): Guest Log: [INFO] Testing connection to cern.ch
2025-01-21 13:55:36 (17420): Guest Log: [INFO] Testing connection to VCCS
2025-01-21 13:55:36 (17420): Guest Log: [INFO] Testing connection to HTCondor
2025-01-21 13:55:36 (17420): Guest Log: [INFO] Testing connection to WMAgent
2025-01-21 13:55:36 (17420): Guest Log: [INFO] Testing connection to EOSCMS
2025-01-21 13:55:36 (17420): Guest Log: [INFO] Testing connection to CMS-Factory
2025-01-21 13:55:36 (17420): Guest Log: [INFO] Testing connection to CMS-Frontier
2025-01-21 13:55:36 (17420): Guest Log: [INFO] Testing connection to Frontier
2025-01-21 13:55:36 (17420): Guest Log: [INFO] Could not find a local HTTP proxy
2025-01-21 13:55:36 (17420): Guest Log: [INFO] CVMFS and Frontier will have to use DIRECT connections
2025-01-21 13:55:36 (17420): Guest Log: [INFO] This makes the application less efficient
2025-01-21 13:55:36 (17420): Guest Log: [INFO] It also puts higher load on the project servers
2025-01-21 13:55:36 (17420): Guest Log: [INFO] Setting up a local HTTP proxy is highly recommended
2025-01-21 13:55:36 (17420): Guest Log: [INFO] Advice can be found in the project forum
2025-01-21 13:55:36 (17420): Guest Log: [INFO] Reloading and probing the CVMFS configuration
2025-01-21 13:55:36 (17420): Guest Log: [INFO] Probing /cvmfs/grid.cern.ch... OK
2025-01-21 13:55:36 (17420): Guest Log: [INFO] Probing /cvmfs/cms-ib.cern.ch... OK
2025-01-21 13:55:36 (17420): Guest Log: [INFO] Probing /cvmfs/oasis.opensciencegrid.org... OK
2025-01-21 13:55:36 (17420): Guest Log: [INFO] Probing /cvmfs/singularity.opensciencegrid.org... OK
2025-01-21 13:55:36 (17420): Guest Log: [INFO] Probing /cvmfs/cms.cern.ch... OK
2025-01-21 13:55:36 (17420): Guest Log: [INFO] Excerpt from "cvmfs_config stat": VERSION HOST PROXY
2025-01-21 13:55:36 (17420): Guest Log: [INFO] 2.7.2.0 http://s1fnal-cvmfs.openhtc.io:8080 DIRECT
2025-01-21 13:55:36 (17420): Guest Log: [INFO] Environment HTTP proxy: not set
2025-01-21 13:55:36 (17420): Guest Log: [INFO] Reading volunteer information
2025-01-21 13:55:36 (17420): Guest Log: [INFO] Using weak account key.
2025-01-21 13:55:36 (17420): Guest Log: [INFO] Requesting an X509 credential from LHC@home
2025-01-21 13:55:36 (17420): Guest Log: [INFO] Using weak account key.
2025-01-21 13:55:36 (17420): Guest Log: [INFO] Requesting an idtoken from LHC@home
2025-01-21 13:55:36 (17420): Guest Log: [INFO] CMS application starting. Check log files.
2025-01-21 13:55:36 (17420): Starting VM using VBoxManage interface. (boinc_6c679e4d335afabf, slot#0)
2025-01-21 13:55:43 (17420): Successfully started VM. (PID = '5212')
2025-01-21 13:55:43 (17420): Reporting VM Process ID to BOINC.
2025-01-21 13:55:43 (17420): Guest Log: BIOS: VirtualBox 7.0.6
2025-01-21 13:55:43 (17420): Guest Log: CPUID EDX: 0x178bfbff
2025-01-21 13:55:43 (17420): Guest Log: BIOS: No PCI IDE controller, not probing IDE
2025-01-21 13:55:43 (17420): Guest Log: BIOS: AHCI 0-P#0: PCHS=16383/16/63 LCHS=1024/255/63 0x0000000002800000 sectors
2025-01-21 13:55:43 (17420): VM state change detected. (old = 'poweredoff', new = 'running')
2025-01-21 13:55:43 (17420): Detected: Web Application Enabled (http://localhost:53133)
2025-01-21 13:55:43 (17420): Status Report: Job Duration: '64800.000000'
2025-01-21 13:55:43 (17420): Status Report: Elapsed Time: '16626.740156'
2025-01-21 13:55:43 (17420): Status Report: CPU Time: '23244.828125'
2025-01-21 13:55:43 (17420): Preference change detected
2025-01-21 13:55:43 (17420): Setting CPU throttle for VM. (100%)
2025-01-21 13:55:44 (17420): Setting checkpoint interval to 600 seconds. (Higher value of (Preference: 60 seconds) or (Vbox_job.xml: 600 seconds))
2025-01-21 13:55:45 (17420): VM state change detected. (old = 'running', new = 'paused')
2025-01-21 13:56:05 (17420): Guest Log: BIOS: Boot : bseqnr=1, bootseq=0032
2025-01-21 13:56:05 (17420): Guest Log: BIOS: Booting from Hard Disk...
2025-01-21 13:56:05 (17420): VM state change detected. (old = 'paused', new = 'running')
2025-01-21 13:56:07 (17420): Guest Log: BIOS: KBD: unsupported int 16h function 03
2025-01-21 13:56:07 (17420): Guest Log: BIOS: AX=0305 BX=0000 CX=0000 DX=0000 
2025-01-21 13:56:34 (17420): Guest Log: vgdrvHeartbeatInit: Setting up heartbeat to trigger every 2000 milliseconds
2025-01-21 13:56:34 (17420): Guest Log: vboxguest: misc device minor 56, IRQ 20, I/O port d020, MMIO at 00000000f0400000 (size 0x400000)
2025-01-21 13:56:34 (17420): Guest Log: VBoxService 5.2.6 r120293 (verbosity: 0) linux.amd64 (Jan 15 2018 14:51:00) release log
2025-01-21 13:56:34 (17420): Guest Log: 00:00:00.000064 main     Log opened 2025-01-21T12:56:32.319558000Z
2025-01-21 13:56:34 (17420): Guest Log: 00:00:00.000164 main     OS Product: Linux
2025-01-21 13:56:34 (17420): Guest Log: 00:00:00.000220 main     OS Release: 4.14.232-19.cernvm.x86_64
2025-01-21 13:56:34 (17420): Guest Log: 00:00:00.000243 main     OS Version: #1 SMP Fri Apr 30 17:12:25 CEST 2021
2025-01-21 13:56:34 (17420): Guest Log: 00:00:00.000262 main     Executable: /usr/sbin/VBoxService
2025-01-21 13:56:34 (17420): Guest Log: 00:00:00.000262 main     Process ID: 2273
2025-01-21 13:56:34 (17420): Guest Log: 00:00:00.000263 main     Package type: LINUX_64BITS_GENERIC
2025-01-21 13:56:34 (17420): Guest Log: 00:00:00.001629 main     5.2.6 r120293 started. Verbose level = 0
2025-01-21 13:56:46 (17420): Guest Log: [INFO] Mounting the shared directory
2025-01-21 13:56:46 (17420): Guest Log: [INFO] Shared directory mounted, enabling vboxmonitor
2025-01-21 13:56:46 (17420): Guest Log: [INFO] Sourcing essential functions from /cvmfs/grid.cern.ch
2025-01-21 13:56:46 (17420): Guest Log: [INFO] Testing connection to cern.ch
2025-01-21 13:56:46 (17420): Guest Log: [INFO] Testing connection to VCCS
2025-01-21 13:56:46 (17420): Guest Log: [INFO] Testing connection to HTCondor
2025-01-21 13:56:46 (17420): Guest Log: [INFO] Testing connection to WMAgent
2025-01-21 13:56:47 (17420): Guest Log: [INFO] Testing connection to EOSCMS
2025-01-21 13:56:47 (17420): Guest Log: [INFO] Testing connection to CMS-Factory
2025-01-21 13:56:47 (17420): Guest Log: [INFO] Testing connection to CMS-Frontier
2025-01-21 13:56:47 (17420): Guest Log: [INFO] Testing connection to Frontier
2025-01-21 13:56:47 (17420): Guest Log: [INFO] Could not find a local HTTP proxy
2025-01-21 13:56:47 (17420): Guest Log: [INFO] CVMFS and Frontier will have to use DIRECT connections
2025-01-21 13:56:47 (17420): Guest Log: [INFO] This makes the application less efficient
2025-01-21 13:56:47 (17420): Guest Log: [INFO] It also puts higher load on the project servers
2025-01-21 13:56:48 (17420): Guest Log: [INFO] Setting up a local HTTP proxy is highly recommended
2025-01-21 13:56:48 (17420): Guest Log: [INFO] Advice can be found in the project forum
2025-01-21 13:56:48 (17420): Guest Log: [INFO] Reloading and probing the CVMFS configuration
2025-01-21 13:56:53 (17420): Guest Log: [INFO] Probing /cvmfs/grid.cern.ch... OK
2025-01-21 13:56:54 (17420): Guest Log: [INFO] Probing /cvmfs/cms.cern.ch... OK
2025-01-21 13:56:54 (17420): Guest Log: [INFO] Probing /cvmfs/oasis.opensciencegrid.org... OK
2025-01-21 13:56:55 (17420): Guest Log: [INFO] Probing /cvmfs/singularity.opensciencegrid.org... OK
2025-01-21 13:56:56 (17420): Guest Log: [INFO] Probing /cvmfs/cms-ib.cern.ch... OK
2025-01-21 13:56:57 (17420): Guest Log: [INFO] Excerpt from "cvmfs_config stat": VERSION HOST PROXY
2025-01-21 13:56:57 (17420): Guest Log: [INFO] 2.7.2.0 http://s1cern-cvmfs.openhtc.io DIRECT
2025-01-21 13:56:57 (17420): Guest Log: [INFO] Environment HTTP proxy: not set
2025-01-21 13:56:57 (17420): Guest Log: [INFO] Reading volunteer information
2025-01-21 13:56:57 (17420): Guest Log: [INFO] Using weak account key.
2025-01-21 13:56:57 (17420): Guest Log: [INFO] Requesting an X509 credential from LHC@home
2025-01-21 13:56:58 (17420): Guest Log: [INFO] Using weak account key.
2025-01-21 13:56:58 (17420): Guest Log: [INFO] Requesting an idtoken from LHC@home
2025-01-21 13:56:59 (17420): Guest Log: [INFO] CMS application starting. Check log files.
2025-01-21 14:00:06 (17420): VM state change detected. (old = 'running', new = 'paused')
2025-01-21 14:00:26 (17420): VM state change detected. (old = 'paused', new = 'running')
2025-01-21 14:00:36 (17420): VM state change detected. (old = 'running', new = 'paused')
2025-01-21 14:00:56 (17420): VM state change detected. (old = 'paused', new = 'running')
2025-01-21 14:01:06 (17420): VM state change detected. (old = 'running', new = 'paused')
2025-01-21 14:01:26 (17420): VM state change detected. (old = 'paused', new = 'running')
2025-01-21 14:01:46 (17420): VM state change detected. (old = 'running', new = 'paused')
2025-01-21 14:02:06 (17420): VM state change detected. (old = 'paused', new = 'running')
2025-01-21 14:02:16 (17420): VM state change detected. (old = 'running', new = 'paused')
2025-01-21 14:02:36 (17420): VM state change detected. (old = 'paused', new = 'running')
2025-01-21 14:02:46 (17420): VM state change detected. (old = 'running', new = 'paused')
2025-01-21 14:03:06 (17420): VM state change detected. (old = 'paused', new = 'running')
2025-01-21 14:03:16 (17420): VM state change detected. (old = 'running', new = 'paused')
2025-01-21 14:03:36 (17420): VM state change detected. (old = 'paused', new = 'running')
2025-01-21 14:03:56 (17420): VM state change detected. (old = 'running', new = 'paused')
2025-01-21 14:04:16 (17420): VM state change detected. (old = 'paused', new = 'running')
2025-01-21 14:04:26 (17420): VM state change detected. (old = 'running', new = 'paused')
2025-01-21 14:04:46 (17420): VM state change detected. (old = 'paused', new = 'running')
2025-01-21 14:05:16 (17420): VM state change detected. (old = 'running', new = 'paused')
2025-01-21 14:05:36 (17420): VM state change detected. (old = 'paused', new = 'running')
2025-01-21 14:05:46 (17420): VM state change detected. (old = 'running', new = 'paused')
2025-01-21 14:06:06 (17420): VM state change detected. (old = 'paused', new = 'running')
2025-01-21 14:06:36 (17420): VM state change detected. (old = 'running', new = 'paused')
2025-01-21 14:06:56 (17420): VM state change detected. (old = 'paused', new = 'running')
2025-01-21 14:07:37 (17420): VM state change detected. (old = 'running', new = 'paused')
2025-01-21 14:07:57 (17420): VM state change detected. (old = 'paused', new = 'running')
2025-01-21 14:07:57 (17420): Stopping VM.
2025-01-21 14:08:12 (17420): Successfully stopped VM.
2025-01-22 15:46:50 (3460): vboxwrapper version 26207
2025-01-22 15:46:50 (3460): BOINC client version: 8.0.2
2025-01-22 15:46:51 (3460): Detected: VirtualBox VboxManage Interface (Version: 7.0.6)
2025-01-22 15:46:52 (3460): Detected: Heartbeat check (file: 'heartbeat' every 1200.000000 seconds)
2025-01-22 15:46:52 (3460): Guest Log: BIOS: VirtualBox 7.0.6
2025-01-22 15:46:52 (3460): Guest Log: CPUID EDX: 0x178bfbff
2025-01-22 15:46:52 (3460): Guest Log: BIOS: No PCI IDE controller, not probing IDE
2025-01-22 15:46:52 (3460): Guest Log: BIOS: AHCI 0-P#0: PCHS=16383/16/63 LCHS=1024/255/63 0x0000000002800000 sectors
2025-01-22 15:46:52 (3460): Guest Log: BIOS: Boot : bseqnr=1, bootseq=0032
2025-01-22 15:46:52 (3460): Guest Log: BIOS: Booting from Hard Disk...
2025-01-22 15:46:52 (3460): Guest Log: BIOS: KBD: unsupported int 16h function 03
2025-01-22 15:46:52 (3460): Guest Log: BIOS: AX=0305 BX=0000 CX=0000 DX=0000 
2025-01-22 15:46:52 (3460): Guest Log: vgdrvHeartbeatInit: Setting up heartbeat to trigger every 2000 milliseconds
2025-01-22 15:46:52 (3460): Guest Log: vboxguest: misc device minor 56, IRQ 20, I/O port d020, MMIO at 00000000f0400000 (size 0x400000)
2025-01-22 15:46:52 (3460): Guest Log: VBoxService 5.2.6 r120293 (verbosity: 0) linux.amd64 (Jan 15 2018 14:51:00) release log
2025-01-22 15:46:52 (3460): Guest Log: 00:00:00.000064 main     Log opened 2025-01-21T12:56:32.319558000Z
2025-01-22 15:46:52 (3460): Guest Log: 00:00:00.000164 main     OS Product: Linux
2025-01-22 15:46:52 (3460): Guest Log: 00:00:00.000220 main     OS Release: 4.14.232-19.cernvm.x86_64
2025-01-22 15:46:52 (3460): Guest Log: 00:00:00.000243 main     OS Version: #1 SMP Fri Apr 30 17:12:25 CEST 2021
2025-01-22 15:46:52 (3460): Guest Log: 00:00:00.000262 main     Executable: /usr/sbin/VBoxService
2025-01-22 15:46:52 (3460): Guest Log: 00:00:00.000262 main     Process ID: 2273
2025-01-22 15:46:52 (3460): Guest Log: 00:00:00.000263 main     Package type: LINUX_64BITS_GENERIC
2025-01-22 15:46:52 (3460): Guest Log: 00:00:00.001629 main     5.2.6 r120293 started. Verbose level = 0
2025-01-22 15:46:52 (3460): Guest Log: [INFO] Mounting the shared directory
2025-01-22 15:46:52 (3460): Guest Log: [INFO] Shared directory mounted, enabling vboxmonitor
2025-01-22 15:46:52 (3460): Guest Log: [INFO] Sourcing essential functions from /cvmfs/grid.cern.ch
2025-01-22 15:46:52 (3460): Guest Log: [INFO] Testing connection to cern.ch
2025-01-22 15:46:52 (3460): Guest Log: [INFO] Testing connection to VCCS
2025-01-22 15:46:52 (3460): Guest Log: [INFO] Testing connection to HTCondor
2025-01-22 15:46:52 (3460): Guest Log: [INFO] Testing connection to WMAgent
2025-01-22 15:46:52 (3460): Guest Log: [INFO] Testing connection to EOSCMS
2025-01-22 15:46:52 (3460): Guest Log: [INFO] Testing connection to CMS-Factory
2025-01-22 15:46:52 (3460): Guest Log: [INFO] Testing connection to CMS-Frontier
2025-01-22 15:46:52 (3460): Guest Log: [INFO] Testing connection to Frontier
2025-01-22 15:46:52 (3460): Guest Log: [INFO] Could not find a local HTTP proxy
2025-01-22 15:46:52 (3460): Guest Log: [INFO] CVMFS and Frontier will have to use DIRECT connections
2025-01-22 15:46:52 (3460): Guest Log: [INFO] This makes the application less efficient
2025-01-22 15:46:52 (3460): Guest Log: [INFO] It also puts higher load on the project servers
2025-01-22 15:46:52 (3460): Guest Log: [INFO] Setting up a local HTTP proxy is highly recommended
2025-01-22 15:46:52 (3460): Guest Log: [INFO] Advice can be found in the project forum
2025-01-22 15:46:52 (3460): Guest Log: [INFO] Reloading and probing the CVMFS configuration
2025-01-22 15:46:52 (3460): Guest Log: [INFO] Probing /cvmfs/grid.cern.ch... OK
2025-01-22 15:46:52 (3460): Guest Log: [INFO] Probing /cvmfs/cms.cern.ch... OK
2025-01-22 15:46:52 (3460): Guest Log: [INFO] Probing /cvmfs/oasis.opensciencegrid.org... OK
2025-01-22 15:46:52 (3460): Guest Log: [INFO] Probing /cvmfs/singularity.opensciencegrid.org... OK
2025-01-22 15:46:52 (3460): Guest Log: [INFO] Probing /cvmfs/cms-ib.cern.ch... OK
2025-01-22 15:46:52 (3460): Guest Log: [INFO] Excerpt from "cvmfs_config stat": VERSION HOST PROXY
2025-01-22 15:46:52 (3460): Guest Log: [INFO] 2.7.2.0 http://s1cern-cvmfs.openhtc.io DIRECT
2025-01-22 15:46:52 (3460): Guest Log: [INFO] Environment HTTP proxy: not set
2025-01-22 15:46:52 (3460): Guest Log: [INFO] Reading volunteer information
2025-01-22 15:46:52 (3460): Guest Log: [INFO] Using weak account key.
2025-01-22 15:46:52 (3460): Guest Log: [INFO] Requesting an X509 credential from LHC@home
2025-01-22 15:46:52 (3460): Guest Log: [INFO] Using weak account key.
2025-01-22 15:46:52 (3460): Guest Log: [INFO] Requesting an idtoken from LHC@home
2025-01-22 15:46:52 (3460): Guest Log: [INFO] CMS application starting. Check log files.
2025-01-22 15:46:52 (3460): Starting VM using VBoxManage interface. (boinc_6c679e4d335afabf, slot#0)
2025-01-22 15:47:16 (3460): Successfully started VM. (PID = '12324')
2025-01-22 15:47:16 (3460): Reporting VM Process ID to BOINC.
2025-01-22 15:47:16 (3460): VM state change detected. (old = 'poweredoff', new = 'running')
2025-01-22 15:47:16 (3460): Detected: Web Application Enabled (http://localhost:53133)
2025-01-22 15:47:17 (3460): VM state change detected. (old = 'running', new = 'paused')
2025-01-22 15:47:19 (3460): Status Report: Job Duration: '64800.000000'
2025-01-22 15:47:19 (3460): Status Report: Elapsed Time: '17065.740156'
2025-01-22 15:47:19 (3460): Status Report: CPU Time: '23600.671875'
2025-01-22 15:47:19 (3460): Preference change detected
2025-01-22 15:47:19 (3460): Setting CPU throttle for VM. (100%)
2025-01-22 15:47:20 (3460): Setting checkpoint interval to 600 seconds. (Higher value of (Preference: 60 seconds) or (Vbox_job.xml: 600 seconds))
2025-01-22 15:47:20 (3460): VM state change detected. (old = 'paused', new = 'running')
2025-01-22 15:47:24 (3460): Guest Log: 00:07:10.142379 timesync vgsvcTimeSyncWorker: Radical host time change: 92 390 536 000 000ns (HostNow=1 737 557 244 489 000 000 ns HostLast=1 737 464 853 953 000 000 ns)
2025-01-22 15:47:34 (3460): Guest Log: 00:07:20.145632 timesync vgsvcTimeSyncWorker: Radical guest time change: 92 632 030 609 000ns (GuestNow=1 737 557 254 492


©2025 CERN