Stderr output

<core_client_version>7.16.5</core_client_version>
<![CDATA[
<message>
(unknown error) - exit code 194 (0xc2)</message>
<stderr_txt>
2020-05-09 14:14:51 (8176): vboxwrapper (7.7.26197): starting
2020-05-09 14:14:52 (8176): Feature: Checkpoint interval offset (169 seconds)
2020-05-09 14:14:52 (8176): Detected: VirtualBox VboxManage Interface (Version: 6.1.6)
2020-05-09 14:14:52 (8176): Detected: Minimum checkpoint interval (600.000000 seconds)
2020-05-09 14:14:52 (8176): Detected: Heartbeat check (file: 'heartbeat' every 1200.000000 seconds)
2020-05-09 14:14:52 (8176): Successfully copied 'init_data.xml' to the shared directory.
2020-05-09 14:14:52 (8176): Successfully copied 'input' to the shared directory.
2020-05-09 14:14:53 (8176): Create VM. (boinc_2b7b3588392bbdac, slot#2)
2020-05-09 14:14:54 (8176): Setting Memory Size for VM. (730MB)
2020-05-09 14:14:54 (8176): Setting CPU Count for VM. (1)
2020-05-09 14:14:55 (8176): Setting Chipset Options for VM.
2020-05-09 14:14:55 (8176): Setting Boot Options for VM.
2020-05-09 14:14:55 (8176): Setting Network Configuration for NAT.
2020-05-09 14:14:56 (8176): Enabling VM Network Access.
2020-05-09 14:14:56 (8176): Disabling USB Support for VM.
2020-05-09 14:14:56 (8176): Disabling COM Port Support for VM.
2020-05-09 14:14:56 (8176): Disabling LPT Port Support for VM.
2020-05-09 14:14:57 (8176): Disabling Audio Support for VM.
2020-05-09 14:14:57 (8176): Disabling Clipboard Support for VM.
2020-05-09 14:14:57 (8176): Disabling Drag and Drop Support for VM.
2020-05-09 14:14:58 (8176): Adding storage controller(s) to VM.
2020-05-09 14:14:58 (8176): Adding virtual disk drive to VM. (vm_image.vdi)
2020-05-09 14:14:58 (8176): Adding VirtualBox Guest Additions to VM.
2020-05-09 14:14:59 (8176): Adding network bandwidth throttle group to VM. (Defaulting to 1024GB)
2020-05-09 14:14:59 (8176): forwarding host port 5188 to guest port 80
2020-05-09 14:14:59 (8176): Enabling remote desktop for VM.
2020-05-09 14:15:00 (8176): Enabling shared directory for VM.
2020-05-09 14:15:01 (8176): Starting VM. (boinc_2b7b3588392bbdac, slot#2)
2020-05-09 14:15:14 (8176): Successfully started VM. (PID = '8524')
2020-05-09 14:15:14 (8176): Reporting VM Process ID to BOINC.
2020-05-09 14:15:24 (8176): Guest Log: BIOS: VirtualBox 6.1.6
2020-05-09 14:15:24 (8176): Guest Log: CPUID EDX: 0x178bfbff
2020-05-09 14:15:24 (8176): Guest Log: BIOS: ata0-0: PCHS=16383/16/63 LCHS=1024/255/63
2020-05-09 14:15:24 (8176): Guest Log: BIOS: Boot : bseqnr=1, bootseq=0032
2020-05-09 14:15:24 (8176): Guest Log: BIOS: Booting from Hard Disk...
2020-05-09 14:15:24 (8176): Guest Log: BIOS: KBD: unsupported int 16h function 03
2020-05-09 14:15:24 (8176): Guest Log: BIOS: AX=0305 BX=0000 CX=0000 DX=0000 
2020-05-09 14:15:25 (8176): VM state change detected. (old = 'poweroff', new = 'running')
2020-05-09 14:15:35 (8176): Detected: Web Application Enabled (http://localhost:5188)
2020-05-09 14:15:35 (8176): Detected: Remote Desktop Enabled (localhost:5189)
2020-05-09 14:15:45 (8176): Guest Log: vgdrvHeartbeatInit: Setting up heartbeat to trigger every 2000 milliseconds
2020-05-09 14:15:45 (8176): Guest Log: vboxguest: misc device minor 56, IRQ 20, I/O port d020, MMIO at 00000000f0400000 (size 0x400000)
2020-05-09 14:15:45 (8176): Preference change detected
2020-05-09 14:15:45 (8176): Setting CPU throttle for VM. (100%)
2020-05-09 14:15:46 (8176): Setting checkpoint interval to 600 seconds. (Higher value of (Preference: 120 seconds) or (Vbox_job.xml: 600 seconds))
2020-05-09 14:15:56 (8176): Guest Log: VBoxService 5.2.6 r120293 (verbosity: 0) linux.amd64 (Jan 15 2018 14:51:00) release log
2020-05-09 14:15:56 (8176): Guest Log: 00:00:00.000248 main     Log opened 2020-05-09T12:15:49.982234000Z
2020-05-09 14:15:56 (8176): Guest Log: 00:00:00.000402 main     OS Product: Linux
2020-05-09 14:15:56 (8176): Guest Log: 00:00:00.000503 main     OS Release: 4.14.76-13.cernvm.x86_64
2020-05-09 14:15:56 (8176): Guest Log: 00:00:00.000602 main     OS Version: #1 SMP Tue Oct 16 18:26:15 CEST 2018
2020-05-09 14:15:56 (8176): Guest Log: 00:00:00.002645 main     Executable: /usr/sbin/VBoxService
2020-05-09 14:15:56 (8176): Guest Log: 00:00:00.002648 main     Process ID: 3208
2020-05-09 14:15:56 (8176): Guest Log: 00:00:00.002650 main     Package type: LINUX_64BITS_GENERIC
2020-05-09 14:15:56 (8176): Guest Log: 00:00:00.006175 main     5.2.6 r120293 started. Verbose level = 0
2020-05-09 14:16:38 (8176): Guest Log: 14:16:34 CEST +02:00 2020-05-09: cranky: [INFO] Detected Theory App
2020-05-09 14:16:38 (8176): Guest Log: 14:16:34 CEST +02:00 2020-05-09: cranky: [INFO] Checking CVMFS.
2020-05-09 14:16:38 (8176): Guest Log: Probing /cvmfs/sft.cern.ch... OK
2020-05-09 14:16:49 (8176): 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
2020-05-09 14:16:49 (8176): Guest Log: 2.5.2.0 4097 0 28400 17838 3 1 263438 4096000 0 65024 0 0 n/a 5 14 http://s1ral-cvmfs.openhtc.io/cvmfs/sft.cern.ch DIRECT 1
2020-05-09 14:16:49 (8176): Guest Log: Probing /cvmfs/grid.cern.ch... OK
2020-05-09 14:16:49 (8176): 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
2020-05-09 14:16:49 (8176): Guest Log: 2.5.2.0 4125 0 27528 12185 3 2 263438 4096000 0 65024 0 2 -100 6410 988 http://s1ral-cvmfs.openhtc.io/cvmfs/grid.cern.ch DIRECT 1
2020-05-09 14:16:49 (8176): Guest Log: Probing /cvmfs/cernvm-prod.cern.ch... OK
2020-05-09 14:16:49 (8176): 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
2020-05-09 14:16:49 (8176): Guest Log: 2.5.2.0 4055 0 25196 249 3 1 263438 4096000 0 65024 0 0 n/a 4 11 http://s1cern-cvmfs.openhtc.io/cvmfs/cernvm-prod.cern.ch DIRECT 1
2020-05-09 14:16:59 (8176): Guest Log: Probing /cvmfs/alice.cern.ch... OK
2020-05-09 14:16:59 (8176): 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
2020-05-09 14:16:59 (8176): Guest Log: 2.5.2.0 4082 0 30636 6570 3 1 263438 4096000 0 65024 0 0 n/a 4054 2931 http://s1cern-cvmfs.openhtc.io/cvmfs/alice.cern.ch DIRECT 1
2020-05-09 14:16:59 (8176): Guest Log: 14:16:51 CEST +02:00 2020-05-09: cranky: [INFO] Checking runc.
2020-05-09 14:16:59 (8176): Guest Log: 14:16:51 CEST +02:00 2020-05-09: cranky: [INFO] Creating the filesystem.
2020-05-09 14:16:59 (8176): Guest Log: 14:16:51 CEST +02:00 2020-05-09: cranky: [INFO] Using /cvmfs/cernvm-prod.cern.ch/cvm3
2020-05-09 14:16:59 (8176): Guest Log: 14:16:52 CEST +02:00 2020-05-09: cranky: [INFO] Updating config.json.
2020-05-09 14:16:59 (8176): Guest Log: 14:16:52 CEST +02:00 2020-05-09: cranky: [INFO] Running Container 'runc'.
2020-05-09 14:16:59 (8176): Guest Log: job: htmld=/shared/html/job
2020-05-09 14:16:59 (8176): Guest Log: job: unpack exitcode=0
2020-05-09 14:16:59 (8176): Guest Log: 14:16:54 CEST +02:00 2020-05-09: cranky: [INFO] ===> [runRivet] Sat May  9 12:16:52 UTC 2020 [boinc pp zinclusive 7000 -,-,50,130 - herwig7 7.1.5 softTune 100000 2]
2020-05-09 15:03:53 (8176): Preference change detected
2020-05-09 15:03:53 (8176): Setting CPU throttle for VM. (100%)
2020-05-09 15:03:53 (8176): Setting checkpoint interval to 600 seconds. (Higher value of (Preference: 120 seconds) or (Vbox_job.xml: 600 seconds))
2020-05-09 15:13:12 (8176): VM state change detected. (old = 'running', new = 'paused')
2020-05-09 15:32:07 (8176): Stopping VM.
2020-05-09 15:32:14 (8176): Successfully stopped VM.
2020-05-09 15:44:41 (5672): vboxwrapper (7.7.26197): starting
2020-05-09 15:44:41 (5672): Feature: Checkpoint interval offset (236 seconds)
2020-05-09 15:44:41 (5672): Detected: VirtualBox VboxManage Interface (Version: 6.1.6)
2020-05-09 15:44:42 (5672): Detected: Minimum checkpoint interval (600.000000 seconds)
2020-05-09 15:44:42 (5672): Detected: Heartbeat check (file: 'heartbeat' every 1200.000000 seconds)
2020-05-09 15:44:42 (5672): Starting VM. (boinc_2b7b3588392bbdac, slot#2)
2020-05-09 15:45:04 (5672): Successfully started VM. (PID = '8184')
2020-05-09 15:45:04 (5672): Reporting VM Process ID to BOINC.
2020-05-09 15:45:14 (5672): Guest Log: 00:57:31.180440 timesync vgsvcTimeSyncWorker: Radical host time change: 1 916 001 000 000ns (HostNow=1 589 031 907 118 000 000 ns HostLast=1 589 029 991 117 000 000 ns)
2020-05-09 15:45:15 (5672): VM state change detected. (old = 'poweroff', new = 'running')
2020-05-09 15:45:25 (5672): Guest Log: 00:57:41.183447 timesync vgsvcTimeSyncWorker: Radical guest time change: 1 916 008 982 000ns (GuestNow=1 589 031 917 127 337 000 ns GuestLast=1 589 030 001 118 355 000 ns fSetTimeLastLoop=true )
2020-05-09 15:45:25 (5672): Detected: Web Application Enabled (http://localhost:5188)
2020-05-09 15:45:25 (5672): Detected: Remote Desktop Enabled (localhost:5189)
2020-05-09 15:45:35 (5672): Preference change detected
2020-05-09 15:45:35 (5672): Setting CPU throttle for VM. (100%)
2020-05-09 15:45:36 (5672): Setting checkpoint interval to 600 seconds. (Higher value of (Preference: 120 seconds) or (Vbox_job.xml: 600 seconds))
2020-05-09 16:28:11 (5672): Status Report: Job Duration: '360000.000000'
2020-05-09 16:28:11 (5672): Status Report: Elapsed Time: '6002.015480'
2020-05-09 16:28:11 (5672): Status Report: CPU Time: '5623.968750'
2020-05-09 18:08:14 (5672): Status Report: Job Duration: '360000.000000'
2020-05-09 18:08:14 (5672): Status Report: Elapsed Time: '12004.714718'
2020-05-09 18:08:14 (5672): Status Report: CPU Time: '11579.109375'
2020-05-09 18:49:37 (5672): VM is no longer is a running state. It is in 'poweroff'.
2020-05-09 18:49:37 (5672): VM state change detected. (old = 'running', new = 'poweroff')
2020-05-09 18:49:47 (5672): Powering off VM.
2020-05-09 18:49:47 (5672): Deregistering VM. (boinc_2b7b3588392bbdac, slot#2)
2020-05-09 18:49:47 (5672): Removing network bandwidth throttle group from VM.
2020-05-09 18:49:48 (5672): Removing storage controller(s) from VM.
2020-05-09 18:49:48 (5672): Removing VM from VirtualBox.
2020-05-09 18:49:48 (5672): Removing virtual disk drive from VirtualBox.
2020-05-09 18:49:53 (5672): VM Premature Shutdown Detected.

    Hypervisor System Log:

00:00:00.415848          VirtualBox: object created
00:00:00.429568          ERROR [COM]: aRC=VBOX_E_VM_ERROR (0x80bb0003) aIID={85632c68-b5bb-4316-a900-5eb28d3413df} aComponent={MachineWrap} aText={Failed to assign the machine to the session (E_FAIL)}, preserve=false aResultDetail=0
00:00:01.840351          ERROR [COM]: aRC=VBOX_E_VM_ERROR (0x80bb0003) aIID={85632c68-b5bb-4316-a900-5eb28d3413df} aComponent={MachineWrap} aText={Failed to assign the machine to the session (E_FAIL)}, preserve=false aResultDetail=0
00:00:01.896081          ERROR [COM]: aRC=VBOX_E_VM_ERROR (0x80bb0003) aIID={85632c68-b5bb-4316-a900-5eb28d3413df} aComponent={MachineWrap} aText={Failed to assign the machine to the session (E_FAIL)}, preserve=false aResultDetail=0
00:00:02.167935          ERROR [COM]: aRC=VBOX_E_VM_ERROR (0x80bb0003) aIID={85632c68-b5bb-4316-a900-5eb28d3413df} aComponent={MachineWrap} aText={Failed to assign the machine to the session (E_FAIL)}, preserve=false aResultDetail=0
00:00:02.424582          Saving settings file "C:\Users\lvanderveen\.VirtualBox\VirtualBox.xml" with version "1.12-windows"
00:00:02.491455 createDelete ERROR [COM]: aRC=VBOX_E_FILE_ERROR (0x80bb0004) aIID={ad47ad09-787b-44ab-b343-a082a3f2dfb1} aComponent={MediumWrap} aText={Could not delete the medium storage unit 'D:\Boinc1\slots\2\vm_image.vdi' (VERR_SHARING_VIOLATION)}, preserve=false aResultDetail=-114
00:00:02.507129          ERROR [COM]: aRC=VBOX_E_OBJECT_NOT_FOUND (0x80bb0001) aIID={d0a0163f-e254-4e5b-a1f2-011cf991c38d} aComponent={VirtualBoxWrap} aText={Could not find a registered machine named 'boinc_60847b390f582503'}, preserve=false aResultDetail=0
00:00:02.696243          Saving settings file "C:\Users\lvanderveen\.VirtualBox\VirtualBox.xml" with version "1.12-windows"
00:00:02.696381 createDelete ERROR [COM]: aRC=VBOX_E_FILE_ERROR (0x80bb0004) aIID={ad47ad09-787b-44ab-b343-a082a3f2dfb1} aComponent={MediumWrap} aText={Could not delete the medium storage unit 'D:\Boinc1\slots\2\vm_image.vdi' (VERR_SHARING_VIOLATION)}, preserve=false aResultDetail=-114
00:00:04.082972          Saving settings file "C:\Users\lvanderveen\.VirtualBox\VirtualBox.xml" with version "1.12-windows"
00:00:04.364093          Saving settings file "D:\Boinc1\slots\1\boinc_60847b390f582503\boinc_60847b390f582503.vbox" with version "1.16-windows"
00:00:04.609073          Saving settings file "C:\Users\lvanderveen\.VirtualBox\VirtualBox.xml" with version "1.12-windows"
00:00:04.904364          Saving settings file "D:\Boinc1\slots\1\boinc_60847b390f582503\boinc_60847b390f582503.vbox" with version "1.16-windows"
00:00:05.170116          Saving settings file "D:\Boinc1\slots\1\boinc_60847b390f582503\boinc_60847b390f582503.vbox" with version "1.16-windows"
00:00:05.451100          Saving settings file "D:\Boinc1\slots\1\boinc_60847b390f582503\boinc_60847b390f582503.vbox" with version "1.16-windows"
00:00:05.984114          Saving settings file "D:\Boinc1\slots\1\boinc_60847b390f582503\boinc_60847b390f582503.vbox" with version "1.16-windows"
00:00:06.294361          Saving settings file "D:\Boinc1\slots\1\boinc_60847b390f582503\boinc_60847b390f582503.vbox" with version "1.16-windows"
00:00:06.562711          Saving settings file "D:\Boinc1\slots\1\boinc_60847b390f582503\boinc_60847b390f582503.vbox" with version "1.16-windows"
00:00:06.828755          Saving settings file "D:\Boinc1\slots\1\boinc_60847b390f582503\boinc_60847b390f582503.vbox" with version "1.16-windows"
00:00:07.093736          Saving settings file "D:\Boinc1\slots\1\boinc_60847b390f582503\boinc_60847b390f582503.vbox" with version "1.16-windows"
00:00:07.359534          Saving settings file "D:\Boinc1\slots\1\boinc_60847b390f582503\boinc_60847b390f582503.vbox" with version "1.16-windows"
00:00:07.624548          Saving settings file "D:\Boinc1\slots\1\boinc_60847b390f582503\boinc_60847b390f582503.vbox" with version "1.16-windows"
00:00:07.890479          Saving settings file "D:\Boinc1\slots\1\boinc_60847b390f582503\boinc_60847b390f582503.vbox" with version "1.16-windows"
00:00:08.156779          Saving settings file "D:\Boinc1\slots\1\boinc_60847b390f582503\boinc_60847b390f582503.vbox" with version "1.16-windows"
00:00:08.421279          Saving settings file "D:\Boinc1\slots\1\boinc_60847b390f582503\boinc_60847b390f582503.vbox" with version "1.16-windows"
00:00:08.711257          Saving settings file "D:\Boinc1\slots\1\boinc_60847b390f582503\boinc_60847b390f582503.vbox" with version "1.16-windows"
00:00:08.983934          ERROR [COM]: aRC=VBOX_E_OBJECT_NOT_FOUND (0x80bb0001) aIID={85632c68-b5bb-4316-a900-5eb28d3413df} aComponent={SessionMachine} aText={No storage device attached to device slot 0 on port 0 of controller 'Hard Disk Controller'}, preserve=false aResultDetail=0
00:00:08.992067          ERROR [COM]: aRC=VBOX_E_OBJECT_NOT_FOUND (0x80bb0001) aIID={85632c68-b5bb-4316-a900-5eb28d3413df} aComponent={SessionMachine} aText={No storage device attached to device slot 0 on port 0 of controller 'Hard Disk Controller'}, preserve=false aResultDetail=0
00:00:08.992251          Saving settings file "C:\Users\lvanderveen\.VirtualBox\VirtualBox.xml" with version "1.12-windows"
00:00:09.025280          Saving settings file "D:\Boinc1\slots\1\boinc_60847b390f582503\boinc_60847b390f582503.vbox" with version "1.16-windows"
00:00:09.249356          ERROR [COM]: aRC=VBOX_E_OBJECT_NOT_FOUND (0x80bb0001) aIID={85632c68-b5bb-4316-a900-5eb28d3413df} aComponent={SessionMachine} aText={No storage device attached to device slot 0 on port 1 of controller 'Hard Disk Controller'}, preserve=false aResultDetail=0
00:00:09.249757          ERROR [COM]: aRC=VBOX_E_OBJECT_NOT_FOUND (0x80bb0001) aIID={85632c68-b5bb-4316-a900-5eb28d3413df} aComponent={SessionMachine} aText={No storage device attached to device slot 0 on port 1 of controller 'Hard Disk Controller'}, preserve=false aResultDetail=0
00:00:09.250212          Saving settings file "D:\Boinc1\slots\1\boinc_60847b390f582503\boinc_60847b390f582503.vbox" with version "1.16-windows"
00:00:09.520021          Saving settings file "D:\Boinc1\slots\1\boinc_60847b390f582503\boinc_60847b390f582503.vbox" with version "1.16-windows"
00:00:09.784348          Saving settings file "D:\Boinc1\slots\1\boinc_60847b390f582503\boinc_60847b390f582503.vbox" with version "1.16-windows"
00:00:10.312903          Saving settings file "D:\Boinc1\slots\1\boinc_60847b390f582503\boinc_60847b390f582503.vbox" with version "1.16-windows"
00:00:10.576202          Saving settings file "D:\Boinc1\slots\1\boinc_60847b390f582503\boinc_60847b390f582503.vbox" with version "1.16-windows"
00:00:10.846712          ERROR [COM]: aRC=VBOX_E_OBJECT_NOT_FOUND (0x80bb0001) aIID={85632c68-b5bb-4316-a900-5eb28d3413df} aComponent={SessionMachine} aText={No storage device attached to device slot 1 on port 0 of controller 'Hard Disk Controller'}, preserve=false aResultDetail=0
00:00:10.846820          ERROR [COM]: aRC=VBOX_E_OBJECT_NOT_FOUND (0x80bb0001) aIID={85632c68-b5bb-4316-a900-5eb28d3413df} aComponent={SessionMachine} aText={No storage device attached to device slot 1 on port 0 of controller 'Hard Disk Controller'}, preserve=false aResultDetail=0
00:00:10.847296          ERROR [COM]: aRC=VBOX_E_OBJECT_NOT_FOUND (0x80bb0001) aIID={85632c68-b5bb-4316-a900-5eb28d3413df} aComponent={SessionMachine} aText={No storage device attached to device slot 1 on port 1 of controller 'Hard Disk Controller'}, preserve=false aResultDetail=0
00:00:10.847384          ERROR [COM]: aRC=VBOX_E_OBJECT_NOT_FOUND (0x80bb0001) aIID={85632c68-b5bb-4316-a900-5eb28d3413df} aComponent={SessionMachine} aText={No storage device attached to device slot 1 on port 1 of controller 'Hard Disk Controller'}, preserve=false aResultDetail=0
00:00:10.866507          ERROR [COM]: aRC=E_FAIL (0x80004005) aIID={85632c68-b5bb-4316-a900-5eb28d3413df} aComponent={SessionMachine} aText={This machine does not have any snapshots}, preserve=false aResultDetail=0
00:00:11.101045          Launched VM: 75481024 pid: 2820 (0xb04) frontend: headless name: boinc_60847b390f582503

    VM Execution Log:


00:00:04.083719   ExitLoadEferMsr - Load IA32_EFER MSR on VM-exit         = 0 (1)
00:00:04.083723   SavePreemptTimer - Save VMX-preemption timer            = 0 (1)
00:00:04.083726   ExitSaveEferLma - Save IA32_EFER.LMA on VM-exit         = 0 (1)
00:00:04.083729   IntelPt - Intel PT (Processor Trace) in VMX operation   = 0 (0)
00:00:04.083732   VmwriteAll - VMWRITE to any supported VMCS field        = 0 (0)
00:00:04.083735   EntryInjectSoftInt - Inject softint. with 0-len instr.  = 0 (0)
00:00:04.083739 
00:00:04.083741 ******************* End of VT-x features ********************
00:00:04.083768 VMEmt: Halt method global1 (5)
00:00:04.083880 VMEmt: HaltedGlobal1 config: cNsSpinBlockThresholdCfg=50000
00:00:04.083897 Changing the VM state from 'CREATING' to 'CREATED'
00:00:04.085954 SharedFolders host service: Adding host mapping
00:00:04.085973     Host path 'D:\Boinc1\slots\2/shared', map name 'shared', writable, automount=false, automntpnt=, create_symlinks=false, missing=false
00:00:04.087609 Changing the VM state from 'CREATED' to 'LOADING'
00:00:04.088384 SSM: File header: Format 2.0, VirtualBox Version 6.1.6 r137129, 64-bit host, cbGCPhys=8, cbGCPtr=8
00:00:04.089694 SSM: Saved state info:
00:00:04.089719 SSM:   Build Type: release
00:00:04.089733 SSM:   Host OS: win.amd64
00:00:04.089975 PCI:    PIIX3/0: register 60: 80 -> 8b
00:00:04.089994 PCI:    PIIX3/0: register 61: 00 -> 8a
00:00:04.090010 PCI:    PIIX3/0: register 62: 00 -> 89
00:00:04.090024 PCI:    PIIX3/0: register 63: 00 -> 8b
00:00:04.090039 PCI:    PIIX3/0: register ad: 00 -> ef
00:00:04.090054 PCI:    PIIX3/0: register de: 00 -> be
00:00:04.090112 PCI: piix3ide/0:  8-bit field LATENCY_TIMER: 0 -> 40
00:00:04.090129 PCI: piix3ide/0: 32-bit field BASE_ADDRESS_4: 1 -> d001
00:00:04.090149 PCI: piix3ide/0: register 40: 00 -> 07
00:00:04.090163 PCI: piix3ide/0: register 41: 80 -> e3
00:00:04.090177 PCI: piix3ide/0: register 42: 00 -> 03
00:00:04.090191 PCI: piix3ide/0: register 43: 80 -> e3
00:00:04.090211 PCI: piix3ide/0: register 48: 00 -> 05
00:00:04.090228 PCI: piix3ide/0: register 4a: 00 -> 02
00:00:04.090242 PCI: piix3ide/0: register 4b: 00 -> 02
00:00:04.090268 PCI:      vga/0: 32-bit field BASE_ADDRESS_0: 8 -> e0000008
00:00:04.090285 PCI:      vga/0:  8-bit field INTERRUPT_LINE: 0 -> a
00:00:04.090300 PCI:      vga/0: 16-bit field COMMAND: 0 -> 3
00:00:04.090900 PCI:    e1000/0:  8-bit field LATENCY_TIMER: 0 -> 40
00:00:04.090919 PCI:    e1000/0: 32-bit field BASE_ADDRESS_0: 0 -> f0000000
00:00:04.090936 PCI:    e1000/0: 32-bit field BASE_ADDRESS_2: 1 -> d011
00:00:04.090953 PCI:    e1000/0:  8-bit field INTERRUPT_LINE: 0 -> 9
00:00:04.090968 PCI:    e1000/0: 16-bit field COMMAND: 0 -> 7
00:00:04.091048 PCI:   VMMDev/0: 32-bit field BASE_ADDRESS_0: 1 -> d021
00:00:04.091066 PCI:   VMMDev/0: 32-bit field BASE_ADDRESS_1: 0 -> f0400000
00:00:04.091083 PCI:   VMMDev/0: 32-bit field BASE_ADDRESS_2: 8 -> f0800008
00:00:04.091099 PCI:   VMMDev/0:  8-bit field INTERRUPT_LINE: 0 -> b
00:00:04.091114 PCI:   VMMDev/0: 16-bit field COMMAND: 0 -> 3
00:00:11.989644 TM: cTSCTicksPerSecond=0xd0bc6578 (3 502 007 672) enmTSCMode=3 (Dynamic) (state load)
00:00:11.989693 GIM: KVM: VCPU  0: Enabled system-time struct. at 0x000000002d9ef000 - u32TscScale=0x9233ac6f i8TscShift=-1 uVersion=2 fFlags=0x1 uTsc=0x735025565 uVirtNanoTS=0x20fb55789
00:00:11.989711 TM: Switching TSC mode from 'Dynamic' to 'RealTscOffset'
00:00:11.989839 PIT: mode=0 count=0x10000 (65536) - 18.20 Hz (ch=0) (restore)
00:00:11.989862 RTC: Stopped the periodic timer (restore)
00:00:11.989904 HGCM: Restoring [VBoxGuestPropSvc]
00:00:11.989984 HGCM: Restoring [VBoxGuestControlSvc]
00:00:11.990050 HGCM: Restoring [VBoxSharedFolders]
00:00:11.990171 HGCM: Restoring [VBoxDragAndDropSvc]
00:00:11.990186 HGCM: Restoring [VBoxSharedClipboard]
00:00:11.990392 VMMDev: Guest Additions information report: Interface = 0x00010004 osType = 0x00053100 (Linux >= 2.6, 64-bit)
00:00:11.991161 E1000#0: Interrupt attempts: 0
00:00:11.991176 E1000#0: Interrupts raised : 0
00:00:11.991186 E1000#0: Interrupts lowered: 0
00:00:11.991196 E1000#0: ICR outside ISR   : 0
00:00:11.991211 E1000#0: IMS raised ints   : 0
00:00:11.991222 E1000#0: Interrupts skipped: 0
00:00:11.991229 E1000#0: Masked interrupts : 0
00:00:11.991237 E1000#0: Early interrupts  : 0
00:00:11.991245 E1000#0: Late interrupts   : 0
00:00:11.991253 E1000#0: Lost interrupts   : 0
00:00:11.991262 E1000#0: Interrupts by RX  : 0
00:00:11.991270 E1000#0: Interrupts by TX  : 0
00:00:11.991278 E1000#0: Interrupts by ICS : 0
00:00:11.991286 E1000#0: Interrupts by RDTR: 0
00:00:11.991293 E1000#0: Interrupts by RDMT: 0
00:00:11.991301 E1000#0: Interrupts by TXQE: 0
00:00:11.991309 E1000#0: TX int delay asked: 0
00:00:11.991317 E1000#0: TX delayed:         0
00:00:11.991324 E1000#0: TX delay expired:   0
00:00:11.991331 E1000#0: TX no report asked: 0
00:00:11.991338 E1000#0: TX abs timer expd : 0
00:00:11.991346 E1000#0: TX int timer expd : 0
00:00:11.991354 E1000#0: RX abs timer expd : 0
00:00:11.991362 E1000#0: RX int timer expd : 0
00:00:11.991370 E1000#0: TX CTX descriptors: 0
00:00:11.991377 E1000#0: TX DAT descriptors: 0
00:00:11.991384 E1000#0: TX LEG descriptors: 0
00:00:11.991392 E1000#0: Received frames   : 0
00:00:11.991400 E1000#0: Transmitted frames: 0
00:00:11.991408 E1000#0: TX frames up to 1514: 0
00:00:11.991416 E1000#0: TX frames up to 2962: 0
00:00:11.991423 E1000#0: TX frames up to 4410: 0
00:00:11.991431 E1000#0: TX frames up to 5858: 0
00:00:11.991439 E1000#0: TX frames up to 7306: 0
00:00:11.991446 E1000#0: TX frames up to 8754: 0
00:00:11.991454 E1000#0: TX frames up to 16384: 0
00:00:11.991462 E1000#0: TX frames up to 32768: 0
00:00:11.991470 E1000#0: Larger TX frames    : 0
00:00:11.991478 E1000#0: Max TX Delay        : 0
00:00:11.991775 Display::i_handleDisplayResize: uScreenId=0 pvVRAM=00000000085d0000 w=800 h=600 bpp=32 cbLine=0xC80 flags=0x1 origin=0,0
00:00:11.992156 Changing the VM state from 'LOADING' to 'SUSPENDED'
00:00:11.992270 Changing the VM state from 'SUSPENDED' to 'RESUMING'
00:00:11.993237 NAT: Link down
00:00:11.993263 Changing the VM state from 'RESUMING' to 'RUNNING'
00:00:11.993288 Console: Machine state changed to 'Running'
00:00:15.081959 NAT: Link up
00:00:15.091615 NAT: DNS#0: 192.168.2.254
00:00:16.193958 NAT: IPv6 not supported
00:00:21.170526 VMMDev: Guest Log: 00:57:31.180440 timesync vgsvcTimeSyncWorker: Radical host time change: 1 916 001 000 000ns (HostNow=1 589 031 907 118 000 000 ns HostLast=1 589 029 991 117 000 000 ns)
00:00:27.218321 VRDP: New connection: 
00:00:27.218517 VRDP: Connection opened (IPv6): 0
00:00:27.218795 VRDP: Negotiating security method with the client.
00:00:27.346571 VRDP: failed to access the server certificate file '': VERR_FILE_NOT_FOUND
00:00:27.346760 VRDP: Connection closed: 0
00:00:27.450333 VRDP: New connection: 
00:00:27.450419 VRDP: Connection opened (IPv6): 1
00:00:27.450657 VRDP: Negotiating security method with the client.
00:00:27.476416 VRDP: Methods 0x0000001b
00:00:27.476463 VRDP: Channel: [rdpdr] [1004]. Accepted.
00:00:27.476486 VRDP: Channel: [rdpsnd] [1005]. Accepted.
00:00:27.476511 VRDP: Channel: [cliprdr] [1006]. Accepted.
00:00:27.476533 VRDP: Channel: [drdynvc] [1007]. Accepted.
00:00:27.476554 VRDP: Unsupported SEC_TAG: 0xC006/8. Skipping.
00:00:27.476574 VRDP: Unsupported SEC_TAG: 0xC00A/8. Skipping.
00:00:27.511117 VRDP: Client seems to be MSFT.
00:00:27.511162 VRDP: Logon: AH1 (::1) build 18362. User: [] Domain: [] Screen: 0
00:00:27.511406 AUTH: User: []. Domain: []. Authentication type: [Null]
00:00:27.511423 AUTH: Access granted.
00:00:27.513265 VRDP: Enabling upstream audio.
00:00:27.513366 VBVA: VRDP acceleration has been requested.
00:00:27.521850 VRDP: SunFlsh disabled.
00:00:27.555900 VRDP: SCARD enabled for 2
00:00:31.172448 VMMDev: Guest Log: 00:57:41.183447 timesync vgsvcTimeSyncWorker: Radical guest time change: 1 916 008 982 000ns (GuestNow=1 589 031 917 127 337 000 ns GuestLast=1 589 030 001 118 355 000 ns fSetTimeLastLoop=true )

    VM Startup Log:


    VM Trace Log:

r 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 supports unrestricted guest: yes
Processor supports nested HW virtualization: no
Processor#0 speed: unknown
Processor#0 description: Intel(R) Core(TM) i7-2600 CPU @ 3.40GHz
Processor#1 speed: unknown
Processor#1 description: Intel(R) Core(TM) i7-2600 CPU @ 3.40GHz
Processor#2 speed: unknown
Processor#2 description: Intel(R) Core(TM) i7-2600 CPU @ 3.40GHz
Processor#3 speed: unknown
Processor#3 description: Intel(R) Core(TM) i7-2600 CPU @ 3.40GHz
Processor#4 speed: unknown
Processor#4 description: Intel(R) Core(TM) i7-2600 CPU @ 3.40GHz
Processor#5 speed: unknown
Processor#5 description: Intel(R) Core(TM) i7-2600 CPU @ 3.40GHz
Processor#6 speed: unknown
Processor#6 description: Intel(R) Core(TM) i7-2600 CPU @ 3.40GHz
Processor#7 speed: unknown
Processor#7 description: Intel(R) Core(TM) i7-2600 CPU @ 3.40GHz
Memory size: 16365 MByte
Memory available: 5856 MByte
Operating system: Windows 10
Operating system version: 10.0.18363

2020-05-09 15:44:42 (5672): 
Command: VBoxManage -q showvminfo "boinc_2b7b3588392bbdac" --machinereadable 
Exit Code: 0
Output:
name="boinc_2b7b3588392bbdac"
groups="/"
ostype="Linux 2.6 / 3.x / 4.x (64-bit)"
UUID="a0d5af18-074b-4686-905e-4a25332466e0"
CfgFile="D:\\Boinc1\\slots\\2\\boinc_2b7b3588392bbdac\\boinc_2b7b3588392bbdac.vbox"
SnapFldr="D:\\Boinc1\\slots\\2\\boinc_2b7b3588392bbdac\\Snapshots"
LogFldr="D:\\Boinc1\\slots\\2\\boinc_2b7b3588392bbdac\\Logs"
hardwareuuid="a0d5af18-074b-4686-905e-4a25332466e0"
memory=730
pagefusion="off"
vram=8
cpuexecutioncap=100
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
rtcuseutc="off"
hwvirtex="on"
nestedpaging="on"
largepages="on"
vtxvpid="on"
vtxux="on"
paravirtprovider="default"
effparavirtprovider="kvm"
VMState="saved"
VMStateChangeTime="2020-05-09T13:32:14.122000000"
VMStateFile="D:\Boinc1\slots\2\boinc_2b7b3588392bbdac\Snapshots\2020-05-09T13-32-07-985824500Z.sav"
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="PIIX4"
storagecontrollerinstance0="0"
storagecontrollermaxportcount0="2"
storagecontrollerportcount0="2"
storagecontrollerbootable0="on"
"Hard Disk Controller-0-0"="D:\Boinc1\slots\2\vm_image.vdi"
"Hard Disk Controller-ImageUUID-0-0"="d7717e92-ae94-489a-becc-922874cba4c6"
"Hard Disk Controller-0-1"="none"
"Hard Disk Controller-1-0"="C:\Program Files\Oracle\VirtualBox\VBoxGuestAdditions.iso"
"Hard Disk Controller-ImageUUID-1-0"="dc78377b-4116-45a3-863a-8280c95061f3"
"Hard Disk Controller-tempeject"="off"
"Hard Disk Controller-IsEjected"="off"
"Hard Disk Controller-1-1"="none"
natnet1="nat"
macaddress1="08002705D8F9"
cableconnected1="on"
nic1="nat"
nictype1="82540EM"
nicspeed1="0"
mtu="0"
sockSnd="64"
sockRcv="64"
tcpWndSnd="64"
tcpWndRcv="64"
Forwarding(0)="tcp_5188_80,tcp,127.0.0.1,5188,,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="5189"
vrdeaddress=""
vrdeauthtype="null"
vrdemulticon="off"
vrdereusecon="off"
vrdevideochannel="off"
vrdeproperty[TCP/Ports]="5189"
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_2b7b3588392bbdac_net,Network,1099511627776
SharedFolderNameMachineMapping1="shared"
SharedFolderPathMachineMapping1="D:\\Boinc1\\slots\\2/shared"
videocap="off"
videocapaudio="off"
capturescreens=""
capturefilename="D:\\Boinc1\\slots\\2\\boinc_2b7b3588392bbdac\\boinc_2b7b3588392bbdac.webm"
captureres="1024x768"
capturevideorate=512
capturevideofps=25
captureopts=""
description="Theory_2390-1153285-2_0"
GuestMemoryBalloon=0

2020-05-09 15:44:58 (5672): 
Command: VBoxManage -q startvm "boinc_2b7b3588392bbdac" --type headless
Exit Code: 0
Output:
Waiting for VM "boinc_2b7b3588392bbdac" to power on...
VM "boinc_2b7b3588392bbdac" has been successfully started.

2020-05-09 15:45:36 (5672): 
Command: VBoxManage -q controlvm "boinc_2b7b3588392bbdac" cpuexecutioncap 100 
Exit Code: 0
Output:

2020-05-09 18:49:47 (5672): 
Command: VBoxManage -q snapshot "boinc_2b7b3588392bbdac" list 
Exit Code: -2147467259
Output:
VBoxManage.exe: error: Code E_FAIL (0x80004005) - Unspecified error (extended info not available)
VBoxManage.exe: error: Context: "LockMachine(a->session, LockType_Shared)" at line 338 of file VBoxManageSnapshot.cpp

2020-05-09 18:49:48 (5672): 
Command: VBoxManage -q bandwidthctl "boinc_2b7b3588392bbdac" remove "boinc_2b7b3588392bbdac_net" 
Exit Code: -2147467259
Output:
VBoxManage.exe: error: Code E_FAIL (0x80004005) - Unspecified error (extended info not available)
VBoxManage.exe: error: Context: "LockMachine(a->session, LockType_Shared)" at line 323 of file VBoxManageBandwidthControl.cpp

2020-05-09 18:49:48 (5672): 
Command: VBoxManage -q storagectl "boinc_2b7b3588392bbdac" --name "Hard Disk Controller" --remove 
Exit Code: -2147467259
Output:
VBoxManage.exe: error: Code E_FAIL (0x80004005) - Unspecified error (extended info not available)
VBoxManage.exe: error: Context: "LockMachine(a->session, LockType_Write)" at line 1048 of file VBoxManageStorageController.cpp

2020-05-09 18:49:48 (5672): 
Command: VBoxManage -q unregistervm "boinc_2b7b3588392bbdac" --delete 
Exit Code: -2135228412
Output:
0%...10%...20%...
Progress state: VBOX_E_FILE_ERROR
VBoxManage.exe: error: Machine delete failed
VBoxManage.exe: error: Could not delete the medium storage unit 'D:\Boinc1\slots\2\vm_image.vdi' (VERR_SHARING_VIOLATION)
VBoxManage.exe: error: Details: code VBOX_E_FILE_ERROR (0x80bb0004), component MediumWrap, interface IMedium
VBoxManage.exe: error: Context: "enum RTEXITCODE __cdecl handleUnregisterVM(struct HandlerArg *)" at line 162 of file VBoxManageMisc.cpp

2020-05-09 18:49:48 (5672): 
Command: VBoxManage -q closemedium disk "D:\Boinc1\slots\2/vm_image.vdi" --delete 
Exit Code: 0
Output:
0%...
Progress state: VBOX_E_FILE_ERROR
VBoxManage.exe: error: Failed to delete medium
VBoxManage.exe: error: Could not delete the medium storage unit 'D:\Boinc1\slots\2\vm_image.vdi' (VERR_SHARING_VIOLATION)
VBoxManage.exe: error: Details: code VBOX_E_FILE_ERROR (0x80bb0004), component MediumWrap, interface IMedium
VBoxManage.exe: error: Context: "enum RTEXITCODE __cdecl handleCloseMedium(struct HandlerArg *)" at line 1731 of file VBoxManageDisk.cpp

18:49:59 (5672): called boinc_finish(194)

</stderr_txt>
]]>

©2024 CERN