| Name | Theory_2848-4516071-1017_1 |
| Workunit | 232468243 |
| Created | 21 May 2025, 18:07:48 UTC |
| Sent | 21 May 2025, 22:59:05 UTC |
| Report deadline | 1 Jun 2025, 22:59:05 UTC |
| Received | 3 Jun 2025, 3:07:52 UTC |
| Server state | Over |
| Outcome | Success |
| Client state | Done |
| Exit status | 0 (0x00000000) |
| Computer ID | 10842482 |
| Run time | 3 hours 47 min 51 sec |
| CPU time | 3 hours 4 min 3 sec |
| Validate state | Valid |
| Credit | 135.17 |
| Device peak FLOPS | 4.27 GFLOPS |
| Application version | Theory Simulation v300.95 (vbox64_theory) windows_x86_64 |
| Peak working set size | 140.03 MB |
| Peak swap size | 89.68 MB |
| Peak disk usage | 1.59 GB |
Stderr output
<core_client_version>7.24.1</core_client_version> <![CDATA[ <stderr_txt> 2025-05-26 12:07:25 (25484): vboxwrapper version 26210 2025-05-26 12:07:25 (25484): BOINC client version: 7.24.1 2025-05-26 12:07:25 (25484): Detected: VirtualBox VboxManage Interface (Version: 7.0.6) 2025-05-26 12:07:25 (25484): Detected: Heartbeat check (file: 'heartbeat' every 1800.000000 seconds) 2025-05-26 12:07:25 (25484): Successfully copied 'init_data.xml' to the shared directory. 2025-05-26 12:07:25 (25484): Successfully copied 'input' to the shared directory. 2025-05-26 12:07:26 (25484): Create VM. (boinc_1fb8823fe6c4e059, slot#5) 2025-05-26 12:07:26 (25484): Setting Memory Size for VM. (630MB) 2025-05-26 12:07:27 (25484): Setting CPU Count for VM. (1) 2025-05-26 12:07:27 (25484): Setting Chipset Options for VM. 2025-05-26 12:07:27 (25484): Setting Graphics Controller Options for VM. (Driver: VBoxVGA, 16MB) 2025-05-26 12:07:27 (25484): Setting Boot Options for VM. 2025-05-26 12:07:28 (25484): Setting Network Configuration for NAT. (Driver: virtio) 2025-05-26 12:07:28 (25484): Enabling VM Network Access. 2025-05-26 12:07:29 (25484): Disabling USB Support for VM. 2025-05-26 12:07:29 (25484): Disabling COM Port Support for VM. 2025-05-26 12:07:29 (25484): Disabling LPT Port Support for VM. 2025-05-26 12:07:30 (25484): Disabling Audio Support for VM. 2025-05-26 12:07:30 (25484): Disabling Clipboard Support for VM. 2025-05-26 12:07:30 (25484): Disabling Drag and Drop Support for VM. 2025-05-26 12:07:30 (25484): Adding storage controller(s) to VM. 2025-05-26 12:07:31 (25484): Adding virtual disk drive to VM. (Theory_2025_04_17_prod.vdi) 2025-05-26 12:07:31 (25484): Adding VirtualBox Guest Additions to VM. 2025-05-26 12:07:32 (25484): Adding network bandwidth throttle group to VM. (Defaulting to 1024GB) 2025-05-26 12:07:32 (25484): forwarding host port 7276 to guest port 80 2025-05-26 12:07:32 (25484): Enabling remote desktop for VM. 2025-05-26 12:07:33 (25484): Required extension pack not installed, remote desktop not enabled. 2025-05-26 12:07:33 (25484): Enabling shared directory for VM. 2025-05-26 12:07:33 (25484): Starting VM using VBoxManage interface. (boinc_1fb8823fe6c4e059, slot#5) 2025-05-26 12:07:41 (25484): Successfully started VM. (PID = '14688') 2025-05-26 12:07:41 (25484): Reporting VM Process ID to BOINC. 2025-05-26 12:07:41 (25484): Guest Log: BIOS: VirtualBox 7.0.6 2025-05-26 12:07:41 (25484): Guest Log: CPUID EDX: 0x178bfbff 2025-05-26 12:07:41 (25484): Guest Log: BIOS: No PCI IDE controller, not probing IDE 2025-05-26 12:07:41 (25484): Guest Log: BIOS: AHCI 0-P#0: PCHS=16383/16/63 LCHS=1024/255/63 0x0000000001400000 sectors 2025-05-26 12:07:41 (25484): VM state change detected. (old = 'poweredoff', new = 'running') 2025-05-26 12:07:41 (25484): Detected: Web Application Enabled (http://localhost:7276) 2025-05-26 12:07:42 (25484): VM state change detected. (old = 'running', new = 'paused') 2025-05-26 12:08:16 (25484): Preference change detected 2025-05-26 12:08:16 (25484): Setting CPU throttle for VM. (50%) 2025-05-26 12:08:16 (25484): Setting checkpoint interval to 600 seconds. (Higher value of (Preference: 60 seconds) or (Vbox_job.xml: 600 seconds)) 2025-05-26 12:08:17 (25484): VM state change detected. (old = 'paused', new = 'running') 2025-05-26 12:08:18 (25484): Guest Log: BIOS: Boot : bseqnr=1, bootseq=0032 2025-05-26 12:08:18 (25484): Guest Log: BIOS: Booting from Hard Disk... 2025-05-26 12:08:26 (25484): VM state change detected. (old = 'running', new = 'paused') 2025-05-26 12:09:06 (25484): VM state change detected. (old = 'paused', new = 'running') 2025-05-26 12:09:07 (25484): Guest Log: BIOS: KBD: unsupported int 16h function 03 2025-05-26 12:09:07 (25484): Guest Log: BIOS: AX=0305 BX=0000 CX=0000 DX=0000 2025-05-26 12:09:07 (25484): Guest Log: int13_harddisk_ext: function 41, unmapped device for ELDL=81 2025-05-26 12:09:07 (25484): Guest Log: int13_harddisk: function 02, unmapped device for ELDL=81 2025-05-26 12:09:07 (25484): Guest Log: int13_harddisk_ext: function 41, unmapped device for ELDL=82 2025-05-26 12:09:07 (25484): Guest Log: int13_harddisk: function 02, unmapped device for ELDL=82 2025-05-26 12:09:07 (25484): Guest Log: int13_harddisk_ext: function 41, unmapped device for ELDL=83 2025-05-26 12:09:07 (25484): Guest Log: int13_harddisk: function 02, unmapped device for ELDL=83 2025-05-26 12:09:07 (25484): Guest Log: int13_harddisk_ext: function 41, unmapped device for ELDL=84 2025-05-26 12:09:07 (25484): Guest Log: int13_harddisk: function 02, unmapped device for ELDL=84 2025-05-26 12:09:07 (25484): Guest Log: int13_harddisk_ext: function 41, unmapped device for ELDL=85 2025-05-26 12:09:07 (25484): Guest Log: int13_harddisk: function 02, unmapped device for ELDL=85 2025-05-26 12:09:07 (25484): Guest Log: int13_harddisk_ext: function 41, unmapped device for ELDL=86 2025-05-26 12:09:07 (25484): Guest Log: int13_harddisk: function 02, unmapped device for ELDL=86 2025-05-26 12:09:07 (25484): Guest Log: int13_harddisk_ext: function 41, unmapped device for ELDL=87 2025-05-26 12:09:07 (25484): Guest Log: int13_harddisk: function 02, unmapped device for ELDL=87 2025-05-26 12:09:07 (25484): Guest Log: int13_harddisk_ext: function 41, unmapped device for ELDL=88 2025-05-26 12:09:07 (25484): Guest Log: int13_harddisk: function 02, unmapped device for ELDL=88 2025-05-26 12:09:07 (25484): Guest Log: int13_harddisk_ext: function 41, unmapped device for ELDL=89 2025-05-26 12:09:07 (25484): Guest Log: int13_harddisk: function 02, unmapped device for ELDL=89 2025-05-26 12:09:07 (25484): Guest Log: int13_harddisk_ext: function 41, unmapped device for ELDL=8a 2025-05-26 12:09:07 (25484): Guest Log: int13_harddisk: function 02, unmapped device for ELDL=8a 2025-05-26 12:09:07 (25484): Guest Log: int13_harddisk_ext: function 41, unmapped device for ELDL=8b 2025-05-26 12:09:07 (25484): Guest Log: int13_harddisk: function 02, unmapped device for ELDL=8b 2025-05-26 12:09:07 (25484): Guest Log: int13_harddisk_ext: function 41, unmapped device for ELDL=8c 2025-05-26 12:09:07 (25484): Guest Log: int13_harddisk: function 02, unmapped device for ELDL=8c 2025-05-26 12:09:07 (25484): Guest Log: int13_harddisk_ext: function 41, unmapped device for ELDL=8d 2025-05-26 12:09:07 (25484): Guest Log: int13_harddisk: function 02, unmapped device for ELDL=8d 2025-05-26 12:09:07 (25484): Guest Log: int13_harddisk_ext: function 41, unmapped device for ELDL=8e 2025-05-26 12:09:07 (25484): Guest Log: int13_harddisk: function 02, unmapped device for ELDL=8e 2025-05-26 12:09:07 (25484): Guest Log: int13_harddisk_ext: function 41, unmapped device for ELDL=8f 2025-05-26 12:09:07 (25484): Guest Log: int13_harddisk: function 02, unmapped device for ELDL=8f 2025-05-26 12:09:16 (25484): VM state change detected. (old = 'running', new = 'paused') 2025-05-26 12:09:37 (25484): VM state change detected. (old = 'paused', new = 'running') 2025-05-26 12:09:46 (25484): VM state change detected. (old = 'running', new = 'paused') 2025-05-26 12:10:06 (25484): Guest Log: vgdrvHeartbeatInit: Setting up heartbeat to trigger every 2000 milliseconds 2025-05-26 12:10:06 (25484): Guest Log: Host supports full mouse state reporting, switching to extended mouse integration protocol 2025-05-26 12:10:06 (25484): Guest Log: vboxguest: Successfully loaded version 7.1.6 r167084 2025-05-26 12:10:06 (25484): Guest Log: vboxguest: misc device minor 123, IRQ 20, I/O port d020, MMIO at 00000000f0400000 (size 0x400000) 2025-05-26 12:10:06 (25484): Guest Log: vboxsf: g_fHostFeatures=0x8000000f g_fSfFeatures=0x1 g_uSfLastFunction=29 2025-05-26 12:10:06 (25484): Guest Log: vboxsf: Successfully loaded version 7.1.6 r167084 on 5.14.0-503.14.1.el9_5.x86_64 (LINUX_VERSION_CODE=0x50e00) 2025-05-26 12:10:06 (25484): VM state change detected. (old = 'paused', new = 'running') 2025-05-26 12:10:16 (25484): VM state change detected. (old = 'running', new = 'paused') 2025-05-26 12:10:57 (25484): VM state change detected. (old = 'paused', new = 'running') 2025-05-26 12:11:06 (25484): VM state change detected. (old = 'running', new = 'paused') 2025-05-26 12:11:26 (25484): VM state change detected. (old = 'paused', new = 'running') 2025-05-26 12:11:30 (25484): Guest Log: Could not find a local HTTP proxy 2025-05-26 12:11:30 (25484): Guest Log: CVMFS and Frontier will have to use DIRECT connections 2025-05-26 12:11:30 (25484): Guest Log: This makes the application less efficient 2025-05-26 12:11:30 (25484): Guest Log: It also puts higher load on the project servers 2025-05-26 12:11:30 (25484): Guest Log: Setting up a local HTTP proxy is highly recommended 2025-05-26 12:11:30 (25484): Guest Log: Advice can be found in the project forum 2025-05-26 12:11:30 (25484): Guest Log: Using custom CVMFS. 2025-05-26 12:11:30 (25484): Guest Log: Probing CVMFS repositories ... 2025-05-26 12:11:37 (25484): VM state change detected. (old = 'running', new = 'paused') 2025-05-26 12:11:57 (25484): VM state change detected. (old = 'paused', new = 'running') 2025-05-26 12:12:07 (25484): VM state change detected. (old = 'running', new = 'paused') 2025-05-26 12:13:07 (25484): VM state change detected. (old = 'paused', new = 'running') 2025-05-26 12:13:17 (25484): VM state change detected. (old = 'running', new = 'paused') 2025-05-26 12:13:37 (25484): VM state change detected. (old = 'paused', new = 'running') 2025-05-26 12:13:47 (25484): VM state change detected. (old = 'running', new = 'paused') 2025-05-26 12:14:07 (25484): VM state change detected. (old = 'paused', new = 'running') 2025-05-26 12:14:17 (25484): VM state change detected. (old = 'running', new = 'paused') 2025-05-26 12:14:57 (25484): VM state change detected. (old = 'paused', new = 'running') 2025-05-26 12:15:03 (25484): Guest Log: Probing /cvmfs/alice.cern.ch... OK 2025-05-26 12:15:03 (25484): Guest Log: Probing /cvmfs/cvmfs-config.cern.ch... OK 2025-05-26 12:15:03 (25484): Guest Log: Probing /cvmfs/grid.cern.ch... OK 2025-05-26 12:15:03 (25484): Guest Log: Probing /cvmfs/sft.cern.ch... OK 2025-05-26 12:15:07 (25484): VM state change detected. (old = 'running', new = 'paused') 2025-05-26 12:15:47 (25484): VM state change detected. (old = 'paused', new = 'running') 2025-05-26 12:15:50 (25484): Guest Log: Excerpt from "cvmfs_config stat": 2025-05-26 12:15:50 (25484): Guest Log: VERSION HOST PROXY 2025-05-26 12:15:50 (25484): Guest Log: 2.12.7.0 http://s1ral-cvmfs.openhtc.io DIRECT 2025-05-26 12:15:50 (25484): Guest Log: ****************************************************************** 2025-05-26 12:15:50 (25484): Guest Log: IMPORTANT HINT(S)! 2025-05-26 12:15:50 (25484): Guest Log: ****************************************************************** 2025-05-26 12:15:50 (25484): Guest Log: CVMFS server: http://s1ral-cvmfs.openhtc.io 2025-05-26 12:15:50 (25484): Guest Log: CVMFS proxy: DIRECT 2025-05-26 12:15:50 (25484): Guest Log: No local HTTP proxy found. 2025-05-26 12:15:50 (25484): Guest Log: With this setup concurrently running containers can't share 2025-05-26 12:15:50 (25484): Guest Log: a common CVMFS cache. A local HTTP proxy is therefore 2025-05-26 12:15:50 (25484): Guest Log: highly recommended. 2025-05-26 12:15:50 (25484): Guest Log: More info how to configure a local HTTP proxy: 2025-05-26 12:15:50 (25484): Guest Log: https://lhcathome.cern.ch/lhcathome/forum_thread.php?id=5473 2025-05-26 12:15:50 (25484): Guest Log: https://lhcathome.cern.ch/lhcathome/forum_thread.php?id=5474 2025-05-26 12:15:50 (25484): Guest Log: ****************************************************************** 2025-05-26 12:15:50 (25484): Guest Log: Environment HTTP proxy: not set 2025-05-26 12:15:52 (25484): Guest Log: job: htmld=/var/www/lighttpd 2025-05-26 12:15:52 (25484): Guest Log: job: unpack exitcode=0 2025-05-26 12:15:57 (25484): VM state change detected. (old = 'running', new = 'paused') 2025-05-26 12:16:57 (25484): VM state change detected. (old = 'paused', new = 'running') 2025-05-26 12:17:07 (25484): VM state change detected. (old = 'running', new = 'paused') 2025-05-26 12:17:27 (25484): VM state change detected. (old = 'paused', new = 'running') 2025-05-26 12:17:37 (25484): VM state change detected. (old = 'running', new = 'paused') 2025-05-26 12:17:57 (25484): VM state change detected. (old = 'paused', new = 'running') 2025-05-26 12:18:07 (25484): VM state change detected. (old = 'running', new = 'paused') 2025-05-26 12:18:47 (25484): VM state change detected. (old = 'paused', new = 'running') 2025-05-26 12:18:57 (25484): VM state change detected. (old = 'running', new = 'paused') 2025-05-26 12:19:17 (25484): VM state change detected. (old = 'paused', new = 'running') 2025-05-26 12:19:27 (25484): VM state change detected. (old = 'running', new = 'paused') 2025-05-26 12:19:47 (25484): VM state change detected. (old = 'paused', new = 'running') 2025-05-26 12:19:57 (25484): VM state change detected. (old = 'running', new = 'paused') 2025-05-26 12:20:37 (25484): VM state change detected. (old = 'paused', new = 'running') 2025-05-26 12:20:47 (25484): VM state change detected. (old = 'running', new = 'paused') 2025-05-26 12:20:48 (25484): VM state change detected. (old = 'paused', new = 'running') 2025-05-26 13:34:04 (25484): VM state change detected. (old = 'running', new = 'paused') 2025-05-26 13:34:24 (25484): VM state change detected. (old = 'paused', new = 'running') 2025-05-26 13:34:35 (25484): VM state change detected. (old = 'running', new = 'paused') 2025-05-26 13:34:55 (25484): VM state change detected. (old = 'paused', new = 'running') 2025-05-26 13:35:05 (25484): VM state change detected. (old = 'running', new = 'paused') 2025-05-26 13:35:45 (25484): VM state change detected. (old = 'paused', new = 'running') 2025-05-26 13:35:55 (25484): VM state change detected. (old = 'running', new = 'paused') 2025-05-26 13:36:35 (25484): VM state change detected. (old = 'paused', new = 'running') 2025-05-26 13:36:45 (25484): VM state change detected. (old = 'running', new = 'paused') 2025-05-26 13:37:25 (25484): VM state change detected. (old = 'paused', new = 'running') 2025-05-26 13:37:35 (25484): VM state change detected. (old = 'running', new = 'paused') 2025-05-26 13:37:55 (25484): VM state change detected. (old = 'paused', new = 'running') 2025-05-26 13:38:05 (25484): VM state change detected. (old = 'running', new = 'paused') 2025-05-26 13:38:25 (25484): VM state change detected. (old = 'paused', new = 'running') 2025-05-26 13:38:35 (25484): VM state change detected. (old = 'running', new = 'paused') 2025-05-26 13:38:55 (25484): VM state change detected. (old = 'paused', new = 'running') 2025-05-26 13:39:05 (25484): VM state change detected. (old = 'running', new = 'paused') 2025-05-26 13:39:25 (25484): VM state change detected. (old = 'paused', new = 'running') 2025-05-26 13:39:35 (25484): VM state change detected. (old = 'running', new = 'paused') 2025-05-26 13:40:15 (25484): VM state change detected. (old = 'paused', new = 'running') 2025-05-26 13:40:25 (25484): VM state change detected. (old = 'running', new = 'paused') 2025-05-26 13:40:45 (25484): VM state change detected. (old = 'paused', new = 'running') 2025-05-26 13:40:55 (25484): VM state change detected. (old = 'running', new = 'paused') 2025-05-26 13:41:35 (25484): VM state change detected. (old = 'paused', new = 'running') 2025-05-26 13:41:45 (25484): VM state change detected. (old = 'running', new = 'paused') 2025-05-26 13:42:05 (25484): VM state change detected. (old = 'paused', new = 'running') 2025-05-26 13:42:15 (25484): VM state change detected. (old = 'running', new = 'paused') 2025-05-26 13:42:35 (25484): VM state change detected. (old = 'paused', new = 'running') 2025-05-26 13:42:45 (25484): VM state change detected. (old = 'running', new = 'paused') 2025-05-26 13:43:25 (25484): VM state change detected. (old = 'paused', new = 'running') 2025-05-26 13:43:35 (25484): VM state change detected. (old = 'running', new = 'paused') 2025-05-26 13:43:55 (25484): VM state change detected. (old = 'paused', new = 'running') 2025-05-26 13:44:05 (25484): VM state change detected. (old = 'running', new = 'paused') 2025-05-26 13:44:25 (25484): VM state change detected. (old = 'paused', new = 'running') 2025-05-26 13:44:35 (25484): VM state change detected. (old = 'running', new = 'paused') 2025-05-26 13:45:15 (25484): VM state change detected. (old = 'paused', new = 'running') 2025-05-26 13:45:25 (25484): VM state change detected. (old = 'running', new = 'paused') 2025-05-26 13:45:45 (25484): VM state change detected. (old = 'paused', new = 'running') 2025-05-26 13:45:55 (25484): VM state change detected. (old = 'running', new = 'paused') 2025-05-26 13:46:15 (25484): VM state change detected. (old = 'paused', new = 'running') 2025-05-26 13:46:25 (25484): VM state change detected. (old = 'running', new = 'paused') 2025-05-26 13:47:05 (25484): VM state change detected. (old = 'paused', new = 'running') 2025-05-26 13:47:15 (25484): VM state change detected. (old = 'running', new = 'paused') 2025-05-26 13:47:35 (25484): VM state change detected. (old = 'paused', new = 'running') 2025-05-26 13:47:45 (25484): VM state change detected. (old = 'running', new = 'paused') 2025-05-26 13:48:06 (25484): VM state change detected. (old = 'paused', new = 'running') 2025-05-26 13:48:15 (25484): VM state change detected. (old = 'running', new = 'paused') 2025-05-26 13:48:55 (25484): VM state change detected. (old = 'paused', new = 'running') 2025-05-26 13:49:06 (25484): VM state change detected. (old = 'running', new = 'paused') 2025-05-26 13:49:26 (25484): VM state change detected. (old = 'paused', new = 'running') 2025-05-26 13:49:36 (25484): VM state change detected. (old = 'running', new = 'paused') 2025-05-26 13:49:57 (25484): VM state change detected. (old = 'paused', new = 'running') 2025-05-26 13:50:06 (25484): VM state change detected. (old = 'running', new = 'paused') 2025-05-26 13:51:06 (25484): VM state change detected. (old = 'paused', new = 'running') 2025-05-26 13:51:16 (25484): VM state change detected. (old = 'running', new = 'paused') 2025-05-26 13:51:37 (25484): VM state change detected. (old = 'paused', new = 'running') 2025-05-26 13:51:46 (25484): VM state change detected. (old = 'running', new = 'paused') 2025-05-26 13:52:06 (25484): VM state change detected. (old = 'paused', new = 'running') 2025-05-26 13:52:16 (25484): VM state change detected. (old = 'running', new = 'paused') 2025-05-26 13:53:36 (25484): VM state change detected. (old = 'paused', new = 'running') 2025-05-26 13:53:46 (25484): VM state change detected. (old = 'running', new = 'paused') 2025-05-26 13:54:07 (25484): VM state change detected. (old = 'paused', new = 'running') 2025-05-26 13:54:16 (25484): VM state change detected. (old = 'running', new = 'paused') 2025-05-26 13:55:16 (25484): VM state change detected. (old = 'paused', new = 'running') 2025-05-26 13:55:26 (25484): VM state change detected. (old = 'running', new = 'paused') 2025-05-26 13:55:46 (25484): VM state change detected. (old = 'paused', new = 'running') 2025-05-26 13:55:56 (25484): VM state change detected. (old = 'running', new = 'paused') 2025-05-26 13:57:16 (25484): VM state change detected. (old = 'paused', new = 'running') 2025-05-26 13:57:27 (25484): VM state change detected. (old = 'running', new = 'paused') 2025-05-26 13:57:48 (25484): VM state change detected. (old = 'paused', new = 'running') 2025-05-26 13:57:57 (25484): VM state change detected. (old = 'running', new = 'paused') 2025-05-26 17:00:36 (25484): VM state change detected. (old = 'paused', new = 'running') 2025-05-26 17:00:41 (25484): VM state change detected. (old = 'running', new = 'paused') 2025-05-26 17:50:14 (25484): Stopping VM. 2025-05-26 17:50:14 (25484): Error in stop VM for VM: -108 Command: VBoxManage -q controlvm "boinc_1fb8823fe6c4e059" savestate Output: 2025-05-26 17:50:14 (25484): VM did not stop when requested. 2025-05-26 17:50:14 (25484): VM was NOT successfully terminated. 2025-05-27 03:30:33 (27180): vboxwrapper version 26210 2025-05-27 03:30:33 (27180): BOINC client version: 7.24.1 2025-05-27 03:30:34 (27180): Detected: VirtualBox VboxManage Interface (Version: 7.0.6) 2025-05-27 03:30:35 (27180): Detected: Heartbeat check (file: 'heartbeat' every 1800.000000 seconds) 2025-05-27 03:30:35 (27180): Guest Log: BIOS: VirtualBox 7.0.6 2025-05-27 03:30:35 (27180): Guest Log: CPUID EDX: 0x178bfbff 2025-05-27 03:30:35 (27180): Guest Log: BIOS: No PCI IDE controller, not probing IDE 2025-05-27 03:30:35 (27180): Guest Log: BIOS: AHCI 0-P#0: PCHS=16383/16/63 LCHS=1024/255/63 0x0000000001400000 sectors 2025-05-27 03:30:35 (27180): Guest Log: BIOS: Boot : bseqnr=1, bootseq=0032 2025-05-27 03:30:35 (27180): Guest Log: BIOS: Booting from Hard Disk... 2025-05-27 03:30:35 (27180): Guest Log: BIOS: KBD: unsupported int 16h function 03 2025-05-27 03:30:35 (27180): Guest Log: BIOS: AX=0305 BX=0000 CX=0000 DX=0000 2025-05-27 03:30:35 (27180): Guest Log: int13_harddisk_ext: function 41, unmapped device for ELDL=81 2025-05-27 03:30:35 (27180): Guest Log: int13_harddisk: function 02, unmapped device for ELDL=81 2025-05-27 03:30:35 (27180): Guest Log: int13_harddisk_ext: function 41, unmapped device for ELDL=82 2025-05-27 03:30:35 (27180): Guest Log: int13_harddisk: function 02, unmapped device for ELDL=82 2025-05-27 03:30:35 (27180): Guest Log: int13_harddisk_ext: function 41, unmapped device for ELDL=83 2025-05-27 03:30:35 (27180): Guest Log: int13_harddisk: function 02, unmapped device for ELDL=83 2025-05-27 03:30:35 (27180): Guest Log: int13_harddisk_ext: function 41, unmapped device for ELDL=84 2025-05-27 03:30:35 (27180): Guest Log: int13_harddisk: function 02, unmapped device for ELDL=84 2025-05-27 03:30:35 (27180): Guest Log: int13_harddisk_ext: function 41, unmapped device for ELDL=85 2025-05-27 03:30:35 (27180): Guest Log: int13_harddisk: function 02, unmapped device for ELDL=85 2025-05-27 03:30:35 (27180): Guest Log: int13_harddisk_ext: function 41, unmapped device for ELDL=86 2025-05-27 03:30:35 (27180): Guest Log: int13_harddisk: function 02, unmapped device for ELDL=86 2025-05-27 03:30:35 (27180): Guest Log: int13_harddisk_ext: function 41, unmapped device for ELDL=87 2025-05-27 03:30:35 (27180): Guest Log: int13_harddisk: function 02, unmapped device for ELDL=87 2025-05-27 03:30:35 (27180): Guest Log: int13_harddisk_ext: function 41, unmapped device for ELDL=88 2025-05-27 03:30:35 (27180): Guest Log: int13_harddisk: function 02, unmapped device for ELDL=88 2025-05-27 03:30:35 (27180): Guest Log: int13_harddisk_ext: function 41, unmapped device for ELDL=89 2025-05-27 03:30:35 (27180): Guest Log: int13_harddisk: function 02, unmapped device for ELDL=89 2025-05-27 03:30:35 (27180): Guest Log: int13_harddisk_ext: function 41, unmapped device for ELDL=8a 2025-05-27 03:30:35 (27180): Guest Log: int13_harddisk: function 02, unmapped device for ELDL=8a 2025-05-27 03:30:35 (27180): Guest Log: int13_harddisk_ext: function 41, unmapped device for ELDL=8b 2025-05-27 03:30:35 (27180): Guest Log: int13_harddisk: function 02, unmapped device for ELDL=8b 2025-05-27 03:30:35 (27180): Guest Log: int13_harddisk_ext: function 41, unmapped device for ELDL=8c 2025-05-27 03:30:35 (27180): Guest Log: int13_harddisk: function 02, unmapped device for ELDL=8c 2025-05-27 03:30:35 (27180): Guest Log: int13_harddisk_ext: function 41, unmapped device for ELDL=8d 2025-05-27 03:30:35 (27180): Guest Log: int13_harddisk: function 02, unmapped device for ELDL=8d 2025-05-27 03:30:35 (27180): Guest Log: int13_harddisk_ext: function 41, unmapped device for ELDL=8e 2025-05-27 03:30:35 (27180): Guest Log: int13_harddisk: function 02, unmapped device for ELDL=8e 2025-05-27 03:30:35 (27180): Guest Log: int13_harddisk_ext: function 41, unmapped device for ELDL=8f 2025-05-27 03:30:35 (27180): Guest Log: int13_harddisk: function 02, unmapped device for ELDL=8f 2025-05-27 03:30:35 (27180): Guest Log: vgdrvHeartbeatInit: Setting up heartbeat to trigger every 2000 milliseconds 2025-05-27 03:30:35 (27180): Guest Log: Host supports full mouse state reporting, switching to extended mouse integration protocol 2025-05-27 03:30:35 (27180): Guest Log: vboxguest: Successfully loaded version 7.1.6 r167084 2025-05-27 03:30:35 (27180): Guest Log: vboxguest: misc device minor 123, IRQ 20, I/O port d020, MMIO at 00000000f0400000 (size 0x400000) 2025-05-27 03:30:35 (27180): Guest Log: vboxsf: g_fHostFeatures=0x8000000f g_fSfFeatures=0x1 g_uSfLastFunction=29 2025-05-27 03:30:35 (27180): Guest Log: vboxsf: Successfully loaded version 7.1.6 r167084 on 5.14.0-503.14.1.el9_5.x86_64 (LINUX_VERSION_CODE=0x50e00) 2025-05-27 03:30:35 (27180): Guest Log: Could not find a local HTTP proxy 2025-05-27 03:30:35 (27180): Guest Log: CVMFS and Frontier will have to use DIRECT connections 2025-05-27 03:30:35 (27180): Guest Log: This makes the application less efficient 2025-05-27 03:30:35 (27180): Guest Log: It also puts higher load on the project servers 2025-05-27 03:30:35 (27180): Guest Log: Setting up a local HTTP proxy is highly recommended 2025-05-27 03:30:35 (27180): Guest Log: Advice can be found in the project forum 2025-05-27 03:30:35 (27180): Guest Log: Using custom CVMFS. 2025-05-27 03:30:35 (27180): Guest Log: Probing CVMFS repositories ... 2025-05-27 03:30:35 (27180): Guest Log: Probing /cvmfs/alice.cern.ch... OK 2025-05-27 03:30:35 (27180): Guest Log: Probing /cvmfs/cvmfs-config.cern.ch... OK 2025-05-27 03:30:35 (27180): Guest Log: Probing /cvmfs/grid.cern.ch... OK 2025-05-27 03:30:35 (27180): Guest Log: Probing /cvmfs/sft.cern.ch... OK 2025-05-27 03:30:35 (27180): Guest Log: Excerpt from "cvmfs_config stat": 2025-05-27 03:30:35 (27180): Guest Log: VERSION HOST PROXY 2025-05-27 03:30:35 (27180): Guest Log: 2.12.7.0 http://s1ral-cvmfs.openhtc.io DIRECT 2025-05-27 03:30:35 (27180): Guest Log: ****************************************************************** 2025-05-27 03:30:35 (27180): Guest Log: IMPORTANT HINT(S)! 2025-05-27 03:30:35 (27180): Guest Log: ****************************************************************** 2025-05-27 03:30:35 (27180): Guest Log: CVMFS server: http://s1ral-cvmfs.openhtc.io 2025-05-27 03:30:35 (27180): Guest Log: CVMFS proxy: DIRECT 2025-05-27 03:30:35 (27180): Guest Log: No local HTTP proxy found. 2025-05-27 03:30:35 (27180): Guest Log: With this setup concurrently running containers can't share 2025-05-27 03:30:35 (27180): Guest Log: a common CVMFS cache. A local HTTP proxy is therefore 2025-05-27 03:30:35 (27180): Guest Log: highly recommended. 2025-05-27 03:30:35 (27180): Guest Log: More info how to configure a local HTTP proxy: 2025-05-27 03:30:35 (27180): Guest Log: https://lhcathome.cern.ch/lhcathome/forum_thread.php?id=5473 2025-05-27 03:30:35 (27180): Guest Log: https://lhcathome.cern.ch/lhcathome/forum_thread.php?id=5474 2025-05-27 03:30:35 (27180): Guest Log: ****************************************************************** 2025-05-27 03:30:35 (27180): Guest Log: Environment HTTP proxy: not set 2025-05-27 03:30:35 (27180): Guest Log: job: htmld=/var/www/lighttpd 2025-05-27 03:30:35 (27180): Guest Log: job: unpack exitcode=0 2025-05-27 03:30:35 (27180): Starting VM using VBoxManage interface. (boinc_1fb8823fe6c4e059, slot#5) 2025-05-27 03:30:49 (27180): Successfully started VM. (PID = '23340') 2025-05-27 03:30:49 (27180): Reporting VM Process ID to BOINC. 2025-05-27 03:30:49 (27180): Guest Log: BIOS: VirtualBox 7.0.6 2025-05-27 03:30:49 (27180): Guest Log: CPUID EDX: 0x178bfbff 2025-05-27 03:30:49 (27180): Guest Log: BIOS: No PCI IDE controller, not probing IDE 2025-05-27 03:30:49 (27180): Guest Log: BIOS: AHCI 0-P#0: PCHS=16383/16/63 LCHS=1024/255/63 0x0000000001400000 sectors 2025-05-27 03:30:49 (27180): VM state change detected. (old = 'poweredoff', new = 'running') 2025-05-27 03:30:49 (27180): Detected: Web Application Enabled (http://localhost:7276) 2025-05-27 03:30:50 (27180): VM state change detected. (old = 'running', new = 'paused') 2025-05-27 03:31:08 (27180): Preference change detected 2025-05-27 03:31:08 (27180): Setting CPU throttle for VM. (50%) 2025-05-27 03:31:08 (27180): Setting checkpoint interval to 600 seconds. (Higher value of (Preference: 60 seconds) or (Vbox_job.xml: 600 seconds)) 2025-05-27 03:31:09 (27180): VM state change detected. (old = 'paused', new = 'running') 2025-05-27 03:31:10 (27180): Guest Log: BIOS: Boot : bseqnr=1, bootseq=0032 2025-05-27 03:31:10 (27180): Guest Log: BIOS: Booting from Hard Disk... 2025-05-27 03:31:18 (27180): VM state change detected. (old = 'running', new = 'paused') 2025-05-27 03:33:18 (27180): VM state change detected. (old = 'paused', new = 'running') 2025-05-27 03:33:21 (27180): Guest Log: BIOS: KBD: unsupported int 16h function 03 2025-05-27 03:33:21 (27180): Guest Log: BIOS: AX=0305 BX=0000 CX=0000 DX=0000 2025-05-27 03:33:21 (27180): Guest Log: int13_harddisk_ext: function 41, unmapped device for ELDL=81 2025-05-27 03:33:21 (27180): Guest Log: int13_harddisk: function 02, unmapped device for ELDL=81 2025-05-27 03:33:21 (27180): Guest Log: int13_harddisk_ext: function 41, unmapped device for ELDL=82 2025-05-27 03:33:21 (27180): Guest Log: int13_harddisk: function 02, unmapped device for ELDL=82 2025-05-27 03:33:21 (27180): Guest Log: int13_harddisk_ext: function 41, unmapped device for ELDL=83 2025-05-27 03:33:21 (27180): Guest Log: int13_harddisk: function 02, unmapped device for ELDL=83 2025-05-27 03:33:21 (27180): Guest Log: int13_harddisk_ext: function 41, unmapped device for ELDL=84 2025-05-27 03:33:21 (27180): Guest Log: int13_harddisk: function 02, unmapped device for ELDL=84 2025-05-27 03:33:21 (27180): Guest Log: int13_harddisk_ext: function 41, unmapped device for ELDL=85 2025-05-27 03:33:21 (27180): Guest Log: int13_harddisk: function 02, unmapped device for ELDL=85 2025-05-27 03:33:21 (27180): Guest Log: int13_harddisk_ext: function 41, unmapped device for ELDL=86 2025-05-27 03:33:21 (27180): Guest Log: int13_harddisk: function 02, unmapped device for ELDL=86 2025-05-27 03:33:21 (27180): Guest Log: int13_harddisk_ext: function 41, unmapped device for ELDL=87 2025-05-27 03:33:21 (27180): Guest Log: int13_harddisk: function 02, unmapped device for ELDL=87 2025-05-27 03:33:21 (27180): Guest Log: int13_harddisk_ext: function 41, unmapped device for ELDL=88 2025-05-27 03:33:21 (27180): Guest Log: int13_harddisk: function 02, unmapped device for ELDL=88 2025-05-27 03:33:21 (27180): Guest Log: int13_harddisk_ext: function 41, unmapped device for ELDL=89 2025-05-27 03:33:21 (27180): Guest Log: int13_harddisk: function 02, unmapped device for ELDL=89 2025-05-27 03:33:21 (27180): Guest Log: int13_harddisk_ext: function 41, unmapped device for ELDL=8a 2025-05-27 03:33:21 (27180): Guest Log: int13_harddisk: function 02, unmapped device for ELDL=8a 2025-05-27 03:33:21 (27180): Guest Log: int13_harddisk_ext: function 41, unmapped device for ELDL=8b 2025-05-27 03:33:21 (27180): Guest Log: int13_harddisk: function 02, unmapped device for ELDL=8b 2025-05-27 03:33:21 (27180): Guest Log: int13_harddisk_ext: function 41, unmapped device for ELDL=8c 2025-05-27 03:33:21 (27180): Guest Log: int13_harddisk: function 02, unmapped device for ELDL=8c 2025-05-27 03:33:21 (27180): Guest Log: int13_harddisk_ext: function 41, unmapped device for ELDL=8d 2025-05-27 03:33:21 (27180): Guest Log: int13_harddisk: function 02, unmapped device for ELDL=8d 2025-05-27 03:33:21 (27180): Guest Log: int13_harddisk_ext: function 41, unmapped device for ELDL=8e 2025-05-27 03:33:21 (27180): Guest Log: int13_harddisk: function 02, unmapped device for ELDL=8e 2025-05-27 03:33:21 (27180): Guest Log: int13_harddisk_ext: function 41, unmapped device for ELDL=8f 2025-05-27 03:33:21 (27180): Guest Log: int13_harddisk: function 02, unmapped device for ELDL=8f 2025-05-27 03:33:28 (27180): VM state change detected. (old = 'running', new = 'paused') 2025-05-27 03:33:49 (27180): VM state change detected. (old = 'paused', new = 'running') 2025-05-27 03:33:59 (27180): VM state change detected. (old = 'running', new = 'paused') 2025-05-27 03:34:19 (27180): VM state change detected. (old = 'paused', new = 'running') 2025-05-27 03:34:28 (27180): Guest Log: vgdrvHeartbeatInit: Setting up heartbeat to trigger every 2000 milliseconds 2025-05-27 03:34:28 (27180): Guest Log: Host supports full mouse state reporting, switching to extended mouse integration protocol 2025-05-27 03:34:28 (27180): Guest Log: vboxguest: Successfully loaded version 7.1.6 r167084 2025-05-27 03:34:28 (27180): Guest Log: vboxguest: misc device minor 123, IRQ 20, I/O port d020, MMIO at 00000000f0400000 (size 0x400000) 2025-05-27 03:34:28 (27180): Guest Log: vboxsf: g_fHostFeatures=0x8000000f g_fSfFeatures=0x1 g_uSfLastFunction=29 2025-05-27 03:34:28 (27180): Guest Log: vboxsf: Successfully loaded version 7.1.6 r167084 on 5.14.0-503.14.1.el9_5.x86_64 (LINUX_VERSION_CODE=0x50e00) 2025-05-27 03:34:29 (27180): VM state change detected. (old = 'running', new = 'paused') 2025-05-27 03:34:49 (27180): VM state change detected. (old = 'paused', new = 'running') 2025-05-27 03:34:59 (27180): VM state change detected. (old = 'running', new = 'paused') 2025-05-27 03:35:19 (27180): VM state change detected. (old = 'paused', new = 'running') 2025-05-27 03:35:29 (27180): VM state change detected. (old = 'running', new = 'paused') 2025-05-27 03:35:49 (27180): VM state change detected. (old = 'paused', new = 'running') 2025-05-27 03:36:01 (27180): Guest Log: Could not find a local HTTP proxy 2025-05-27 03:36:01 (27180): Guest Log: CVMFS and Frontier will have to use DIRECT connections 2025-05-27 03:36:01 (27180): Guest Log: This makes the application less efficient 2025-05-27 03:36:01 (27180): Guest Log: It also puts higher load on the project servers 2025-05-27 03:36:01 (27180): Guest Log: Setting up a local HTTP proxy is highly recommended 2025-05-27 03:36:01 (27180): Guest Log: Advice can be found in the project forum 2025-05-27 03:36:01 (27180): Guest Log: Using custom CVMFS. 2025-05-27 03:36:01 (27180): Guest Log: Probing CVMFS repositories ... 2025-05-27 03:36:09 (27180): VM state change detected. (old = 'running', new = 'paused') 2025-05-27 03:36:29 (27180): VM state change detected. (old = 'paused', new = 'running') 2025-05-27 03:36:49 (27180): VM state change detected. (old = 'running', new = 'paused') 2025-05-27 03:37:09 (27180): VM state change detected. (old = 'paused', new = 'running') 2025-05-27 03:37:29 (27180): VM state change detected. (old = 'running', new = 'paused') 2025-05-27 03:37:49 (27180): VM state change detected. (old = 'paused', new = 'running') 2025-05-27 03:39:29 (27180): VM state change detected. (old = 'running', new = 'paused') 2025-05-27 03:39:49 (27180): VM state change detected. (old = 'paused', new = 'running') 2025-05-27 03:40:49 (27180): VM state change detected. (old = 'running', new = 'paused') 2025-05-27 03:41:09 (27180): VM state change detected. (old = 'paused', new = 'running') 2025-05-27 03:41:19 (27180): VM state change detected. (old = 'running', new = 'paused') 2025-05-27 03:41:39 (27180): VM state change detected. (old = 'paused', new = 'running') 2025-05-27 03:41:49 (27180): VM state change detected. (old = 'running', new = 'paused') 2025-05-27 03:41:50 (27180): VM state change detected. (old = 'paused', new = 'running') 2025-05-27 03:43:00 (27180): VM state change detected. (old = 'running', new = 'paused') 2025-05-27 03:43:20 (27180): VM state change detected. (old = 'paused', new = 'running') 2025-05-27 03:43:30 (27180): VM state change detected. (old = 'running', new = 'paused') 2025-05-27 03:43:50 (27180): VM state change detected. (old = 'paused', new = 'running') 2025-05-27 03:44:00 (27180): VM state change detected. (old = 'running', new = 'paused') 2025-05-27 03:44:20 (27180): VM state change detected. (old = 'paused', new = 'running') 2025-05-27 03:44:30 (27180): VM state change detected. (old = 'running', new = 'paused') 2025-05-27 03:44:50 (27180): VM state change detected. (old = 'paused', new = 'running') 2025-05-27 03:45:00 (27180): VM state change detected. (old = 'running', new = 'paused') 2025-05-27 03:45:20 (27180): VM state change detected. (old = 'paused', new = 'running') 2025-05-27 03:45:50 (27180): VM state change detected. (old = 'running', new = 'paused') 2025-05-27 03:46:10 (27180): VM state change detected. (old = 'paused', new = 'running') 2025-05-27 03:46:20 (27180): VM state change detected. (old = 'running', new = 'paused') 2025-05-27 03:46:40 (27180): VM state change detected. (old = 'paused', new = 'running') 2025-05-27 03:46:50 (27180): VM state change detected. (old = 'running', new = 'paused') 2025-05-27 03:50:02 (27180): VM state change detected. (old = 'paused', new = 'running') 2025-05-27 03:50:20 (27180): VM state change detected. (old = 'running', new = 'paused') 2025-05-27 03:56:31 (27180): VM state change detected. (old = 'paused', new = 'running') 2025-05-27 03:56:40 (27180): VM state change detected. (old = 'running', new = 'paused') 2025-05-27 03:57:01 (27180): VM state change detected. (old = 'paused', new = 'running') 2025-05-27 03:57:41 (27180): VM state change detected. (old = 'running', new = 'paused') 2025-05-27 03:58:01 (27180): VM state change detected. (old = 'paused', new = 'running') 2025-05-27 03:58:10 (27180): VM state change detected. (old = 'running', new = 'paused') 2025-05-27 03:58:31 (27180): VM state change detected. (old = 'paused', new = 'running') 2025-05-27 03:58:39 (27180): Guest Log: Probing /cvmfs/alice.cern.ch... OK 2025-05-27 03:58:39 (27180): Guest Log: Probing /cvmfs/cvmfs-config.cern.ch... OK 2025-05-27 03:58:39 (27180): Guest Log: Probing /cvmfs/grid.cern.ch... OK 2025-05-27 03:58:39 (27180): Guest Log: Probing /cvmfs/sft.cern.ch... OK 2025-05-27 03:58:41 (27180): VM state change detected. (old = 'running', new = 'paused') 2025-05-27 03:59:01 (27180): VM state change detected. (old = 'paused', new = 'running') 2025-05-27 03:59:06 (27180): Guest Log: Excerpt from "cvmfs_config stat": 2025-05-27 03:59:06 (27180): Guest Log: VERSION HOST PROXY 2025-05-27 03:59:06 (27180): Guest Log: 2.12.7.0 http://s1bnl-cvmfs.openhtc.io DIRECT 2025-05-27 03:59:06 (27180): Guest Log: ****************************************************************** 2025-05-27 03:59:06 (27180): Guest Log: IMPORTANT HINT(S)! 2025-05-27 03:59:06 (27180): Guest Log: ****************************************************************** 2025-05-27 03:59:06 (27180): Guest Log: CVMFS server: http://s1bnl-cvmfs.openhtc.io 2025-05-27 03:59:06 (27180): Guest Log: CVMFS proxy: DIRECT 2025-05-27 03:59:06 (27180): Guest Log: No local HTTP proxy found. 2025-05-27 03:59:06 (27180): Guest Log: With this setup concurrently running containers can't share 2025-05-27 03:59:06 (27180): Guest Log: a common CVMFS cache. A local HTTP proxy is therefore 2025-05-27 03:59:06 (27180): Guest Log: highly recommended. 2025-05-27 03:59:06 (27180): Guest Log: More info how to configure a local HTTP proxy: 2025-05-27 03:59:06 (27180): Guest Log: https://lhcathome.cern.ch/lhcathome/forum_thread.php?id=5473 2025-05-27 03:59:06 (27180): Guest Log: https://lhcathome.cern.ch/lhcathome/forum_thread.php?id=5474 2025-05-27 03:59:06 (27180): Guest Log: ****************************************************************** 2025-05-27 03:59:06 (27180): Guest Log: Environment HTTP proxy: not set 2025-05-27 03:59:08 (27180): Guest Log: job: htmld=/var/www/lighttpd 2025-05-27 03:59:08 (27180): Guest Log: job: unpack exitcode=0 2025-05-27 03:59:11 (27180): VM state change detected. (old = 'running', new = 'paused') 2025-05-27 03:59:31 (27180): VM state change detected. (old = 'paused', new = 'running') 2025-05-27 03:59:41 (27180): VM state change detected. (old = 'running', new = 'paused') 2025-05-27 04:00:01 (27180): VM state change detected. (old = 'paused', new = 'running') 2025-05-27 04:00:11 (27180): VM state change detected. (old = 'running', new = 'paused') 2025-05-27 04:00:31 (27180): VM state change detected. (old = 'paused', new = 'running') 2025-05-27 04:00:41 (27180): VM state change detected. (old = 'running', new = 'paused') 2025-05-27 04:01:01 (27180): VM state change detected. (old = 'paused', new = 'running') 2025-05-27 04:01:11 (27180): VM state change detected. (old = 'running', new = 'paused') 2025-05-27 04:01:47 (27180): VM state change detected. (old = 'paused', new = 'running') 2025-05-27 04:01:50 (27180): VM state change detected. (old = 'running', new = 'paused') 2025-05-27 04:02:02 (27180): VM state change detected. (old = 'paused', new = 'running') 2025-05-27 04:02:14 (27180): VM state change detected. (old = 'running', new = 'paused') 2025-05-27 04:02:33 (27180): VM state change detected. (old = 'paused', new = 'running') 2025-05-27 04:02:42 (27180): VM state change detected. (old = 'running', new = 'paused') 2025-05-27 04:03:03 (27180): VM state change detected. (old = 'paused', new = 'running') 2025-05-27 04:03:15 (27180): VM state change detected. (old = 'running', new = 'paused') 2025-05-27 04:06:26 (27180): VM state change detected. (old = 'paused', new = 'running') 2025-05-27 04:06:35 (27180): VM state change detected. (old = 'running', new = 'paused') 2025-05-27 04:07:31 (27180): VM state change detected. (old = 'paused', new = 'running') 2025-05-27 04:07:34 (27180): VM state change detected. (old = 'running', new = 'paused') 2025-05-27 04:07:53 (27180): VM state change detected. (old = 'paused', new = 'running') 2025-05-27 04:08:06 (27180): VM state change detected. (old = 'running', new = 'paused') 2025-05-27 04:08:23 (27180): VM state change detected. (old = 'paused', new = 'running') 2025-05-27 04:08:33 (27180): VM state change detected. (old = 'running', new = 'paused') 2025-05-27 04:08:53 (27180): VM state change detected. (old = 'paused', new = 'running') 2025-05-27 04:09:05 (27180): VM state change detected. (old = 'running', new = 'paused') 2025-05-27 04:09:23 (27180): VM state change detected. (old = 'paused', new = 'running') 2025-05-27 04:09:34 (27180): VM state change detected. (old = 'running', new = 'paused') 2025-05-27 04:09:53 (27180): VM state change detected. (old = 'paused', new = 'running') 2025-05-27 04:10:04 (27180): VM state change detected. (old = 'running', new = 'paused') 2025-05-27 04:10:22 (27180): VM state change detected. (old = 'paused', new = 'running') 2025-05-27 04:10:35 (27180): VM state change detected. (old = 'running', new = 'paused') 2025-05-27 04:10:54 (27180): VM state change detected. (old = 'paused', new = 'running') 2025-05-27 04:11:06 (27180): VM state change detected. (old = 'running', new = 'paused') 2025-05-27 04:11:22 (27180): VM state change detected. (old = 'paused', new = 'running') 2025-05-27 04:11:32 (27180): VM state change detected. (old = 'running', new = 'paused') 2025-05-27 04:11:52 (27180): VM state change detected. (old = 'paused', new = 'running') 2025-05-27 04:12:02 (27180): VM state change detected. (old = 'running', new = 'paused') 2025-05-27 04:12:22 (27180): VM state change detected. (old = 'paused', new = 'running') 2025-05-27 04:12:32 (27180): VM state change detected. (old = 'running', new = 'paused') 2025-05-27 04:12:52 (27180): VM state change detected. (old = 'paused', new = 'running') 2025-05-27 04:13:02 (27180): VM state change detected. (old = 'running', new = 'paused') 2025-05-27 04:13:22 (27180): VM state change detected. (old = 'paused', new = 'running') 2025-05-27 04:13:32 (27180): VM state change detected. (old = 'running', new = 'paused') 2025-05-27 04:13:52 (27180): VM state change detected. (old = 'paused', new = 'running') 2025-05-27 04:14:02 (27180): VM state change detected. (old = 'running', new = 'paused') 2025-05-27 04:14:22 (27180): VM state change detected. (old = 'paused', new = 'running') 2025-05-27 04:14:32 (27180): VM state change detected. (old = 'running', new = 'paused') 2025-05-27 04:14:52 (27180): VM state change detected. (old = 'paused', new = 'running') 2025-05-27 04:15:02 (27180): VM state change detected. (old = 'running', new = 'paused') 2025-05-27 04:15:22 (27180): VM state change detected. (old = 'paused', new = 'running') 2025-05-27 04:15:32 (27180): VM state change detected. (old = 'running', new = 'paused') 2025-05-27 04:15:52 (27180): VM state change detected. (old = 'paused', new = 'running') 2025-05-27 04:16:02 (27180): VM state change detected. (old = 'running', new = 'paused') 2025-05-27 04:16:22 (27180): VM state change detected. (old = 'paused', new = 'running') 2025-05-27 04:16:32 (27180): VM state change detected. (old = 'running', new = 'paused') 2025-05-27 04:16:52 (27180): VM state change detected. (old = 'paused', new = 'running') 2025-05-27 04:17:02 (27180): VM state change detected. (old = 'running', new = 'paused') 2025-05-27 04:17:22 (27180): VM state change detected. (old = 'paused', new = 'running') 2025-05-27 04:17:32 (27180): VM state change detected. (old = 'running', new = 'paused') 2025-05-27 04:17:52 (27180): VM state change detected. (old = 'paused', new = 'running') 2025-05-27 04:18:03 (27180): VM state change detected. (old = 'running', new = 'paused') 2025-05-27 04:18:24 (27180): VM state change detected. (old = 'paused', new = 'running') 2025-05-27 04:18:33 (27180): VM state change detected. (old = 'running', new = 'paused') 2025-05-27 04:18:52 (27180): Stopping VM. 2025-05-27 04:18:57 (27180): Successfully stopped VM. 2025-06-01 03:18:33 (25948): vboxwrapper version 26210 2025-06-01 03:18:33 (25948): BOINC client version: 7.24.1 2025-06-01 03:18:33 (25948): Detected: VirtualBox VboxManage Interface (Version: 7.0.6) 2025-06-01 03:18:33 (25948): Detected: Heartbeat check (file: 'heartbeat' every 1800.000000 seconds) 2025-06-01 03:18:34 (25948): Guest Log: BIOS: VirtualBox 7.0.6 2025-06-01 03:18:34 (25948): Guest Log: CPUID EDX: 0x178bfbff 2025-06-01 03:18:34 (25948): Guest Log: BIOS: No PCI IDE controller, not probing IDE 2025-06-01 03:18:34 (25948): Guest Log: BIOS: AHCI 0-P#0: PCHS=16383/16/63 LCHS=1024/255/63 0x0000000001400000 sectors 2025-06-01 03:18:34 (25948): Guest Log: BIOS: Boot : bseqnr=1, bootseq=0032 2025-06-01 03:18:34 (25948): Guest Log: BIOS: Booting from Hard Disk... 2025-06-01 03:18:34 (25948): Guest Log: BIOS: KBD: unsupported int 16h function 03 2025-06-01 03:18:34 (25948): Guest Log: BIOS: AX=0305 BX=0000 CX=0000 DX=0000 2025-06-01 03:18:34 (25948): Guest Log: int13_harddisk_ext: function 41, unmapped device for ELDL=81 2025-06-01 03:18:34 (25948): Guest Log: int13_harddisk: function 02, unmapped device for ELDL=81 2025-06-01 03:18:34 (25948): Guest Log: int13_harddisk_ext: function 41, unmapped device for ELDL=82 2025-06-01 03:18:34 (25948): Guest Log: int13_harddisk: function 02, unmapped device for ELDL=82 2025-06-01 03:18:34 (25948): Guest Log: int13_harddisk_ext: function 41, unmapped device for ELDL=83 2025-06-01 03:18:34 (25948): Guest Log: int13_harddisk: function 02, unmapped device for ELDL=83 2025-06-01 03:18:34 (25948): Guest Log: int13_harddisk_ext: function 41, unmapped device for ELDL=84 2025-06-01 03:18:34 (25948): Guest Log: int13_harddisk: function 02, unmapped device for ELDL=84 2025-06-01 03:18:34 (25948): Guest Log: int13_harddisk_ext: function 41, unmapped device for ELDL=85 2025-06-01 03:18:34 (25948): Guest Log: int13_harddisk: function 02, unmapped device for ELDL=85 2025-06-01 03:18:34 (25948): Guest Log: int13_harddisk_ext: function 41, unmapped device for ELDL=86 2025-06-01 03:18:34 (25948): Guest Log: int13_harddisk: function 02, unmapped device for ELDL=86 2025-06-01 03:18:34 (25948): Guest Log: int13_harddisk_ext: function 41, unmapped device for ELDL=87 2025-06-01 03:18:34 (25948): Guest Log: int13_harddisk: function 02, unmapped device for ELDL=87 2025-06-01 03:18:34 (25948): Guest Log: int13_harddisk_ext: function 41, unmapped device for ELDL=88 2025-06-01 03:18:34 (25948): Guest Log: int13_harddisk: function 02, unmapped device for ELDL=88 2025-06-01 03:18:34 (25948): Guest Log: int13_harddisk_ext: function 41, unmapped device for ELDL=89 2025-06-01 03:18:34 (25948): Guest Log: int13_harddisk: function 02, unmapped device for ELDL=89 2025-06-01 03:18:34 (25948): Guest Log: int13_harddisk_ext: function 41, unmapped device for ELDL=8a 2025-06-01 03:18:34 (25948): Guest Log: int13_harddisk: function 02, unmapped device for ELDL=8a 2025-06-01 03:18:34 (25948): Guest Log: int13_harddisk_ext: function 41, unmapped device for ELDL=8b 2025-06-01 03:18:34 (25948): Guest Log: int13_harddisk: function 02, unmapped device for ELDL=8b 2025-06-01 03:18:34 (25948): Guest Log: int13_harddisk_ext: function 41, unmapped device for ELDL=8c 2025-06-01 03:18:34 (25948): Guest Log: int13_harddisk: function 02, unmapped device for ELDL=8c 2025-06-01 03:18:34 (25948): Guest Log: int13_harddisk_ext: function 41, unmapped device for ELDL=8d 2025-06-01 03:18:34 (25948): Guest Log: int13_harddisk: function 02, unmapped device for ELDL=8d 2025-06-01 03:18:34 (25948): Guest Log: int13_harddisk_ext: function 41, unmapped device for ELDL=8e 2025-06-01 03:18:34 (25948): Guest Log: int13_harddisk: function 02, unmapped device for ELDL=8e 2025-06-01 03:18:34 (25948): Guest Log: int13_harddisk_ext: function 41, unmapped device for ELDL=8f 2025-06-01 03:18:34 (25948): Guest Log: int13_harddisk: function 02, unmapped device for ELDL=8f 2025-06-01 03:18:34 (25948): Guest Log: vgdrvHeartbeatInit: Setting up heartbeat to trigger every 2000 milliseconds 2025-06-01 03:18:34 (25948): Guest Log: Host supports full mouse state reporting, switching to extended mouse integration protocol 2025-06-01 03:18:34 (25948): Guest Log: vboxguest: Successfully loaded version 7.1.6 r167084 2025-06-01 03:18:34 (25948): Guest Log: vboxguest: misc device minor 123, IRQ 20, I/O port d020, MMIO at 00000000f0400000 (size 0x400000) 2025-06-01 03:18:34 (25948): Guest Log: vboxsf: g_fHostFeatures=0x8000000f g_fSfFeatures=0x1 g_uSfLastFunction=29 2025-06-01 03:18:34 (25948): Guest Log: vboxsf: Successfully loaded version 7.1.6 r167084 on 5.14.0-503.14.1.el9_5.x86_64 (LINUX_VERSION_CODE=0x50e00) 2025-06-01 03:18:34 (25948): Guest Log: Could not find a local HTTP proxy 2025-06-01 03:18:34 (25948): Guest Log: CVMFS and Frontier will have to use DIRECT connections 2025-06-01 03:18:34 (25948): Guest Log: This makes the application less efficient 2025-06-01 03:18:34 (25948): Guest Log: It also puts higher load on the project servers 2025-06-01 03:18:34 (25948): Guest Log: Setting up a local HTTP proxy is highly recommended 2025-06-01 03:18:34 (25948): Guest Log: Advice can be found in the project forum 2025-06-01 03:18:34 (25948): Guest Log: Using custom CVMFS. 2025-06-01 03:18:34 (25948): Guest Log: Probing CVMFS repositories ... 2025-06-01 03:18:34 (25948): Guest Log: Probing /cvmfs/alice.cern.ch... OK 2025-06-01 03:18:34 (25948): Guest Log: Probing /cvmfs/cvmfs-config.cern.ch... OK 2025-06-01 03:18:34 (25948): Guest Log: Probing /cvmfs/grid.cern.ch... OK 2025-06-01 03:18:34 (25948): Guest Log: Probing /cvmfs/sft.cern.ch... OK 2025-06-01 03:18:34 (25948): Guest Log: Excerpt from "cvmfs_config stat": 2025-06-01 03:18:34 (25948): Guest Log: VERSION HOST PROXY 2025-06-01 03:18:34 (25948): Guest Log: 2.12.7.0 http://s1bnl-cvmfs.openhtc.io DIRECT 2025-06-01 03:18:34 (25948): Guest Log: ****************************************************************** 2025-06-01 03:18:34 (25948): Guest Log: IMPORTANT HINT(S)! 2025-06-01 03:18:34 (25948): Guest Log: ****************************************************************** 2025-06-01 03:18:34 (25948): Guest Log: CVMFS server: http://s1bnl-cvmfs.openhtc.io 2025-06-01 03:18:34 (25948): Guest Log: CVMFS proxy: DIRECT 2025-06-01 03:18:34 (25948): Guest Log: No local HTTP proxy found. 2025-06-01 03:18:34 (25948): Guest Log: With this setup concurrently running containers can't share 2025-06-01 03:18:34 (25948): Guest Log: a common CVMFS cache. A local HTTP proxy is therefore 2025-06-01 03:18:34 (25948): Guest Log: highly recommended. 2025-06-01 03:18:34 (25948): Guest Log: More info how to configure a local HTTP proxy: 2025-06-01 03:18:34 (25948): Guest Log: https://lhcathome.cern.ch/lhcathome/forum_thread.php?id=5473 2025-06-01 03:18:34 (25948): Guest Log: https://lhcathome.cern.ch/lhcathome/forum_thread.php?id=5474 2025-06-01 03:18:34 (25948): Guest Log: ****************************************************************** 2025-06-01 03:18:34 (25948): Guest Log: Environment HTTP proxy: not set 2025-06-01 03:18:34 (25948): Guest Log: job: htmld=/var/www/lighttpd 2025-06-01 03:18:34 (25948): Guest Log: job: unpack exitcode=0 2025-06-01 03:18:34 (25948): Starting VM using VBoxManage interface. (boinc_1fb8823fe6c4e059, slot#5) 2025-06-01 03:18:48 (25948): Successfully started VM. (PID = '19684') 2025-06-01 03:18:48 (25948): Reporting VM Process ID to BOINC. 2025-06-01 03:18:48 (25948): VM state change detected. (old = 'poweredoff', new = 'running') 2025-06-01 03:18:48 (25948): Detected: Web Application Enabled (http://localhost:7276) 2025-06-01 03:18:48 (25948): Preference change detected 2025-06-01 03:18:48 (25948): Setting CPU throttle for VM. (50%) 2025-06-01 03:18:49 (25948): Setting checkpoint interval to 600 seconds. (Higher value of (Preference: 60 seconds) or (Vbox_job.xml: 600 seconds)) 2025-06-01 03:24:19 (25948): Status Report: Job Duration: '864000.000000' 2025-06-01 03:24:19 (25948): Status Report: Elapsed Time: '6000.770498' 2025-06-01 03:24:19 (25948): Status Report: CPU Time: '3236.093750' 2025-06-01 03:38:55 (25948): VM state change detected. (old = 'running', new = 'paused') 2025-06-01 03:39:17 (25948): VM state change detected. (old = 'paused', new = 'running') 2025-06-01 03:57:37 (25948): VM state change detected. (old = 'running', new = 'paused') 2025-06-01 03:57:38 (25948): VM state change detected. (old = 'paused', new = 'running') 2025-06-01 04:14:19 (25948): VM state change detected. (old = 'running', new = 'paused') 2025-06-01 04:14:39 (25948): VM state change detected. (old = 'paused', new = 'running') 2025-06-01 04:28:51 (25948): VM state change detected. (old = 'running', new = 'paused') 2025-06-01 04:29:11 (25948): VM state change detected. (old = 'paused', new = 'running') 2025-06-01 04:30:41 (25948): VM state change detected. (old = 'running', new = 'paused') 2025-06-01 04:31:01 (25948): VM state change detected. (old = 'paused', new = 'running') 2025-06-01 04:32:31 (25948): VM state change detected. (old = 'running', new = 'paused') 2025-06-01 04:32:51 (25948): VM state change detected. (old = 'paused', new = 'running') 2025-06-01 04:34:31 (25948): VM state change detected. (old = 'running', new = 'paused') 2025-06-01 04:34:51 (25948): VM state change detected. (old = 'paused', new = 'running') 2025-06-01 04:36:21 (25948): VM state change detected. (old = 'running', new = 'paused') 2025-06-01 04:36:41 (25948): VM state change detected. (old = 'paused', new = 'running') 2025-06-01 04:38:12 (25948): VM state change detected. (old = 'running', new = 'paused') 2025-06-01 04:38:32 (25948): VM state change detected. (old = 'paused', new = 'running') 2025-06-01 04:39:32 (25948): VM state change detected. (old = 'running', new = 'paused') 2025-06-01 04:39:52 (25948): VM state change detected. (old = 'paused', new = 'running') 2025-06-01 04:41:23 (25948): VM state change detected. (old = 'running', new = 'paused') 2025-06-01 04:41:42 (25948): VM state change detected. (old = 'paused', new = 'running') 2025-06-01 04:42:13 (25948): VM state change detected. (old = 'running', new = 'paused') 2025-06-01 04:42:32 (25948): VM state change detected. (old = 'paused', new = 'running') 2025-06-01 04:43:12 (25948): VM state change detected. (old = 'running', new = 'paused') 2025-06-01 04:43:33 (25948): VM state change detected. (old = 'paused', new = 'running') 2025-06-01 04:44:12 (25948): VM state change detected. (old = 'running', new = 'paused') 2025-06-01 04:44:33 (25948): VM state change detected. (old = 'paused', new = 'running') 2025-06-01 04:46:34 (25948): VM state change detected. (old = 'running', new = 'paused') 2025-06-01 04:46:53 (25948): VM state change detected. (old = 'paused', new = 'running') 2025-06-01 04:47:03 (25948): VM state change detected. (old = 'running', new = 'paused') 2025-06-01 04:47:23 (25948): VM state change detected. (old = 'paused', new = 'running') 2025-06-01 04:48:03 (25948): VM state change detected. (old = 'running', new = 'paused') 2025-06-01 04:48:23 (25948): VM state change detected. (old = 'paused', new = 'running') 2025-06-01 05:10:06 (25948): Status Report: Job Duration: '864000.000000' 2025-06-01 05:10:06 (25948): Status Report: Elapsed Time: '12001.437980' 2025-06-01 05:10:06 (25948): Status Report: CPU Time: '7621.500000' 2025-06-01 05:15:39 (25948): Error in pause VM for VM: -182 Command: VBoxManage -q controlvm "boinc_1fb8823fe6c4e059" pause Output: VBoxManage.exe: error: Already paused VBoxManage.exe: error: Details: code VBOX_E_INVALID_VM_STATE (0x80bb0002), component ConsoleWrap, interface IConsole, callee IUnknown VBoxManage.exe: error: Context: "Pause()" at line 390 of file VBoxManageControlVM.cpp 2025-06-01 05:15:40 (25948): VM state change detected. (old = 'running', new = 'paused') 2025-06-01 05:15:41 (25948): VM state change detected. (old = 'paused', new = 'running') 2025-06-01 05:24:25 (25948): VM state change detected. (old = 'running', new = 'paused') 2025-06-01 05:24:26 (25948): VM state change detected. (old = 'paused', new = 'running') 2025-06-01 05:39:47 (25948): VM state change detected. (old = 'running', new = 'paused') 2025-06-01 05:40:07 (25948): VM state change detected. (old = 'paused', new = 'running') 2025-06-01 05:41:47 (25948): VM state change detected. (old = 'running', new = 'paused') 2025-06-01 05:42:07 (25948): VM state change detected. (old = 'paused', new = 'running') 2025-06-01 05:45:37 (25948): VM state change detected. (old = 'running', new = 'paused') 2025-06-01 05:45:57 (25948): VM state change detected. (old = 'paused', new = 'running') 2025-06-01 05:55:08 (25948): VM state change detected. (old = 'running', new = 'paused') 2025-06-01 05:55:28 (25948): VM state change detected. (old = 'paused', new = 'running') 2025-06-01 06:08:40 (25948): VM state change detected. (old = 'running', new = 'paused') 2025-06-01 06:09:01 (25948): VM state change detected. (old = 'paused', new = 'running') 2025-06-01 06:14:40 (25948): VM state change detected. (old = 'running', new = 'paused') 2025-06-01 06:15:00 (25948): VM state change detected. (old = 'paused', new = 'running') 2025-06-01 06:36:23 (25948): Guest Log: job: run exitcode=0 2025-06-01 06:36:23 (25948): Guest Log: job: diskusage=6928 2025-06-01 06:36:23 (25948): Guest Log: job: logsize=64 k 2025-06-01 06:36:23 (25948): Guest Log: job: times= 2025-06-01 06:36:23 (25948): Guest Log: 0m0.038s 0m0.029s 2025-06-01 06:36:23 (25948): Guest Log: 185m9.847s 4m20.402s 2025-06-01 06:36:23 (25948): Guest Log: job: cpuusage=11370 2025-06-01 06:36:23 (25948): Guest Log: Job Finished 2025-06-01 06:36:23 (25948): Guest Log: boinc_shutdown called with exit code 0 2025-06-01 06:36:23 (25948): Guest Log: sd_delay: 902 2025-06-01 06:36:23 (25948): Guest Log: ETA: 2025-05-26 23:15:32 UTC 2025-06-01 06:51:26 (25948): VM Completion File Detected. 2025-06-01 06:51:26 (25948): Powering off VM. 2025-06-01 06:51:26 (25948): Successfully stopped VM. 2025-06-01 06:51:26 (25948): Deregistering VM. (boinc_1fb8823fe6c4e059, slot#5) 2025-06-01 06:51:27 (25948): Removing network bandwidth throttle group from VM. 2025-06-01 06:51:27 (25948): Removing VM from VirtualBox. 2025-06-01 06:51:32 (25948): called boinc_finish(0) </stderr_txt> ]]>
©2025 CERN