Stderr output

<core_client_version>7.16.5</core_client_version>
<![CDATA[
<stderr_txt>
2020-04-19 23:42:47 (20000): Detected: vboxwrapper 26197
2020-04-19 23:42:47 (20000): Detected: BOINC client v7.7
2020-04-19 23:42:48 (20000): Detected: VirtualBox VboxManage Interface (Version: 5.2.8)
2020-04-19 23:42:48 (20000): Detected: Heartbeat check (file: 'heartbeat' every 1200.000000 seconds)
2020-04-19 23:42:48 (20000): Successfully copied 'init_data.xml' to the shared directory.
2020-04-19 23:42:48 (20000): Successfully copied 'input' to the shared directory.
2020-04-19 23:42:50 (20000): Create VM. (boinc_81cd84d2db9fae86, slot#0)
2020-04-19 23:42:51 (20000): Setting Memory Size for VM. (630MB)
2020-04-19 23:42:51 (20000): Setting CPU Count for VM. (1)
2020-04-19 23:42:52 (20000): Setting Chipset Options for VM.
2020-04-19 23:42:52 (20000): Setting Boot Options for VM.
2020-04-19 23:42:53 (20000): Setting Network Configuration for NAT.
2020-04-19 23:42:53 (20000): Enabling VM Network Access.
2020-04-19 23:42:53 (20000): Disabling USB Support for VM.
2020-04-19 23:42:54 (20000): Disabling COM Port Support for VM.
2020-04-19 23:42:54 (20000): Disabling LPT Port Support for VM.
2020-04-19 23:42:55 (20000): Disabling Audio Support for VM.
2020-04-19 23:42:55 (20000): Disabling Clipboard Support for VM.
2020-04-19 23:42:55 (20000): Disabling Drag and Drop Support for VM.
2020-04-19 23:42:56 (20000): Adding storage controller(s) to VM.
2020-04-19 23:42:56 (20000): Adding virtual disk drive to VM. (vm_image.vdi)
2020-04-19 23:42:56 (20000): Adding VirtualBox Guest Additions to VM.
2020-04-19 23:42:57 (20000): Adding network bandwidth throttle group to VM. (Defaulting to 1024GB)
2020-04-19 23:42:57 (20000): forwarding host port 7311 to guest port 80
2020-04-19 23:42:57 (20000): Enabling remote desktop for VM.
2020-04-19 23:42:58 (20000): Enabling shared directory for VM.
2020-04-19 23:42:58 (20000): Starting VM using VBoxManage interface. (boinc_81cd84d2db9fae86, slot#0)
2020-04-19 23:43:04 (20000): Successfully started VM. (PID = '20512')
2020-04-19 23:43:04 (20000): Reporting VM Process ID to BOINC.
2020-04-19 23:43:04 (20000): Guest Log: BIOS: VirtualBox 5.2.8

2020-04-19 23:43:04 (20000): Guest Log: CPUID EDX: 0x078bfbff

2020-04-19 23:43:04 (20000): Guest Log: BIOS: ata0-0: PCHS=16383/16/63 LCHS=1024/255/63

2020-04-19 23:43:04 (20000): VM state change detected. (old = 'PoweredOff', new = 'Running')
2020-04-19 23:43:04 (20000): Detected: Web Application Enabled (http://localhost:7311)
2020-04-19 23:43:04 (20000): Detected: Remote Desktop Enabled (localhost:7312)
2020-04-19 23:43:04 (20000): Preference change detected
2020-04-19 23:43:04 (20000): Setting CPU throttle for VM. (100%)
2020-04-19 23:43:04 (20000): Setting checkpoint interval to 600 seconds. (Higher value of (Preference: 60 seconds) or (Vbox_job.xml: 600 seconds))
2020-04-19 23:43:06 (20000): Guest Log: BIOS: Boot : bseqnr=1, bootseq=0032

2020-04-19 23:43:06 (20000): Guest Log: BIOS: Booting from Hard Disk...

2020-04-19 23:43:08 (20000): Guest Log: BIOS: KBD: unsupported int 16h function 03

2020-04-19 23:43:08 (20000): Guest Log: BIOS: AX=0305 BX=0000 CX=0000 DX=0000 

2020-04-19 23:43:30 (20000): Guest Log: vgdrvHeartbeatInit: Setting up heartbeat to trigger every 2000 milliseconds

2020-04-19 23:43:30 (20000): Guest Log: vboxguest: misc device minor 56, IRQ 20, I/O port d020, MMIO at 00000000f0400000 (size 0x400000)

2020-04-19 23:43:34 (20000): Guest Log: VBoxService 5.2.6 r120293 (verbosity: 0) linux.amd64 (Jan 15 2018 14:51:00) release log

2020-04-19 23:43:34 (20000): Guest Log: 00:00:00.000145 main     Log opened 2020-04-19T21:43:31.901967000Z

2020-04-19 23:43:34 (20000): Guest Log: 00:00:00.000279 main     OS Product: Linux

2020-04-19 23:43:34 (20000): Guest Log: 00:00:00.000332 main     OS Release: 4.14.76-13.cernvm.x86_64

2020-04-19 23:43:34 (20000): Guest Log: 00:00:00.000377 main     OS Version: #1 SMP Tue Oct 16 18:26:15 CEST 2018

2020-04-19 23:43:34 (20000): Guest Log: 00:00:00.000437 main     Executable: /usr/sbin/VBoxService

2020-04-19 23:43:34 (20000): Guest Log: 00:00:00.000439 main     Process ID: 3201

2020-04-19 23:43:34 (20000): Guest Log: 00:00:00.000440 main     Package type: LINUX_64BITS_GENERIC

2020-04-19 23:43:34 (20000): Guest Log: 00:00:00.007057 main     5.2.6 r120293 started. Verbose level = 0

2020-04-19 23:44:00 (20000): Guest Log: 23:43:58 CEST +02:00 2020-04-19: cranky: [INFO] Detected Theory App

2020-04-19 23:44:00 (20000): Guest Log: 23:43:58 CEST +02:00 2020-04-19: cranky: [INFO] Checking CVMFS.

2020-04-19 23:44:07 (20000): Guest Log: 23:44:05 CEST +02:00 2020-04-19: cranky: [INFO] Checking runc.

2020-04-19 23:44:07 (20000): Guest Log: 23:44:05 CEST +02:00 2020-04-19: cranky: [INFO] Creating the filesystem.

2020-04-19 23:44:07 (20000): Guest Log: 23:44:05 CEST +02:00 2020-04-19: cranky: [INFO] Using /cvmfs/cernvm-prod.cern.ch/cvm3

2020-04-19 23:44:07 (20000): Guest Log: 23:44:05 CEST +02:00 2020-04-19: cranky: [INFO] Updating config.json.

2020-04-19 23:44:08 (20000): Guest Log: 23:44:05 CEST +02:00 2020-04-19: cranky: [INFO] Running Container 'runc'.

2020-04-19 23:44:08 (20000): Guest Log: job: htmld=/shared/html/job

2020-04-19 23:44:08 (20000): Guest Log: job: unpack exitcode=0

2020-04-19 23:44:10 (20000): Guest Log: 23:44:07 CEST +02:00 2020-04-19: cranky: [INFO] ===> [runRivet] Sun Apr 19 21:44:06 UTC 2020 [boinc pp jets 7000 400 - pythia6 6.424 phard 100000 4]

2020-04-20 00:26:55 (20000): VM state change detected. (old = 'Running', new = 'Paused')
2020-04-27 23:03:41 (32348): Detected: vboxwrapper 26197
2020-04-27 23:03:41 (32348): Detected: BOINC client v7.7
2020-04-27 23:03:42 (32348): Detected: VirtualBox VboxManage Interface (Version: 5.2.8)
2020-04-27 23:03:42 (32348): Detected: Heartbeat check (file: 'heartbeat' every 1200.000000 seconds)
2020-04-27 23:03:42 (32348): Starting VM using VBoxManage interface. (boinc_81cd84d2db9fae86, slot#0)
2020-04-27 23:04:14 (32348): Error in start VM for VM: -2135228409
Command:
VBoxManage -q startvm "boinc_81cd84d2db9fae86" --type headless
Output:
VBoxManage.exe: error: The machine 'boinc_81cd84d2db9fae86' is already locked by a session (or being locked or unlocked)
VBoxManage.exe: error: Details: code VBOX_E_INVALID_OBJECT_STATE (0x80bb0007), component MachineWrap, interface IMachine, callee IUnknown
VBoxManage.exe: error: Context: "LaunchVMProcess(a->session, sessionType.raw(), Bstr(strEnv).raw(), progress.asOutParam())" at line 600 of file VBoxManageMisc.cpp

Notes:

Another VirtualBox management application has locked the session for
this VM. BOINC cannot properly monitor this VM
and so this job will be aborted.


2020-04-27 23:04:14 (32348): VM failed to start.
2020-04-27 23:04:14 (32348): Could not start 
2020-04-27 23:04:14 (32348): ERROR: VM failed to start
2020-04-27 23:04:19 (32348): 
   NOTE: VM session lock error encountered.
 		    BOINC will be notified that it needs to clean up the environment.
 		    This might be a temporary problem and so this job will be rescheduled for another time.

2020-04-27 23:04:25 (29012): Detected: vboxwrapper 26197
2020-04-27 23:04:25 (29012): Detected: BOINC client v7.7
2020-04-27 23:04:25 (29012): Detected: VirtualBox VboxManage Interface (Version: 5.2.8)
2020-04-27 23:04:25 (29012): Detected: Heartbeat check (file: 'heartbeat' every 1200.000000 seconds)
2020-04-27 23:04:26 (29012): Starting VM using VBoxManage interface. (boinc_81cd84d2db9fae86, slot#0)
2020-04-27 23:04:57 (29012): Error in start VM for VM: -2135228409
Command:
VBoxManage -q startvm "boinc_81cd84d2db9fae86" --type headless
Output:
VBoxManage.exe: error: The machine 'boinc_81cd84d2db9fae86' is already locked by a session (or being locked or unlocked)
VBoxManage.exe: error: Details: code VBOX_E_INVALID_OBJECT_STATE (0x80bb0007), component MachineWrap, interface IMachine, callee IUnknown
VBoxManage.exe: error: Context: "LaunchVMProcess(a->session, sessionType.raw(), Bstr(strEnv).raw(), progress.asOutParam())" at line 600 of file VBoxManageMisc.cpp

Notes:

Another VirtualBox management application has locked the session for
this VM. BOINC cannot properly monitor this VM
and so this job will be aborted.


2020-04-27 23:04:57 (29012): VM failed to start.
2020-04-27 23:04:57 (29012): Could not start 
2020-04-27 23:04:57 (29012): ERROR: VM failed to start
2020-04-27 23:05:02 (29012): 
   NOTE: VM session lock error encountered.
 		    BOINC will be notified that it needs to clean up the environment.
 		    This might be a temporary problem and so this job will be rescheduled for another time.

2020-04-29 01:43:04 (31924): Detected: vboxwrapper 26197
2020-04-29 01:43:04 (31924): Detected: BOINC client v7.7
2020-04-29 01:43:05 (31924): Detected: VirtualBox VboxManage Interface (Version: 5.2.8)
2020-04-29 01:43:05 (31924): Detected: Heartbeat check (file: 'heartbeat' every 1200.000000 seconds)
2020-04-29 01:43:06 (31924): Starting VM using VBoxManage interface. (boinc_81cd84d2db9fae86, slot#0)
2020-04-29 09:25:00 (31924): Error in start VM for VM: -2135228409
Command:
VBoxManage -q startvm "boinc_81cd84d2db9fae86" --type headless
Output:
VBoxManage.exe: error: The machine 'boinc_81cd84d2db9fae86' is already locked by a session (or being locked or unlocked)
VBoxManage.exe: error: Details: code VBOX_E_INVALID_OBJECT_STATE (0x80bb0007), component MachineWrap, interface IMachine, callee IUnknown
VBoxManage.exe: error: Context: "LaunchVMProcess(a->session, sessionType.raw(), Bstr(strEnv).raw(), progress.asOutParam())" at line 600 of file VBoxManageMisc.cpp

Notes:

Another VirtualBox management application has locked the session for
this VM. BOINC cannot properly monitor this VM
and so this job will be aborted.


2020-04-29 09:25:00 (31924): VM failed to start.
2020-04-29 09:25:00 (31924): Could not start 
2020-04-29 09:25:00 (31924): ERROR: VM failed to start
2020-04-29 09:25:05 (31924): 
   NOTE: VM session lock error encountered.
 		    BOINC will be notified that it needs to clean up the environment.
 		    This might be a temporary problem and so this job will be rescheduled for another time.

2020-04-30 09:25:25 (33116): Detected: vboxwrapper 26197
2020-04-30 09:25:25 (33116): Detected: BOINC client v7.7
2020-04-30 09:25:26 (33116): Detected: VirtualBox VboxManage Interface (Version: 5.2.8)
2020-04-30 09:25:27 (33116): Detected: Heartbeat check (file: 'heartbeat' every 1200.000000 seconds)
2020-04-30 09:25:28 (33116): Starting VM using VBoxManage interface. (boinc_81cd84d2db9fae86, slot#0)
2020-04-30 09:26:02 (33116): Error in start VM for VM: -2135228409
Command:
VBoxManage -q startvm "boinc_81cd84d2db9fae86" --type headless
Output:
VBoxManage.exe: error: The machine 'boinc_81cd84d2db9fae86' is already locked by a session (or being locked or unlocked)
VBoxManage.exe: error: Details: code VBOX_E_INVALID_OBJECT_STATE (0x80bb0007), component MachineWrap, interface IMachine, callee IUnknown
VBoxManage.exe: error: Context: "LaunchVMProcess(a->session, sessionType.raw(), Bstr(strEnv).raw(), progress.asOutParam())" at line 600 of file VBoxManageMisc.cpp

Notes:

Another VirtualBox management application has locked the session for
this VM. BOINC cannot properly monitor this VM
and so this job will be aborted.


2020-04-30 09:26:02 (33116): VM failed to start.
2020-04-30 09:26:02 (33116): Could not start 
2020-04-30 09:26:02 (33116): ERROR: VM failed to start
2020-04-30 09:26:07 (33116): 
   NOTE: VM session lock error encountered.
 		    BOINC will be notified that it needs to clean up the environment.
 		    This might be a temporary problem and so this job will be rescheduled for another time.

2020-05-01 03:11:48 (8372): Detected: vboxwrapper 26197
2020-05-01 03:11:48 (8372): Detected: BOINC client v7.7
2020-05-01 03:11:51 (8372): Detected: VirtualBox VboxManage Interface (Version: Unknown)
2020-05-01 03:11:52 (8372): Detected: Heartbeat check (file: 'heartbeat' every 1200.000000 seconds)
2020-05-01 03:11:52 (8372): Starting VM using VBoxManage interface. (boinc_81cd84d2db9fae86, slot#0)
2020-05-01 03:12:01 (8372): Successfully started VM. (PID = '6044')
2020-05-01 03:12:01 (8372): Reporting VM Process ID to BOINC.
2020-05-01 03:12:01 (8372): Guest Log: BIOS: VirtualBox 5.2.8

2020-05-01 03:12:01 (8372): Guest Log: CPUID EDX: 0x078bfbff

2020-05-01 03:12:01 (8372): Guest Log: BIOS: ata0-0: PCHS=16383/16/63 LCHS=1024/255/63

2020-05-01 03:12:01 (8372): VM state change detected. (old = 'PoweredOff', new = 'Running')
2020-05-01 03:12:01 (8372): Detected: Web Application Enabled (http://localhost:7311)
2020-05-01 03:12:01 (8372): Detected: Remote Desktop Enabled (localhost:7312)
2020-05-01 03:12:01 (8372): Preference change detected
2020-05-01 03:12:01 (8372): Setting CPU throttle for VM. (100%)
2020-05-01 03:12:01 (8372): Setting checkpoint interval to 600 seconds. (Higher value of (Preference: 60 seconds) or (Vbox_job.xml: 600 seconds))
2020-05-01 03:12:03 (8372): Guest Log: BIOS: Boot : bseqnr=1, bootseq=0032

2020-05-01 03:12:03 (8372): Guest Log: BIOS: Booting from Hard Disk...

2020-05-01 03:12:08 (8372): Guest Log: BIOS: KBD: unsupported int 16h function 03

2020-05-01 03:12:08 (8372): Guest Log: BIOS: AX=0305 BX=0000 CX=0000 DX=0000 

2020-05-01 03:12:46 (8372): Guest Log: vgdrvHeartbeatInit: Setting up heartbeat to trigger every 2000 milliseconds

2020-05-01 03:12:46 (8372): Guest Log: vboxguest: misc device minor 56, IRQ 20, I/O port d020, MMIO at 00000000f0400000 (size 0x400000)

2020-05-01 03:12:53 (8372): Guest Log: VBoxService 5.2.6 r120293 (verbosity: 0) linux.amd64 (Jan 15 2018 14:51:00) release log

2020-05-01 03:12:53 (8372): Guest Log: 00:00:00.000154 main     Log opened 2020-05-01T01:12:44.675404000Z

2020-05-01 03:12:53 (8372): Guest Log: 00:00:00.000315 main     OS Product: Linux

2020-05-01 03:12:53 (8372): Guest Log: 00:00:00.000357 main     OS Release: 4.14.76-13.cernvm.x86_64

2020-05-01 03:12:53 (8372): Guest Log: 00:00:00.000388 main     OS Version: #1 SMP Tue Oct 16 18:26:15 CEST 2018

2020-05-01 03:12:53 (8372): Guest Log: 00:00:00.000416 main     Executable: /usr/sbin/VBoxService

2020-05-01 03:12:53 (8372): Guest Log: 00:00:00.000417 main     Process ID: 3205

2020-05-01 03:12:53 (8372): Guest Log: 00:00:00.000418 main     Package type: LINUX_64BITS_GENERIC

2020-05-01 03:12:53 (8372): Guest Log: 00:00:00.006206 main     5.2.6 r120293 started. Verbose level = 0

2020-05-01 03:13:18 (8372): Guest Log: 03:13:10 CEST +02:00 2020-05-01: cranky: [INFO] Detected Theory App

2020-05-01 03:13:18 (8372): Guest Log: 03:13:10 CEST +02:00 2020-05-01: cranky: [INFO] Checking CVMFS.

2020-05-01 03:13:25 (8372): Guest Log: 03:13:16 CEST +02:00 2020-05-01: cranky: [INFO] Checking runc.

2020-05-01 03:13:25 (8372): Guest Log: 03:13:16 CEST +02:00 2020-05-01: cranky: [INFO] Creating the filesystem.

2020-05-01 03:13:25 (8372): Guest Log: 03:13:16 CEST +02:00 2020-05-01: cranky: [INFO] Using /cvmfs/cernvm-prod.cern.ch/cvm3

2020-05-01 03:13:25 (8372): Guest Log: 03:13:17 CEST +02:00 2020-05-01: cranky: [INFO] Updating config.json.

2020-05-01 03:13:25 (8372): Guest Log: 03:13:17 CEST +02:00 2020-05-01: cranky: [INFO] Running Container 'runc'.

2020-05-01 03:13:31 (8372): Guest Log: job: htmld=/shared/html/job

2020-05-01 03:13:31 (8372): Guest Log: job: unpack exitcode=0

2020-05-01 03:13:33 (8372): Guest Log: 03:13:25 CEST +02:00 2020-05-01: cranky: [INFO] ===> [runRivet] Fri May  1 01:13:23 UTC 2020 [boinc pp jets 7000 400 - pythia6 6.424 phard 100000 4]

2020-05-01 04:10:22 (8372): Status Report: Job Duration: '360000.000000'
2020-05-01 04:10:22 (8372): Status Report: Elapsed Time: '6000.981074'
2020-05-01 04:10:22 (8372): Status Report: CPU Time: '5713.458624'
2020-05-01 04:59:00 (8372): Guest Log: job: run exitcode=0

2020-05-01 04:59:00 (8372): Guest Log: job: diskusage=3544

2020-05-01 04:59:00 (8372): Guest Log: job: logsize=76 k

2020-05-01 04:59:00 (8372): Guest Log: job: times=

2020-05-01 04:59:00 (8372): Guest Log: 0m0.015s 0m0.016s

2020-05-01 04:59:00 (8372): Guest Log: 102m42.085s 0m55.493s

2020-05-01 04:59:00 (8372): Guest Log: job: cpuusage=6218

2020-05-01 04:59:00 (8372): Guest Log: 04:58:55 CEST +02:00 2020-05-01: cranky: [INFO] Container 'runc' finished with status code 0.

2020-05-01 04:59:00 (8372): Guest Log: 04:58:55 CEST +02:00 2020-05-01: cranky: [INFO] Preparing output.

2020-05-01 04:59:01 (8372): Guest Log: [INFO] Job Finished

2020-05-01 04:59:01 (8372): Guest Log: [INFO] Shutting Down.

2020-05-01 04:59:01 (8372): VM Completion File Detected.
2020-05-01 04:59:01 (8372): VM Completion Message: Job Finished
.
2020-05-01 04:59:01 (8372): Powering off VM.
2020-05-01 05:04:02 (8372): VM did not power off when requested.
2020-05-01 05:04:02 (8372): VM was successfully terminated.
2020-05-01 05:04:02 (8372): Deregistering VM. (boinc_81cd84d2db9fae86, slot#0)
2020-05-01 05:04:02 (8372): Removing VM from VirtualBox.
05:04:08 (8372): called boinc_finish(0)

</stderr_txt>
]]>

©2025 CERN