Stderr output

<core_client_version>7.16.20</core_client_version>
<![CDATA[
<stderr_txt>
2022-12-28 17:58:05 (7992): Detected: vboxwrapper 26206
2022-12-28 17:58:05 (7992): Detected: BOINC client v7.16.20
2022-12-28 17:58:20 (7992): Detected: VirtualBox VboxManage Interface (Version: 6.1.32)
2022-12-28 17:58:20 (7992): Detected: Heartbeat check (file: 'heartbeat' every 1200.000000 seconds)
2022-12-28 17:58:21 (7992): Successfully copied 'init_data.xml' to the shared directory.
2022-12-28 17:58:21 (7992): Successfully copied 'input' to the shared directory.
2022-12-28 17:58:23 (7992): Create VM. (boinc_370c2f8a8d6d0dfc, slot#0)
2022-12-28 17:58:25 (7992): Setting Memory Size for VM. (630MB)
2022-12-28 17:58:26 (7992): Setting CPU Count for VM. (1)
2022-12-28 17:58:27 (7992): Setting Chipset Options for VM.
2022-12-28 17:58:28 (7992): Setting Graphics Controller Options for VM.
2022-12-28 17:58:30 (7992): Setting Boot Options for VM.
2022-12-28 17:58:30 (7992): Setting Network Configuration for NAT.
2022-12-28 17:58:32 (7992): Enabling VM Network Access.
2022-12-28 17:58:35 (7992): Disabling USB Support for VM.
2022-12-28 17:58:55 (7992): Disabling COM Port Support for VM.
2022-12-28 17:59:08 (7992): Disabling LPT Port Support for VM.
2022-12-28 17:59:15 (7992): Disabling Audio Support for VM.
2022-12-28 17:59:22 (7992): Disabling Clipboard Support for VM.
2022-12-28 17:59:23 (7992): Disabling Drag and Drop Support for VM.
2022-12-28 17:59:23 (7992): Adding storage controller(s) to VM.
2022-12-28 17:59:24 (7992): Adding virtual disk drive to VM. (vm_image.vdi)
2022-12-28 17:59:25 (7992): Adding VirtualBox Guest Additions to VM.
2022-12-28 17:59:25 (7992): Adding network bandwidth throttle group to VM. (Defaulting to 1024GB)
2022-12-28 17:59:26 (7992): forwarding host port 60056 to guest port 80
2022-12-28 17:59:28 (7992): Enabling remote desktop for VM.
2022-12-28 17:59:29 (7992): Required extension pack not installed, remote desktop not enabled.
2022-12-28 17:59:29 (7992): Enabling shared directory for VM.
2022-12-28 17:59:32 (7992): Starting VM using VBoxManage interface. (boinc_370c2f8a8d6d0dfc, slot#0)
2022-12-28 17:59:53 (7992): Successfully started VM. (PID = '13520')
2022-12-28 17:59:53 (7992): Reporting VM Process ID to BOINC.
2022-12-28 17:59:53 (7992): Guest Log: BIOS: VirtualBox 6.1.32
2022-12-28 17:59:53 (7992): Guest Log: CPUID EDX: 0x178bfbff
2022-12-28 17:59:53 (7992): Guest Log: BIOS: No PCI IDE controller, not probing IDE
2022-12-28 17:59:53 (7992): Guest Log: BIOS: AHCI 0-P#0: PCHS=16383/16/63 LCHS=1024/255/63 0x0000000002800000 sectors
2022-12-28 17:59:53 (7992): Guest Log: BIOS: Boot : bseqnr=1, bootseq=0032
2022-12-28 17:59:53 (7992): Guest Log: BIOS: Booting from Hard Disk...
2022-12-28 17:59:53 (7992): Guest Log: BIOS: KBD: unsupported int 16h function 03
2022-12-28 17:59:53 (7992): Guest Log: BIOS: AX=0305 BX=0000 CX=0000 DX=0000 
2022-12-28 17:59:53 (7992): VM state change detected. (old = 'poweredoff', new = 'running')
2022-12-28 17:59:58 (7992): Detected: Web Application Enabled (http://localhost:60056)
2022-12-28 17:59:58 (7992): Preference change detected
2022-12-28 17:59:58 (7992): Setting CPU throttle for VM. (100%)
2022-12-28 18:00:09 (7992): Setting checkpoint interval to 600 seconds. (Higher value of (Preference: 60 seconds) or (Vbox_job.xml: 600 seconds))
2022-12-28 18:00:18 (7992): VM state change detected. (old = 'running', new = 'paused')
2022-12-28 18:00:35 (7992): VM state change detected. (old = 'paused', new = 'running')
2022-12-28 18:01:40 (7992): Guest Log: vgdrvHeartbeatInit: Setting up heartbeat to trigger every 2000 milliseconds
2022-12-28 18:01:40 (7992): Guest Log: vboxguest: misc device minor 56, IRQ 20, I/O port d020, MMIO at 00000000f0400000 (size 0x400000)
2022-12-28 18:01:40 (7992): Guest Log: VBoxService 5.2.6 r120293 (verbosity: 0) linux.amd64 (Jan 15 2018 14:51:00) release log
2022-12-28 18:01:40 (7992): Guest Log: 00:00:00.000332 main     Log opened 2022-12-28T23:01:00.574736000Z
2022-12-28 18:01:40 (7992): Guest Log: 00:00:00.000617 main     OS Product: Linux
2022-12-28 18:01:40 (7992): Guest Log: 00:00:00.000713 main     OS Release: 4.14.76-13.cernvm.x86_64
2022-12-28 18:01:40 (7992): Guest Log: 00:00:00.000843 main     OS Version: #1 SMP Tue Oct 16 18:26:15 CEST 2018
2022-12-28 18:01:40 (7992): Guest Log: 00:00:00.000935 main     Executable: /usr/sbin/VBoxService
2022-12-28 18:01:40 (7992): Guest Log: 00:00:00.000939 main     Process ID: 3244
2022-12-28 18:01:40 (7992): Guest Log: 00:00:00.000941 main     Package type: LINUX_64BITS_GENERIC
2022-12-28 18:01:40 (7992): Guest Log: 00:00:00.009949 main     5.2.6 r120293 started. Verbose level = 0
2022-12-28 18:01:40 (7992): VM state change detected. (old = 'running', new = 'paused')
2022-12-28 18:02:10 (7992): VM state change detected. (old = 'paused', new = 'running')
2022-12-28 18:02:21 (7992): VM state change detected. (old = 'running', new = 'paused')
2022-12-28 18:02:42 (7992): VM state change detected. (old = 'paused', new = 'running')
2022-12-28 18:03:17 (7992): Guest Log: 18:02:01 EST -05:00 2022-12-28: cranky: [INFO] Detected Theory App
2022-12-28 18:03:17 (7992): Guest Log: 18:02:02 EST -05:00 2022-12-28: cranky: [INFO] Checking CVMFS.
2022-12-28 18:03:17 (7992): Guest Log: Probing /cvmfs/sft.cern.ch... OK
2022-12-28 18:03:17 (7992): 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
2022-12-28 18:03:17 (7992): Guest Log: 2.5.2.0 4146 0 27168 24663 3 1 289481 4096000 0 65024 0 0 n/a 5 3 http://s1cern-cvmfs.openhtc.io/cvmfs/sft.cern.ch DIRECT 1
2022-12-28 18:03:17 (7992): Guest Log: Probing /cvmfs/grid.cern.ch... OK
2022-12-28 18:03:17 (7992): 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
2022-12-28 18:03:17 (7992): Guest Log: 2.5.2.0 4123 0 27416 20125 3 2 289481 4096000 0 65024 0 2 -100 7811 2291 http://s1cern-cvmfs.openhtc.io/cvmfs/grid.cern.ch DIRECT 1
2022-12-28 18:03:17 (7992): Guest Log: Probing /cvmfs/cernvm-prod.cern.ch... OK
2022-12-28 18:03:17 (7992): 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
2022-12-28 18:03:17 (7992): Guest Log: 2.5.2.0 4098 0 27248 268 3 1 289481 4096000 0 65024 0 0 n/a 4 3 http://s1ral-cvmfs.openhtc.io/cvmfs/cernvm-prod.cern.ch DIRECT 1
2022-12-28 18:03:17 (7992): Guest Log: Probing /cvmfs/alice.cern.ch... OK
2022-12-28 18:03:17 (7992): 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
2022-12-28 18:03:17 (7992): Guest Log: 2.5.2.0 4175 0 32064 14212 3 1 289481 4096000 0 65024 0 0 n/a 15368 1648 http://s1bnl-cvmfs.openhtc.io/cvmfs/alice.cern.ch DIRECT 1
2022-12-28 18:03:17 (7992): Guest Log: 18:02:25 EST -05:00 2022-12-28: cranky: [INFO] Checking runc.
2022-12-28 18:03:17 (7992): Guest Log: 18:02:25 EST -05:00 2022-12-28: cranky: [INFO] Creating the filesystem.
2022-12-28 18:03:17 (7992): Guest Log: 18:02:25 EST -05:00 2022-12-28: cranky: [INFO] Using /cvmfs/cernvm-prod.cern.ch/cvm3
2022-12-28 18:03:17 (7992): Guest Log: 18:02:26 EST -05:00 2022-12-28: cranky: [INFO] Updating config.json.
2022-12-28 18:03:17 (7992): Guest Log: 18:02:27 EST -05:00 2022-12-28: cranky: [INFO] Running Container 'runc'.
2022-12-28 18:03:17 (7992): VM state change detected. (old = 'running', new = 'paused')
2022-12-28 18:03:50 (7992): VM state change detected. (old = 'paused', new = 'running')
2022-12-28 18:04:05 (7992): VM state change detected. (old = 'running', new = 'paused')
2022-12-28 18:07:11 (7992): VM state change detected. (old = 'paused', new = 'running')
2022-12-28 18:07:20 (7992): Guest Log: job: htmld=/shared/html/job
2022-12-28 18:07:20 (7992): Guest Log: job: unpack exitcode=0
2022-12-28 18:07:21 (7992): Guest Log: 18:02:53 EST -05:00 2022-12-28: cranky: [INFO] ===> [runRivet] Wed Dec 28 23:02:53 UTC 2022 [boinc pp jets 7000 150 - pythia8 8.186 default-noFsr 100000 320]
2022-12-28 18:09:21 (7992): VM state change detected. (old = 'running', new = 'paused')
2022-12-28 18:09:31 (7992): VM state change detected. (old = 'paused', new = 'running')
2022-12-28 18:11:41 (7992): VM state change detected. (old = 'running', new = 'paused')
2022-12-28 18:12:11 (7992): VM state change detected. (old = 'paused', new = 'running')
2022-12-28 18:14:13 (7992): VM state change detected. (old = 'running', new = 'paused')
2022-12-28 18:15:42 (7992): VM state change detected. (old = 'paused', new = 'running')
2022-12-28 18:20:11 (7992): VM state change detected. (old = 'running', new = 'paused')
2023-01-09 21:51:07 (7992): VM state change detected. (old = 'paused', new = 'running')
2023-01-09 21:51:21 (7992): Guest Log: 00:12:40.499785 timesync vgsvcTimeSyncWorker: Radical host time change: 1 049 462 806 000 000ns (HostNow=1 673 319 068 449 000 000 ns HostLast=1 672 269 605 643 000 000 ns)
2023-01-09 21:51:21 (7992): Guest Log: 00:12:50.511204 timesync vgsvcTimeSyncWorker: Radical guest time change: 1 049 857 672 252 000ns (GuestNow=1 673 319 078 467 574 000 ns GuestLast=1 672 269 220 795 322 000 ns fSetTimeLastLoop=true )
2023-01-09 21:51:21 (7992): VM state change detected. (old = 'running', new = 'paused')
2023-01-09 21:51:38 (7992): VM state change detected. (old = 'paused', new = 'running')
2023-01-09 21:51:52 (7992): VM state change detected. (old = 'running', new = 'paused')
2023-01-09 21:56:45 (7992): VM state change detected. (old = 'paused', new = 'running')
2023-01-09 21:57:02 (7992): VM state change detected. (old = 'running', new = 'paused')
2023-01-09 21:57:19 (7992): VM state change detected. (old = 'paused', new = 'running')
2023-01-09 21:57:32 (7992): VM state change detected. (old = 'running', new = 'paused')
2023-01-09 21:59:51 (7992): VM state change detected. (old = 'paused', new = 'running')
2023-01-09 22:00:02 (7992): VM state change detected. (old = 'running', new = 'paused')
2023-01-09 22:00:50 (7992): VM state change detected. (old = 'paused', new = 'running')
2023-01-09 22:01:00 (7992): VM state change detected. (old = 'running', new = 'paused')
2023-01-09 22:01:31 (7992): VM state change detected. (old = 'paused', new = 'running')
2023-01-09 22:01:42 (7992): VM state change detected. (old = 'running', new = 'paused')
2023-01-09 22:03:15 (7992): VM state change detected. (old = 'paused', new = 'running')
2023-01-09 22:03:22 (7992): VM state change detected. (old = 'running', new = 'paused')
2023-01-09 22:05:27 (7992): VM state change detected. (old = 'paused', new = 'running')
2023-01-09 22:05:33 (7992): VM state change detected. (old = 'running', new = 'paused')
2023-01-09 22:05:53 (7992): VM state change detected. (old = 'paused', new = 'running')
2023-01-09 22:06:07 (7992): VM state change detected. (old = 'running', new = 'paused')
2023-01-09 22:08:05 (7992): VM state change detected. (old = 'paused', new = 'running')
2023-01-09 22:08:15 (7992): VM state change detected. (old = 'running', new = 'paused')
2023-01-09 22:08:25 (7992): VM state change detected. (old = 'paused', new = 'running')
2023-01-09 22:08:34 (7992): Guest Log: job: run exitcode=1
2023-01-09 22:08:34 (7992): Guest Log: job: diskusage=2816
2023-01-09 22:08:34 (7992): Guest Log: job: logsize=28 k
2023-01-09 22:08:34 (7992): Guest Log: job: times=
2023-01-09 22:08:34 (7992): Guest Log: 0m0.093s 0m0.188s
2023-01-09 22:08:34 (7992): Guest Log: 0m49.032s 0m18.173s
2023-01-09 22:08:34 (7992): Guest Log: job: cpuusage=67
2023-01-09 22:08:34 (7992): Guest Log: 21:53:32 EST -05:00 2023-01-09: cranky: [INFO] Container 'runc' finished with status code 1.
2023-01-09 22:08:34 (7992): Guest Log: 21:53:32 EST -05:00 2023-01-09: cranky: [INFO] Preparing output.
2023-01-09 22:08:35 (7992): VM state change detected. (old = 'running', new = 'paused')
2023-01-09 22:09:47 (7992): Guest Log: [INFO] Job Finished
2023-01-09 22:09:47 (7992): Guest Log: [INFO] Shutting Down.
2023-01-09 22:09:47 (7992): VM state change detected. (old = 'paused', new = 'running')
2023-01-09 22:09:47 (7992): VM Completion File Detected.
2023-01-09 22:09:47 (7992): VM Completion Message: Job Finished
.
2023-01-09 22:09:47 (7992): Powering off VM.
2023-01-09 22:09:53 (7992): Successfully stopped VM.
2023-01-09 22:09:53 (7992): Deregistering VM. (boinc_370c2f8a8d6d0dfc, slot#0)
2023-01-09 22:09:55 (7992): Removing network bandwidth throttle group from VM.
2023-01-09 22:09:56 (7992): Removing VM from VirtualBox.
22:10:01 (7992): called boinc_finish(0)

</stderr_txt>
]]>

©2025 CERN