Stderr output

<core_client_version>7.14.2</core_client_version>
<![CDATA[
<stderr_txt>
2019-05-16 01:01:41 (4240): Detected: vboxwrapper 26197
2019-05-16 01:01:41 (4240): Detected: BOINC client v7.7
2019-05-16 01:01:42 (4240): Detected: VirtualBox VboxManage Interface (Version: 5.2.8)
2019-05-16 01:01:42 (4240): Successfully copied 'init_data.xml' to the shared directory.
2019-05-16 01:01:42 (4240): Successfully copied 'cranky' to the shared directory.
2019-05-16 01:01:42 (4240): Successfully copied 'input' to the shared directory.
2019-05-16 01:01:44 (4240): Create VM. (boinc_f7756bd1b57e0ef7, slot#15)
2019-05-16 01:01:45 (4240): Setting Memory Size for VM. (1030MB)
2019-05-16 01:01:45 (4240): Setting CPU Count for VM. (4)
2019-05-16 01:01:45 (4240): Setting Chipset Options for VM.
2019-05-16 01:01:46 (4240): Setting Boot Options for VM.
2019-05-16 01:01:46 (4240): Setting Network Configuration for NAT.
2019-05-16 01:01:46 (4240): Enabling VM Network Access.
2019-05-16 01:01:47 (4240): Disabling USB Support for VM.
2019-05-16 01:01:47 (4240): Disabling COM Port Support for VM.
2019-05-16 01:01:47 (4240): Disabling LPT Port Support for VM.
2019-05-16 01:01:48 (4240): Disabling Audio Support for VM.
2019-05-16 01:01:48 (4240): Disabling Clipboard Support for VM.
2019-05-16 01:01:48 (4240): Disabling Drag and Drop Support for VM.
2019-05-16 01:01:48 (4240): Adding storage controller(s) to VM.
2019-05-16 01:01:49 (4240): Adding virtual disk drive to VM. (vm_image.vdi)
2019-05-16 01:01:49 (4240): Adding VirtualBox Guest Additions to VM.
2019-05-16 01:01:49 (4240): Adding network bandwidth throttle group to VM. (Defaulting to 1024GB)
2019-05-16 01:01:49 (4240): forwarding host port 54500 to guest port 80
2019-05-16 01:01:50 (4240): Enabling remote desktop for VM.
2019-05-16 01:01:50 (4240): Required extension pack not installed, remote desktop not enabled.
2019-05-16 01:01:50 (4240): Enabling shared directory for VM.
2019-05-16 01:01:50 (4240): Starting VM using VBoxManage interface. (boinc_f7756bd1b57e0ef7, slot#15)
2019-05-16 01:01:55 (4240): Successfully started VM. (PID = '2232')
2019-05-16 01:01:55 (4240): Reporting VM Process ID to BOINC.
2019-05-16 01:01:55 (4240): Guest Log: BIOS: VirtualBox 5.2.8

2019-05-16 01:01:55 (4240): Guest Log: CPUID EDX: 0x178bfbff

2019-05-16 01:01:55 (4240): Guest Log: BIOS: ata0-0: PCHS=16383/16/63 LCHS=1024/255/63

2019-05-16 01:01:55 (4240): VM state change detected. (old = 'PoweredOff', new = 'Running')
2019-05-16 01:01:55 (4240): Detected: Web Application Enabled (http://localhost:54500)
2019-05-16 01:01:55 (4240): Preference change detected
2019-05-16 01:01:55 (4240): Setting CPU throttle for VM. (100%)
2019-05-16 01:01:55 (4240): Setting checkpoint interval to 600 seconds. (Higher value of (Preference: 600 seconds) or (Vbox_job.xml: 600 seconds))
2019-05-16 01:01:57 (4240): Guest Log: BIOS: Boot : bseqnr=1, bootseq=0032

2019-05-16 01:01:57 (4240): Guest Log: BIOS: Booting from Hard Disk...

2019-05-16 01:01:59 (4240): Guest Log: BIOS: KBD: unsupported int 16h function 03

2019-05-16 01:01:59 (4240): Guest Log: BIOS: AX=0305 BX=0000 CX=0000 DX=0000 

2019-05-16 01:02:23 (4240): Guest Log: vgdrvHeartbeatInit: Setting up heartbeat to trigger every 2000 milliseconds

2019-05-16 01:02:23 (4240): Guest Log: vboxguest: misc device minor 56, IRQ 20, I/O port d020, MMIO at 00000000f0400000 (size 0x400000)

2019-05-16 01:02:27 (4240): Guest Log: VBoxService 5.2.6 r120293 (verbosity: 0) linux.amd64 (Jan 15 2018 14:51:00) release log

2019-05-16 01:02:27 (4240): Guest Log: 00:00:00.000726 main     Log opened 2019-05-15T23:02:27.267804000Z

2019-05-16 01:02:27 (4240): Guest Log: 00:00:00.000860 main     OS Product: Linux

2019-05-16 01:02:27 (4240): Guest Log: 00:00:00.000925 main     OS Release: 4.14.76-13.cernvm.x86_64

2019-05-16 01:02:27 (4240): Guest Log: 00:00:00.000972 main     OS Version: #1 SMP Tue Oct 16 18:26:15 CEST 2018

2019-05-16 01:02:27 (4240): Guest Log: 00:00:00.001017 main     Executable: /usr/sbin/VBoxService

2019-05-16 01:02:27 (4240): Guest Log: 00:00:00.001019 main     Process ID: 3346

2019-05-16 01:02:27 (4240): Guest Log: 00:00:00.001021 main     Package type: LINUX_64BITS_GENERIC

2019-05-16 01:02:27 (4240): Guest Log: 00:00:00.002762 main     5.2.6 r120293 started. Verbose level = 0

2019-05-16 01:02:38 (4240): Guest Log: 23:02:37 2019-05-15: cranky: [INFO] Detected Theory App

2019-05-16 01:02:38 (4240): Guest Log: 23:02:37 2019-05-15: cranky: [INFO] Checking CVMFS.

2019-05-16 01:02:46 (4240): Guest Log: 23:02:46 2019-05-15: cranky: [INFO] Checking runc.

2019-05-16 01:02:47 (4240): Guest Log: 23:02:46 2019-05-15: cranky: [INFO] Creating the filesystem.

2019-05-16 01:02:47 (4240): Guest Log: 23:02:46 2019-05-15: cranky: [INFO] Using /cvmfs/cernvm-prod.cern.ch/cvm3

2019-05-16 01:02:47 (4240): Guest Log: 23:02:47 2019-05-15: cranky: [INFO] Updating config.json.

2019-05-16 01:02:47 (4240): Guest Log: 23:02:47 2019-05-15: cranky: [INFO] Running Container 'runc'.

2019-05-16 02:42:00 (4240): Status Report: Job Duration: '64800.000000'
2019-05-16 02:42:00 (4240): Status Report: Elapsed Time: '6000.000000'
2019-05-16 02:42:00 (4240): Status Report: CPU Time: '6844.000000'
2019-05-16 03:14:17 (4240): Stopping VM.
2019-05-16 03:46:19 (4712): Detected: vboxwrapper 26197
2019-05-16 03:46:19 (4712): Detected: BOINC client v7.7
2019-05-16 03:46:19 (4712): Detected: VirtualBox VboxManage Interface (Version: 5.2.8)
2019-05-16 03:46:20 (4712): Starting VM using VBoxManage interface. (boinc_f7756bd1b57e0ef7, slot#15)
2019-05-16 03:46:29 (4712): Successfully started VM. (PID = '8112')
2019-05-16 03:46:29 (4712): Reporting VM Process ID to BOINC.
2019-05-16 03:46:29 (4712): Guest Log: 02:11:51.573229 timesync vgsvcTimeSyncWorker: Radical host time change: 1 940 094 000 000ns (HostNow=1 557 971 188 931 000 000 ns HostLast=1 557 969 248 837 000 000 ns)

2019-05-16 03:46:29 (4712): VM state change detected. (old = 'PoweredOff', new = 'Running')
2019-05-16 03:46:29 (4712): Detected: Web Application Enabled (http://localhost:54500)
2019-05-16 03:46:29 (4712): Status Report: Job Duration: '64800.000000'
2019-05-16 03:46:29 (4712): Status Report: Elapsed Time: '7936.000000'
2019-05-16 03:46:29 (4712): Status Report: CPU Time: '9043.062500'
2019-05-16 03:46:29 (4712): Preference change detected
2019-05-16 03:46:29 (4712): Setting CPU throttle for VM. (100%)
2019-05-16 03:46:29 (4712): Setting checkpoint interval to 600 seconds. (Higher value of (Preference: 600 seconds) or (Vbox_job.xml: 600 seconds))
2019-05-16 03:46:39 (4712): Guest Log: 02:12:01.578630 timesync vgsvcTimeSyncWorker: Radical guest time change: 1 940 096 551 000ns (GuestNow=1 557 971 198 936 610 000 ns GuestLast=1 557 969 258 840 059 000 ns fSetTimeLastLoop=true )

2019-05-16 05:26:34 (4712): Status Report: Job Duration: '64800.000000'
2019-05-16 05:26:34 (4712): Status Report: Elapsed Time: '13936.000000'
2019-05-16 05:26:34 (4712): Status Report: CPU Time: '15906.187500'
2019-05-16 06:27:42 (4712): Stopping VM.
2019-05-16 07:11:18 (1100): Detected: vboxwrapper 26197
2019-05-16 07:11:18 (1100): Detected: BOINC client v7.7
2019-05-16 07:11:19 (1100): Detected: VirtualBox VboxManage Interface (Version: 5.2.8)
2019-05-16 07:11:20 (1100): Starting VM using VBoxManage interface. (boinc_f7756bd1b57e0ef7, slot#15)
2019-05-16 07:11:28 (1100): Successfully started VM. (PID = '1976')
2019-05-16 07:11:28 (1100): Reporting VM Process ID to BOINC.
2019-05-16 07:11:28 (1100): VM state change detected. (old = 'PoweredOff', new = 'Running')
2019-05-16 07:11:28 (1100): Detected: Web Application Enabled (http://localhost:54500)
2019-05-16 07:11:28 (1100): Status Report: Job Duration: '64800.000000'
2019-05-16 07:11:28 (1100): Status Report: Elapsed Time: '17602.000000'
2019-05-16 07:11:28 (1100): Status Report: CPU Time: '20094.812500'
2019-05-16 07:11:28 (1100): Preference change detected
2019-05-16 07:11:28 (1100): Setting CPU throttle for VM. (100%)
2019-05-16 07:11:28 (1100): Setting checkpoint interval to 600 seconds. (Higher value of (Preference: 600 seconds) or (Vbox_job.xml: 600 seconds))
2019-05-16 07:11:35 (1100): Guest Log: 04:53:13.319678 timesync vgsvcTimeSyncWorker: Radical host time change: 2 634 363 000 000ns (HostNow=1 557 983 495 043 000 000 ns HostLast=1 557 980 860 680 000 000 ns)

2019-05-16 07:11:45 (1100): Guest Log: 04:53:23.320681 timesync vgsvcTimeSyncWorker: Radical guest time change: 2 634 366 740 000ns (GuestNow=1 557 983 505 044 194 000 ns GuestLast=1 557 980 870 677 454 000 ns fSetTimeLastLoop=true )

2019-05-16 08:51:33 (1100): Status Report: Job Duration: '64800.000000'
2019-05-16 08:51:33 (1100): Status Report: Elapsed Time: '23602.000000'
2019-05-16 08:51:33 (1100): Status Report: CPU Time: '26958.281250'
2019-05-16 09:11:55 (1100): Stopping VM.
2019-05-16 10:01:14 (6944): Detected: vboxwrapper 26197
2019-05-16 10:01:14 (6944): Detected: BOINC client v7.7
2019-05-16 10:01:14 (6944): Detected: VirtualBox VboxManage Interface (Version: 5.2.8)
2019-05-16 10:01:15 (6944): Starting VM using VBoxManage interface. (boinc_f7756bd1b57e0ef7, slot#15)
2019-05-16 10:01:22 (6944): Successfully started VM. (PID = '6680')
2019-05-16 10:01:22 (6944): Reporting VM Process ID to BOINC.
2019-05-16 10:01:22 (6944): Guest Log: 06:53:34.691816 timesync vgsvcTimeSyncWorker: Radical host time change: 2 976 096 000 000ns (HostNow=1 557 993 682 506 000 000 ns HostLast=1 557 990 706 410 000 000 ns)

2019-05-16 10:01:22 (6944): VM state change detected. (old = 'PoweredOff', new = 'Running')
2019-05-16 10:01:22 (6944): Detected: Web Application Enabled (http://localhost:54500)
2019-05-16 10:01:22 (6944): Status Report: Job Duration: '64800.000000'
2019-05-16 10:01:22 (6944): Status Report: Elapsed Time: '24823.000000'
2019-05-16 10:01:22 (6944): Status Report: CPU Time: '28352.578125'
2019-05-16 10:01:22 (6944): Preference change detected
2019-05-16 10:01:22 (6944): Setting CPU throttle for VM. (100%)
2019-05-16 10:01:22 (6944): Setting checkpoint interval to 600 seconds. (Higher value of (Preference: 600 seconds) or (Vbox_job.xml: 600 seconds))
2019-05-16 10:01:32 (6944): Guest Log: 06:53:44.693962 timesync vgsvcTimeSyncWorker: Radical guest time change: 2 976 093 054 000ns (GuestNow=1 557 993 692 508 243 000 ns GuestLast=1 557 990 716 415 189 000 ns fSetTimeLastLoop=true )

2019-05-16 11:41:27 (6944): Status Report: Job Duration: '64800.000000'
2019-05-16 11:41:27 (6944): Status Report: Elapsed Time: '30823.000000'
2019-05-16 11:41:27 (6944): Status Report: CPU Time: '35212.546875'
2019-05-16 12:02:02 (6944): Stopping VM.
2019-05-16 12:20:06 (2296): Detected: vboxwrapper 26197
2019-05-16 12:20:06 (2296): Detected: BOINC client v7.7
2019-05-16 12:20:07 (2296): Detected: VirtualBox VboxManage Interface (Version: 5.2.8)
2019-05-16 12:20:07 (2296): Starting VM using VBoxManage interface. (boinc_f7756bd1b57e0ef7, slot#15)
2019-05-16 12:20:20 (2296): Successfully started VM. (PID = '3892')
2019-05-16 12:20:20 (2296): Reporting VM Process ID to BOINC.
2019-05-16 12:20:20 (2296): VM state change detected. (old = 'PoweredOff', new = 'Running')
2019-05-16 12:20:20 (2296): Detected: Web Application Enabled (http://localhost:54500)
2019-05-16 12:20:20 (2296): Status Report: Job Duration: '64800.000000'
2019-05-16 12:20:20 (2296): Status Report: Elapsed Time: '32057.000000'
2019-05-16 12:20:20 (2296): Status Report: CPU Time: '36618.187500'
2019-05-16 12:20:20 (2296): Preference change detected
2019-05-16 12:20:20 (2296): Setting CPU throttle for VM. (100%)
2019-05-16 12:20:20 (2296): Setting checkpoint interval to 600 seconds. (Higher value of (Preference: 600 seconds) or (Vbox_job.xml: 600 seconds))
2019-05-16 12:23:39 (2296): Stopping VM.
2019-05-16 20:27:43 (3656): Detected: vboxwrapper 26197
2019-05-16 20:27:43 (3656): Detected: BOINC client v7.7
2019-05-16 20:27:44 (3656): Detected: VirtualBox VboxManage Interface (Version: 5.2.8)
2019-05-16 20:27:45 (3656): Starting VM using VBoxManage interface. (boinc_f7756bd1b57e0ef7, slot#15)
2019-05-16 20:27:54 (3656): Successfully started VM. (PID = '2596')
2019-05-16 20:27:54 (3656): Reporting VM Process ID to BOINC.
2019-05-16 20:27:54 (3656): Guest Log: 08:57:36.209938 timesync vgsvcTimeSyncWorker: Radical host time change: 29 063 018 000 000ns (HostNow=1 558 031 273 630 000 000 ns HostLast=1 558 002 210 612 000 000 ns)

2019-05-16 20:27:54 (3656): VM state change detected. (old = 'PoweredOff', new = 'Running')
2019-05-16 20:27:54 (3656): Detected: Web Application Enabled (http://localhost:54500)
2019-05-16 20:27:54 (3656): Status Report: Job Duration: '64800.000000'
2019-05-16 20:27:54 (3656): Status Report: Elapsed Time: '32256.000000'
2019-05-16 20:27:54 (3656): Status Report: CPU Time: '36845.109375'
2019-05-16 20:27:54 (3656): Preference change detected
2019-05-16 20:27:54 (3656): Setting CPU throttle for VM. (100%)
2019-05-16 20:27:54 (3656): Setting checkpoint interval to 600 seconds. (Higher value of (Preference: 600 seconds) or (Vbox_job.xml: 600 seconds))
2019-05-16 20:28:04 (3656): Guest Log: 08:57:46.210972 timesync vgsvcTimeSyncWorker: Radical guest time change: 29 063 014 903 000ns (GuestNow=1 558 031 283 631 220 000 ns GuestLast=1 558 002 220 616 317 000 ns fSetTimeLastLoop=true )

2019-05-16 22:07:58 (3656): Status Report: Job Duration: '64800.000000'
2019-05-16 22:07:58 (3656): Status Report: Elapsed Time: '38256.000000'
2019-05-16 22:07:58 (3656): Status Report: CPU Time: '43705.875000'
2019-05-16 22:28:25 (3656): Stopping VM.
2019-05-16 22:34:40 (7088): Detected: vboxwrapper 26197
2019-05-16 22:34:40 (7088): Detected: BOINC client v7.7
2019-05-16 22:34:40 (7088): Detected: VirtualBox VboxManage Interface (Version: 5.2.8)
2019-05-16 22:34:41 (7088): Starting VM using VBoxManage interface. (boinc_f7756bd1b57e0ef7, slot#15)
2019-05-16 22:34:50 (7088): Successfully started VM. (PID = '6372')
2019-05-16 22:34:50 (7088): Reporting VM Process ID to BOINC.
2019-05-16 22:34:50 (7088): VM state change detected. (old = 'PoweredOff', new = 'Running')
2019-05-16 22:34:50 (7088): Detected: Web Application Enabled (http://localhost:54500)
2019-05-16 22:34:50 (7088): Status Report: Job Duration: '64800.000000'
2019-05-16 22:34:50 (7088): Status Report: Elapsed Time: '39482.000000'
2019-05-16 22:34:50 (7088): Status Report: CPU Time: '45101.140625'
2019-05-16 22:34:50 (7088): Preference change detected
2019-05-16 22:34:50 (7088): Setting CPU throttle for VM. (100%)
2019-05-16 22:34:50 (7088): Setting checkpoint interval to 600 seconds. (Higher value of (Preference: 600 seconds) or (Vbox_job.xml: 600 seconds))
2019-05-16 23:53:38 (7088): Guest Log: ===> [runRivet] Wed May 15 23:02:47 UTC 2019 [boinc pp jets 7000 150,-,1860 - pythia8 8.235 tune-2c 100000 57]

2019-05-16 23:53:38 (7088): Guest Log: 21:53:38 2019-05-16: cranky: [INFO] Preparing output.

2019-05-16 23:53:38 (7088): VM Completion File Detected.
2019-05-16 23:53:38 (7088): Powering off VM.
2019-05-16 23:58:39 (7088): VM did not power off when requested.
2019-05-16 23:58:39 (7088): VM was successfully terminated.
2019-05-16 23:58:39 (7088): Deregistering VM. (boinc_f7756bd1b57e0ef7, slot#15)
2019-05-16 23:58:39 (7088): Removing network bandwidth throttle group from VM.
2019-05-16 23:58:40 (7088): Removing VM from VirtualBox.
23:58:45 (7088): called boinc_finish(0)

</stderr_txt>
]]>

©2024 CERN