Task 1126987

Name 07152228_199_0
Workunit 736185
Created 9 Apr 2019, 14:37:41 UTC
Sent 9 Apr 2019, 14:44:36 UTC
Report deadline 14 Apr 2019, 14:44:36 UTC
Received 10 Apr 2019, 15:47:30 UTC
Server state Over
Outcome Success
Client state Done
Exit status 0 (0x00000000)
Computer ID 1303
Run time 9 min 30 sec
CPU time 3 min 56 sec
Validate state Valid
Credit 1.32
Device peak FLOPS 2.78 GFLOPS
Application version boinc2docker v1.12 (vbox64_mt)
windows_x86_64
Peak working set size 43.55 MB
Peak swap size 99.07 MB
Peak disk usage 1.10 GB

Stderr output

<core_client_version>7.6.9</core_client_version>
<![CDATA[
<stderr_txt>
2019-04-09 21:23:54 (404): vboxwrapper (7.9.26200): starting
2019-04-09 21:23:54 (404): Status Report: Detected vboxsvc.exe. (PID = '10824')
2019-04-09 21:23:54 (404): Feature: Checkpoint interval offset (24 seconds)
2019-04-09 21:23:54 (404): Detected: VirtualBox COM Interface (Version: 5.2.8)
2019-04-09 21:23:54 (404): Detected: Sandbox Configuration Enabled
2019-04-09 21:23:54 (404): Detected: Minimum checkpoint interval (600.000000 seconds)
2019-04-09 21:23:54 (404): Create VM. (boinc_9986ff3a8a2e7c98, slot#13)
2019-04-09 21:23:54 (404): Updating drive controller type and model for desired configuration.
2019-04-09 21:23:55 (404): Setting Memory Size for VM. (3072MB)
2019-04-09 21:23:55 (404): Setting CPU Count for VM. (1)
2019-04-09 21:23:55 (404): Setting Chipset Options for VM.
2019-04-09 21:23:55 (404): Setting Boot Options for VM.
2019-04-09 21:23:55 (404): Enabling VM Network Access.
2019-04-09 21:23:55 (404): Setting Network Configuration for NAT.
2019-04-09 21:23:55 (404): Disabling USB Support for VM.
2019-04-09 21:23:55 (404): Disabling COM Port Support for VM.
2019-04-09 21:23:55 (404): Disabling LPT Port Support for VM.
2019-04-09 21:23:55 (404): Disabling Audio Support for VM.
2019-04-09 21:23:55 (404): Disabling Clipboard Support for VM.
2019-04-09 21:23:55 (404): Disabling Drag and Drop Support for VM.
2019-04-09 21:23:55 (404): Adding storage controller(s) to VM.
2019-04-09 21:23:55 (404): Adding virtual ISO 9660 disk drive to VM. (vm_isocontext.iso)
2019-04-09 21:23:57 (404): Adding VirtualBox Guest Additions to VM.
2019-04-09 21:23:57 (404): Adding network bandwidth throttle group to VM. (Defaulting to 1024GB)
2019-04-09 21:23:57 (404): Enabling shared directory for VM.
2019-04-09 21:23:57 (404): Starting VM. (boinc_9986ff3a8a2e7c98, slot#13)
2019-04-09 21:29:33 (404): Successfully started VM. (PID = '13272')
2019-04-09 21:29:33 (404): Reporting VM Process ID to BOINC.
2019-04-09 21:34:34 (404): VM is no longer is a running state. It is in 'poweroff'.
2019-04-09 21:34:39 (404): 
   NOTE: VM failed to enter an online state within the timeout period.
    This might be a temporary problem and so this job will be rescheduled for another time.


    Hypervisor System Log:

03:35:53.688593          ERROR [COM]: aRC=E_ACCESSDENIED (0x80070005) aIID={85cd948e-a71f-4289-281e-0ca7ad48cd89} aComponent={MachineWrap} aText={The object functionality is limited}, preserve=false aResultDetail=0
03:35:53.689570          ERROR [COM]: aRC=E_ACCESSDENIED (0x80070005) aIID={85cd948e-a71f-4289-281e-0ca7ad48cd89} aComponent={MachineWrap} aText={The object functionality is limited}, preserve=false aResultDetail=0
03:35:54.668623          ERROR [COM]: aRC=E_ACCESSDENIED (0x80070005) aIID={85cd948e-a71f-4289-281e-0ca7ad48cd89} aComponent={MachineWrap} aText={The object functionality is limited}, preserve=false aResultDetail=0
03:35:55.672702          ERROR [COM]: aRC=E_ACCESSDENIED (0x80070005) aIID={85cd948e-a71f-4289-281e-0ca7ad48cd89} aComponent={MachineWrap} aText={The object functionality is limited}, preserve=false aResultDetail=0
03:35:56.675748          ERROR [COM]: aRC=E_ACCESSDENIED (0x80070005) aIID={85cd948e-a71f-4289-281e-0ca7ad48cd89} aComponent={MachineWrap} aText={The object functionality is limited}, preserve=false aResultDetail=0
03:35:57.682959          ERROR [COM]: aRC=E_ACCESSDENIED (0x80070005) aIID={85cd948e-a71f-4289-281e-0ca7ad48cd89} aComponent={MachineWrap} aText={The object functionality is limited}, preserve=false aResultDetail=0
03:35:58.696251          ERROR [COM]: aRC=E_ACCESSDENIED (0x80070005) aIID={85cd948e-a71f-4289-281e-0ca7ad48cd89} aComponent={MachineWrap} aText={The object functionality is limited}, preserve=false aResultDetail=0
03:35:58.698176          ERROR [COM]: aRC=E_ACCESSDENIED (0x80070005) aIID={85cd948e-a71f-4289-281e-0ca7ad48cd89} aComponent={MachineWrap} aText={The object functionality is limited}, preserve=false aResultDetail=0
03:35:58.705984          ERROR [COM]: aRC=E_ACCESSDENIED (0x80070005) aIID={85cd948e-a71f-4289-281e-0ca7ad48cd89} aComponent={MachineWrap} aText={The object functionality is limited}, preserve=false aResultDetail=0
03:35:59.699329          ERROR [COM]: aRC=E_ACCESSDENIED (0x80070005) aIID={85cd948e-a71f-4289-281e-0ca7ad48cd89} aComponent={MachineWrap} aText={The object functionality is limited}, preserve=false aResultDetail=0
03:36:00.701786          ERROR [COM]: aRC=E_ACCESSDENIED (0x80070005) aIID={85cd948e-a71f-4289-281e-0ca7ad48cd89} aComponent={MachineWrap} aText={The object functionality is limited}, preserve=false aResultDetail=0
03:36:01.704864          ERROR [COM]: aRC=E_ACCESSDENIED (0x80070005) aIID={85cd948e-a71f-4289-281e-0ca7ad48cd89} aComponent={MachineWrap} aText={The object functionality is limited}, preserve=false aResultDetail=0
03:36:02.707825          ERROR [COM]: aRC=E_ACCESSDENIED (0x80070005) aIID={85cd948e-a71f-4289-281e-0ca7ad48cd89} aComponent={MachineWrap} aText={The object functionality is limited}, preserve=false aResultDetail=0
03:36:03.710208          ERROR [COM]: aRC=E_ACCESSDENIED (0x80070005) aIID={85cd948e-a71f-4289-281e-0ca7ad48cd89} aComponent={MachineWrap} aText={The object functionality is limited}, preserve=false aResultDetail=0
03:36:03.713136          ERROR [COM]: aRC=E_ACCESSDENIED (0x80070005) aIID={85cd948e-a71f-4289-281e-0ca7ad48cd89} aComponent={MachineWrap} aText={The object functionality is limited}, preserve=false aResultDetail=0
03:36:03.726238          ERROR [COM]: aRC=E_ACCESSDENIED (0x80070005) aIID={85cd948e-a71f-4289-281e-0ca7ad48cd89} aComponent={MachineWrap} aText={The object functionality is limited}, preserve=false aResultDetail=0
03:36:04.713562          ERROR [COM]: aRC=E_ACCESSDENIED (0x80070005) aIID={85cd948e-a71f-4289-281e-0ca7ad48cd89} aComponent={MachineWrap} aText={The object functionality is limited}, preserve=false aResultDetail=0
03:36:05.717169          ERROR [COM]: aRC=E_ACCESSDENIED (0x80070005) aIID={85cd948e-a71f-4289-281e-0ca7ad48cd89} aComponent={MachineWrap} aText={The object functionality is limited}, preserve=false aResultDetail=0
03:36:06.719722          ERROR [COM]: aRC=E_ACCESSDENIED (0x80070005) aIID={85cd948e-a71f-4289-281e-0ca7ad48cd89} aComponent={MachineWrap} aText={The object functionality is limited}, preserve=false aResultDetail=0
03:36:07.723532          ERROR [COM]: aRC=E_ACCESSDENIED (0x80070005) aIID={85cd948e-a71f-4289-281e-0ca7ad48cd89} aComponent={MachineWrap} aText={The object functionality is limited}, preserve=false aResultDetail=0
03:36:08.728089          ERROR [COM]: aRC=E_ACCESSDENIED (0x80070005) aIID={85cd948e-a71f-4289-281e-0ca7ad48cd89} aComponent={MachineWrap} aText={The object functionality is limited}, preserve=false aResultDetail=0
03:36:08.730203          ERROR [COM]: aRC=E_ACCESSDENIED (0x80070005) aIID={85cd948e-a71f-4289-281e-0ca7ad48cd89} aComponent={MachineWrap} aText={The object functionality is limited}, preserve=false aResultDetail=0
03:36:08.733161          ERROR [COM]: aRC=E_ACCESSDENIED (0x80070005) aIID={85cd948e-a71f-4289-281e-0ca7ad48cd89} aComponent={MachineWrap} aText={The object functionality is limited}, preserve=false aResultDetail=0
03:36:09.730336          ERROR [COM]: aRC=E_ACCESSDENIED (0x80070005) aIID={85cd948e-a71f-4289-281e-0ca7ad48cd89} aComponent={MachineWrap} aText={The object functionality is limited}, preserve=false aResultDetail=0
03:36:10.733248          ERROR [COM]: aRC=E_ACCESSDENIED (0x80070005) aIID={85cd948e-a71f-4289-281e-0ca7ad48cd89} aComponent={MachineWrap} aText={The object functionality is limited}, preserve=false aResultDetail=0
03:36:11.736460          ERROR [COM]: aRC=E_ACCESSDENIED (0x80070005) aIID={85cd948e-a71f-4289-281e-0ca7ad48cd89} aComponent={MachineWrap} aText={The object functionality is limited}, preserve=false aResultDetail=0
03:36:12.740181          ERROR [COM]: aRC=E_ACCESSDENIED (0x80070005) aIID={85cd948e-a71f-4289-281e-0ca7ad48cd89} aComponent={MachineWrap} aText={The object functionality is limited}, preserve=false aResultDetail=0
03:36:13.743319          ERROR [COM]: aRC=E_ACCESSDENIED (0x80070005) aIID={85cd948e-a71f-4289-281e-0ca7ad48cd89} aComponent={MachineWrap} aText={The object functionality is limited}, preserve=false aResultDetail=0
03:36:13.753079          ERROR [COM]: aRC=E_ACCESSDENIED (0x80070005) aIID={85cd948e-a71f-4289-281e-0ca7ad48cd89} aComponent={MachineWrap} aText={The object functionality is limited}, preserve=false aResultDetail=0
03:36:13.759911          ERROR [COM]: aRC=E_ACCESSDENIED (0x80070005) aIID={85cd948e-a71f-4289-281e-0ca7ad48cd89} aComponent={MachineWrap} aText={The object functionality is limited}, preserve=false aResultDetail=0
03:36:14.754032          ERROR [COM]: aRC=E_ACCESSDENIED (0x80070005) aIID={85cd948e-a71f-4289-281e-0ca7ad48cd89} aComponent={MachineWrap} aText={The object functionality is limited}, preserve=false aResultDetail=0
03:36:15.756901          ERROR [COM]: aRC=E_ACCESSDENIED (0x80070005) aIID={85cd948e-a71f-4289-281e-0ca7ad48cd89} aComponent={MachineWrap} aText={The object functionality is limited}, preserve=false aResultDetail=0
03:36:16.768786          ERROR [COM]: aRC=E_ACCESSDENIED (0x80070005) aIID={85cd948e-a71f-4289-281e-0ca7ad48cd89} aComponent={MachineWrap} aText={The object functionality is limited}, preserve=false aResultDetail=0
03:36:18.762220          ERROR [COM]: aRC=E_ACCESSDENIED (0x80070005) aIID={85cd948e-a71f-4289-281e-0ca7ad48cd89} aComponent={MachineWrap} aText={The object functionality is limited}, preserve=false aResultDetail=0
03:36:18.774908          ERROR [COM]: aRC=E_ACCESSDENIED (0x80070005) aIID={85cd948e-a71f-4289-281e-0ca7ad48cd89} aComponent={MachineWrap} aText={The object functionality is limited}, preserve=false aResultDetail=0
03:36:23.788144          ERROR [COM]: aRC=E_ACCESSDENIED (0x80070005) aIID={85cd948e-a71f-4289-281e-0ca7ad48cd89} aComponent={MachineWrap} aText={The object functionality is limited}, preserve=false aResultDetail=0
03:36:23.796929          ERROR [COM]: aRC=E_ACCESSDENIED (0x80070005) aIID={85cd948e-a71f-4289-281e-0ca7ad48cd89} aComponent={MachineWrap} aText={The object functionality is limited}, preserve=false aResultDetail=0

    VM Execution Log:

139277 
00:00:12.139277 [/Devices/pckbd/0/] (level 3)
00:00:12.139278   Trusted <integer> = 0x0000000000000001 (1)
00:00:12.139280 
00:00:12.139281 [/Devices/pckbd/0/Config/] (level 4)
00:00:12.139282 
00:00:12.139282 [/Devices/pckbd/0/LUN#0/] (level 4)
00:00:12.139283   Driver <string>  = "KeyboardQueue" (cb=14)
00:00:12.139283 
00:00:12.139284 [/Devices/pckbd/0/LUN#0/AttachedDriver/] (level 5)
00:00:12.139285   Driver <string>  = "MainKeyboard" (cb=13)
00:00:12.139285 
00:00:12.139286 [/Devices/pckbd/0/LUN#0/AttachedDriver/Config/] (level 6)
00:00:12.139287   Object <integer> = 0x0000000001eb8e00 (32 214 528)
00:00:12.139288 
00:00:12.139288 [/Devices/pckbd/0/LUN#0/Config/] (level 5)
00:00:12.139289   QueueSize <integer> = 0x0000000000000040 (64)
00:00:12.139290 
00:00:12.139290 [/Devices/pckbd/0/LUN#1/] (level 4)
00:00:12.139291   Driver <string>  = "MouseQueue" (cb=11)
00:00:12.139292 
00:00:12.139292 [/Devices/pckbd/0/LUN#1/AttachedDriver/] (level 5)
00:00:12.139293   Driver <string>  = "MainMouse" (cb=10)
00:00:12.139294 
00:00:12.139294 [/Devices/pckbd/0/LUN#1/AttachedDriver/Config/] (level 6)
00:00:12.139295   Object <integer> = 0x0000000001eb9470 (32 216 176)
00:00:12.139296 
00:00:12.139297 [/Devices/pckbd/0/LUN#1/Config/] (level 5)
00:00:12.139297   QueueSize <integer> = 0x0000000000000080 (128)
00:00:12.139298 
00:00:12.139299 [/Devices/pcnet/] (level 2)
00:00:12.139299 
00:00:12.139300 [/Devices/serial/] (level 2)
00:00:12.139300 
00:00:12.139301 [/Devices/vga/] (level 2)
00:00:12.139301 
00:00:12.139302 [/Devices/vga/0/] (level 3)
00:00:12.139302   PCIBusNo      <integer> = 0x0000000000000000 (0)
00:00:12.139303   PCIDeviceNo   <integer> = 0x0000000000000002 (2)
00:00:12.139304   PCIFunctionNo <integer> = 0x0000000000000000 (0)
00:00:12.139304   Trusted       <integer> = 0x0000000000000001 (1)
00:00:12.139305 
00:00:12.139305 [/Devices/vga/0/Config/] (level 4)
00:00:12.139310   CustomVideoModes <integer> = 0x0000000000000000 (0)
00:00:12.139310   FadeIn           <integer> = 0x0000000000000001 (1)
00:00:12.139311   FadeOut          <integer> = 0x0000000000000001 (1)
00:00:12.139312   HeightReduction  <integer> = 0x0000000000000000 (0)
00:00:12.139312   LogoFile         <string>  = "" (cb=1)
00:00:12.139313   LogoTime         <integer> = 0x0000000000000000 (0)
00:00:12.139314   MonitorCount     <integer> = 0x0000000000000001 (1)
00:00:12.139315   ShowBootMenu     <integer> = 0x0000000000000002 (2)
00:00:12.139315   VRamSize         <integer> = 0x0000000000800000 (8 388 608, 8 MB)
00:00:12.139317 
00:00:12.139317 [/Devices/vga/0/LUN#0/] (level 4)
00:00:12.139318   Driver <string>  = "MainDisplay" (cb=12)
00:00:12.139319 
00:00:12.139319 [/Devices/vga/0/LUN#0/Config/] (level 5)
00:00:12.139320   Object <integer> = 0x0000000001eb9d10 (32 218 384)
00:00:12.139321 
00:00:12.139321 [/Devices/vga/0/LUN#999/] (level 4)
00:00:12.139322   Driver <string>  = "MainStatus" (cb=11)
00:00:12.139323 
00:00:12.139323 [/Devices/vga/0/LUN#999/Config/] (level 5)
00:00:12.139324   First   <integer> = 0x0000000000000000 (0)
00:00:12.139324   Last    <integer> = 0x0000000000000000 (0)
00:00:12.139325   papLeds <integer> = 0x0000000001eb3b98 (32 193 432)
00:00:12.139326 
00:00:12.139326 [/Devices/virtio-net/] (level 2)
00:00:12.139327 
00:00:12.139327 [/EM/] (level 1)
00:00:12.139328   TripleFaultReset <integer> = 0x0000000000000000 (0)
00:00:12.139329 
00:00:12.139329 [/GIM/] (level 1)
00:00:12.139330   Provider <string>  = "KVM" (cb=4)
00:00:12.139330 
00:00:12.139331 [/HM/] (level 1)
00:00:12.139331   64bitEnabled       <integer> = 0x0000000000000001 (1)
00:00:12.139332   EnableLargePages   <integer> = 0x0000000000000001 (1)
00:00:12.139333   EnableNestedPaging <integer> = 0x0000000000000001 (1)
00:00:12.139333   EnableUX           <integer> = 0x0000000000000001 (1)
00:00:12.139334   EnableVPID         <integer> = 0x0000000000000001 (1)
00:00:12.139335   Exclusive          <integer> = 0x0000000000000000 (0)
00:00:12.139336   HMForced           <integer> = 0x0000000000000001 (1)
00:00:12.139336   IBPBOnVMEntry      <integer> = 0x0000000000000000 (0)
00:00:12.139339   IBPBOnVMExit       <integer> = 0x0000000000000000 (0)
00:00:12.139339   SpecCtrlByHost     <integer> = 0x0000000000000000 (0)
00:00:12.139340 
00:00:12.139340 [/MM/] (level 1)
00:00:12.139341   CanUseLargerHeap <integer> = 0x0000000000000000 (0)
00:00:12.139342 
00:00:12.139342 [/PDM/] (level 1)
00:00:12.139343 
00:00:12.139343 [/PDM/AsyncCompletion/] (level 2)
00:00:12.139345 
00:00:12.139346 [/PDM/AsyncCompletion/File/] (level 3)
00:00:12.139347 
00:00:12.139347 [/PDM/AsyncCompletion/File/BwGroups/] (level 4)
00:00:12.139348 
00:00:12.139348 [/PDM/BlkCache/] (level 2)
00:00:12.139349   CacheSize <integer> = 0x0000000000500000 (5 242 880, 5 MB)
00:00:12.139350 
00:00:12.139351 [/PDM/Devices/] (level 2)
00:00:12.139351 
00:00:12.139352 [/PDM/Drivers/] (level 2)
00:00:12.139352 
00:00:12.139352 [/PDM/Drivers/VBoxC/] (level 3)
00:00:12.139353   Path <string>  = "VBoxC" (cb=6)
00:00:12.139354 
00:00:12.139354 [/PDM/NetworkShaper/] (level 2)
00:00:12.139355 
00:00:12.139355 [/PDM/NetworkShaper/BwGroups/] (level 3)
00:00:12.139356 
00:00:12.139356 [/PDM/NetworkShaper/BwGroups/boinc_9986ff3a8a2e7c98_net/] (level 4)
00:00:12.139360   Max <integer> = 0x0000010000000000 (1 099 511 627 776)
00:00:12.139362 
00:00:12.139362 [/TM/] (level 1)
00:00:12.139363   UTCOffset <integer> = 0x0000000000000000 (0)
00:00:12.139363 
00:00:12.139368 ********************* End of CFGM dump **********************
00:00:12.158410 VM: fHMEnabled=true  (configured) fRecompileUser=false fRecompileSupervisor=false
00:00:12.158415 VM: fRawRing1Enabled=false CSAM=true  PATM=true 
00:00:12.170446 HM: HMR3Init: VT-x w/ nested paging and unrestricted guest execution hw support
00:00:12.177006 MM: cbHyperHeap=0x100000 (1048576)
00:00:12.185506 CPUM: fXStateHostMask=0x7; initial: 0x7; host XCR0=0x1f
00:00:12.236198 CPUM: Matched host CPU INTEL 0x6/0x8e/0xa Intel_Core7_CoffeeLake with CPU DB entry 'Intel Core i7-6700K' (INTEL 0x6/0x5e/0x3 Intel_Core7_Skylake)
00:00:12.240044 CPUM: MXCSR_MASK=0xffff (host: 0xffff)
00:00:12.240093 CPUM: Microcode revision 0x00000084
00:00:12.240114 CPUM: Changing leaf 13[0]: EBX=0x440 -> 0x340, ECX=0x440 -> 0x340
00:00:12.240155 CPUM: SetGuestCpuIdFeature: Enabled PAE
00:00:12.290902 PGM: HCPhysInterPD=000000008b994000 HCPhysInterPaePDPT=000000008b997000 HCPhysInterPaePML4=000000008b965000
00:00:12.293658 PGM: apInterPTs={000000008b995000,000000008b996000} apInterPaePTs={0000000019643000,0000000147344000} apInterPaePDs={000000013a545000,00000001a0e46000,0000000011b47000,000000016ce48000} pInterPaePDPT64=000000008b964000
00:00:12.293688 PGM: Host paging mode: AMD64+NX
00:00:12.295565 PGM: PGMPool: cMaxPages=1584 (u64MaxPages=1571)
00:00:12.295592 PGM: pgmR3PoolInit: cMaxPages=0x630 cMaxUsers=0xc60 cMaxPhysExts=0xc60 fCacheEnable=true 
00:00:12.350884 MMR3HyperAllocOnceNoRel: cb=0xc00080 uAlignment=0x0 returns VERR_MM_HYPER_NO_MEMORY
00:00:12.476802 AssertLogRel F:\tinderbox\win-5.2\src\VBox\VMM\VMMR3\PGMPhys.cpp(1743) int __cdecl PGMR3PhysRegisterRam(struct VM *,unsigned __int64,unsigned __int64,const char *): RT_SUCCESS_NP(rc)
00:00:12.479744 cbRamRange=12583040
00:00:12.558340 VMSetError: F:\tinderbox\win-5.2\src\VBox\VMM\VMMR3\VM.cpp(361) int __cdecl VMR3Create(unsigned int,const struct VMM2USERMETHODS *,void (__cdecl *)(struct UVM *,void *,int,const char *,unsigned int,const char *,const char *,char *),void *,int (__cdecl *)(struct UVM *,struct VM *,void *),void *,struct VM **,struct UVM **); rc=VERR_MM_HYPER_NO_MEMORY
00:00:12.562571 VMSetError: Hypervisor memory allocation failed.
00:00:12.620927 ERROR [COM]: aRC=E_FAIL (0x80004005) aIID={872da645-4a9b-1727-bee2-5585105b9eed} aComponent={ConsoleWrap} aText={Hypervisor memory allocation failed. (VERR_MM_HYPER_NO_MEMORY)}, preserve=false aResultDetail=0
00:00:12.766123 Console: Machine state changed to 'PoweredOff'
00:00:13.940264 Power up failed (vrc=VERR_MM_HYPER_NO_MEMORY, rc=E_FAIL (0X80004005))

    VM Startup Log:


    VM Trace Log:

2019-04-09 21:49:21 (128): vboxwrapper (7.9.26200): starting
2019-04-09 21:49:21 (128): Status Report: Detected vboxsvc.exe. (PID = '10824')
2019-04-09 21:49:22 (128): Feature: Checkpoint interval offset (8 seconds)
2019-04-09 21:49:22 (128): Detected: VirtualBox COM Interface (Version: 5.2.8)
2019-04-09 21:49:22 (128): Detected: Sandbox Configuration Enabled
2019-04-09 21:49:22 (128): Detected: Minimum checkpoint interval (600.000000 seconds)
2019-04-09 21:49:22 (128): Starting VM. (boinc_9986ff3a8a2e7c98, slot#13)
2019-04-09 21:50:17 (128): Guest Log: BIOS: VirtualBox 5.2.8

2019-04-09 21:50:17 (128): Guest Log: CPUID EDX: 0x078bfbff

2019-04-09 21:50:17 (128): Guest Log: BIOS: Boot : bseqnr=1, bootseq=0032

2019-04-09 21:50:17 (128): Guest Log: int13_harddisk: function 02, unmapped device for ELDL=80

2019-04-09 21:50:17 (128): Guest Log: BIOS: Boot from Hard Disk 0 failed

2019-04-09 21:50:17 (128): Guest Log: BIOS: Boot : bseqnr=2, bootseq=0003

2019-04-09 21:50:17 (128): Guest Log: BIOS: Booting from CD-ROM...

2019-04-09 21:50:17 (128): Successfully started VM. (PID = '7960')
2019-04-09 21:50:17 (128): Reporting VM Process ID to BOINC.
2019-04-09 21:50:22 (128): Guest Log: BIOS: KBD: unsupported int 16h function 03

2019-04-09 21:50:22 (128): Guest Log: BIOS: AX=0305 BX=0000 CX=0000 DX=0000 

2019-04-09 21:50:22 (128): VM state change detected. (old = 'poweroff', new = 'running')
2019-04-09 21:50:32 (128): Preference change detected
2019-04-09 21:50:32 (128): Setting CPU throttle for VM. (100%)
2019-04-09 21:50:33 (128): Setting checkpoint interval to 600 seconds. (Higher value of (Preference: 600 seconds) or (Vbox_job.xml: 600 seconds))
2019-04-09 21:50:43 (128): Guest Log: net.ipv4.ip_forward = 1

2019-04-09 21:50:43 (128): Guest Log: sysctl: cannot stat /proc/sys/net/ipv6/conf/all/forwarding: No such file or directory

2019-04-09 21:50:43 (128): Guest Log: sysctl: setting key "cannot stat %s": No such file or directory

2019-04-09 21:50:43 (128): Guest Log: sysctl: "cannot stat %s" is an unknown key

2019-04-09 21:50:43 (128): Guest Log: sysctl: setting key "cannot stat %s": No such file or directory

2019-04-09 21:50:43 (128): Guest Log: Segmentation fault

2019-04-09 21:50:43 (128): Guest Log: automount ...

2019-04-09 21:50:43 (128): Guest Log: Is the disk unpartitioned?, test for the 'boot2docker format-me' string

2019-04-09 21:50:43 (128): Guest Log: automount over.

2019-04-09 21:50:43 (128): Guest Log: Setting hostname to boot2docker Done.

2019-04-09 21:50:43 (128): Guest Log: Tue Apr  9 21:50:40 UTC 2019 dhcp -------------------------------

2019-04-09 21:50:43 (128): Guest Log: vgdrvHeartbeatInit: Setting up heartbeat to trigger every 2000 milliseconds

2019-04-09 21:50:43 (128): Guest Log: vboxguest: misc device minor 56, IRQ 20, I/O port d020, MMIO at 00000000f0400000 (size 0x400000)

2019-04-09 21:50:48 (128): Guest Log: udevadm settle - timeout of 5 seconds reached, the event queue contains:

2019-04-09 21:50:48 (128): Guest Log:   /sys/devices/LNXSYSTM:00/LNXSYBUS:00/PNP0A03:00/device:00/PNP0700:00 (1074)

2019-04-09 21:50:48 (128): Guest Log:   /sys/devices/LNXSYSTM:00 (1295)

2019-04-09 21:50:48 (128): Guest Log:   /sys/devices/LNXSYSTM:00/LNXCPU:00 (1296)

2019-04-09 21:50:48 (128): Guest Log:   /sys/devices/LNXSYSTM:00/LNXPWRBN:00 (1297)

2019-04-09 21:50:48 (128): Guest Log:   /sys/devices/LNXSYSTM:00/LNXPWRBN:00/input/input0 (1298)

2019-04-09 21:50:48 (128): Guest Log:   /sys/devices/LNXSYSTM:00/LNXPWRBN:00/input/input0/event0 (1299)

2019-04-09 21:50:48 (128): Guest Log:   /sys/devices/LNXSYSTM:00/LNXSLPBN:00 (1300)

2019-04-09 21:50:48 (128): Guest Log:   /sys/devices/LNXSYSTM:00/LNXSLPBN:00/input/input1 (1301)

2019-04-09 21:50:48 (128): Guest Log:   /sys/devices/LNXSYSTM:00/LNXSLPBN:00/input/input1/event1 (1302)

2019-04-09 21:50:48 (128): Guest Log:   /sys/devices/LNXSYSTM:00/LNXSYBUS:00 (1303)

2019-04-09 21:50:48 (128): Guest Log:   /sys/devices/LNXSYSTM:00/LNXSYBUS:00/PNP0A03:00 (1304)

2019-04-09 21:50:48 (128): Guest Log:   /sys/devices/LNXSYSTM:00/LNXSYBUS:00/PNP0A03:00/ACPI0003:00 (1305)

2019-04-09 21:50:48 (128): Guest Log:   /sys/devices/LNXSYSTM:00/LNXSYBUS:00/PNP0A03:00/ACPI0003:00/power_supply/AC (1306)

2019-04-09 21:50:48 (128): Guest Log:   /sys/devices/LNXSYSTM:00/LNXSYBUS:00/PNP0A03:00/LNXVIDEO:00 (1307)

2019-04-09 21:50:48 (128): Guest Log:   /sys/devices/LNXSYSTM:00/LNXSYBUS:00/PNP0A03:00/LNXVIDEO:00/device:01 (1308)

2019-04-09 21:50:48 (128): Guest Log:   /sys/devices/LNXSYSTM:00/LNXSYBUS:00/PNP0A03:00/LNXVIDEO:00/input/input6 (1309)

2019-04-09 21:50:48 (128): Guest Log:   /sys/devices/LNXSYSTM:00/LNXSYBUS:00/PNP0A03:00/LNXVIDEO:00/input/input6/event5 (1310)

2019-04-09 21:50:48 (128): Guest Log:   /sys/devices/LNXSYSTM:00/LNXSYBUS:00/PNP0A03:00/PNP0400:00 (1311)

2019-04-09 21:50:48 (128): Guest Log:   /sys/devices/LNXSYSTM:00/LNXSYBUS:00/PNP0A03:00/PNP0400:01 (1312)

2019-04-09 21:50:48 (128): Guest Log:   /sys/devices/LNXSYSTM:00/LNXSYBUS:00/PNP0A03:00/PNP0501:00 (1313)

2019-04-09 21:50:48 (128): Guest Log:   /sys/devices/LNXSYSTM:00/LNXSYBUS:00/PNP0A03:00/PNP0501:01 (1314)

2019-04-09 21:50:48 (128): Guest Log:   /sys/devices/LNXSYSTM:00/LNXSYBUS:00/PNP0A03:00/PNP0501:02 (1315)

2019-04-09 21:50:48 (128): Guest Log:   /sys/devices/LNXSYSTM:00/LNXSYBUS:00/PNP0A03:00/PNP0501:03 (1316)

2019-04-09 21:50:48 (128): Guest Log:   /sys/devices/LNXSYSTM:00/LNXSYBUS:00/PNP0A03:00/PNP0C02:00 (1317)

2019-04-09 21:50:48 (128): Guest Log:   /sys/devices/LNXSYSTM:00/LNXSYBUS:00/PNP0A03:00/PNP0C0A:00 (1318)

2019-04-09 21:50:48 (128): Guest Log:   /sys/devices/LNXSYSTM:00/LNXSYBUS:00/PNP0A03:00/PNP0C0A:00/power_supply/BAT0 (1319)

2019-04-09 21:50:48 (128): Guest Log:   /sys/devices/LNXSYSTM:00/LNXSYBUS:00/PNP0A03:00/PNP8390:00 (1320)

2019-04-09 21:50:48 (128): Guest Log:   /sys/devices/LNXSYSTM:00/LNXSYBUS:00/PNP0A03:00/device:00 (1321)

2019-04-09 21:50:48 (128): Guest Log:   /sys/devices/LNXSYSTM:00/LNXSYBUS:00/PNP0A03:00/device:00/APP0001:00 (1322)

2019-04-09 21:50:48 (128): Guest Log:   /sys/devices/LNXSYSTM:00/LNXSYBUS:00/PNP0A03:00/device:00/PNP0000:00 (1323)

2019-04-09 21:50:48 (128): Guest Log:   /sys/devices/LNXSYSTM:00/LNXSYBUS:00/PNP0A03:00/device:00/PNP0100:00 (1324)

2019-04-09 21:50:48 (128): Guest Log:   /sys/devices/LNXSYSTM:00/LNXSYBUS:00/PNP0A03:00/device:00/PNP0103:00 (1325)

2019-04-09 21:50:48 (128): Guest Log:   /sys/devices/LNXSYSTM:00/LNXSYBUS:00/PNP0A03:00/device:00/PNP0200:00 (1326)

2019-04-09 21:50:48 (128): Guest Log:   /sys/devices/LNXSYSTM:00/LNXSYBUS:00/PNP0A03:00/device:00/PNP0303:00 (1327)

2019-04-09 21:50:48 (128): Guest Log:   /sys/devices/LNXSYSTM:00/LNXSYBUS:00/PNP0A03:00/device:00/PNP0700:00 (1328)

2019-04-09 21:50:48 (128): Guest Log:   /sys/devices/LNXSYSTM:00/LNXSYBUS:00/PNP0A03:00/device:00/PNP0B00:00 (1329)

2019-04-09 21:50:48 (128): Guest Log:   /sys/devices/LNXSYSTM:00/LNXSYBUS:00/PNP0A03:00/device:00/PNP0F03:00 (1330)

2019-04-09 21:50:48 (128): Guest Log:   /sys/devices/LNXSYSTM:00/LNXSYBUS:00/PNP0A03:00/device:02 (1331)

2019-04-09 21:50:48 (128): Guest Log:   /sys/devices/LNXSYSTM:00/LNXSYBUS:00/PNP0C0F:00 (1332)

2019-04-09 21:50:48 (128): Guest Log:   /sys/devices/LNXSYSTM:00/LNXSYBUS:00/PNP0C0F:01 (1333)

2019-04-09 21:50:49 (128): Guest Log:   /sys/devices/LNXSYSTM:00/LNXSYBUS:00/PNP0C0F:02 (1334)

2019-04-09 21:50:49 (128): Guest Log:   /sys/devices/LNXSYSTM:00/LNXSYBUS:00/PNP0C0F:03 (1335)

2019-04-09 21:50:49 (128): Guest Log:   /sys/devices/LNXSYSTM:00/LNXSYBUS:01 (1336)

2019-04-09 21:50:49 (128): Guest Log: Tue Apr  9 21:50:46 UTC 2019 dhcp -------------------------------

2019-04-09 21:50:49 (128): Guest Log: VBoxService 5.0.16 r105871 (verbosity: 0) linux.amd64 (Mar  4 2016 17:38:55) release log

2019-04-09 21:50:49 (128): Guest Log: 00:00:00.000150 main     Log opened 2019-04-09T21:50:46.652626000Z

2019-04-09 21:50:49 (128): Guest Log: VBoxService 5.0.16 r105871 (verbosity: 0) linux.amd64 (Mar  4 2016 17:38:55) release log

2019-04-09 21:50:49 (128): Guest Log: 00:00:00.000150 main     Log opened 2019-04-09T21:50:46.652626000Z

2019-04-09 21:50:49 (128): Guest Log: 00:00:00.006151 main     OS Product: Linux

2019-04-09 21:50:49 (128): Guest Log: 00:00:00.006292 main     OS Release: 4.1.19-boot2docker

2019-04-09 21:50:49 (128): Guest Log: 00:00:00.006400 main     OS Version: #1 SMP Sun Apr 17 19:40:54 UTC 2016

2019-04-09 21:50:49 (128): Guest Log: 00:00:00.006488 main     Executable: /sbin/VBoxService

2019-04-09 21:50:49 (128): Guest Log: 00:00:00.006490 main     Process ID: 850

2019-04-09 21:50:49 (128): Guest Log: 00:00:00.006491 main     Package type: LINUX_64BITS_GENERIC

2019-04-09 21:50:49 (128): Guest Log: 00:00:00.006151 main     OS Product: Linux

2019-04-09 21:50:49 (128): Guest Log: 00:00:00.006292 main     OS Release: 4.1.19-boot2docker

2019-04-09 21:50:49 (128): Guest Log: 00:00:00.006400 main     OS Version: #1 SMP Sun Apr 17 19:40:54 UTC 2016

2019-04-09 21:50:49 (128): Guest Log: 00:00:00.006488 main     Executable: /sbin/VBoxService

2019-04-09 21:50:49 (128): Guest Log: 00:00:00.006490 main     Process ID: 850

2019-04-09 21:50:49 (128): Guest Log: 00:00:00.006491 main     Package type: LINUX_64BITS_GENERIC

2019-04-09 21:50:49 (128): Guest Log: 00:00:00.081722 main     5.0.16 r105871 started. Verbose level = 0

2019-04-09 21:50:49 (128): Guest Log: 00:00:00.081722 main     5.0.16 r105871 started. Verbose level = 0

2019-04-09 21:50:49 (128): Guest Log: 00:00:00.158588 vminfo   rtldrNativeLoad: dlopen('libdbus-1.so.3', RTLD_NOW | RTLD_LOCAL) failed: libdbus-1.so.3: cannot open shared object file: No such file or directory

2019-04-09 21:50:49 (128): Guest Log: 00:00:00.158861 vminfo   Error: Unable to connect to system D-Bus (1/3): D-Bus not installed

2019-04-09 21:50:49 (128): Guest Log: Mounting BOINC shared/...

2019-04-09 21:50:49 (128): Guest Log: -------------------

2019-04-09 21:50:49 (128): Guest Log: Tue Apr  9 19:50:48 UTC 2019

2019-04-09 21:50:54 (128): Guest Log: 00:00:05.165690 vminfo   Error: Unable to connect to system D-Bus (2/3): D-Bus not installed

2019-04-09 21:50:54 (128): Guest Log: Tue Apr  9 19:50:53 UTC 2019

2019-04-09 21:50:54 (128): Guest Log: 1: lo: <LOOPBACK,UP,LOWER_UP> mtu 65536 qdisc noqueue state UNKNOWN group default 

2019-04-09 21:50:54 (128): Guest Log:     link/loopback 00:00:00:00:00:00 brd 00:00:00:00:00:00

2019-04-09 21:50:54 (128): Guest Log:     inet 127.0.0.1/8 scope host lo

2019-04-09 21:50:54 (128): Guest Log:        valid_lft forever preferred_lft forever

2019-04-09 21:50:54 (128): Guest Log: 2: dummy0: <BROADCAST,NOARP> mtu 1500 qdisc noop state DOWN group default 

2019-04-09 21:50:54 (128): Guest Log:     link/ether 52:c3:65:c4:68:ab brd ff:ff:ff:ff:ff:ff

2019-04-09 21:50:54 (128): Guest Log: 3: eth0: <BROADCAST,MULTICAST,UP,LOWER_UP> mtu 1500 qdisc pfifo_fast state UP group default qlen 1000

2019-04-09 21:50:54 (128): Guest Log:     link/ether 08:00:27:12:dc:bf brd ff:ff:ff:ff:ff:ff

2019-04-09 21:50:54 (128): Guest Log:     inet 10.0.2.15/24 brd 10.0.2.255 scope global eth0

2019-04-09 21:50:54 (128): Guest Log:        valid_lft forever preferred_lft forever

2019-04-09 21:50:54 (128): Guest Log: -------------------

2019-04-09 21:50:54 (128): Guest Log: Linking /etc/docker to /var/lib/boot2docker for persistence

2019-04-09 21:50:54 (128): Guest Log: Waiting for Docker daemon to start...

2019-04-09 21:50:59 (128): Guest Log: REPOSITORY          TAG                 IMAGE ID            CREATED             SIZE

2019-04-09 21:50:59 (128): Guest Log: Running boinc_app...

2019-04-09 21:50:59 (128): Guest Log: Importing Docker image from BOINC...

2019-04-09 21:50:59 (128): Guest Log: Filesystem                Size      Used Available Use% Mounted on

2019-04-09 21:50:59 (128): Guest Log: tmpfs                     2.6G    164.1M      2.5G   6% /

2019-04-09 21:50:59 (128): Guest Log: tmpfs                     1.5G         0      1.5G   0% /dev/shm

2019-04-09 21:50:59 (128): Guest Log: cgroup                    1.5G         0      1.5G   0% /sys/fs/cgroup

2019-04-09 21:50:59 (128): Guest Log: shared                  204.6G    112.6G     92.0G  55% /root/shared

2019-04-09 21:50:59 (128): Guest Log: tmpfs                     2.6G    164.1M      2.5G   6% /var/lib/docker/aufs

2019-04-09 21:50:59 (128): Guest Log: 00:00:10.180056 vminfo   Error: Unable to connect to system D-Bus (3/3): D-Bus not installed

2019-04-09 21:51:31 (128): VM state change detected. (old = 'running', new = 'paused')
2019-04-09 21:52:17 (128): VM state change detected. (old = 'paused', new = 'running')
2019-04-09 21:52:22 (128): Guest Log: doing docker load...

2019-04-09 21:52:27 (128): Guest Log: Filesystem                Size      Used Available Use% Mounted on

2019-04-09 21:52:27 (128): Guest Log: tmpfs                     2.6G    663.1M      2.0G  24% /

2019-04-09 21:52:27 (128): Guest Log: tmpfs                     1.5G         0      1.5G   0% /dev/shm

2019-04-09 21:52:27 (128): Guest Log: cgroup                    1.5G         0      1.5G   0% /sys/fs/cgroup

2019-04-09 21:52:27 (128): Guest Log: shared                  204.6G    112.5G     92.1G  55% /root/shared

2019-04-09 21:52:27 (128): Guest Log: tmpfs                     2.6G    663.1M      2.0G  24% /var/lib/docker/aufs

2019-04-09 21:52:27 (128): Guest Log:               total        used        free      shared  buff/cache   available

2019-04-09 21:52:27 (128): Guest Log: Mem:           3007          47        2257         663         701        2258

2019-04-09 21:52:27 (128): Guest Log: Swap:           701           0         701

2019-04-09 21:52:27 (128): Guest Log: Building apps directory...

2019-04-09 22:00:30 (128): Guest Log: Prerun diagnostics...

2019-04-09 22:00:30 (128): Guest Log: REPOSITORY                    TAG                 IMAGE ID            CREATED             SIZE

2019-04-09 22:00:30 (128): Guest Log: nanohub_apps_share64_matlab   4                   32c863520615        16 months ago       488.2 MB

2019-04-09 22:00:30 (128): Guest Log: CONTAINER ID        IMAGE               COMMAND             CREATED             STATUS              PORTS               NAMES

2019-04-09 22:00:30 (128): Guest Log: 499.0M	/var/lib/docker

2019-04-09 22:00:30 (128): Guest Log:               total        used        free      shared  buff/cache   available

2019-04-09 22:00:30 (128): Guest Log: Mem:           3007          47        2246         663         713        2256

2019-04-09 22:00:30 (128): Guest Log: Swap:           701           0         701

2019-04-09 22:00:30 (128): Guest Log: Filesystem                Size      Used Available Use% Mounted on

2019-04-09 22:00:30 (128): Guest Log: tmpfs                     2.6G    663.1M      2.0G  24% /

2019-04-09 22:00:30 (128): Guest Log: tmpfs                     1.5G         0      1.5G   0% /dev/shm

2019-04-09 22:00:30 (128): Guest Log: cgroup                    1.5G         0      1.5G   0% /sys/fs/cgroup

2019-04-09 22:00:30 (128): Guest Log: shared                  204.6G    112.8G     91.8G  55% /root/shared

2019-04-09 22:00:30 (128): Guest Log: tmpfs                     2.6G    663.1M      2.0G  24% /var/lib/docker/aufs

2019-04-09 22:00:30 (128): Guest Log: Running... 

2019-04-09 22:00:30 (128): Guest Log: 07152228_199.boinc

2019-04-09 22:00:30 (128): Guest Log: 07152228_199.sh

2019-04-09 22:01:52 (128): Guest Log: boinc_app exited (0)

2019-04-09 22:01:52 (128): Guest Log: Saving results...

2019-04-09 22:01:52 (128): Guest Log: 07152228_199_output.tar.gz

2019-04-09 22:01:52 (128): VM Completion File Detected.
2019-04-09 22:01:52 (128): Powering off VM.
2019-04-09 22:01:55 (128): Successfully stopped VM.
2019-04-09 22:02:00 (128): Deregistering VM. (boinc_9986ff3a8a2e7c98, slot#13)
2019-04-09 22:02:00 (128): Removing virtual disk drive(s) from VM.
2019-04-09 22:02:00 (128): Removing network bandwidth throttle group from VM.
2019-04-09 22:02:00 (128): Removing storage controller(s) from VM.
2019-04-09 22:02:01 (128): Removing VM from VirtualBox.
22:02:06 (128): called boinc_finish(0)

</stderr_txt>
]]>


©2024 COPYRIGHT 2017-2018 NCN