Stderr output

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

2020-10-11 18:27:03 (10760): Guest Log: CPUID EDX: 0x178bfbff

2020-10-11 18:27:03 (10760): Guest Log: BIOS: ata0-0: PCHS=16383/16/63 LCHS=1024/255/63

2020-10-11 18:27:03 (10760): VM state change detected. (old = 'PoweredOff', new = 'Running')
2020-10-11 18:27:03 (10760): Detected: Web Application Enabled (http://localhost:52869)
2020-10-11 18:27:03 (10760): Detected: Remote Desktop Enabled (localhost:52870)
2020-10-11 18:27:03 (10760): Preference change detected
2020-10-11 18:27:03 (10760): Setting CPU throttle for VM. (85%)
2020-10-11 18:27:03 (10760): Setting checkpoint interval to 1200 seconds. (Higher value of (Preference: 1200 seconds) or (Vbox_job.xml: 600 seconds))
2020-10-11 18:27:05 (10760): Guest Log: BIOS: Boot : bseqnr=1, bootseq=0032

2020-10-11 18:27:05 (10760): Guest Log: BIOS: Booting from Hard Disk...

2020-10-11 18:27:07 (10760): Guest Log: BIOS: KBD: unsupported int 16h function 03

2020-10-11 18:27:07 (10760): Guest Log: BIOS: AX=0305 BX=0000 CX=0000 DX=0000 

2020-10-11 18:27:26 (10760): Guest Log: vgdrvHeartbeatInit: Setting up heartbeat to trigger every 2000 milliseconds

2020-10-11 18:27:26 (10760): Guest Log: vboxguest: misc device minor 56, IRQ 20, I/O port d020, MMIO at 00000000f0400000 (size 0x400000)

2020-10-11 18:27:29 (10760): Guest Log: VBoxService 5.2.6 r120293 (verbosity: 0) linux.amd64 (Jan 15 2018 14:51:00) release log

2020-10-11 18:27:29 (10760): Guest Log: 00:00:00.000094 main     Log opened 2020-10-11T17:27:28.503566000Z

2020-10-11 18:27:29 (10760): Guest Log: 00:00:00.000228 main     OS Product: Linux

2020-10-11 18:27:29 (10760): Guest Log: 00:00:00.000289 main     OS Release: 4.14.76-13.cernvm.x86_64

2020-10-11 18:27:29 (10760): Guest Log: 00:00:00.000343 main     OS Version: #1 SMP Tue Oct 16 18:26:15 CEST 2018

2020-10-11 18:27:29 (10760): Guest Log: 00:00:00.000395 main     Executable: /usr/sbin/VBoxService

2020-10-11 18:27:29 (10760): Guest Log: 00:00:00.000396 main     Process ID: 3202

2020-10-11 18:27:29 (10760): Guest Log: 00:00:00.000397 main     Package type: LINUX_64BITS_GENERIC

2020-10-11 18:27:29 (10760): Guest Log: 00:00:00.003224 main     5.2.6 r120293 started. Verbose level = 0

2020-10-11 18:27:57 (10760): Guest Log: 18:27:57 BST +01:00 2020-10-11: cranky: [INFO] Detected Theory App

2020-10-11 18:27:57 (10760): Guest Log: 18:27:57 BST +01:00 2020-10-11: cranky: [INFO] Checking CVMFS.

2020-10-11 18:27:58 (10760): Guest Log: Probing /cvmfs/sft.cern.ch... OK

2020-10-11 18:27:59 (10760): 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-10-11 18:27:59 (10760): Guest Log: 2.5.2.0 4053 0 28496 19087 3 1 264356 4096000 0 65024 0 0 n/a 5 5 http://s1cern-cvmfs.openhtc.io/cvmfs/sft.cern.ch DIRECT 1

2020-10-11 18:27:59 (10760): Guest Log: Probing /cvmfs/grid.cern.ch... OK

2020-10-11 18:28:00 (10760): 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-10-11 18:28:00 (10760): Guest Log: 2.5.2.0 4031 0 25516 13427 3 2 264356 4096000 0 65024 0 2 -100 6411 2044 http://s1ral-cvmfs.openhtc.io/cvmfs/grid.cern.ch DIRECT 1

2020-10-11 18:28:00 (10760): Guest Log: Probing /cvmfs/cernvm-prod.cern.ch... OK

2020-10-11 18:28:01 (10760): 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-10-11 18:28:01 (10760): Guest Log: 2.5.2.0 4100 0 25152 259 3 1 264356 4096000 0 65024 0 0 n/a 4 1 http://s1ral-cvmfs.openhtc.io/cvmfs/cernvm-prod.cern.ch DIRECT 1

2020-10-11 18:28:01 (10760): Guest Log: Probing /cvmfs/alice.cern.ch... OK

2020-10-11 18:28:03 (10760): 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-10-11 18:28:03 (10760): Guest Log: 2.5.2.0 4060 0 31164 7668 3 1 264356 4096000 0 65024 0 0 n/a 4427 1643 http://s1asgc-cvmfs.openhtc.io:8080/cvmfs/alice.cern.ch DIRECT 1

2020-10-11 18:28:03 (10760): Guest Log: 18:28:02 BST +01:00 2020-10-11: cranky: [INFO] Checking runc.

2020-10-11 18:28:03 (10760): Guest Log: 18:28:02 BST +01:00 2020-10-11: cranky: [INFO] Creating the filesystem.

2020-10-11 18:28:03 (10760): Guest Log: 18:28:02 BST +01:00 2020-10-11: cranky: [INFO] Using /cvmfs/cernvm-prod.cern.ch/cvm3

2020-10-11 18:28:03 (10760): Guest Log: 18:28:02 BST +01:00 2020-10-11: cranky: [INFO] Updating config.json.

2020-10-11 18:28:03 (10760): Guest Log: 18:28:02 BST +01:00 2020-10-11: cranky: [INFO] Running Container 'runc'.

2020-10-11 18:28:06 (10760): Guest Log: job: htmld=/shared/html/job

2020-10-11 18:28:06 (10760): Guest Log: job: unpack exitcode=0

2020-10-11 18:28:07 (10760): Guest Log: 18:28:06 BST +01:00 2020-10-11: cranky: [INFO] ===> [runRivet] Sun Oct 11 17:28:06 UTC 2020 [boinc pp jets 8000 25 - pythia8 8.235 tune-A2 100000 52]

2020-10-11 20:07:10 (10760): Status Report: Job Duration: '864000.000000'
2020-10-11 20:07:10 (10760): Status Report: Elapsed Time: '6000.000000'
2020-10-11 20:07:10 (10760): Status Report: CPU Time: '3866.406250'
2020-10-11 21:14:02 (10760): Stopping VM.
2020-10-23 15:37:47 (12036): Detected: vboxwrapper 26197
2020-10-23 15:37:47 (12036): Detected: BOINC client v7.7
2020-10-23 15:37:48 (12036): Detected: VirtualBox VboxManage Interface (Version: 6.1.12)
2020-10-23 15:37:48 (12036): Detected: Heartbeat check (file: 'heartbeat' every 1200.000000 seconds)
2020-10-23 15:37:48 (12036): Starting VM using VBoxManage interface. (boinc_e1e785355d59964e, slot#14)
2020-10-23 15:37:59 (12036): Successfully started VM. (PID = '18456')
2020-10-23 15:37:59 (12036): Reporting VM Process ID to BOINC.
2020-10-23 15:37:59 (12036): Guest Log: 02:46:34.116390 timesync vgsvcTimeSyncWorker: Radical host time change: 1 016 646 110 000 000ns (HostNow=1 603 463 878 728 000 000 ns HostLast=1 602 447 232 618 000 000 ns)

2020-10-23 15:37:59 (12036): VM state change detected. (old = 'PoweredOff', new = 'Running')
2020-10-23 15:37:59 (12036): Detected: Web Application Enabled (http://localhost:52869)
2020-10-23 15:37:59 (12036): Detected: Remote Desktop Enabled (localhost:52870)
2020-10-23 15:38:00 (12036): VM state change detected. (old = 'Running', new = 'Paused')
2020-10-23 15:38:06 (12036): Status Report: Job Duration: '864000.000000'
2020-10-23 15:38:06 (12036): Status Report: Elapsed Time: '9997.000000'
2020-10-23 15:38:06 (12036): Status Report: CPU Time: '7448.546875'
2020-10-23 15:38:06 (12036): Preference change detected
2020-10-23 15:38:06 (12036): Setting CPU throttle for VM. (85%)
2020-10-23 15:38:06 (12036): Setting checkpoint interval to 1200 seconds. (Higher value of (Preference: 1200 seconds) or (Vbox_job.xml: 600 seconds))
2020-10-23 15:38:06 (12036): VM state change detected. (old = 'Paused', new = 'Running')
2020-10-23 15:38:16 (12036): Guest Log: 02:46:44.142738 timesync vgsvcTimeSyncWorker: Radical guest time change: 1 016 646 246 632 000ns (GuestNow=1 603 463 888 798 929 000 ns GuestLast=1 602 447 242 552 297 000 ns fSetTimeLastLoop=true )

2020-10-23 15:47:06 (12036): Stopping VM.
2020-10-23 17:47:21 (15364): Detected: vboxwrapper 26197
2020-10-23 17:47:21 (15364): Detected: BOINC client v7.7
2020-10-23 17:47:21 (15364): Detected: VirtualBox VboxManage Interface (Version: 6.1.12)
2020-10-23 17:47:22 (15364): Detected: Heartbeat check (file: 'heartbeat' every 1200.000000 seconds)
2020-10-23 17:47:22 (15364): Starting VM using VBoxManage interface. (boinc_e1e785355d59964e, slot#14)
2020-10-23 17:47:30 (15364): Successfully started VM. (PID = '17200')
2020-10-23 17:47:30 (15364): Reporting VM Process ID to BOINC.
2020-10-23 17:47:30 (15364): Guest Log: 02:55:34.397201 timesync vgsvcTimeSyncWorker: Radical host time change: 7 233 064 000 000ns (HostNow=1 603 471 649 973 000 000 ns HostLast=1 603 464 416 909 000 000 ns)

2020-10-23 17:47:30 (15364): VM state change detected. (old = 'PoweredOff', new = 'Running')
2020-10-23 17:47:30 (15364): Detected: Web Application Enabled (http://localhost:52869)
2020-10-23 17:47:30 (15364): Detected: Remote Desktop Enabled (localhost:52870)
2020-10-23 17:47:30 (15364): Status Report: Job Duration: '864000.000000'
2020-10-23 17:47:30 (15364): Status Report: Elapsed Time: '10519.329058'
2020-10-23 17:47:30 (15364): Status Report: CPU Time: '7925.640625'
2020-10-23 17:47:30 (15364): Preference change detected
2020-10-23 17:47:30 (15364): Setting CPU throttle for VM. (85%)
2020-10-23 17:47:31 (15364): Setting checkpoint interval to 1200 seconds. (Higher value of (Preference: 1200 seconds) or (Vbox_job.xml: 600 seconds))
2020-10-23 17:47:40 (15364): Guest Log: 02:55:44.398574 timesync vgsvcTimeSyncWorker: Radical guest time change: 7 240 921 023 000ns (GuestNow=1 603 471 659 974 399 000 ns GuestLast=1 603 464 419 053 376 000 ns fSetTimeLastLoop=true )

2020-10-23 18:45:53 (15364): Stopping VM.
2020-10-23 18:49:27 (16012): Detected: vboxwrapper 26197
2020-10-23 18:49:27 (16012): Detected: BOINC client v7.7
2020-10-23 18:49:28 (16012): Detected: VirtualBox VboxManage Interface (Version: 6.1.12)
2020-10-23 18:49:28 (16012): Detected: Heartbeat check (file: 'heartbeat' every 1200.000000 seconds)
2020-10-23 18:49:28 (16012): Starting VM using VBoxManage interface. (boinc_e1e785355d59964e, slot#14)
2020-10-23 18:49:36 (16012): Successfully started VM. (PID = '16404')
2020-10-23 18:49:36 (16012): Reporting VM Process ID to BOINC.
2020-10-23 18:49:36 (16012): VM state change detected. (old = 'PoweredOff', new = 'Running')
2020-10-23 18:49:36 (16012): Detected: Web Application Enabled (http://localhost:52869)
2020-10-23 18:49:36 (16012): Detected: Remote Desktop Enabled (localhost:52870)
2020-10-23 18:49:36 (16012): Status Report: Job Duration: '864000.000000'
2020-10-23 18:49:36 (16012): Status Report: Elapsed Time: '14001.485329'
2020-10-23 18:49:36 (16012): Status Report: CPU Time: '11017.312500'
2020-10-23 18:49:36 (16012): Preference change detected
2020-10-23 18:49:36 (16012): Setting CPU throttle for VM. (85%)
2020-10-23 18:49:36 (16012): Setting checkpoint interval to 1200 seconds. (Higher value of (Preference: 1200 seconds) or (Vbox_job.xml: 600 seconds))
2020-10-23 20:13:55 (16012): Stopping VM.
2020-10-24 18:21:06 (17788): Detected: vboxwrapper 26197
2020-10-24 18:21:06 (17788): Detected: BOINC client v7.7
2020-10-24 18:21:07 (17788): Detected: VirtualBox VboxManage Interface (Version: 6.1.12)
2020-10-24 18:21:07 (17788): Detected: Heartbeat check (file: 'heartbeat' every 1200.000000 seconds)
2020-10-24 18:21:08 (17788): Starting VM using VBoxManage interface. (boinc_e1e785355d59964e, slot#14)
2020-10-24 18:21:16 (17788): Successfully started VM. (PID = '17264')
2020-10-24 18:21:16 (17788): Reporting VM Process ID to BOINC.
2020-10-24 18:21:16 (17788): VM state change detected. (old = 'PoweredOff', new = 'Running')
2020-10-24 18:21:16 (17788): Detected: Web Application Enabled (http://localhost:52869)
2020-10-24 18:21:16 (17788): Detected: Remote Desktop Enabled (localhost:52870)
2020-10-24 18:21:16 (17788): Status Report: Job Duration: '864000.000000'
2020-10-24 18:21:16 (17788): Status Report: Elapsed Time: '19029.485329'
2020-10-24 18:21:16 (17788): Status Report: CPU Time: '15553.656250'
2020-10-24 18:21:16 (17788): Preference change detected
2020-10-24 18:21:16 (17788): Setting CPU throttle for VM. (85%)
2020-10-24 18:21:16 (17788): Setting checkpoint interval to 1200 seconds. (Higher value of (Preference: 1200 seconds) or (Vbox_job.xml: 600 seconds))
2020-10-24 18:21:24 (17788): Guest Log: 05:18:28.515874 timesync vgsvcTimeSyncWorker: Radical host time change: 79 649 149 000 000ns (HostNow=1 603 560 084 238 000 000 ns HostLast=1 603 480 435 089 000 000 ns)

2020-10-24 18:21:34 (17788): Guest Log: 05:18:38.517248 timesync vgsvcTimeSyncWorker: Radical guest time change: 79 649 217 125 000ns (GuestNow=1 603 560 094 239 394 000 ns GuestLast=1 603 480 445 022 269 000 ns fSetTimeLastLoop=true )

2020-10-24 20:01:39 (17788): Status Report: Job Duration: '864000.000000'
2020-10-24 20:01:39 (17788): Status Report: Elapsed Time: '25029.485329'
2020-10-24 20:01:39 (17788): Status Report: CPU Time: '20917.921875'
2020-10-24 21:01:28 (17788): Guest Log: job: run exitcode=0

2020-10-24 21:01:28 (17788): Guest Log: job: diskusage=3012

2020-10-24 21:01:28 (17788): Guest Log: job: logsize=80 k

2020-10-24 21:01:28 (17788): Guest Log: job: times=

2020-10-24 21:01:28 (17788): Guest Log: 0m0.011s 0m0.009s

2020-10-24 21:01:28 (17788): Guest Log: 443m22.891s 2m14.922s

2020-10-24 21:01:28 (17788): Guest Log: job: cpuusage=26738

2020-10-24 21:01:28 (17788): Guest Log: 21:01:27 BST +01:00 2020-10-24: cranky: [INFO] Container 'runc' finished with status code 0.

2020-10-24 21:01:28 (17788): Guest Log: 21:01:27 BST +01:00 2020-10-24: cranky: [INFO] Preparing output.

2020-10-24 21:01:33 (17788): Guest Log: [INFO] Job Finished

2020-10-24 21:01:33 (17788): Guest Log: [INFO] Shutting Down.

2020-10-24 21:01:33 (17788): VM Completion File Detected.
2020-10-24 21:01:33 (17788): VM Completion Message: Job Finished
.
2020-10-24 21:01:33 (17788): Powering off VM.
2020-10-24 21:06:33 (17788): VM did not power off when requested.
2020-10-24 21:06:33 (17788): VM was successfully terminated.
2020-10-24 21:06:33 (17788): Deregistering VM. (boinc_e1e785355d59964e, slot#14)
2020-10-24 21:06:34 (17788): Removing network bandwidth throttle group from VM.
2020-10-24 21:06:34 (17788): Removing VM from VirtualBox.
21:06:39 (17788): called boinc_finish(0)

</stderr_txt>
]]>

©2025 CERN