Stderr output

<core_client_version>7.16.7</core_client_version>
<![CDATA[
<stderr_txt>
2020-09-02 15:45:29 (8600): Detected: vboxwrapper 26197
2020-09-02 15:45:29 (8600): Detected: BOINC client v7.7
2020-09-02 15:45:29 (8600): Detected: VirtualBox VboxManage Interface (Version: 6.0.14)
2020-09-02 15:45:30 (8600): Detected: Heartbeat check (file: 'heartbeat' every 1200.000000 seconds)
2020-09-02 15:45:30 (8600): Successfully copied 'init_data.xml' to the shared directory.
2020-09-02 15:45:30 (8600): Successfully copied 'input' to the shared directory.
2020-09-02 15:45:31 (8600): Create VM. (boinc_a48f58da7f4168b5, slot#2)
2020-09-02 15:45:31 (8600): Setting Memory Size for VM. (630MB)
2020-09-02 15:45:32 (8600): Setting CPU Count for VM. (1)
2020-09-02 15:45:32 (8600): Setting Chipset Options for VM.
2020-09-02 15:45:32 (8600): Setting Boot Options for VM.
2020-09-02 15:45:33 (8600): Setting Network Configuration for NAT.
2020-09-02 15:45:33 (8600): Enabling VM Network Access.
2020-09-02 15:45:33 (8600): Disabling USB Support for VM.
2020-09-02 15:45:33 (8600): Disabling COM Port Support for VM.
2020-09-02 15:45:34 (8600): Disabling LPT Port Support for VM.
2020-09-02 15:45:34 (8600): Disabling Audio Support for VM.
2020-09-02 15:45:34 (8600): Disabling Clipboard Support for VM.
2020-09-02 15:45:34 (8600): Disabling Drag and Drop Support for VM.
2020-09-02 15:45:35 (8600): Adding storage controller(s) to VM.
2020-09-02 15:45:35 (8600): Adding virtual disk drive to VM. (vm_image.vdi)
2020-09-02 15:45:35 (8600): Adding VirtualBox Guest Additions to VM.
2020-09-02 15:45:36 (8600): Adding network bandwidth throttle group to VM. (Defaulting to 1024GB)
2020-09-02 15:45:36 (8600): forwarding host port 50709 to guest port 80
2020-09-02 15:45:36 (8600): Enabling remote desktop for VM.
2020-09-02 15:45:36 (8600): Required extension pack not installed, remote desktop not enabled.
2020-09-02 15:45:36 (8600): Enabling shared directory for VM.
2020-09-02 15:45:37 (8600): Starting VM using VBoxManage interface. (boinc_a48f58da7f4168b5, slot#2)
2020-09-02 15:45:41 (8600): Successfully started VM. (PID = '2108')
2020-09-02 15:45:41 (8600): Reporting VM Process ID to BOINC.
2020-09-02 15:45:41 (8600): Guest Log: BIOS: VirtualBox 6.0.14

2020-09-02 15:45:41 (8600): Guest Log: CPUID EDX: 0x178bfbff

2020-09-02 15:45:41 (8600): Guest Log: BIOS: ata0-0: PCHS=16383/16/63 LCHS=1024/255/63

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

2020-09-02 15:45:43 (8600): Guest Log: BIOS: Booting from Hard Disk...

2020-09-02 15:45:45 (8600): Guest Log: BIOS: KBD: unsupported int 16h function 03

2020-09-02 15:45:45 (8600): Guest Log: BIOS: AX=0305 BX=0000 CX=0000 DX=0000 

2020-09-02 15:46:11 (8600): Guest Log: vgdrvHeartbeatInit: Setting up heartbeat to trigger every 2000 milliseconds

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

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

2020-09-02 15:46:15 (8600): Guest Log: 00:00:00.000470 main     Log opened 2020-09-02T06:46:15.276638000Z

2020-09-02 15:46:15 (8600): Guest Log: 00:00:00.000713 main     OS Product: Linux

2020-09-02 15:46:15 (8600): Guest Log: 00:00:00.000796 main     OS Release: 4.14.76-13.cernvm.x86_64

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

2020-09-02 15:46:15 (8600): Guest Log: 00:00:00.000970 main     Executable: /usr/sbin/VBoxService

2020-09-02 15:46:15 (8600): Guest Log: 00:00:00.000972 main     Process ID: 3192

2020-09-02 15:46:15 (8600): Guest Log: 00:00:00.000974 main     Package type: LINUX_64BITS_GENERIC

2020-09-02 15:46:15 (8600): Guest Log: 00:00:00.008823 main     5.2.6 r120293 started. Verbose level = 0

2020-09-02 15:46:47 (8600): Guest Log: 15:46:46 JST +09:00 2020-09-02: cranky: [INFO] Detected Theory App

2020-09-02 15:46:47 (8600): Guest Log: 15:46:46 JST +09:00 2020-09-02: cranky: [INFO] Checking CVMFS.

2020-09-02 15:46:48 (8600): Guest Log: Probing /cvmfs/sft.cern.ch... OK

2020-09-02 15:46:49 (8600): 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-09-02 15:46:49 (8600): Guest Log: 2.5.2.0 4058 0 25136 18741 3 1 264036 4096000 0 65024 0 0 n/a 5 3 http://s1ihep-cvmfs.openhtc.io/cvmfs/sft.cern.ch DIRECT 1

2020-09-02 15:46:50 (8600): Guest Log: Probing /cvmfs/grid.cern.ch... OK

2020-09-02 15:46:51 (8600): 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-09-02 15:46:51 (8600): Guest Log: 2.5.2.0 4080 0 25448 13111 3 2 264036 4096000 0 65024 0 2 -100 6412 3610 http://s1asgc-cvmfs.openhtc.io:8080/cvmfs/grid.cern.ch DIRECT 1

2020-09-02 15:46:52 (8600): Guest Log: Probing /cvmfs/cernvm-prod.cern.ch... OK

2020-09-02 15:46:53 (8600): 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-09-02 15:46:53 (8600): Guest Log: 2.5.2.0 4035 0 27228 256 3 1 264036 4096000 0 65024 0 0 n/a 4 2 http://s1ral-cvmfs.openhtc.io/cvmfs/cernvm-prod.cern.ch DIRECT 1

2020-09-02 15:46:54 (8600): Guest Log: Probing /cvmfs/alice.cern.ch... OK

2020-09-02 15:46:55 (8600): 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-09-02 15:46:55 (8600): Guest Log: 2.5.2.0 4106 0 30016 7359 3 1 264036 4096000 0 65024 0 0 n/a 4302 3466 http://s1asgc-cvmfs.openhtc.io:8080/cvmfs/alice.cern.ch DIRECT 1

2020-09-02 15:46:55 (8600): Guest Log: 15:46:54 JST +09:00 2020-09-02: cranky: [INFO] Checking runc.

2020-09-02 15:46:55 (8600): Guest Log: 15:46:54 JST +09:00 2020-09-02: cranky: [INFO] Creating the filesystem.

2020-09-02 15:46:55 (8600): Guest Log: 15:46:54 JST +09:00 2020-09-02: cranky: [INFO] Using /cvmfs/cernvm-prod.cern.ch/cvm3

2020-09-02 15:46:55 (8600): Guest Log: 15:46:54 JST +09:00 2020-09-02: cranky: [INFO] Updating config.json.

2020-09-02 15:46:55 (8600): Guest Log: 15:46:55 JST +09:00 2020-09-02: cranky: [INFO] Running Container 'runc'.

2020-09-02 15:46:56 (8600): Guest Log: job: htmld=/shared/html/job

2020-09-02 15:46:56 (8600): Guest Log: job: unpack exitcode=0

2020-09-02 15:46:57 (8600): Guest Log: 15:46:57 JST +09:00 2020-09-02: cranky: [INFO] ===> [runRivet] Wed Sep  2 06:46:55 UTC 2020 [boinc pp jets 13000 180,-,3560 - pythia6 6.427 pro-q2o 100000 42]

2020-09-02 16:26:39 (8600): Stopping VM.
2020-09-03 08:59:43 (11740): Detected: vboxwrapper 26197
2020-09-03 08:59:43 (11740): Detected: BOINC client v7.7
2020-09-03 08:59:44 (11740): Detected: VirtualBox VboxManage Interface (Version: 6.0.14)
2020-09-03 08:59:44 (11740): Detected: Heartbeat check (file: 'heartbeat' every 1200.000000 seconds)
2020-09-03 08:59:44 (11740): Starting VM using VBoxManage interface. (boinc_a48f58da7f4168b5, slot#2)
2020-09-03 09:00:00 (11740): Successfully started VM. (PID = '12296')
2020-09-03 09:00:00 (11740): Reporting VM Process ID to BOINC.
2020-09-03 09:00:00 (11740): VM state change detected. (old = 'PoweredOff', new = 'Running')
2020-09-03 09:00:00 (11740): Detected: Web Application Enabled (http://localhost:50709)
2020-09-03 09:00:01 (11740): VM state change detected. (old = 'Running', new = 'Paused')
2020-09-03 09:00:05 (11740): Preference change detected
2020-09-03 09:00:05 (11740): Setting CPU throttle for VM. (100%)
2020-09-03 09:00:05 (11740): Setting checkpoint interval to 600 seconds. (Higher value of (Preference: 60 seconds) or (Vbox_job.xml: 600 seconds))
2020-09-03 09:00:06 (11740): VM state change detected. (old = 'Paused', new = 'Running')
2020-09-03 09:00:10 (11740): Guest Log: 00:40:31.620787 timesync vgsvcTimeSyncWorker: Radical host time change: 59 612 934 000 000ns (HostNow=1 599 091 209 700 000 000 ns HostLast=1 599 031 596 766 000 000 ns)

2020-09-03 09:00:16 (11740): Stopping VM.
2020-09-06 12:20:57 (12080): Detected: vboxwrapper 26197
2020-09-06 12:20:57 (12080): Detected: BOINC client v7.7
2020-09-06 12:20:58 (12080): Detected: VirtualBox VboxManage Interface (Version: 6.0.14)
2020-09-06 12:20:58 (12080): Detected: Heartbeat check (file: 'heartbeat' every 1200.000000 seconds)
2020-09-06 12:20:58 (12080): Starting VM using VBoxManage interface. (boinc_a48f58da7f4168b5, slot#2)
2020-09-06 12:21:13 (12080): Successfully started VM. (PID = '12516')
2020-09-06 12:21:13 (12080): Reporting VM Process ID to BOINC.
2020-09-06 12:21:13 (12080): VM state change detected. (old = 'PoweredOff', new = 'Running')
2020-09-06 12:21:13 (12080): Detected: Web Application Enabled (http://localhost:50709)
2020-09-06 12:21:14 (12080): VM state change detected. (old = 'Running', new = 'Paused')
2020-09-06 12:21:18 (12080): Preference change detected
2020-09-06 12:21:18 (12080): Setting CPU throttle for VM. (100%)
2020-09-06 12:21:19 (12080): Setting checkpoint interval to 600 seconds. (Higher value of (Preference: 60 seconds) or (Vbox_job.xml: 600 seconds))
2020-09-06 12:21:19 (12080): VM state change detected. (old = 'Paused', new = 'Running')
2020-09-06 12:21:20 (12080): Guest Log: 00:40:41.634864 timesync vgsvcTimeSyncWorker: Radical host time change: 271 270 667 000 000ns (HostNow=1 599 362 480 367 000 000 ns HostLast=1 599 091 209 700 000 000 ns)

2020-09-06 12:21:20 (12080): Guest Log: 00:40:41.635050 timesync vgsvcTimeSyncWorker: Radical guest time change: 59 612 935 681 000ns (GuestNow=1 599 091 219 730 186 000 ns GuestLast=1 599 031 606 794 505 000 ns fSetTimeLastLoop=true )

2020-09-06 12:21:30 (12080): Guest Log: 00:40:51.639498 timesync vgsvcTimeSyncWorker: Radical guest time change: 271 270 641 462 000ns (GuestNow=1 599 362 490 371 648 000 ns GuestLast=1 599 091 219 730 186 000 ns fSetTimeLastLoop=true )

2020-09-06 12:21:49 (12080): VM state change detected. (old = 'Running', new = 'Paused')
2020-09-06 12:21:59 (12080): VM state change detected. (old = 'Paused', new = 'Running')
2020-09-06 12:25:10 (12080): VM state change detected. (old = 'Running', new = 'Paused')
2020-09-06 12:25:20 (12080): VM state change detected. (old = 'Paused', new = 'Running')
2020-09-06 12:25:30 (12080): VM state change detected. (old = 'Running', new = 'Paused')
2020-09-06 12:26:20 (12080): VM state change detected. (old = 'Paused', new = 'Running')
2020-09-06 12:27:09 (12080): VM state change detected. (old = 'Running', new = 'Paused')
2020-09-06 12:27:29 (12080): VM state change detected. (old = 'Paused', new = 'Running')
2020-09-06 12:28:10 (12080): VM state change detected. (old = 'Running', new = 'Paused')
2020-09-06 12:28:19 (12080): VM state change detected. (old = 'Paused', new = 'Running')
2020-09-06 12:29:27 (12080): Stopping VM.
2020-09-06 13:26:17 (12544): Detected: vboxwrapper 26197
2020-09-06 13:26:17 (12544): Detected: BOINC client v7.7
2020-09-06 13:26:18 (12544): Detected: VirtualBox VboxManage Interface (Version: 6.0.14)
2020-09-06 13:26:18 (12544): Detected: Heartbeat check (file: 'heartbeat' every 1200.000000 seconds)
2020-09-06 13:26:18 (12544): Starting VM using VBoxManage interface. (boinc_a48f58da7f4168b5, slot#2)
2020-09-06 13:26:28 (12544): Successfully started VM. (PID = '13412')
2020-09-06 13:26:28 (12544): Reporting VM Process ID to BOINC.
2020-09-06 13:26:28 (12544): VM state change detected. (old = 'PoweredOff', new = 'Running')
2020-09-06 13:26:28 (12544): Detected: Web Application Enabled (http://localhost:50709)
2020-09-06 13:26:29 (12544): VM state change detected. (old = 'Running', new = 'Paused')
2020-09-06 13:26:38 (12544): Preference change detected
2020-09-06 13:26:38 (12544): Setting CPU throttle for VM. (100%)
2020-09-06 13:26:38 (12544): Setting checkpoint interval to 600 seconds. (Higher value of (Preference: 60 seconds) or (Vbox_job.xml: 600 seconds))
2020-09-06 13:26:39 (12544): Guest Log: 00:47:11.879277 timesync vgsvcTimeSyncWorker: Radical host time change: 3 439 297 000 000ns (HostNow=1 599 366 398 295 000 000 ns HostLast=1 599 362 958 998 000 000 ns)

2020-09-06 13:26:39 (12544): VM state change detected. (old = 'Paused', new = 'Running')
2020-09-06 13:26:49 (12544): Guest Log: 00:47:21.884614 timesync vgsvcTimeSyncWorker: Radical guest time change: 3 537 688 970 000ns (GuestNow=1 599 366 408 300 365 000 ns GuestLast=1 599 362 870 611 395 000 ns fSetTimeLastLoop=true )

2020-09-06 13:29:04 (12544): Stopping VM.
2020-09-06 15:32:16 (13196): Detected: vboxwrapper 26197
2020-09-06 15:32:16 (13196): Detected: BOINC client v7.7
2020-09-06 15:32:17 (13196): Detected: VirtualBox VboxManage Interface (Version: 6.0.14)
2020-09-06 15:32:17 (13196): Detected: Heartbeat check (file: 'heartbeat' every 1200.000000 seconds)
2020-09-06 15:32:17 (13196): Starting VM using VBoxManage interface. (boinc_a48f58da7f4168b5, slot#2)
2020-09-06 15:32:26 (13196): Successfully started VM. (PID = '14108')
2020-09-06 15:32:26 (13196): Reporting VM Process ID to BOINC.
2020-09-06 15:32:26 (13196): VM state change detected. (old = 'PoweredOff', new = 'Running')
2020-09-06 15:32:26 (13196): Detected: Web Application Enabled (http://localhost:50709)
2020-09-06 15:32:27 (13196): VM state change detected. (old = 'Running', new = 'Paused')
2020-09-06 15:32:37 (13196): Preference change detected
2020-09-06 15:32:37 (13196): Setting CPU throttle for VM. (100%)
2020-09-06 15:32:38 (13196): Setting checkpoint interval to 600 seconds. (Higher value of (Preference: 60 seconds) or (Vbox_job.xml: 600 seconds))
2020-09-06 15:32:38 (13196): VM state change detected. (old = 'Paused', new = 'Running')
2020-09-06 15:32:40 (13196): Guest Log: 00:49:41.979229 timesync vgsvcTimeSyncWorker: Radical host time change: 7 422 197 000 000ns (HostNow=1 599 373 960 582 000 000 ns HostLast=1 599 366 538 385 000 000 ns)

2020-09-06 15:32:50 (13196): Guest Log: 00:49:51.985464 timesync vgsvcTimeSyncWorker: Radical guest time change: 7 422 193 308 000ns (GuestNow=1 599 373 970 588 257 000 ns GuestLast=1 599 366 548 394 949 000 ns fSetTimeLastLoop=true )

2020-09-06 15:34:22 (13196): VM state change detected. (old = 'Running', new = 'Paused')
2020-09-06 15:34:23 (13196): VM state change detected. (old = 'Paused', new = 'Running')
2020-09-06 15:34:56 (13196): Stopping VM.
2020-09-06 15:43:00 (12404): Detected: vboxwrapper 26197
2020-09-06 15:43:00 (12404): Detected: BOINC client v7.7
2020-09-06 15:43:01 (12404): Detected: VirtualBox VboxManage Interface (Version: 6.0.14)
2020-09-06 15:43:02 (12404): Detected: Heartbeat check (file: 'heartbeat' every 1200.000000 seconds)
2020-09-06 15:43:02 (12404): Starting VM using VBoxManage interface. (boinc_a48f58da7f4168b5, slot#2)
2020-09-06 15:43:18 (12404): Successfully started VM. (PID = '15788')
2020-09-06 15:43:18 (12404): Reporting VM Process ID to BOINC.
2020-09-06 15:43:18 (12404): VM state change detected. (old = 'PoweredOff', new = 'Running')
2020-09-06 15:43:18 (12404): Detected: Web Application Enabled (http://localhost:50709)
2020-09-06 15:43:19 (12404): VM state change detected. (old = 'Running', new = 'Paused')
2020-09-06 15:43:21 (12404): Preference change detected
2020-09-06 15:43:21 (12404): Setting CPU throttle for VM. (100%)
2020-09-06 15:43:22 (12404): Setting checkpoint interval to 600 seconds. (Higher value of (Preference: 60 seconds) or (Vbox_job.xml: 600 seconds))
2020-09-06 15:43:22 (12404): VM state change detected. (old = 'Paused', new = 'Running')
2020-09-06 15:44:12 (12404): VM state change detected. (old = 'Running', new = 'Paused')
2020-09-06 15:44:22 (12404): VM state change detected. (old = 'Paused', new = 'Running')
2020-09-06 15:47:32 (12404): VM state change detected. (old = 'Running', new = 'Paused')
2020-09-06 15:47:42 (12404): VM state change detected. (old = 'Paused', new = 'Running')
2020-09-06 15:48:13 (12404): VM state change detected. (old = 'Running', new = 'Paused')
2020-09-06 15:48:23 (12404): VM state change detected. (old = 'Paused', new = 'Running')
2020-09-06 16:01:20 (12404): Stopping VM.
2020-09-07 09:28:42 (13172): Detected: vboxwrapper 26197
2020-09-07 09:28:42 (13172): Detected: BOINC client v7.7
2020-09-07 09:28:43 (13172): Detected: VirtualBox VboxManage Interface (Version: 6.0.14)
2020-09-07 09:28:43 (13172): Detected: Heartbeat check (file: 'heartbeat' every 1200.000000 seconds)
2020-09-07 09:28:44 (13172): Starting VM using VBoxManage interface. (boinc_a48f58da7f4168b5, slot#2)
2020-09-07 09:28:55 (13172): Successfully started VM. (PID = '13416')
2020-09-07 09:28:55 (13172): Reporting VM Process ID to BOINC.
2020-09-07 09:28:55 (13172): VM state change detected. (old = 'PoweredOff', new = 'Running')
2020-09-07 09:28:55 (13172): Detected: Web Application Enabled (http://localhost:50709)
2020-09-07 09:28:56 (13172): VM state change detected. (old = 'Running', new = 'Paused')
2020-09-07 09:29:03 (13172): Preference change detected
2020-09-07 09:29:03 (13172): Setting CPU throttle for VM. (100%)
2020-09-07 09:29:04 (13172): Setting checkpoint interval to 600 seconds. (Higher value of (Preference: 60 seconds) or (Vbox_job.xml: 600 seconds))
2020-09-07 09:29:04 (13172): VM state change detected. (old = 'Paused', new = 'Running')
2020-09-07 09:29:06 (13172): Guest Log: 01:09:42.694571 timesync vgsvcTimeSyncWorker: Radical host time change: 62 869 806 000 000ns (HostNow=1 599 438 545 327 000 000 ns HostLast=1 599 375 675 521 000 000 ns)

2020-09-07 09:29:16 (13172): Guest Log: 01:09:52.696156 timesync vgsvcTimeSyncWorker: Radical guest time change: 62 898 105 701 000ns (GuestNow=1 599 438 555 328 601 000 ns GuestLast=1 599 375 657 222 900 000 ns fSetTimeLastLoop=true )

2020-09-07 09:34:19 (13172): Stopping VM.
2020-09-07 09:35:12 (13172): Error in stop VM for VM: -182
Command:
VBoxManage -q controlvm "boinc_a48f58da7f4168b5" savestate
Output:

2020-09-07 09:35:12 (13172): VM did not stop when requested.
2020-09-07 09:35:12 (13172): VM was successfully terminated.
2020-09-07 09:56:29 (13984): Detected: vboxwrapper 26197
2020-09-07 09:56:29 (13984): Detected: BOINC client v7.7
2020-09-07 09:56:30 (13984): Detected: VirtualBox VboxManage Interface (Version: 6.0.14)
2020-09-07 09:56:30 (13984): Detected: Heartbeat check (file: 'heartbeat' every 1200.000000 seconds)
2020-09-07 09:56:31 (13984): Starting VM using VBoxManage interface. (boinc_a48f58da7f4168b5, slot#2)
2020-09-07 09:56:37 (13984): Successfully started VM. (PID = '15016')
2020-09-07 09:56:37 (13984): Reporting VM Process ID to BOINC.
2020-09-07 09:56:37 (13984): Guest Log: BIOS: VirtualBox 6.0.14

2020-09-07 09:56:37 (13984): Guest Log: CPUID EDX: 0x178bfbff

2020-09-07 09:56:37 (13984): Guest Log: BIOS: ata0-0: PCHS=16383/16/63 LCHS=1024/255/63

2020-09-07 09:56:37 (13984): VM state change detected. (old = 'PoweredOff', new = 'Running')
2020-09-07 09:56:37 (13984): Detected: Web Application Enabled (http://localhost:50709)
2020-09-07 09:56:37 (13984): Preference change detected
2020-09-07 09:56:37 (13984): Setting CPU throttle for VM. (100%)
2020-09-07 09:56:37 (13984): Setting checkpoint interval to 600 seconds. (Higher value of (Preference: 60 seconds) or (Vbox_job.xml: 600 seconds))
2020-09-07 09:56:39 (13984): Guest Log: BIOS: Boot : bseqnr=1, bootseq=0032

2020-09-07 09:56:39 (13984): Guest Log: BIOS: Booting from Hard Disk...

2020-09-07 09:56:46 (13984): Guest Log: BIOS: KBD: unsupported int 16h function 03

2020-09-07 09:56:46 (13984): Guest Log: BIOS: AX=0305 BX=0000 CX=0000 DX=0000 

2020-09-07 09:57:17 (13984): Guest Log: vgdrvHeartbeatInit: Setting up heartbeat to trigger every 2000 milliseconds

2020-09-07 09:57:17 (13984): Guest Log: vboxguest: misc device minor 56, IRQ 20, I/O port d020, MMIO at 00000000f0400000 (size 0x400000)

2020-09-07 09:57:22 (13984): Guest Log: VBoxService 5.2.6 r120293 (verbosity: 0) linux.amd64 (Jan 15 2018 14:51:00) release log

2020-09-07 09:57:22 (13984): Guest Log: 00:00:00.000231 main     Log opened 2020-09-07T00:57:27.853651000Z

2020-09-07 09:57:22 (13984): Guest Log: 00:00:00.000383 main     OS Product: Linux

2020-09-07 09:57:22 (13984): Guest Log: 00:00:00.000445 main     OS Release: 4.14.76-13.cernvm.x86_64

2020-09-07 09:57:22 (13984): Guest Log: 00:00:00.000506 main     OS Version: #1 SMP Tue Oct 16 18:26:15 CEST 2018

2020-09-07 09:57:22 (13984): Guest Log: 00:00:00.000569 main     Executable: /usr/sbin/VBoxService

2020-09-07 09:57:22 (13984): Guest Log: 00:00:00.000571 main     Process ID: 3188

2020-09-07 09:57:22 (13984): Guest Log: 00:00:00.000572 main     Package type: LINUX_64BITS_GENERIC

2020-09-07 09:57:22 (13984): Guest Log: 00:00:00.005502 main     5.2.6 r120293 started. Verbose level = 0

2020-09-07 09:57:54 (13984): Guest Log: 09:58:02 JST +09:00 2020-09-07: cranky: [INFO] Detected Theory App

2020-09-07 09:57:54 (13984): Guest Log: 09:58:02 JST +09:00 2020-09-07: cranky: [INFO] Checking CVMFS.

2020-09-07 09:57:56 (13984): Guest Log: Probing /cvmfs/sft.cern.ch... OK

2020-09-07 09:58:00 (13984): 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-09-07 09:58:00 (13984): Guest Log: 2.5.2.0 4033 0 27176 18835 3 1 1124772 4096001 0 65024 0 0 n/a 0 0 http://s1ihep-cvmfs.openhtc.io/cvmfs/sft.cern.ch DIRECT 1

2020-09-07 09:58:00 (13984): Guest Log: Probing /cvmfs/grid.cern.ch... OK

2020-09-07 09:58:00 (13984): 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-09-07 09:58:00 (13984): Guest Log: 2.5.2.0 4055 0 27536 13149 3 2 1124772 4096001 0 65024 0 2 0 4274 1847 http://s1ihep-cvmfs.openhtc.io/cvmfs/grid.cern.ch DIRECT 1

2020-09-07 09:58:00 (13984): Guest Log: Probing /cvmfs/cernvm-prod.cern.ch... OK

2020-09-07 09:58:03 (13984): 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-09-07 09:58:03 (13984): Guest Log: 2.5.2.0 4103 0 25708 256 3 1 1124772 4096001 0 65024 0 0 n/a 0 0 http://s1asgc-cvmfs.openhtc.io:8080/cvmfs/cernvm-prod.cern.ch DIRECT 1

2020-09-07 09:58:04 (13984): Guest Log: Probing /cvmfs/alice.cern.ch... OK

2020-09-07 09:58:05 (13984): 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-09-07 09:58:05 (13984): Guest Log: 2.5.2.0 4077 0 28008 7394 3 1 1124772 4096001 0 65024 0 0 n/a 4314 1337 http://s1asgc-cvmfs.openhtc.io:8080/cvmfs/alice.cern.ch DIRECT 1

2020-09-07 09:58:05 (13984): Guest Log: 09:58:13 JST +09:00 2020-09-07: cranky: [INFO] Checking runc.

2020-09-07 09:58:05 (13984): Guest Log: 09:58:13 JST +09:00 2020-09-07: cranky: [INFO] Creating the filesystem.

2020-09-07 09:58:05 (13984): Guest Log: 09:58:13 JST +09:00 2020-09-07: cranky: [INFO] Using /cvmfs/cernvm-prod.cern.ch/cvm3

2020-09-07 09:58:06 (13984): Guest Log: 09:58:14 JST +09:00 2020-09-07: cranky: [INFO] Updating config.json.

2020-09-07 09:58:06 (13984): Guest Log: 09:58:14 JST +09:00 2020-09-07: cranky: [INFO] Running Container 'runc'.

2020-09-07 09:58:07 (13984): Guest Log: job: htmld=/shared/html/job

2020-09-07 09:58:07 (13984): Guest Log: job: unpack exitcode=0

2020-09-07 09:58:08 (13984): Guest Log: 09:58:16 JST +09:00 2020-09-07: cranky: [INFO] ===> [runRivet] Mon Sep  7 00:58:15 UTC 2020 [boinc pp jets 13000 180,-,3560 - pythia6 6.427 pro-q2o 100000 42]

2020-09-07 09:58:11 (13984): VM state change detected. (old = 'Running', new = 'Paused')
2020-09-07 09:58:21 (13984): VM state change detected. (old = 'Paused', new = 'Running')
2020-09-07 10:09:55 (13112): Detected: vboxwrapper 26197
2020-09-07 10:09:55 (13112): Detected: BOINC client v7.7
2020-09-07 10:09:56 (13112): Detected: VirtualBox VboxManage Interface (Version: 6.0.14)
2020-09-07 10:09:56 (13112): Detected: Heartbeat check (file: 'heartbeat' every 1200.000000 seconds)
2020-09-07 10:09:56 (13112): Starting VM using VBoxManage interface. (boinc_a48f58da7f4168b5, slot#2)
2020-09-07 10:10:03 (13112): Successfully started VM. (PID = '14720')
2020-09-07 10:10:03 (13112): Reporting VM Process ID to BOINC.
2020-09-07 10:10:03 (13112): Guest Log: BIOS: VirtualBox 6.0.14

2020-09-07 10:10:03 (13112): Guest Log: CPUID EDX: 0x178bfbff

2020-09-07 10:10:03 (13112): Guest Log: BIOS: ata0-0: PCHS=16383/16/63 LCHS=1024/255/63

2020-09-07 10:10:03 (13112): VM state change detected. (old = 'PoweredOff', new = 'Running')
2020-09-07 10:10:03 (13112): Stopping VM.
2020-09-08 17:27:09 (13208): Detected: vboxwrapper 26197
2020-09-08 17:27:09 (13208): Detected: BOINC client v7.7
2020-09-08 17:27:10 (13208): Detected: VirtualBox VboxManage Interface (Version: 6.0.14)
2020-09-08 17:27:11 (13208): Detected: Heartbeat check (file: 'heartbeat' every 1200.000000 seconds)
2020-09-08 17:27:11 (13208): Starting VM using VBoxManage interface. (boinc_a48f58da7f4168b5, slot#2)
2020-09-08 17:27:17 (13208): Successfully started VM. (PID = '12536')
2020-09-08 17:27:17 (13208): Reporting VM Process ID to BOINC.
2020-09-08 17:27:17 (13208): VM state change detected. (old = 'PoweredOff', new = 'Running')
2020-09-08 17:27:17 (13208): Preference change detected
2020-09-08 17:27:17 (13208): Setting CPU throttle for VM. (100%)
2020-09-08 17:27:18 (13208): Setting checkpoint interval to 600 seconds. (Higher value of (Preference: 60 seconds) or (Vbox_job.xml: 600 seconds))
2020-09-08 17:27:18 (13208): Guest Log: BIOS: Boot : bseqnr=1, bootseq=0032

2020-09-08 17:27:18 (13208): Guest Log: BIOS: Booting from Hard Disk...

2020-09-08 17:27:29 (13208): Guest Log: BIOS: KBD: unsupported int 16h function 03

2020-09-08 17:27:29 (13208): Guest Log: BIOS: AX=0305 BX=0000 CX=0000 DX=0000 

2020-09-08 17:28:00 (13208): Guest Log: vgdrvHeartbeatInit: Setting up heartbeat to trigger every 2000 milliseconds

2020-09-08 17:28:00 (13208): Guest Log: vboxguest: misc device minor 56, IRQ 20, I/O port d020, MMIO at 00000000f0400000 (size 0x400000)

2020-09-08 17:28:05 (13208): Guest Log: VBoxService 5.2.6 r120293 (verbosity: 0) linux.amd64 (Jan 15 2018 14:51:00) release log

2020-09-08 17:28:05 (13208): Guest Log: 00:00:00.000225 main     Log opened 2020-09-08T08:28:05.528424000Z

2020-09-08 17:28:05 (13208): Guest Log: 00:00:00.000404 main     OS Product: Linux

2020-09-08 17:28:05 (13208): Guest Log: 00:00:00.000492 main     OS Release: 4.14.76-13.cernvm.x86_64

2020-09-08 17:28:05 (13208): Guest Log: 00:00:00.000564 main     OS Version: #1 SMP Tue Oct 16 18:26:15 CEST 2018

2020-09-08 17:28:05 (13208): Guest Log: 00:00:00.000641 main     Executable: /usr/sbin/VBoxService

2020-09-08 17:28:05 (13208): Guest Log: 00:00:00.000643 main     Process ID: 3191

2020-09-08 17:28:05 (13208): Guest Log: 00:00:00.000645 main     Package type: LINUX_64BITS_GENERIC

2020-09-08 17:28:05 (13208): Guest Log: 00:00:00.004954 main     5.2.6 r120293 started. Verbose level = 0

2020-09-08 17:28:38 (13208): Guest Log: 17:28:37 JST +09:00 2020-09-08: cranky: [INFO] Detected Theory App

2020-09-08 17:28:38 (13208): Guest Log: 17:28:37 JST +09:00 2020-09-08: cranky: [INFO] Checking CVMFS.

2020-09-08 17:28:38 (13208): Guest Log: Probing /cvmfs/sft.cern.ch... OK

2020-09-08 17:28:40 (13208): 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-09-08 17:28:40 (13208): Guest Log: 2.5.2.0 4059 0 28276 18837 3 1 1142608 4096001 0 65024 0 0 n/a 5 7 http://s1asgc-cvmfs.openhtc.io:8080/cvmfs/sft.cern.ch DIRECT 1

2020-09-08 17:28:41 (13208): Guest Log: Probing /cvmfs/grid.cern.ch... OK

2020-09-08 17:28:42 (13208): 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-09-08 17:28:42 (13208): Guest Log: 2.5.2.0 4106 0 27712 13161 3 2 1142608 4096001 0 65024 0 2 0 4274 2941 http://s1asgc-cvmfs.openhtc.io:8080/cvmfs/grid.cern.ch DIRECT 1

2020-09-08 17:28:43 (13208): Guest Log: Probing /cvmfs/cernvm-prod.cern.ch... OK

2020-09-08 17:28:44 (13208): 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-09-08 17:28:44 (13208): Guest Log: 2.5.2.0 4033 0 27212 256 3 1 1142608 4096001 0 65024 0 0 n/a 0 0 http://s1asgc-cvmfs.openhtc.io:8080/cvmfs/cernvm-prod.cern.ch DIRECT 1

2020-09-08 17:28:46 (13208): Guest Log: Probing /cvmfs/alice.cern.ch... OK

2020-09-08 17:28:47 (13208): 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-09-08 17:28:47 (13208): Guest Log: 2.5.2.0 4083 0 30064 7405 3 1 1142608 4096001 0 65024 0 0 n/a 4315 1903 http://s1asgc-cvmfs.openhtc.io:8080/cvmfs/alice.cern.ch DIRECT 1

2020-09-08 17:28:47 (13208): Guest Log: 17:28:46 JST +09:00 2020-09-08: cranky: [INFO] Checking runc.

2020-09-08 17:28:47 (13208): Guest Log: 17:28:47 JST +09:00 2020-09-08: cranky: [INFO] Creating the filesystem.

2020-09-08 17:28:47 (13208): Guest Log: 17:28:47 JST +09:00 2020-09-08: cranky: [INFO] Using /cvmfs/cernvm-prod.cern.ch/cvm3

2020-09-08 17:28:47 (13208): Guest Log: 17:28:47 JST +09:00 2020-09-08: cranky: [INFO] Updating config.json.

2020-09-08 17:28:47 (13208): Guest Log: 17:28:47 JST +09:00 2020-09-08: cranky: [INFO] Running Container 'runc'.

2020-09-08 17:28:48 (13208): Guest Log: job: htmld=/shared/html/job

2020-09-08 17:28:48 (13208): Guest Log: job: unpack exitcode=0

2020-09-08 17:28:50 (13208): Guest Log: 17:28:49 JST +09:00 2020-09-08: cranky: [INFO] ===> [runRivet] Tue Sep  8 08:28:48 UTC 2020 [boinc pp jets 13000 180,-,3560 - pythia6 6.427 pro-q2o 100000 42]

2020-09-08 17:29:22 (13208): Stopping VM.
2020-09-10 02:57:25 (13388): Detected: vboxwrapper 26197
2020-09-10 02:57:25 (13388): Detected: BOINC client v7.7
2020-09-10 02:57:26 (13388): Detected: VirtualBox VboxManage Interface (Version: 6.0.14)
2020-09-10 02:57:27 (13388): Detected: Heartbeat check (file: 'heartbeat' every 1200.000000 seconds)
2020-09-10 02:57:27 (13388): Starting VM using VBoxManage interface. (boinc_a48f58da7f4168b5, slot#2)
2020-09-10 02:57:50 (13388): Successfully started VM. (PID = '15312')
2020-09-10 02:57:50 (13388): Reporting VM Process ID to BOINC.
2020-09-10 02:57:50 (13388): VM state change detected. (old = 'PoweredOff', new = 'Running')
2020-09-10 02:57:59 (13388): Guest Log: 00:01:30.312021 timesync vgsvcTimeSyncWorker: Radical host time change: 120 508 877 000 000ns (HostNow=1 599 674 274 067 000 000 ns HostLast=1 599 553 765 190 000 000 ns)

2020-09-10 02:57:59 (13388): VM state change detected. (old = 'Running', new = 'Paused')
2020-09-10 02:58:00 (13388): Preference change detected
2020-09-10 02:58:00 (13388): Setting CPU throttle for VM. (100%)
2020-09-10 02:58:04 (13388): Setting checkpoint interval to 600 seconds. (Higher value of (Preference: 60 seconds) or (Vbox_job.xml: 600 seconds))
2020-09-10 02:58:04 (13388): VM state change detected. (old = 'Paused', new = 'Running')
2020-09-10 02:58:07 (13388): Guest Log: 00:01:40.347792 timesync vgsvcTimeSyncWorker: Radical guest time change: 120 508 413 098 000ns (GuestNow=1 599 674 284 106 220 000 ns GuestLast=1 599 553 775 693 122 000 ns fSetTimeLastLoop=true )

2020-09-10 04:43:01 (13388): Status Report: Job Duration: '864000.000000'
2020-09-10 04:43:01 (13388): Status Report: Elapsed Time: '6000.079242'
2020-09-10 04:43:01 (13388): Status Report: CPU Time: '6296.703125'
2020-09-10 05:37:15 (13388): Guest Log: job: run exitcode=0

2020-09-10 05:37:15 (13388): Guest Log: job: diskusage=1916

2020-09-10 05:37:15 (13388): Guest Log: job: logsize=52 k

2020-09-10 05:37:15 (13388): Guest Log: job: times=

2020-09-10 05:37:15 (13388): Guest Log: 0m0.021s 0m0.016s

2020-09-10 05:37:15 (13388): Guest Log: 156m34.472s 1m17.725s

2020-09-10 05:37:15 (13388): Guest Log: job: cpuusage=9472

2020-09-10 05:37:15 (13388): Guest Log: 05:37:14 JST +09:00 2020-09-10: cranky: [INFO] Container 'runc' finished with status code 0.

2020-09-10 05:37:15 (13388): Guest Log: 05:37:14 JST +09:00 2020-09-10: cranky: [INFO] Preparing output.

2020-09-10 05:37:16 (13388): Guest Log: [INFO] Job Finished

2020-09-10 05:37:17 (13388): Guest Log: [INFO] Shutting Down.

2020-09-10 05:37:17 (13388): VM Completion File Detected.
2020-09-10 05:37:17 (13388): VM Completion Message: Job Finished
.
2020-09-10 05:37:17 (13388): Powering off VM.
2020-09-10 13:41:05 (4744): Detected: vboxwrapper 26197
2020-09-10 13:41:05 (4744): Detected: BOINC client v7.7
2020-09-10 13:41:06 (4744): Detected: VirtualBox VboxManage Interface (Version: 6.0.14)
2020-09-10 13:41:06 (4744): Detected: Heartbeat check (file: 'heartbeat' every 1200.000000 seconds)
2020-09-10 13:41:07 (4744): Starting VM using VBoxManage interface. (boinc_a48f58da7f4168b5, slot#2)
2020-09-10 13:41:13 (4744): Successfully started VM. (PID = '14632')
2020-09-10 13:41:13 (4744): Reporting VM Process ID to BOINC.
2020-09-10 13:41:13 (4744): Guest Log: BIOS: VirtualBox 6.0.14

2020-09-10 13:41:13 (4744): Guest Log: CPUID EDX: 0x178bfbff

2020-09-10 13:41:13 (4744): Guest Log: BIOS: ata0-0: PCHS=16383/16/63 LCHS=1024/255/63

2020-09-10 13:41:13 (4744): VM state change detected. (old = 'PoweredOff', new = 'Running')
2020-09-10 13:41:13 (4744): VM Completion File Detected.
2020-09-10 13:41:13 (4744): VM Completion Message: Job Finished
.
2020-09-10 13:41:13 (4744): Powering off VM.
2020-09-10 13:46:14 (4744): VM did not power off when requested.
2020-09-10 13:46:14 (4744): VM was successfully terminated.
2020-09-10 13:46:14 (4744): Deregistering VM. (boinc_a48f58da7f4168b5, slot#2)
2020-09-10 13:46:15 (4744): Removing network bandwidth throttle group from VM.
2020-09-10 13:46:16 (4744): Removing VM from VirtualBox.
13:46:21 (4744): called boinc_finish(0)

</stderr_txt>
]]>

©2024 CERN