Name | CMS_2214942_1658892771.989121_0 |
Workunit | 2198916 |
Created | 27 Jul 2022, 3:32:54 UTC |
Sent | 28 Jul 2022, 5:19:53 UTC |
Report deadline | 4 Aug 2022, 5:19:53 UTC |
Received | 29 Jul 2022, 5:16:43 UTC |
Server state | Over |
Outcome | Computation error |
Client state | Compute error |
Exit status | 194 (0x000000C2) EXIT_ABORTED_BY_CLIENT |
Computer ID | 4164 |
Run time | 8 hours 30 min 27 sec |
CPU time | 7 hours 45 min 38 sec |
Validate state | Invalid |
Credit | 0.00 |
Device peak FLOPS | 21.14 GFLOPS |
Application version | CMS Simulation v60.63 (vbox64_mt_mcore_cms) windows_x86_64 |
Peak working set size | 118.68 MB |
Peak swap size | 140.46 MB |
Peak disk usage | 648.99 MB |
<core_client_version>7.16.20</core_client_version> <![CDATA[ <message> (unknown error) - exit code 194 (0xc2)</message> <stderr_txt> 2022-07-28 07:19:54 (16460): Detected: vboxwrapper 26205 2022-07-28 07:19:54 (16460): Detected: BOINC client v7.16.20 2022-07-28 07:19:55 (16460): Detected: VirtualBox VboxManage Interface (Version: 6.0.14) 2022-07-28 07:19:55 (16460): Detected: Heartbeat check (file: 'heartbeat' every 1200.000000 seconds) 2022-07-28 07:19:55 (16460): Successfully copied 'init_data.xml' to the shared directory. 2022-07-28 07:19:56 (16460): Create VM. (boinc_fa1002db84c0c141, slot#0) 2022-07-28 07:19:56 (16460): Setting Memory Size for VM. (6376MB) 2022-07-28 07:19:57 (16460): Setting CPU Count for VM. (6) 2022-07-28 07:19:57 (16460): Setting Chipset Options for VM. 2022-07-28 07:19:57 (16460): Setting Graphics Controller Options for VM. 2022-07-28 07:19:57 (16460): Setting Boot Options for VM. 2022-07-28 07:19:58 (16460): Setting Network Configuration for NAT. 2022-07-28 07:19:58 (16460): Enabling VM Network Access. 2022-07-28 07:19:58 (16460): Disabling USB Support for VM. 2022-07-28 07:19:58 (16460): Disabling COM Port Support for VM. 2022-07-28 07:19:59 (16460): Disabling LPT Port Support for VM. 2022-07-28 07:19:59 (16460): Disabling Audio Support for VM. 2022-07-28 07:19:59 (16460): Disabling Clipboard Support for VM. 2022-07-28 07:19:59 (16460): Disabling Drag and Drop Support for VM. 2022-07-28 07:20:00 (16460): Adding storage controller(s) to VM. 2022-07-28 07:20:00 (16460): Adding virtual disk drive to VM. (CMS_2022_07_25.vdi) 2022-07-28 07:20:01 (16460): Adding VirtualBox Guest Additions to VM. 2022-07-28 07:20:01 (16460): Adding network bandwidth throttle group to VM. (Defaulting to 1024GB) 2022-07-28 07:20:02 (16460): forwarding host port 53097 to guest port 80 2022-07-28 07:20:02 (16460): Enabling remote desktop for VM. 2022-07-28 07:20:02 (16460): Required extension pack not installed, remote desktop not enabled. 2022-07-28 07:20:02 (16460): Enabling shared directory for VM. 2022-07-28 07:20:03 (16460): Starting VM using VBoxManage interface. (boinc_fa1002db84c0c141, slot#0) 2022-07-28 07:20:06 (16460): Successfully started VM. (PID = '17456') 2022-07-28 07:20:06 (16460): Reporting VM Process ID to BOINC. 2022-07-28 07:20:06 (16460): Guest Log: BIOS: VirtualBox 6.0.14 2022-07-28 07:20:06 (16460): Guest Log: CPUID EDX: 0x178bfbff 2022-07-28 07:20:06 (16460): Guest Log: BIOS: AHCI 0-P#0: PCHS=16383/16/63 LCHS=1024/255/63 0x0000000002800000 sectors 2022-07-28 07:20:06 (16460): VM state change detected. (old = 'poweredoff', new = 'running') 2022-07-28 07:20:06 (16460): Detected: Web Application Enabled (http://localhost:53097) 2022-07-28 07:20:06 (16460): Preference change detected 2022-07-28 07:20:06 (16460): Setting CPU throttle for VM. (100%) 2022-07-28 07:20:06 (16460): Setting checkpoint interval to 600 seconds. (Higher value of (Preference: 60 seconds) or (Vbox_job.xml: 600 seconds)) 2022-07-28 07:20:08 (16460): Guest Log: BIOS: Boot : bseqnr=1, bootseq=0032 2022-07-28 07:20:08 (16460): Guest Log: BIOS: Booting from Hard Disk... 2022-07-28 07:20:10 (16460): Guest Log: BIOS: KBD: unsupported int 16h function 03 2022-07-28 07:20:10 (16460): Guest Log: BIOS: AX=0305 BX=0000 CX=0000 DX=0000 2022-07-28 07:20:55 (16460): Guest Log: vgdrvHeartbeatInit: Setting up heartbeat to trigger every 2000 milliseconds 2022-07-28 07:20:55 (16460): Guest Log: vboxguest: misc device minor 56, IRQ 20, I/O port d020, MMIO at 00000000f0400000 (size 0x400000) 2022-07-28 07:20:57 (16460): Guest Log: VBoxService 5.2.6 r120293 (verbosity: 0) linux.amd64 (Jan 15 2018 14:51:00) release log 2022-07-28 07:20:57 (16460): Guest Log: 00:00:00.000143 main Log opened 2022-07-28T05:20:58.329409000Z 2022-07-28 07:20:57 (16460): Guest Log: 00:00:00.000389 main OS Product: Linux 2022-07-28 07:20:57 (16460): Guest Log: 00:00:00.000459 main OS Release: 4.14.232-19.cernvm.x86_64 2022-07-28 07:20:57 (16460): Guest Log: 00:00:00.000768 main OS Version: #1 SMP Fri Apr 30 17:12:25 CEST 2021 2022-07-28 07:20:57 (16460): Guest Log: 00:00:00.000811 main Executable: /usr/sbin/VBoxService 2022-07-28 07:20:57 (16460): Guest Log: 00:00:00.000812 main Process ID: 2385 2022-07-28 07:20:57 (16460): Guest Log: 00:00:00.000813 main Package type: LINUX_64BITS_GENERIC 2022-07-28 07:20:57 (16460): Guest Log: 00:00:00.001601 main 5.2.6 r120293 started. Verbose level = 0 2022-07-28 07:21:41 (16460): Guest Log: [INFO] Mounting the shared directory 2022-07-28 07:21:42 (16460): Guest Log: [INFO] Shared directory mounted, enabling vboxmonitor 2022-07-28 07:21:42 (16460): Guest Log: [INFO] Sourcing essential functions from /cvmfs/grid.cern.ch 2022-07-28 07:21:42 (16460): Guest Log: [INFO] Testing connection to cern.ch 2022-07-28 07:21:44 (16460): Guest Log: [INFO] Testing connection to VCCS 2022-07-28 07:21:46 (16460): Guest Log: [INFO] Testing connection to HTCondor 2022-07-28 07:21:48 (16460): Guest Log: [INFO] Testing connection to WMAgent 2022-07-28 07:21:50 (16460): Guest Log: [INFO] Testing connection to EOSCMS 2022-07-28 07:21:53 (16460): Guest Log: [INFO] Testing connection to CMS-Frontier 2022-07-28 07:21:55 (16460): Guest Log: [INFO] Testing connection to Frontier 2022-07-28 07:22:03 (16460): Guest Log: [INFO] Could not find a local HTTP proxy 2022-07-28 07:22:03 (16460): Guest Log: [INFO] CVMFS and Frontier will have to use DIRECT connections 2022-07-28 07:22:03 (16460): Guest Log: [INFO] This makes the application less efficient 2022-07-28 07:22:03 (16460): Guest Log: [INFO] It also puts higher load on the project servers 2022-07-28 07:22:03 (16460): Guest Log: [INFO] Setting up a local HTTP proxy is highly recommended 2022-07-28 07:22:04 (16460): Guest Log: [INFO] Advice can be found in the project forum 2022-07-28 07:22:04 (16460): Guest Log: [INFO] Reloading and probing the CVMFS configuration 2022-07-28 07:22:05 (16460): Guest Log: [INFO] Probing /cvmfs/cvmfs-config.cern.ch... OK 2022-07-28 07:22:05 (16460): Guest Log: [INFO] Probing /cvmfs/grid.cern.ch... OK 2022-07-28 07:22:12 (16460): Guest Log: [INFO] Probing /cvmfs/cms.cern.ch... OK 2022-07-28 07:22:13 (16460): Guest Log: [INFO] Probing /cvmfs/oasis.opensciencegrid.org... OK 2022-07-28 07:22:14 (16460): Guest Log: [INFO] Probing /cvmfs/singularity.opensciencegrid.org... OK 2022-07-28 07:22:18 (16460): Guest Log: [INFO] Probing /cvmfs/cms-ib.cern.ch... OK 2022-07-28 07:22:18 (16460): Guest Log: [INFO] Excerpt from "cvmfs_config stat": VERSION HOST PROXY 2022-07-28 07:22:18 (16460): Guest Log: [INFO] 2.7.2.0 http://cvmfs-stratum-one.cern.ch http://128.142.161.84:3125 2022-07-28 07:22:18 (16460): Guest Log: [INFO] Reading volunteer information 2022-07-28 07:22:21 (16460): Guest Log: [INFO] Requesting an X509 credential from LHC@home 2022-07-28 07:22:24 (16460): Guest Log: [INFO] Requesting an X509 credential from vLHC@home-dev 2022-07-28 07:22:28 (16460): Guest Log: [INFO] CMS application starting. Check log files. 2022-07-28 07:22:28 (16460): Guest Log: [INFO] Requesting an idtoken from LHC@home 2022-07-28 07:22:31 (16460): Guest Log: [INFO] Requesting an idtoken from vLHC@home-dev 2022-07-28 07:25:53 (16460): Stopping VM. 2022-07-28 07:25:59 (16460): Successfully stopped VM. 2022-07-28 11:34:27 (3936): Detected: vboxwrapper 26205 2022-07-28 11:34:27 (3936): Detected: BOINC client v7.16.20 2022-07-28 11:34:28 (3936): Detected: VirtualBox VboxManage Interface (Version: 6.0.14) 2022-07-28 11:34:29 (3936): Detected: Heartbeat check (file: 'heartbeat' every 1200.000000 seconds) 2022-07-28 11:34:29 (3936): Guest Log: BIOS: VirtualBox 6.0.14 2022-07-28 11:34:29 (3936): Guest Log: CPUID EDX: 0x178bfbff 2022-07-28 11:34:29 (3936): Guest Log: BIOS: AHCI 0-P#0: PCHS=16383/16/63 LCHS=1024/255/63 0x0000000002800000 sectors 2022-07-28 11:34:29 (3936): Guest Log: BIOS: Boot : bseqnr=1, bootseq=0032 2022-07-28 11:34:29 (3936): Guest Log: BIOS: Booting from Hard Disk... 2022-07-28 11:34:29 (3936): Guest Log: BIOS: KBD: unsupported int 16h function 03 2022-07-28 11:34:29 (3936): Guest Log: BIOS: AX=0305 BX=0000 CX=0000 DX=0000 2022-07-28 11:34:29 (3936): Guest Log: vgdrvHeartbeatInit: Setting up heartbeat to trigger every 2000 milliseconds 2022-07-28 11:34:29 (3936): Guest Log: vboxguest: misc device minor 56, IRQ 20, I/O port d020, MMIO at 00000000f0400000 (size 0x400000) 2022-07-28 11:34:29 (3936): Guest Log: VBoxService 5.2.6 r120293 (verbosity: 0) linux.amd64 (Jan 15 2018 14:51:00) release log 2022-07-28 11:34:29 (3936): Guest Log: 00:00:00.000143 main Log opened 2022-07-28T05:20:58.329409000Z 2022-07-28 11:34:29 (3936): Guest Log: 00:00:00.000389 main OS Product: Linux 2022-07-28 11:34:29 (3936): Guest Log: 00:00:00.000459 main OS Release: 4.14.232-19.cernvm.x86_64 2022-07-28 11:34:29 (3936): Guest Log: 00:00:00.000768 main OS Version: #1 SMP Fri Apr 30 17:12:25 CEST 2021 2022-07-28 11:34:29 (3936): Guest Log: 00:00:00.000811 main Executable: /usr/sbin/VBoxService 2022-07-28 11:34:29 (3936): Guest Log: 00:00:00.000812 main Process ID: 2385 2022-07-28 11:34:29 (3936): Guest Log: 00:00:00.000813 main Package type: LINUX_64BITS_GENERIC 2022-07-28 11:34:29 (3936): Guest Log: 00:00:00.001601 main 5.2.6 r120293 started. Verbose level = 0 2022-07-28 11:34:29 (3936): Guest Log: [INFO] Mounting the shared directory 2022-07-28 11:34:29 (3936): Guest Log: [INFO] Shared directory mounted, enabling vboxmonitor 2022-07-28 11:34:29 (3936): Guest Log: [INFO] Sourcing essential functions from /cvmfs/grid.cern.ch 2022-07-28 11:34:29 (3936): Guest Log: [INFO] Testing connection to cern.ch 2022-07-28 11:34:29 (3936): Guest Log: [INFO] Testing connection to VCCS 2022-07-28 11:34:29 (3936): Guest Log: [INFO] Testing connection to HTCondor 2022-07-28 11:34:29 (3936): Guest Log: [INFO] Testing connection to WMAgent 2022-07-28 11:34:29 (3936): Guest Log: [INFO] Testing connection to EOSCMS 2022-07-28 11:34:29 (3936): Guest Log: [INFO] Testing connection to CMS-Frontier 2022-07-28 11:34:29 (3936): Guest Log: [INFO] Testing connection to Frontier 2022-07-28 11:34:29 (3936): Guest Log: [INFO] Could not find a local HTTP proxy 2022-07-28 11:34:29 (3936): Guest Log: [INFO] CVMFS and Frontier will have to use DIRECT connections 2022-07-28 11:34:29 (3936): Guest Log: [INFO] This makes the application less efficient 2022-07-28 11:34:29 (3936): Guest Log: [INFO] It also puts higher load on the project servers 2022-07-28 11:34:29 (3936): Guest Log: [INFO] Setting up a local HTTP proxy is highly recommended 2022-07-28 11:34:29 (3936): Guest Log: [INFO] Advice can be found in the project forum 2022-07-28 11:34:29 (3936): Guest Log: [INFO] Reloading and probing the CVMFS configuration 2022-07-28 11:34:29 (3936): Guest Log: [INFO] Probing /cvmfs/cvmfs-config.cern.ch... OK 2022-07-28 11:34:29 (3936): Guest Log: [INFO] Probing /cvmfs/grid.cern.ch... OK 2022-07-28 11:34:29 (3936): Guest Log: [INFO] Probing /cvmfs/cms.cern.ch... OK 2022-07-28 11:34:29 (3936): Guest Log: [INFO] Probing /cvmfs/oasis.opensciencegrid.org... OK 2022-07-28 11:34:29 (3936): Guest Log: [INFO] Probing /cvmfs/singularity.opensciencegrid.org... OK 2022-07-28 11:34:29 (3936): Guest Log: [INFO] Probing /cvmfs/cms-ib.cern.ch... OK 2022-07-28 11:34:29 (3936): Guest Log: [INFO] Excerpt from "cvmfs_config stat": VERSION HOST PROXY 2022-07-28 11:34:29 (3936): Guest Log: [INFO] 2.7.2.0 http://cvmfs-stratum-one.cern.ch http://128.142.161.84:3125 2022-07-28 11:34:29 (3936): Guest Log: [INFO] Reading volunteer information 2022-07-28 11:34:29 (3936): Guest Log: [INFO] Requesting an X509 credential from LHC@home 2022-07-28 11:34:29 (3936): Guest Log: [INFO] Requesting an X509 credential from vLHC@home-dev 2022-07-28 11:34:29 (3936): Guest Log: [INFO] CMS application starting. Check log files. 2022-07-28 11:34:29 (3936): Guest Log: [INFO] Requesting an idtoken from LHC@home 2022-07-28 11:34:29 (3936): Guest Log: [INFO] Requesting an idtoken from vLHC@home-dev 2022-07-28 11:34:29 (3936): Starting VM using VBoxManage interface. (boinc_fa1002db84c0c141, slot#0) 2022-07-28 11:34:36 (3936): Successfully started VM. (PID = '13572') 2022-07-28 11:34:36 (3936): Reporting VM Process ID to BOINC. 2022-07-28 11:34:36 (3936): VM state change detected. (old = 'poweredoff', new = 'running') 2022-07-28 11:34:36 (3936): Detected: Web Application Enabled (http://localhost:53097) 2022-07-28 11:34:36 (3936): Preference change detected 2022-07-28 11:34:36 (3936): Setting CPU throttle for VM. (100%) 2022-07-28 11:34:37 (3936): Setting checkpoint interval to 600 seconds. (Higher value of (Preference: 60 seconds) or (Vbox_job.xml: 600 seconds)) 2022-07-28 11:34:38 (3936): Guest Log: 00:05:00.143967 timesync vgsvcTimeSyncWorker: Radical host time change: 14 932 097 000 000ns (HostNow=1 659 000 878 853 000 000 ns HostLast=1 658 985 946 756 000 000 ns) 2022-07-28 11:34:48 (3936): Guest Log: 00:05:10.145805 timesync vgsvcTimeSyncWorker: Radical guest time change: 14 930 382 288 000ns (GuestNow=1 659 000 888 855 142 000 ns GuestLast=1 658 985 958 472 854 000 ns fSetTimeLastLoop=true ) 2022-07-28 11:47:10 (3936): VM state change detected. (old = 'running', new = 'paused') 2022-07-28 11:47:20 (3936): VM state change detected. (old = 'paused', new = 'running') 2022-07-28 12:47:23 (3936): VM state change detected. (old = 'running', new = 'paused') 2022-07-28 12:47:33 (3936): VM state change detected. (old = 'paused', new = 'running') 2022-07-28 13:09:17 (3936): Status Report: Job Duration: '64800.000000' 2022-07-28 13:09:17 (3936): Status Report: Elapsed Time: '6000.000000' 2022-07-28 13:09:17 (3936): Status Report: CPU Time: '5590.046875' 2022-07-28 13:47:36 (3936): VM state change detected. (old = 'running', new = 'paused') 2022-07-28 13:47:46 (3936): VM state change detected. (old = 'paused', new = 'running') 2022-07-28 14:47:39 (3936): VM state change detected. (old = 'running', new = 'paused') 2022-07-28 14:47:49 (3936): VM state change detected. (old = 'paused', new = 'running') 2022-07-28 14:49:45 (3936): Status Report: Job Duration: '64800.000000' 2022-07-28 14:49:45 (3936): Status Report: Elapsed Time: '12000.000000' 2022-07-28 14:49:45 (3936): Status Report: CPU Time: '11643.718750' 2022-07-28 15:47:52 (3936): VM state change detected. (old = 'running', new = 'paused') 2022-07-28 15:48:02 (3936): VM state change detected. (old = 'paused', new = 'running') 2022-07-28 16:30:01 (3936): Status Report: Job Duration: '64800.000000' 2022-07-28 16:30:01 (3936): Status Report: Elapsed Time: '18000.000000' 2022-07-28 16:30:01 (3936): Status Report: CPU Time: '17739.078125' 2022-07-28 16:48:06 (3936): VM state change detected. (old = 'running', new = 'paused') 2022-07-28 16:48:16 (3936): VM state change detected. (old = 'paused', new = 'running') 2022-07-28 17:48:12 (3936): VM state change detected. (old = 'running', new = 'paused') 2022-07-28 17:48:21 (3936): VM state change detected. (old = 'paused', new = 'running') 2022-07-28 18:10:28 (3936): Status Report: Job Duration: '64800.000000' 2022-07-28 18:10:28 (3936): Status Report: Elapsed Time: '24000.000000' 2022-07-28 18:10:28 (3936): Status Report: CPU Time: '23854.312500' 2022-07-28 18:48:23 (3936): VM state change detected. (old = 'running', new = 'paused') 2022-07-28 18:48:33 (3936): VM state change detected. (old = 'paused', new = 'running') 2022-07-28 19:15:37 (3936): VM state change detected. (old = 'running', new = 'paused') 2022-07-28 19:15:38 (3936): VM state change detected. (old = 'paused', new = 'running') 2022-07-28 19:15:39 (3936): VM state change detected. (old = 'running', new = 'paused') 2022-07-28 19:16:54 (3936): VM state change detected. (old = 'paused', new = 'running') 2022-07-28 19:16:55 (3936): VM state change detected. (old = 'running', new = 'paused') 2022-07-28 19:16:56 (3936): VM state change detected. (old = 'paused', new = 'running') 2022-07-28 19:16:57 (3936): VM state change detected. (old = 'running', new = 'paused') 2022-07-28 19:16:58 (3936): VM state change detected. (old = 'paused', new = 'running') 2022-07-28 19:19:01 (3936): VM state change detected. (old = 'running', new = 'paused') 2022-07-28 19:19:03 (3936): VM state change detected. (old = 'paused', new = 'running') 2022-07-28 19:19:07 (3936): VM state change detected. (old = 'running', new = 'paused') 2022-07-28 19:20:42 (3936): VM state change detected. (old = 'paused', new = 'running') 2022-07-28 19:20:43 (3936): VM state change detected. (old = 'running', new = 'paused') 2022-07-28 19:20:59 (3936): VM state change detected. (old = 'paused', new = 'running') 2022-07-28 19:21:00 (3936): VM state change detected. (old = 'running', new = 'paused') 2022-07-28 19:21:43 (3936): VM state change detected. (old = 'paused', new = 'running') 2022-07-29 03:39:28 (9984): Detected: vboxwrapper 26205 2022-07-29 03:39:28 (9984): Detected: BOINC client v7.16.20 2022-07-29 03:39:29 (9984): Detected: VirtualBox VboxManage Interface (Version: 6.0.14) 2022-07-29 03:39:29 (9984): Detected: Heartbeat check (file: 'heartbeat' every 1200.000000 seconds) 2022-07-29 03:39:30 (9984): Guest Log: 00:05:00.143967 timesync vgsvcTimeSyncWorker: Radical host time change: 14 932 097 000 000ns (HostNow=1 659 000 878 853 000 000 ns HostLast=1 658 985 946 756 000 000 ns) 2022-07-29 03:39:30 (9984): Guest Log: 00:05:10.145805 timesync vgsvcTimeSyncWorker: Radical guest time change: 14 930 382 288 000ns (GuestNow=1 659 000 888 855 142 000 ns GuestLast=1 658 985 958 472 854 000 ns fSetTimeLastLoop=true ) 2022-07-29 03:39:30 (9984): Starting VM using VBoxManage interface. (boinc_fa1002db84c0c141, slot#0) 2022-07-29 03:39:34 (9984): Successfully started VM. (PID = '12192') 2022-07-29 03:39:34 (9984): Reporting VM Process ID to BOINC. 2022-07-29 03:39:34 (9984): Guest Log: BIOS: VirtualBox 6.0.14 2022-07-29 03:39:34 (9984): Guest Log: CPUID EDX: 0x178bfbff 2022-07-29 03:39:34 (9984): Guest Log: BIOS: AHCI 0-P#0: PCHS=16383/16/63 LCHS=1024/255/63 0x0000000002800000 sectors 2022-07-29 03:39:34 (9984): VM state change detected. (old = 'poweredoff', new = 'running') 2022-07-29 03:39:34 (9984): Detected: Web Application Enabled (http://localhost:53097) 2022-07-29 03:39:34 (9984): Status Report: Job Duration: '64800.000000' 2022-07-29 03:39:34 (9984): Status Report: Elapsed Time: '28201.687920' 2022-07-29 03:39:34 (9984): Status Report: CPU Time: '27892.046875' 2022-07-29 03:39:34 (9984): Preference change detected 2022-07-29 03:39:34 (9984): Setting CPU throttle for VM. (100%) 2022-07-29 03:39:35 (9984): Setting checkpoint interval to 600 seconds. (Higher value of (Preference: 60 seconds) or (Vbox_job.xml: 600 seconds)) 2022-07-29 03:39:36 (9984): Guest Log: BIOS: Boot : bseqnr=1, bootseq=0032 2022-07-29 03:39:36 (9984): Guest Log: BIOS: Booting from Hard Disk... 2022-07-29 03:39:38 (9984): Guest Log: BIOS: KBD: unsupported int 16h function 03 2022-07-29 03:39:38 (9984): Guest Log: BIOS: AX=0305 BX=0000 CX=0000 DX=0000 2022-07-29 03:41:12 (9984): Guest Log: vgdrvHeartbeatInit: Setting up heartbeat to trigger every 2000 milliseconds 2022-07-29 03:41:12 (9984): Guest Log: vboxguest: misc device minor 56, IRQ 20, I/O port d020, MMIO at 00000000f0400000 (size 0x400000) 2022-07-29 03:41:38 (9984): Guest Log: VBoxService 5.2.6 r120293 (verbosity: 0) linux.amd64 (Jan 15 2018 14:51:00) release log 2022-07-29 03:41:38 (9984): Guest Log: 00:00:00.000143 main Log opened 2022-07-29T01:41:44.633818000Z 2022-07-29 03:41:38 (9984): Guest Log: 00:00:00.000295 main OS Product: Linux 2022-07-29 03:41:38 (9984): Guest Log: 00:00:00.000357 main OS Release: 4.14.232-19.cernvm.x86_64 2022-07-29 03:41:38 (9984): Guest Log: 00:00:00.000425 main OS Version: #1 SMP Fri Apr 30 17:12:25 CEST 2021 2022-07-29 03:41:38 (9984): Guest Log: 00:00:00.000527 main Executable: /usr/sbin/VBoxService 2022-07-29 03:41:38 (9984): Guest Log: 00:00:00.000529 main Process ID: 2417 2022-07-29 03:41:38 (9984): Guest Log: 00:00:00.000529 main Package type: LINUX_64BITS_GENERIC 2022-07-29 03:41:38 (9984): Guest Log: 00:00:00.001456 main 5.2.6 r120293 started. Verbose level = 0 2022-07-29 03:43:21 (9984): Guest Log: [INFO] Mounting the shared directory 2022-07-29 03:45:34 (9984): Guest Log: [INFO] Shared directory mounted, enabling vboxmonitor 2022-07-29 03:48:12 (9984): Guest Log: [INFO] Sourcing essential functions from /cvmfs/grid.cern.ch 2022-07-29 03:51:42 (9984): Guest Log: [INFO] Testing connection to cern.ch 2022-07-29 03:54:51 (9984): VM state change detected. (old = 'running', new = 'paused') 2022-07-29 03:55:01 (9984): VM state change detected. (old = 'paused', new = 'running') 2022-07-29 03:57:09 (9984): Guest Log: [DEBUG] Status run 1 of up to 3: 2 2022-07-29 04:03:41 (9984): Guest Log: [DEBUG] Status run 2 of up to 3: 2 2022-07-29 04:09:55 (9984): VM state change detected. (old = 'running', new = 'paused') 2022-07-29 04:10:05 (9984): VM state change detected. (old = 'paused', new = 'running') 2022-07-29 04:11:46 (9984): Guest Log: [DEBUG] Status run 3 of up to 3: 2 2022-07-29 04:19:58 (9984): VM Heartbeat file specified, but missing heartbeat. 2022-07-29 04:19:58 (9984): Powering off VM. 2022-07-29 04:19:58 (9984): Successfully stopped VM. 2022-07-29 04:19:58 (9984): Deregistering VM. (boinc_fa1002db84c0c141, slot#0) 2022-07-29 04:19:58 (9984): Removing network bandwidth throttle group from VM. 2022-07-29 04:19:58 (9984): Removing VM from VirtualBox. Hypervisor System Log: 04:05:08.324536 ERROR [COM]: aRC=E_ACCESSDENIED (0x80070005) aIID={5047460a-265d-4538-b23e-ddba5fb84976} aComponent={MachineWrap} aText={The object functionality is limited}, preserve=false aResultDetail=0 04:05:08.324548 ERROR [COM]: aRC=E_ACCESSDENIED (0x80070005) aIID={5047460a-265d-4538-b23e-ddba5fb84976} aComponent={MachineWrap} aText={The object functionality is limited}, preserve=false aResultDetail=0 04:05:08.324639 ERROR [COM]: aRC=E_ACCESSDENIED (0x80070005) aIID={5047460a-265d-4538-b23e-ddba5fb84976} aComponent={MachineWrap} aText={The object functionality is limited}, preserve=false aResultDetail=0 04:05:08.324652 ERROR [COM]: aRC=E_ACCESSDENIED (0x80070005) aIID={5047460a-265d-4538-b23e-ddba5fb84976} aComponent={MachineWrap} aText={The object functionality is limited}, preserve=false aResultDetail=0 04:05:08.324662 ERROR [COM]: aRC=E_ACCESSDENIED (0x80070005) aIID={5047460a-265d-4538-b23e-ddba5fb84976} aComponent={MachineWrap} aText={The object functionality is limited}, preserve=false aResultDetail=0 04:05:08.324673 ERROR [COM]: aRC=E_ACCESSDENIED (0x80070005) aIID={5047460a-265d-4538-b23e-ddba5fb84976} aComponent={MachineWrap} aText={The object functionality is limited}, preserve=false aResultDetail=0 04:05:08.324682 ERROR [COM]: aRC=E_ACCESSDENIED (0x80070005) aIID={5047460a-265d-4538-b23e-ddba5fb84976} aComponent={MachineWrap} aText={The object functionality is limited}, preserve=false aResultDetail=0 04:05:08.324692 ERROR [COM]: aRC=E_ACCESSDENIED (0x80070005) aIID={5047460a-265d-4538-b23e-ddba5fb84976} aComponent={MachineWrap} aText={The object functionality is limited}, preserve=false aResultDetail=0 04:05:08.324703 ERROR [COM]: aRC=E_ACCESSDENIED (0x80070005) aIID={5047460a-265d-4538-b23e-ddba5fb84976} aComponent={MachineWrap} aText={The object functionality is limited}, preserve=false aResultDetail=0 04:05:08.324712 ERROR [COM]: aRC=E_ACCESSDENIED (0x80070005) aIID={5047460a-265d-4538-b23e-ddba5fb84976} aComponent={MachineWrap} aText={The object functionality is limited}, preserve=false aResultDetail=0 04:05:08.324722 ERROR [COM]: aRC=E_ACCESSDENIED (0x80070005) aIID={5047460a-265d-4538-b23e-ddba5fb84976} aComponent={MachineWrap} aText={The object functionality is limited}, preserve=false aResultDetail=0 04:05:08.324732 ERROR [COM]: aRC=E_ACCESSDENIED (0x80070005) aIID={5047460a-265d-4538-b23e-ddba5fb84976} aComponent={MachineWrap} aText={The object functionality is limited}, preserve=false aResultDetail=0 04:05:08.324742 ERROR [COM]: aRC=E_ACCESSDENIED (0x80070005) aIID={5047460a-265d-4538-b23e-ddba5fb84976} aComponent={MachineWrap} aText={The object functionality is limited}, preserve=false aResultDetail=0 04:05:08.324752 ERROR [COM]: aRC=E_ACCESSDENIED (0x80070005) aIID={5047460a-265d-4538-b23e-ddba5fb84976} aComponent={MachineWrap} aText={The object functionality is limited}, preserve=false aResultDetail=0 04:05:08.324762 ERROR [COM]: aRC=E_ACCESSDENIED (0x80070005) aIID={5047460a-265d-4538-b23e-ddba5fb84976} aComponent={MachineWrap} aText={The object functionality is limited}, preserve=false aResultDetail=0 04:05:08.324772 ERROR [COM]: aRC=E_ACCESSDENIED (0x80070005) aIID={5047460a-265d-4538-b23e-ddba5fb84976} aComponent={MachineWrap} aText={The object functionality is limited}, preserve=false aResultDetail=0 04:05:08.324783 ERROR [COM]: aRC=E_ACCESSDENIED (0x80070005) aIID={5047460a-265d-4538-b23e-ddba5fb84976} aComponent={MachineWrap} aText={The object functionality is limited}, preserve=false aResultDetail=0 04:05:08.324792 ERROR [COM]: aRC=E_ACCESSDENIED (0x80070005) aIID={5047460a-265d-4538-b23e-ddba5fb84976} aComponent={MachineWrap} aText={The object functionality is limited}, preserve=false aResultDetail=0 04:05:08.324802 ERROR [COM]: aRC=E_ACCESSDENIED (0x80070005) aIID={5047460a-265d-4538-b23e-ddba5fb84976} aComponent={MachineWrap} aText={The object functionality is limited}, preserve=false aResultDetail=0 04:05:08.324813 ERROR [COM]: aRC=E_ACCESSDENIED (0x80070005) aIID={5047460a-265d-4538-b23e-ddba5fb84976} aComponent={MachineWrap} aText={The object functionality is limited}, preserve=false aResultDetail=0 04:05:08.324823 ERROR [COM]: aRC=E_ACCESSDENIED (0x80070005) aIID={5047460a-265d-4538-b23e-ddba5fb84976} aComponent={MachineWrap} aText={The object functionality is limited}, preserve=false aResultDetail=0 04:05:08.324874 ERROR [COM]: aRC=E_ACCESSDENIED (0x80070005) aIID={5047460a-265d-4538-b23e-ddba5fb84976} aComponent={MachineWrap} aText={The object functionality is limited}, preserve=false aResultDetail=0 04:05:08.324887 ERROR [COM]: aRC=E_ACCESSDENIED (0x80070005) aIID={5047460a-265d-4538-b23e-ddba5fb84976} aComponent={MachineWrap} aText={The object functionality is limited}, preserve=false aResultDetail=0 04:05:08.324897 ERROR [COM]: aRC=E_ACCESSDENIED (0x80070005) aIID={5047460a-265d-4538-b23e-ddba5fb84976} aComponent={MachineWrap} aText={The object functionality is limited}, preserve=false aResultDetail=0 04:05:08.324907 ERROR [COM]: aRC=E_ACCESSDENIED (0x80070005) aIID={5047460a-265d-4538-b23e-ddba5fb84976} aComponent={MachineWrap} aText={The object functionality is limited}, preserve=false aResultDetail=0 04:05:08.324917 ERROR [COM]: aRC=E_ACCESSDENIED (0x80070005) aIID={5047460a-265d-4538-b23e-ddba5fb84976} aComponent={MachineWrap} aText={The object functionality is limited}, preserve=false aResultDetail=0 04:05:08.324927 ERROR [COM]: aRC=E_ACCESSDENIED (0x80070005) aIID={5047460a-265d-4538-b23e-ddba5fb84976} aComponent={MachineWrap} aText={The object functionality is limited}, preserve=false aResultDetail=0 04:05:08.324937 ERROR [COM]: aRC=E_ACCESSDENIED (0x80070005) aIID={5047460a-265d-4538-b23e-ddba5fb84976} aComponent={MachineWrap} aText={The object functionality is limited}, preserve=false aResultDetail=0 04:05:08.324947 ERROR [COM]: aRC=E_ACCESSDENIED (0x80070005) aIID={5047460a-265d-4538-b23e-ddba5fb84976} aComponent={MachineWrap} aText={The object functionality is limited}, preserve=false aResultDetail=0 04:05:08.324957 ERROR [COM]: aRC=E_ACCESSDENIED (0x80070005) aIID={5047460a-265d-4538-b23e-ddba5fb84976} aComponent={MachineWrap} aText={The object functionality is limited}, preserve=false aResultDetail=0 04:05:08.324966 ERROR [COM]: aRC=E_ACCESSDENIED (0x80070005) aIID={5047460a-265d-4538-b23e-ddba5fb84976} aComponent={MachineWrap} aText={The object functionality is limited}, preserve=false aResultDetail=0 04:05:08.324976 ERROR [COM]: aRC=E_ACCESSDENIED (0x80070005) aIID={5047460a-265d-4538-b23e-ddba5fb84976} aComponent={MachineWrap} aText={The object functionality is limited}, preserve=false aResultDetail=0 04:05:08.324986 ERROR [COM]: aRC=E_ACCESSDENIED (0x80070005) aIID={5047460a-265d-4538-b23e-ddba5fb84976} aComponent={MachineWrap} aText={The object functionality is limited}, preserve=false aResultDetail=0 04:05:08.326201 Saving settings file "C:\Users\mrbro\.VirtualBox\VirtualBox.xml" with version "1.12-windows" 04:05:13.353338 main VirtualBox: object deletion starts 04:05:13.354767 main ERROR [COM]: aRC=VBOX_E_OBJECT_IN_USE (0x80bb000c) aIID={ad47ad09-787b-44ab-b343-a082a3f2dfb1} aComponent={MediumWrap} aText={Medium 'C:\ProgramData\BOINC\slots\10\vm_image.vdi' cannot be closed because it is still attached to 1 virtual machines}, preserve=false aResultDetail=0 04:05:13.355240 main ERROR [COM]: aRC=VBOX_E_OBJECT_IN_USE (0x80bb000c) aIID={ad47ad09-787b-44ab-b343-a082a3f2dfb1} aComponent={MediumWrap} aText={Medium 'C:\ProgramData\BOINC\slots\11\vm_image.vdi' cannot be closed because it is still attached to 1 virtual machines}, preserve=false aResultDetail=0 04:05:13.360035 Watcher ERROR [COM]: aRC=E_ACCESSDENIED (0x80070005) aIID={d0a0163f-e254-4e5b-a1f2-011cf991c38d} aComponent={VirtualBoxWrap} aText={The object is not ready}, preserve=false aResultDetail=0 04:05:13.360734 main VirtualBox: object deleted VM Execution Log: VM Startup Log: VM Trace Log: Maximum guest RAM size: 2097152 Megabytes Minimum video RAM size: 0 Megabytes Maximum video RAM size: 256 Megabytes Maximum guest monitor count: 64 Minimum guest CPU count: 1 Maximum guest CPU count: 32 Virtual disk limit (info): 2199022206976 Bytes Maximum Serial Port count: 4 Maximum Parallel Port count: 2 Maximum Boot Position: 4 Maximum PIIX3 Network Adapter count: 8 Maximum ICH9 Network Adapter count: 36 Maximum PIIX3 IDE Controllers: 1 Maximum ICH9 IDE Controllers: 1 Maximum IDE Port count: 2 Maximum Devices per IDE Port: 2 Maximum PIIX3 SATA Controllers: 1 Maximum ICH9 SATA Controllers: 8 Maximum SATA Port count: 30 Maximum Devices per SATA Port: 1 Maximum PIIX3 SCSI Controllers: 1 Maximum ICH9 SCSI Controllers: 8 Maximum SCSI Port count: 16 Maximum Devices per SCSI Port: 1 Maximum SAS PIIX3 Controllers: 1 Maximum SAS ICH9 Controllers: 8 Maximum SAS Port count: 255 Maximum Devices per SAS Port: 1 Maximum NVMe PIIX3 Controllers: 1 Maximum NVMe ICH9 Controllers: 8 Maximum NVMe Port count: 255 Maximum Devices per NVMe Port: 1 Maximum PIIX3 Floppy Controllers:1 Maximum ICH9 Floppy Controllers: 1 Maximum Floppy Port count: 1 Maximum Devices per Floppy Port: 2 Default machine folder: C:\Users\mrbro\VirtualBox VMs Raw-mode Supported: yes Exclusive HW virtualization use: off Default hard disk format: VDI VRDE auth library: VBoxAuth Webservice auth. library: VBoxAuth Remote desktop ExtPack: Log history count: 3 Default frontend: Default audio driver: DirectSound Autostart database path: Default Guest Additions ISO: C:\Program Files\Oracle\VirtualBox/VBoxGuestAdditions.iso Logging Level: all Proxy Mode: System Proxy URL: 2022-07-29 03:39:29 (9984): Command: VBoxManage -q list hostinfo Exit Code: 0 Output: Host Information: Host time: 2022-07-29T01:39:29.424000000Z Processor online count: 8 Processor count: 8 Processor online core count: 4 Processor core count: 4 Processor supports HW virtualization: yes Processor supports PAE: yes Processor supports long mode: yes Processor supports nested paging: yes Processor#0 speed: unknown Processor#0 description: AMD Ryzen 5 3500U with Radeon Vega Mobile Gfx Processor#1 speed: unknown Processor#1 description: AMD Ryzen 5 3500U with Radeon Vega Mobile Gfx Processor#2 speed: unknown Processor#2 description: AMD Ryzen 5 3500U with Radeon Vega Mobile Gfx Processor#3 speed: unknown Processor#3 description: AMD Ryzen 5 3500U with Radeon Vega Mobile Gfx Processor#4 speed: unknown Processor#4 description: AMD Ryzen 5 3500U with Radeon Vega Mobile Gfx Processor#5 speed: unknown Processor#5 description: AMD Ryzen 5 3500U with Radeon Vega Mobile Gfx Processor#6 speed: unknown Processor#6 description: AMD Ryzen 5 3500U with Radeon Vega Mobile Gfx Processor#7 speed: unknown Processor#7 description: AMD Ryzen 5 3500U with Radeon Vega Mobile Gfx Memory size: 7103 MByte Memory available: 1321 MByte Operating system: Windows 10 Operating system version: 10.0.22000 2022-07-29 03:39:29 (9984): Command: VBoxManage -q showvminfo "boinc_fa1002db84c0c141" --machinereadable Exit Code: 0 Output: name="boinc_fa1002db84c0c141" groups="/" ostype="Linux 2.6 / 3.x / 4.x (64-bit)" UUID="d8a8fa69-f12c-4357-8ba8-5dda59ebe0d1" CfgFile="C:\\ProgramData\\BOINC\\slots\\0\\boinc_fa1002db84c0c141\\boinc_fa1002db84c0c141.vbox" SnapFldr="C:\\ProgramData\\BOINC\\slots\\0\\boinc_fa1002db84c0c141\\Snapshots" LogFldr="C:\\ProgramData\\BOINC\\slots\\0\\boinc_fa1002db84c0c141\\Logs" hardwareuuid="d8a8fa69-f12c-4357-8ba8-5dda59ebe0d1" memory=6376 pagefusion="off" vram=16 cpuexecutioncap=100 hpet="off" cpu-profile="host" chipset="piix3" firmware="BIOS" cpus=6 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 rtcuseutc="off" hwvirtex="on" nestedpaging="on" largepages="on" vtxvpid="on" vtxux="on" paravirtprovider="default" effparavirtprovider="kvm" VMState="poweroff" VMStateChangeTime="2022-07-28T09:34:35.000000000" 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="" storagecontrollername0="Hard Disk Controller" storagecontrollertype0="IntelAhci" storagecontrollerinstance0="0" storagecontrollermaxportcount0="30" storagecontrollerportcount0="3" storagecontrollerbootable0="on" "Hard Disk Controller-0-0"="C:\ProgramData\BOINC\slots\0\boinc_fa1002db84c0c141\Snapshots/{c3aeeaec-dfe2-4ca6-89b9-f7418e150549}.vdi" "Hard Disk Controller-ImageUUID-0-0"="c3aeeaec-dfe2-4ca6-89b9-f7418e150549" "Hard Disk Controller-1-0"="C:\Program Files\Oracle\VirtualBox\VBoxGuestAdditions.iso" "Hard Disk Controller-ImageUUID-1-0"="c08dec24-bfd6-43da-b89f-7b31730b4844" "Hard Disk Controller-tempeject"="off" "Hard Disk Controller-IsEjected"="off" "Hard Disk Controller-2-0"="none" natnet1="nat" macaddress1="0800279F1964" cableconnected1="on" nic1="nat" nictype1="82540EM" nicspeed1="0" mtu="0" sockSnd="64" sockRcv="64" tcpWndSnd="64" tcpWndRcv="64" Forwarding(0)="tcp_53097_80,tcp,127.0.0.1,53097,,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="off" usb="off" ehci="off" xhci="off" BandwidthGroup0=boinc_fa1002db84c0c141_net,Network,1099511627776 SharedFolderNameMachineMapping1="shared" SharedFolderPathMachineMapping1="C:\\ProgramData\\BOINC\\slots\\0/shared" videocap="off" videocapaudio="off" capturescreens="0" capturefilename="C:\\ProgramData\\BOINC\\slots\\0\\boinc_fa1002db84c0c141\\boinc_fa1002db84c0c141.webm" captureres="1024x768" capturevideorate=512 capturevideofps=25 captureopts="" description="CMS_2214942_1658892771.989121_0" GuestMemoryBalloon=0 2022-07-29 03:39:33 (9984): Command: VBoxManage -q startvm "boinc_fa1002db84c0c141" --type headless Exit Code: 0 Output: Waiting for VM "boinc_fa1002db84c0c141" to power on... VM "boinc_fa1002db84c0c141" has been successfully started. 2022-07-29 03:39:35 (9984): Command: VBoxManage -q controlvm "boinc_fa1002db84c0c141" cpuexecutioncap 100 Exit Code: 0 Output: 2022-07-29 03:54:50 (9984): Command: VBoxManage -q controlvm "boinc_fa1002db84c0c141" pause Exit Code: 0 Output: 2022-07-29 03:55:00 (9984): Command: VBoxManage -q controlvm "boinc_fa1002db84c0c141" resume Exit Code: 0 Output: 2022-07-29 04:09:55 (9984): Command: VBoxManage -q controlvm "boinc_fa1002db84c0c141" pause Exit Code: 0 Output: 2022-07-29 04:10:05 (9984): Command: VBoxManage -q controlvm "boinc_fa1002db84c0c141" resume Exit Code: 0 Output: 2022-07-29 04:19:58 (9984): Command: VBoxManage -q controlvm "boinc_fa1002db84c0c141" poweroff Exit Code: 0 Output: 0%...10%...20%...30%...40%...50%...60%...70%...80%...90%...100% 2022-07-29 04:19:58 (9984): Command: VBoxManage -q snapshot "boinc_fa1002db84c0c141" list Exit Code: -108 Output: This machine does not have any snapshots 2022-07-29 04:19:58 (9984): Command: VBoxManage -q bandwidthctl "boinc_fa1002db84c0c141" remove "boinc_fa1002db84c0c141_net" Exit Code: 0 Output: 2022-07-29 04:19:59 (9984): Command: VBoxManage -q unregistervm "boinc_fa1002db84c0c141" --delete Exit Code: 0 Output: 0%...10%...20%...30%...40%...50%...60%...70%...80%...90%...100% 04:20:04 (9984): called boinc_finish(194) </stderr_txt> ]]>
©2024 CERN