Stderr output

<core_client_version>7.16.11</core_client_version>
<![CDATA[
<stderr_txt>
2021-07-04 09:27:49 (5532): Detected: vboxwrapper 26197
2021-07-04 09:27:49 (5532): Detected: BOINC client v7.7
2021-07-04 09:27:49 (5532): Detected: VirtualBox VboxManage Interface (Version: 6.1.22)
2021-07-04 09:27:49 (5532): Successfully copied 'init_data.xml' to the shared directory.
2021-07-04 09:27:49 (5532): Successfully copied 'input' to the shared directory.
2021-07-04 09:27:49 (5532): Feature: Checkpoint interval offset (331 seconds)
2021-07-04 09:27:49 (5532): Detected: Minimum checkpoint interval (666.000000 seconds)
2021-07-04 09:27:50 (5532): Create VM. (boinc_a5599952adb3b103, slot#1)
2021-07-04 09:27:51 (5532): Setting Memory Size for VM. (730MB)
2021-07-04 09:27:52 (5532): Setting CPU Count for VM. (1)
2021-07-04 09:27:52 (5532): Setting Chipset Options for VM.
2021-07-04 09:27:52 (5532): Setting Boot Options for VM.
2021-07-04 09:27:53 (5532): Setting Network Configuration for NAT.
2021-07-04 09:27:53 (5532): Enabling VM Network Access.
2021-07-04 09:27:53 (5532): Disabling USB Support for VM.
2021-07-04 09:27:54 (5532): Disabling COM Port Support for VM.
2021-07-04 09:27:54 (5532): Disabling LPT Port Support for VM.
2021-07-04 09:27:54 (5532): Disabling Audio Support for VM.
2021-07-04 09:27:54 (5532): Disabling Clipboard Support for VM.
2021-07-04 09:27:55 (5532): Disabling Drag and Drop Support for VM.
2021-07-04 09:27:55 (5532): Adding storage controller(s) to VM.
2021-07-04 09:27:55 (5532): Adding virtual disk drive to VM. (vm_image.vdi)
2021-07-04 09:27:56 (5532): Adding VirtualBox Guest Additions to VM.
2021-07-04 09:27:56 (5532): Adding network bandwidth throttle group to VM. (Defaulting to 1024GB)
2021-07-04 09:27:56 (5532): forwarding host port 21042 to guest port 80
2021-07-04 09:27:56 (5532): Enabling remote desktop for VM.
2021-07-04 09:27:57 (5532): Required extension pack not installed, remote desktop not enabled.
2021-07-04 09:27:57 (5532): Enabling shared directory for VM.
2021-07-04 09:27:57 (5532): Starting VM using VBoxManage interface. (boinc_a5599952adb3b103, slot#1)
2021-07-04 09:28:03 (5532): Successfully started VM. (PID = '7324')
2021-07-04 09:28:03 (5532): Reporting VM Process ID to BOINC.
2021-07-04 09:28:03 (5532): Guest Log: BIOS: VirtualBox 6.1.22

2021-07-04 09:28:03 (5532): Guest Log: CPUID EDX: 0x178bfbff

2021-07-04 09:28:03 (5532): Guest Log: BIOS: ata0-0: PCHS=16383/16/63 LCHS=1024/255/63

2021-07-04 09:28:03 (5532): VM state change detected. (old = 'PoweredOff', new = 'Running')
2021-07-04 09:28:03 (5532): Detected: Web Application Enabled (http://localhost:21042)
2021-07-04 09:28:03 (5532): Preference change detected
2021-07-04 09:28:03 (5532): Setting CPU throttle for VM. (50%)
2021-07-04 09:28:03 (5532): Setting checkpoint interval to 666 seconds. (Higher value of (Preference: 120 seconds) or (Vbox_job.xml: 666 seconds))
2021-07-04 09:28:05 (5532): Guest Log: BIOS: Boot : bseqnr=1, bootseq=0032

2021-07-04 09:28:05 (5532): Guest Log: BIOS: Booting from Hard Disk...

2021-07-04 09:28:07 (5532): Guest Log: BIOS: KBD: unsupported int 16h function 03

2021-07-04 09:28:07 (5532): Guest Log: BIOS: AX=0305 BX=0000 CX=0000 DX=0000 

2021-07-04 09:28:45 (5532): Guest Log: vgdrvHeartbeatInit: Setting up heartbeat to trigger every 2000 milliseconds

2021-07-04 09:28:45 (5532): Guest Log: vboxguest: misc device minor 56, IRQ 20, I/O port d020, MMIO at 00000000f0400000 (size 0x400000)

2021-07-04 09:28:50 (5532): Guest Log: VBoxService 5.2.6 r120293 (verbosity: 0) linux.amd64 (Jan 15 2018 14:51:00) release log

2021-07-04 09:28:50 (5532): Guest Log: 00:00:00.000145 main     Log opened 2021-07-04T07:28:51.239070000Z

2021-07-04 09:28:50 (5532): Guest Log: 00:00:00.000272 main     OS Product: Linux

2021-07-04 09:28:50 (5532): Guest Log: 00:00:00.000310 main     OS Release: 4.14.76-13.cernvm.x86_64

2021-07-04 09:28:50 (5532): Guest Log: 00:00:00.000363 main     OS Version: #1 SMP Tue Oct 16 18:26:15 CEST 2018

2021-07-04 09:28:50 (5532): Guest Log: 00:00:00.000398 main     Executable: /usr/sbin/VBoxService

2021-07-04 09:28:50 (5532): Guest Log: 00:00:00.000399 main     Process ID: 3211

2021-07-04 09:28:50 (5532): Guest Log: 00:00:00.000400 main     Package type: LINUX_64BITS_GENERIC

2021-07-04 09:28:50 (5532): Guest Log: 00:00:00.003516 main     5.2.6 r120293 started. Verbose level = 0

2021-07-04 09:29:35 (5532): Guest Log: 09:29:35 CEST +02:00 2021-07-04: cranky: [INFO] Detected Theory App

2021-07-04 09:29:35 (5532): Guest Log: 09:29:35 CEST +02:00 2021-07-04: cranky: [INFO] Checking CVMFS.

2021-07-04 09:29:37 (5532): Guest Log: Probing /cvmfs/sft.cern.ch... OK

2021-07-04 09:29:39 (5532): 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

2021-07-04 09:29:39 (5532): Guest Log: 2.5.2.0 4106 0 28388 20524 3 1 265902 4096000 0 65024 0 0 n/a 5 9 http://s1cern-cvmfs.openhtc.io/cvmfs/sft.cern.ch DIRECT 1

2021-07-04 09:29:42 (5532): Guest Log: Probing /cvmfs/grid.cern.ch... OK

2021-07-04 09:29:43 (5532): 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

2021-07-04 09:29:43 (5532): Guest Log: 2.5.2.0 4129 0 27536 15619 3 2 265902 4096000 0 65024 0 2 -100 6413 4574 http://s1cern-cvmfs.openhtc.io/cvmfs/grid.cern.ch DIRECT 1

2021-07-04 09:29:46 (5532): Guest Log: Probing /cvmfs/cernvm-prod.cern.ch... OK

2021-07-04 09:29:48 (5532): 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

2021-07-04 09:29:48 (5532): Guest Log: 2.5.2.0 4059 0 27240 267 3 1 265902 4096000 0 65024 0 0 n/a 4 11 http://s1cern-cvmfs.openhtc.io/cvmfs/cernvm-prod.cern.ch DIRECT 1

2021-07-04 09:29:51 (5532): Guest Log: Probing /cvmfs/alice.cern.ch... OK

2021-07-04 09:29:52 (5532): 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

2021-07-04 09:29:52 (5532): Guest Log: 2.5.2.0 4082 0 31384 9638 3 1 265902 4096000 0 65024 0 0 n/a 5074 2686 http://s1ral-cvmfs.openhtc.io/cvmfs/alice.cern.ch DIRECT 1

2021-07-04 09:29:52 (5532): Guest Log: 09:29:52 CEST +02:00 2021-07-04: cranky: [INFO] Checking runc.

2021-07-04 09:29:52 (5532): Guest Log: 09:29:52 CEST +02:00 2021-07-04: cranky: [INFO] Creating the filesystem.

2021-07-04 09:29:52 (5532): Guest Log: 09:29:53 CEST +02:00 2021-07-04: cranky: [INFO] Using /cvmfs/cernvm-prod.cern.ch/cvm3

2021-07-04 09:29:52 (5532): Guest Log: 09:29:53 CEST +02:00 2021-07-04: cranky: [INFO] Updating config.json.

2021-07-04 09:29:52 (5532): Guest Log: 09:29:53 CEST +02:00 2021-07-04: cranky: [INFO] Running Container 'runc'.

2021-07-04 09:29:57 (5532): Guest Log: job: htmld=/shared/html/job

2021-07-04 09:29:57 (5532): Guest Log: job: unpack exitcode=0

2021-07-04 09:29:59 (5532): Guest Log: 09:29:59 CEST +02:00 2021-07-04: cranky: [INFO] ===> [runRivet] Sun Jul  4 07:29:57 UTC 2021 [boinc ppbar zinclusive 1960 -,-,50,120 - pythia8 8.244 default-DL 100000 193]

2021-07-04 09:33:05 (5532): Preference change detected
2021-07-04 09:33:05 (5532): Setting CPU throttle for VM. (100%)
2021-07-04 09:33:05 (5532): Setting checkpoint interval to 666 seconds. (Higher value of (Preference: 120 seconds) or (Vbox_job.xml: 666 seconds))
2021-07-04 09:34:02 (5532): Preference change detected
2021-07-04 09:34:02 (5532): Setting CPU throttle for VM. (100%)
2021-07-04 09:34:02 (5532): Setting checkpoint interval to 666 seconds. (Higher value of (Preference: 120 seconds) or (Vbox_job.xml: 666 seconds))
2021-07-04 09:37:00 (5532): VM state change detected. (old = 'Running', new = 'Paused')
2021-07-04 09:38:35 (5532): VM state change detected. (old = 'Paused', new = 'Running')
2021-07-04 09:46:18 (5532): Creating new snapshot for VM.
2021-07-04 09:46:23 (5532): Checkpoint completed.
2021-07-04 09:57:27 (5532): Creating new snapshot for VM.
2021-07-04 09:57:32 (5532): Deleting stale snapshot.
2021-07-04 09:57:33 (5532): Checkpoint completed.
2021-07-04 10:08:34 (5532): Creating new snapshot for VM.
2021-07-04 10:08:39 (5532): Deleting stale snapshot.
2021-07-04 10:08:40 (5532): Checkpoint completed.
2021-07-04 10:19:42 (5532): Creating new snapshot for VM.
2021-07-04 10:19:46 (5532): Deleting stale snapshot.
2021-07-04 10:19:48 (5532): Checkpoint completed.
2021-07-04 10:30:50 (5532): Creating new snapshot for VM.
2021-07-04 10:30:55 (5532): Deleting stale snapshot.
2021-07-04 10:30:56 (5532): Checkpoint completed.
2021-07-04 10:41:57 (5532): Creating new snapshot for VM.
2021-07-04 10:42:02 (5532): Deleting stale snapshot.
2021-07-04 10:42:04 (5532): Checkpoint completed.
2021-07-04 10:53:05 (5532): Creating new snapshot for VM.
2021-07-04 10:53:10 (5532): Deleting stale snapshot.
2021-07-04 10:53:11 (5532): Checkpoint completed.
2021-07-04 11:04:13 (5532): Creating new snapshot for VM.
2021-07-04 11:04:17 (5532): Deleting stale snapshot.
2021-07-04 11:04:18 (5532): Checkpoint completed.
2021-07-04 11:09:49 (5532): Status Report: Elapsed Time: '6000.625458'
2021-07-04 11:09:49 (5532): Status Report: CPU Time: '5702.062500'
2021-07-04 11:15:20 (5532): Creating new snapshot for VM.
2021-07-04 11:15:25 (5532): Deleting stale snapshot.
2021-07-04 11:15:26 (5532): Checkpoint completed.
2021-07-04 11:26:27 (5532): Creating new snapshot for VM.
2021-07-04 11:26:33 (5532): Deleting stale snapshot.
2021-07-04 11:26:34 (5532): Checkpoint completed.
2021-07-04 11:37:35 (5532): Creating new snapshot for VM.
2021-07-04 11:37:40 (5532): Deleting stale snapshot.
2021-07-04 11:37:41 (5532): Checkpoint completed.
2021-07-04 11:48:42 (5532): Creating new snapshot for VM.
2021-07-04 11:48:49 (5532): Deleting stale snapshot.
2021-07-04 11:48:50 (5532): Checkpoint completed.
2021-07-04 11:59:50 (5532): Creating new snapshot for VM.
2021-07-04 11:59:56 (5532): Deleting stale snapshot.
2021-07-04 11:59:57 (5532): Checkpoint completed.
2021-07-04 12:10:57 (5532): Creating new snapshot for VM.
2021-07-04 12:11:02 (5532): Deleting stale snapshot.
2021-07-04 12:11:03 (5532): Checkpoint completed.
2021-07-04 12:22:04 (5532): Creating new snapshot for VM.
2021-07-04 12:22:10 (5532): Deleting stale snapshot.
2021-07-04 12:22:11 (5532): Checkpoint completed.
2021-07-04 12:33:11 (5532): Creating new snapshot for VM.
2021-07-04 12:33:16 (5532): Deleting stale snapshot.
2021-07-04 12:33:17 (5532): Checkpoint completed.
2021-07-04 12:44:19 (5532): Creating new snapshot for VM.
2021-07-04 12:44:24 (5532): Deleting stale snapshot.
2021-07-04 12:44:25 (5532): Checkpoint completed.
2021-07-04 12:49:57 (5532): Status Report: Elapsed Time: '12001.550505'
2021-07-04 12:49:57 (5532): Status Report: CPU Time: '11657.484375'
2021-07-04 12:55:25 (5532): Creating new snapshot for VM.
2021-07-04 12:55:31 (5532): Deleting stale snapshot.
2021-07-04 12:55:32 (5532): Checkpoint completed.
2021-07-04 13:06:33 (5532): Creating new snapshot for VM.
2021-07-04 13:06:38 (5532): Deleting stale snapshot.
2021-07-04 13:06:39 (5532): Checkpoint completed.
2021-07-04 13:17:40 (5532): Creating new snapshot for VM.
2021-07-04 13:17:46 (5532): Deleting stale snapshot.
2021-07-04 13:17:48 (5532): Checkpoint completed.
2021-07-04 13:28:48 (5532): Creating new snapshot for VM.
2021-07-04 13:28:53 (5532): Deleting stale snapshot.
2021-07-04 13:28:54 (5532): Checkpoint completed.
2021-07-04 13:39:55 (5532): Creating new snapshot for VM.
2021-07-04 13:40:02 (5532): Deleting stale snapshot.
2021-07-04 13:40:03 (5532): Checkpoint completed.
2021-07-04 13:51:03 (5532): Creating new snapshot for VM.
2021-07-04 13:51:08 (5532): Deleting stale snapshot.
2021-07-04 13:51:09 (5532): Checkpoint completed.
2021-07-04 14:02:10 (5532): Creating new snapshot for VM.
2021-07-04 14:02:16 (5532): Deleting stale snapshot.
2021-07-04 14:02:17 (5532): Checkpoint completed.
2021-07-04 14:12:40 (5532): Guest Log: job: run exitcode=0

2021-07-04 14:12:40 (5532): Guest Log: job: diskusage=2368

2021-07-04 14:12:40 (5532): Guest Log: job: logsize=68 k

2021-07-04 14:12:40 (5532): Guest Log: job: times=

2021-07-04 14:12:40 (5532): Guest Log: 0m0.014s 0m0.014s

2021-07-04 14:12:40 (5532): Guest Log: 271m30.169s 1m43.550s

2021-07-04 14:12:40 (5532): Guest Log: job: cpuusage=16394

2021-07-04 14:12:40 (5532): Guest Log: 14:09:17 CEST +02:00 2021-07-04: cranky: [INFO] Container 'runc' finished with status code 0.

2021-07-04 14:12:40 (5532): Guest Log: 14:09:17 CEST +02:00 2021-07-04: cranky: [INFO] Preparing output.

2021-07-04 14:12:41 (5532): Guest Log: [INFO] Job Finished

2021-07-04 14:12:41 (5532): Guest Log: [INFO] Shutting Down.

2021-07-04 14:12:41 (5532): VM Completion File Detected.
2021-07-04 14:12:41 (5532): VM Completion Message: Job Finished
.
2021-07-04 14:12:41 (5532): Powering off VM.
2021-07-04 14:17:42 (5532): VM did not power off when requested.
2021-07-04 14:17:42 (5532): VM was successfully terminated.
2021-07-04 14:17:42 (5532): Deregistering VM. (boinc_a5599952adb3b103, slot#1)
2021-07-04 14:17:42 (5532): Deleting stale snapshot.
2021-07-04 14:17:42 (5532): Removing network bandwidth throttle group from VM.
2021-07-04 14:17:43 (5532): Removing VM from VirtualBox.
14:17:48 (5532): called boinc_finish(0)

</stderr_txt>
]]>

©2024 CERN