Name | C7aLDmu2bT5n9Rq4apoT9bVoABFKDmABFKDmlqFKDm6iOKDmlQJ5So_0 |
Workunit | 223161471 |
Created | 21 May 2024, 10:37:30 UTC |
Sent | 27 Sep 2024, 13:19:56 UTC |
Report deadline | 8 Sep 2025, 12:46:36 UTC |
Received | 23 May 2024, 3:30:43 UTC |
Server state | In progress |
Outcome | Success |
Client state | Compute error |
Exit status | -2147467259 (0x80004005) Unknown error code |
Computer ID | 10803325 |
Run time | 21 hours 59 min 27 sec |
CPU time | 15 hours 21 min 42 sec |
Validate state | Initial |
Credit | 0.00 |
Device peak FLOPS | 3.77 GFLOPS |
Application version | ATLAS Simulation v3.01 (vbox64_mt_mcore_atlas) windows_x86_64 |
Peak working set size | 88.67 MB |
Peak swap size | 108.28 MB |
Peak disk usage | 2.71 GB |
<core_client_version>7.24.1</core_client_version> <![CDATA[ <message> Unspecified error (0x80004005) - exit code 2147500037 (0x80004005)</message> <stderr_txt> 2024-05-21 16:36:56 (35596): Detected: vboxwrapper 26206 2024-05-21 16:36:56 (35596): Detected: BOINC client v7.24.1 2024-05-21 16:36:56 (35596): Detected: VirtualBox VboxManage Interface (Version: 7.0.14) 2024-05-21 16:36:57 (35596): Successfully copied 'init_data.xml' to the shared directory. 2024-05-21 16:36:57 (35596): Create VM. (boinc_ac126dfc4892e95c, slot#15) 2024-05-21 16:36:58 (35596): Setting Memory Size for VM. (4100MB) 2024-05-21 16:36:59 (35596): Setting CPU Count for VM. (1) 2024-05-21 16:36:59 (35596): Setting Chipset Options for VM. 2024-05-21 16:36:59 (35596): Setting Graphics Controller Options for VM. 2024-05-21 16:37:00 (35596): Setting Boot Options for VM. 2024-05-21 16:37:00 (35596): Setting Network Configuration for NAT. 2024-05-21 16:37:00 (35596): Enabling VM Network Access. 2024-05-21 16:37:00 (35596): Disabling USB Support for VM. 2024-05-21 16:37:01 (35596): Disabling COM Port Support for VM. 2024-05-21 16:37:01 (35596): Disabling LPT Port Support for VM. 2024-05-21 16:37:01 (35596): Disabling Audio Support for VM. 2024-05-21 16:37:02 (35596): Disabling Clipboard Support for VM. 2024-05-21 16:37:02 (35596): Disabling Drag and Drop Support for VM. 2024-05-21 16:37:02 (35596): Adding storage controller(s) to VM. 2024-05-21 16:37:03 (35596): Adding virtual disk drive to VM. (ATLAS_vbox_3.01_image.vdi) 2024-05-21 16:37:03 (35596): Adding VirtualBox Guest Additions to VM. 2024-05-21 16:37:04 (35596): Adding network bandwidth throttle group to VM. (Defaulting to 1024GB) 2024-05-21 16:37:04 (35596): forwarding host port 62903 to guest port 80 2024-05-21 16:37:05 (35596): Enabling remote desktop for VM. 2024-05-21 16:37:05 (35596): Enabling shared directory for VM. 2024-05-21 16:37:06 (35596): Starting VM using VBoxManage interface. (boinc_ac126dfc4892e95c, slot#15) 2024-05-21 16:37:14 (35596): Successfully started VM. (PID = '22708') 2024-05-21 16:37:14 (35596): Reporting VM Process ID to BOINC. 2024-05-21 16:37:14 (35596): Guest Log: BIOS: VirtualBox 7.0.14 2024-05-21 16:37:14 (35596): Guest Log: CPUID EDX: 0x178bfbff 2024-05-21 16:37:14 (35596): Guest Log: BIOS: No PCI IDE controller, not probing IDE 2024-05-21 16:37:14 (35596): Guest Log: BIOS: AHCI 0-P#0: PCHS=16383/16/63 LCHS=1024/255/63 0x0000000002800000 sectors 2024-05-21 16:37:14 (35596): VM state change detected. (old = 'poweredoff', new = 'running') 2024-05-21 16:37:14 (35596): Detected: Web Application Enabled (http://localhost:62903) 2024-05-21 16:37:14 (35596): Detected: Remote Desktop Enabled (localhost:62904) 2024-05-21 16:37:14 (35596): Preference change detected 2024-05-21 16:37:14 (35596): Setting CPU throttle for VM. (90%) 2024-05-21 16:37:14 (35596): Setting checkpoint interval to 900 seconds. (Higher value of (Preference: 60 seconds) or (Vbox_job.xml: 900 seconds)) 2024-05-21 16:37:16 (35596): Guest Log: BIOS: Boot : bseqnr=1, bootseq=0032 2024-05-21 16:37:16 (35596): Guest Log: BIOS: Booting from Hard Disk... 2024-05-21 16:37:19 (35596): Guest Log: BIOS: KBD: unsupported int 16h function 03 2024-05-21 16:37:19 (35596): Guest Log: BIOS: AX=0305 BX=0000 CX=0000 DX=0000 2024-05-21 16:37:19 (35596): Guest Log: int13_harddisk_ext: function 41, unmapped device for ELDL=81 2024-05-21 16:37:19 (35596): Guest Log: int13_harddisk: function 02, unmapped device for ELDL=81 2024-05-21 16:37:19 (35596): Guest Log: int13_harddisk_ext: function 41, unmapped device for ELDL=82 2024-05-21 16:37:19 (35596): Guest Log: int13_harddisk: function 02, unmapped device for ELDL=82 2024-05-21 16:37:19 (35596): Guest Log: int13_harddisk_ext: function 41, unmapped device for ELDL=83 2024-05-21 16:37:19 (35596): Guest Log: int13_harddisk: function 02, unmapped device for ELDL=83 2024-05-21 16:37:19 (35596): Guest Log: int13_harddisk_ext: function 41, unmapped device for ELDL=84 2024-05-21 16:37:19 (35596): Guest Log: int13_harddisk: function 02, unmapped device for ELDL=84 2024-05-21 16:37:19 (35596): Guest Log: int13_harddisk_ext: function 41, unmapped device for ELDL=85 2024-05-21 16:37:19 (35596): Guest Log: int13_harddisk: function 02, unmapped device for ELDL=85 2024-05-21 16:37:19 (35596): Guest Log: int13_harddisk_ext: function 41, unmapped device for ELDL=86 2024-05-21 16:37:19 (35596): Guest Log: int13_harddisk: function 02, unmapped device for ELDL=86 2024-05-21 16:37:19 (35596): Guest Log: int13_harddisk_ext: function 41, unmapped device for ELDL=87 2024-05-21 16:37:19 (35596): Guest Log: int13_harddisk: function 02, unmapped device for ELDL=87 2024-05-21 16:37:19 (35596): Guest Log: int13_harddisk_ext: function 41, unmapped device for ELDL=88 2024-05-21 16:37:19 (35596): Guest Log: int13_harddisk: function 02, unmapped device for ELDL=88 2024-05-21 16:37:19 (35596): Guest Log: int13_harddisk_ext: function 41, unmapped device for ELDL=89 2024-05-21 16:37:19 (35596): Guest Log: int13_harddisk: function 02, unmapped device for ELDL=89 2024-05-21 16:37:19 (35596): Guest Log: int13_harddisk_ext: function 41, unmapped device for ELDL=8a 2024-05-21 16:37:19 (35596): Guest Log: int13_harddisk: function 02, unmapped device for ELDL=8a 2024-05-21 16:37:19 (35596): Guest Log: int13_harddisk_ext: function 41, unmapped device for ELDL=8b 2024-05-21 16:37:19 (35596): Guest Log: int13_harddisk: function 02, unmapped device for ELDL=8b 2024-05-21 16:37:19 (35596): Guest Log: int13_harddisk_ext: function 41, unmapped device for ELDL=8c 2024-05-21 16:37:19 (35596): Guest Log: int13_harddisk: function 02, unmapped device for ELDL=8c 2024-05-21 16:37:19 (35596): Guest Log: int13_harddisk_ext: function 41, unmapped device for ELDL=8d 2024-05-21 16:37:19 (35596): Guest Log: int13_harddisk: function 02, unmapped device for ELDL=8d 2024-05-21 16:37:19 (35596): Guest Log: int13_harddisk_ext: function 41, unmapped device for ELDL=8e 2024-05-21 16:37:19 (35596): Guest Log: int13_harddisk: function 02, unmapped device for ELDL=8e 2024-05-21 16:37:19 (35596): Guest Log: int13_harddisk_ext: function 41, unmapped device for ELDL=8f 2024-05-21 16:37:19 (35596): Guest Log: int13_harddisk: function 02, unmapped device for ELDL=8f 2024-05-21 16:37:31 (35596): Guest Log: vgdrvHeartbeatInit: Setting up heartbeat to trigger every 2000 milliseconds 2024-05-21 16:37:31 (35596): Guest Log: vboxguest: misc device minor 58, IRQ 20, I/O port d020, MMIO at 00000000f0400000 (size 0x400000) 2024-05-21 16:37:57 (35596): Guest Log: VBoxService 5.2.32 r132073 (verbosity: 0) linux.amd64 (Jul 12 2019 10:32:28) release log 2024-05-21 16:37:57 (35596): Guest Log: 00:00:00.000260 main Log opened 2024-05-21T16:37:55.755921000Z 2024-05-21 16:37:57 (35596): Guest Log: 00:00:00.000432 main OS Product: Linux 2024-05-21 16:37:57 (35596): Guest Log: 00:00:00.000499 main OS Release: 3.10.0-957.27.2.el7.x86_64 2024-05-21 16:37:57 (35596): Guest Log: 00:00:00.000539 main OS Version: #1 SMP Mon Jul 29 17:46:05 UTC 2019 2024-05-21 16:37:57 (35596): Guest Log: 00:00:00.000567 main Executable: /opt/VBoxGuestAdditions-5.2.32/sbin/VBoxService 2024-05-21 16:37:57 (35596): Guest Log: 00:00:00.000568 main Process ID: 1244 2024-05-21 16:37:57 (35596): Guest Log: 00:00:00.000568 main Package type: LINUX_64BITS_GENERIC 2024-05-21 16:37:57 (35596): Guest Log: 00:00:00.003613 main 5.2.32 r132073 started. Verbose level = 0 2024-05-21 16:37:58 (35596): Guest Log: [INFO] Probing /cvmfs/atlas.cern.ch... 2024-05-21 16:37:58 (35596): Guest Log: [INFO] Mounting shared directory 2024-05-21 16:37:58 (35596): Guest Log: [INFO] Checking for init_data.xml 2024-05-21 16:38:07 (35596): Guest Log: 00:00:10.044661 timesync vgsvcTimeSyncWorker: Radical guest time change: 25 210 888 241 000ns (GuestNow=1 716 334 686 684 745 000 ns GuestLast=1 716 309 475 796 504 000 ns fSetTimeLastLoop=true ) 2024-05-21 16:38:09 (35596): Guest Log: [INFO] Probing /cvmfs/atlas.cern.ch... OK 2024-05-21 16:38:09 (35596): Guest Log: [INFO] Detected branch: prod 2024-05-21 16:38:09 (35596): Guest Log: This is the prod version of the ATLAS job wrapper 2024-05-21 16:38:09 (35596): Guest Log: Copying input files 2024-05-21 16:38:18 (35596): Guest Log: Copied input files into RunAtlas. 2024-05-21 16:38:18 (35596): Guest Log: This VM did not configure a local http proxy via BOINC. 2024-05-21 16:38:18 (35596): Guest Log: Small home clusters do not require a local http proxy but it is suggested if 2024-05-21 16:38:18 (35596): Guest Log: more than 10 cores throughout the same LAN segment are regularly running ATLAS like tasks. 2024-05-21 16:38:18 (35596): Guest Log: Further information can be found at the LHC@home message board. 2024-05-21 16:38:30 (35596): Guest Log: Running cvmfs_config stat atlas.cern.ch 2024-05-21 16:38:30 (35596): 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 2024-05-21 16:38:30 (35596): Guest Log: 2.6.3.0 1541 0 30068 133007 4 1 3116989 4096000 0 65024 0 0 n/a 1 0 http://s1ral-cvmfs.openhtc.io/cvmfs/atlas.cern.ch DIRECT 1 2024-05-21 16:38:35 (35596): Guest Log: copied the webapp to /var/www 2024-05-21 16:38:35 (35596): Guest Log: core_number=1 2024-05-21 16:38:35 (35596): Guest Log: Apptainer command /cvmfs/atlas.cern.ch/repo/containers/sw/apptainer/x86_64-el7/current/bin/apptainer exec -B /cvmfs,/data,/home/atlas/RunAtlas /cvmfs/atlas.cern.ch/repo/containers/fs/singularity/x86_64-centos7 2024-05-21 16:38:35 (35596): Guest Log: *** Starting ATLAS job. (PandaID=6211388378 taskID=38921007) *** 2024-05-21 16:56:42 (35596): VM state change detected. (old = 'running', new = 'paused') 2024-05-21 16:57:02 (35596): VM state change detected. (old = 'paused', new = 'running') 2024-05-21 17:08:55 (35596): VM state change detected. (old = 'running', new = 'paused') 2024-05-21 17:09:17 (35596): VM state change detected. (old = 'paused', new = 'running') 2024-05-21 17:25:18 (35596): VM state change detected. (old = 'running', new = 'paused') 2024-05-21 17:25:38 (35596): VM state change detected. (old = 'paused', new = 'running') 2024-05-21 17:37:51 (35596): VM state change detected. (old = 'running', new = 'paused') 2024-05-21 17:38:12 (35596): VM state change detected. (old = 'paused', new = 'running') 2024-05-21 17:53:15 (35596): VM state change detected. (old = 'running', new = 'paused') 2024-05-21 17:53:36 (35596): VM state change detected. (old = 'paused', new = 'running') 2024-05-21 18:10:58 (35596): VM state change detected. (old = 'running', new = 'paused') 2024-05-21 18:11:19 (35596): VM state change detected. (old = 'paused', new = 'running') 2024-05-21 18:14:49 (35596): VM state change detected. (old = 'running', new = 'paused') 2024-05-21 18:15:10 (35596): VM state change detected. (old = 'paused', new = 'running') 2024-05-21 18:19:52 (35596): Status Report: Elapsed Time: '6000.000000' 2024-05-21 18:19:52 (35596): Status Report: CPU Time: '3293.421875' 2024-05-21 18:21:43 (35596): VM state change detected. (old = 'running', new = 'paused') 2024-05-21 18:22:03 (35596): VM state change detected. (old = 'paused', new = 'running') 2024-05-21 18:48:48 (35596): VM state change detected. (old = 'running', new = 'paused') 2024-05-21 18:49:09 (35596): VM state change detected. (old = 'paused', new = 'running') 2024-05-21 19:15:34 (35596): VM state change detected. (old = 'running', new = 'paused') 2024-05-21 19:15:54 (35596): VM state change detected. (old = 'paused', new = 'running') 2024-05-21 19:42:28 (35596): VM state change detected. (old = 'running', new = 'paused') 2024-05-21 19:42:49 (35596): VM state change detected. (old = 'paused', new = 'running') 2024-05-21 19:52:21 (35596): VM state change detected. (old = 'running', new = 'paused') 2024-05-21 19:52:42 (35596): VM state change detected. (old = 'paused', new = 'running') 2024-05-21 20:01:35 (35596): VM state change detected. (old = 'running', new = 'paused') 2024-05-21 20:01:55 (35596): VM state change detected. (old = 'paused', new = 'running') 2024-05-21 20:02:07 (35596): Status Report: Elapsed Time: '12000.000000' 2024-05-21 20:02:07 (35596): Status Report: CPU Time: '6922.343750' 2024-05-21 20:10:09 (35596): VM state change detected. (old = 'running', new = 'paused') 2024-05-21 20:10:29 (35596): VM state change detected. (old = 'paused', new = 'running') 2024-05-21 20:38:06 (35596): VM state change detected. (old = 'running', new = 'paused') 2024-05-21 20:38:26 (35596): VM state change detected. (old = 'paused', new = 'running') 2024-05-21 21:04:03 (35596): VM state change detected. (old = 'running', new = 'paused') 2024-05-21 21:04:23 (35596): VM state change detected. (old = 'paused', new = 'running') 2024-05-21 21:31:29 (35596): VM state change detected. (old = 'running', new = 'paused') 2024-05-21 21:31:49 (35596): VM state change detected. (old = 'paused', new = 'running') 2024-05-21 21:35:50 (35596): VM state change detected. (old = 'running', new = 'paused') 2024-05-21 21:36:10 (35596): VM state change detected. (old = 'paused', new = 'running') 2024-05-21 21:43:58 (35596): Status Report: Elapsed Time: '18000.635536' 2024-05-21 21:43:58 (35596): Status Report: CPU Time: '10648.078125' 2024-05-21 21:59:04 (35596): VM state change detected. (old = 'running', new = 'paused') 2024-05-21 21:59:24 (35596): VM state change detected. (old = 'paused', new = 'running') 2024-05-21 22:10:58 (35596): VM state change detected. (old = 'running', new = 'paused') 2024-05-21 22:11:18 (35596): VM state change detected. (old = 'paused', new = 'running') 2024-05-21 22:26:51 (35596): VM state change detected. (old = 'running', new = 'paused') 2024-05-21 22:27:12 (35596): VM state change detected. (old = 'paused', new = 'running') 2024-05-21 22:52:17 (35596): VM state change detected. (old = 'running', new = 'paused') 2024-05-21 22:52:38 (35596): VM state change detected. (old = 'paused', new = 'running') 2024-05-21 23:25:30 (35596): Status Report: Elapsed Time: '24000.635536' 2024-05-21 23:25:30 (35596): Status Report: CPU Time: '15128.437500' 2024-05-21 23:25:47 (35596): VM state change detected. (old = 'running', new = 'paused') 2024-05-21 23:26:08 (35596): VM state change detected. (old = 'paused', new = 'running') 2024-05-22 01:05:58 (35596): Status Report: Elapsed Time: '30000.635536' 2024-05-22 01:05:58 (35596): Status Report: CPU Time: '20172.078125' 2024-05-22 01:15:03 (35596): VM state change detected. (old = 'running', new = 'paused') 2024-05-22 01:15:24 (35596): VM state change detected. (old = 'paused', new = 'running') 2024-05-22 01:16:44 (35596): VM state change detected. (old = 'running', new = 'paused') 2024-05-22 01:17:05 (35596): VM state change detected. (old = 'paused', new = 'running') 2024-05-22 01:33:41 (35596): VM state change detected. (old = 'running', new = 'paused') 2024-05-22 01:34:02 (35596): VM state change detected. (old = 'paused', new = 'running') 2024-05-22 01:43:34 (35596): VM state change detected. (old = 'running', new = 'paused') 2024-05-22 01:43:55 (35596): VM state change detected. (old = 'paused', new = 'running') 2024-05-22 02:11:11 (35596): VM state change detected. (old = 'running', new = 'paused') 2024-05-22 02:11:32 (35596): VM state change detected. (old = 'paused', new = 'running') 2024-05-22 02:38:36 (35596): VM state change detected. (old = 'running', new = 'paused') 2024-05-22 02:38:56 (35596): VM state change detected. (old = 'paused', new = 'running') 2024-05-22 02:48:14 (35596): Status Report: Elapsed Time: '36000.635536' 2024-05-22 02:48:14 (35596): Status Report: CPU Time: '24427.234375' 2024-05-22 02:48:39 (35596): VM state change detected. (old = 'running', new = 'paused') 2024-05-22 02:48:59 (35596): VM state change detected. (old = 'paused', new = 'running') 2024-05-22 03:06:32 (35596): VM state change detected. (old = 'running', new = 'paused') 2024-05-22 03:06:52 (35596): VM state change detected. (old = 'paused', new = 'running') 2024-05-22 03:35:19 (35596): VM state change detected. (old = 'running', new = 'paused') 2024-05-22 03:35:40 (35596): VM state change detected. (old = 'paused', new = 'running') 2024-05-22 03:36:30 (35596): VM state change detected. (old = 'running', new = 'paused') 2024-05-22 03:36:31 (35596): VM state change detected. (old = 'paused', new = 'running') 2024-05-22 04:04:57 (35596): VM state change detected. (old = 'running', new = 'paused') 2024-05-22 04:05:17 (35596): VM state change detected. (old = 'paused', new = 'running') 2024-05-22 04:11:29 (35596): VM state change detected. (old = 'running', new = 'paused') 2024-05-22 04:11:49 (35596): VM state change detected. (old = 'paused', new = 'running') 2024-05-22 04:30:08 (35596): Status Report: Elapsed Time: '42000.635536' 2024-05-22 04:30:08 (35596): Status Report: CPU Time: '28912.921875' 2024-05-22 04:38:05 (35596): VM state change detected. (old = 'running', new = 'paused') 2024-05-22 04:38:25 (35596): VM state change detected. (old = 'paused', new = 'running') 2024-05-22 04:40:57 (35596): VM state change detected. (old = 'running', new = 'paused') 2024-05-22 04:41:17 (35596): VM state change detected. (old = 'paused', new = 'running') 2024-05-22 04:57:51 (35596): VM state change detected. (old = 'running', new = 'paused') 2024-05-22 04:58:11 (35596): VM state change detected. (old = 'paused', new = 'running') 2024-05-22 05:15:34 (35596): VM state change detected. (old = 'running', new = 'paused') 2024-05-22 05:15:54 (35596): VM state change detected. (old = 'paused', new = 'running') 2024-05-22 05:44:12 (35596): VM state change detected. (old = 'running', new = 'paused') 2024-05-22 05:44:33 (35596): VM state change detected. (old = 'paused', new = 'running') 2024-05-22 06:12:00 (35596): Status Report: Elapsed Time: '48000.635536' 2024-05-22 06:12:00 (35596): Status Report: CPU Time: '32650.546875' 2024-05-22 06:12:46 (35596): VM state change detected. (old = 'running', new = 'paused') 2024-05-22 06:13:06 (35596): VM state change detected. (old = 'paused', new = 'running') 2024-05-22 06:42:31 (35596): VM state change detected. (old = 'running', new = 'paused') 2024-05-22 06:42:51 (35596): VM state change detected. (old = 'paused', new = 'running') 2024-05-22 06:45:34 (35596): VM state change detected. (old = 'running', new = 'paused') 2024-05-22 06:45:54 (35596): VM state change detected. (old = 'paused', new = 'running') 2024-05-22 07:14:28 (35596): VM state change detected. (old = 'running', new = 'paused') 2024-05-22 07:14:48 (35596): VM state change detected. (old = 'paused', new = 'running') 2024-05-22 07:45:25 (35596): VM state change detected. (old = 'running', new = 'paused') 2024-05-22 07:45:45 (35596): VM state change detected. (old = 'paused', new = 'running') 2024-05-22 07:53:52 (35596): Status Report: Elapsed Time: '54000.635536' 2024-05-22 07:53:52 (35596): Status Report: CPU Time: '36861.171875' 2024-05-22 08:02:58 (35596): VM state change detected. (old = 'running', new = 'paused') 2024-05-22 08:03:18 (35596): VM state change detected. (old = 'paused', new = 'running') 2024-05-22 08:21:52 (35596): VM state change detected. (old = 'running', new = 'paused') 2024-05-22 08:22:13 (35596): VM state change detected. (old = 'paused', new = 'running') 2024-05-22 09:14:02 (35596): VM state change detected. (old = 'running', new = 'paused') 2024-05-22 09:14:22 (35596): VM state change detected. (old = 'paused', new = 'running') 2024-05-22 09:21:23 (35596): VM state change detected. (old = 'running', new = 'paused') 2024-05-22 09:21:44 (35596): VM state change detected. (old = 'paused', new = 'running') 2024-05-22 09:33:56 (35596): VM state change detected. (old = 'running', new = 'paused') 2024-05-22 09:34:16 (35596): VM state change detected. (old = 'paused', new = 'running') 2024-05-22 09:35:45 (35596): Status Report: Elapsed Time: '60000.635536' 2024-05-22 09:35:45 (35596): Status Report: CPU Time: '41225.156250' 2024-05-22 09:59:51 (35596): VM state change detected. (old = 'running', new = 'paused') 2024-05-22 10:00:11 (35596): VM state change detected. (old = 'paused', new = 'running') 2024-05-22 10:06:34 (35596): VM state change detected. (old = 'running', new = 'paused') 2024-05-22 10:06:54 (35596): VM state change detected. (old = 'paused', new = 'running') 2024-05-22 10:08:14 (35596): VM state change detected. (old = 'running', new = 'paused') 2024-05-22 10:08:34 (35596): VM state change detected. (old = 'paused', new = 'running') 2024-05-22 10:15:36 (35596): VM state change detected. (old = 'running', new = 'paused') 2024-05-22 10:15:56 (35596): VM state change detected. (old = 'paused', new = 'running') 2024-05-22 10:20:37 (35596): VM state change detected. (old = 'running', new = 'paused') 2024-05-22 10:20:57 (35596): VM state change detected. (old = 'paused', new = 'running') 2024-05-22 10:36:00 (35596): VM state change detected. (old = 'running', new = 'paused') 2024-05-22 10:36:20 (35596): VM state change detected. (old = 'paused', new = 'running') 2024-05-22 10:40:41 (35596): VM state change detected. (old = 'running', new = 'paused') 2024-05-22 10:41:01 (35596): VM state change detected. (old = 'paused', new = 'running') 2024-05-22 10:42:01 (35596): VM state change detected. (old = 'running', new = 'paused') 2024-05-22 10:42:22 (35596): VM state change detected. (old = 'paused', new = 'running') 2024-05-22 10:44:05 (35596): VM state change detected. (old = 'running', new = 'paused') 2024-05-22 10:44:23 (35596): VM state change detected. (old = 'paused', new = 'running') 2024-05-22 10:52:56 (35596): VM state change detected. (old = 'running', new = 'paused') 2024-05-22 10:53:16 (35596): VM state change detected. (old = 'paused', new = 'running') 2024-05-22 11:01:50 (35596): VM state change detected. (old = 'running', new = 'paused') 2024-05-22 11:02:10 (35596): VM state change detected. (old = 'paused', new = 'running') 2024-05-22 11:10:32 (35596): VM state change detected. (old = 'running', new = 'paused') 2024-05-22 11:10:52 (35596): VM state change detected. (old = 'paused', new = 'running') 2024-05-22 11:20:05 (35596): Status Report: Elapsed Time: '66000.635536' 2024-05-22 11:20:05 (35596): Status Report: CPU Time: '45635.406250' 2024-05-22 11:30:07 (35596): VM state change detected. (old = 'running', new = 'paused') 2024-05-22 11:30:27 (35596): VM state change detected. (old = 'paused', new = 'running') 2024-05-22 11:42:31 (35596): VM state change detected. (old = 'running', new = 'paused') 2024-05-22 11:42:51 (35596): VM state change detected. (old = 'paused', new = 'running') 2024-05-22 11:49:22 (35596): VM state change detected. (old = 'running', new = 'paused') 2024-05-22 11:49:43 (35596): VM state change detected. (old = 'paused', new = 'running') 2024-05-22 11:52:53 (35596): VM state change detected. (old = 'running', new = 'paused') 2024-05-22 11:53:13 (35596): VM state change detected. (old = 'paused', new = 'running') 2024-05-22 11:56:34 (35596): VM state change detected. (old = 'running', new = 'paused') 2024-05-22 11:56:54 (35596): VM state change detected. (old = 'paused', new = 'running') 2024-05-22 12:12:17 (35596): VM state change detected. (old = 'running', new = 'paused') 2024-05-22 12:12:37 (35596): VM state change detected. (old = 'paused', new = 'running') 2024-05-22 12:14:47 (35596): VM state change detected. (old = 'running', new = 'paused') 2024-05-22 12:15:07 (35596): VM state change detected. (old = 'paused', new = 'running') 2024-05-22 12:16:07 (35596): VM state change detected. (old = 'running', new = 'paused') 2024-05-22 12:16:27 (35596): VM state change detected. (old = 'paused', new = 'running') 2024-05-22 12:43:12 (35596): VM state change detected. (old = 'running', new = 'paused') 2024-05-22 12:43:53 (35596): VM state change detected. (old = 'paused', new = 'running') 2024-05-22 12:49:57 (35596): VM state change detected. (old = 'running', new = 'paused') 2024-05-22 12:49:58 (35596): VM state change detected. (old = 'paused', new = 'running') 2024-05-22 12:55:57 (35596): VM state change detected. (old = 'running', new = 'paused') 2024-05-22 12:56:17 (35596): VM state change detected. (old = 'paused', new = 'running') 2024-05-22 13:04:08 (35596): Status Report: Elapsed Time: '72000.635536' 2024-05-22 13:04:08 (35596): Status Report: CPU Time: '50236.250000' 2024-05-22 13:21:01 (35596): VM state change detected. (old = 'running', new = 'paused') 2024-05-22 13:21:22 (35596): VM state change detected. (old = 'paused', new = 'running') 2024-05-22 13:44:10 (35596): VM state change detected. (old = 'running', new = 'paused') 2024-05-22 13:44:28 (35596): VM state change detected. (old = 'paused', new = 'running') 2024-05-22 13:48:28 (35596): VM state change detected. (old = 'running', new = 'paused') 2024-05-22 13:48:49 (35596): VM state change detected. (old = 'paused', new = 'running') 2024-05-22 13:53:09 (35596): VM state change detected. (old = 'running', new = 'paused') 2024-05-22 13:53:30 (35596): VM state change detected. (old = 'paused', new = 'running') 2024-05-22 14:24:47 (35596): VM state change detected. (old = 'running', new = 'paused') 2024-05-22 14:25:08 (35596): VM state change detected. (old = 'paused', new = 'running') 2024-05-22 14:46:04 (35596): Status Report: Elapsed Time: '78000.635536' 2024-05-22 14:46:04 (35596): Status Report: CPU Time: '54506.453125' 2024-05-22 14:54:13 (35596): VM state change detected. (old = 'running', new = 'paused') 2024-05-22 14:54:33 (35596): VM state change detected. (old = 'paused', new = 'running') 2024-05-22 14:57:04 (35596): VM state change detected. (old = 'running', new = 'paused') 2024-05-22 14:57:24 (35596): VM state change detected. (old = 'paused', new = 'running') 2024-05-22 15:04:16 (35596): VM state change detected. (old = 'running', new = 'paused') 2024-05-22 15:04:26 (35596): Stopping VM. 2024-05-22 15:05:12 (35596): Error in stop VM for VM: -182 Command: VBoxManage -q controlvm "boinc_ac126dfc4892e95c" savestate Output: 0%...10%...20%...30%...40%...50%...60%... 2024-05-22 15:05:12 (35596): VM did not stop when requested. 2024-05-22 15:05:12 (35596): VM was successfully terminated. 2024-05-22 19:29:20 (1700): Detected: vboxwrapper 26206 2024-05-22 19:29:20 (1700): Detected: BOINC client v7.24.1 2024-05-22 19:29:34 (1700): Detected: VirtualBox VboxManage Interface (Version: 7.0.14) 2024-05-22 19:29:37 (1700): Guest Log: BIOS: VirtualBox 7.0.14 2024-05-22 19:29:37 (1700): Guest Log: CPUID EDX: 0x178bfbff 2024-05-22 19:29:37 (1700): Guest Log: BIOS: No PCI IDE controller, not probing IDE 2024-05-22 19:29:37 (1700): Guest Log: BIOS: AHCI 0-P#0: PCHS=16383/16/63 LCHS=1024/255/63 0x0000000002800000 sectors 2024-05-22 19:29:37 (1700): Guest Log: BIOS: Boot : bseqnr=1, bootseq=0032 2024-05-22 19:29:37 (1700): Guest Log: BIOS: Booting from Hard Disk... 2024-05-22 19:29:37 (1700): Guest Log: BIOS: KBD: unsupported int 16h function 03 2024-05-22 19:29:37 (1700): Guest Log: BIOS: AX=0305 BX=0000 CX=0000 DX=0000 2024-05-22 19:29:37 (1700): Guest Log: int13_harddisk_ext: function 41, unmapped device for ELDL=81 2024-05-22 19:29:37 (1700): Guest Log: int13_harddisk: function 02, unmapped device for ELDL=81 2024-05-22 19:29:37 (1700): Guest Log: int13_harddisk_ext: function 41, unmapped device for ELDL=82 2024-05-22 19:29:37 (1700): Guest Log: int13_harddisk: function 02, unmapped device for ELDL=82 2024-05-22 19:29:37 (1700): Guest Log: int13_harddisk_ext: function 41, unmapped device for ELDL=83 2024-05-22 19:29:37 (1700): Guest Log: int13_harddisk: function 02, unmapped device for ELDL=83 2024-05-22 19:29:37 (1700): Guest Log: int13_harddisk_ext: function 41, unmapped device for ELDL=84 2024-05-22 19:29:37 (1700): Guest Log: int13_harddisk: function 02, unmapped device for ELDL=84 2024-05-22 19:29:37 (1700): Guest Log: int13_harddisk_ext: function 41, unmapped device for ELDL=85 2024-05-22 19:29:37 (1700): Guest Log: int13_harddisk: function 02, unmapped device for ELDL=85 2024-05-22 19:29:37 (1700): Guest Log: int13_harddisk_ext: function 41, unmapped device for ELDL=86 2024-05-22 19:29:37 (1700): Guest Log: int13_harddisk: function 02, unmapped device for ELDL=86 2024-05-22 19:29:37 (1700): Guest Log: int13_harddisk_ext: function 41, unmapped device for ELDL=87 2024-05-22 19:29:37 (1700): Guest Log: int13_harddisk: function 02, unmapped device for ELDL=87 2024-05-22 19:29:37 (1700): Guest Log: int13_harddisk_ext: function 41, unmapped device for ELDL=88 2024-05-22 19:29:37 (1700): Guest Log: int13_harddisk: function 02, unmapped device for ELDL=88 2024-05-22 19:29:37 (1700): Guest Log: int13_harddisk_ext: function 41, unmapped device for ELDL=89 2024-05-22 19:29:37 (1700): Guest Log: int13_harddisk: function 02, unmapped device for ELDL=89 2024-05-22 19:29:37 (1700): Guest Log: int13_harddisk_ext: function 41, unmapped device for ELDL=8a 2024-05-22 19:29:37 (1700): Guest Log: int13_harddisk: function 02, unmapped device for ELDL=8a 2024-05-22 19:29:37 (1700): Guest Log: int13_harddisk_ext: function 41, unmapped device for ELDL=8b 2024-05-22 19:29:37 (1700): Guest Log: int13_harddisk: function 02, unmapped device for ELDL=8b 2024-05-22 19:29:37 (1700): Guest Log: int13_harddisk_ext: function 41, unmapped device for ELDL=8c 2024-05-22 19:29:37 (1700): Guest Log: int13_harddisk: function 02, unmapped device for ELDL=8c 2024-05-22 19:29:37 (1700): Guest Log: int13_harddisk_ext: function 41, unmapped device for ELDL=8d 2024-05-22 19:29:37 (1700): Guest Log: int13_harddisk: function 02, unmapped device for ELDL=8d 2024-05-22 19:29:37 (1700): Guest Log: int13_harddisk_ext: function 41, unmapped device for ELDL=8e 2024-05-22 19:29:37 (1700): Guest Log: int13_harddisk: function 02, unmapped device for ELDL=8e 2024-05-22 19:29:37 (1700): Guest Log: int13_harddisk_ext: function 41, unmapped device for ELDL=8f 2024-05-22 19:29:37 (1700): Guest Log: int13_harddisk: function 02, unmapped device for ELDL=8f 2024-05-22 19:29:37 (1700): Guest Log: vgdrvHeartbeatInit: Setting up heartbeat to trigger every 2000 milliseconds 2024-05-22 19:29:37 (1700): Guest Log: vboxguest: misc device minor 58, IRQ 20, I/O port d020, MMIO at 00000000f0400000 (size 0x400000) 2024-05-22 19:29:37 (1700): Guest Log: VBoxService 5.2.32 r132073 (verbosity: 0) linux.amd64 (Jul 12 2019 10:32:28) release log 2024-05-22 19:29:37 (1700): Guest Log: 00:00:00.000260 main Log opened 2024-05-21T16:37:55.755921000Z 2024-05-22 19:29:37 (1700): Guest Log: 00:00:00.000432 main OS Product: Linux 2024-05-22 19:29:37 (1700): Guest Log: 00:00:00.000499 main OS Release: 3.10.0-957.27.2.el7.x86_64 2024-05-22 19:29:37 (1700): Guest Log: 00:00:00.000539 main OS Version: #1 SMP Mon Jul 29 17:46:05 UTC 2019 2024-05-22 19:29:37 (1700): Guest Log: 00:00:00.000567 main Executable: /opt/VBoxGuestAdditions-5.2.32/sbin/VBoxService 2024-05-22 19:29:37 (1700): Guest Log: 00:00:00.000568 main Process ID: 1244 2024-05-22 19:29:37 (1700): Guest Log: 00:00:00.000568 main Package type: LINUX_64BITS_GENERIC 2024-05-22 19:29:37 (1700): Guest Log: 00:00:00.003613 main 5.2.32 r132073 started. Verbose level = 0 2024-05-22 19:29:37 (1700): Guest Log: [INFO] Probing /cvmfs/atlas.cern.ch... 2024-05-22 19:29:37 (1700): Guest Log: [INFO] Mounting shared directory 2024-05-22 19:29:37 (1700): Guest Log: [INFO] Checking for init_data.xml 2024-05-22 19:29:37 (1700): Guest Log: 00:00:10.044661 timesync vgsvcTimeSyncWorker: Radical guest time change: 25 210 888 241 000ns (GuestNow=1 716 334 686 684 745 000 ns GuestLast=1 716 309 475 796 504 000 ns fSetTimeLastLoop=true ) 2024-05-22 19:29:37 (1700): Guest Log: [INFO] Probing /cvmfs/atlas.cern.ch... OK 2024-05-22 19:29:37 (1700): Guest Log: [INFO] Detected branch: prod 2024-05-22 19:29:37 (1700): Guest Log: This is the prod version of the ATLAS job wrapper 2024-05-22 19:29:37 (1700): Guest Log: Copying input files 2024-05-22 19:29:37 (1700): Guest Log: Copied input files into RunAtlas. 2024-05-22 19:29:37 (1700): Guest Log: This VM did not configure a local http proxy via BOINC. 2024-05-22 19:29:37 (1700): Guest Log: Small home clusters do not require a local http proxy but it is suggested if 2024-05-22 19:29:37 (1700): Guest Log: more than 10 cores throughout the same LAN segment are regularly running ATLAS like tasks. 2024-05-22 19:29:37 (1700): Guest Log: Further information can be found at the LHC@home message board. 2024-05-22 19:29:37 (1700): Guest Log: Running cvmfs_config stat atlas.cern.ch 2024-05-22 19:29:37 (1700): 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 2024-05-22 19:29:37 (1700): Guest Log: 2.6.3.0 1541 0 30068 133007 4 1 3116989 4096000 0 65024 0 0 n/a 1 0 http://s1ral-cvmfs.openhtc.io/cvmfs/atlas.cern.ch DIRECT 1 2024-05-22 19:29:37 (1700): Guest Log: copied the webapp to /var/www 2024-05-22 19:29:37 (1700): Guest Log: core_number=1 2024-05-22 19:29:37 (1700): Guest Log: Apptainer command /cvmfs/atlas.cern.ch/repo/containers/sw/apptainer/x86_64-el7/current/bin/apptainer exec -B /cvmfs,/data,/home/atlas/RunAtlas /cvmfs/atlas.cern.ch/repo/containers/fs/singularity/x86_64-centos7 2024-05-22 19:29:37 (1700): Guest Log: *** Starting ATLAS job. (PandaID=6211388378 taskID=38921007) *** 2024-05-22 19:29:37 (1700): Starting VM using VBoxManage interface. (boinc_ac126dfc4892e95c, slot#15) 2024-05-22 19:30:29 (1700): Error in start VM for VM: -2147467259 Command: VBoxManage -q startvm "boinc_ac126dfc4892e95c" --type headless Output: VBoxManage.exe: error: The VM session was aborted VBoxManage.exe: error: Details: code E_FAIL (0x80004005), component SessionMachine, interface ISession Waiting for VM "boinc_ac126dfc4892e95c" to power on... 2024-05-22 19:30:29 (1700): VM failed to start. 2024-05-22 19:30:29 (1700): Could not start 2024-05-22 19:30:29 (1700): ERROR: VM failed to start 2024-05-22 19:30:29 (1700): Powering off VM. 2024-05-22 19:30:29 (1700): Deregistering VM. (boinc_ac126dfc4892e95c, slot#15) 2024-05-22 19:30:29 (1700): Removing network bandwidth throttle group from VM. 2024-05-22 19:30:29 (1700): Removing VM from VirtualBox. Hypervisor System Log: 00:00:58.872431 USBPROXY usbLibGetDevices: Starting USB device enumeration 00:00:58.949530 USBPROXY Getting USB descriptor (id 0) failed (dwErr=31) on hub USB#ROOT_HUB30#4&6970116&0&0#{f18a0e88-c30c-11d0-8815-00a0c906bed8} port 4 00:00:58.979489 USBPROXY Getting USB descriptor (id 0) failed (dwErr=31) on hub USB#VID_05E3&PID_0608#5&2cf64626&0&13#{f18a0e88-c30c-11d0-8815-00a0c906bed8} port 4 00:00:58.979624 USBPROXY Getting USB descriptor (id 0) failed (dwErr=31) on hub USB#ROOT_HUB30#4&6970116&0&0#{f18a0e88-c30c-11d0-8815-00a0c906bed8} port 14 00:00:58.979854 USBPROXY usbLibGetDevices: Found 8 USB devices, 0 captured 00:01:00.740249 Finished saving settings file "E:\BOINC\Data\slots\3\boinc_2d068c7408dc585c\boinc_2d068c7408dc585c.vbox" 00:01:00.847439 Saving settings file "E:\BOINC\Data\slots\3\boinc_2d068c7408dc585c\boinc_2d068c7408dc585c.vbox" with version "1.19-windows" 00:01:00.952211 Finished saving settings file "E:\BOINC\Data\slots\3\boinc_2d068c7408dc585c\boinc_2d068c7408dc585c.vbox" 00:01:00.964591 USBPROXY usbLibGetDevices: Starting USB device enumeration 00:01:00.968582 USBPROXY Getting USB descriptor (id 0) failed (dwErr=31) on hub USB#ROOT_HUB30#4&6970116&0&0#{f18a0e88-c30c-11d0-8815-00a0c906bed8} port 4 00:01:00.986170 USBPROXY Getting USB descriptor (id 0) failed (dwErr=31) on hub USB#VID_05E3&PID_0608#5&2cf64626&0&13#{f18a0e88-c30c-11d0-8815-00a0c906bed8} port 4 00:01:00.986231 USBPROXY Getting USB descriptor (id 0) failed (dwErr=31) on hub USB#ROOT_HUB30#4&6970116&0&0#{f18a0e88-c30c-11d0-8815-00a0c906bed8} port 14 00:01:00.986379 USBPROXY usbLibGetDevices: Found 8 USB devices, 0 captured 00:01:01.104689 ERROR [COM]: aRC=VBOX_E_NOT_SUPPORTED (0x80bb0009) aIID={300763af-5d6b-46e6-aa96-273eac15538a} aComponent={SessionMachine} aText={This VM is not encrypted}, preserve=false aResultDetail=0 00:01:01.108091 ERROR [COM]: aRC=VBOX_E_OBJECT_NOT_FOUND (0x80bb0001) aIID={300763af-5d6b-46e6-aa96-273eac15538a} aComponent={SessionMachine} aText={No storage device attached to device slot 0 on port 2 of controller 'Hard Disk Controller'}, preserve=false aResultDetail=0 00:01:01.108139 ERROR [COM]: aRC=VBOX_E_OBJECT_NOT_FOUND (0x80bb0001) aIID={300763af-5d6b-46e6-aa96-273eac15538a} aComponent={SessionMachine} aText={No storage device attached to device slot 0 on port 2 of controller 'Hard Disk Controller'}, preserve=false aResultDetail=0 00:01:01.317285 ERROR [COM]: aRC=E_FAIL (0x80004005) aIID={300763af-5d6b-46e6-aa96-273eac15538a} aComponent={SessionMachine} aText={This machine does not have any snapshots}, preserve=false aResultDetail=0 00:01:01.620330 Launched VM: 3902337040 pid: 10436 (0x28c4) frontend: headless name: boinc_2d068c7408dc585c 00:01:03.778057 Watcher Saving settings file "E:\BOINC\Data\slots\15\boinc_ac126dfc4892e95c\boinc_ac126dfc4892e95c.vbox" with version "1.19-windows" 00:01:03.807651 ERROR [COM]: aRC=VBOX_E_OBJECT_NOT_FOUND (0x80bb0001) aIID={ad47ad09-787b-44ab-b343-a082a3f2dfb1} aComponent={MediumWrap} aText={Property 'CRYPT/KeyId' does not exist}, preserve=false aResultDetail=0 00:01:03.808088 ERROR [COM]: aRC=VBOX_E_OBJECT_NOT_FOUND (0x80bb0001) aIID={ad47ad09-787b-44ab-b343-a082a3f2dfb1} aComponent={MediumWrap} aText={Property 'CRYPT/KeyId' does not exist}, preserve=false aResultDetail=0 00:01:03.974686 Watcher Finished saving settings file "E:\BOINC\Data\slots\15\boinc_ac126dfc4892e95c\boinc_ac126dfc4892e95c.vbox" 00:01:03.975920 Watcher Reaper: Pid 13820 (0x35fc) exited normally: -2147483645 (0x80000003) 00:01:04.030419 ERROR [COM]: aRC=E_FAIL (0x80004005) aIID={300763af-5d6b-46e6-aa96-273eac15538a} aComponent={SessionMachine} aText={This machine does not have any snapshots}, preserve=false aResultDetail=0 00:01:04.082799 Saving settings file "E:\BOINC\Data\slots\15\boinc_ac126dfc4892e95c\boinc_ac126dfc4892e95c.vbox" with version "1.19-windows" 00:01:04.169029 Finished saving settings file "E:\BOINC\Data\slots\15\boinc_ac126dfc4892e95c\boinc_ac126dfc4892e95c.vbox" 00:01:04.337314 Saving settings file "C:\Users\PMS\.VirtualBox\VirtualBox.xml" with version "1.12-windows" 00:01:04.339570 Finished saving settings file "C:\Users\PMS\.VirtualBox\VirtualBox.xml" 00:01:04.339771 Saving settings file "E:\BOINC\Data\slots\6\boinc_d152967ca35e4e4e\boinc_d152967ca35e4e4e.vbox" with version "1.19-windows" 00:01:04.485576 Finished saving settings file "E:\BOINC\Data\slots\6\boinc_d152967ca35e4e4e\boinc_d152967ca35e4e4e.vbox" 00:01:04.486418 DeleteVM Saving settings file "E:\BOINC\Data\slots\6\boinc_d152967ca35e4e4e\boinc_d152967ca35e4e4e.vbox" with version "1.19-windows" 00:01:04.575513 DeleteVM Finished saving settings file "E:\BOINC\Data\slots\6\boinc_d152967ca35e4e4e\boinc_d152967ca35e4e4e.vbox" 00:01:04.640927 Watcher Saving settings file "E:\BOINC\Data\slots\6\boinc_d152967ca35e4e4e\boinc_d152967ca35e4e4e.vbox" with version "1.19-windows" 00:01:04.735830 Watcher Finished saving settings file "E:\BOINC\Data\slots\6\boinc_d152967ca35e4e4e\boinc_d152967ca35e4e4e.vbox" 00:01:04.736828 Watcher Reaper: Pid 12656 (0x3170) exited normally: -2147483645 (0x80000003) 00:01:04.794405 ERROR [COM]: aRC=E_FAIL (0x80004005) aIID={300763af-5d6b-46e6-aa96-273eac15538a} aComponent={SessionMachine} aText={This machine does not have any snapshots}, preserve=false aResultDetail=0 00:01:04.845819 Saving settings file "E:\BOINC\Data\slots\6\boinc_d152967ca35e4e4e\boinc_d152967ca35e4e4e.vbox" with version "1.19-windows" 00:01:04.991976 Finished saving settings file "E:\BOINC\Data\slots\6\boinc_d152967ca35e4e4e\boinc_d152967ca35e4e4e.vbox" 00:01:05.099843 Saving settings file "E:\BOINC\Data\slots\1\boinc_ea8c3786b8f4df0f\boinc_ea8c3786b8f4df0f.vbox" with version "1.19-windows" 00:01:05.211682 Finished saving settings file "E:\BOINC\Data\slots\1\boinc_ea8c3786b8f4df0f\boinc_ea8c3786b8f4df0f.vbox" 00:01:05.211929 Saving settings file "C:\Users\PMS\.VirtualBox\VirtualBox.xml" with version "1.12-windows" 00:01:05.259052 Finished saving settings file "C:\Users\PMS\.VirtualBox\VirtualBox.xml" 00:01:05.259213 Saving settings file "C:\Users\PMS\.VirtualBox\VirtualBox.xml" with version "1.12-windows" 00:01:05.261300 Finished saving settings file "C:\Users\PMS\.VirtualBox\VirtualBox.xml" 00:01:05.262162 DeleteVM Saving settings file "C:\Users\PMS\.VirtualBox\VirtualBox.xml" with version "1.12-windows" 00:01:05.264563 DeleteVM Finished saving settings file "C:\Users\PMS\.VirtualBox\VirtualBox.xml" 00:01:06.531098 ERROR [COM]: aRC=VBOX_E_OBJECT_NOT_FOUND (0x80bb0001) aIID={ad47ad09-787b-44ab-b343-a082a3f2dfb1} aComponent={MediumWrap} aText={Property 'CRYPT/KeyId' does not exist}, preserve=false aResultDetail=0 00:01:06.531531 ERROR [COM]: aRC=VBOX_E_OBJECT_NOT_FOUND (0x80bb0001) aIID={ad47ad09-787b-44ab-b343-a082a3f2dfb1} aComponent={MediumWrap} aText={Property 'CRYPT/KeyId' does not exist}, preserve=false aResultDetail=0 00:01:07.592216 Saving settings file "E:\BOINC\Data\slots\3\boinc_2d068c7408dc585c\boinc_2d068c7408dc585c.vbox" with version "1.19-windows" 00:01:07.757182 Finished saving settings file "E:\BOINC\Data\slots\3\boinc_2d068c7408dc585c\boinc_2d068c7408dc585c.vbox" 00:01:14.322282 USBPROXY usbLibGetDevices: Starting USB device enumeration 00:01:14.337836 USBPROXY Getting USB descriptor (id 0) failed (dwErr=31) on hub USB#ROOT_HUB30#4&6970116&0&0#{f18a0e88-c30c-11d0-8815-00a0c906bed8} port 4 00:01:14.355159 USBPROXY Getting USB descriptor (id 0) failed (dwErr=31) on hub USB#VID_05E3&PID_0608#5&2cf64626&0&13#{f18a0e88-c30c-11d0-8815-00a0c906bed8} port 4 00:01:14.355234 USBPROXY Getting USB descriptor (id 0) failed (dwErr=31) on hub USB#ROOT_HUB30#4&6970116&0&0#{f18a0e88-c30c-11d0-8815-00a0c906bed8} port 14 00:01:14.355398 USBPROXY usbLibGetDevices: Found 8 USB devices, 0 captured VM Execution Log: VM Startup Log: VM Trace Log: lt audio driver: Windows Audio Session Autostart database path: Default Guest Additions ISO: E:\VBox/VBoxGuestAdditions.iso Logging Level: all Proxy Mode: System Proxy URL: User language: C 2024-05-22 19:29:34 (1700): Command: VBoxManage -q list hostinfo Exit Code: 0 Output: Host Information: Host time: 2024-05-23T02:29:34.738000000Z Processor online count: 16 Processor count: 16 Processor online core count: 10 Processor core count: 10 Processor supports HW virtualization: yes Processor supports PAE: yes Processor supports long mode: yes Processor supports nested paging: yes Processor supports unrestricted guest: yes Processor supports nested HW virtualization: yes Processor supports virt. vmsave/vmload: no Processor#0 speed: unknown Processor#0 description: 12th Gen Intel(R) Core(TM) i5-12600K Processor#1 speed: unknown Processor#1 description: 12th Gen Intel(R) Core(TM) i5-12600K Processor#2 speed: unknown Processor#2 description: 12th Gen Intel(R) Core(TM) i5-12600K Processor#3 speed: unknown Processor#3 description: 12th Gen Intel(R) Core(TM) i5-12600K Processor#4 speed: unknown Processor#4 description: 12th Gen Intel(R) Core(TM) i5-12600K Processor#5 speed: unknown Processor#5 description: 12th Gen Intel(R) Core(TM) i5-12600K Processor#6 speed: unknown Processor#6 description: 12th Gen Intel(R) Core(TM) i5-12600K Processor#7 speed: unknown Processor#7 description: 12th Gen Intel(R) Core(TM) i5-12600K Processor#8 speed: unknown Processor#8 description: 12th Gen Intel(R) Core(TM) i5-12600K Processor#9 speed: unknown Processor#9 description: 12th Gen Intel(R) Core(TM) i5-12600K Processor#10 speed: unknown Processor#10 description: 12th Gen Intel(R) Core(TM) i5-12600K Processor#11 speed: unknown Processor#11 description: 12th Gen Intel(R) Core(TM) i5-12600K Processor#12 speed: unknown Processor#12 description: 12th Gen Intel(R) Core(TM) i5-12600K Processor#13 speed: unknown Processor#13 description: 12th Gen Intel(R) Core(TM) i5-12600K Processor#14 speed: unknown Processor#14 description: 12th Gen Intel(R) Core(TM) i5-12600K Processor#15 speed: unknown Processor#15 description: 12th Gen Intel(R) Core(TM) i5-12600K Memory size: 32509 MByte Memory available: 26821 MByte Operating system: Windows 11 Operating system version: 10.0.22000 2024-05-22 19:29:36 (1700): Command: VBoxManage -q showvminfo "boinc_ac126dfc4892e95c" --machinereadable Exit Code: 0 Output: name="boinc_ac126dfc4892e95c" Encryption: disabled groups="/" ostype="Linux 2.6 / 3.x / 4.x / 5.x (64-bit)" UUID="ca2a45aa-3385-47ed-ac09-81e354b03e8d" CfgFile="E:\\BOINC\\Data\\slots\\15\\boinc_ac126dfc4892e95c\\boinc_ac126dfc4892e95c.vbox" SnapFldr="E:\\BOINC\\Data\\slots\\15\\boinc_ac126dfc4892e95c\\Snapshots" LogFldr="E:\\BOINC\\Data\\slots\\15\\boinc_ac126dfc4892e95c\\Logs" hardwareuuid="ca2a45aa-3385-47ed-ac09-81e354b03e8d" memory=4100 pagefusion="off" vram=16 cpuexecutioncap=90 hpet="off" cpu-profile="host" chipset="piix3" firmware="BIOS" cpus=1 pae="on" longmode="on" triplefaultreset="off" apic="on" x2apic="on" nested-hw-virt="off" cpuid-portability-level=0 bootmenu="messageandmenu" boot1="disk" boot2="dvd" boot3="none" boot4="none" acpi="on" ioapic="on" biosapic="apic" biossystemtimeoffset=0 BIOS NVRAM File="E:\\BOINC\\Data\\slots\\15\\boinc_ac126dfc4892e95c\\boinc_ac126dfc4892e95c.nvram" rtcuseutc="off" hwvirtex="on" nestedpaging="on" largepages="on" vtxvpid="on" vtxux="on" virtvmsavevmload="on" iommu="none" paravirtprovider="default" effparavirtprovider="kvm" VMState="aborted" VMStateChangeTime="2024-05-22T22:05:14.000000000" graphicscontroller="vboxvga" monitorcount=1 accelerate3d="off" accelerate2dvideo="off" teleporterenabled="off" teleporterport=0 teleporteraddress="" teleporterpassword="" tracing-enabled="off" tracing-allow-vm-access="off" tracing-config="" autostart-enabled="off" autostart-delay=0 defaultfrontend="" vmprocpriority="default" storagecontrollername0="Hard Disk Controller" storagecontrollertype0="IntelAhci" storagecontrollerinstance0="0" storagecontrollermaxportcount0="30" storagecontrollerportcount0="3" storagecontrollerbootable0="on" "Hard Disk Controller-0-0"="E:\\BOINC\\Data\\slots\\15\\boinc_ac126dfc4892e95c\\Snapshots/{a06f2fac-d5fa-431a-90a9-9db952ca4561}.vdi" "Hard Disk Controller-ImageUUID-0-0"="a06f2fac-d5fa-431a-90a9-9db952ca4561" "Hard Disk Controller-nonrotational-0-0"="off" "Hard Disk Controller-discard-0-0"="off" "Hard Disk Controller-1-0"="E:\\VBox\\VBoxGuestAdditions.iso" "Hard Disk Controller-ImageUUID-1-0"="740cc23d-53a2-410a-a63c-6bdfb3513f61" "Hard Disk Controller-tempeject-1-0"="off" "Hard Disk Controller-IsEjected-1-0"="off" "Hard Disk Controller-nonrotational-1-0"="off" "Hard Disk Controller-discard-1-0"="off" "Hard Disk Controller-2-0"="none" natnet1="nat" macaddress1="0800275EC09F" cableconnected1="on" nic1="nat" nictype1="82540EM" nicspeed1="0" mtu="0" sockSnd="64" sockRcv="64" tcpWndSnd="64" tcpWndRcv="64" Forwarding(0)="tcp_62903_80,tcp,127.0.0.1,62903,,80" nic2="none" nic3="none" nic4="none" nic5="none" nic6="none" nic7="none" nic8="none" hidpointing="ps2mouse" hidkeyboard="ps2kbd" uart1="off" uart2="off" uart3="off" uart4="off" lpt1="off" lpt2="off" audio="none" audio_out="off" audio_in="off" clipboard="disabled" draganddrop="disabled" vrde="on" vrdeport=-1 vrdeports="62904" vrdeaddress="" vrdeauthtype="null" vrdemulticon="off" vrdereusecon="off" vrdevideochannel="off" vrdeproperty[TCP/Ports]="62904" vrdeproperty[TCP/Address]=<not set> vrdeproperty[VideoChannel/Enabled]=<not set> vrdeproperty[VideoChannel/Quality]=<not set> vrdeproperty[VideoChannel/DownscaleProtection]=<not set> vrdeproperty[Client/DisableDisplay]=<not set> vrdeproperty[Client/DisableInput]=<not set> vrdeproperty[Client/DisableAudio]=<not set> vrdeproperty[Client/DisableUSB]=<not set> vrdeproperty[Client/DisableClipboard]=<not set> vrdeproperty[Client/DisableUpstreamAudio]=<not set> vrdeproperty[Client/DisableRDPDR]=<not set> vrdeproperty[H3DRedirect/Enabled]=<not set> vrdeproperty[Security/Method]=<not set> vrdeproperty[Security/ServerCertificate]=<not set> vrdeproperty[Security/ServerPrivateKey]=<not set> vrdeproperty[Security/CACertificate]=<not set> vrdeproperty[Audio/RateCorrectionMode]=<not set> vrdeproperty[Audio/LogPath]=<not set> usb="off" ehci="off" xhci="off" BandwidthGroup0="boinc_ac126dfc4892e95c_net",Network,1099511627776 SharedFolderNameMachineMapping1="shared" SharedFolderPathMachineMapping1="E:\\BOINC\\Data\\slots\\15\\shared" recording_enabled="off" recording_screens=1 rec_screen0 rec_screen_enabled="on" rec_screen_id=0 rec_screen_video_enabled="on" rec_screen_audio_enabled="off" rec_screen_dest="File" rec_screen_dest_filename="E:\\BOINC\\Data\\slots\\15\\boinc_ac126dfc4892e95c\\boinc_ac126dfc4892e95c-screen0.webm" rec_screen_opts="vc_enabled=true,ac_enabled=false,ac_profile=med" rec_screen_video_res_xy="1024x768" rec_screen_video_rate_kbps=512 rec_screen_video_fps=25 description="C7aLDmu2bT5n9Rq4apoT9bVoABFKDmABFKDmlqFKDm6iOKDmlQJ5So_0" GuestMemoryBalloon=0 2024-05-22 19:30:29 (1700): Command: VBoxManage -q startvm "boinc_ac126dfc4892e95c" --type headless Exit Code: -2147467259 Output: VBoxManage.exe: error: The VM session was aborted VBoxManage.exe: error: Details: code E_FAIL (0x80004005), component SessionMachine, interface ISession Waiting for VM "boinc_ac126dfc4892e95c" to power on... 2024-05-22 19:30:29 (1700): Command: VBoxManage -q snapshot "boinc_ac126dfc4892e95c" list Exit Code: -108 Output: This machine does not have any snapshots 2024-05-22 19:30:29 (1700): Command: VBoxManage -q bandwidthctl "boinc_ac126dfc4892e95c" remove "boinc_ac126dfc4892e95c_net" Exit Code: 0 Output: 2024-05-22 19:30:30 (1700): Command: VBoxManage -q unregistervm "boinc_ac126dfc4892e95c" --delete Exit Code: 0 Output: 0%...10%...20%...30%...40%...50%...60%...70%...80%...90%...100% 19:30:40 (1700): called boinc_finish(-2147467259) </stderr_txt> ]]>
©2024 CERN