| Name | CMS_633700_1752903840.091160_0 |
| Workunit | 233679627 |
| Created | 19 Jul 2025, 5:44:03 UTC |
| Sent | 19 Jul 2025, 8:44:21 UTC |
| Report deadline | 19 Aug 2025, 8:44:21 UTC |
| Received | 24 Jul 2025, 9:03:29 UTC |
| Server state | Over |
| Outcome | Computation error |
| Client state | Compute error |
| Exit status | -2147467259 (0x80004005) Unknown error code |
| Computer ID | 10842609 |
| Run time | 16 hours 15 min 10 sec |
| CPU time | 2 days 10 hours 36 min 45 sec |
| Validate state | Invalid |
| Credit | 0.00 |
| Device peak FLOPS | 20.31 GFLOPS |
| Application version | CMS Simulation v70.91 (vbox64_mt_mcore_cms) windows_x86_64 |
| Peak working set size | 71.04 MB |
| Peak swap size | 70.96 MB |
| Peak disk usage | 3.30 GB |
Stderr output
<core_client_version>8.0.2</core_client_version>
<![CDATA[
<message>
Erreur non sp�cifi�e
(0x80004005) - exit code 2147500037 (0x80004005)</message>
<stderr_txt>
Guest Log: [INFO] Mounting the shared directory
2025-07-23 12:18:47 (12724): Guest Log: [INFO] Shared directory mounted, enabling vboxmonitor
2025-07-23 12:18:47 (12724): Guest Log: [INFO] Sourcing essential functions from /cvmfs/grid.cern.ch
2025-07-23 12:18:47 (12724): Guest Log: [INFO] Testing connection to cern.ch
2025-07-23 12:18:47 (12724): Guest Log: [INFO] Testing connection to VCCS
2025-07-23 12:18:47 (12724): Guest Log: [INFO] Testing connection to HTCondor
2025-07-23 12:18:47 (12724): Guest Log: [INFO] Testing connection to WMAgent
2025-07-23 12:18:48 (12724): Guest Log: [INFO] Testing connection to EOSCMS
2025-07-23 12:18:48 (12724): Guest Log: [INFO] Testing connection to CMS-Factory
2025-07-23 12:18:48 (12724): Guest Log: [INFO] Testing connection to CMS-Frontier
2025-07-23 12:18:48 (12724): Guest Log: [INFO] Testing connection to Frontier
2025-07-23 12:18:48 (12724): Guest Log: [INFO] Testing connection to http://cms-frontier.openhtc.io:8080/FrontierProd/Frontier/
2025-07-23 12:18:50 (12724): Guest Log: [INFO] Could not find a local HTTP proxy
2025-07-23 12:18:50 (12724): Guest Log: [INFO] CVMFS and Frontier will have to use DIRECT connections
2025-07-23 12:18:50 (12724): Guest Log: [INFO] This makes the application less efficient
2025-07-23 12:18:50 (12724): Guest Log: [INFO] It also puts higher load on the project servers
2025-07-23 12:18:50 (12724): Guest Log: [INFO] Setting up a local HTTP proxy is highly recommended
2025-07-23 12:18:50 (12724): Guest Log: [INFO] Advice can be found in the project forum
2025-07-23 12:18:50 (12724): Guest Log: [INFO] Reloading and probing the CVMFS configuration
2025-07-23 12:18:58 (12724): Guest Log: [INFO] Probing /cvmfs/grid.cern.ch... OK
2025-07-23 12:19:01 (12724): Guest Log: [INFO] Probing /cvmfs/cms-ib.cern.ch... OK
2025-07-23 12:19:01 (12724): Guest Log: [INFO] Probing /cvmfs/singularity.opensciencegrid.org... OK
2025-07-23 12:19:01 (12724): Guest Log: [INFO] Probing /cvmfs/cms.cern.ch... OK
2025-07-23 12:19:01 (12724): Guest Log: [INFO] Probing /cvmfs/oasis.opensciencegrid.org... OK
2025-07-23 12:19:02 (12724): Guest Log: [INFO] Excerpt from "cvmfs_config stat": VERSION HOST PROXY
2025-07-23 12:19:02 (12724): Guest Log: [INFO] 2.7.2.0 http://s1cern-cvmfs.openhtc.io DIRECT
2025-07-23 12:19:02 (12724): Guest Log: [INFO] Environment HTTP proxy: not set
2025-07-23 12:19:02 (12724): Guest Log: [INFO] Reading volunteer information
2025-07-23 12:19:07 (12724): Guest Log: [INFO] Requesting an X509 credential from LHC@home
2025-07-23 12:19:09 (12724): Guest Log: [INFO] Requesting an idtoken from LHC@home
2025-07-23 12:19:09 (12724): Guest Log: [INFO] CMS application starting. Check log files.
2025-07-23 12:29:00 (12724): VM state change detected. (old = 'running', new = 'paused')
2025-07-23 12:29:20 (12724): VM state change detected. (old = 'paused', new = 'running')
2025-07-23 12:35:48 (12724): VM state change detected. (old = 'running', new = 'paused')
2025-07-23 12:42:08 (12724): VM state change detected. (old = 'paused', new = 'running')
2025-07-23 12:50:15 (12724): VM state change detected. (old = 'running', new = 'paused')
2025-07-23 12:56:51 (12724): VM state change detected. (old = 'paused', new = 'running')
2025-07-23 12:59:13 (12724): VM state change detected. (old = 'running', new = 'paused')
2025-07-23 13:39:12 (12724): VM state change detected. (old = 'paused', new = 'running')
2025-07-23 13:39:15 (12724): Guest Log: 00:27:50.573405 timesync vgsvcTimeSyncWorker: Radical host time change: 2 409 412 000 000ns (HostNow=1 753 270 755 265 000 000 ns HostLast=1 753 268 345 853 000 000 ns)
2025-07-23 13:39:25 (12724): Guest Log: 00:28:00.578116 timesync vgsvcTimeSyncWorker: Radical guest time change: 3 204 151 599 000ns (GuestNow=1 753 270 765 269 865 000 ns GuestLast=1 753 267 561 118 266 000 ns fSetTimeLastLoop=true )
2025-07-23 13:41:16 (12724): VM state change detected. (old = 'running', new = 'paused')
2025-07-23 13:41:37 (12724): VM state change detected. (old = 'paused', new = 'running')
2025-07-23 13:46:17 (12724): VM state change detected. (old = 'running', new = 'paused')
2025-07-23 13:46:37 (12724): VM state change detected. (old = 'paused', new = 'running')
2025-07-23 13:51:17 (12724): VM state change detected. (old = 'running', new = 'paused')
2025-07-23 13:51:38 (12724): VM state change detected. (old = 'paused', new = 'running')
2025-07-23 13:51:48 (12724): VM state change detected. (old = 'running', new = 'paused')
2025-07-23 13:52:08 (12724): VM state change detected. (old = 'paused', new = 'running')
2025-07-23 13:58:19 (12724): VM state change detected. (old = 'running', new = 'paused')
2025-07-23 13:58:39 (12724): VM state change detected. (old = 'paused', new = 'running')
2025-07-23 13:59:29 (12724): VM state change detected. (old = 'running', new = 'paused')
2025-07-23 13:59:49 (12724): VM state change detected. (old = 'paused', new = 'running')
2025-07-23 14:00:26 (12724): VM state change detected. (old = 'running', new = 'paused')
2025-07-23 14:03:26 (12724): VM state change detected. (old = 'paused', new = 'running')
2025-07-23 14:10:30 (12724): VM state change detected. (old = 'running', new = 'paused')
2025-07-23 14:10:50 (12724): VM state change detected. (old = 'paused', new = 'running')
2025-07-23 14:15:30 (12724): VM state change detected. (old = 'running', new = 'paused')
2025-07-23 14:15:50 (12724): VM state change detected. (old = 'paused', new = 'running')
2025-07-23 14:20:03 (12724): VM state change detected. (old = 'running', new = 'paused')
2025-07-23 18:11:41 (12724): VM state change detected. (old = 'paused', new = 'running')
2025-07-23 18:11:45 (12724): Guest Log: 01:03:02.143622 timesync vgsvcTimeSyncWorker: Radical host time change: 13 908 307 000 000ns (HostNow=1 753 287 105 613 000 000 ns HostLast=1 753 273 197 306 000 000 ns)
2025-07-23 18:11:55 (12724): Guest Log: 01:03:12.147715 timesync vgsvcTimeSyncWorker: Radical guest time change: 14 248 782 005 000ns (GuestNow=1 753 287 115 617 233 000 ns GuestLast=1 753 272 866 835 228 000 ns fSetTimeLastLoop=true )
2025-07-23 18:16:48 (12724): VM state change detected. (old = 'running', new = 'paused')
2025-07-23 18:17:08 (12724): VM state change detected. (old = 'paused', new = 'running')
2025-07-23 18:19:58 (12724): VM state change detected. (old = 'running', new = 'paused')
2025-07-23 18:20:19 (12724): VM state change detected. (old = 'paused', new = 'running')
2025-07-23 18:20:34 (12724): VM state change detected. (old = 'running', new = 'paused')
2025-07-23 18:23:37 (12724): VM state change detected. (old = 'paused', new = 'running')
2025-07-23 18:23:58 (12724): VM state change detected. (old = 'running', new = 'paused')
2025-07-23 18:24:18 (12724): VM state change detected. (old = 'paused', new = 'running')
2025-07-23 18:24:28 (12724): VM state change detected. (old = 'running', new = 'paused')
2025-07-23 18:24:48 (12724): VM state change detected. (old = 'paused', new = 'running')
2025-07-23 18:25:29 (12724): VM state change detected. (old = 'running', new = 'paused')
2025-07-23 18:25:49 (12724): VM state change detected. (old = 'paused', new = 'running')
2025-07-23 18:26:18 (12724): VM state change detected. (old = 'running', new = 'paused')
2025-07-23 18:26:38 (12724): VM state change detected. (old = 'paused', new = 'running')
2025-07-23 18:38:49 (12724): VM state change detected. (old = 'running', new = 'paused')
2025-07-23 18:39:09 (12724): VM state change detected. (old = 'paused', new = 'running')
2025-07-23 18:40:59 (12724): VM state change detected. (old = 'running', new = 'paused')
2025-07-23 18:41:19 (12724): VM state change detected. (old = 'paused', new = 'running')
2025-07-23 18:42:10 (12724): VM state change detected. (old = 'running', new = 'paused')
2025-07-23 18:42:30 (12724): VM state change detected. (old = 'paused', new = 'running')
2025-07-23 18:45:40 (12724): VM state change detected. (old = 'running', new = 'paused')
2025-07-23 18:46:00 (12724): VM state change detected. (old = 'paused', new = 'running')
2025-07-23 18:46:19 (12724): VM state change detected. (old = 'running', new = 'paused')
2025-07-23 18:46:39 (12724): VM state change detected. (old = 'paused', new = 'running')
2025-07-23 18:51:00 (12724): VM state change detected. (old = 'running', new = 'paused')
2025-07-23 18:51:20 (12724): VM state change detected. (old = 'paused', new = 'running')
2025-07-23 18:53:31 (12724): VM state change detected. (old = 'running', new = 'paused')
2025-07-23 18:53:50 (12724): VM state change detected. (old = 'paused', new = 'running')
2025-07-23 18:54:00 (12724): VM state change detected. (old = 'running', new = 'paused')
2025-07-23 18:54:20 (12724): VM state change detected. (old = 'paused', new = 'running')
2025-07-23 18:55:00 (12724): VM state change detected. (old = 'running', new = 'paused')
2025-07-23 18:55:20 (12724): VM state change detected. (old = 'paused', new = 'running')
2025-07-23 18:56:50 (12724): Status Report: Job Duration: '64800.000000'
2025-07-23 18:56:50 (12724): Status Report: Elapsed Time: '54826.357245'
2025-07-23 18:56:50 (12724): Status Report: CPU Time: '197919.250000'
2025-07-23 18:59:00 (12724): VM state change detected. (old = 'running', new = 'paused')
2025-07-23 18:59:21 (12724): VM state change detected. (old = 'paused', new = 'running')
2025-07-23 19:02:01 (12724): VM state change detected. (old = 'running', new = 'paused')
2025-07-23 19:02:21 (12724): VM state change detected. (old = 'paused', new = 'running')
2025-07-23 19:06:01 (12724): VM state change detected. (old = 'running', new = 'paused')
2025-07-23 19:06:21 (12724): VM state change detected. (old = 'paused', new = 'running')
2025-07-23 19:07:02 (12724): VM state change detected. (old = 'running', new = 'paused')
2025-07-23 19:07:22 (12724): VM state change detected. (old = 'paused', new = 'running')
2025-07-23 19:07:46 (12724): VM state change detected. (old = 'running', new = 'paused')
2025-07-23 19:20:40 (12724): VM state change detected. (old = 'paused', new = 'running')
2025-07-23 19:20:52 (12724): VM state change detected. (old = 'running', new = 'paused')
2025-07-23 19:21:12 (12724): VM state change detected. (old = 'paused', new = 'running')
2025-07-23 19:21:22 (12724): VM state change detected. (old = 'running', new = 'paused')
2025-07-23 19:21:42 (12724): VM state change detected. (old = 'paused', new = 'running')
2025-07-23 19:21:52 (12724): VM state change detected. (old = 'running', new = 'paused')
2025-07-23 19:22:12 (12724): VM state change detected. (old = 'paused', new = 'running')
2025-07-23 19:22:32 (12724): VM state change detected. (old = 'running', new = 'paused')
2025-07-23 19:22:52 (12724): VM state change detected. (old = 'paused', new = 'running')
2025-07-23 19:23:02 (12724): VM state change detected. (old = 'running', new = 'paused')
2025-07-23 19:23:23 (12724): VM state change detected. (old = 'paused', new = 'running')
2025-07-23 19:24:02 (12724): VM state change detected. (old = 'running', new = 'paused')
2025-07-23 19:24:22 (12724): VM state change detected. (old = 'paused', new = 'running')
2025-07-23 19:24:32 (12724): VM state change detected. (old = 'running', new = 'paused')
2025-07-23 19:24:52 (12724): VM state change detected. (old = 'paused', new = 'running')
2025-07-23 19:25:52 (12724): VM state change detected. (old = 'running', new = 'paused')
2025-07-23 19:26:12 (12724): VM state change detected. (old = 'paused', new = 'running')
2025-07-23 19:26:22 (12724): VM state change detected. (old = 'running', new = 'paused')
2025-07-23 19:26:42 (12724): VM state change detected. (old = 'paused', new = 'running')
2025-07-23 19:27:03 (12724): VM state change detected. (old = 'running', new = 'paused')
2025-07-23 19:27:23 (12724): VM state change detected. (old = 'paused', new = 'running')
2025-07-23 19:27:52 (12724): VM state change detected. (old = 'running', new = 'paused')
2025-07-23 19:28:12 (12724): VM state change detected. (old = 'paused', new = 'running')
2025-07-23 19:28:32 (12724): VM state change detected. (old = 'running', new = 'paused')
2025-07-23 19:28:53 (12724): VM state change detected. (old = 'paused', new = 'running')
2025-07-23 19:29:03 (12724): VM state change detected. (old = 'running', new = 'paused')
2025-07-23 19:29:23 (12724): VM state change detected. (old = 'paused', new = 'running')
2025-07-23 19:29:33 (12724): VM state change detected. (old = 'running', new = 'paused')
2025-07-23 19:29:53 (12724): VM state change detected. (old = 'paused', new = 'running')
2025-07-23 19:30:03 (12724): VM state change detected. (old = 'running', new = 'paused')
2025-07-23 19:30:23 (12724): VM state change detected. (old = 'paused', new = 'running')
2025-07-23 19:30:33 (12724): VM state change detected. (old = 'running', new = 'paused')
2025-07-23 19:30:53 (12724): VM state change detected. (old = 'paused', new = 'running')
2025-07-23 19:31:33 (12724): VM state change detected. (old = 'running', new = 'paused')
2025-07-23 19:31:53 (12724): VM state change detected. (old = 'paused', new = 'running')
2025-07-23 19:32:03 (12724): VM state change detected. (old = 'running', new = 'paused')
2025-07-23 19:32:23 (12724): VM state change detected. (old = 'paused', new = 'running')
2025-07-23 19:32:33 (12724): VM state change detected. (old = 'running', new = 'paused')
2025-07-23 19:32:53 (12724): VM state change detected. (old = 'paused', new = 'running')
2025-07-23 19:33:32 (12724): VM state change detected. (old = 'running', new = 'paused')
2025-07-23 19:33:53 (12724): VM state change detected. (old = 'paused', new = 'running')
2025-07-23 19:34:33 (12724): VM state change detected. (old = 'running', new = 'paused')
2025-07-23 19:34:53 (12724): VM state change detected. (old = 'paused', new = 'running')
2025-07-23 19:35:33 (12724): VM state change detected. (old = 'running', new = 'paused')
2025-07-23 19:35:53 (12724): VM state change detected. (old = 'paused', new = 'running')
2025-07-23 19:36:33 (12724): VM state change detected. (old = 'running', new = 'paused')
2025-07-23 19:36:53 (12724): VM state change detected. (old = 'paused', new = 'running')
2025-07-23 19:37:03 (12724): VM state change detected. (old = 'running', new = 'paused')
2025-07-23 19:37:23 (12724): VM state change detected. (old = 'paused', new = 'running')
2025-07-23 19:37:33 (12724): VM state change detected. (old = 'running', new = 'paused')
2025-07-23 19:37:53 (12724): VM state change detected. (old = 'paused', new = 'running')
2025-07-23 19:38:34 (12724): VM state change detected. (old = 'running', new = 'paused')
2025-07-23 19:38:54 (12724): VM state change detected. (old = 'paused', new = 'running')
2025-07-23 19:39:13 (12724): VM state change detected. (old = 'running', new = 'paused')
2025-07-23 19:39:33 (12724): VM state change detected. (old = 'paused', new = 'running')
2025-07-23 19:40:03 (12724): VM state change detected. (old = 'running', new = 'paused')
2025-07-23 19:40:24 (12724): VM state change detected. (old = 'paused', new = 'running')
2025-07-23 19:40:34 (12724): VM state change detected. (old = 'running', new = 'paused')
2025-07-23 19:40:54 (12724): VM state change detected. (old = 'paused', new = 'running')
2025-07-23 19:41:04 (12724): VM state change detected. (old = 'running', new = 'paused')
2025-07-23 19:41:24 (12724): VM state change detected. (old = 'paused', new = 'running')
2025-07-23 19:41:53 (12724): VM state change detected. (old = 'running', new = 'paused')
2025-07-23 19:42:13 (12724): VM state change detected. (old = 'paused', new = 'running')
2025-07-23 19:42:33 (12724): VM state change detected. (old = 'running', new = 'paused')
2025-07-23 19:42:54 (12724): VM state change detected. (old = 'paused', new = 'running')
2025-07-23 19:43:04 (12724): VM state change detected. (old = 'running', new = 'paused')
2025-07-23 19:43:24 (12724): VM state change detected. (old = 'paused', new = 'running')
2025-07-23 19:43:44 (12724): VM state change detected. (old = 'running', new = 'paused')
2025-07-23 19:44:04 (12724): VM state change detected. (old = 'paused', new = 'running')
2025-07-23 19:44:14 (12724): VM state change detected. (old = 'running', new = 'paused')
2025-07-23 19:44:34 (12724): VM state change detected. (old = 'paused', new = 'running')
2025-07-23 19:44:43 (12724): VM state change detected. (old = 'running', new = 'paused')
2025-07-23 19:45:04 (12724): VM state change detected. (old = 'paused', new = 'running')
2025-07-23 19:45:14 (12724): VM state change detected. (old = 'running', new = 'paused')
2025-07-23 19:45:34 (12724): VM state change detected. (old = 'paused', new = 'running')
2025-07-23 19:45:44 (12724): VM state change detected. (old = 'running', new = 'paused')
2025-07-23 19:46:04 (12724): VM state change detected. (old = 'paused', new = 'running')
2025-07-23 19:46:14 (12724): VM state change detected. (old = 'running', new = 'paused')
2025-07-23 19:46:34 (12724): VM state change detected. (old = 'paused', new = 'running')
2025-07-23 19:46:44 (12724): VM state change detected. (old = 'running', new = 'paused')
2025-07-23 19:47:04 (12724): VM state change detected. (old = 'paused', new = 'running')
2025-07-23 19:47:14 (12724): VM state change detected. (old = 'running', new = 'paused')
2025-07-23 19:47:34 (12724): VM state change detected. (old = 'paused', new = 'running')
2025-07-23 19:47:43 (12724): VM state change detected. (old = 'running', new = 'paused')
2025-07-23 19:48:03 (12724): VM state change detected. (old = 'paused', new = 'running')
2025-07-23 19:48:14 (12724): VM state change detected. (old = 'running', new = 'paused')
2025-07-23 19:48:34 (12724): VM state change detected. (old = 'paused', new = 'running')
2025-07-23 19:48:44 (12724): VM state change detected. (old = 'running', new = 'paused')
2025-07-23 19:49:04 (12724): VM state change detected. (old = 'paused', new = 'running')
2025-07-23 19:49:24 (12724): VM state change detected. (old = 'running', new = 'paused')
2025-07-23 19:49:44 (12724): VM state change detected. (old = 'paused', new = 'running')
2025-07-23 19:50:04 (12724): VM state change detected. (old = 'running', new = 'paused')
2025-07-23 19:50:24 (12724): VM state change detected. (old = 'paused', new = 'running')
2025-07-23 19:50:35 (12724): VM state change detected. (old = 'running', new = 'paused')
2025-07-23 19:50:55 (12724): VM state change detected. (old = 'paused', new = 'running')
2025-07-23 19:51:04 (12724): VM state change detected. (old = 'running', new = 'paused')
2025-07-23 19:51:24 (12724): VM state change detected. (old = 'paused', new = 'running')
2025-07-23 19:51:34 (12724): VM state change detected. (old = 'running', new = 'paused')
2025-07-23 19:51:54 (12724): VM state change detected. (old = 'paused', new = 'running')
2025-07-23 19:52:04 (12724): VM state change detected. (old = 'running', new = 'paused')
2025-07-23 19:52:24 (12724): VM state change detected. (old = 'paused', new = 'running')
2025-07-23 19:52:34 (12724): VM state change detected. (old = 'running', new = 'paused')
2025-07-23 19:52:54 (12724): VM state change detected. (old = 'paused', new = 'running')
2025-07-23 19:53:04 (12724): VM state change detected. (old = 'running', new = 'paused')
2025-07-23 19:53:24 (12724): VM state change detected. (old = 'paused', new = 'running')
2025-07-23 19:53:55 (12724): VM state change detected. (old = 'running', new = 'paused')
2025-07-23 19:54:15 (12724): VM state change detected. (old = 'paused', new = 'running')
2025-07-23 19:55:04 (12724): VM state change detected. (old = 'running', new = 'paused')
2025-07-23 19:55:24 (12724): VM state change detected. (old = 'paused', new = 'running')
2025-07-23 19:56:04 (12724): VM state change detected. (old = 'running', new = 'paused')
2025-07-23 19:56:24 (12724): VM state change detected. (old = 'paused', new = 'running')
2025-07-23 19:56:34 (12724): VM state change detected. (old = 'running', new = 'paused')
2025-07-23 19:56:54 (12724): VM state change detected. (old = 'paused', new = 'running')
2025-07-23 19:57:04 (12724): VM state change detected. (old = 'running', new = 'paused')
2025-07-23 19:57:24 (12724): VM state change detected. (old = 'paused', new = 'running')
2025-07-23 19:57:55 (12724): VM state change detected. (old = 'running', new = 'paused')
2025-07-23 19:58:15 (12724): VM state change detected. (old = 'paused', new = 'running')
2025-07-23 19:58:35 (12724): VM state change detected. (old = 'running', new = 'paused')
2025-07-23 19:58:55 (12724): VM state change detected. (old = 'paused', new = 'running')
2025-07-23 19:59:34 (12724): VM state change detected. (old = 'running', new = 'paused')
2025-07-23 19:59:55 (12724): VM state change detected. (old = 'paused', new = 'running')
2025-07-23 20:00:05 (12724): VM state change detected. (old = 'running', new = 'paused')
2025-07-23 20:00:25 (12724): VM state change detected. (old = 'paused', new = 'running')
2025-07-23 20:00:35 (12724): VM state change detected. (old = 'running', new = 'paused')
2025-07-23 20:04:50 (12724): VM state change detected. (old = 'paused', new = 'running')
2025-07-23 20:05:05 (12724): VM state change detected. (old = 'running', new = 'paused')
2025-07-23 20:05:25 (12724): VM state change detected. (old = 'paused', new = 'running')
2025-07-23 20:05:55 (12724): VM state change detected. (old = 'running', new = 'paused')
2025-07-23 20:06:15 (12724): VM state change detected. (old = 'paused', new = 'running')
2025-07-23 20:06:25 (12724): VM state change detected. (old = 'running', new = 'paused')
2025-07-23 20:06:45 (12724): VM state change detected. (old = 'paused', new = 'running')
2025-07-23 20:07:05 (12724): VM state change detected. (old = 'running', new = 'paused')
2025-07-23 20:07:25 (12724): VM state change detected. (old = 'paused', new = 'running')
2025-07-23 20:07:35 (12724): VM state change detected. (old = 'running', new = 'paused')
2025-07-23 20:07:55 (12724): VM state change detected. (old = 'paused', new = 'running')
2025-07-23 20:08:15 (12724): VM state change detected. (old = 'running', new = 'paused')
2025-07-23 20:08:36 (12724): VM state change detected. (old = 'paused', new = 'running')
2025-07-23 20:08:56 (12724): VM state change detected. (old = 'running', new = 'paused')
2025-07-23 20:09:16 (12724): VM state change detected. (old = 'paused', new = 'running')
2025-07-23 20:09:35 (12724): VM state change detected. (old = 'running', new = 'paused')
2025-07-23 20:09:55 (12724): VM state change detected. (old = 'paused', new = 'running')
2025-07-23 20:10:05 (12724): VM state change detected. (old = 'running', new = 'paused')
2025-07-23 20:10:25 (12724): VM state change detected. (old = 'paused', new = 'running')
2025-07-23 20:10:35 (12724): VM state change detected. (old = 'running', new = 'paused')
2025-07-23 20:10:55 (12724): VM state change detected. (old = 'paused', new = 'running')
2025-07-23 20:11:36 (12724): VM state change detected. (old = 'running', new = 'paused')
2025-07-23 20:11:56 (12724): VM state change detected. (old = 'paused', new = 'running')
2025-07-23 20:12:15 (12724): VM state change detected. (old = 'running', new = 'paused')
2025-07-23 20:12:35 (12724): VM state change detected. (old = 'paused', new = 'running')
2025-07-23 20:12:55 (12724): VM state change detected. (old = 'running', new = 'paused')
2025-07-23 20:13:16 (12724): VM state change detected. (old = 'paused', new = 'running')
2025-07-23 20:13:36 (12724): VM state change detected. (old = 'running', new = 'paused')
2025-07-23 20:13:56 (12724): VM state change detected. (old = 'paused', new = 'running')
2025-07-23 20:14:02 (12724): VM state change detected. (old = 'running', new = 'paused')
2025-07-23 20:17:07 (12724): VM state change detected. (old = 'paused', new = 'running')
2025-07-23 20:17:26 (12724): VM state change detected. (old = 'running', new = 'paused')
2025-07-23 20:17:46 (12724): VM state change detected. (old = 'paused', new = 'running')
2025-07-23 20:17:55 (12724): VM state change detected. (old = 'running', new = 'paused')
2025-07-23 20:18:16 (12724): VM state change detected. (old = 'paused', new = 'running')
2025-07-23 20:18:26 (12724): VM state change detected. (old = 'running', new = 'paused')
2025-07-23 20:18:46 (12724): VM state change detected. (old = 'paused', new = 'running')
2025-07-23 20:18:56 (12724): VM state change detected. (old = 'running', new = 'paused')
2025-07-23 20:19:16 (12724): VM state change detected. (old = 'paused', new = 'running')
2025-07-23 20:19:26 (12724): VM state change detected. (old = 'running', new = 'paused')
2025-07-23 20:19:46 (12724): VM state change detected. (old = 'paused', new = 'running')
2025-07-23 20:19:56 (12724): VM state change detected. (old = 'running', new = 'paused')
2025-07-23 20:20:16 (12724): VM state change detected. (old = 'paused', new = 'running')
2025-07-23 20:20:26 (12724): VM state change detected. (old = 'running', new = 'paused')
2025-07-23 20:20:46 (12724): VM state change detected. (old = 'paused', new = 'running')
2025-07-23 20:20:56 (12724): VM state change detected. (old = 'running', new = 'paused')
2025-07-23 20:21:16 (12724): VM state change detected. (old = 'paused', new = 'running')
2025-07-23 20:21:36 (12724): VM state change detected. (old = 'running', new = 'paused')
2025-07-23 20:21:56 (12724): VM state change detected. (old = 'paused', new = 'running')
2025-07-23 20:22:06 (12724): VM state change detected. (old = 'running', new = 'paused')
2025-07-23 20:22:26 (12724): VM state change detected. (old = 'paused', new = 'running')
2025-07-23 20:22:57 (12724): VM state change detected. (old = 'running', new = 'paused')
2025-07-23 20:23:17 (12724): VM state change detected. (old = 'paused', new = 'running')
2025-07-23 20:23:36 (12724): VM state change detected. (old = 'running', new = 'paused')
2025-07-23 20:23:57 (12724): VM state change detected. (old = 'paused', new = 'running')
2025-07-23 20:24:16 (12724): VM state change detected. (old = 'running', new = 'paused')
2025-07-23 20:24:36 (12724): VM state change detected. (old = 'paused', new = 'running')
2025-07-23 20:24:46 (12724): VM state change detected. (old = 'running', new = 'paused')
2025-07-23 20:25:06 (12724): VM state change detected. (old = 'paused', new = 'running')
2025-07-23 20:25:16 (12724): VM state change detected. (old = 'running', new = 'paused')
2025-07-23 20:25:36 (12724): VM state change detected. (old = 'paused', new = 'running')
2025-07-23 20:25:47 (12724): VM state change detected. (old = 'running', new = 'paused')
2025-07-23 20:26:07 (12724): VM state change detected. (old = 'paused', new = 'running')
2025-07-23 20:26:17 (12724): VM state change detected. (old = 'running', new = 'paused')
2025-07-23 20:26:37 (12724): VM state change detected. (old = 'paused', new = 'running')
2025-07-23 20:26:57 (12724): VM state change detected. (old = 'running', new = 'paused')
2025-07-23 20:27:17 (12724): VM state change detected. (old = 'paused', new = 'running')
2025-07-23 20:27:36 (12724): VM state change detected. (old = 'running', new = 'paused')
2025-07-23 20:27:56 (12724): VM state change detected. (old = 'paused', new = 'running')
2025-07-23 20:28:06 (12724): VM state change detected. (old = 'running', new = 'paused')
2025-07-23 20:28:26 (12724): VM state change detected. (old = 'paused', new = 'running')
2025-07-23 20:28:57 (12724): VM state change detected. (old = 'running', new = 'paused')
2025-07-23 20:29:17 (12724): VM state change detected. (old = 'paused', new = 'running')
2025-07-23 20:29:35 (12724): VM state change detected. (old = 'running', new = 'paused')
2025-07-23 20:36:57 (12724): VM state change detected. (old = 'paused', new = 'running')
2025-07-23 20:37:18 (12724): VM state change detected. (old = 'running', new = 'paused')
2025-07-23 20:37:38 (12724): VM state change detected. (old = 'paused', new = 'running')
2025-07-23 20:37:48 (12724): VM state change detected. (old = 'running', new = 'paused')
2025-07-23 20:38:08 (12724): VM state change detected. (old = 'paused', new = 'running')
2025-07-23 20:38:18 (12724): VM state change detected. (old = 'running', new = 'paused')
2025-07-23 20:38:38 (12724): VM state change detected. (old = 'paused', new = 'running')
2025-07-23 20:38:57 (12724): VM state change detected. (old = 'running', new = 'paused')
2025-07-23 20:39:17 (12724): VM state change detected. (old = 'paused', new = 'running')
2025-07-23 20:39:28 (12724): VM state change detected. (old = 'running', new = 'paused')
2025-07-23 20:39:48 (12724): VM state change detected. (old = 'paused', new = 'running')
2025-07-23 20:39:49 (12724): VM state change detected. (old = 'running', new = 'paused')
2025-07-23 20:42:55 (12724): VM state change detected. (old = 'paused', new = 'running')
2025-07-23 20:43:08 (12724): VM state change detected. (old = 'running', new = 'paused')
2025-07-23 20:43:28 (12724): VM state change detected. (old = 'paused', new = 'running')
2025-07-23 20:43:38 (12724): VM state change detected. (old = 'running', new = 'paused')
2025-07-23 20:43:58 (12724): VM state change detected. (old = 'paused', new = 'running')
2025-07-23 20:44:18 (12724): VM state change detected. (old = 'running', new = 'paused')
2025-07-23 20:44:38 (12724): VM state change detected. (old = 'paused', new = 'running')
2025-07-23 20:44:59 (12724): VM state change detected. (old = 'running', new = 'paused')
2025-07-23 20:45:19 (12724): VM state change detected. (old = 'paused', new = 'running')
2025-07-23 20:45:58 (12724): VM state change detected. (old = 'running', new = 'paused')
2025-07-23 20:46:18 (12724): VM state change detected. (old = 'paused', new = 'running')
2025-07-23 20:46:29 (12724): VM state change detected. (old = 'running', new = 'paused')
2025-07-23 20:46:49 (12724): VM state change detected. (old = 'paused', new = 'running')
2025-07-23 20:47:08 (12724): VM state change detected. (old = 'running', new = 'paused')
2025-07-23 20:47:29 (12724): VM state change detected. (old = 'paused', new = 'running')
2025-07-23 20:47:59 (12724): VM state change detected. (old = 'running', new = 'paused')
2025-07-23 20:48:19 (12724): VM state change detected. (old = 'paused', new = 'running')
2025-07-23 20:48:29 (12724): VM state change detected. (old = 'running', new = 'paused')
2025-07-23 20:48:49 (12724): VM state change detected. (old = 'paused', new = 'running')
2025-07-23 20:49:09 (12724): VM state change detected. (old = 'running', new = 'paused')
2025-07-23 20:49:29 (12724): VM state change detected. (old = 'paused', new = 'running')
2025-07-23 20:49:49 (12724): VM state change detected. (old = 'running', new = 'paused')
2025-07-23 20:50:08 (12724): VM state change detected. (old = 'paused', new = 'running')
2025-07-23 20:50:29 (12724): VM state change detected. (old = 'running', new = 'paused')
2025-07-23 20:50:49 (12724): VM state change detected. (old = 'paused', new = 'running')
2025-07-23 20:50:59 (12724): VM state change detected. (old = 'running', new = 'paused')
2025-07-23 20:51:19 (12724): VM state change detected. (old = 'paused', new = 'running')
2025-07-23 20:51:59 (12724): VM state change detected. (old = 'running', new = 'paused')
2025-07-23 20:52:19 (12724): VM state change detected. (old = 'paused', new = 'running')
2025-07-23 20:52:59 (12724): VM state change detected. (old = 'running', new = 'paused')
2025-07-23 20:53:19 (12724): VM state change detected. (old = 'paused', new = 'running')
2025-07-23 20:53:39 (12724): VM state change detected. (old = 'running', new = 'paused')
2025-07-23 20:57:31 (12724): VM state change detected. (old = 'paused', new = 'running')
2025-07-23 20:57:50 (12724): VM state change detected. (old = 'running', new = 'paused')
2025-07-23 20:58:10 (12724): VM state change detected. (old = 'paused', new = 'running')
2025-07-23 20:58:20 (12724): VM state change detected. (old = 'running', new = 'paused')
2025-07-23 20:58:40 (12724): VM state change detected. (old = 'paused', new = 'running')
2025-07-23 20:58:49 (12724): VM state change detected. (old = 'running', new = 'paused')
2025-07-23 20:59:09 (12724): VM state change detected. (old = 'paused', new = 'running')
2025-07-23 20:59:19 (12724): VM state change detected. (old = 'running', new = 'paused')
2025-07-23 20:59:39 (12724): VM state change detected. (old = 'paused', new = 'running')
2025-07-23 20:59:49 (12724): VM state change detected. (old = 'running', new = 'paused')
2025-07-23 21:00:09 (12724): VM state change detected. (old = 'paused', new = 'running')
2025-07-23 21:00:19 (12724): VM state change detected. (old = 'running', new = 'paused')
2025-07-23 21:00:39 (12724): VM state change detected. (old = 'paused', new = 'running')
2025-07-23 21:00:50 (12724): VM state change detected. (old = 'running', new = 'paused')
2025-07-23 21:01:10 (12724): VM state change detected. (old = 'paused', new = 'running')
2025-07-23 21:01:20 (12724): VM state change detected. (old = 'running', new = 'paused')
2025-07-23 21:01:40 (12724): VM state change detected. (old = 'paused', new = 'running')
2025-07-23 21:01:50 (12724): VM state change detected. (old = 'running', new = 'paused')
2025-07-23 21:02:10 (12724): VM state change detected. (old = 'paused', new = 'running')
2025-07-23 21:02:20 (12724): VM state change detected. (old = 'running', new = 'paused')
2025-07-23 21:02:40 (12724): VM state change detected. (old = 'paused', new = 'running')
2025-07-23 21:02:49 (12724): VM state change detected. (old = 'running', new = 'paused')
2025-07-23 21:03:09 (12724): VM state change detected. (old = 'paused', new = 'running')
2025-07-23 21:03:19 (12724): VM state change detected. (old = 'running', new = 'paused')
2025-07-23 21:03:39 (12724): VM state change detected. (old = 'paused', new = 'running')
2025-07-23 21:03:49 (12724): VM state change detected. (old = 'running', new = 'paused')
2025-07-23 21:04:09 (12724): VM state change detected. (old = 'paused', new = 'running')
2025-07-23 21:04:19 (12724): VM state change detected. (old = 'running', new = 'paused')
2025-07-23 21:04:39 (12724): VM state change detected. (old = 'paused', new = 'running')
2025-07-23 21:04:50 (12724): VM state change detected. (old = 'running', new = 'paused')
2025-07-23 21:05:10 (12724): VM state change detected. (old = 'paused', new = 'running')
2025-07-23 21:05:20 (12724): VM state change detected. (old = 'running', new = 'paused')
2025-07-23 21:05:40 (12724): VM state change detected. (old = 'paused', new = 'running')
2025-07-23 21:05:50 (12724): VM state change detected. (old = 'running', new = 'paused')
2025-07-23 21:06:10 (12724): VM state change detected. (old = 'paused', new = 'running')
2025-07-23 21:06:20 (12724): VM state change detected. (old = 'running', new = 'paused')
2025-07-23 21:06:40 (12724): VM state change detected. (old = 'paused', new = 'running')
2025-07-23 21:07:00 (12724): VM state change detected. (old = 'running', new = 'paused')
2025-07-23 21:07:19 (12724): VM state change detected. (old = 'paused', new = 'running')
2025-07-23 21:07:29 (12724): VM state change detected. (old = 'running', new = 'paused')
2025-07-23 21:07:49 (12724): VM state change detected. (old = 'paused', new = 'running')
2025-07-23 21:08:00 (12724): VM state change detected. (old = 'running', new = 'paused')
2025-07-23 21:08:20 (12724): VM state change detected. (old = 'paused', new = 'running')
2025-07-23 21:08:30 (12724): VM state change detected. (old = 'running', new = 'paused')
2025-07-23 21:08:50 (12724): VM state change detected. (old = 'paused', new = 'running')
2025-07-23 21:09:00 (12724): VM state change detected. (old = 'running', new = 'paused')
2025-07-23 21:09:20 (12724): VM state change detected. (old = 'paused', new = 'running')
2025-07-23 21:09:30 (12724): VM state change detected. (old = 'running', new = 'paused')
2025-07-23 21:09:50 (12724): VM state change detected. (old = 'paused', new = 'running')
2025-07-23 21:10:00 (12724): VM state change detected. (old = 'running', new = 'paused')
2025-07-23 21:10:20 (12724): VM state change detected. (old = 'paused', new = 'running')
2025-07-23 21:10:30 (12724): VM state change detected. (old = 'running', new = 'paused')
2025-07-23 21:10:51 (12724): VM state change detected. (old = 'paused', new = 'running')
2025-07-23 21:11:00 (12724): VM state change detected. (old = 'running', new = 'paused')
2025-07-23 21:16:56 (12724): VM state change detected. (old = 'paused', new = 'running')
2025-07-23 21:17:10 (12724): VM state change detected. (old = 'running', new = 'paused')
2025-07-23 21:17:30 (12724): VM state change detected. (old = 'paused', new = 'running')
2025-07-23 21:17:51 (12724): VM state change detected. (old = 'running', new = 'paused')
2025-07-23 21:18:11 (12724): VM state change detected. (old = 'paused', new = 'running')
2025-07-23 21:18:30 (12724): VM state change detected. (old = 'running', new = 'paused')
2025-07-23 21:18:50 (12724): VM state change detected. (old = 'paused', new = 'running')
2025-07-23 21:19:00 (12724): VM state change detected. (old = 'running', new = 'paused')
2025-07-23 21:19:20 (12724): VM state change detected. (old = 'paused', new = 'running')
2025-07-23 21:19:31 (12724): VM state change detected. (old = 'running', new = 'paused')
2025-07-23 21:19:51 (12724): VM state change detected. (old = 'paused', new = 'running')
2025-07-23 21:20:01 (12724): VM state change detected. (old = 'running', new = 'paused')
2025-07-23 21:20:21 (12724): VM state change detected. (old = 'paused', new = 'running')
2025-07-23 21:20:31 (12724): VM state change detected. (old = 'running', new = 'paused')
2025-07-23 21:20:51 (12724): VM state change detected. (old = 'paused', new = 'running')
2025-07-23 21:21:01 (12724): VM state change detected. (old = 'running', new = 'paused')
2025-07-23 21:21:21 (12724): VM state change detected. (old = 'paused', new = 'running')
2025-07-23 21:21:30 (12724): VM state change detected. (old = 'running', new = 'paused')
2025-07-23 21:36:44 (12724): VM state change detected. (old = 'paused', new = 'running')
2025-07-23 21:37:01 (12724): VM state change detected. (old = 'running', new = 'paused')
2025-07-23 21:37:21 (12724): VM state change detected. (old = 'paused', new = 'running')
2025-07-23 21:37:31 (12724): VM state change detected. (old = 'running', new = 'paused')
2025-07-23 21:37:51 (12724): VM state change detected. (old = 'paused', new = 'running')
2025-07-23 21:38:02 (12724): VM state change detected. (old = 'running', new = 'paused')
2025-07-23 21:38:22 (12724): VM state change detected. (old = 'paused', new = 'running')
2025-07-23 21:38:32 (12724): VM state change detected. (old = 'running', new = 'paused')
2025-07-23 21:38:52 (12724): VM state change detected. (old = 'paused', new = 'running')
2025-07-23 21:39:02 (12724): VM state change detected. (old = 'running', new = 'paused')
2025-07-23 21:39:22 (12724): VM state change detected. (old = 'paused', new = 'running')
2025-07-23 21:39:32 (12724): VM state change detected. (old = 'running', new = 'paused')
2025-07-23 21:39:52 (12724): VM state change detected. (old = 'paused', new = 'running')
2025-07-23 21:40:02 (12724): VM state change detected. (old = 'running', new = 'paused')
2025-07-23 21:44:56 (12724): VM state change detected. (old = 'paused', new = 'running')
2025-07-23 21:45:20 (12724): VM state change detected. (old = 'running', new = 'paused')
2025-07-23 22:14:26 (12724): VM state change detected. (old = 'paused', new = 'running')
2025-07-23 22:14:34 (12724): VM state change detected. (old = 'running', new = 'paused')
2025-07-23 22:14:54 (12724): VM state change detected. (old = 'paused', new = 'running')
2025-07-23 22:14:59 (12724): Guest Log: 02:34:54.902213 timesync vgsvcTimeSyncWorker: Radical guest time change: 2 170 337 373 000ns (GuestNow=1 753 301 678 708 193 000 ns GuestLast=1 753 299 508 370 820 000 ns fSetTimeLastLoop=true )
2025-07-23 22:15:04 (12724): VM state change detected. (old = 'running', new = 'paused')
2025-07-23 22:15:25 (12724): VM state change detected. (old = 'paused', new = 'running')
2025-07-23 22:15:34 (12724): VM state change detected. (old = 'running', new = 'paused')
2025-07-23 22:15:54 (12724): VM state change detected. (old = 'paused', new = 'running')
2025-07-23 22:16:04 (12724): VM state change detected. (old = 'running', new = 'paused')
2025-07-23 22:16:25 (12724): VM state change detected. (old = 'paused', new = 'running')
2025-07-23 22:16:34 (12724): VM state change detected. (old = 'running', new = 'paused')
2025-07-23 22:16:54 (12724): VM state change detected. (old = 'paused', new = 'running')
2025-07-23 22:17:05 (12724): VM state change detected. (old = 'running', new = 'paused')
2025-07-24 10:59:56 (16220): vboxwrapper version 26210
2025-07-24 10:59:56 (16220): BOINC client version: 8.0.2
2025-07-24 10:59:57 (16220): Detected: VirtualBox VboxManage Interface (Version: 7.1.6)
2025-07-24 10:59:58 (16220): Detected: Heartbeat check (file: 'heartbeat' every 1200.000000 seconds)
2025-07-24 10:59:59 (16220): Guest Log: BIOS: VirtualBox 7.1.6
2025-07-24 10:59:59 (16220): Guest Log: CPUID EDX: 0x178bfbff
2025-07-24 10:59:59 (16220): Guest Log: BIOS: No PCI IDE controller, not probing IDE
2025-07-24 10:59:59 (16220): Guest Log: BIOS: AHCI 0-P#0: PCHS=16383/16/63 LCHS=1024/255/63 0x0000000002800000 sectors
2025-07-24 10:59:59 (16220): Guest Log: BIOS: Boot : bseqnr=1, bootseq=0032
2025-07-24 10:59:59 (16220): Guest Log: BIOS: Booting from Hard Disk...
2025-07-24 10:59:59 (16220): Guest Log: BIOS: KBD: unsupported int 16h function 03
2025-07-24 10:59:59 (16220): Guest Log: BIOS: AX=0305 BX=0000 CX=0000 DX=0000
2025-07-24 10:59:59 (16220): Guest Log: vgdrvHeartbeatInit: Setting up heartbeat to trigger every 2000 milliseconds
2025-07-24 10:59:59 (16220): Guest Log: vboxguest: misc device minor 56, IRQ 20, I/O port d020, MMIO at 00000000f0400000 (size 0x400000)
2025-07-24 10:59:59 (16220): Guest Log: VBoxService 5.2.6 r120293 (verbosity: 0) linux.amd64 (Jan 15 2018 14:51:00) release log
2025-07-24 10:59:59 (16220): Guest Log: 00:00:00.000110 main Log opened 2025-07-23T10:18:10.545184000Z
2025-07-24 10:59:59 (16220): Guest Log: 00:00:00.000210 main OS Product: Linux
2025-07-24 10:59:59 (16220): Guest Log: 00:00:00.000245 main OS Release: 4.14.232-19.cernvm.x86_64
2025-07-24 10:59:59 (16220): Guest Log: 00:00:00.000272 main OS Version: #1 SMP Fri Apr 30 17:12:25 CEST 2021
2025-07-24 10:59:59 (16220): Guest Log: 00:00:00.000298 main Executable: /usr/sbin/VBoxService
2025-07-24 10:59:59 (16220): Guest Log: 00:00:00.000299 main Process ID: 2295
2025-07-24 10:59:59 (16220): Guest Log: 00:00:00.000300 main Package type: LINUX_64BITS_GENERIC
2025-07-24 10:59:59 (16220): Guest Log: 00:00:00.001474 main 5.2.6 r120293 started. Verbose level = 0
2025-07-24 10:59:59 (16220): Guest Log: [INFO] Mounting the shared directory
2025-07-24 10:59:59 (16220): Guest Log: [INFO] Shared directory mounted, enabling vboxmonitor
2025-07-24 10:59:59 (16220): Guest Log: [INFO] Sourcing essential functions from /cvmfs/grid.cern.ch
2025-07-24 10:59:59 (16220): Guest Log: [INFO] Testing connection to cern.ch
2025-07-24 10:59:59 (16220): Guest Log: [INFO] Testing connection to VCCS
2025-07-24 10:59:59 (16220): Guest Log: [INFO] Testing connection to HTCondor
2025-07-24 10:59:59 (16220): Guest Log: [INFO] Testing connection to WMAgent
2025-07-24 10:59:59 (16220): Guest Log: [INFO] Testing connection to EOSCMS
2025-07-24 10:59:59 (16220): Guest Log: [INFO] Testing connection to CMS-Factory
2025-07-24 10:59:59 (16220): Guest Log: [INFO] Testing connection to CMS-Frontier
2025-07-24 10:59:59 (16220): Guest Log: [INFO] Testing connection to Frontier
2025-07-24 10:59:59 (16220): Guest Log: [INFO] Testing connection to http://cms-frontier.openhtc.io:8080/FrontierProd/Frontier/
2025-07-24 10:59:59 (16220): Guest Log: [INFO] Could not find a local HTTP proxy
2025-07-24 10:59:59 (16220): Guest Log: [INFO] CVMFS and Frontier will have to use DIRECT connections
2025-07-24 10:59:59 (16220): Guest Log: [INFO] This makes the application less efficient
2025-07-24 10:59:59 (16220): Guest Log: [INFO] It also puts higher load on the project servers
2025-07-24 10:59:59 (16220): Guest Log: [INFO] Setting up a local HTTP proxy is highly recommended
2025-07-24 10:59:59 (16220): Guest Log: [INFO] Advice can be found in the project forum
2025-07-24 10:59:59 (16220): Guest Log: [INFO] Reloading and probing the CVMFS configuration
2025-07-24 10:59:59 (16220): Guest Log: [INFO] Probing /cvmfs/grid.cern.ch... OK
2025-07-24 10:59:59 (16220): Guest Log: [INFO] Probing /cvmfs/cms-ib.cern.ch... OK
2025-07-24 10:59:59 (16220): Guest Log: [INFO] Probing /cvmfs/singularity.opensciencegrid.org... OK
2025-07-24 10:59:59 (16220): Guest Log: [INFO] Probing /cvmfs/cms.cern.ch... OK
2025-07-24 10:59:59 (16220): Guest Log: [INFO] Probing /cvmfs/oasis.opensciencegrid.org... OK
2025-07-24 10:59:59 (16220): Guest Log: [INFO] Excerpt from "cvmfs_config stat": VERSION HOST PROXY
2025-07-24 10:59:59 (16220): Guest Log: [INFO] 2.7.2.0 http://s1cern-cvmfs.openhtc.io DIRECT
2025-07-24 10:59:59 (16220): Guest Log: [INFO] Environment HTTP proxy: not set
2025-07-24 10:59:59 (16220): Guest Log: [INFO] Reading volunteer information
2025-07-24 10:59:59 (16220): Guest Log: [INFO] Requesting an X509 credential from LHC@home
2025-07-24 10:59:59 (16220): Guest Log: [INFO] Requesting an idtoken from LHC@home
2025-07-24 10:59:59 (16220): Guest Log: [INFO] CMS application starting. Check log files.
2025-07-24 10:59:59 (16220): Guest Log: 00:27:50.573405 timesync vgsvcTimeSyncWorker: Radical host time change: 2 409 412 000 000ns (HostNow=1 753 270 755 265 000 000 ns HostLast=1 753 268 345 853 000 000 ns)
2025-07-24 10:59:59 (16220): Guest Log: 00:28:00.578116 timesync vgsvcTimeSyncWorker: Radical guest time change: 3 204 151 599 000ns (GuestNow=1 753 270 765 269 865 000 ns GuestLast=1 753 267 561 118 266 000 ns fSetTimeLastLoop=true )
2025-07-24 10:59:59 (16220): Guest Log: 01:03:02.143622 timesync vgsvcTimeSyncWorker: Radical host time change: 13 908 307 000 000ns (HostNow=1 753 287 105 613 000 000 ns HostLast=1 753 273 197 306 000 000 ns)
2025-07-24 10:59:59 (16220): Guest Log: 01:03:12.147715 timesync vgsvcTimeSyncWorker: Radical guest time change: 14 248 782 005 000ns (GuestNow=1 753 287 115 617 233 000 ns GuestLast=1 753 272 866 835 228 000 ns fSetTimeLastLoop=true )
2025-07-24 11:00:00 (16220): Guest Log: 02:34:54.902213 timesync vgsvcTimeSyncWorker: Radical guest time change: 2 170 337 373 000ns (GuestNow=1 753 301 678 708 193 000 ns GuestLast=1 753 299 508 370 820 000 ns fSetTimeLastLoop=true )
2025-07-24 11:00:00 (16220): Starting VM using VBoxManage interface. (boinc_b7b1cfcb8dcfce1e, slot#2)
2025-07-24 11:00:07 (16220): Error in start VM for VM: -2147467259
Command:
VBoxManage -q startvm "boinc_b7b1cfcb8dcfce1e" --type headless
Output:
VBoxManage.exe: error: The VM session was aborted
VBoxManage.exe: error: Details: code E_FAIL (0x80004005), component SessionMachine, interface ISession
Waiting for VM "boinc_b7b1cfcb8dcfce1e" to power on...
2025-07-24 11:00:07 (16220): VM failed to start.
2025-07-24 11:00:07 (16220): Could not start
2025-07-24 11:00:07 (16220): ERROR: VM failed to start
2025-07-24 11:00:07 (16220): Powering off VM.
2025-07-24 11:00:07 (16220): Deregistering VM. (boinc_b7b1cfcb8dcfce1e, slot#2)
2025-07-24 11:00:07 (16220): Removing network bandwidth throttle group from VM.
2025-07-24 11:00:07 (16220): Removing VM from VirtualBox.
Hypervisor System Log:
00:00:09.167905 ERROR [COM]: aRC=E_ACCESSDENIED (0x80070005) aIID={e36a5081-a82a-40bd-9e4e-42a44d6ce50f} aComponent={MachineWrap} aText={The object functionality is limited}, preserve=false aResultDetail=0
00:00:09.167926 ERROR [COM]: aRC=E_ACCESSDENIED (0x80070005) aIID={e36a5081-a82a-40bd-9e4e-42a44d6ce50f} aComponent={MachineWrap} aText={The object functionality is limited}, preserve=false aResultDetail=0
00:00:09.167934 ERROR [COM]: aRC=E_ACCESSDENIED (0x80070005) aIID={e36a5081-a82a-40bd-9e4e-42a44d6ce50f} aComponent={MachineWrap} aText={The object functionality is limited}, preserve=false aResultDetail=0
00:00:09.167940 ERROR [COM]: aRC=E_ACCESSDENIED (0x80070005) aIID={e36a5081-a82a-40bd-9e4e-42a44d6ce50f} aComponent={MachineWrap} aText={The object functionality is limited}, preserve=false aResultDetail=0
00:00:09.167946 ERROR [COM]: aRC=E_ACCESSDENIED (0x80070005) aIID={e36a5081-a82a-40bd-9e4e-42a44d6ce50f} aComponent={MachineWrap} aText={The object functionality is limited}, preserve=false aResultDetail=0
00:00:09.167951 ERROR [COM]: aRC=E_ACCESSDENIED (0x80070005) aIID={e36a5081-a82a-40bd-9e4e-42a44d6ce50f} aComponent={MachineWrap} aText={The object functionality is limited}, preserve=false aResultDetail=0
00:00:09.733086 Watcher Saving settings file "D:\Program Files\BOINC\slots\2\boinc_b7b1cfcb8dcfce1e\boinc_b7b1cfcb8dcfce1e.vbox" with version "1.19-windows"
00:00:09.793599 Watcher Finished saving settings file "D:\Program Files\BOINC\slots\2\boinc_b7b1cfcb8dcfce1e\boinc_b7b1cfcb8dcfce1e.vbox"
00:00:09.794423 Watcher Reaper: Pid 13824 (0x3600) exited normally: -2147483645 (0x80000003)
00:00:09.836549 ERROR [COM]: aRC=E_ACCESSDENIED (0x80070005) aIID={e36a5081-a82a-40bd-9e4e-42a44d6ce50f} aComponent={MachineWrap} aText={The object functionality is limited}, preserve=false aResultDetail=0
00:00:09.836570 ERROR [COM]: aRC=E_ACCESSDENIED (0x80070005) aIID={e36a5081-a82a-40bd-9e4e-42a44d6ce50f} aComponent={MachineWrap} aText={The object functionality is limited}, preserve=false aResultDetail=0
00:00:09.836579 ERROR [COM]: aRC=E_ACCESSDENIED (0x80070005) aIID={e36a5081-a82a-40bd-9e4e-42a44d6ce50f} aComponent={MachineWrap} aText={The object functionality is limited}, preserve=false aResultDetail=0
00:00:09.836589 ERROR [COM]: aRC=E_ACCESSDENIED (0x80070005) aIID={e36a5081-a82a-40bd-9e4e-42a44d6ce50f} aComponent={MachineWrap} aText={The object functionality is limited}, preserve=false aResultDetail=0
00:00:09.836598 ERROR [COM]: aRC=E_ACCESSDENIED (0x80070005) aIID={e36a5081-a82a-40bd-9e4e-42a44d6ce50f} aComponent={MachineWrap} aText={The object functionality is limited}, preserve=false aResultDetail=0
00:00:09.836604 ERROR [COM]: aRC=E_ACCESSDENIED (0x80070005) aIID={e36a5081-a82a-40bd-9e4e-42a44d6ce50f} aComponent={MachineWrap} aText={The object functionality is limited}, preserve=false aResultDetail=0
00:00:09.837486 Platform architecture set to 'x86'
00:00:09.838379 ERROR [COM]: aRC=E_FAIL (0x80004005) aIID={e36a5081-a82a-40bd-9e4e-42a44d6ce50f} aComponent={SessionMachine} aText={This machine does not have any snapshots}, preserve=false aResultDetail=0
00:00:09.875382 ERROR [COM]: aRC=E_ACCESSDENIED (0x80070005) aIID={e36a5081-a82a-40bd-9e4e-42a44d6ce50f} aComponent={MachineWrap} aText={The object functionality is limited}, preserve=false aResultDetail=0
00:00:09.875410 ERROR [COM]: aRC=E_ACCESSDENIED (0x80070005) aIID={e36a5081-a82a-40bd-9e4e-42a44d6ce50f} aComponent={MachineWrap} aText={The object functionality is limited}, preserve=false aResultDetail=0
00:00:09.875418 ERROR [COM]: aRC=E_ACCESSDENIED (0x80070005) aIID={e36a5081-a82a-40bd-9e4e-42a44d6ce50f} aComponent={MachineWrap} aText={The object functionality is limited}, preserve=false aResultDetail=0
00:00:09.875424 ERROR [COM]: aRC=E_ACCESSDENIED (0x80070005) aIID={e36a5081-a82a-40bd-9e4e-42a44d6ce50f} aComponent={MachineWrap} aText={The object functionality is limited}, preserve=false aResultDetail=0
00:00:09.875430 ERROR [COM]: aRC=E_ACCESSDENIED (0x80070005) aIID={e36a5081-a82a-40bd-9e4e-42a44d6ce50f} aComponent={MachineWrap} aText={The object functionality is limited}, preserve=false aResultDetail=0
00:00:09.875435 ERROR [COM]: aRC=E_ACCESSDENIED (0x80070005) aIID={e36a5081-a82a-40bd-9e4e-42a44d6ce50f} aComponent={MachineWrap} aText={The object functionality is limited}, preserve=false aResultDetail=0
00:00:09.876465 Platform architecture set to 'x86'
00:00:09.877610 Saving settings file "D:\Program Files\BOINC\slots\2\boinc_b7b1cfcb8dcfce1e\boinc_b7b1cfcb8dcfce1e.vbox" with version "1.19-windows"
00:00:10.110623 Finished saving settings file "D:\Program Files\BOINC\slots\2\boinc_b7b1cfcb8dcfce1e\boinc_b7b1cfcb8dcfce1e.vbox"
00:00:10.394000 ERROR [COM]: aRC=E_ACCESSDENIED (0x80070005) aIID={e36a5081-a82a-40bd-9e4e-42a44d6ce50f} aComponent={MachineWrap} aText={The object functionality is limited}, preserve=false aResultDetail=0
00:00:10.394023 ERROR [COM]: aRC=E_ACCESSDENIED (0x80070005) aIID={e36a5081-a82a-40bd-9e4e-42a44d6ce50f} aComponent={MachineWrap} aText={The object functionality is limited}, preserve=false aResultDetail=0
00:00:10.394030 ERROR [COM]: aRC=E_ACCESSDENIED (0x80070005) aIID={e36a5081-a82a-40bd-9e4e-42a44d6ce50f} aComponent={MachineWrap} aText={The object functionality is limited}, preserve=false aResultDetail=0
00:00:10.394036 ERROR [COM]: aRC=E_ACCESSDENIED (0x80070005) aIID={e36a5081-a82a-40bd-9e4e-42a44d6ce50f} aComponent={MachineWrap} aText={The object functionality is limited}, preserve=false aResultDetail=0
00:00:10.394042 ERROR [COM]: aRC=E_ACCESSDENIED (0x80070005) aIID={e36a5081-a82a-40bd-9e4e-42a44d6ce50f} aComponent={MachineWrap} aText={The object functionality is limited}, preserve=false aResultDetail=0
00:00:10.394047 ERROR [COM]: aRC=E_ACCESSDENIED (0x80070005) aIID={e36a5081-a82a-40bd-9e4e-42a44d6ce50f} aComponent={MachineWrap} aText={The object functionality is limited}, preserve=false aResultDetail=0
00:00:10.394308 ERROR [COM]: aRC=E_ACCESSDENIED (0x80070005) aIID={e36a5081-a82a-40bd-9e4e-42a44d6ce50f} aComponent={MachineWrap} aText={The object functionality is limited}, preserve=false aResultDetail=0
00:00:10.394325 ERROR [COM]: aRC=E_ACCESSDENIED (0x80070005) aIID={e36a5081-a82a-40bd-9e4e-42a44d6ce50f} aComponent={MachineWrap} aText={The object functionality is limited}, preserve=false aResultDetail=0
00:00:10.394334 ERROR [COM]: aRC=E_ACCESSDENIED (0x80070005) aIID={e36a5081-a82a-40bd-9e4e-42a44d6ce50f} aComponent={MachineWrap} aText={The object functionality is limited}, preserve=false aResultDetail=0
00:00:10.394340 ERROR [COM]: aRC=E_ACCESSDENIED (0x80070005) aIID={e36a5081-a82a-40bd-9e4e-42a44d6ce50f} aComponent={MachineWrap} aText={The object functionality is limited}, preserve=false aResultDetail=0
00:00:10.394346 ERROR [COM]: aRC=E_ACCESSDENIED (0x80070005) aIID={e36a5081-a82a-40bd-9e4e-42a44d6ce50f} aComponent={MachineWrap} aText={The object functionality is limited}, preserve=false aResultDetail=0
00:00:10.394351 ERROR [COM]: aRC=E_ACCESSDENIED (0x80070005) aIID={e36a5081-a82a-40bd-9e4e-42a44d6ce50f} aComponent={MachineWrap} aText={The object functionality is limited}, preserve=false aResultDetail=0
00:00:10.394431 Saving settings file "C:\Users\William\.VirtualBox\VirtualBox.xml" with version "1.12-windows"
00:00:10.403523 Finished saving settings file "C:\Users\William\.VirtualBox\VirtualBox.xml"
00:00:10.403641 Saving settings file "C:\Users\William\.VirtualBox\VirtualBox.xml" with version "1.12-windows"
00:00:10.406045 Finished saving settings file "C:\Users\William\.VirtualBox\VirtualBox.xml"
00:00:10.407093 DeleteVM Saving settings file "C:\Users\William\.VirtualBox\VirtualBox.xml" with version "1.12-windows"
00:00:10.409717 DeleteVM Finished saving settings file "C:\Users\William\.VirtualBox\VirtualBox.xml"
VM Execution Log:
VM Startup Log:
VM Trace Log:
s:1
Supported platform architectures: x86
x86 platform properties:
Maximum Serial Port count: 4
Maximum Parallel Port count: 2
Maximum Boot Position: 4
Maximum Floppy Port count: 1
Maximum Floppy Devices per Port: 2
Maximum virtio-scsi Port count: 256
Maximum virtio-scsi Devices per Port: 1
Maximum IDE Port count: 2
Maximum IDE Devices per port: 2
Maximum SATA Port count: 30
Maximum SATA Device per port: 1
Maximum SCSI Port count: 16
Maximum SCSI Devices per port: 1
Maximum SAS Port count: 255
Maximum SAS Devices per Port: 1
Maximum NVMe Port count: 255
Maximum NVMe Devices per Port: 1
Supported chipsets: PIIX3, ICH9
PIIX3 chipset properties:
Maximum PIIX3 Network Adapter count: 8
Maximum PIIX3 IDE Controllers: 1
Maximum PIIX3 SATA Controllers: 1
Maximum PIIX3 SCSI Controllers: 1
Maximum PIIX3 SAS Controllers: 1
Maximum PIIX3 NVMe Controllers: 1
Maximum PIIX3 virtio-scsi Controllers: 1
Maximum PIIX3 Floppy Controllers:1
ICH9 chipset properties:
Maximum ICH9 Network Adapter count: 36
Maximum ICH9 IDE Controllers: 1
Maximum ICH9 SATA Controllers: 8
Maximum ICH9 SCSI Controllers: 8
Maximum ICH9 SAS Controllers: 8
Maximum ICH9 NVMe Controllers: 8
Maximum ICH9 virtio-scsi Controllers: 8
Maximum ICH9 Floppy Controllers:1
2025-07-24 10:59:58 (16220):
Command: VBoxManage -q list hostinfo
Exit Code: 0
Output:
Host Information:
Host time: 2025-07-24T08:59:57.905000000Z
Processor online count: 12
Processor count: 12
Processor online core count: 6
Processor core count: 6
Processor supports HW virtualization: yes
Processor supports PAE: yes
Processor supports long mode: yes
Processor supports nested paging: yes
Processor supports unrestricted guest: yes
Processor supports nested HW virtualization: yes
Processor supports virt. vmsave/vmload: no
Processor#0 speed: unknown
Processor#0 description: Intel(R) Core(TM) i7-8700K CPU @ 3.70GHz
Processor#1 speed: unknown
Processor#1 description: Intel(R) Core(TM) i7-8700K CPU @ 3.70GHz
Processor#2 speed: unknown
Processor#2 description: Intel(R) Core(TM) i7-8700K CPU @ 3.70GHz
Processor#3 speed: unknown
Processor#3 description: Intel(R) Core(TM) i7-8700K CPU @ 3.70GHz
Processor#4 speed: unknown
Processor#4 description: Intel(R) Core(TM) i7-8700K CPU @ 3.70GHz
Processor#5 speed: unknown
Processor#5 description: Intel(R) Core(TM) i7-8700K CPU @ 3.70GHz
Processor#6 speed: unknown
Processor#6 description: Intel(R) Core(TM) i7-8700K CPU @ 3.70GHz
Processor#7 speed: unknown
Processor#7 description: Intel(R) Core(TM) i7-8700K CPU @ 3.70GHz
Processor#8 speed: unknown
Processor#8 description: Intel(R) Core(TM) i7-8700K CPU @ 3.70GHz
Processor#9 speed: unknown
Processor#9 description: Intel(R) Core(TM) i7-8700K CPU @ 3.70GHz
Processor#10 speed: unknown
Processor#10 description: Intel(R) Core(TM) i7-8700K CPU @ 3.70GHz
Processor#11 speed: unknown
Processor#11 description: Intel(R) Core(TM) i7-8700K CPU @ 3.70GHz
Memory size: 16329 MByte
Memory available: 9555 MByte
Operating system: Windows 10
Operating system version: 10.0.19045
2025-07-24 10:59:58 (16220):
Command: VBoxManage -q showvminfo "boinc_b7b1cfcb8dcfce1e" --machinereadable
Exit Code: 0
Output:
name="boinc_b7b1cfcb8dcfce1e"
encryption="disabled"
groups="/"
platformArchitecture="x86"
ostype="Linux 2.6 / 3.x / 4.x / 5.x (64-bit)"
UUID="2d63afe3-7fa2-4003-9c61-983717331413"
CfgFile="D:\\Program Files\\BOINC\\slots\\2\\boinc_b7b1cfcb8dcfce1e\\boinc_b7b1cfcb8dcfce1e.vbox"
SnapFldr="D:\\Program Files\\BOINC\\slots\\2\\boinc_b7b1cfcb8dcfce1e\\Snapshots"
LogFldr="D:\\Program Files\\BOINC\\slots\\2\\boinc_b7b1cfcb8dcfce1e\\Logs"
hardwareuuid="2d63afe3-7fa2-4003-9c61-983717331413"
memory=4584
pagefusion="off"
vram=16
cpuexecutioncap=100
cpu-profile="host"
chipset="piix3"
firmware="BIOS"
cpus=4
hpet="off"
pae="off"
longmode="on"
triplefaultreset="off"
apic="on"
x2apic="on"
nested-hw-virt="off"
hwvirtex="on"
nestedpaging="on"
largepages="on"
vtxvpid="on"
vtxux="on"
virtvmsavevmload="on"
cpuid-portability-level=0
bootmenu="messageandmenu"
boot1="disk"
boot2="dvd"
boot3="none"
boot4="none"
acpi="on"
ioapic="on"
biosapic="apic"
biossystemtimeoffset=0
NvramFile="D:\\Program Files\\BOINC\\slots\\2\\boinc_b7b1cfcb8dcfce1e\\boinc_b7b1cfcb8dcfce1e.nvram"
rtcuseutc="off"
iommu="none"
paravirtprovider="default"
effparavirtprovider="kvm"
VMState="poweroff"
VMStateChangeTime="2025-07-23T10:16:57.000000000"
graphicscontroller="vboxvga"
monitorcount=1
accelerate3d="off"
teleporterenabled="off"
teleporterport=0
teleporteraddress=""
teleporterpassword=""
tracing-enabled="off"
tracing-allow-vm-access="off"
tracing-config=""
autostart-enabled="off"
autostart-delay=0
defaultfrontend=""
vmprocpriority="default"
storagecontrollername0="Hard Disk Controller"
storagecontrollertype0="IntelAhci"
storagecontrollerinstance0="0"
storagecontrollermaxportcount0="30"
storagecontrollerportcount0="3"
storagecontrollerbootable0="on"
"Hard Disk Controller-0-0"="D:\\Program Files\\BOINC\\slots\\2\\boinc_b7b1cfcb8dcfce1e\\Snapshots/{ed039a73-8dab-466d-9643-3795360ccce0}.vdi"
"Hard Disk Controller-ImageUUID-0-0"="ed039a73-8dab-466d-9643-3795360ccce0"
"Hard Disk Controller-nonrotational-0-0"="off"
"Hard Disk Controller-discard-0-0"="off"
"Hard Disk Controller-1-0"="C:\\Program Files\\Oracle\\VirtualBox\\VBoxGuestAdditions.iso"
"Hard Disk Controller-ImageUUID-1-0"="dcb82a20-6e67-402d-abeb-ae93aea212e4"
"Hard Disk Controller-tempeject-1-0"="off"
"Hard Disk Controller-IsEjected-1-0"="off"
"Hard Disk Controller-nonrotational-1-0"="off"
"Hard Disk Controller-discard-1-0"="off"
"Hard Disk Controller-2-0"="none"
natnet1="nat"
macaddress1="080027B3302A"
cableconnected1="on"
nic1="nat"
nictype1="virtio"
nicspeed1="0"
mtu="0"
sockSnd="64"
sockRcv="64"
tcpWndSnd="64"
tcpWndRcv="64"
Forwarding(0)="tcp_63395_80,tcp,127.0.0.1,63395,,80"
nic2="none"
nic3="none"
nic4="none"
nic5="none"
nic6="none"
nic7="none"
nic8="none"
hidpointing="ps2mouse"
hidkeyboard="ps2kbd"
uart1="off"
uart2="off"
uart3="off"
uart4="off"
lpt1="off"
lpt2="off"
audio="none"
audio_out="off"
audio_in="off"
clipboard="disabled"
clipboard_file_transfers="off"
draganddrop="disabled"
vrde="off"
usb="off"
ehci="off"
xhci="off"
BandwidthGroup0="boinc_b7b1cfcb8dcfce1e_net",Network,1099511627776
SharedFolderNameMachineMapping1="shared"
SharedFolderPathMachineMapping1="D:\\Program Files\\BOINC\\slots\\2\\shared"
recording_started="off"
recording_enabled="off"
recording_screens=1
rec_screen0
rec_screen_enabled="on"
rec_screen_id=0
rec_screen_video_enabled="on"
rec_screen_audio_enabled="off"
rec_screen_dest="File"
rec_screen_dest_filename="D:\\Program Files\\BOINC\\slots\\2\\boinc_b7b1cfcb8dcfce1e\\boinc_b7b1cfcb8dcfce1e-screen0.webm"
rec_screen_opts="vc_enabled=true,ac_enabled=false,ac_profile=med"
rec_screen_video_res_xy="1024x768"
rec_screen_video_rate_kbps=512
rec_screen_video_fps=25
description="CMS_633700_1752903840.091160_0"
GuestMemoryB
©2025 CERN