Name | Theory_2773-3000907-121_1 |
Workunit | 229750281 |
Created | 11 Jan 2025, 18:36:37 UTC |
Sent | 12 Jan 2025, 1:26:53 UTC |
Report deadline | 23 Jan 2025, 1:26:53 UTC |
Received | 24 Jan 2025, 8:53:11 UTC |
Server state | Over |
Outcome | Computation error |
Client state | Compute error |
Exit status | 0 (0x00000000) |
Computer ID | 10848017 |
Run time | 9 days 19 hours 28 min 15 sec |
CPU time | 1 hours 20 min 10 sec |
Validate state | Invalid |
Credit | 0.00 |
Device peak FLOPS | 6.89 GFLOPS |
Application version | Theory Simulation v300.30 (vbox64_theory) x86_64-pc-linux-gnu |
Peak working set size | 700.83 MB |
Peak swap size | 2.21 GB |
Peak disk usage | 407.78 MB |
<core_client_version>8.0.2</core_client_version> <![CDATA[ <stderr_txt> ort: CPU Time: '3937.510000' 2025-01-21 14:16:08 (34647): Stopping VM. 2025-01-21 14:16:14 (34647): Successfully stopped VM. 2025-01-21 14:16:37 (67765): vboxwrapper version 26207 2025-01-21 14:16:37 (67765): BOINC client version: 8.0.2 2025-01-21 14:16:37 (67765): Detected: VirtualBox VboxManage Interface (Version: 7.1.4) 2025-01-21 14:16:37 (67765): Detected: Heartbeat check (file: 'heartbeat' every 1200.000000 seconds) 2025-01-21 14:16:37 (67765): Starting VM using VBoxManage interface. (boinc_e204efab051646d5, slot#23) 2025-01-21 14:16:39 (67765): Successfully started VM. (PID = '68579') 2025-01-21 14:16:39 (67765): Reporting VM Process ID to BOINC. 2025-01-21 14:16:39 (67765): VM state change detected. (old = 'poweredoff', new = 'running') 2025-01-21 14:16:39 (67765): Detected: Web Application Enabled (http://localhost:47773) 2025-01-21 14:16:39 (67765): Status Report: Job Duration: '864000.000000' 2025-01-21 14:16:39 (67765): Status Report: Elapsed Time: '683142.330767' 2025-01-21 14:16:39 (67765): Status Report: CPU Time: '3939.670000' 2025-01-21 14:16:39 (67765): Preference change detected 2025-01-21 14:16:39 (67765): Setting CPU throttle for VM. (100%) 2025-01-21 14:16:39 (67765): Setting checkpoint interval to 600 seconds. (Higher value of (Preference: 120 seconds) or (Vbox_job.xml: 600 seconds)) 2025-01-21 14:23:01 (67765): VM state change detected. (old = 'running', new = 'paused') 2025-01-21 14:23:21 (67765): VM state change detected. (old = 'paused', new = 'running') 2025-01-21 15:02:45 (67765): VM state change detected. (old = 'running', new = 'paused') 2025-01-21 15:03:05 (67765): VM state change detected. (old = 'paused', new = 'running') 2025-01-21 15:12:47 (67765): VM state change detected. (old = 'running', new = 'paused') 2025-01-21 15:13:08 (67765): VM state change detected. (old = 'paused', new = 'running') 2025-01-21 15:20:18 (67765): VM state change detected. (old = 'running', new = 'paused') 2025-01-21 15:20:38 (67765): VM state change detected. (old = 'paused', new = 'running') 2025-01-21 15:29:09 (67765): VM state change detected. (old = 'running', new = 'paused') 2025-01-21 15:29:29 (67765): VM state change detected. (old = 'paused', new = 'running') 2025-01-21 15:38:01 (67765): VM state change detected. (old = 'running', new = 'paused') 2025-01-21 15:38:21 (67765): VM state change detected. (old = 'paused', new = 'running') 2025-01-21 15:50:11 (67765): VM state change detected. (old = 'running', new = 'paused') 2025-01-21 15:50:31 (67765): VM state change detected. (old = 'paused', new = 'running') 2025-01-21 15:58:06 (67765): Status Report: Job Duration: '864000.000000' 2025-01-21 15:58:06 (67765): Status Report: Elapsed Time: '689142.330767' 2025-01-21 15:58:06 (67765): Status Report: CPU Time: '3962.830000' 2025-01-21 16:29:55 (67765): VM state change detected. (old = 'running', new = 'paused') 2025-01-21 16:30:15 (67765): VM state change detected. (old = 'paused', new = 'running') 2025-01-21 17:37:27 (67765): Status Report: Job Duration: '864000.000000' 2025-01-21 17:37:27 (67765): Status Report: Elapsed Time: '695142.330767' 2025-01-21 17:37:27 (67765): Status Report: CPU Time: '3987.800000' 2025-01-21 18:45:58 (67765): VM state change detected. (old = 'running', new = 'paused') 2025-01-21 18:46:17 (67765): VM state change detected. (old = 'paused', new = 'running') 2025-01-21 19:05:19 (67765): VM state change detected. (old = 'running', new = 'paused') 2025-01-21 19:05:39 (67765): VM state change detected. (old = 'paused', new = 'running') 2025-01-21 19:17:09 (67765): Status Report: Job Duration: '864000.000000' 2025-01-21 19:17:09 (67765): Status Report: Elapsed Time: '701142.330767' 2025-01-21 19:17:09 (67765): Status Report: CPU Time: '4013.240000' 2025-01-21 19:25:41 (67765): VM state change detected. (old = 'running', new = 'paused') 2025-01-21 19:26:01 (67765): VM state change detected. (old = 'paused', new = 'running') 2025-01-21 19:43:12 (67765): VM state change detected. (old = 'running', new = 'paused') 2025-01-21 19:43:32 (67765): VM state change detected. (old = 'paused', new = 'running') 2025-01-21 20:25:06 (67765): VM state change detected. (old = 'running', new = 'paused') 2025-01-21 20:25:27 (67765): VM state change detected. (old = 'paused', new = 'running') 2025-01-21 20:57:13 (67765): Status Report: Job Duration: '864000.000000' 2025-01-21 20:57:13 (67765): Status Report: Elapsed Time: '707142.330767' 2025-01-21 20:57:13 (67765): Status Report: CPU Time: '4038.850000' 2025-01-21 20:59:29 (67765): VM state change detected. (old = 'running', new = 'paused') 2025-01-21 20:59:49 (67765): VM state change detected. (old = 'paused', new = 'running') 2025-01-21 21:08:00 (67765): VM state change detected. (old = 'running', new = 'paused') 2025-01-21 21:08:20 (67765): VM state change detected. (old = 'paused', new = 'running') 2025-01-21 21:30:12 (67765): VM state change detected. (old = 'running', new = 'paused') 2025-01-21 21:30:32 (67765): VM state change detected. (old = 'paused', new = 'running') 2025-01-21 21:52:08 (67765): Stopping VM. 2025-01-21 21:52:33 (67765): Successfully stopped VM. 2025-01-22 00:09:30 (319960): vboxwrapper version 26207 2025-01-22 00:09:30 (319960): BOINC client version: 8.0.2 2025-01-22 00:09:30 (319960): Detected: VirtualBox VboxManage Interface (Version: 7.1.6) 2025-01-22 00:09:30 (319960): Detected: Heartbeat check (file: 'heartbeat' every 1200.000000 seconds) 2025-01-22 00:09:30 (319960): Starting VM using VBoxManage interface. (boinc_e204efab051646d5, slot#23) 2025-01-22 00:09:31 (319960): Successfully started VM. (PID = '320055') 2025-01-22 00:09:31 (319960): Reporting VM Process ID to BOINC. 2025-01-22 00:09:31 (319960): VM state change detected. (old = 'poweredoff', new = 'running') 2025-01-22 00:09:31 (319960): Detected: Web Application Enabled (http://localhost:47773) 2025-01-22 00:09:31 (319960): Status Report: Job Duration: '864000.000000' 2025-01-22 00:09:31 (319960): Status Report: Elapsed Time: '710408.330767' 2025-01-22 00:09:31 (319960): Status Report: CPU Time: '4053.630000' 2025-01-22 00:09:31 (319960): Preference change detected 2025-01-22 00:09:31 (319960): Setting CPU throttle for VM. (100%) 2025-01-22 00:09:32 (319960): Setting checkpoint interval to 600 seconds. (Higher value of (Preference: 120 seconds) or (Vbox_job.xml: 600 seconds)) 2025-01-22 00:09:32 (319960): Guest Log: 41:29:22.729230 timesync vgsvcTimeSyncWorker: Radical host time change: 8 251 126 000 000ns (HostNow=1 737 522 572 761 000 000 ns HostLast=1 737 514 321 635 000 000 ns) 2025-01-22 00:09:42 (319960): Guest Log: 41:29:32.729524 timesync vgsvcTimeSyncWorker: Radical guest time change: 8 556 642 898 000ns (GuestNow=1 737 522 582 768 475 000 ns GuestLast=1 737 514 026 125 577 000 ns fSetTimeLastLoop=true ) 2025-01-22 00:32:03 (319960): VM state change detected. (old = 'running', new = 'paused') 2025-01-22 00:32:24 (319960): VM state change detected. (old = 'paused', new = 'running') 2025-01-22 00:50:15 (319960): VM state change detected. (old = 'running', new = 'paused') 2025-01-22 00:50:35 (319960): VM state change detected. (old = 'paused', new = 'running') 2025-01-22 01:01:46 (319960): VM state change detected. (old = 'running', new = 'paused') 2025-01-22 01:02:06 (319960): VM state change detected. (old = 'paused', new = 'running') 2025-01-22 01:34:10 (319960): VM state change detected. (old = 'running', new = 'paused') 2025-01-22 01:34:29 (319960): VM state change detected. (old = 'paused', new = 'running') 2025-01-22 01:49:56 (319960): Status Report: Job Duration: '864000.000000' 2025-01-22 01:49:56 (319960): Status Report: Elapsed Time: '716408.330767' 2025-01-22 01:49:56 (319960): Status Report: CPU Time: '4080.640000' 2025-01-22 01:51:51 (319960): VM state change detected. (old = 'running', new = 'paused') 2025-01-22 01:52:11 (319960): VM state change detected. (old = 'paused', new = 'running') 2025-01-22 02:00:32 (319960): VM state change detected. (old = 'running', new = 'paused') 2025-01-22 02:00:51 (319960): VM state change detected. (old = 'paused', new = 'running') 2025-01-22 02:29:04 (319960): VM state change detected. (old = 'running', new = 'paused') 2025-01-22 02:29:24 (319960): VM state change detected. (old = 'paused', new = 'running') 2025-01-22 02:45:37 (319960): VM state change detected. (old = 'running', new = 'paused') 2025-01-22 02:45:56 (319960): VM state change detected. (old = 'paused', new = 'running') 2025-01-22 03:15:19 (319960): VM state change detected. (old = 'running', new = 'paused') 2025-01-22 03:15:39 (319960): VM state change detected. (old = 'paused', new = 'running') 2025-01-22 03:23:10 (319960): VM state change detected. (old = 'running', new = 'paused') 2025-01-22 03:23:30 (319960): VM state change detected. (old = 'paused', new = 'running') 2025-01-22 03:31:02 (319960): Status Report: Job Duration: '864000.000000' 2025-01-22 03:31:02 (319960): Status Report: Elapsed Time: '722408.330767' 2025-01-22 03:31:02 (319960): Status Report: CPU Time: '4105.210000' 2025-01-22 04:02:33 (319960): VM state change detected. (old = 'running', new = 'paused') 2025-01-22 04:02:53 (319960): VM state change detected. (old = 'paused', new = 'running') 2025-01-22 04:12:14 (319960): VM state change detected. (old = 'running', new = 'paused') 2025-01-22 04:12:34 (319960): VM state change detected. (old = 'paused', new = 'running') 2025-01-22 04:22:55 (319960): VM state change detected. (old = 'running', new = 'paused') 2025-01-22 04:23:15 (319960): VM state change detected. (old = 'paused', new = 'running') 2025-01-22 04:30:36 (319960): VM state change detected. (old = 'running', new = 'paused') 2025-01-22 04:30:56 (319960): VM state change detected. (old = 'paused', new = 'running') 2025-01-22 05:04:19 (319960): VM state change detected. (old = 'running', new = 'paused') 2025-01-22 05:04:39 (319960): VM state change detected. (old = 'paused', new = 'running') 2025-01-22 05:11:47 (319960): Status Report: Job Duration: '864000.000000' 2025-01-22 05:11:47 (319960): Status Report: Elapsed Time: '728408.330767' 2025-01-22 05:11:47 (319960): Status Report: CPU Time: '4130.460000' 2025-01-22 06:16:17 (319960): VM state change detected. (old = 'running', new = 'paused') 2025-01-22 06:16:37 (319960): VM state change detected. (old = 'paused', new = 'running') 2025-01-22 06:48:00 (319960): VM state change detected. (old = 'running', new = 'paused') 2025-01-22 06:48:19 (319960): VM state change detected. (old = 'paused', new = 'running') 2025-01-22 06:51:29 (319960): Status Report: Job Duration: '864000.000000' 2025-01-22 06:51:29 (319960): Status Report: Elapsed Time: '734408.330767' 2025-01-22 06:51:29 (319960): Status Report: CPU Time: '4160.460000' 2025-01-22 07:27:23 (319960): VM state change detected. (old = 'running', new = 'paused') 2025-01-22 07:27:43 (319960): VM state change detected. (old = 'paused', new = 'running') 2025-01-22 07:43:55 (319960): VM state change detected. (old = 'running', new = 'paused') 2025-01-22 07:44:15 (319960): VM state change detected. (old = 'paused', new = 'running') 2025-01-22 08:03:57 (319960): VM state change detected. (old = 'running', new = 'paused') 2025-01-22 08:04:17 (319960): VM state change detected. (old = 'paused', new = 'running') 2025-01-22 08:20:08 (319960): VM state change detected. (old = 'running', new = 'paused') 2025-01-22 08:20:28 (319960): VM state change detected. (old = 'paused', new = 'running') 2025-01-22 08:31:52 (319960): Status Report: Job Duration: '864000.000000' 2025-01-22 08:31:52 (319960): Status Report: Elapsed Time: '740408.330767' 2025-01-22 08:31:52 (319960): Status Report: CPU Time: '4188.300000' 2025-01-22 08:41:00 (319960): VM state change detected. (old = 'running', new = 'paused') 2025-01-22 08:41:20 (319960): VM state change detected. (old = 'paused', new = 'running') 2025-01-22 08:57:51 (319960): VM state change detected. (old = 'running', new = 'paused') 2025-01-22 08:58:12 (319960): VM state change detected. (old = 'paused', new = 'running') 2025-01-22 09:47:56 (319960): VM state change detected. (old = 'running', new = 'paused') 2025-01-22 09:48:16 (319960): VM state change detected. (old = 'paused', new = 'running') 2025-01-22 10:11:57 (319960): Status Report: Job Duration: '864000.000000' 2025-01-22 10:11:57 (319960): Status Report: Elapsed Time: '746408.330767' 2025-01-22 10:11:57 (319960): Status Report: CPU Time: '4214.490000' 2025-01-22 10:27:21 (319960): VM state change detected. (old = 'running', new = 'paused') 2025-01-22 10:27:40 (319960): VM state change detected. (old = 'paused', new = 'running') 2025-01-22 10:56:43 (319960): VM state change detected. (old = 'running', new = 'paused') 2025-01-22 10:57:03 (319960): VM state change detected. (old = 'paused', new = 'running') 2025-01-22 11:05:14 (319960): VM state change detected. (old = 'running', new = 'paused') 2025-01-22 11:05:34 (319960): VM state change detected. (old = 'paused', new = 'running') 2025-01-22 11:35:07 (319960): VM state change detected. (old = 'running', new = 'paused') 2025-01-22 11:35:27 (319960): VM state change detected. (old = 'paused', new = 'running') 2025-01-22 11:52:20 (319960): Status Report: Job Duration: '864000.000000' 2025-01-22 11:52:20 (319960): Status Report: Elapsed Time: '752408.330767' 2025-01-22 11:52:20 (319960): Status Report: CPU Time: '4242.230000' 2025-01-22 11:54:28 (319960): VM state change detected. (old = 'running', new = 'paused') 2025-01-22 11:54:49 (319960): VM state change detected. (old = 'paused', new = 'running') 2025-01-22 12:23:42 (319960): VM state change detected. (old = 'running', new = 'paused') 2025-01-22 12:24:01 (319960): VM state change detected. (old = 'paused', new = 'running') 2025-01-22 12:48:34 (319960): VM state change detected. (old = 'running', new = 'paused') 2025-01-22 12:48:53 (319960): VM state change detected. (old = 'paused', new = 'running') 2025-01-22 13:27:47 (319960): VM state change detected. (old = 'running', new = 'paused') 2025-01-22 13:28:07 (319960): VM state change detected. (old = 'paused', new = 'running') 2025-01-22 13:32:45 (319960): Status Report: Job Duration: '864000.000000' 2025-01-22 13:32:45 (319960): Status Report: Elapsed Time: '758408.330767' 2025-01-22 13:32:45 (319960): Status Report: CPU Time: '4268.940000' 2025-01-22 13:57:00 (319960): VM state change detected. (old = 'running', new = 'paused') 2025-01-22 13:57:20 (319960): VM state change detected. (old = 'paused', new = 'running') 2025-01-22 14:05:01 (319960): VM state change detected. (old = 'running', new = 'paused') 2025-01-22 14:05:20 (319960): VM state change detected. (old = 'paused', new = 'running') 2025-01-22 14:35:13 (319960): VM state change detected. (old = 'running', new = 'paused') 2025-01-22 14:35:34 (319960): VM state change detected. (old = 'paused', new = 'running') 2025-01-22 14:52:25 (319960): VM state change detected. (old = 'running', new = 'paused') 2025-01-22 14:52:46 (319960): VM state change detected. (old = 'paused', new = 'running') 2025-01-22 15:13:11 (319960): Status Report: Job Duration: '864000.000000' 2025-01-22 15:13:11 (319960): Status Report: Elapsed Time: '764408.330767' 2025-01-22 15:13:11 (319960): Status Report: CPU Time: '4296.490000' 2025-01-22 15:21:19 (319960): VM state change detected. (old = 'running', new = 'paused') 2025-01-22 15:21:39 (319960): VM state change detected. (old = 'paused', new = 'running') 2025-01-22 15:49:21 (319960): VM state change detected. (old = 'running', new = 'paused') 2025-01-22 15:49:41 (319960): VM state change detected. (old = 'paused', new = 'running') 2025-01-22 16:40:05 (319960): VM state change detected. (old = 'running', new = 'paused') 2025-01-22 16:40:26 (319960): VM state change detected. (old = 'paused', new = 'running') 2025-01-22 16:53:14 (319960): Status Report: Job Duration: '864000.000000' 2025-01-22 16:53:14 (319960): Status Report: Elapsed Time: '770408.330767' 2025-01-22 16:53:14 (319960): Status Report: CPU Time: '4322.430000' 2025-01-22 16:57:58 (319960): VM state change detected. (old = 'running', new = 'paused') 2025-01-22 16:58:17 (319960): VM state change detected. (old = 'paused', new = 'running') 2025-01-22 17:28:00 (319960): VM state change detected. (old = 'running', new = 'paused') 2025-01-22 17:28:20 (319960): VM state change detected. (old = 'paused', new = 'running') 2025-01-22 17:46:12 (319960): VM state change detected. (old = 'running', new = 'paused') 2025-01-22 17:46:32 (319960): VM state change detected. (old = 'paused', new = 'running') 2025-01-22 18:02:14 (319960): VM state change detected. (old = 'running', new = 'paused') 2025-01-22 19:10:23 (319960): VM state change detected. (old = 'paused', new = 'running') 2025-01-22 19:10:33 (319960): Guest Log: 59:08:43.932714 timesync vgsvcTimeSyncWorker: Radical host time change: 4 098 990 000 000ns (HostNow=1 737 591 032 465 000 000 ns HostLast=1 737 586 933 475 000 000 ns) 2025-01-22 19:10:43 (319960): Guest Log: 59:08:53.933484 timesync vgsvcTimeSyncWorker: Radical guest time change: 4 908 508 768 000ns (GuestNow=1 737 591 042 473 041 000 ns GuestLast=1 737 586 133 964 273 000 ns fSetTimeLastLoop=true ) 2025-01-22 19:15:46 (319960): VM state change detected. (old = 'running', new = 'paused') 2025-01-22 19:16:04 (319960): VM state change detected. (old = 'paused', new = 'running') 2025-01-22 19:26:46 (319960): VM state change detected. (old = 'running', new = 'paused') 2025-01-22 19:27:06 (319960): VM state change detected. (old = 'paused', new = 'running') 2025-01-22 19:27:56 (319960): VM state change detected. (old = 'running', new = 'paused') 2025-01-22 19:53:47 (319960): Stopping VM. 2025-01-22 19:54:07 (319960): Successfully stopped VM. 2025-01-22 21:53:04 (603925): vboxwrapper version 26207 2025-01-22 21:53:04 (603925): BOINC client version: 8.0.2 2025-01-22 21:53:04 (603925): Detected: VirtualBox VboxManage Interface (Version: 7.1.6) 2025-01-22 21:53:04 (603925): Detected: Heartbeat check (file: 'heartbeat' every 1200.000000 seconds) 2025-01-22 21:53:04 (603925): Guest Log: 41:29:22.729230 timesync vgsvcTimeSyncWorker: Radical host time change: 8 251 126 000 000ns (HostNow=1 737 522 572 761 000 000 ns HostLast=1 737 514 321 635 000 000 ns) 2025-01-22 21:53:04 (603925): Guest Log: 41:29:32.729524 timesync vgsvcTimeSyncWorker: Radical guest time change: 8 556 642 898 000ns (GuestNow=1 737 522 582 768 475 000 ns GuestLast=1 737 514 026 125 577 000 ns fSetTimeLastLoop=true ) 2025-01-22 21:53:04 (603925): Guest Log: 59:08:43.932714 timesync vgsvcTimeSyncWorker: Radical host time change: 4 098 990 000 000ns (HostNow=1 737 591 032 465 000 000 ns HostLast=1 737 586 933 475 000 000 ns) 2025-01-22 21:53:04 (603925): Guest Log: 59:08:53.933484 timesync vgsvcTimeSyncWorker: Radical guest time change: 4 908 508 768 000ns (GuestNow=1 737 591 042 473 041 000 ns GuestLast=1 737 586 133 964 273 000 ns fSetTimeLastLoop=true ) 2025-01-22 21:53:04 (603925): Starting VM using VBoxManage interface. (boinc_e204efab051646d5, slot#23) 2025-01-22 21:53:08 (603925): Successfully started VM. (PID = '604753') 2025-01-22 21:53:08 (603925): Reporting VM Process ID to BOINC. 2025-01-22 21:53:08 (603925): VM state change detected. (old = 'poweredoff', new = 'running') 2025-01-22 21:53:08 (603925): Detected: Web Application Enabled (http://localhost:47773) 2025-01-22 21:53:08 (603925): Status Report: Job Duration: '864000.000000' 2025-01-22 21:53:08 (603925): Status Report: Elapsed Time: '775543.330767' 2025-01-22 21:53:08 (603925): Status Report: CPU Time: '4350.660000' 2025-01-22 21:53:08 (603925): Preference change detected 2025-01-22 21:53:08 (603925): Setting CPU throttle for VM. (100%) 2025-01-22 21:53:08 (603925): Setting checkpoint interval to 600 seconds. (Higher value of (Preference: 120 seconds) or (Vbox_job.xml: 600 seconds)) 2025-01-22 21:53:11 (603925): Guest Log: 59:25:33.991602 timesync vgsvcTimeSyncWorker: Radical host time change: 8 721 407 000 000ns (HostNow=1 737 600 790 448 000 000 ns HostLast=1 737 592 069 041 000 000 ns) 2025-01-22 21:53:21 (603925): Guest Log: 59:25:43.991829 timesync vgsvcTimeSyncWorker: Radical guest time change: 8 757 916 930 000ns (GuestNow=1 737 600 800 448 245 000 ns GuestLast=1 737 592 042 531 315 000 ns fSetTimeLastLoop=true ) 2025-01-22 22:02:37 (603925): VM state change detected. (old = 'running', new = 'paused') 2025-01-22 22:02:58 (603925): VM state change detected. (old = 'paused', new = 'running') 2025-01-22 22:21:40 (603925): VM state change detected. (old = 'running', new = 'paused') 2025-01-22 22:21:59 (603925): VM state change detected. (old = 'paused', new = 'running') 2025-01-22 22:23:47 (603925): Stopping VM. 2025-01-22 22:23:51 (603925): Successfully stopped VM. 2025-01-22 22:24:15 (624102): vboxwrapper version 26207 2025-01-22 22:24:15 (624102): BOINC client version: 8.0.2 2025-01-22 22:24:16 (624102): Detected: VirtualBox VboxManage Interface (Version: 7.1.6) 2025-01-22 22:24:16 (624102): Detected: Heartbeat check (file: 'heartbeat' every 1200.000000 seconds) 2025-01-22 22:24:17 (624102): Guest Log: 59:25:33.991602 timesync vgsvcTimeSyncWorker: Radical host time change: 8 721 407 000 000ns (HostNow=1 737 600 790 448 000 000 ns HostLast=1 737 592 069 041 000 000 ns) 2025-01-22 22:24:17 (624102): Guest Log: 59:25:43.991829 timesync vgsvcTimeSyncWorker: Radical guest time change: 8 757 916 930 000ns (GuestNow=1 737 600 800 448 245 000 ns GuestLast=1 737 592 042 531 315 000 ns fSetTimeLastLoop=true ) 2025-01-22 22:24:17 (624102): Starting VM using VBoxManage interface. (boinc_e204efab051646d5, slot#23) 2025-01-22 22:24:19 (624102): Successfully started VM. (PID = '626093') 2025-01-22 22:24:19 (624102): Reporting VM Process ID to BOINC. 2025-01-22 22:24:19 (624102): VM state change detected. (old = 'poweredoff', new = 'running') 2025-01-22 22:24:19 (624102): Detected: Web Application Enabled (http://localhost:47773) 2025-01-22 22:24:19 (624102): Status Report: Job Duration: '864000.000000' 2025-01-22 22:24:19 (624102): Status Report: Elapsed Time: '777358.330767' 2025-01-22 22:24:19 (624102): Status Report: CPU Time: '4360.060000' 2025-01-22 22:24:19 (624102): Preference change detected 2025-01-22 22:24:19 (624102): Setting CPU throttle for VM. (100%) 2025-01-22 22:24:19 (624102): Setting checkpoint interval to 600 seconds. (Higher value of (Preference: 120 seconds) or (Vbox_job.xml: 600 seconds)) 2025-01-22 22:34:17 (624102): VM state change detected. (old = 'running', new = 'paused') 2025-01-22 22:34:38 (624102): VM state change detected. (old = 'paused', new = 'running') 2025-01-22 22:52:31 (624102): VM state change detected. (old = 'running', new = 'paused') 2025-01-22 22:52:51 (624102): VM state change detected. (old = 'paused', new = 'running') 2025-01-22 23:10:14 (646139): vboxwrapper version 26207 2025-01-22 23:10:14 (646139): BOINC client version: 8.0.2 2025-01-22 23:10:14 (646139): Detected: VirtualBox VboxManage Interface (Version: 7.1.6) 2025-01-22 23:10:15 (646139): Detected: Heartbeat check (file: 'heartbeat' every 1200.000000 seconds) 2025-01-22 23:10:15 (646139): Starting VM using VBoxManage interface. (boinc_e204efab051646d5, slot#23) 2025-01-22 23:10:16 (646139): Successfully started VM. (PID = '647697') 2025-01-22 23:10:16 (646139): Reporting VM Process ID to BOINC. 2025-01-22 23:10:16 (646139): Guest Log: BIOS: VirtualBox 7.1.6 2025-01-22 23:10:16 (646139): Guest Log: CPUID EDX: 0x178bfbff 2025-01-22 23:10:16 (646139): Guest Log: BIOS: No PCI IDE controller, not probing IDE 2025-01-22 23:10:16 (646139): Guest Log: BIOS: AHCI 0-P#0: PCHS=16383/16/63 LCHS=1024/255/63 0x0000000002800000 sectors 2025-01-22 23:10:16 (646139): VM state change detected. (old = 'poweredoff', new = 'running') 2025-01-22 23:10:16 (646139): Detected: Web Application Enabled (http://localhost:47773) 2025-01-22 23:10:16 (646139): Status Report: Job Duration: '864000.000000' 2025-01-22 23:10:16 (646139): Status Report: Elapsed Time: '779615.330767' 2025-01-22 23:10:16 (646139): Status Report: CPU Time: '4370.000000' 2025-01-22 23:10:16 (646139): Preference change detected 2025-01-22 23:10:16 (646139): Setting CPU throttle for VM. (100%) 2025-01-22 23:10:16 (646139): Setting checkpoint interval to 600 seconds. (Higher value of (Preference: 120 seconds) or (Vbox_job.xml: 600 seconds)) 2025-01-22 23:10:18 (646139): Guest Log: BIOS: Boot : bseqnr=1, bootseq=0032 2025-01-22 23:10:18 (646139): Guest Log: BIOS: Booting from Hard Disk... 2025-01-22 23:10:21 (646139): Guest Log: BIOS: KBD: unsupported int 16h function 03 2025-01-22 23:10:21 (646139): Guest Log: BIOS: AX=0305 BX=0000 CX=0000 DX=0000 2025-01-22 23:10:53 (646139): Guest Log: vgdrvHeartbeatInit: Setting up heartbeat to trigger every 2000 milliseconds 2025-01-22 23:10:53 (646139): Guest Log: vboxguest: misc device minor 56, IRQ 20, I/O port d020, MMIO at 00000000f0400000 (size 0x400000) 2025-01-22 23:10:58 (646139): Guest Log: VBoxService 5.2.6 r120293 (verbosity: 0) linux.amd64 (Jan 15 2018 14:51:00) release log 2025-01-22 23:10:58 (646139): Guest Log: 00:00:00.000123 main Log opened 2025-01-23T04:10:57.752740000Z 2025-01-22 23:10:58 (646139): Guest Log: 00:00:00.000320 main OS Product: Linux 2025-01-22 23:10:58 (646139): Guest Log: 00:00:00.000393 main OS Release: 4.14.76-13.cernvm.x86_64 2025-01-22 23:10:58 (646139): Guest Log: 00:00:00.000434 main OS Version: #1 SMP Tue Oct 16 18:26:15 CEST 2018 2025-01-22 23:10:58 (646139): Guest Log: 00:00:00.000488 main Executable: /usr/sbin/VBoxService 2025-01-22 23:10:58 (646139): Guest Log: 00:00:00.000489 main Process ID: 3152 2025-01-22 23:10:58 (646139): Guest Log: 00:00:00.000490 main Package type: LINUX_64BITS_GENERIC 2025-01-22 23:10:58 (646139): Guest Log: 00:00:00.008977 main 5.2.6 r120293 started. Verbose level = 0 2025-01-22 23:11:41 (646139): Guest Log: 23:11:41 EST -05:00 2025-01-22: cranky: [INFO] Detected Theory App 2025-01-22 23:11:41 (646139): Guest Log: 23:11:41 EST -05:00 2025-01-22: cranky: [INFO] Checking CVMFS. 2025-01-22 23:11:42 (646139): Guest Log: Probing /cvmfs/sft.cern.ch... OK 2025-01-22 23:11:43 (646139): Guest Log: VERSION PID UPTIME(M) MEM(K) REVISION EXPIRES(M) NOCATALOGS CACHEUSE(K) CACHEMAX(K) NOFDUSE NOFDMAX NOIOERR NOOPEN HITRATE(%) RX(K) SPEED(K/S) HOST PROXY ONLINE 2025-01-22 23:11:43 (646139): Guest Log: 2.5.2.0 4038 0 27184 15697 2 1 244090 4096000 0 65024 1 0 n/a 1 3 http://s1asgc-cvmfs.openhtc.io:8080/cvmfs/sft.cern.ch http://192.41.231.239:6082 0 2025-01-22 23:11:44 (646139): Guest Log: Probing /cvmfs/grid.cern.ch... OK 2025-01-22 23:11:44 (646139): Guest Log: VERSION PID UPTIME(M) MEM(K) REVISION EXPIRES(M) NOCATALOGS CACHEUSE(K) CACHEMAX(K) NOFDUSE NOFDMAX NOIOERR NOOPEN HITRATE(%) RX(K) SPEED(K/S) HOST PROXY ONLINE 2025-01-22 23:11:44 (646139): Guest Log: 2.5.2.0 4017 0 25388 10299 2 2 244090 4096000 0 65024 3 2 0 1 2 http://s1bnl-cvmfs.openhtc.io/cvmfs/grid.cern.ch http://192.41.231.239:6082 0 2025-01-22 23:11:45 (646139): Guest Log: Probing /cvmfs/cernvm-prod.cern.ch... OK 2025-01-22 23:11:45 (646139): Guest Log: VERSION PID UPTIME(M) MEM(K) REVISION EXPIRES(M) NOCATALOGS CACHEUSE(K) CACHEMAX(K) NOFDUSE NOFDMAX NOIOERR NOOPEN HITRATE(%) RX(K) SPEED(K/S) HOST PROXY ONLINE 2025-01-22 23:11:45 (646139): Guest Log: 2.5.2.0 3995 0 27260 245 2 1 244090 4096000 0 65024 1 0 n/a 1 3 http://s1asgc-cvmfs.openhtc.io:8080/cvmfs/cernvm-prod.cern.ch http://192.41.231.239:6082 0 2025-01-22 23:11:46 (646139): Guest Log: Probing /cvmfs/alice.cern.ch... OK 2025-01-22 23:11:47 (646139): Guest Log: VERSION PID UPTIME(M) MEM(K) REVISION EXPIRES(M) NOCATALOGS CACHEUSE(K) CACHEMAX(K) NOFDUSE NOFDMAX NOIOERR NOOPEN HITRATE(%) RX(K) SPEED(K/S) HOST PROXY ONLINE 2025-01-22 23:11:47 (646139): Guest Log: 2.5.2.0 4060 0 28840 5181 2 1 244090 4096000 0 65024 1 0 n/a 1 3 http://s1asgc-cvmfs.openhtc.io:8080/cvmfs/alice.cern.ch http://192.41.231.239:6082 0 2025-01-22 23:11:47 (646139): Guest Log: 23:11:46 EST -05:00 2025-01-22: cranky: [INFO] Checking runc. 2025-01-22 23:11:48 (646139): Guest Log: 23:11:47 EST -05:00 2025-01-22: cranky: [INFO] Creating the filesystem. 2025-01-22 23:11:48 (646139): Guest Log: 23:11:47 EST -05:00 2025-01-22: cranky: [INFO] Using /cvmfs/cernvm-prod.cern.ch/cvm4 2025-01-22 23:11:48 (646139): Guest Log: 23:11:47 EST -05:00 2025-01-22: cranky: [INFO] Updating config.json. 2025-01-22 23:11:48 (646139): Guest Log: 23:11:47 EST -05:00 2025-01-22: cranky: [INFO] Running Container 'runc'. 2025-01-22 23:11:48 (646139): Guest Log: standard_init_linux.go:203: exec user process caused "input/output error" 2025-01-22 23:11:48 (646139): Guest Log: 23:11:48 EST -05:00 2025-01-22: cranky: [INFO] Container 'runc' finished with status code 1. 2025-01-22 23:11:48 (646139): Guest Log: 23:11:48 EST -05:00 2025-01-22: cranky: [INFO] Preparing output. 2025-01-22 23:11:48 (646139): Guest Log: 23:11:48 EST -05:00 2025-01-22: cranky: [ERROR] No output found. 2025-01-23 00:10:13 (20997): vboxwrapper version 26207 2025-01-23 00:10:13 (20997): BOINC client version: 8.0.2 2025-01-23 00:10:14 (20997): Detected: VirtualBox VboxManage Interface (Version: 7.1.6) 2025-01-23 00:10:14 (20997): Detected: Heartbeat check (file: 'heartbeat' every 1200.000000 seconds) 2025-01-23 00:10:14 (20997): Guest Log: BIOS: VirtualBox 7.1.6 2025-01-23 00:10:14 (20997): Guest Log: CPUID EDX: 0x178bfbff 2025-01-23 00:10:14 (20997): Guest Log: BIOS: No PCI IDE controller, not probing IDE 2025-01-23 00:10:14 (20997): Guest Log: BIOS: AHCI 0-P#0: PCHS=16383/16/63 LCHS=1024/255/63 0x0000000002800000 sectors 2025-01-23 00:10:14 (20997): Guest Log: BIOS: Boot : bseqnr=1, bootseq=0032 2025-01-23 00:10:14 (20997): Guest Log: BIOS: Booting from Hard Disk... 2025-01-23 00:10:14 (20997): Guest Log: BIOS: KBD: unsupported int 16h function 03 2025-01-23 00:10:14 (20997): Guest Log: BIOS: AX=0305 BX=0000 CX=0000 DX=0000 2025-01-23 00:10:14 (20997): Guest Log: vgdrvHeartbeatInit: Setting up heartbeat to trigger every 2000 milliseconds 2025-01-23 00:10:14 (20997): Guest Log: vboxguest: misc device minor 56, IRQ 20, I/O port d020, MMIO at 00000000f0400000 (size 0x400000) 2025-01-23 00:10:14 (20997): Guest Log: VBoxService 5.2.6 r120293 (verbosity: 0) linux.amd64 (Jan 15 2018 14:51:00) release log 2025-01-23 00:10:14 (20997): Guest Log: 00:00:00.000123 main Log opened 2025-01-23T04:10:57.752740000Z 2025-01-23 00:10:14 (20997): Guest Log: 00:00:00.000320 main OS Product: Linux 2025-01-23 00:10:14 (20997): Guest Log: 00:00:00.000393 main OS Release: 4.14.76-13.cernvm.x86_64 2025-01-23 00:10:14 (20997): Guest Log: 00:00:00.000434 main OS Version: #1 SMP Tue Oct 16 18:26:15 CEST 2018 2025-01-23 00:10:14 (20997): Guest Log: 00:00:00.000488 main Executable: /usr/sbin/VBoxService 2025-01-23 00:10:14 (20997): Guest Log: 00:00:00.000489 main Process ID: 3152 2025-01-23 00:10:14 (20997): Guest Log: 00:00:00.000490 main Package type: LINUX_64BITS_GENERIC 2025-01-23 00:10:14 (20997): Guest Log: 00:00:00.008977 main 5.2.6 r120293 started. Verbose level = 0 2025-01-23 00:10:14 (20997): Guest Log: 23:11:41 EST -05:00 2025-01-22: cranky: [INFO] Detected Theory App 2025-01-23 00:10:14 (20997): Guest Log: 23:11:41 EST -05:00 2025-01-22: cranky: [INFO] Checking CVMFS. 2025-01-23 00:10:14 (20997): Guest Log: Probing /cvmfs/sft.cern.ch... OK 2025-01-23 00:10:14 (20997): Guest Log: VERSION PID UPTIME(M) MEM(K) REVISION EXPIRES(M) NOCATALOGS CACHEUSE(K) CACHEMAX(K) NOFDUSE NOFDMAX NOIOERR NOOPEN HITRATE(%) RX(K) SPEED(K/S) HOST PROXY ONLINE 2025-01-23 00:10:14 (20997): Guest Log: 2.5.2.0 4038 0 27184 15697 2 1 244090 4096000 0 65024 1 0 n/a 1 3 http://s1asgc-cvmfs.openhtc.io:8080/cvmfs/sft.cern.ch http://192.41.231.239:6082 0 2025-01-23 00:10:14 (20997): Guest Log: Probing /cvmfs/grid.cern.ch... OK 2025-01-23 00:10:14 (20997): Guest Log: VERSION PID UPTIME(M) MEM(K) REVISION EXPIRES(M) NOCATALOGS CACHEUSE(K) CACHEMAX(K) NOFDUSE NOFDMAX NOIOERR NOOPEN HITRATE(%) RX(K) SPEED(K/S) HOST PROXY ONLINE 2025-01-23 00:10:14 (20997): Guest Log: 2.5.2.0 4017 0 25388 10299 2 2 244090 4096000 0 65024 3 2 0 1 2 http://s1bnl-cvmfs.openhtc.io/cvmfs/grid.cern.ch http://192.41.231.239:6082 0 2025-01-23 00:10:14 (20997): Guest Log: Probing /cvmfs/cernvm-prod.cern.ch... OK 2025-01-23 00:10:14 (20997): Guest Log: VERSION PID UPTIME(M) MEM(K) REVISION EXPIRES(M) NOCATALOGS CACHEUSE(K) CACHEMAX(K) NOFDUSE NOFDMAX NOIOERR NOOPEN HITRATE(%) RX(K) SPEED(K/S) HOST PROXY ONLINE 2025-01-23 00:10:14 (20997): Guest Log: 2.5.2.0 3995 0 27260 245 2 1 244090 4096000 0 65024 1 0 n/a 1 3 http://s1asgc-cvmfs.openhtc.io:8080/cvmfs/cernvm-prod.cern.ch http://192.41.231.239:6082 0 2025-01-23 00:10:14 (20997): Guest Log: Probing /cvmfs/alice.cern.ch... OK 2025-01-23 00:10:14 (20997): Guest Log: VERSION PID UPTIME(M) MEM(K) REVISION EXPIRES(M) NOCATALOGS CACHEUSE(K) CACHEMAX(K) NOFDUSE NOFDMAX NOIOERR NOOPEN HITRATE(%) RX(K) SPEED(K/S) HOST PROXY ONLINE 2025-01-23 00:10:14 (20997): Guest Log: 2.5.2.0 4060 0 28840 5181 2 1 244090 4096000 0 65024 1 0 n/a 1 3 http://s1asgc-cvmfs.openhtc.io:8080/cvmfs/alice.cern.ch http://192.41.231.239:6082 0 2025-01-23 00:10:14 (20997): Guest Log: 23:11:46 EST -05:00 2025-01-22: cranky: [INFO] Checking runc. 2025-01-23 00:10:14 (20997): Guest Log: 23:11:47 EST -05:00 2025-01-22: cranky: [INFO] Creating the filesystem. 2025-01-23 00:10:14 (20997): Guest Log: 23:11:47 EST -05:00 2025-01-22: cranky: [INFO] Using /cvmfs/cernvm-prod.cern.ch/cvm4 2025-01-23 00:10:14 (20997): Guest Log: 23:11:47 EST -05:00 2025-01-22: cranky: [INFO] Updating config.json. 2025-01-23 00:10:14 (20997): Guest Log: 23:11:47 EST -05:00 2025-01-22: cranky: [INFO] Running Container 'runc'. 2025-01-23 00:10:14 (20997): Guest Log: standard_init_linux.go:203: exec user process caused "input/output error" 2025-01-23 00:10:14 (20997): Guest Log: 23:11:48 EST -05:00 2025-01-22: cranky: [INFO] Container 'runc' finished with status code 1. 2025-01-23 00:10:14 (20997): Guest Log: 23:11:48 EST -05:00 2025-01-22: cranky: [INFO] Preparing output. 2025-01-23 00:10:14 (20997): Guest Log: 23:11:48 EST -05:00 2025-01-22: cranky: [ERROR] No output found. 2025-01-23 00:10:14 (20997): Starting VM using VBoxManage interface. (boinc_e204efab051646d5, slot#23) 2025-01-23 00:10:15 (20997): Successfully started VM. (PID = '21835') 2025-01-23 00:10:15 (20997): Reporting VM Process ID to BOINC. 2025-01-23 00:10:15 (20997): Guest Log: BIOS: VirtualBox 7.1.6 2025-01-23 00:10:15 (20997): Guest Log: CPUID EDX: 0x178bfbff 2025-01-23 00:10:15 (20997): Guest Log: BIOS: No PCI IDE controller, not probing IDE 2025-01-23 00:10:15 (20997): Guest Log: BIOS: AHCI 0-P#0: PCHS=16383/16/63 LCHS=1024/255/63 0x0000000002800000 sectors 2025-01-23 00:10:15 (20997): VM state change detected. (old = 'poweredoff', new = 'running') 2025-01-23 00:10:15 (20997): Detected: Web Application Enabled (http://localhost:47773) 2025-01-23 00:10:15 (20997): Status Report: Job Duration: '864000.000000' 2025-01-23 00:10:15 (20997): Status Report: Elapsed Time: '779615.330767' 2025-01-23 00:10:15 (20997): Status Report: CPU Time: '4370.000000' 2025-01-23 00:10:15 (20997): Preference change detected 2025-01-23 00:10:15 (20997): Setting CPU throttle for VM. (100%) 2025-01-23 00:10:15 (20997): Setting checkpoint interval to 600 seconds. (Higher value of (Preference: 120 seconds) or (Vbox_job.xml: 600 seconds)) 2025-01-23 00:10:17 (20997): Guest Log: BIOS: Boot : bseqnr=1, bootseq=0032 2025-01-23 00:10:17 (20997): Guest Log: BIOS: Booting from Hard Disk... 2025-01-23 00:10:20 (20997): Guest Log: BIOS: KBD: unsupported int 16h function 03 2025-01-23 00:10:20 (20997): Guest Log: BIOS: AX=0305 BX=0000 CX=0000 DX=0000 2025-01-23 00:10:38 (20997): Guest Log: vgdrvHeartbeatInit: Setting up heartbeat to trigger every 2000 milliseconds 2025-01-23 00:10:38 (20997): Guest Log: vboxguest: misc device minor 56, IRQ 20, I/O port d020, MMIO at 00000000f0400000 (size 0x400000) 2025-01-23 00:10:41 (20997): Guest Log: VBoxService 5.2.6 r120293 (verbosity: 0) linux.amd64 (Jan 15 2018 14:51:00) release log 2025-01-23 00:10:41 (20997): Guest Log: 00:00:00.000075 main Log opened 2025-01-23T05:10:40.764697000Z 2025-01-23 00:10:41 (20997): Guest Log: 00:00:00.000145 main OS Product: Linux 2025-01-23 00:10:41 (20997): Guest Log: 00:00:00.000169 main OS Release: 4.14.76-13.cernvm.x86_64 2025-01-23 00:10:41 (20997): Guest Log: 00:00:00.000191 main OS Version: #1 SMP Tue Oct 16 18:26:15 CEST 2018 2025-01-23 00:10:41 (20997): Guest Log: 00:00:00.000209 main Executable: /usr/sbin/VBoxService 2025-01-23 00:10:41 (20997): Guest Log: 00:00:00.000209 main Process ID: 3156 2025-01-23 00:10:41 (20997): Guest Log: 00:00:00.000210 main Package type: LINUX_64BITS_GENERIC 2025-01-23 00:10:41 (20997): Guest Log: 00:00:00.002350 main 5.2.6 r120293 started. Verbose level = 0 2025-01-23 00:11:04 (20997): Guest Log: 00:11:04 EST -05:00 2025-01-23: cranky: [INFO] Detected Theory App 2025-01-23 00:11:04 (20997): Guest Log: 00:11:04 EST -05:00 2025-01-23: cranky: [INFO] Checking CVMFS. 2025-01-23 00:11:05 (20997): Guest Log: Probing /cvmfs/sft.cern.ch... OK 2025-01-23 00:11:05 (20997): Guest Log: VERSION PID UPTIME(M) MEM(K) REVISION EXPIRES(M) NOCATALOGS CACHEUSE(K) CACHEMAX(K) NOFDUSE NOFDMAX NOIOERR NOOPEN HITRATE(%) RX(K) SPEED(K/S) HOST PROXY ONLINE 2025-01-23 00:11:05 (20997): Guest Log: 2.5.2.0 4052 0 27392 15697 2 1 244090 4096000 0 65024 1 0 n/a 1 3 http://s1asgc-cvmfs.openhtc.io:8080/cvmfs/sft.cern.ch http://192.41.231.239:6082 0 2025-01-23 00:11:06 (20997): Guest Log: Probing /cvmfs/grid.cern.ch... OK 2025-01-23 00:11:06 (20997): Guest Log: VERSION PID UPTIME(M) MEM(K) REVISION EXPIRES(M) NOCATALOGS CACHEUSE(K) CACHEMAX(K) NOFDUSE NOFDMAX NOIOERR NOOPEN HITRATE(%) RX(K) SPEED(K/S) HOST PROXY ONLINE 2025-01-23 00:11:06 (20997): Guest Log: 2.5.2.0 4005 0 25468 10299 2 2 244090 4096000 0 65024 3 2 0 1 2 http://s1bnl-cvmfs.openhtc.io/cvmfs/grid.cern.ch http://192.41.231.239:6082 0 2025-01-23 00:11:06 (20997): Guest Log: Probing /cvmfs/cernvm-prod.cern.ch... OK 2025-01-23 00:11:07 (20997): Guest Log: VERSION PID UPTIME(M) MEM(K) REVISION EXPIRES(M) NOCATALOGS CACHEUSE(K) CACHEMAX(K) NOFDUSE NOFDMAX NOIOERR NOOPEN HITRATE(%) RX(K) SPEED(K/S) HOST PROXY ONLINE 2025-01-23 00:11:07 (20997): Guest Log: 2.5.2.0 3983 0 25160 245 2 1 244090 4096000 0 65024 1 0 n/a 1 0 http://s1asgc-cvmfs.openhtc.io:8080/cvmfs/cernvm-prod.cern.ch http://192.41.231.239:6082 0 2025-01-23 00:11:07 (20997): Guest Log: Probing /cvmfs/alice.cern.ch... OK 2025-01-23 00:11:08 (20997): Guest Log: VERSION PID UPTIME(M) MEM(K) REVISION EXPIRES(M) NOCATALOGS CACHEUSE(K) CACHEMAX(K) NOFDUSE NOFDMAX NOIOERR NOOPEN HITRATE(%) RX(K) SPEED(K/S) HOST PROXY ONLINE 2025-01-23 00:11:08 (20997): Guest Log: 2.5.2.0 4027 0 28760 5181 2 1 244090 4096000 0 65024 1 0 n/a 1 2 http://s1asgc-cvmfs.openhtc.io:8080/cvmfs/alice.cern.ch http://192.41.231.239:6082 0 2025-01-23 00:11:08 (20997): Guest Log: 00:11:07 EST -05:00 2025-01-23: cranky: [INFO] Checking runc. 2025-01-23 00:11:08 (20997): Guest Log: 00:11:07 EST -05:00 2025-01-23: cranky: [INFO] Creating the filesystem. 2025-01-23 00:11:08 (20997): Guest Log: 00:11:07 EST -05:00 2025-01-23: cranky: [INFO] Using /cvmfs/cernvm-prod.cern.ch/cvm4 2025-01-23 00:11:08 (20997): Guest Log: 00:11:08 EST -05:00 2025-01-23: cranky: [INFO] Updating config.json. 2025-01-23 00:11:08 (20997): Guest Log: 00:11:08 EST -05:00 2025-01-23: cranky: [INFO] Running Container 'runc'. 2025-01-23 00:11:08 (20997): Guest Log: standard_init_linux.go:203: exec user process caused "input/output error" 2025-01-23 00:11:08 (20997): Guest Log: 00:11:08 EST -05:00 2025-01-23: cranky: [INFO] Container 'runc' finished with status code 1. 2025-01-23 00:11:08 (20997): Guest Log: 00:11:08 EST -05:00 2025-01-23: cranky: [INFO] Preparing output. 2025-01-23 00:11:08 (20997): Guest Log: 00:11:08 EST -05:00 2025-01-23: cranky: [ERROR] No output found. 2025-01-23 00:19:16 (20997): VM state change detected. (old = 'running', new = 'paused') 2025-01-23 00:19:36 (20997): VM state change detected. (old = 'paused', new = 'running') 2025-01-23 00:21:27 (20997): VM state change detected. (old = 'running', new = 'paused') 2025-01-23 00:21:48 (20997): VM state change detected. (old = 'paused', new = 'running') 2025-01-23 00:28:20 (20997): VM state change detected. (old = 'running', new = 'paused') 2025-01-23 00:28:40 (20997): VM state change detected. (old = 'paused', new = 'running') 2025-01-23 00:38:21 (20997): VM state change detected. (old = 'running', new = 'paused') 2025-01-23 00:38:41 (20997): VM state change detected. (old = 'paused', new = 'running') 2025-01-23 00:44:42 (20997): VM state change detected. (old = 'running', new = 'paused') 2025-01-23 00:45:02 (20997): VM state change detected. (old = 'paused', new = 'running') 2025-01-23 00:52:03 (20997): VM state change detected. (old = 'running', new = 'paused') 2025-01-23 00:52:23 (20997): VM state change detected. (old = 'paused', new = 'running') 2025-01-23 01:00:44 (20997): VM state change detected. (old = 'running', new = 'paused') 2025-01-23 01:01:03 (20997): VM state change detected. (old = 'paused', new = 'running') 2025-01-23 01:10:35 (20997): VM state change detected. (old = 'running', new = 'paused') 2025-01-23 01:10:54 (20997): VM state change detected. (old = 'paused', new = 'running') 2025-01-23 01:52:03 (20997): Status Report: Job Duration: '864000.000000' 2025-01-23 01:52:03 (20997): Status Report: Elapsed Time: '785615.330767' 2025-01-23 01:52:03 (20997): Status Report: CPU Time: '4418.910000' 2025-01-23 03:08:16 (20997): VM state change detected. (old = 'running', new = 'paused') 2025-01-23 03:08:36 (20997): VM state change detected. (old = 'paused', new = 'running') 2025-01-23 03:25:57 (20997): VM state change detected. (old = 'running', new = 'paused') 2025-01-23 03:26:17 (20997): VM state change detected. (old = 'paused', new = 'running') 2025-01-23 03:31:45 (20997): Status Report: Job Duration: '864000.000000' 2025-01-23 03:31:45 (20997): Status Report: Elapsed Time: '791615.330767' 2025-01-23 03:31:45 (20997): Status Report: CPU Time: '4451.710000' 2025-01-23 03:33:08 (20997): VM state change detected. (old = 'running', new = 'paused') 2025-01-23 03:33:28 (20997): VM state change detected. (old = 'paused', new = 'running') 2025-01-23 03:52:40 (20997): VM state change detected. (old = 'running', new = 'paused') 2025-01-23 03:53:00 (20997): VM state change detected. (old = 'paused', new = 'running') 2025-01-23 04:13:51 (20997): VM state change detected. (old = 'running', new = 'paused') 2025-01-23 04:14:12 (20997): VM state change detected. (old = 'paused', new = 'running') 2025-01-23 04:30:53 (20997): VM state change detected. (old = 'running', new = 'paused') 2025-01-23 04:31:13 (20997): VM state change detected. (old = 'paused', new = 'running') 2025-01-23 04:48:55 (20997): VM state change detected. (old = 'running', new = 'paused') 2025-01-23 04:49:15 (20997): VM state change detected. (old = 'paused', new = 'running') 2025-01-23 05:07:47 (20997): VM state change detected. (old = 'running', new = 'paused') 2025-01-23 05:08:08 (20997): VM state change detected. (old = 'paused', new = 'running') 2025-01-23 05:12:52 (20997): Status Report: Job Duration: '864000.000000' 2025-01-23 05:12:52 (20997): Status Report: Elapsed Time: '797615.330767' 2025-01-23 05:12:52 (20997): Status Report: CPU Time: '4483.750000' 2025-01-23 05:38:40 (20997): VM state change detected. (old = 'running', new = 'paused') 2025-01-23 05:39:00 (20997): VM state change detected. (old = 'paused', new = 'running') 2025-01-23 06:09:13 (20997): VM state change detected. (old = 'running', new = 'paused') 2025-01-23 06:09:33 (20997): VM state change detected. (old = 'paused', new = 'running') 2025-01-23 06:40:26 (20997): VM state change detected. (old = 'running', new = 'paused') 2025-01-23 06:40:46 (20997): VM state change detected. (old = 'paused', new = 'running') 2025-01-23 06:52:55 (20997): Status Report: Job Duration: '864000.000000' 2025-01-23 06:52:55 (20997): Status Report: Elapsed Time: '803615.330767' 2025-01-23 06:52:55 (20997): Status Report: CPU Time: '4511.170000' 2025-01-23 07:11:38 (20997): VM state change detected. (old = 'running', new = 'paused') 2025-01-23 07:11:58 (20997): VM state change detected. (old = 'paused', new = 'running') 2025-01-23 07:30:20 (20997): VM state change detected. (old = 'running', new = 'paused') 2025-01-23 07:30:41 (20997): VM state change detected. (old = 'paused', new = 'running') 2025-01-23 07:40:11 (20997): VM state change detected. (old = 'running', new = 'paused') 2025-01-23 07:40:31 (20997): VM state change detected. (old = 'paused', new = 'running') 2025-01-23 08:21:35 (20997): VM state change detected. (old = 'running', new = 'paused') 2025-01-23 08:21:55 (20997): VM state change detected. (old = 'paused', new = 'running') 2025-01-23 08:33:19 (20997): Status Report: Job Duration: '864000.000000' 2025-01-23 08:33:19 (20997): Status Report: Elapsed Time: '809615.330767' 2025-01-23 08:33:19 (20997): Status Report: CPU Time: '4539.520000' 2025-01-23 10:12:20 (20997): Status Report: Job Duration: '864000.000000' 2025-01-23 10:12:20 (20997): Status Report: Elapsed Time: '815615.330767' 2025-01-23 10:12:20 (20997): Status Report: CPU Time: '4568.720000' 2025-01-23 10:13:17 (20997): VM state change detected. (old = 'running', new = 'paused') 2025-01-23 10:13:37 (20997): VM state change detected. (old = 'paused', new = 'running') 2025-01-23 10:33:08 (20997): VM state change detected. (old = 'running', new = 'paused') 2025-01-23 10:33:29 (20997): VM state change detected. (old = 'paused', new = 'running') 2025-01-23 11:03:22 (20997): VM state change detected. (old = 'running', new = 'paused') 2025-01-23 11:03:42 (20997): VM state change detected. (old = 'paused', new = 'running') 2025-01-23 11:21:33 (20997): VM state change detected. (old = 'running', new = 'paused') 2025-01-23 11:21:54 (20997): VM state change detected. (old = 'paused', new = 'running') 2025-01-23 11:50:56 (20997): VM state change detected. (old = 'running', new = 'paused') 2025-01-23 11:51:16 (20997): VM state change detected. (old = 'paused', new = 'running') 2025-01-23 11:53:06 (20997): Status Report: Job Duration: '864000.000000' 2025-01-23 11:53:06 (20997): Status Report: Elapsed Time: '821615.330767' 2025-01-23 11:53:06 (20997): Status Report: CPU Time: '4598.470000' 2025-01-23 12:22:49 (20997): VM state change detected. (old = 'running', new = 'paused') 2025-01-23 12:23:09 (20997): VM state change detected. (old = 'paused', new = 'running') 2025-01-23 12:41:11 (20997): VM state change detected. (old = 'running', new = 'paused') 2025-01-23 12:41:31 (20997): VM state change detected. (old = 'paused', new = 'running') 2025-01-23 13:09:54 (20997): VM state change detected. (old = 'running', new = 'paused') 2025-01-23 13:10:13 (20997): VM state change detected. (old = 'paused', new = 'running') 2025-01-23 13:19:04 (20997): VM state change detected. (old = 'running', new = 'paused') 2025-01-23 13:19:25 (20997): VM state change detected. (old = 'paused', new = 'running') 2025-01-23 13:33:30 (20997): Status Report: Job Duration: '864000.000000' 2025-01-23 13:33:30 (20997): Status Report: Elapsed Time: '827615.330767' 2025-01-23 13:33:30 (20997): Status Report: CPU Time: '4628.020000' 2025-01-23 13:39:37 (20997): VM state change detected. (old = 'running', new = 'paused') 2025-01-23 13:39:57 (20997): VM state change detected. (old = 'paused', new = 'running') 2025-01-23 13:46:47 (20997): VM state change detected. (old = 'running', new = 'paused') 2025-01-23 13:47:07 (20997): VM state change detected. (old = 'paused', new = 'running') 2025-01-23 13:52:48 (20997): VM state change detected. (old = 'running', new = 'paused') 2025-01-23 13:53:08 (20997): VM state change detected. (old = 'paused', new = 'running') 2025-01-23 14:01:29 (20997): VM state change detected. (old = 'running', new = 'paused') 2025-01-23 14:01:48 (20997): VM state change detected. (old = 'paused', new = 'running') 2025-01-23 14:10:09 (20997): VM state change detected. (old = 'running', new = 'paused') 2025-01-23 14:10:29 (20997): VM state change detected. (old = 'paused', new = 'running') 2025-01-23 14:19:00 (20997): VM state change detected. (old = 'running', new = 'paused') 2025-01-23 14:19:20 (20997): VM state change detected. (old = 'paused', new = 'running') 2025-01-23 14:27:41 (20997): VM state change detected. (old = 'running', new = 'paused') 2025-01-23 14:28:01 (20997): VM state change detected. (old = 'paused', new = 'running') 2025-01-23 14:33:22 (20997): VM state change detected. (old = 'running', new = 'paused') 2025-01-23 14:33:42 (20997): VM state change detected. (old = 'paused', new = 'running') 2025-01-23 14:54:14 (20997): VM state change detected. (old = 'running', new = 'paused') 2025-01-23 14:54:34 (20997): VM state change detected. (old = 'paused', new = 'running') 2025-01-23 15:15:38 (20997): Status Report: Job Duration: '864000.000000' 2025-01-23 15:15:38 (20997): Status Report: Elapsed Time: '833615.330767' 2025-01-23 15:15:38 (20997): Status Report: CPU Time: '4658.010000' 2025-01-23 16:01:42 (20997): VM state change detected. (old = 'running', new = 'paused') 2025-01-23 16:02:02 (20997): VM state change detected. (old = 'paused', new = 'running') 2025-01-23 16:10:13 (20997): VM state change detected. (old = 'running', new = 'paused') 2025-01-23 16:10:33 (20997): VM state change detected. (old = 'paused', new = 'running') 2025-01-23 16:26:55 (20997): VM state change detected. (old = 'running', new = 'paused') 2025-01-23 16:27:15 (20997): VM state change detected. (old = 'paused', new = 'running') 2025-01-23 16:43:47 (20997): VM state change detected. (old = 'running', new = 'paused') 2025-01-23 16:44:07 (20997): VM state change detected. (old = 'paused', new = 'running') 2025-01-23 16:56:02 (20997): Status Report: Job Duration: '864000.000000' 2025-01-23 16:56:02 (20997): Status Report: Elapsed Time: '839615.330767' 2025-01-23 16:56:02 (20997): Status Report: CPU Time: '4685.150000' 2025-01-23 17:00:39 (20997): VM state change detected. (old = 'running', new = 'paused') 2025-01-23 17:00:59 (20997): VM state change detected. (old = 'paused', new = 'running') 2025-01-23 18:15:37 (20997): VM state change detected. (old = 'running', new = 'paused') 2025-01-23 18:15:56 (20997): VM state change detected. (old = 'paused', new = 'running') 2025-01-23 18:35:43 (20997): Status Report: Job Duration: '864000.000000' 2025-01-23 18:35:43 (20997): Status Report: Elapsed Time: '845615.330767' 2025-01-23 18:35:43 (20997): Status Report: CPU Time: '4711.350000' 2025-01-23 18:47:20 (20997): VM state change detected. (old = 'running', new = 'paused') 2025-01-23 18:47:39 (20997): VM state change detected. (old = 'paused', new = 'running') 2025-01-23 19:19:53 (20997): VM state change detected. (old = 'running', new = 'paused') 2025-01-23 19:20:13 (20997): VM state change detected. (old = 'paused', new = 'running') 2025-01-23 19:28:34 (20997): VM state change detected. (old = 'running', new = 'paused') 2025-01-23 19:28:53 (20997): VM state change detected. (old = 'paused', new = 'running') 2025-01-23 19:46:56 (20997): VM state change detected. (old = 'running', new = 'paused') 2025-01-23 19:47:15 (20997): VM state change detected. (old = 'paused', new = 'running') 2025-01-23 20:08:19 (20997): VM state change detected. (old = 'running', new = 'paused') 2025-01-23 20:08:39 (20997): VM state change detected. (old = 'paused', new = 'running') 2025-01-23 20:16:28 (20997): Status Report: Job Duration: '864000.000000' 2025-01-23 20:16:28 (20997): Status Report: Elapsed Time: '851615.330767' 2025-01-23 20:16:28 (20997): Status Report: CPU Time: '4738.680000' 2025-01-23 20:27:20 (20997): VM state change detected. (old = 'running', new = 'paused') 2025-01-23 20:27:41 (20997): VM state change detected. (old = 'paused', new = 'running') 2025-01-24 00:42:38 (5458): vboxwrapper version 26207 2025-01-24 00:42:38 (5458): BOINC client version: 8.0.2 2025-01-24 00:42:38 (5458): Detected: VirtualBox VboxManage Interface (Version: 7.1.6) 2025-01-24 00:42:38 (5458): Detected: Heartbeat check (file: 'heartbeat' every 1200.000000 seconds) 2025-01-24 00:42:39 (5458): Guest Log: BIOS: VirtualBox 7.1.6 2025-01-24 00:42:39 (5458): Guest Log: CPUID EDX: 0x178bfbff 2025-01-24 00:42:39 (5458): Guest Log: BIOS: No PCI IDE controller, not probing IDE 2025-01-24 00:42:39 (5458): Guest Log: BIOS: AHCI 0-P#0: PCHS=16383/16/63 LCHS=1024/255/63 0x0000000002800000 sectors 2025-01-24 00:42:39 (5458): Guest Log: BIOS: Boot : bseqnr=1, bootseq=0032 2025-01-24 00:42:39 (5458): Guest Log: BIOS: Booting from Hard Disk... 2025-01-24 00:42:39 (5458): Guest Log: BIOS: KBD: unsupported int 16h function 03 2025-01-24 00:42:39 (5458): Guest Log: BIOS: AX=0305 BX=0000 CX=0000 DX=0000 2025-01-24 00:42:39 (5458): Guest Log: vgdrvHeartbeatInit: Setting up heartbeat to trigger every 2000 milliseconds 2025-01-24 00:42:39 (5458): Guest Log: vboxguest: misc device minor 56, IRQ 20, I/O port d020, MMIO at 00000000f0400000 (size 0x400000) 2025-01-24 00:42:39 (5458): Guest Log: VBoxService 5.2.6 r120293 (verbosity: 0) linux.amd64 (Jan 15 2018 14:51:00) release log 2025-01-24 00:42:39 (5458): Guest Log: 00:00:00.000075 main Log opened 2025-01-23T05:10:40.764697000Z 2025-01-24 00:42:39 (5458): Guest Log: 00:00:00.000145 main OS Product: Linux 2025-01-24 00:42:39 (5458): Guest Log: 00:00:00.000169 main OS Release: 4.14.76-13.cernvm.x86_64 2025-01-24 00:42:39 (5458): Guest Log: 00:00:00.000191 main OS Version: #1 SMP Tue Oct 16 18:26:15 CEST 2018 2025-01-24 00:42:39 (5458): Guest Log: 00:00:00.000209 main Executable: /usr/sbin/VBoxService 2025-01-24 00:42:39 (5458): Guest Log: 00:00:00.000209 main Process ID: 3156 2025-01-24 00:42:39 (5458): Guest Log: 00:00:00.000210 main Package type: LINUX_64BITS_GENERIC 2025-01-24 00:42:39 (5458): Guest Log: 00:00:00.002350 main 5.2.6 r120293 started. Verbose level = 0 2025-01-24 00:42:39 (5458): Guest Log: 00:11:04 EST -05:00 2025-01-23: cranky: [INFO] Detected Theory App 2025-01-24 00:42:39 (5458): Guest Log: 00:11:04 EST -05:00 2025-01-23: cranky: [INFO] Checking CVMFS. 2025-01-24 00:42:39 (5458): Guest Log: Probing /cvmfs/sft.cern.ch... OK 2025-01-24 00:42:39 (5458): Guest Log: VERSION PID UPTIME(M) MEM(K) REVISION EXPIRES(M) NOCATALOGS CACHEUSE(K) CACHEMAX(K) NOFDUSE NOFDMAX NOIOERR NOOPEN HITRATE(%) RX(K) SPEED(K/S) HOST PROXY ONLINE 2025-01-24 00:42:39 (5458): Guest Log: 2.5.2.0 4052 0 27392 15697 2 1 244090 4096000 0 65024 1 0 n/a 1 3 http://s1asgc-cvmfs.openhtc.io:8080/cvmfs/sft.cern.ch http://192.41.231.239:6082 0 2025-01-24 00:42:39 (5458): Guest Log: Probing /cvmfs/grid.cern.ch... OK 2025-01-24 00:42:39 (5458): Guest Log: VERSION PID UPTIME(M) MEM(K) REVISION EXPIRES(M) NOCATALOGS CACHEUSE(K) CACHEMAX(K) NOFDUSE NOFDMAX NOIOERR NOOPEN HITRATE(%) RX(K) SPEED(K/S) HOST PROXY ONLINE 2025-01-24 00:42:39 (5458): Guest Log: 2.5.2.0 4005 0 25468 10299 2 2 244090 4096000 0 65024 3 2 0 1 2 http://s1bnl-cvmfs.openhtc.io/cvmfs/grid.cern.ch http://192.41.231.239:6082 0 2025-01-24 00:42:39 (5458): Guest Log: Probing /cvmfs/cernvm-prod.cern.ch... OK 2025-01-24 00:42:39 (5458): Guest Log: VERSION PID UPTIME(M) MEM(K) REVISION EXPIRES(M) NOCATALOGS CACHEUSE(K) CACHEMAX(K) NOFDUSE NOFDMAX NOIOERR NOOPEN HITRATE(%) RX(K) SPEED(K/S) HOST PROXY ONLINE 2025-01-24 00:42:39 (5458): Guest Log: 2.5.2.0 3983 0 25160 245 2 1 244090 4096000 0 65024 1 0 n/a 1 0 http://s1asgc-cvmfs.openhtc.io:8080/cvmfs/cernvm-prod.cern.ch http://192.41.231.239:6082 0 2025-01-24 00:42:39 (5458): Guest Log: Probing /cvmfs/alice.cern.ch... OK 2025-01-24 00:42:39 (5458): Guest Log: VERSION PID UPTIME(M) MEM(K) REVISION EXPIRES(M) NOCATALOGS CACHEUSE(K) CACHEMAX(K) NOFDUSE NOFDMAX NOIOERR NOOPEN HITRATE(%) RX(K) SPEED(K/S) HOST PROXY ONLINE 2025-01-24 00:42:39 (5458): Guest Log: 2.5.2.0 4027 0 28760 5181 2 1 244090 4096000 0 65024 1 0 n/a 1 2 http://s1asgc-cvmfs.openhtc.io:8080/cvmfs/alice.cern.ch http://192.41.231.239:6082 0 2025-01-24 00:42:39 (5458): Guest Log: 00:11:07 EST -05:00 2025-01-23: cranky: [INFO] Checking runc. 2025-01-24 00:42:39 (5458): Guest Log: 00:11:07 EST -05:00 2025-01-23: cranky: [INFO] Creating the filesystem. 2025-01-24 00:42:39 (5458): Guest Log: 00:11:07 EST -05:00 2025-01-23: cranky: [INFO] Using /cvmfs/cernvm-prod.cern.ch/cvm4 2025-01-24 00:42:39 (5458): Guest Log: 00:11:08 EST -05:00 2025-01-23: cranky: [INFO] Updating config.json. 2025-01-24 00:42:39 (5458): Guest Log: 00:11:08 EST -05:00 2025-01-23: cranky: [INFO] Running Container 'runc'. 2025-01-24 00:42:39 (5458): Guest Log: standard_init_linux.go:203: exec user process caused "input/output error" 2025-01-24 00:42:39 (5458): Guest Log: 00:11:08 EST -05:00 2025-01-23: cranky: [INFO] Container 'runc' finished with status code 1. 2025-01-24 00:42:39 (5458): Guest Log: 00:11:08 EST -05:00 2025-01-23: cranky: [INFO] Preparing output. 2025-01-24 00:42:39 (5458): Guest Log: 00:11:08 EST -05:00 2025-01-23: cranky: [ERROR] No output found. 2025-01-24 00:42:39 (5458): Starting VM using VBoxManage interface. (boinc_e204efab051646d5, slot#23) 2025-01-24 00:42:40 (5458): Successfully started VM. (PID = '6328') 2025-01-24 00:42:40 (5458): Reporting VM Process ID to BOINC. 2025-01-24 00:42:40 (5458): Guest Log: BIOS: VirtualBox 7.1.6 2025-01-24 00:42:40 (5458): Guest Log: CPUID EDX: 0x178bfbff 2025-01-24 00:42:40 (5458): Guest Log: BIOS: No PCI IDE controller, not probing IDE 2025-01-24 00:42:40 (5458): Guest Log: BIOS: AHCI 0-P#0: PCHS=16383/16/63 LCHS=1024/255/63 0x0000000002800000 sectors 2025-01-24 00:42:40 (5458): VM state change detected. (old = 'poweredoff', new = 'running') 2025-01-24 00:42:40 (5458): Detected: Web Application Enabled (http://localhost:47773) 2025-01-24 00:42:40 (5458): Status Report: Job Duration: '864000.000000' 2025-01-24 00:42:40 (5458): Status Report: Elapsed Time: '852733.330767' 2025-01-24 00:42:40 (5458): Status Report: CPU Time: '4743.940000' 2025-01-24 00:42:40 (5458): Preference change detected 2025-01-24 00:42:40 (5458): Setting CPU throttle for VM. (100%) 2025-01-24 00:42:40 (5458): Setting checkpoint interval to 600 seconds. (Higher value of (Preference: 120 seconds) or (Vbox_job.xml: 600 seconds)) 2025-01-24 00:42:42 (5458): Guest Log: BIOS: Boot : bseqnr=1, bootseq=0032 2025-01-24 00:42:42 (5458): Guest Log: BIOS: Booting from Hard Disk... 2025-01-24 00:42:45 (5458): Guest Log: BIOS: KBD: unsupported int 16h function 03 2025-01-24 00:42:45 (5458): Guest Log: BIOS: AX=0305 BX=0000 CX=0000 DX=0000 2025-01-24 00:43:56 (5458): Guest Log: vgdrvHeartbeatInit: Setting up heartbeat to trigger every 2000 milliseconds 2025-01-24 00:43:56 (5458): Guest Log: vboxguest: misc device minor 56, IRQ 20, I/O port d020, MMIO at 00000000f0400000 (size 0x400000) 2025-01-24 00:43:58 (5458): Guest Log: VBoxService 5.2.6 r120293 (verbosity: 0) linux.amd64 (Jan 15 2018 14:51:00) release log 2025-01-24 00:43:58 (5458): Guest Log: 00:00:00.000055 main Log opened 2025-01-24T05:43:58.561370000Z 2025-01-24 00:43:58 (5458): Guest Log: 00:00:00.000116 main OS Product: Linux 2025-01-24 00:43:58 (5458): Guest Log: 00:00:00.000139 main OS Release: 4.14.76-13.cernvm.x86_64 2025-01-24 00:43:58 (5458): Guest Log: 00:00:00.000175 main OS Version: #1 SMP Tue Oct 16 18:26:15 CEST 2018 2025-01-24 00:43:58 (5458): Guest Log: 00:00:00.000199 main Executable: /usr/sbin/VBoxService 2025-01-24 00:43:58 (5458): Guest Log: 00:00:00.000200 main Process ID: 3158 2025-01-24 00:43:58 (5458): Guest Log: 00:00:00.000200 main Package type: LINUX_64BITS_GENERIC 2025-01-24 00:43:58 (5458): Guest Log: 00:00:00.001947 main 5.2.6 r120293 started. Verbose level = 0 2025-01-24 00:44:19 (5458): Guest Log: 00:44:19 EST -05:00 2025-01-24: cranky: [INFO] Detected Theory App 2025-01-24 00:44:19 (5458): Guest Log: 00:44:19 EST -05:00 2025-01-24: cranky: [INFO] Checking CVMFS. 2025-01-24 00:44:19 (5458): Guest Log: Probing /cvmfs/sft.cern.ch... OK 2025-01-24 00:44:20 (5458): Guest Log: VERSION PID UPTIME(M) MEM(K) REVISION EXPIRES(M) NOCATALOGS CACHEUSE(K) CACHEMAX(K) NOFDUSE NOFDMAX NOIOERR NOOPEN HITRATE(%) RX(K) SPEED(K/S) HOST PROXY ONLINE 2025-01-24 00:44:20 (5458): Guest Log: 2.5.2.0 4056 0 27172 15697 2 1 244090 4096000 0 65024 1 0 n/a 1 3 http://s1asgc-cvmfs.openhtc.io:8080/cvmfs/sft.cern.ch http://192.41.231.239:6082 0 2025-01-24 00:44:20 (5458): Guest Log: Probing /cvmfs/grid.cern.ch... OK 2025-01-24 00:44:21 (5458): Guest Log: VERSION PID UPTIME(M) MEM(K) REVISION EXPIRES(M) NOCATALOGS CACHEUSE(K) CACHEMAX(K) NOFDUSE NOFDMAX NOIOERR NOOPEN HITRATE(%) RX(K) SPEED(K/S) HOST PROXY ONLINE 2025-01-24 00:44:21 (5458): Guest Log: 2.5.2.0 4035 0 27244 10299 2 2 244090 4096000 0 65024 3 2 0 1 2 http://s1bnl-cvmfs.openhtc.io/cvmfs/grid.cern.ch http://192.41.231.239:6082 0 2025-01-24 00:44:21 (5458): Guest Log: Probing /cvmfs/cernvm-prod.cern.ch... OK 2025-01-24 00:44:22 (5458): Guest Log: VERSION PID UPTIME(M) MEM(K) REVISION EXPIRES(M) NOCATALOGS CACHEUSE(K) CACHEMAX(K) NOFDUSE NOFDMAX NOIOERR NOOPEN HITRATE(%) RX(K) SPEED(K/S) HOST PROXY ONLINE 2025-01-24 00:44:22 (5458): Guest Log: 2.5.2.0 4009 0 27208 245 2 1 244090 4096000 0 65024 1 0 n/a 1 1 http://s1asgc-cvmfs.openhtc.io:8080/cvmfs/cernvm-prod.cern.ch http://192.41.231.239:6082 0 2025-01-24 00:44:22 (5458): Guest Log: Probing /cvmfs/alice.cern.ch... OK 2025-01-24 00:44:22 (5458): Guest Log: VERSION PID UPTIME(M) MEM(K) REVISION EXPIRES(M) NOCATALOGS CACHEUSE(K) CACHEMAX(K) NOFDUSE NOFDMAX NOIOERR NOOPEN HITRATE(%) RX(K) SPEED(K/S) HOST PROXY ONLINE 2025-01-24 00:44:22 (5458): Guest Log: 2.5.2.0 3986 0 26732 5181 2 1 244090 4096000 0 65024 1 0 n/a 1 0 http://s1asgc-cvmfs.openhtc.io:8080/cvmfs/alice.cern.ch http://192.41.231.239:6082 0 2025-01-24 00:44:22 (5458): Guest Log: 00:44:22 EST -05:00 2025-01-24: cranky: [INFO] Checking runc. 2025-01-24 00:44:22 (5458): Guest Log: 00:44:22 EST -05:00 2025-01-24: cranky: [INFO] Creating the filesystem. 2025-01-24 00:44:22 (5458): Guest Log: 00:44:22 EST -05:00 2025-01-24: cranky: [INFO] Using /cvmfs/cernvm-prod.cern.ch/cvm4 2025-01-24 00:44:23 (5458): Guest Log: 00:44:22 EST -05:00 2025-01-24: cranky: [INFO] Updating config.json. 2025-01-24 00:44:23 (5458): Guest Log: 00:44:22 EST -05:00 2025-01-24: cranky: [INFO] Running Container 'runc'. 2025-01-24 00:44:23 (5458): Guest Log: standard_init_linux.go:203: exec user process caused "input/output error" 2025-01-24 00:44:23 (5458): Guest Log: 00:44:22 EST -05:00 2025-01-24: cranky: [INFO] Container 'runc' finished with status code 1. 2025-01-24 00:44:23 (5458): Guest Log: 00:44:22 EST -05:00 2025-01-24: cranky: [INFO] Preparing output. 2025-01-24 00:44:23 (5458): Guest Log: 00:44:22 EST -05:00 2025-01-24: cranky: [ERROR] No output found. 2025-01-24 00:52:57 (5458): VM state change detected. (old = 'running', new = 'paused') 2025-01-24 00:53:17 (5458): VM state change detected. (old = 'paused', new = 'running') 2025-01-24 01:26:10 (5458): VM state change detected. (old = 'running', new = 'paused') 2025-01-24 01:26:30 (5458): VM state change detected. (old = 'paused', new = 'running') 2025-01-24 01:33:50 (5458): VM state change detected. (old = 'running', new = 'paused') 2025-01-24 01:34:11 (5458): VM state change detected. (old = 'paused', new = 'running') 2025-01-24 01:40:02 (5458): VM state change detected. (old = 'running', new = 'paused') 2025-01-24 01:40:21 (5458): VM state change detected. (old = 'paused', new = 'running') 2025-01-24 01:47:42 (5458): VM state change detected. (old = 'running', new = 'paused') 2025-01-24 01:48:02 (5458): VM state change detected. (old = 'paused', new = 'running') 2025-01-24 01:57:23 (5458): VM state change detected. (old = 'running', new = 'paused') 2025-01-24 01:57:43 (5458): VM state change detected. (old = 'paused', new = 'running') 2025-01-24 02:24:41 (5458): Status Report: Job Duration: '864000.000000' 2025-01-24 02:24:41 (5458): Status Report: Elapsed Time: '858733.330767' 2025-01-24 02:24:41 (5458): Status Report: CPU Time: '4785.980000' 2025-01-24 03:51:35 (5458): Powerin
©2025 CERN