| Name | CMS_3246353_1654774605.732552_0 |
| Workunit | 2188974 |
| Created | 9 Jun 2022, 11:36:46 UTC |
| Sent | 12 Jun 2022, 8:18:02 UTC |
| Report deadline | 19 Jun 2022, 8:18:02 UTC |
| Received | 14 Jun 2022, 6:15:40 UTC |
| Server state | Over |
| Outcome | Computation error |
| Client state | Compute error |
| Exit status | 196 (0x000000C4) EXIT_DISK_LIMIT_EXCEEDED |
| Computer ID | 4164 |
| Run time | 17 hours 13 min 13 sec |
| CPU time | 9 hours 20 min 58 sec |
| Validate state | Invalid |
| Credit | 0.00 |
| Device peak FLOPS | 22.70 GFLOPS |
| Application version | CMS Simulation v60.55 (vbox64_mt_mcore_cms) windows_x86_64 |
| Peak working set size | 98.36 MB |
| Peak swap size | 117.25 MB |
| Peak disk usage | 7.64 GB |
Stderr output
<core_client_version>7.16.20</core_client_version>
<![CDATA[
<message>
Disk usage limit exceeded</message>
<stderr_txt>
2022-06-12 10:53:37 (10888): Detected: vboxwrapper 26202
2022-06-12 10:53:37 (10888): Detected: BOINC client v7.16.20
2022-06-12 10:53:37 (10888): Detected: VirtualBox VboxManage Interface (Version: 6.0.14)
2022-06-12 10:53:38 (10888): Detected: Heartbeat check (file: 'heartbeat' every 1200.000000 seconds)
2022-06-12 10:53:38 (10888): Successfully copied 'init_data.xml' to the shared directory.
2022-06-12 10:53:39 (10888): Create VM. (boinc_9c3af08294f2b9cd, slot#2)
2022-06-12 10:53:39 (10888): Setting Memory Size for VM. (6376MB)
2022-06-12 10:53:40 (10888): Setting CPU Count for VM. (6)
2022-06-12 10:53:40 (10888): Setting Chipset Options for VM.
2022-06-12 10:53:40 (10888): Setting Boot Options for VM.
2022-06-12 10:53:40 (10888): Setting Network Configuration for NAT.
2022-06-12 10:53:41 (10888): Enabling VM Network Access.
2022-06-12 10:53:41 (10888): Disabling USB Support for VM.
2022-06-12 10:53:41 (10888): Disabling COM Port Support for VM.
2022-06-12 10:53:41 (10888): Disabling LPT Port Support for VM.
2022-06-12 10:53:42 (10888): Disabling Audio Support for VM.
2022-06-12 10:53:42 (10888): Disabling Clipboard Support for VM.
2022-06-12 10:53:42 (10888): Disabling Drag and Drop Support for VM.
2022-06-12 10:53:43 (10888): Adding storage controller(s) to VM.
2022-06-12 10:53:43 (10888): Adding virtual disk drive to VM. (vm_image.vdi)
2022-06-12 10:53:43 (10888): Adding VirtualBox Guest Additions to VM.
2022-06-12 10:53:43 (10888): Adding network bandwidth throttle group to VM. (Defaulting to 1024GB)
2022-06-12 10:53:44 (10888): forwarding host port 62064 to guest port 80
2022-06-12 10:53:44 (10888): Enabling remote desktop for VM.
2022-06-12 10:53:44 (10888): Required extension pack not installed, remote desktop not enabled.
2022-06-12 10:53:44 (10888): Enabling shared directory for VM.
2022-06-12 10:53:45 (10888): Starting VM using VBoxManage interface. (boinc_9c3af08294f2b9cd, slot#2)
2022-06-12 10:53:49 (10888): Successfully started VM. (PID = '16980')
2022-06-12 10:53:49 (10888): Reporting VM Process ID to BOINC.
2022-06-12 10:53:49 (10888): Guest Log: BIOS: VirtualBox 6.0.14
2022-06-12 10:53:49 (10888): Guest Log: CPUID EDX: 0x178bfbff
2022-06-12 10:53:49 (10888): Guest Log: BIOS: ata0-0: PCHS=16383/16/63 LCHS=1024/255/63
2022-06-12 10:53:49 (10888): VM state change detected. (old = 'poweredoff', new = 'running')
2022-06-12 10:53:49 (10888): Detected: Web Application Enabled (http://localhost:62064)
2022-06-12 10:53:49 (10888): Preference change detected
2022-06-12 10:53:49 (10888): Setting CPU throttle for VM. (100%)
2022-06-12 10:53:49 (10888): Setting checkpoint interval to 600 seconds. (Higher value of (Preference: 60 seconds) or (Vbox_job.xml: 600 seconds))
2022-06-12 10:53:51 (10888): Guest Log: BIOS: Boot : bseqnr=1, bootseq=0032
2022-06-12 10:53:51 (10888): Guest Log: BIOS: Booting from Hard Disk...
2022-06-12 10:53:53 (10888): Guest Log: BIOS: KBD: unsupported int 16h function 03
2022-06-12 10:53:53 (10888): Guest Log: BIOS: AX=0305 BX=0000 CX=0000 DX=0000
2022-06-12 10:54:39 (10888): Guest Log: vgdrvHeartbeatInit: Setting up heartbeat to trigger every 2000 milliseconds
2022-06-12 10:54:39 (10888): Guest Log: vboxguest: misc device minor 56, IRQ 20, I/O port d020, MMIO at 00000000f0400000 (size 0x400000)
2022-06-12 10:54:40 (10888): Guest Log: VBoxService 5.2.6 r120293 (verbosity: 0) linux.amd64 (Jan 15 2018 14:51:00) release log
2022-06-12 10:54:40 (10888): Guest Log: 00:00:00.000136 main Log opened 2022-06-12T08:54:41.533690000Z
2022-06-12 10:54:40 (10888): Guest Log: 00:00:00.000998 main OS Product: Linux
2022-06-12 10:54:40 (10888): Guest Log: 00:00:00.001090 main OS Release: 4.14.232-19.cernvm.x86_64
2022-06-12 10:54:40 (10888): Guest Log: 00:00:00.001132 main OS Version: #1 SMP Fri Apr 30 17:12:25 CEST 2021
2022-06-12 10:54:40 (10888): Guest Log: 00:00:00.001176 main Executable: /usr/sbin/VBoxService
2022-06-12 10:54:40 (10888): Guest Log: 00:00:00.001177 main Process ID: 2351
2022-06-12 10:54:40 (10888): Guest Log: 00:00:00.001178 main Package type: LINUX_64BITS_GENERIC
2022-06-12 10:54:40 (10888): Guest Log: 00:00:00.002411 main 5.2.6 r120293 started. Verbose level = 0
2022-06-12 10:56:20 (10888): Guest Log: [INFO] Mounting the shared directory
2022-06-12 10:56:20 (10888): Guest Log: [INFO] Shared directory mounted, enabling vboxmonitor
2022-06-12 10:56:20 (10888): Guest Log: [INFO] Sourcing essential functions from /cvmfs/grid.cern.ch
2022-06-12 10:56:20 (10888): Guest Log: [INFO] Testing connection to cern.ch
2022-06-12 10:56:23 (10888): Guest Log: [INFO] Testing connection to VCCS
2022-06-12 10:56:25 (10888): Guest Log: [INFO] Testing connection to HTCondor
2022-06-12 10:56:27 (10888): Guest Log: [INFO] Testing connection to WMAgent
2022-06-12 10:56:29 (10888): Guest Log: [INFO] Testing connection to EOSCMS
2022-06-12 10:56:32 (10888): Guest Log: [INFO] Testing connection to CMS-Frontier
2022-06-12 10:56:34 (10888): Guest Log: [INFO] Testing connection to Frontier
2022-06-12 10:56:43 (10888): Guest Log: [INFO] Could not find a local HTTP proxy
2022-06-12 10:56:43 (10888): Guest Log: [INFO] CVMFS and Frontier will have to use DIRECT connections
2022-06-12 10:56:43 (10888): Guest Log: [INFO] This makes the application less efficient
2022-06-12 10:56:43 (10888): Guest Log: [INFO] It also puts higher load on the project servers
2022-06-12 10:56:43 (10888): Guest Log: [INFO] Setting up a local HTTP proxy is highly recommended
2022-06-12 10:56:43 (10888): Guest Log: [INFO] Advice can be found in the project forum
2022-06-12 10:56:43 (10888): Guest Log: [INFO] Reloading and probing the CVMFS configuration
2022-06-12 10:56:54 (10888): Guest Log: [INFO] Probing /cvmfs/cvmfs-config.cern.ch... OK
2022-06-12 10:56:54 (10888): Guest Log: [INFO] Probing /cvmfs/grid.cern.ch... OK
2022-06-12 10:57:00 (10888): Guest Log: [INFO] Probing /cvmfs/singularity.opensciencegrid.org... OK
2022-06-12 10:57:02 (10888): Guest Log: [INFO] Probing /cvmfs/oasis.opensciencegrid.org... OK
2022-06-12 10:57:06 (10888): Guest Log: [INFO] Probing /cvmfs/cms.cern.ch... OK
2022-06-12 10:57:08 (10888): Guest Log: [INFO] Probing /cvmfs/cms-ib.cern.ch... OK
2022-06-12 10:57:11 (10888): Guest Log: [INFO] Excerpt from "cvmfs_config stat": VERSION HOST PROXY
2022-06-12 10:57:11 (10888): Guest Log: [INFO] 2.7.2.0 http://s1cern-cvmfs.openhtc.io DIRECT
2022-06-12 10:57:11 (10888): Guest Log: [INFO] Reading volunteer information
2022-06-12 10:57:21 (10888): Guest Log: [INFO] Requesting an X509 credential from LHC@home
2022-06-12 10:57:25 (10888): Guest Log: [INFO] Requesting an X509 credential from vLHC@home-dev
2022-06-12 10:57:29 (10888): Guest Log: [INFO] CMS application starting. Check log files.
2022-06-12 11:30:46 (10888): VM state change detected. (old = 'running', new = 'paused')
2022-06-12 11:30:56 (10888): VM state change detected. (old = 'paused', new = 'running')
2022-06-12 11:46:30 (10888): Stopping VM.
2022-06-12 11:46:54 (10888): Successfully stopped VM.
2022-06-12 12:51:14 (8220): Detected: vboxwrapper 26202
2022-06-12 12:51:14 (8220): Detected: BOINC client v7.16.20
2022-06-12 12:51:15 (8220): Detected: VirtualBox VboxManage Interface (Version: 6.0.14)
2022-06-12 12:51:15 (8220): Detected: Heartbeat check (file: 'heartbeat' every 1200.000000 seconds)
2022-06-12 12:51:16 (8220): Guest Log: BIOS: VirtualBox 6.0.14
2022-06-12 12:51:16 (8220): Guest Log: CPUID EDX: 0x178bfbff
2022-06-12 12:51:16 (8220): Guest Log: BIOS: ata0-0: PCHS=16383/16/63 LCHS=1024/255/63
2022-06-12 12:51:16 (8220): Guest Log: BIOS: Boot : bseqnr=1, bootseq=0032
2022-06-12 12:51:16 (8220): Guest Log: BIOS: Booting from Hard Disk...
2022-06-12 12:51:16 (8220): Guest Log: BIOS: KBD: unsupported int 16h function 03
2022-06-12 12:51:16 (8220): Guest Log: BIOS: AX=0305 BX=0000 CX=0000 DX=0000
2022-06-12 12:51:16 (8220): Guest Log: vgdrvHeartbeatInit: Setting up heartbeat to trigger every 2000 milliseconds
2022-06-12 12:51:16 (8220): Guest Log: vboxguest: misc device minor 56, IRQ 20, I/O port d020, MMIO at 00000000f0400000 (size 0x400000)
2022-06-12 12:51:16 (8220): Guest Log: VBoxService 5.2.6 r120293 (verbosity: 0) linux.amd64 (Jan 15 2018 14:51:00) release log
2022-06-12 12:51:16 (8220): Guest Log: 00:00:00.000136 main Log opened 2022-06-12T08:54:41.533690000Z
2022-06-12 12:51:16 (8220): Guest Log: 00:00:00.000998 main OS Product: Linux
2022-06-12 12:51:16 (8220): Guest Log: 00:00:00.001090 main OS Release: 4.14.232-19.cernvm.x86_64
2022-06-12 12:51:16 (8220): Guest Log: 00:00:00.001132 main OS Version: #1 SMP Fri Apr 30 17:12:25 CEST 2021
2022-06-12 12:51:16 (8220): Guest Log: 00:00:00.001176 main Executable: /usr/sbin/VBoxService
2022-06-12 12:51:16 (8220): Guest Log: 00:00:00.001177 main Process ID: 2351
2022-06-12 12:51:16 (8220): Guest Log: 00:00:00.001178 main Package type: LINUX_64BITS_GENERIC
2022-06-12 12:51:16 (8220): Guest Log: 00:00:00.002411 main 5.2.6 r120293 started. Verbose level = 0
2022-06-12 12:51:16 (8220): Guest Log: [INFO] Mounting the shared directory
2022-06-12 12:51:16 (8220): Guest Log: [INFO] Shared directory mounted, enabling vboxmonitor
2022-06-12 12:51:16 (8220): Guest Log: [INFO] Sourcing essential functions from /cvmfs/grid.cern.ch
2022-06-12 12:51:16 (8220): Guest Log: [INFO] Testing connection to cern.ch
2022-06-12 12:51:16 (8220): Guest Log: [INFO] Testing connection to VCCS
2022-06-12 12:51:16 (8220): Guest Log: [INFO] Testing connection to HTCondor
2022-06-12 12:51:16 (8220): Guest Log: [INFO] Testing connection to WMAgent
2022-06-12 12:51:16 (8220): Guest Log: [INFO] Testing connection to EOSCMS
2022-06-12 12:51:16 (8220): Guest Log: [INFO] Testing connection to CMS-Frontier
2022-06-12 12:51:16 (8220): Guest Log: [INFO] Testing connection to Frontier
2022-06-12 12:51:16 (8220): Guest Log: [INFO] Could not find a local HTTP proxy
2022-06-12 12:51:16 (8220): Guest Log: [INFO] CVMFS and Frontier will have to use DIRECT connections
2022-06-12 12:51:16 (8220): Guest Log: [INFO] This makes the application less efficient
2022-06-12 12:51:16 (8220): Guest Log: [INFO] It also puts higher load on the project servers
2022-06-12 12:51:16 (8220): Guest Log: [INFO] Setting up a local HTTP proxy is highly recommended
2022-06-12 12:51:16 (8220): Guest Log: [INFO] Advice can be found in the project forum
2022-06-12 12:51:16 (8220): Guest Log: [INFO] Reloading and probing the CVMFS configuration
2022-06-12 12:51:16 (8220): Guest Log: [INFO] Probing /cvmfs/cvmfs-config.cern.ch... OK
2022-06-12 12:51:16 (8220): Guest Log: [INFO] Probing /cvmfs/grid.cern.ch... OK
2022-06-12 12:51:16 (8220): Guest Log: [INFO] Probing /cvmfs/singularity.opensciencegrid.org... OK
2022-06-12 12:51:16 (8220): Guest Log: [INFO] Probing /cvmfs/oasis.opensciencegrid.org... OK
2022-06-12 12:51:16 (8220): Guest Log: [INFO] Probing /cvmfs/cms.cern.ch... OK
2022-06-12 12:51:16 (8220): Guest Log: [INFO] Probing /cvmfs/cms-ib.cern.ch... OK
2022-06-12 12:51:16 (8220): Guest Log: [INFO] Excerpt from "cvmfs_config stat": VERSION HOST PROXY
2022-06-12 12:51:16 (8220): Guest Log: [INFO] 2.7.2.0 http://s1cern-cvmfs.openhtc.io DIRECT
2022-06-12 12:51:16 (8220): Guest Log: [INFO] Reading volunteer information
2022-06-12 12:51:16 (8220): Guest Log: [INFO] Requesting an X509 credential from LHC@home
2022-06-12 12:51:16 (8220): Guest Log: [INFO] Requesting an X509 credential from vLHC@home-dev
2022-06-12 12:51:16 (8220): Guest Log: [INFO] CMS application starting. Check log files.
2022-06-12 12:51:16 (8220): Starting VM using VBoxManage interface. (boinc_9c3af08294f2b9cd, slot#2)
2022-06-12 12:51:32 (8220): Successfully started VM. (PID = '13120')
2022-06-12 12:51:32 (8220): Reporting VM Process ID to BOINC.
2022-06-12 12:51:32 (8220): VM state change detected. (old = 'poweredoff', new = 'running')
2022-06-12 12:51:32 (8220): Detected: Web Application Enabled (http://localhost:62064)
2022-06-12 12:51:32 (8220): Preference change detected
2022-06-12 12:51:32 (8220): Setting CPU throttle for VM. (100%)
2022-06-12 12:51:32 (8220): Setting checkpoint interval to 600 seconds. (Higher value of (Preference: 60 seconds) or (Vbox_job.xml: 600 seconds))
2022-06-12 12:51:33 (8220): Guest Log: 00:51:42.847237 timesync vgsvcTimeSyncWorker: Radical host time change: 3 910 414 000 000ns (HostNow=1 655 031 093 097 000 000 ns HostLast=1 655 027 182 683 000 000 ns)
2022-06-12 12:51:43 (8220): Guest Log: 00:51:52.851740 timesync vgsvcTimeSyncWorker: Radical guest time change: 3 918 723 983 000ns (GuestNow=1 655 031 103 102 782 000 ns GuestLast=1 655 027 184 378 799 000 ns fSetTimeLastLoop=true )
2022-06-12 12:54:20 (8220): Stopping VM.
2022-06-12 12:54:43 (8220): Successfully stopped VM.
2022-06-12 14:28:42 (12972): Detected: vboxwrapper 26202
2022-06-12 14:28:42 (12972): Detected: BOINC client v7.16.20
2022-06-12 14:28:43 (12972): Detected: VirtualBox VboxManage Interface (Version: 6.0.14)
2022-06-12 14:28:43 (12972): Detected: Heartbeat check (file: 'heartbeat' every 1200.000000 seconds)
2022-06-12 14:28:43 (12972): Guest Log: 00:51:42.847237 timesync vgsvcTimeSyncWorker: Radical host time change: 3 910 414 000 000ns (HostNow=1 655 031 093 097 000 000 ns HostLast=1 655 027 182 683 000 000 ns)
2022-06-12 14:28:43 (12972): Guest Log: 00:51:52.851740 timesync vgsvcTimeSyncWorker: Radical guest time change: 3 918 723 983 000ns (GuestNow=1 655 031 103 102 782 000 ns GuestLast=1 655 027 184 378 799 000 ns fSetTimeLastLoop=true )
2022-06-12 14:28:43 (12972): Starting VM using VBoxManage interface. (boinc_9c3af08294f2b9cd, slot#2)
2022-06-12 14:29:00 (12972): Successfully started VM. (PID = '17108')
2022-06-12 14:29:00 (12972): Reporting VM Process ID to BOINC.
2022-06-12 14:29:00 (12972): VM state change detected. (old = 'poweredoff', new = 'running')
2022-06-12 14:29:00 (12972): Detected: Web Application Enabled (http://localhost:62064)
2022-06-12 14:29:00 (12972): Preference change detected
2022-06-12 14:29:00 (12972): Setting CPU throttle for VM. (100%)
2022-06-12 14:29:00 (12972): Setting checkpoint interval to 600 seconds. (Higher value of (Preference: 60 seconds) or (Vbox_job.xml: 600 seconds))
2022-06-12 14:29:02 (12972): Guest Log: 00:54:33.281799 timesync vgsvcTimeSyncWorker: Radical host time change: 5 688 772 000 000ns (HostNow=1 655 036 941 977 000 000 ns HostLast=1 655 031 253 205 000 000 ns)
2022-06-12 14:29:12 (12972): Guest Log: 00:54:43.296870 timesync vgsvcTimeSyncWorker: Radical guest time change: 5 688 459 425 000ns (GuestNow=1 655 036 951 992 084 000 ns GuestLast=1 655 031 263 532 659 000 ns fSetTimeLastLoop=true )
2022-06-12 14:41:49 (12972): VM state change detected. (old = 'running', new = 'paused')
2022-06-12 14:41:59 (12972): VM state change detected. (old = 'paused', new = 'running')
2022-06-12 15:13:59 (12972): Status Report: Job Duration: '64800.000000'
2022-06-12 15:13:59 (12972): Status Report: Elapsed Time: '6000.000000'
2022-06-12 15:13:59 (12972): Status Report: CPU Time: '6025.265625'
2022-06-12 15:42:01 (12972): VM state change detected. (old = 'running', new = 'paused')
2022-06-12 15:42:11 (12972): VM state change detected. (old = 'paused', new = 'running')
2022-06-12 16:42:04 (12972): VM state change detected. (old = 'running', new = 'paused')
2022-06-12 16:42:14 (12972): VM state change detected. (old = 'paused', new = 'running')
2022-06-12 16:54:27 (12972): Status Report: Job Duration: '64800.000000'
2022-06-12 16:54:27 (12972): Status Report: Elapsed Time: '12000.000000'
2022-06-12 16:54:27 (12972): Status Report: CPU Time: '12682.171875'
2022-06-12 17:42:08 (12972): VM state change detected. (old = 'running', new = 'paused')
2022-06-12 17:42:18 (12972): VM state change detected. (old = 'paused', new = 'running')
2022-06-12 18:34:45 (12972): Status Report: Job Duration: '64800.000000'
2022-06-12 18:34:45 (12972): Status Report: Elapsed Time: '18000.000000'
2022-06-12 18:34:45 (12972): Status Report: CPU Time: '19180.921875'
2022-06-12 18:42:26 (12972): VM state change detected. (old = 'running', new = 'paused')
2022-06-12 18:42:35 (12972): VM state change detected. (old = 'paused', new = 'running')
2022-06-12 19:35:27 (12972): VM state change detected. (old = 'running', new = 'paused')
2022-06-12 19:35:34 (12972): VM state change detected. (old = 'paused', new = 'running')
2022-06-12 19:42:47 (12972): VM state change detected. (old = 'running', new = 'paused')
2022-06-12 19:42:48 (12972): VM state change detected. (old = 'paused', new = 'running')
2022-06-12 20:15:27 (12972): Status Report: Job Duration: '64800.000000'
2022-06-12 20:15:27 (12972): Status Report: Elapsed Time: '24000.380157'
2022-06-12 20:15:27 (12972): Status Report: CPU Time: '24662.781250'
2022-06-12 20:37:22 (12972): Stopping VM.
2022-06-12 20:38:12 (12972): Error in stop VM for VM: -182
Command:
VBoxManage -q controlvm "boinc_9c3af08294f2b9cd" savestate
Output:
0%...10%...20%...30%...40%...50%...60%...70%...
2022-06-12 20:38:12 (12972): VM did not stop when requested.
2022-06-12 20:38:12 (12972): VM was successfully terminated.
2022-06-12 22:01:43 (13536): Detected: vboxwrapper 26202
2022-06-12 22:01:43 (13536): Detected: BOINC client v7.16.20
2022-06-12 22:01:44 (13536): Detected: VirtualBox VboxManage Interface (Version: 6.0.14)
2022-06-12 22:01:44 (13536): Detected: Heartbeat check (file: 'heartbeat' every 1200.000000 seconds)
2022-06-12 22:01:45 (13536): Guest Log: 00:54:33.281799 timesync vgsvcTimeSyncWorker: Radical host time change: 5 688 772 000 000ns (HostNow=1 655 036 941 977 000 000 ns HostLast=1 655 031 253 205 000 000 ns)
2022-06-12 22:01:45 (13536): Guest Log: 00:54:43.296870 timesync vgsvcTimeSyncWorker: Radical guest time change: 5 688 459 425 000ns (GuestNow=1 655 036 951 992 084 000 ns GuestLast=1 655 031 263 532 659 000 ns fSetTimeLastLoop=true )
2022-06-12 22:01:45 (13536): Starting VM using VBoxManage interface. (boinc_9c3af08294f2b9cd, slot#2)
2022-06-12 22:01:49 (13536): Successfully started VM. (PID = '13392')
2022-06-12 22:01:49 (13536): Reporting VM Process ID to BOINC.
2022-06-12 22:01:49 (13536): Guest Log: BIOS: VirtualBox 6.0.14
2022-06-12 22:01:49 (13536): Guest Log: CPUID EDX: 0x178bfbff
2022-06-12 22:01:49 (13536): Guest Log: BIOS: ata0-0: PCHS=16383/16/63 LCHS=1024/255/63
2022-06-12 22:01:49 (13536): VM state change detected. (old = 'poweredoff', new = 'running')
2022-06-12 22:01:49 (13536): Detected: Web Application Enabled (http://localhost:62064)
2022-06-12 22:01:49 (13536): Status Report: Job Duration: '64800.000000'
2022-06-12 22:01:49 (13536): Status Report: Elapsed Time: '25314.380157'
2022-06-12 22:01:49 (13536): Status Report: CPU Time: '24718.421875'
2022-06-12 22:01:49 (13536): Preference change detected
2022-06-12 22:01:49 (13536): Setting CPU throttle for VM. (100%)
2022-06-12 22:01:50 (13536): Setting checkpoint interval to 600 seconds. (Higher value of (Preference: 60 seconds) or (Vbox_job.xml: 600 seconds))
2022-06-12 22:01:51 (13536): Guest Log: BIOS: Boot : bseqnr=1, bootseq=0032
2022-06-12 22:01:51 (13536): Guest Log: BIOS: Booting from Hard Disk...
2022-06-12 22:01:53 (13536): Guest Log: BIOS: KBD: unsupported int 16h function 03
2022-06-12 22:01:53 (13536): Guest Log: BIOS: AX=0305 BX=0000 CX=0000 DX=0000
2022-06-12 22:02:36 (13536): Guest Log: vgdrvHeartbeatInit: Setting up heartbeat to trigger every 2000 milliseconds
2022-06-12 22:02:36 (13536): Guest Log: vboxguest: misc device minor 56, IRQ 20, I/O port d020, MMIO at 00000000f0400000 (size 0x400000)
2022-06-12 22:02:37 (13536): Guest Log: VBoxService 5.2.6 r120293 (verbosity: 0) linux.amd64 (Jan 15 2018 14:51:00) release log
2022-06-12 22:02:37 (13536): Guest Log: 00:00:00.000140 main Log opened 2022-06-12T20:02:38.039848000Z
2022-06-12 22:02:37 (13536): Guest Log: 00:00:00.000258 main OS Product: Linux
2022-06-12 22:02:37 (13536): Guest Log: 00:00:00.000307 main OS Release: 4.14.232-19.cernvm.x86_64
2022-06-12 22:02:37 (13536): Guest Log: 00:00:00.000357 main OS Version: #1 SMP Fri Apr 30 17:12:25 CEST 2021
2022-06-12 22:02:37 (13536): Guest Log: 00:00:00.000391 main Executable: /usr/sbin/VBoxService
2022-06-12 22:02:37 (13536): Guest Log: 00:00:00.000392 main Process ID: 2354
2022-06-12 22:02:37 (13536): Guest Log: 00:00:00.000393 main Package type: LINUX_64BITS_GENERIC
2022-06-12 22:02:37 (13536): Guest Log: 00:00:00.001446 main 5.2.6 r120293 started. Verbose level = 0
2022-06-12 22:03:02 (13536): Guest Log: [INFO] Mounting the shared directory
2022-06-12 22:03:03 (13536): Guest Log: [INFO] Shared directory mounted, enabling vboxmonitor
2022-06-12 22:03:03 (13536): Guest Log: [INFO] Sourcing essential functions from /cvmfs/grid.cern.ch
2022-06-12 22:03:03 (13536): Guest Log: [INFO] Testing connection to cern.ch
2022-06-12 22:03:05 (13536): Guest Log: [INFO] Testing connection to VCCS
2022-06-12 22:03:07 (13536): Guest Log: [INFO] Testing connection to HTCondor
2022-06-12 22:03:09 (13536): Guest Log: [INFO] Testing connection to WMAgent
2022-06-12 22:03:12 (13536): Guest Log: [INFO] Testing connection to EOSCMS
2022-06-12 22:03:14 (13536): Guest Log: [INFO] Testing connection to CMS-Frontier
2022-06-12 22:03:16 (13536): Guest Log: [INFO] Testing connection to Frontier
2022-06-12 22:03:25 (13536): Guest Log: [INFO] Could not find a local HTTP proxy
2022-06-12 22:03:25 (13536): Guest Log: [INFO] CVMFS and Frontier will have to use DIRECT connections
2022-06-12 22:03:25 (13536): Guest Log: [INFO] This makes the application less efficient
2022-06-12 22:03:26 (13536): Guest Log: [INFO] It also puts higher load on the project servers
2022-06-12 22:03:26 (13536): Guest Log: [INFO] Setting up a local HTTP proxy is highly recommended
2022-06-12 22:03:26 (13536): Guest Log: [INFO] Advice can be found in the project forum
2022-06-12 22:03:26 (13536): Guest Log: [INFO] Reloading and probing the CVMFS configuration
2022-06-12 22:03:40 (13536): Guest Log: [INFO] Probing /cvmfs/cvmfs-config.cern.ch... OK
2022-06-12 22:03:40 (13536): Guest Log: [INFO] Probing /cvmfs/grid.cern.ch... OK
2022-06-12 22:03:45 (13536): Guest Log: [INFO] Probing /cvmfs/cms-ib.cern.ch... OK
2022-06-12 22:03:46 (13536): Guest Log: [INFO] Probing /cvmfs/cms.cern.ch... OK
2022-06-12 22:03:47 (13536): Guest Log: [INFO] Probing /cvmfs/singularity.opensciencegrid.org... OK
2022-06-12 22:03:49 (13536): Guest Log: [INFO] Probing /cvmfs/oasis.opensciencegrid.org... OK
2022-06-12 22:03:52 (13536): Guest Log: [INFO] Excerpt from "cvmfs_config stat": VERSION HOST PROXY
2022-06-12 22:03:52 (13536): Guest Log: [INFO] 2.7.2.0 http://s1cern-cvmfs.openhtc.io DIRECT
2022-06-12 22:03:52 (13536): Guest Log: [INFO] Reading volunteer information
2022-06-12 22:03:57 (13536): Guest Log: [INFO] Requesting an X509 credential from LHC@home
2022-06-12 22:04:01 (13536): Guest Log: [INFO] Requesting an X509 credential from vLHC@home-dev
2022-06-12 22:04:05 (13536): Guest Log: [INFO] CMS application starting. Check log files.
2022-06-12 22:13:13 (13536): VM state change detected. (old = 'running', new = 'paused')
2022-06-12 22:13:23 (13536): VM state change detected. (old = 'paused', new = 'running')
2022-06-12 22:28:24 (13536): VM state change detected. (old = 'running', new = 'paused')
2022-06-12 22:28:34 (13536): VM state change detected. (old = 'paused', new = 'running')
2022-06-12 23:16:26 (13536): VM state change detected. (old = 'running', new = 'paused')
2022-06-12 23:16:37 (13536): VM state change detected. (old = 'paused', new = 'running')
2022-06-12 23:28:28 (13536): VM state change detected. (old = 'running', new = 'paused')
2022-06-12 23:28:38 (13536): VM state change detected. (old = 'paused', new = 'running')
2022-06-12 23:42:17 (13536): Stopping VM.
2022-06-12 23:42:58 (13536): Successfully stopped VM.
2022-06-13 02:44:12 (8656): Detected: vboxwrapper 26202
2022-06-13 02:44:12 (8656): Detected: BOINC client v7.16.20
2022-06-13 02:44:13 (8656): Detected: VirtualBox VboxManage Interface (Version: 6.0.14)
2022-06-13 02:44:13 (8656): Detected: Heartbeat check (file: 'heartbeat' every 1200.000000 seconds)
2022-06-13 02:44:14 (8656): Guest Log: BIOS: VirtualBox 6.0.14
2022-06-13 02:44:14 (8656): Guest Log: CPUID EDX: 0x178bfbff
2022-06-13 02:44:14 (8656): Guest Log: BIOS: ata0-0: PCHS=16383/16/63 LCHS=1024/255/63
2022-06-13 02:44:14 (8656): Guest Log: BIOS: Boot : bseqnr=1, bootseq=0032
2022-06-13 02:44:14 (8656): Guest Log: BIOS: Booting from Hard Disk...
2022-06-13 02:44:14 (8656): Guest Log: BIOS: KBD: unsupported int 16h function 03
2022-06-13 02:44:14 (8656): Guest Log: BIOS: AX=0305 BX=0000 CX=0000 DX=0000
2022-06-13 02:44:14 (8656): Guest Log: vgdrvHeartbeatInit: Setting up heartbeat to trigger every 2000 milliseconds
2022-06-13 02:44:14 (8656): Guest Log: vboxguest: misc device minor 56, IRQ 20, I/O port d020, MMIO at 00000000f0400000 (size 0x400000)
2022-06-13 02:44:14 (8656): Guest Log: VBoxService 5.2.6 r120293 (verbosity: 0) linux.amd64 (Jan 15 2018 14:51:00) release log
2022-06-13 02:44:14 (8656): Guest Log: 00:00:00.000140 main Log opened 2022-06-12T20:02:38.039848000Z
2022-06-13 02:44:14 (8656): Guest Log: 00:00:00.000258 main OS Product: Linux
2022-06-13 02:44:14 (8656): Guest Log: 00:00:00.000307 main OS Release: 4.14.232-19.cernvm.x86_64
2022-06-13 02:44:14 (8656): Guest Log: 00:00:00.000357 main OS Version: #1 SMP Fri Apr 30 17:12:25 CEST 2021
2022-06-13 02:44:14 (8656): Guest Log: 00:00:00.000391 main Executable: /usr/sbin/VBoxService
2022-06-13 02:44:14 (8656): Guest Log: 00:00:00.000392 main Process ID: 2354
2022-06-13 02:44:14 (8656): Guest Log: 00:00:00.000393 main Package type: LINUX_64BITS_GENERIC
2022-06-13 02:44:14 (8656): Guest Log: 00:00:00.001446 main 5.2.6 r120293 started. Verbose level = 0
2022-06-13 02:44:14 (8656): Guest Log: [INFO] Mounting the shared directory
2022-06-13 02:44:14 (8656): Guest Log: [INFO] Shared directory mounted, enabling vboxmonitor
2022-06-13 02:44:14 (8656): Guest Log: [INFO] Sourcing essential functions from /cvmfs/grid.cern.ch
2022-06-13 02:44:14 (8656): Guest Log: [INFO] Testing connection to cern.ch
2022-06-13 02:44:14 (8656): Guest Log: [INFO] Testing connection to VCCS
2022-06-13 02:44:14 (8656): Guest Log: [INFO] Testing connection to HTCondor
2022-06-13 02:44:14 (8656): Guest Log: [INFO] Testing connection to WMAgent
2022-06-13 02:44:14 (8656): Guest Log: [INFO] Testing connection to EOSCMS
2022-06-13 02:44:14 (8656): Guest Log: [INFO] Testing connection to CMS-Frontier
2022-06-13 02:44:14 (8656): Guest Log: [INFO] Testing connection to Frontier
2022-06-13 02:44:14 (8656): Guest Log: [INFO] Could not find a local HTTP proxy
2022-06-13 02:44:14 (8656): Guest Log: [INFO] CVMFS and Frontier will have to use DIRECT connections
2022-06-13 02:44:14 (8656): Guest Log: [INFO] This makes the application less efficient
2022-06-13 02:44:14 (8656): Guest Log: [INFO] It also puts higher load on the project servers
2022-06-13 02:44:14 (8656): Guest Log: [INFO] Setting up a local HTTP proxy is highly recommended
2022-06-13 02:44:14 (8656): Guest Log: [INFO] Advice can be found in the project forum
2022-06-13 02:44:14 (8656): Guest Log: [INFO] Reloading and probing the CVMFS configuration
2022-06-13 02:44:14 (8656): Guest Log: [INFO] Probing /cvmfs/cvmfs-config.cern.ch... OK
2022-06-13 02:44:14 (8656): Guest Log: [INFO] Probing /cvmfs/grid.cern.ch... OK
2022-06-13 02:44:14 (8656): Guest Log: [INFO] Probing /cvmfs/cms-ib.cern.ch... OK
2022-06-13 02:44:14 (8656): Guest Log: [INFO] Probing /cvmfs/cms.cern.ch... OK
2022-06-13 02:44:14 (8656): Guest Log: [INFO] Probing /cvmfs/singularity.opensciencegrid.org... OK
2022-06-13 02:44:14 (8656): Guest Log: [INFO] Probing /cvmfs/oasis.opensciencegrid.org... OK
2022-06-13 02:44:14 (8656): Guest Log: [INFO] Excerpt from "cvmfs_config stat": VERSION HOST PROXY
2022-06-13 02:44:14 (8656): Guest Log: [INFO] 2.7.2.0 http://s1cern-cvmfs.openhtc.io DIRECT
2022-06-13 02:44:14 (8656): Guest Log: [INFO] Reading volunteer information
2022-06-13 02:44:14 (8656): Guest Log: [INFO] Requesting an X509 credential from LHC@home
2022-06-13 02:44:14 (8656): Guest Log: [INFO] Requesting an X509 credential from vLHC@home-dev
2022-06-13 02:44:14 (8656): Guest Log: [INFO] CMS application starting. Check log files.
2022-06-13 02:44:14 (8656): Starting VM using VBoxManage interface. (boinc_9c3af08294f2b9cd, slot#2)
2022-06-13 02:44:30 (8656): Successfully started VM. (PID = '17996')
2022-06-13 02:44:30 (8656): Reporting VM Process ID to BOINC.
2022-06-13 02:44:31 (8656): VM state change detected. (old = 'poweredoff', new = 'running')
2022-06-13 02:44:31 (8656): Detected: Web Application Enabled (http://localhost:62064)
2022-06-13 02:44:31 (8656): Status Report: Job Duration: '64800.000000'
2022-06-13 02:44:31 (8656): Status Report: Elapsed Time: '31291.380157'
2022-06-13 02:44:31 (8656): Status Report: CPU Time: '31343.609375'
2022-06-13 02:44:31 (8656): Preference change detected
2022-06-13 02:44:31 (8656): Setting CPU throttle for VM. (100%)
2022-06-13 02:44:31 (8656): Setting checkpoint interval to 600 seconds. (Higher value of (Preference: 60 seconds) or (Vbox_job.xml: 600 seconds))
2022-06-13 02:44:39 (8656): Guest Log: 01:39:10.267204 timesync vgsvcTimeSyncWorker: Radical host time change: 10 942 141 000 000ns (HostNow=1 655 081 078 139 000 000 ns HostLast=1 655 070 135 998 000 000 ns)
2022-06-13 02:44:49 (8656): Guest Log: 01:39:20.295555 timesync vgsvcTimeSyncWorker: Radical guest time change: 10 979 899 726 000ns (GuestNow=1 655 081 088 186 964 000 ns GuestLast=1 655 070 108 287 238 000 ns fSetTimeLastLoop=true )
2022-06-13 02:45:02 (8656): VM state change detected. (old = 'running', new = 'paused')
2022-06-13 02:45:12 (8656): VM state change detected. (old = 'paused', new = 'running')
2022-06-13 03:45:09 (8656): VM state change detected. (old = 'running', new = 'paused')
2022-06-13 03:45:19 (8656): VM state change detected. (old = 'paused', new = 'running')
2022-06-13 04:24:59 (8656): Status Report: Job Duration: '64800.000000'
2022-06-13 04:24:59 (8656): Status Report: Elapsed Time: '37291.380157'
2022-06-13 04:24:59 (8656): Status Report: CPU Time: '32627.968750'
2022-06-13 04:45:28 (8656): VM state change detected. (old = 'running', new = 'paused')
2022-06-13 04:45:38 (8656): VM state change detected. (old = 'paused', new = 'running')
2022-06-13 06:05:16 (8656): Status Report: Job Duration: '64800.000000'
2022-06-13 06:05:16 (8656): Status Report: Elapsed Time: '43291.380157'
2022-06-13 06:05:16 (8656): Status Report: CPU Time: '32878.578125'
2022-06-13 06:45:37 (8656): VM state change detected. (old = 'running', new = 'paused')
2022-06-13 06:45:48 (8656): VM state change detected. (old = 'paused', new = 'running')
2022-06-13 07:45:35 (8656): Status Report: Job Duration: '64800.000000'
2022-06-13 07:45:35 (8656): Status Report: Elapsed Time: '49291.380157'
2022-06-13 07:45:35 (8656): Status Report: CPU Time: '33131.093750'
2022-06-13 07:45:47 (8656): VM state change detected. (old = 'running', new = 'paused')
2022-06-13 07:45:57 (8656): VM state change detected. (old = 'paused', new = 'running')
2022-06-13 08:13:30 (8656): Stopping VM.
2022-06-13 08:14:10 (8656): Successfully stopped VM.
2022-06-13 17:34:51 (10008): Detected: vboxwrapper 26202
2022-06-13 17:34:51 (10008): Detected: BOINC client v7.16.20
2022-06-13 17:34:51 (10008): Detected: VirtualBox VboxManage Interface (Version: 6.0.14)
2022-06-13 17:34:51 (10008): Detected: Heartbeat check (file: 'heartbeat' every 1200.000000 seconds)
2022-06-13 17:34:52 (10008): Guest Log: 01:39:10.267204 timesync vgsvcTimeSyncWorker: Radical host time change: 10 942 141 000 000ns (HostNow=1 655 081 078 139 000 000 ns HostLast=1 655 070 135 998 000 000 ns)
2022-06-13 17:34:52 (10008): Guest Log: 01:39:20.295555 timesync vgsvcTimeSyncWorker: Radical guest time change: 10 979 899 726 000ns (GuestNow=1 655 081 088 186 964 000 ns GuestLast=1 655 070 108 287 238 000 ns fSetTimeLastLoop=true )
2022-06-13 17:34:52 (10008): Starting VM using VBoxManage interface. (boinc_9c3af08294f2b9cd, slot#2)
2022-06-13 17:35:11 (10008): Successfully started VM. (PID = '11708')
2022-06-13 17:35:11 (10008): Reporting VM Process ID to BOINC.
2022-06-13 17:35:11 (10008): VM state change detected. (old = 'poweredoff', new = 'running')
2022-06-13 17:35:11 (10008): Detected: Web Application Enabled (http://localhost:62064)
2022-06-13 17:35:12 (10008): VM state change detected. (old = 'running', new = 'paused')
2022-06-13 17:35:22 (10008): Status Report: Job Duration: '64800.000000'
2022-06-13 17:35:22 (10008): Status Report: Elapsed Time: '50954.380157'
2022-06-13 17:35:22 (10008): Status Report: CPU Time: '33200.703125'
2022-06-13 17:35:22 (10008): Preference change detected
2022-06-13 17:35:22 (10008): Setting CPU throttle for VM. (100%)
2022-06-13 17:35:22 (10008): Setting checkpoint interval to 600 seconds. (Higher value of (Preference: 60 seconds) or (Vbox_job.xml: 600 seconds))
2022-06-13 17:35:22 (10008): VM state change detected. (old = 'paused', new = 'running')
2022-06-13 17:35:23 (10008): Guest Log: 07:07:27.698137 timesync vgsvcTimeSyncWorker: Radical host time change: 33 718 474 000 000ns (HostNow=1 655 134 523 671 000 000 ns HostLast=1 655 100 805 197 000 000 ns)
2022-06-13 17:35:33 (10008): Guest Log: 07:07:37.708154 timesync vgsvcTimeSyncWorker: Radical guest time change: 33 758 092 165 000ns (GuestNow=1 655 134 533 681 355 000 ns GuestLast=1 655 100 775 589 190 000 ns fSetTimeLastLoop=true )
2022-06-13 17:35:52 (10008): VM state change detected. (old = 'running', new = 'paused')
2022-06-13 17:36:02 (10008): VM state change detected. (old = 'paused', new = 'running')
2022-06-13 18:36:06 (10008): VM state change detected. (old = 'running', new = 'paused')
2022-06-13 18:36:16 (10008): VM state change detected. (old = 'paused', new = 'running')
2022-06-13 19:15:49 (10008): Status Report: Job Duration: '64800.000000'
2022-06-13 19:15:49 (10008): Status Report: Elapsed Time: '56954.380157'
2022-06-13 19:15:49 (10008): Status Report: CPU Time: '33447.421875'
2022-06-13 19:36:09 (10008): VM state change detected. (old = 'running', new = 'paused')
2022-06-13 19:36:20 (10008): VM state change detected. (old = 'paused', new = 'running')
2022-06-13 20:36:13 (10008): Stopping VM.
2022-06-13 20:37:01 (10008): Error in stop VM for VM: -182
Command:
VBoxManage -q controlvm "boinc_9c3af08294f2b9cd" savestate
Output:
0%...10%...20%...30%...40%...50%...60%...70%...80%...90%...
2022-06-13 20:37:01 (10008): VM did not stop when requested.
2022-06-13 20:37:01 (10008): VM was successfully terminated.
2022-06-14 00:10:51 (14680): Detected: vboxwrapper 26202
2022-06-14 00:10:51 (14680): Detected: BOINC client v7.16.20
2022-06-14 00:10:51 (14680): Detected: VirtualBox VboxManage Interface (Version: 6.0.14)
2022-06-14 00:10:51 (14680): Detected: Heartbeat check (file: 'heartbeat' every 1200.000000 seconds)
2022-06-14 00:10:52 (14680): Guest Log: 07:07:27.698137 timesync vgsvcTimeSyncWorker: Radical host time change: 33 718 474 000 000ns (HostNow=1 655 134 523 671 000 000 ns HostLast=1 655 100 805 197 000 000 ns)
2022-06-14 00:10:52 (14680): Guest Log: 07:07:37.708154 timesync vgsvcTimeSyncWorker: Radical guest time change: 33 758 092 165 000ns (GuestNow=1 655 134 533 681 355 000 ns GuestLast=1 655 100 775 589 190 000 ns fSetTimeLastLoop=true )
2022-06-14 00:10:52 (14680): Starting VM using VBoxManage interface. (boinc_9c3af08294f2b9cd, slot#2)
2022-06-14 00:10:56 (14680): Successfully started VM. (PID = '16508')
2022-06-14 00:10:56 (14680): Reporting VM Process ID to BOINC.
2022-06-14 00:10:56 (14680): Guest Log: BIOS: VirtualBox 6.0.14
2022-06-14 00:10:56 (14680): Guest Log: CPUID EDX: 0x178bfbff
2022-06-14 00:10:56 (14680): Guest Log: BIOS: ata0-0: PCHS=16383/16/63 LCHS=1024/255/63
2022-06-14 00:10:56 (14680): VM state change detected. (old = 'poweredoff', new = 'running')
2022-06-14 00:10:56 (14680): Detected: Web Application Enabled (http://localhost:62064)
2022-06-14 00:10:56 (14680): Status Report: Job Duration: '64800.000000'
2022-06-14 00:10:56 (14680): Status Report: Elapsed Time: '61761.380157'
2022-06-14 00:10:56 (14680): Status Report: CPU Time: '33630.296875'
2022-06-14 00:10:56 (14680): Preference change detected
2022-06-14 00:10:56 (14680): Setting CPU throttle for VM. (100%)
2022-06-14 00:10:56 (14680): Setting checkpoint interval to 600 seconds. (Higher value of (Preference: 60 seconds) or (Vbox_job.xml: 600 seconds))
2022-06-14 00:10:58 (14680): Guest Log: BIOS: Boot : bseqnr=1, bootseq=0032
2022-06-14 00:10:58 (14680): Guest Log: BIOS: Booting from Hard Disk...
2022-06-14 00:11:00 (14680): Guest Log: BIOS: KBD: unsupported int 16h function 03
2022-06-14 00:11:00 (14680): Guest Log: BIOS: AX=0305 BX=0000 CX=0000 DX=0000
2022-06-14 00:12:32 (14680): Guest Log: vgdrvHeartbeatInit: Setting up heartbeat to trigger every 2000 milliseconds
2022-06-14 00:12:32 (14680): Guest Log: vboxguest: misc device minor 56, IRQ 20, I/O port d020, MMIO at 00000000f0400000 (size 0x400000)
2022-06-14 00:12:34 (14680): Guest Log: VBoxService 5.2.6 r120293 (verbosity: 0) linux.amd64 (Jan 15 2018 14:51:00) release log
2022-06-14 00:12:34 (14680): Guest Log: 00:00:00.000198 main Log opened 2022-06-13T22:12:39.193655000Z
2022-06-14 00:12:34 (14680): Guest Log: 00:00:00.000484 main OS Product: Linux
2022-06-14 00:12:34 (14680): Guest Log: 00:00:00.000530 main OS Release: 4.14.232-19.cernvm.x86_64
2022-06-14 00:12:34 (14680): Guest Log: 00:00:00.000567 main OS Version: #1 SMP Fri Apr 30 17:12:25 CEST 2021
2022-06-14 00:12:34 (14680): Guest Log: 00:00:00.000596 main Executable: /usr/sbin/VBoxService
2022-06-14 00:12:34 (14680): Guest Log: 00:00:00.000596 main Process ID: 2354
2022-06-14 00:12:34 (14680): Guest Log: 00:00:00.000597 main Package type: LINUX_64BITS_GENERIC
2022-06-14 00:12:34 (14680): Guest Log: 00:00:00.001401 main 5.2.6 r120293 started. Verbose level = 0
2022-06-14 00:13:26 (14680): Powering off VM.
2022-06-14 00:13:26 (14680): Successfully stopped VM.
2022-06-14 00:13:26 (14680): Deregistering VM. (boinc_9c3af08294f2b9cd, slot#2)
2022-06-14 00:13:27 (14680): Removing network bandwidth throttle group from VM.
2022-06-14 00:13:27 (14680): Removing VM from VirtualBox.
Hypervisor System Log:
01:03:14.922367 ERROR [COM]: aRC=E_ACCESSDENIED (0x80070005) aIID={5047460a-265d-4538-b23e-ddba5fb84976} aComponent={MachineWrap} aText={The object functionality is limited}, preserve=false aResultDetail=0
01:03:14.922375 ERROR [COM]: aRC=E_ACCESSDENIED (0x80070005) aIID={5047460a-265d-4538-b23e-ddba5fb84976} aComponent={MachineWrap} aText={The object functionality is limited}, preserve=false aResultDetail=0
01:03:14.922383 ERROR [COM]: aRC=E_ACCESSDENIED (0x80070005) aIID={5047460a-265d-4538-b23e-ddba5fb84976} aComponent={MachineWrap} aText={The object functionality is limited}, preserve=false aResultDetail=0
01:03:14.922392 ERROR [COM]: aRC=E_ACCESSDENIED (0x80070005) aIID={5047460a-265d-4538-b23e-ddba5fb84976} aComponent={MachineWrap} aText={The object functionality is limited}, preserve=false aResultDetail=0
01:03:14.922400 ERROR [COM]: aRC=E_ACCESSDENIED (0x80070005) aIID={5047460a-265d-4538-b23e-ddba5fb84976} aComponent={MachineWrap} aText={The object functionality is limited}, preserve=false aResultDetail=0
01:03:14.922409 ERROR [COM]: aRC=E_ACCESSDENIED (0x80070005) aIID={5047460a-265d-4538-b23e-ddba5fb84976} aComponent={MachineWrap} aText={The object functionality is limited}, preserve=false aResultDetail=0
01:03:14.922417 ERROR [COM]: aRC=E_ACCESSDENIED (0x80070005) aIID={5047460a-265d-4538-b23e-ddba5fb84976} aComponent={MachineWrap} aText={The object functionality is limited}, preserve=false aResultDetail=0
01:03:14.922425 ERROR [COM]: aRC=E_ACCESSDENIED (0x80070005) aIID={5047460a-265d-4538-b23e-ddba5fb84976} aComponent={MachineWrap} aText={The object functionality is limited}, preserve=false aResultDetail=0
01:03:14.922433 ERROR [COM]: aRC=E_ACCESSDENIED (0x80070005) aIID={5047460a-265d-4538-b23e-ddba5fb84976} aComponent={MachineWrap} aText={The object functionality is limited}, preserve=false aResultDetail=0
01:03:14.922444 ERROR [COM]: aRC=E_ACCESSDENIED (0x80070005) aIID={5047460a-265d-4538-b23e-ddba5fb84976} aComponent={MachineWrap} aText={The object functionality is limited}, preserve=false aResultDetail=0
01:03:14.922453 ERROR [COM]: aRC=E_ACCESSDENIED (0x80070005) aIID={5047460a-265d-4538-b23e-ddba5fb84976} aComponent={MachineWrap} aText={The object functionality is limited}, preserve=false aResultDetail=0
01:03:14.922461 ERROR [COM]: aRC=E_ACCESSDENIED (0x80070005) aIID={5047460a-265d-4538-b23e-ddba5fb84976} aComponent={MachineWrap} aText={The object functionality is limited}, preserve=false aResultDetail=0
01:03:14.922470 ERROR [COM]: aRC=E_ACCESSDENIED (0x80070005) aIID={5047460a-265d-4538-b23e-ddba5fb84976} aComponent={MachineWrap} aText={The object functionality is limited}, preserve=false aResultDetail=0
01:03:14.922478 ERROR [COM]: aRC=E_ACCESSDENIED (0x80070005) aIID={5047460a-265d-4538-b23e-ddba5fb84976} aComponent={MachineWrap} aText={The object functionality is limited}, preserve=false aResultDetail=0
01:03:14.922486 ERROR [COM]: aRC=E_ACCESSDENIED (0x80070005) aIID={5047460a-265d-4538-b23e-ddba5fb84976} aComponent={MachineWrap} aText={The object functionality is limited}, preserve=false aResultDetail=0
01:03:14.922494 ERROR [COM]: aRC=E_ACCESSDENIED (0x80070005) aIID={5047460a-265d-4538-b23e-ddba5fb84976} aComponent={MachineWrap} aText={The object functionality is limited}, preserve=false aResultDetail=0
01:03:14.922502 ERROR [COM]: aRC=E_ACCESSDENIED (0x80070005) aIID={5047460a-265d-4538-b23e-ddba5fb84976} aComponent={MachineWrap} aText={The object functionality is limited}, preserve=false aResultDetail=0
01:03:14.922510 ERROR [COM]: aRC=E_ACCESSDENIED (0x80070005) aIID={5047460a-265d-4538-b23e-ddba5fb84976} aComponent={MachineWrap} aText={The object functionality is limited}, preserve=false aResultDetail=0
01:03:14.922518 ERROR [COM]: aRC=E_ACCESSDENIED (0x80070005) aIID={5047460a-265d-4538-b23e-ddba5fb84976} aComponent={MachineWrap} aText={The object functionality is limited}, preserve=false aResultDetail=0
01:03:14.922526 ERROR [COM]: aRC=E_ACCESSDENIED (0x80070005) aIID={5047460a-265d-4538-b23e-ddba5fb84976} aComponent={MachineWrap} aText={The object functionality is limited}, preserve=false aResultDetail=0
01:03:14.922535 ERROR [COM]: aRC=E_ACCESSDENIED (0x80070005) aIID={5047460a-265d-4538-b23e-ddba5fb84976} aComponent={MachineWrap} aText={The object functionality is limited}, preserve=false aResultDetail=0
01:03:14.922543 ERROR [COM]: aRC=E_ACCESSDENIED (0x80070005) aIID={5047460a-265d-4538-b23e-ddba5fb84976} aComponent={MachineWrap} aText={The object functionality is limited}, preserve=false aResultDetail=0
01:03:14.922551 ERROR [COM]: aRC=E_ACCESSDENIED (0x80070005) aIID={5047460a-265d-4538-b23e-ddba5fb84976} aComponent={MachineWrap} aText={The object functionality is limited}, preserve=false aResultDetail=0
01:03:14.922559 ERROR [COM]: aRC=E_ACCESSDENIED (0x80070005) aIID={5047460a-265d-4538-b23e-ddba5fb84976} aComponent={MachineWrap} aText={The object functionality is limited}, preserve=false aResultDetail=0
01:03:14.922567 ERROR [COM]: aRC=E_ACCESSDENIED (0x80070005) aIID={5047460a-265d-4538-b23e-ddba5fb84976} aComponent={MachineWrap} aText={The object functionality is limited}, preserve=false aResultDetail=0
01:03:14.922575 ERROR [COM]: aRC=E_ACCESSDENIED (0x80070005) aIID={5047460a-265d-4538-b23e-ddba5fb84976} aComponent={MachineWrap} aText={The object functionality is limited}, preserve=false aResultDetail=0
01:03:14.922584 ERROR [COM]: aRC=E_ACCESSDENIED (0x80070005) aIID={5047460a-265d-4538-b23e-ddba5fb84976} aComponent={MachineWrap} aText={The object functionality is limited}, preserve=false aResultDetail=0
01:03:14.922592 ERROR [COM]: aRC=E_ACCESSDENIED (0x80070005) aIID={5047460a-265d-4538-b23e-ddba5fb84976} aComponent={MachineWrap} aText={The object functionality is limited}, preserve=false aResultDetail=0
01:03:14.922602 ERROR [COM]: aRC=E_ACCESSDENIED (0x80070005) aIID={5047460a-265d-4538-b23e-ddba5fb84976} aComponent={MachineWrap} aText={The object functionality is limited}, preserve=false aResultDetail=0
01:03:14.922611 ERROR [COM]: aRC=E_ACCESSDENIED (0x80070005) aIID={5047460a-265d-4538-b23e-ddba5fb84976} aComponent={MachineWrap} aText={The object functionality is limited}, preserve=false aResultDetail=0
01:03:14.922620 ERROR [COM]: aRC=E_ACCESSDENIED (0x80070005) aIID={5047460a-265d-4538-b23e-ddba5fb84976} aComponent={MachineWrap} aText={The object functionality is limited}, preserve=false aResultDetail=0
01:03:14.922628 ERROR [COM]: aRC=E_ACCESSDENIED (0x80070005) aIID={5047460a-265d-4538-b23e-ddba5fb84976} aComponent={MachineWrap} aText={The object functionality is limited}, preserve=false aResultDetail=0
01:03:14.922636 ERROR [COM]: aRC=E_ACCESSDENIED (0x80070005) aIID={5047460a-265d-4538-b23e-ddba5fb84976} aComponent={MachineWrap} aText={The object functionality is limited}, preserve=false aResultDetail=0
01:03:14.922644 ERROR [COM]: aRC=E_ACCESSDENIED (0x80070005) aIID={5047460a-265d-4538-b23e-ddba5fb84976} aComponent={MachineWrap} aText={The object functionality is limited}, preserve=false aResultDetail=0
01:03:14.923407 Saving settings file "C:\Users\mrbro\.VirtualBox\VirtualBox.xml" with version "1.12-windows"
01:03:19.965498 main VirtualBox: object deletion starts
01:03:19.966532 main ERROR [COM]: aRC=VBOX_E_OBJECT_IN_USE (0x80bb000c) aIID={ad47ad09-787b-44ab-b343-a082a3f2dfb1} aComponent={MediumWrap} aText={Medium 'C:\ProgramData\BOINC\slots\9\vm_image.vdi' cannot be closed because it is still attached to 1 virtual machines}, preserve=false aResultDetail=0
01:03:19.974472 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
01:03:19.974767 main VirtualBox: object deleted
VM Execution Log:
VM Startup Log:
VM Trace Log:
resume
Exit Code: 0
Output:
2022-06-13 20:37:01 (10008):
Command: VBoxManage -q controlvm "boinc_9c3af08294f2b9cd" savestate
Exit Code: -182
Output:
0%...10%...20%...30%...40%...50%...60%...70%...80%...90%...
2022-06-14 00:10:51 (14680):
Command: VBoxManage -q --version
Exit Code: 0
Output:
6.0.14r133895
2022-06-14 00:10:51 (14680):
Command: VBoxManage -q list systemproperties
Exit Code: 0
Output:
API version: 6_0
Minimum guest RAM size: 4 Megabytes
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-06-14 00:10:51 (14680):
Command: VBoxManage -q list hostinfo
Exit Code: 0
Output:
Host Information:
Host time: 2022-06-13T22:10:51.620000000Z
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: 1555 MByte
Operating system: Windows 10
Operating system version: 10.0.22000
2022-06-14 00:10:52 (14680):
Command: VBoxManage -q showvminfo "boinc_9c3af08294f2b9cd" --machinereadable
Exit Code: 0
Output:
name="boinc_9c3af08294f2b9cd"
groups="/"
ostype="Linux 2.6 / 3.x / 4.x (64-bit)"
UUID="c41f43fb-39a2-4b74-96b0-eee9759cfc23"
CfgFile="C:\\ProgramData\\BOINC\\slots\\2\\boinc_9c3af08294f2b9cd\\boinc_9c3af08294f2b9cd.vbox"
SnapFldr="C:\\ProgramData\\BOINC\\slots\\2\\boinc_9c3af08294f2b9cd\\Snapshots"
LogFldr="C:\\ProgramData\\BOINC\\slots\\2\\boinc_9c3af08294f2b9cd\\Logs"
hardwareuuid="c41f43fb-39a2-4b74-96b0-eee9759cfc23"
memory=6376
pagefusion="off"
vram=8
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="aborted"
VMStateChangeTime="2022-06-13T18:37:01.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="PIIX4"
storagecontrollerinstance0="0"
storagecontrollermaxportcount0="2"
storagecontrollerportcount0="2"
storagecontrollerbootable0="on"
"Hard Disk Controller-0-0"="C:\ProgramData\BOINC\slots\2\vm_image.vdi"
"Hard Disk Controller-ImageUUID-0-0"="f5e494f4-f5fc-4857-86a6-370a1cd1c3a9"
"Hard Disk Controller-0-1"="none"
"Hard Disk Controller-1-0"="C:\Program Files\Oracle\VirtualBox\VBoxGuestAdditions.iso"
"Hard Disk Controller-ImageUUID-1-0"="d623c567-f709-4acd-a1e5-b523bf490902"
"Hard Disk Controller-tempeject"="off"
"Hard Disk Controller-IsEjected"="off"
"Hard Disk Controller-1-1"="none"
natnet1="nat"
macaddress1="080027044A99"
cableconnected1="on"
nic1="nat"
nictype1="82540EM"
nicspeed1="0"
mtu="0"
sockSnd="64"
sockRcv="64"
tcpWndSnd="64"
tcpWndRcv="64"
Forwarding(0)="tcp_62064_80,tcp,127.0.0.1,62064,,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_9c3af08294f2b9cd_net,Network,1099511627776
SharedFolderNameMachineMapping1="shared"
SharedFolderPathMachineMapping1="C:\\ProgramData\\BOINC\\slots\\2/shared"
videocap="off"
videocapaudio="off"
capturescreens="0"
capturefilename="C:\\ProgramData\\BOINC\\slots\\2\\boinc_9c3af08294f2b9cd\\boinc_9c3af08294f2b9cd.webm"
captureres="1024x768"
capturevideorate=512
capturevideofps=25
captureopts=""
description="CMS_3246353_1654774605.732552_0"
GuestMemoryBalloon=0
2022-06-14 00:10:55 (14680):
Command: VBoxManage -q startvm "boinc_9c3af08294f2b9cd" --type headless
Exit Code: 0
Output:
Waiting for VM "boinc_9c3af08294f2b9cd" to power on...
VM "boinc_9c3af08294f2b9cd" has been successfully started.
2022-06-14 00:10:56 (14680):
Command: VBoxManage -q controlvm "boinc_9c3af08294f2b9cd" cpuexecutioncap 100
Exit Code: 0
Output:
2022-06-14 00:13:26 (14680):
Command: VBoxManage -q controlvm "boinc_9c3af08294f2b9cd" poweroff
Exit Code: 0
Output:
0%...10%...20%...30%...40%...50%...60%...70%...80%...90%...100%
2022-06-14 00:13:27 (14680):
Command: VBoxManage -q snapshot "boinc_9c3af08294f2b9cd" list
Exit Code: -108
Output:
This machine does not have any snapshots
2022-06-14 00:13:27 (14680):
Command: VBoxManage -q bandwidthctl "boinc_9c3af08294f2b9cd" remove "boinc_9c3af08294f2b9cd_net"
Exit Code: 0
Output:
2022-06-14 00:13:27 (14680):
Command: VBoxManage -q unregistervm "boinc_9c3af08294f2b9cd" --delete
Exit Code: 0
Output:
0%...10%...20%...30%...40%...50%...60%...70%...80%...90%...100%
00:13:32 (14680): called boinc_finish(194)
</stderr_txt>
]]>
©2024 CERN