Stderr output

<core_client_version>7.16.7</core_client_version>
<![CDATA[
<stderr_txt>
2020-10-15 02:45:16 (2068): Detected: vboxwrapper 26197
2020-10-15 02:45:16 (2068): Detected: BOINC client v7.7
2020-10-15 02:45:17 (2068): Detected: VirtualBox VboxManage Interface (Version: 6.1.4)
2020-10-15 02:45:17 (2068): Detected: Heartbeat check (file: 'heartbeat' every 1200.000000 seconds)
2020-10-15 02:45:18 (2068): Successfully copied 'init_data.xml' to the shared directory.
2020-10-15 02:45:18 (2068): Successfully copied 'input' to the shared directory.
2020-10-15 02:45:19 (2068): Create VM. (boinc_db8f057743710ad6, slot#7)
2020-10-15 02:45:20 (2068): Setting Memory Size for VM. (630MB)
2020-10-15 02:45:20 (2068): Setting CPU Count for VM. (1)
2020-10-15 02:45:20 (2068): Setting Chipset Options for VM.
2020-10-15 02:45:21 (2068): Setting Boot Options for VM.
2020-10-15 02:45:21 (2068): Setting Network Configuration for NAT.
2020-10-15 02:45:21 (2068): Enabling VM Network Access.
2020-10-15 02:45:22 (2068): Disabling USB Support for VM.
2020-10-15 02:45:22 (2068): Disabling COM Port Support for VM.
2020-10-15 02:45:22 (2068): Disabling LPT Port Support for VM.
2020-10-15 02:45:23 (2068): Disabling Audio Support for VM.
2020-10-15 02:45:23 (2068): Disabling Clipboard Support for VM.
2020-10-15 02:45:23 (2068): Disabling Drag and Drop Support for VM.
2020-10-15 02:45:23 (2068): Adding storage controller(s) to VM.
2020-10-15 02:45:24 (2068): Adding virtual disk drive to VM. (vm_image.vdi)
2020-10-15 02:45:24 (2068): Adding VirtualBox Guest Additions to VM.
2020-10-15 02:45:24 (2068): Adding network bandwidth throttle group to VM. (Defaulting to 1024GB)
2020-10-15 02:45:24 (2068): forwarding host port 49861 to guest port 80
2020-10-15 02:45:25 (2068): Enabling remote desktop for VM.
2020-10-15 02:45:25 (2068): Required extension pack not installed, remote desktop not enabled.
2020-10-15 02:45:25 (2068): Enabling shared directory for VM.
2020-10-15 02:45:25 (2068): Starting VM using VBoxManage interface. (boinc_db8f057743710ad6, slot#7)
2020-10-15 02:45:31 (2068): Successfully started VM. (PID = '14672')
2020-10-15 02:45:31 (2068): Reporting VM Process ID to BOINC.
2020-10-15 02:45:31 (2068): Guest Log: BIOS: VirtualBox 6.1.4

2020-10-15 02:45:31 (2068): Guest Log: CPUID EDX: 0x178bfbff

2020-10-15 02:45:31 (2068): Guest Log: BIOS: ata0-0: PCHS=16383/16/63 LCHS=1024/255/63

2020-10-15 02:45:31 (2068): VM state change detected. (old = 'PoweredOff', new = 'Running')
2020-10-15 02:45:31 (2068): Detected: Web Application Enabled (http://localhost:49861)
2020-10-15 02:45:31 (2068): Preference change detected
2020-10-15 02:45:31 (2068): Setting CPU throttle for VM. (100%)
2020-10-15 02:45:31 (2068): Setting checkpoint interval to 600 seconds. (Higher value of (Preference: 60 seconds) or (Vbox_job.xml: 600 seconds))
2020-10-15 02:45:33 (2068): Guest Log: BIOS: Boot : bseqnr=1, bootseq=0032

2020-10-15 02:45:33 (2068): Guest Log: BIOS: Booting from Hard Disk...

2020-10-15 02:45:36 (2068): Guest Log: BIOS: KBD: unsupported int 16h function 03

2020-10-15 02:45:36 (2068): Guest Log: BIOS: AX=0305 BX=0000 CX=0000 DX=0000 

2020-10-15 02:46:12 (2068): Guest Log: vgdrvHeartbeatInit: Setting up heartbeat to trigger every 2000 milliseconds

2020-10-15 02:46:12 (2068): Guest Log: vboxguest: misc device minor 56, IRQ 20, I/O port d020, MMIO at 00000000f0400000 (size 0x400000)

2020-10-15 02:46:16 (2068): Guest Log: VBoxService 5.2.6 r120293 (verbosity: 0) linux.amd64 (Jan 15 2018 14:51:00) release log

2020-10-15 02:46:16 (2068): Guest Log: 00:00:00.021689 main     Log opened 2020-10-15T00:46:15.241874000Z

2020-10-15 02:46:16 (2068): Guest Log: 00:00:00.023987 main     OS Product: Linux

2020-10-15 02:46:16 (2068): Guest Log: 00:00:00.024497 main     OS Release: 4.14.76-13.cernvm.x86_64

2020-10-15 02:46:16 (2068): Guest Log: 00:00:00.025175 main     OS Version: #1 SMP Tue Oct 16 18:26:15 CEST 2018

2020-10-15 02:46:16 (2068): Guest Log: 00:00:00.025577 main     Executable: /usr/sbin/VBoxService

2020-10-15 02:46:16 (2068): Guest Log: 00:00:00.025579 main     Process ID: 3203

2020-10-15 02:46:16 (2068): Guest Log: 00:00:00.025581 main     Package type: LINUX_64BITS_GENERIC

2020-10-15 02:46:16 (2068): Guest Log: 00:00:00.033703 main     5.2.6 r120293 started. Verbose level = 0

2020-10-15 02:46:59 (2068): Guest Log: 02:46:57 CEST +02:00 2020-10-15: cranky: [INFO] Detected Theory App

2020-10-15 02:46:59 (2068): Guest Log: 02:46:57 CEST +02:00 2020-10-15: cranky: [INFO] Checking CVMFS.

2020-10-15 02:47:00 (2068): Guest Log: Probing /cvmfs/sft.cern.ch... OK

2020-10-15 02:47:01 (2068): 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-15 02:47:01 (2068): Guest Log: 2.5.2.0 4120 0 28348 19103 3 1 264405 4096000 0 65024 0 0 n/a 5 4 http://s1ral-cvmfs.openhtc.io/cvmfs/sft.cern.ch DIRECT 1

2020-10-15 02:47:02 (2068): Guest Log: Probing /cvmfs/grid.cern.ch... OK

2020-10-15 02:47:03 (2068): 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-15 02:47:03 (2068): Guest Log: 2.5.2.0 4037 0 27540 13453 3 2 264405 4096000 0 65024 0 2 -100 6411 4608 http://s1cern-cvmfs.openhtc.io/cvmfs/grid.cern.ch DIRECT 1

2020-10-15 02:47:04 (2068): Guest Log: Probing /cvmfs/cernvm-prod.cern.ch... OK

2020-10-15 02:47:05 (2068): 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-15 02:47:05 (2068): Guest Log: 2.5.2.0 4091 0 27344 259 3 1 264405 4096000 0 65024 0 0 n/a 4 4 http://s1cern-cvmfs.openhtc.io/cvmfs/cernvm-prod.cern.ch DIRECT 1

2020-10-15 02:47:06 (2068): Guest Log: Probing /cvmfs/alice.cern.ch... OK

2020-10-15 02:47:07 (2068): 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-15 02:47:07 (2068): Guest Log: 2.5.2.0 4064 0 30196 7702 3 1 264405 4096000 0 65024 0 0 n/a 4448 2373 http://s1unl-cvmfs.openhtc.io/cvmfs/alice.cern.ch DIRECT 1

2020-10-15 02:47:07 (2068): Guest Log: 02:47:05 CEST +02:00 2020-10-15: cranky: [INFO] Checking runc.

2020-10-15 02:47:07 (2068): Guest Log: 02:47:05 CEST +02:00 2020-10-15: cranky: [INFO] Creating the filesystem.

2020-10-15 02:47:07 (2068): Guest Log: 02:47:05 CEST +02:00 2020-10-15: cranky: [INFO] Using /cvmfs/cernvm-prod.cern.ch/cvm3

2020-10-15 02:47:07 (2068): Guest Log: 02:47:06 CEST +02:00 2020-10-15: cranky: [INFO] Updating config.json.

2020-10-15 02:47:07 (2068): Guest Log: 02:47:06 CEST +02:00 2020-10-15: cranky: [INFO] Running Container 'runc'.

2020-10-15 02:47:09 (2068): Guest Log: job: htmld=/shared/html/job

2020-10-15 02:47:09 (2068): Guest Log: job: unpack exitcode=0

2020-10-15 02:47:09 (2068): Guest Log: 02:47:08 CEST +02:00 2020-10-15: cranky: [INFO] ===> [runRivet] Thu Oct 15 00:47:08 UTC 2020 [boinc pp jets 7000 100 - pythia8 8.301 tune-AU2 100000 50]

2020-10-15 03:49:05 (2068): Stopping VM.
2020-10-15 18:54:50 (7812): Detected: vboxwrapper 26197
2020-10-15 18:54:50 (7812): Detected: BOINC client v7.7
2020-10-15 18:54:51 (7812): Detected: VirtualBox VboxManage Interface (Version: 6.1.4)
2020-10-15 18:54:51 (7812): Detected: Heartbeat check (file: 'heartbeat' every 1200.000000 seconds)
2020-10-15 18:54:51 (7812): Starting VM using VBoxManage interface. (boinc_db8f057743710ad6, slot#7)
2020-10-15 18:55:01 (7812): Successfully started VM. (PID = '5440')
2020-10-15 18:55:01 (7812): Reporting VM Process ID to BOINC.
2020-10-15 18:55:01 (7812): Guest Log: 01:02:51.336853 timesync vgsvcTimeSyncWorker: Radical host time change: 54 364 606 000 000ns (HostNow=1 602 780 901 029 000 000 ns HostLast=1 602 726 536 423 000 000 ns)

2020-10-15 18:55:01 (7812): VM state change detected. (old = 'PoweredOff', new = 'Running')
2020-10-15 18:55:01 (7812): Detected: Web Application Enabled (http://localhost:49861)
2020-10-15 18:55:01 (7812): Preference change detected
2020-10-15 18:55:01 (7812): Setting CPU throttle for VM. (100%)
2020-10-15 18:55:02 (7812): Setting checkpoint interval to 600 seconds. (Higher value of (Preference: 60 seconds) or (Vbox_job.xml: 600 seconds))
2020-10-15 18:55:11 (7812): Guest Log: 01:03:01.376252 timesync vgsvcTimeSyncWorker: Radical guest time change: 54 364 695 243 000ns (GuestNow=1 602 780 911 119 755 000 ns GuestLast=1 602 726 546 424 512 000 ns fSetTimeLastLoop=true )

2020-10-15 19:31:48 (7812): Status Report: Job Duration: '864000.000000'
2020-10-15 19:31:48 (7812): Status Report: Elapsed Time: '6000.000000'
2020-10-15 19:31:48 (7812): Status Report: CPU Time: '5610.218750'
2020-10-15 19:55:33 (7812): Stopping VM.
2020-10-15 21:43:18 (12500): Detected: vboxwrapper 26197
2020-10-15 21:43:18 (12500): Detected: BOINC client v7.7
2020-10-15 21:43:19 (12500): Detected: VirtualBox VboxManage Interface (Version: 6.1.4)
2020-10-15 21:43:19 (12500): Detected: Heartbeat check (file: 'heartbeat' every 1200.000000 seconds)
2020-10-15 21:43:20 (12500): Starting VM using VBoxManage interface. (boinc_db8f057743710ad6, slot#7)
2020-10-15 21:43:32 (12500): Successfully started VM. (PID = '2680')
2020-10-15 21:43:32 (12500): Reporting VM Process ID to BOINC.
2020-10-15 21:43:32 (12500): VM state change detected. (old = 'PoweredOff', new = 'Running')
2020-10-15 21:43:32 (12500): Detected: Web Application Enabled (http://localhost:49861)
2020-10-15 21:43:32 (12500): Status Report: Job Duration: '864000.000000'
2020-10-15 21:43:32 (12500): Status Report: Elapsed Time: '7421.000000'
2020-10-15 21:43:32 (12500): Status Report: CPU Time: '7024.437500'
2020-10-15 21:43:32 (12500): Preference change detected
2020-10-15 21:43:32 (12500): Setting CPU throttle for VM. (100%)
2020-10-15 21:43:33 (12500): Setting checkpoint interval to 600 seconds. (Higher value of (Preference: 60 seconds) or (Vbox_job.xml: 600 seconds))
2020-10-15 21:43:39 (12500): Guest Log: 02:03:32.592283 timesync vgsvcTimeSyncWorker: Radical host time change: 6 487 088 000 000ns (HostNow=1 602 791 019 505 000 000 ns HostLast=1 602 784 532 417 000 000 ns)

2020-10-15 21:43:49 (12500): Guest Log: 02:03:42.594224 timesync vgsvcTimeSyncWorker: Radical guest time change: 6 487 171 241 000ns (GuestNow=1 602 791 029 506 966 000 ns GuestLast=1 602 784 542 335 725 000 ns fSetTimeLastLoop=true )

2020-10-15 22:44:14 (12500): Stopping VM.
2020-10-16 12:09:37 (13180): Detected: vboxwrapper 26197
2020-10-16 12:09:37 (13180): Detected: BOINC client v7.7
2020-10-16 12:09:38 (13180): Detected: VirtualBox VboxManage Interface (Version: 6.1.4)
2020-10-16 12:09:38 (13180): Detected: Heartbeat check (file: 'heartbeat' every 1200.000000 seconds)
2020-10-16 12:09:38 (13180): Starting VM using VBoxManage interface. (boinc_db8f057743710ad6, slot#7)
2020-10-16 12:09:48 (13180): Successfully started VM. (PID = '6952')
2020-10-16 12:09:48 (13180): Reporting VM Process ID to BOINC.
2020-10-16 12:09:48 (13180): VM state change detected. (old = 'PoweredOff', new = 'Running')
2020-10-16 12:09:48 (13180): Detected: Web Application Enabled (http://localhost:49861)
2020-10-16 12:09:48 (13180): Status Report: Job Duration: '864000.000000'
2020-10-16 12:09:48 (13180): Status Report: Elapsed Time: '11057.000000'
2020-10-16 12:09:48 (13180): Status Report: CPU Time: '10654.046875'
2020-10-16 12:09:48 (13180): Preference change detected
2020-10-16 12:09:48 (13180): Setting CPU throttle for VM. (100%)
2020-10-16 12:09:49 (13180): Setting checkpoint interval to 600 seconds. (Higher value of (Preference: 60 seconds) or (Vbox_job.xml: 600 seconds))
2020-10-16 12:09:53 (13180): Guest Log: 03:04:13.710546 timesync vgsvcTimeSyncWorker: Radical host time change: 48 342 359 000 000ns (HostNow=1 602 842 992 980 000 000 ns HostLast=1 602 794 650 621 000 000 ns)

2020-10-16 12:10:03 (13180): Guest Log: 03:04:23.711558 timesync vgsvcTimeSyncWorker: Radical guest time change: 48 342 357 778 000ns (GuestNow=1 602 843 002 981 039 000 ns GuestLast=1 602 794 660 623 261 000 ns fSetTimeLastLoop=true )

2020-10-16 13:08:23 (13180): Preference change detected
2020-10-16 13:08:23 (13180): Setting CPU throttle for VM. (100%)
2020-10-16 13:08:23 (13180): Setting checkpoint interval to 600 seconds. (Higher value of (Preference: 60 seconds) or (Vbox_job.xml: 600 seconds))
2020-10-16 13:09:13 (13180): Preference change detected
2020-10-16 13:09:13 (13180): Setting CPU throttle for VM. (100%)
2020-10-16 13:09:13 (13180): Setting checkpoint interval to 600 seconds. (Higher value of (Preference: 60 seconds) or (Vbox_job.xml: 600 seconds))
2020-10-16 13:10:36 (13180): Preference change detected
2020-10-16 13:10:36 (13180): Setting CPU throttle for VM. (100%)
2020-10-16 13:10:36 (13180): Setting checkpoint interval to 600 seconds. (Higher value of (Preference: 60 seconds) or (Vbox_job.xml: 600 seconds))
2020-10-16 13:49:57 (13180): Status Report: Job Duration: '864000.000000'
2020-10-16 13:49:57 (13180): Status Report: Elapsed Time: '17057.028027'
2020-10-16 13:49:57 (13180): Status Report: CPU Time: '16656.968750'
2020-10-16 15:30:04 (13180): Status Report: Job Duration: '864000.000000'
2020-10-16 15:30:04 (13180): Status Report: Elapsed Time: '23057.028027'
2020-10-16 15:30:04 (13180): Status Report: CPU Time: '22661.843750'
2020-10-16 17:10:08 (13180): Status Report: Job Duration: '864000.000000'
2020-10-16 17:10:08 (13180): Status Report: Elapsed Time: '29057.028027'
2020-10-16 17:10:08 (13180): Status Report: CPU Time: '28665.953125'
2020-10-16 18:50:16 (13180): Status Report: Job Duration: '864000.000000'
2020-10-16 18:50:16 (13180): Status Report: Elapsed Time: '35057.028027'
2020-10-16 18:50:16 (13180): Status Report: CPU Time: '34660.687500'
2020-10-16 20:30:24 (13180): Status Report: Job Duration: '864000.000000'
2020-10-16 20:30:24 (13180): Status Report: Elapsed Time: '41057.028027'
2020-10-16 20:30:24 (13180): Status Report: CPU Time: '40651.343750'
2020-10-16 22:10:32 (13180): Status Report: Job Duration: '864000.000000'
2020-10-16 22:10:32 (13180): Status Report: Elapsed Time: '47057.028027'
2020-10-16 22:10:32 (13180): Status Report: CPU Time: '46642.343750'
2020-10-16 23:50:39 (13180): Status Report: Job Duration: '864000.000000'
2020-10-16 23:50:39 (13180): Status Report: Elapsed Time: '53057.028027'
2020-10-16 23:50:39 (13180): Status Report: CPU Time: '52631.218750'
2020-10-17 01:30:44 (13180): Status Report: Job Duration: '864000.000000'
2020-10-17 01:30:44 (13180): Status Report: Elapsed Time: '59057.028027'
2020-10-17 01:30:44 (13180): Status Report: CPU Time: '58633.015625'
2020-10-17 03:10:50 (13180): Status Report: Job Duration: '864000.000000'
2020-10-17 03:10:50 (13180): Status Report: Elapsed Time: '65057.028027'
2020-10-17 03:10:50 (13180): Status Report: CPU Time: '64638.296875'
2020-10-17 04:50:56 (13180): Status Report: Job Duration: '864000.000000'
2020-10-17 04:50:56 (13180): Status Report: Elapsed Time: '71057.028027'
2020-10-17 04:50:56 (13180): Status Report: CPU Time: '70643.109375'
2020-10-17 06:31:02 (13180): Status Report: Job Duration: '864000.000000'
2020-10-17 06:31:02 (13180): Status Report: Elapsed Time: '77057.028027'
2020-10-17 06:31:02 (13180): Status Report: CPU Time: '76647.984375'
2020-10-17 08:11:07 (13180): Status Report: Job Duration: '864000.000000'
2020-10-17 08:11:07 (13180): Status Report: Elapsed Time: '83057.028027'
2020-10-17 08:11:07 (13180): Status Report: CPU Time: '82652.625000'
2020-10-17 08:31:13 (13180): Guest Log: job: run exitcode=0

2020-10-17 08:31:13 (13180): Guest Log: job: diskusage=6972

2020-10-17 08:31:13 (13180): Guest Log: job: logsize=112 k

2020-10-17 08:31:13 (13180): Guest Log: job: times=

2020-10-17 08:31:13 (13180): Guest Log: 0m0.008s 0m0.024s

2020-10-17 08:31:13 (13180): Guest Log: 1378m18.479s 7m33.436s

2020-10-17 08:31:13 (13180): Guest Log: job: cpuusage=83152

2020-10-17 08:31:14 (13180): Guest Log: 08:31:14 CEST +02:00 2020-10-17: cranky: [INFO] Container 'runc' finished with status code 0.

2020-10-17 08:31:14 (13180): Guest Log: 08:31:14 CEST +02:00 2020-10-17: cranky: [INFO] Preparing output.

2020-10-17 08:31:15 (13180): Guest Log: [INFO] Job Finished

2020-10-17 08:31:15 (13180): Guest Log: [INFO] Shutting Down.

2020-10-17 08:31:15 (13180): VM Completion File Detected.
2020-10-17 08:31:15 (13180): VM Completion Message: Job Finished
.
2020-10-17 08:31:15 (13180): Powering off VM.
2020-10-17 08:36:17 (13180): VM did not power off when requested.
2020-10-17 08:36:17 (13180): VM was successfully terminated.
2020-10-17 08:36:17 (13180): Deregistering VM. (boinc_db8f057743710ad6, slot#7)
2020-10-17 08:36:17 (13180): Removing network bandwidth throttle group from VM.
2020-10-17 08:36:18 (13180): Removing VM from VirtualBox.
08:36:23 (13180): called boinc_finish(0)

</stderr_txt>
]]>

©2025 CERN