Name Theory_2794-3262103-8_1
Workunit 225859176
Created 5 Oct 2024, 22:10:50 UTC
Sent 6 Oct 2024, 1:38:03 UTC
Report deadline 17 Oct 2024, 1:38:03 UTC
Received 20 Oct 2024, 12:05:12 UTC
Server state Over
Outcome Success
Client state Done
Exit status 0 (0x00000000)
Computer ID 10642557
Run time 5 days 10 hours 15 min 28 sec
CPU time 5 days 7 hours 28 min 58 sec
Validate state Valid
Credit 8,332.16
Device peak FLOPS 7.68 GFLOPS
Application version Theory Simulation v300.30 (vbox64_theory)
x86_64-pc-linux-gnu
Peak working set size 693.63 MB
Peak swap size 2.02 GB
Peak disk usage 7.01 GB

Stderr output

<core_client_version>8.0.2</core_client_version>
<![CDATA[
<stderr_txt>
2024-10-14 21:10:13 (26244): vboxwrapper version 26207
2024-10-14 21:10:13 (26244): BOINC client version: 8.0.2
2024-10-14 21:10:13 (26244): Detected: VirtualBox VboxManage Interface (Version: 7.1.2)
2024-10-14 21:10:13 (26244): Detected: Heartbeat check (file: 'heartbeat' every 1200.000000 seconds)
2024-10-14 21:10:13 (26244): Successfully copied 'init_data.xml' to the shared directory.
2024-10-14 21:10:13 (26244): Successfully copied 'input' to the shared directory.
2024-10-14 21:10:13 (26244): Create VM. (boinc_7607e99a93e74b2a, slot#1)
2024-10-14 21:10:13 (26244): Setting Memory Size for VM. (630MB)
2024-10-14 21:10:13 (26244): Setting CPU Count for VM. (1)
2024-10-14 21:10:13 (26244): Setting Chipset Options for VM.
2024-10-14 21:10:13 (26244): Setting Graphics Controller Options for VM.
2024-10-14 21:10:13 (26244): Setting Boot Options for VM.
2024-10-14 21:10:13 (26244): Setting Network Configuration for NAT.
2024-10-14 21:10:13 (26244): Enabling VM Network Access.
2024-10-14 21:10:14 (26244): Disabling USB Support for VM.
2024-10-14 21:10:14 (26244): Disabling COM Port Support for VM.
2024-10-14 21:10:14 (26244): Disabling LPT Port Support for VM.
2024-10-14 21:10:14 (26244): Disabling Audio Support for VM.
2024-10-14 21:10:14 (26244): Disabling Clipboard Support for VM.
2024-10-14 21:10:14 (26244): Disabling Drag and Drop Support for VM.
2024-10-14 21:10:14 (26244): Adding storage controller(s) to VM.
2024-10-14 21:10:14 (26244): Adding virtual disk drive to VM. (Theory_2024_04_30_prod.vdi)
2024-10-14 21:10:15 (26244): Attempts: 2
2024-10-14 21:10:16 (26244): Adding VirtualBox Guest Additions to VM.
2024-10-14 21:10:16 (26244): Adding network bandwidth throttle group to VM. (Defaulting to 1024GB)
2024-10-14 21:10:16 (26244): forwarding host port 55493 to guest port 80
2024-10-14 21:10:16 (26244): Enabling remote desktop for VM.
2024-10-14 21:10:16 (26244): Required extension pack not installed, remote desktop not enabled.
2024-10-14 21:10:16 (26244): Enabling shared directory for VM.
2024-10-14 21:10:16 (26244): Starting VM using VBoxManage interface. (boinc_7607e99a93e74b2a, slot#1)
2024-10-14 21:10:17 (26244): Successfully started VM. (PID = '27890')
2024-10-14 21:10:17 (26244): Reporting VM Process ID to BOINC.
2024-10-14 21:10:17 (26244): Guest Log: BIOS: VirtualBox 7.1.2
2024-10-14 21:10:17 (26244): Guest Log: CPUID EDX: 0x178bfbff
2024-10-14 21:10:17 (26244): Guest Log: BIOS: No PCI IDE controller, not probing IDE
2024-10-14 21:10:17 (26244): Guest Log: BIOS: AHCI 0-P#0: PCHS=16383/16/63 LCHS=1024/255/63 0x0000000002800000 sectors
2024-10-14 21:10:17 (26244): VM state change detected. (old = 'poweredoff', new = 'running')
2024-10-14 21:10:17 (26244): Detected: Web Application Enabled (http://localhost:55493)
2024-10-14 21:10:17 (26244): Preference change detected
2024-10-14 21:10:17 (26244): Setting CPU throttle for VM. (100%)
2024-10-14 21:10:17 (26244): Setting checkpoint interval to 600 seconds. (Higher value of (Preference: 60 seconds) or (Vbox_job.xml: 600 seconds))
2024-10-14 21:10:19 (26244): Guest Log: BIOS: Boot : bseqnr=1, bootseq=0032
2024-10-14 21:10:19 (26244): Guest Log: BIOS: Booting from Hard Disk...
2024-10-14 21:10:22 (26244): Guest Log: BIOS: KBD: unsupported int 16h function 03
2024-10-14 21:10:22 (26244): Guest Log: BIOS: AX=0305 BX=0000 CX=0000 DX=0000 
2024-10-14 21:10:43 (26244): Guest Log: vgdrvHeartbeatInit: Setting up heartbeat to trigger every 2000 milliseconds
2024-10-14 21:10:43 (26244): Guest Log: vboxguest: misc device minor 56, IRQ 20, I/O port d020, MMIO at 00000000f0400000 (size 0x400000)
2024-10-14 21:10:45 (26244): Guest Log: VBoxService 5.2.6 r120293 (verbosity: 0) linux.amd64 (Jan 15 2018 14:51:00) release log
2024-10-14 21:10:45 (26244): Guest Log: 00:00:00.000074 main     Log opened 2024-10-15T01:10:50.193243000Z
2024-10-14 21:10:45 (26244): Guest Log: 00:00:00.000141 main     OS Product: Linux
2024-10-14 21:10:45 (26244): Guest Log: 00:00:00.000153 main     OS Release: 4.14.76-13.cernvm.x86_64
2024-10-14 21:10:45 (26244): Guest Log: 00:00:00.000162 main     OS Version: #1 SMP Tue Oct 16 18:26:15 CEST 2018
2024-10-14 21:10:45 (26244): Guest Log: 00:00:00.000170 main     Executable: /usr/sbin/VBoxService
2024-10-14 21:10:45 (26244): Guest Log: 00:00:00.000170 main     Process ID: 3219
2024-10-14 21:10:45 (26244): Guest Log: 00:00:00.000171 main     Package type: LINUX_64BITS_GENERIC
2024-10-14 21:10:45 (26244): Guest Log: 00:00:00.004395 main     5.2.6 r120293 started. Verbose level = 0
2024-10-14 21:11:01 (26244): Guest Log: 21:11:06 EDT -04:00 2024-10-14: cranky: [INFO] Detected Theory App
2024-10-14 21:11:01 (26244): Guest Log: 21:11:06 EDT -04:00 2024-10-14: cranky: [INFO] Checking CVMFS.
2024-10-14 21:11:02 (26244): Guest Log: Probing /cvmfs/sft.cern.ch... OK
2024-10-14 21:11:02 (26244): 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
2024-10-14 21:11:02 (26244): Guest Log: 2.5.2.0 4099 0 26328 30730 3 1 277907 4096000 0 65024 0 0 n/a 5 6 http://s1unl-cvmfs.openhtc.io/cvmfs/sft.cern.ch DIRECT 1
2024-10-14 21:11:02 (26244): Guest Log: Probing /cvmfs/grid.cern.ch... OK
2024-10-14 21:11:02 (26244): 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
2024-10-14 21:11:02 (26244): Guest Log: 2.5.2.0 4053 0 25488 25481 3 2 277907 4096000 0 65024 0 2 -100 10072 7912 http://s1bnl-cvmfs.openhtc.io/cvmfs/grid.cern.ch DIRECT 1
2024-10-14 21:11:03 (26244): Guest Log: Probing /cvmfs/cernvm-prod.cern.ch... OK
2024-10-14 21:11:03 (26244): 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
2024-10-14 21:11:03 (26244): Guest Log: 2.5.2.0 4122 0 27212 272 3 1 277907 4096000 0 65024 0 0 n/a 4 5 http://s1unl-cvmfs.openhtc.io/cvmfs/cernvm-prod.cern.ch DIRECT 1
2024-10-14 21:11:03 (26244): Guest Log: Probing /cvmfs/alice.cern.ch... OK
2024-10-14 21:11:03 (26244): 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
2024-10-14 21:11:03 (26244): Guest Log: 2.5.2.0 4077 0 39660 20038 3 1 277907 4096000 0 65024 0 0 n/a 6170 3730 http://s1unl-cvmfs.openhtc.io/cvmfs/alice.cern.ch DIRECT 1
2024-10-14 21:11:03 (26244): Guest Log: 21:11:08 EDT -04:00 2024-10-14: cranky: [INFO] Checking runc.
2024-10-14 21:11:04 (26244): Guest Log: 21:11:08 EDT -04:00 2024-10-14: cranky: [INFO] Creating the filesystem.
2024-10-14 21:11:04 (26244): Guest Log: 21:11:08 EDT -04:00 2024-10-14: cranky: [INFO] Using /cvmfs/cernvm-prod.cern.ch/cvm4
2024-10-14 21:11:04 (26244): Guest Log: 21:11:09 EDT -04:00 2024-10-14: cranky: [INFO] Updating config.json.
2024-10-14 21:11:04 (26244): Guest Log: 21:11:09 EDT -04:00 2024-10-14: cranky: [INFO] Running Container 'runc'.
2024-10-14 21:11:08 (26244): Guest Log: job: htmld=/shared/html/job
2024-10-14 21:11:09 (26244): Guest Log: job: unpack exitcode=0
2024-10-14 21:11:09 (26244): Guest Log: INFO: activated the work-around for ld:
2024-10-14 21:11:09 (26244): Guest Log: lrwxrwxrwx 1 0 0 15 Oct 15 01:11 /tmp/tmp.ciMFA242Hz/ld -> /usr/bin/ld.bfd
2024-10-14 21:11:11 (26244): Guest Log: 21:11:16 EDT -04:00 2024-10-14: cranky: [INFO] ===> [runRivet] Tue Oct 15 01:11:14 UTC 2024 [boinc pp z1j 7000 150 - herwig7 7.2.1 nlo-dipole 100000 8]
2024-10-14 22:35:09 (26244): VM state change detected. (old = 'running', new = 'paused')
2024-10-14 22:35:29 (26244): VM state change detected. (old = 'paused', new = 'running')
2024-10-14 22:47:52 (26244): VM state change detected. (old = 'running', new = 'paused')
2024-10-14 22:48:13 (26244): VM state change detected. (old = 'paused', new = 'running')
2024-10-14 22:50:03 (26244): Status Report: Job Duration: '864000.000000'
2024-10-14 22:50:03 (26244): Status Report: Elapsed Time: '6000.000000'
2024-10-14 22:50:03 (26244): Status Report: CPU Time: '5279.490000'
2024-10-14 22:57:45 (26244): VM state change detected. (old = 'running', new = 'paused')
2024-10-14 22:58:05 (26244): VM state change detected. (old = 'paused', new = 'running')
2024-10-15 00:29:28 (26244): Status Report: Job Duration: '864000.000000'
2024-10-15 00:29:28 (26244): Status Report: Elapsed Time: '12000.000000'
2024-10-15 00:29:28 (26244): Status Report: CPU Time: '11097.750000'
2024-10-15 00:36:38 (26244): VM state change detected. (old = 'running', new = 'paused')
2024-10-15 00:36:57 (26244): VM state change detected. (old = 'paused', new = 'running')
2024-10-15 02:08:53 (26244): Status Report: Job Duration: '864000.000000'
2024-10-15 02:08:53 (26244): Status Report: Elapsed Time: '18000.000000'
2024-10-15 02:08:53 (26244): Status Report: CPU Time: '16927.450000'
2024-10-15 03:47:58 (26244): Status Report: Job Duration: '864000.000000'
2024-10-15 03:47:58 (26244): Status Report: Elapsed Time: '24000.000000'
2024-10-15 03:47:58 (26244): Status Report: CPU Time: '22758.610000'
2024-10-15 05:27:03 (26244): Status Report: Job Duration: '864000.000000'
2024-10-15 05:27:03 (26244): Status Report: Elapsed Time: '30000.000000'
2024-10-15 05:27:03 (26244): Status Report: CPU Time: '28588.450000'
2024-10-15 07:06:08 (26244): Status Report: Job Duration: '864000.000000'
2024-10-15 07:06:08 (26244): Status Report: Elapsed Time: '36000.000000'
2024-10-15 07:06:08 (26244): Status Report: CPU Time: '34419.340000'
2024-10-15 08:45:12 (26244): Status Report: Job Duration: '864000.000000'
2024-10-15 08:45:12 (26244): Status Report: Elapsed Time: '42000.000000'
2024-10-15 08:45:12 (26244): Status Report: CPU Time: '40249.730000'
2024-10-15 10:24:17 (26244): Status Report: Job Duration: '864000.000000'
2024-10-15 10:24:17 (26244): Status Report: Elapsed Time: '48000.000000'
2024-10-15 10:24:17 (26244): Status Report: CPU Time: '46064.820000'
2024-10-15 12:03:22 (26244): Status Report: Job Duration: '864000.000000'
2024-10-15 12:03:22 (26244): Status Report: Elapsed Time: '54000.000000'
2024-10-15 12:03:22 (26244): Status Report: CPU Time: '51893.610000'
2024-10-15 13:42:27 (26244): Status Report: Job Duration: '864000.000000'
2024-10-15 13:42:27 (26244): Status Report: Elapsed Time: '60000.000000'
2024-10-15 13:42:27 (26244): Status Report: CPU Time: '57724.850000'
2024-10-15 15:21:33 (26244): Status Report: Job Duration: '864000.000000'
2024-10-15 15:21:33 (26244): Status Report: Elapsed Time: '66000.000000'
2024-10-15 15:21:33 (26244): Status Report: CPU Time: '63555.550000'
2024-10-15 17:00:38 (26244): Status Report: Job Duration: '864000.000000'
2024-10-15 17:00:38 (26244): Status Report: Elapsed Time: '72000.000000'
2024-10-15 17:00:38 (26244): Status Report: CPU Time: '69386.410000'
2024-10-15 18:39:43 (26244): Status Report: Job Duration: '864000.000000'
2024-10-15 18:39:43 (26244): Status Report: Elapsed Time: '78000.000000'
2024-10-15 18:39:43 (26244): Status Report: CPU Time: '75217.160000'
2024-10-15 20:18:47 (26244): Status Report: Job Duration: '864000.000000'
2024-10-15 20:18:47 (26244): Status Report: Elapsed Time: '84000.000000'
2024-10-15 20:18:47 (26244): Status Report: CPU Time: '80985.120000'
2024-10-15 21:57:51 (26244): Status Report: Job Duration: '864000.000000'
2024-10-15 21:57:51 (26244): Status Report: Elapsed Time: '90000.000000'
2024-10-15 21:57:51 (26244): Status Report: CPU Time: '86787.100000'
2024-10-15 23:36:57 (26244): Status Report: Job Duration: '864000.000000'
2024-10-15 23:36:57 (26244): Status Report: Elapsed Time: '96000.000000'
2024-10-15 23:36:57 (26244): Status Report: CPU Time: '92614.660000'
2024-10-16 01:16:02 (26244): Status Report: Job Duration: '864000.000000'
2024-10-16 01:16:02 (26244): Status Report: Elapsed Time: '102000.000000'
2024-10-16 01:16:02 (26244): Status Report: CPU Time: '98442.070000'
2024-10-16 02:55:07 (26244): Status Report: Job Duration: '864000.000000'
2024-10-16 02:55:07 (26244): Status Report: Elapsed Time: '108000.000000'
2024-10-16 02:55:07 (26244): Status Report: CPU Time: '104268.330000'
2024-10-16 04:34:13 (26244): Status Report: Job Duration: '864000.000000'
2024-10-16 04:34:13 (26244): Status Report: Elapsed Time: '114000.000000'
2024-10-16 04:34:13 (26244): Status Report: CPU Time: '110095.660000'
2024-10-16 06:13:18 (26244): Status Report: Job Duration: '864000.000000'
2024-10-16 06:13:18 (26244): Status Report: Elapsed Time: '120000.000000'
2024-10-16 06:13:18 (26244): Status Report: CPU Time: '115922.860000'
2024-10-16 07:52:24 (26244): Status Report: Job Duration: '864000.000000'
2024-10-16 07:52:24 (26244): Status Report: Elapsed Time: '126000.000000'
2024-10-16 07:52:24 (26244): Status Report: CPU Time: '121749.920000'
2024-10-16 09:31:29 (26244): Status Report: Job Duration: '864000.000000'
2024-10-16 09:31:29 (26244): Status Report: Elapsed Time: '132000.000000'
2024-10-16 09:31:29 (26244): Status Report: CPU Time: '127570.710000'
2024-10-16 11:10:35 (26244): Status Report: Job Duration: '864000.000000'
2024-10-16 11:10:35 (26244): Status Report: Elapsed Time: '138000.000000'
2024-10-16 11:10:35 (26244): Status Report: CPU Time: '133398.510000'
2024-10-16 12:49:40 (26244): Status Report: Job Duration: '864000.000000'
2024-10-16 12:49:40 (26244): Status Report: Elapsed Time: '144000.000000'
2024-10-16 12:49:40 (26244): Status Report: CPU Time: '139225.980000'
2024-10-16 14:28:45 (26244): Status Report: Job Duration: '864000.000000'
2024-10-16 14:28:45 (26244): Status Report: Elapsed Time: '150000.000000'
2024-10-16 14:28:45 (26244): Status Report: CPU Time: '145052.250000'
2024-10-16 16:07:51 (26244): Status Report: Job Duration: '864000.000000'
2024-10-16 16:07:51 (26244): Status Report: Elapsed Time: '156000.000000'
2024-10-16 16:07:51 (26244): Status Report: CPU Time: '150880.110000'
2024-10-16 17:46:56 (26244): Status Report: Job Duration: '864000.000000'
2024-10-16 17:46:56 (26244): Status Report: Elapsed Time: '162000.000000'
2024-10-16 17:46:56 (26244): Status Report: CPU Time: '156707.690000'
2024-10-16 19:26:01 (26244): Status Report: Job Duration: '864000.000000'
2024-10-16 19:26:01 (26244): Status Report: Elapsed Time: '168000.000000'
2024-10-16 19:26:01 (26244): Status Report: CPU Time: '162515.870000'
2024-10-16 21:05:05 (26244): Status Report: Job Duration: '864000.000000'
2024-10-16 21:05:05 (26244): Status Report: Elapsed Time: '174000.000000'
2024-10-16 21:05:05 (26244): Status Report: CPU Time: '168318.140000'
2024-10-16 22:44:10 (26244): Status Report: Job Duration: '864000.000000'
2024-10-16 22:44:10 (26244): Status Report: Elapsed Time: '180000.000000'
2024-10-16 22:44:10 (26244): Status Report: CPU Time: '174107.010000'
2024-10-17 00:23:14 (26244): Status Report: Job Duration: '864000.000000'
2024-10-17 00:23:14 (26244): Status Report: Elapsed Time: '186000.000000'
2024-10-17 00:23:14 (26244): Status Report: CPU Time: '179914.780000'
2024-10-17 02:02:20 (26244): Status Report: Job Duration: '864000.000000'
2024-10-17 02:02:20 (26244): Status Report: Elapsed Time: '192000.000000'
2024-10-17 02:02:20 (26244): Status Report: CPU Time: '185738.890000'
2024-10-17 03:41:25 (26244): Status Report: Job Duration: '864000.000000'
2024-10-17 03:41:25 (26244): Status Report: Elapsed Time: '198000.000000'
2024-10-17 03:41:25 (26244): Status Report: CPU Time: '191564.570000'
2024-10-17 05:20:31 (26244): Status Report: Job Duration: '864000.000000'
2024-10-17 05:20:31 (26244): Status Report: Elapsed Time: '204000.000000'
2024-10-17 05:20:31 (26244): Status Report: CPU Time: '197390.040000'
2024-10-17 06:59:36 (26244): Status Report: Job Duration: '864000.000000'
2024-10-17 06:59:36 (26244): Status Report: Elapsed Time: '210000.000000'
2024-10-17 06:59:36 (26244): Status Report: CPU Time: '203215.210000'
2024-10-17 08:38:42 (26244): Status Report: Job Duration: '864000.000000'
2024-10-17 08:38:42 (26244): Status Report: Elapsed Time: '216000.000000'
2024-10-17 08:38:42 (26244): Status Report: CPU Time: '209038.180000'
2024-10-17 10:17:47 (26244): Status Report: Job Duration: '864000.000000'
2024-10-17 10:17:47 (26244): Status Report: Elapsed Time: '222000.000000'
2024-10-17 10:17:47 (26244): Status Report: CPU Time: '214864.640000'
2024-10-17 10:37:23 (26244): VM state change detected. (old = 'running', new = 'paused')
2024-10-17 10:37:43 (26244): VM state change detected. (old = 'paused', new = 'running')
2024-10-17 11:57:12 (26244): Status Report: Job Duration: '864000.000000'
2024-10-17 11:57:12 (26244): Status Report: Elapsed Time: '228000.000000'
2024-10-17 11:57:12 (26244): Status Report: CPU Time: '220694.270000'
2024-10-17 13:36:13 (26244): Status Report: Job Duration: '864000.000000'
2024-10-17 13:36:13 (26244): Status Report: Elapsed Time: '234000.000000'
2024-10-17 13:36:13 (26244): Status Report: CPU Time: '226527.580000'
2024-10-17 15:15:14 (26244): Status Report: Job Duration: '864000.000000'
2024-10-17 15:15:14 (26244): Status Report: Elapsed Time: '240000.000000'
2024-10-17 15:15:14 (26244): Status Report: CPU Time: '232364.410000'
2024-10-17 16:54:15 (26244): Status Report: Job Duration: '864000.000000'
2024-10-17 16:54:15 (26244): Status Report: Elapsed Time: '246000.000000'
2024-10-17 16:54:15 (26244): Status Report: CPU Time: '238208.820000'
2024-10-17 17:47:07 (26244): VM state change detected. (old = 'running', new = 'paused')
2024-10-17 17:47:26 (26244): VM state change detected. (old = 'paused', new = 'running')
2024-10-17 18:33:36 (26244): Status Report: Job Duration: '864000.000000'
2024-10-17 18:33:36 (26244): Status Report: Elapsed Time: '252000.000000'
2024-10-17 18:33:36 (26244): Status Report: CPU Time: '244060.250000'
2024-10-17 19:19:28 (26244): VM state change detected. (old = 'running', new = 'paused')
2024-10-17 19:19:48 (26244): VM state change detected. (old = 'paused', new = 'running')
2024-10-17 19:42:03 (26244): VM state change detected. (old = 'running', new = 'paused')
2024-10-17 19:42:24 (26244): VM state change detected. (old = 'paused', new = 'running')
2024-10-17 19:42:54 (26244): VM state change detected. (old = 'running', new = 'paused')
2024-10-17 19:43:15 (26244): VM state change detected. (old = 'paused', new = 'running')
2024-10-17 20:13:40 (26244): Status Report: Job Duration: '864000.000000'
2024-10-17 20:13:40 (26244): Status Report: Elapsed Time: '258000.000000'
2024-10-17 20:13:40 (26244): Status Report: CPU Time: '249899.110000'
2024-10-17 20:46:31 (6548): vboxwrapper version 26207
2024-10-17 20:46:31 (6548): BOINC client version: 8.0.2
2024-10-17 20:46:32 (6548): Detected: VirtualBox VboxManage Interface (Version: 7.1.4)
2024-10-17 20:46:32 (6548): Detected: Heartbeat check (file: 'heartbeat' every 1200.000000 seconds)
2024-10-17 20:46:32 (6548): Guest Log: BIOS: VirtualBox 7.1.2
2024-10-17 20:46:32 (6548): Guest Log: CPUID EDX: 0x178bfbff
2024-10-17 20:46:32 (6548): Guest Log: BIOS: No PCI IDE controller, not probing IDE
2024-10-17 20:46:32 (6548): Guest Log: BIOS: AHCI 0-P#0: PCHS=16383/16/63 LCHS=1024/255/63 0x0000000002800000 sectors
2024-10-17 20:46:32 (6548): Guest Log: BIOS: Boot : bseqnr=1, bootseq=0032
2024-10-17 20:46:32 (6548): Guest Log: BIOS: Booting from Hard Disk...
2024-10-17 20:46:32 (6548): Guest Log: BIOS: KBD: unsupported int 16h function 03
2024-10-17 20:46:32 (6548): Guest Log: BIOS: AX=0305 BX=0000 CX=0000 DX=0000 
2024-10-17 20:46:32 (6548): Guest Log: vgdrvHeartbeatInit: Setting up heartbeat to trigger every 2000 milliseconds
2024-10-17 20:46:32 (6548): Guest Log: vboxguest: misc device minor 56, IRQ 20, I/O port d020, MMIO at 00000000f0400000 (size 0x400000)
2024-10-17 20:46:32 (6548): Guest Log: VBoxService 5.2.6 r120293 (verbosity: 0) linux.amd64 (Jan 15 2018 14:51:00) release log
2024-10-17 20:46:32 (6548): Guest Log: 00:00:00.000074 main     Log opened 2024-10-15T01:10:50.193243000Z
2024-10-17 20:46:32 (6548): Guest Log: 00:00:00.000141 main     OS Product: Linux
2024-10-17 20:46:32 (6548): Guest Log: 00:00:00.000153 main     OS Release: 4.14.76-13.cernvm.x86_64
2024-10-17 20:46:32 (6548): Guest Log: 00:00:00.000162 main     OS Version: #1 SMP Tue Oct 16 18:26:15 CEST 2018
2024-10-17 20:46:32 (6548): Guest Log: 00:00:00.000170 main     Executable: /usr/sbin/VBoxService
2024-10-17 20:46:32 (6548): Guest Log: 00:00:00.000170 main     Process ID: 3219
2024-10-17 20:46:32 (6548): Guest Log: 00:00:00.000171 main     Package type: LINUX_64BITS_GENERIC
2024-10-17 20:46:32 (6548): Guest Log: 00:00:00.004395 main     5.2.6 r120293 started. Verbose level = 0
2024-10-17 20:46:32 (6548): Guest Log: 21:11:06 EDT -04:00 2024-10-14: cranky: [INFO] Detected Theory App
2024-10-17 20:46:32 (6548): Guest Log: 21:11:06 EDT -04:00 2024-10-14: cranky: [INFO] Checking CVMFS.
2024-10-17 20:46:32 (6548): Guest Log: Probing /cvmfs/sft.cern.ch... OK
2024-10-17 20:46:32 (6548): 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
2024-10-17 20:46:32 (6548): Guest Log: 2.5.2.0 4099 0 26328 30730 3 1 277907 4096000 0 65024 0 0 n/a 5 6 http://s1unl-cvmfs.openhtc.io/cvmfs/sft.cern.ch DIRECT 1
2024-10-17 20:46:32 (6548): Guest Log: Probing /cvmfs/grid.cern.ch... OK
2024-10-17 20:46:32 (6548): 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
2024-10-17 20:46:32 (6548): Guest Log: 2.5.2.0 4053 0 25488 25481 3 2 277907 4096000 0 65024 0 2 -100 10072 7912 http://s1bnl-cvmfs.openhtc.io/cvmfs/grid.cern.ch DIRECT 1
2024-10-17 20:46:32 (6548): Guest Log: Probing /cvmfs/cernvm-prod.cern.ch... OK
2024-10-17 20:46:32 (6548): 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
2024-10-17 20:46:32 (6548): Guest Log: 2.5.2.0 4122 0 27212 272 3 1 277907 4096000 0 65024 0 0 n/a 4 5 http://s1unl-cvmfs.openhtc.io/cvmfs/cernvm-prod.cern.ch DIRECT 1
2024-10-17 20:46:32 (6548): Guest Log: Probing /cvmfs/alice.cern.ch... OK
2024-10-17 20:46:32 (6548): 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
2024-10-17 20:46:32 (6548): Guest Log: 2.5.2.0 4077 0 39660 20038 3 1 277907 4096000 0 65024 0 0 n/a 6170 3730 http://s1unl-cvmfs.openhtc.io/cvmfs/alice.cern.ch DIRECT 1
2024-10-17 20:46:32 (6548): Guest Log: 21:11:08 EDT -04:00 2024-10-14: cranky: [INFO] Checking runc.
2024-10-17 20:46:32 (6548): Guest Log: 21:11:08 EDT -04:00 2024-10-14: cranky: [INFO] Creating the filesystem.
2024-10-17 20:46:32 (6548): Guest Log: 21:11:08 EDT -04:00 2024-10-14: cranky: [INFO] Using /cvmfs/cernvm-prod.cern.ch/cvm4
2024-10-17 20:46:32 (6548): Guest Log: 21:11:09 EDT -04:00 2024-10-14: cranky: [INFO] Updating config.json.
2024-10-17 20:46:32 (6548): Guest Log: 21:11:09 EDT -04:00 2024-10-14: cranky: [INFO] Running Container 'runc'.
2024-10-17 20:46:32 (6548): Guest Log: job: htmld=/shared/html/job
2024-10-17 20:46:32 (6548): Guest Log: job: unpack exitcode=0
2024-10-17 20:46:32 (6548): Guest Log: INFO: activated the work-around for ld:
2024-10-17 20:46:32 (6548): Guest Log: lrwxrwxrwx 1 0 0 15 Oct 15 01:11 /tmp/tmp.ciMFA242Hz/ld -> /usr/bin/ld.bfd
2024-10-17 20:46:32 (6548): Guest Log: 21:11:16 EDT -04:00 2024-10-14: cranky: [INFO] ===> [runRivet] Tue Oct 15 01:11:14 UTC 2024 [boinc pp z1j 7000 150 - herwig7 7.2.1 nlo-dipole 100000 8]
2024-10-17 20:46:32 (6548): Starting VM using VBoxManage interface. (boinc_7607e99a93e74b2a, slot#1)
2024-10-17 20:46:33 (6548): Successfully started VM. (PID = '8876')
2024-10-17 20:46:33 (6548): Reporting VM Process ID to BOINC.
2024-10-17 20:46:33 (6548): Guest Log: BIOS: VirtualBox 7.1.4
2024-10-17 20:46:33 (6548): Guest Log: CPUID EDX: 0x178bfbff
2024-10-17 20:46:33 (6548): Guest Log: BIOS: No PCI IDE controller, not probing IDE
2024-10-17 20:46:33 (6548): Guest Log: BIOS: AHCI 0-P#0: PCHS=16383/16/63 LCHS=1024/255/63 0x0000000002800000 sectors
2024-10-17 20:46:33 (6548): VM state change detected. (old = 'poweredoff', new = 'running')
2024-10-17 20:46:33 (6548): Detected: Web Application Enabled (http://localhost:55493)
2024-10-17 20:46:33 (6548): Status Report: Job Duration: '864000.000000'
2024-10-17 20:46:33 (6548): Status Report: Elapsed Time: '259888.000000'
2024-10-17 20:46:33 (6548): Status Report: CPU Time: '251721.440000'
2024-10-17 20:46:33 (6548): Preference change detected
2024-10-17 20:46:34 (6548): Setting CPU throttle for VM. (100%)
2024-10-17 20:46:34 (6548): Setting checkpoint interval to 600 seconds. (Higher value of (Preference: 60 seconds) or (Vbox_job.xml: 600 seconds))
2024-10-17 20:46:35 (6548): Guest Log: BIOS: Boot : bseqnr=1, bootseq=0032
2024-10-17 20:46:35 (6548): Guest Log: BIOS: Booting from Hard Disk...
2024-10-17 20:46:38 (6548): Guest Log: BIOS: KBD: unsupported int 16h function 03
2024-10-17 20:46:38 (6548): Guest Log: BIOS: AX=0305 BX=0000 CX=0000 DX=0000 
2024-10-17 20:47:06 (6548): Guest Log: vgdrvHeartbeatInit: Setting up heartbeat to trigger every 2000 milliseconds
2024-10-17 20:47:06 (6548): Guest Log: vboxguest: misc device minor 56, IRQ 20, I/O port d020, MMIO at 00000000f0400000 (size 0x400000)
2024-10-17 20:47:10 (6548): Guest Log: VBoxService 5.2.6 r120293 (verbosity: 0) linux.amd64 (Jan 15 2018 14:51:00) release log
2024-10-17 20:47:10 (6548): Guest Log: 00:00:00.000213 main     Log opened 2024-10-18T00:47:11.154290000Z
2024-10-17 20:47:10 (6548): Guest Log: 00:00:00.000373 main     OS Product: Linux
2024-10-17 20:47:10 (6548): Guest Log: 00:00:00.000405 main     OS Release: 4.14.76-13.cernvm.x86_64
2024-10-17 20:47:10 (6548): Guest Log: 00:00:00.000421 main     OS Version: #1 SMP Tue Oct 16 18:26:15 CEST 2018
2024-10-17 20:47:10 (6548): Guest Log: 00:00:00.000435 main     Executable: /usr/sbin/VBoxService
2024-10-17 20:47:10 (6548): Guest Log: 00:00:00.000440 main     Process ID: 3222
2024-10-17 20:47:10 (6548): Guest Log: 00:00:00.000441 main     Package type: LINUX_64BITS_GENERIC
2024-10-17 20:47:10 (6548): Guest Log: 00:00:00.004013 main     5.2.6 r120293 started. Verbose level = 0
2024-10-17 20:47:37 (6548): Guest Log: 20:47:37 EDT -04:00 2024-10-17: cranky: [INFO] Detected Theory App
2024-10-17 20:47:37 (6548): Guest Log: 20:47:37 EDT -04:00 2024-10-17: cranky: [INFO] Checking CVMFS.
2024-10-17 20:47:37 (6548): Guest Log: Probing /cvmfs/sft.cern.ch... OK
2024-10-17 20:47:38 (6548): 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
2024-10-17 20:47:38 (6548): Guest Log: 2.5.2.0 4057 0 28236 30764 3 1 2861644 4096000 0 65024 0 0 n/a 0 0 http://s1bnl-cvmfs.openhtc.io/cvmfs/sft.cern.ch DIRECT 1
2024-10-17 20:47:38 (6548): Guest Log: Probing /cvmfs/grid.cern.ch... OK
2024-10-17 20:47:39 (6548): 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
2024-10-17 20:47:39 (6548): Guest Log: 2.5.2.0 4105 0 25632 25507 3 2 2861644 4096000 0 65024 0 2 0 7934 1362 http://s1fnal-cvmfs.openhtc.io/cvmfs/grid.cern.ch DIRECT 1
2024-10-17 20:47:39 (6548): Guest Log: Probing /cvmfs/cernvm-prod.cern.ch... OK
2024-10-17 20:47:39 (6548): 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
2024-10-17 20:47:39 (6548): Guest Log: 2.5.2.0 4080 0 27228 272 3 1 2861644 4096000 0 65024 0 0 n/a 0 0 http://s1bnl-cvmfs.openhtc.io/cvmfs/cernvm-prod.cern.ch DIRECT 1
2024-10-17 20:47:39 (6548): Guest Log: Probing /cvmfs/alice.cern.ch... OK
2024-10-17 20:47:40 (6548): 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
2024-10-17 20:47:40 (6548): Guest Log: 2.5.2.0 4131 0 40620 20061 3 1 2861644 4096000 0 65024 0 0 n/a 6178 1432 http://s1fnal-cvmfs.openhtc.io/cvmfs/alice.cern.ch DIRECT 1
2024-10-17 20:47:40 (6548): Guest Log: 20:47:40 EDT -04:00 2024-10-17: cranky: [INFO] Checking runc.
2024-10-17 20:47:40 (6548): Guest Log: 20:47:40 EDT -04:00 2024-10-17: cranky: [INFO] Creating the filesystem.
2024-10-17 20:47:40 (6548): Guest Log: 20:47:40 EDT -04:00 2024-10-17: cranky: [INFO] Using /cvmfs/cernvm-prod.cern.ch/cvm4
2024-10-17 20:47:40 (6548): Guest Log: 20:47:40 EDT -04:00 2024-10-17: cranky: [INFO] Updating config.json.
2024-10-17 20:47:40 (6548): Guest Log: 20:47:40 EDT -04:00 2024-10-17: cranky: [INFO] Running Container 'runc'.
2024-10-17 20:47:40 (6548): Guest Log: job: htmld=/shared/html/job
2024-10-17 20:47:41 (6548): Guest Log: job: unpack exitcode=0
2024-10-17 20:47:41 (6548): Guest Log: INFO: activated the work-around for ld:
2024-10-17 20:47:41 (6548): Guest Log: lrwxrwxrwx 1 0 0 15 Oct 18 00:47 /tmp/tmp.VvJpjABkJB/ld -> /usr/bin/ld.bfd
2024-10-17 20:47:42 (6548): Guest Log: 20:47:42 EDT -04:00 2024-10-17: cranky: [INFO] ===> [runRivet] Fri Oct 18 00:47:41 UTC 2024 [boinc pp z1j 7000 150 - herwig7 7.2.1 nlo-dipole 100000 8]
2024-10-17 20:56:38 (6548): VM state change detected. (old = 'running', new = 'paused')
2024-10-17 20:56:58 (6548): VM state change detected. (old = 'paused', new = 'running')
2024-10-17 21:06:41 (6548): VM state change detected. (old = 'running', new = 'paused')
2024-10-17 21:07:02 (6548): VM state change detected. (old = 'paused', new = 'running')
2024-10-17 21:31:02 (6548): VM state change detected. (old = 'running', new = 'paused')
2024-10-17 21:31:22 (6548): VM state change detected. (old = 'paused', new = 'running')
2024-10-17 21:31:32 (6548): VM state change detected. (old = 'running', new = 'paused')
2024-10-17 21:31:52 (6548): VM state change detected. (old = 'paused', new = 'running')
2024-10-17 21:32:12 (6548): VM state change detected. (old = 'running', new = 'paused')
2024-10-17 21:32:32 (6548): VM state change detected. (old = 'paused', new = 'running')
2024-10-17 21:33:13 (6548): VM state change detected. (old = 'running', new = 'paused')
2024-10-17 21:33:32 (6548): VM state change detected. (old = 'paused', new = 'running')
2024-10-17 22:27:42 (6548): Status Report: Job Duration: '864000.000000'
2024-10-17 22:27:42 (6548): Status Report: Elapsed Time: '265888.000000'
2024-10-17 22:27:42 (6548): Status Report: CPU Time: '257128.760000'
2024-10-17 22:35:27 (6548): VM state change detected. (old = 'running', new = 'paused')
2024-10-17 22:35:47 (6548): VM state change detected. (old = 'paused', new = 'running')
2024-10-17 22:35:57 (6548): VM state change detected. (old = 'running', new = 'paused')
2024-10-17 22:36:18 (6548): VM state change detected. (old = 'paused', new = 'running')
2024-10-17 23:39:13 (6548): VM state change detected. (old = 'running', new = 'paused')
2024-10-17 23:39:34 (6548): VM state change detected. (old = 'paused', new = 'running')
2024-10-18 00:07:48 (6548): Status Report: Job Duration: '864000.000000'
2024-10-18 00:07:48 (6548): Status Report: Elapsed Time: '271888.000000'
2024-10-18 00:07:48 (6548): Status Report: CPU Time: '262977.700000'
2024-10-18 00:50:24 (6548): VM state change detected. (old = 'running', new = 'paused')
2024-10-18 00:50:44 (6548): VM state change detected. (old = 'paused', new = 'running')
2024-10-18 01:13:33 (6548): VM state change detected. (old = 'running', new = 'paused')
2024-10-18 01:13:53 (6548): VM state change detected. (old = 'paused', new = 'running')
2024-10-18 01:47:33 (6548): Status Report: Job Duration: '864000.000000'
2024-10-18 01:47:33 (6548): Status Report: Elapsed Time: '277888.000000'
2024-10-18 01:47:33 (6548): Status Report: CPU Time: '268820.870000'
2024-10-18 02:01:54 (6548): VM state change detected. (old = 'running', new = 'paused')
2024-10-18 02:02:14 (6548): VM state change detected. (old = 'paused', new = 'running')
2024-10-18 02:24:23 (6548): VM state change detected. (old = 'running', new = 'paused')
2024-10-18 02:24:44 (6548): VM state change detected. (old = 'paused', new = 'running')
2024-10-18 03:14:06 (6548): VM state change detected. (old = 'running', new = 'paused')
2024-10-18 03:14:26 (6548): VM state change detected. (old = 'paused', new = 'running')
2024-10-18 03:27:38 (6548): Status Report: Job Duration: '864000.000000'
2024-10-18 03:27:38 (6548): Status Report: Elapsed Time: '283888.000000'
2024-10-18 03:27:38 (6548): Status Report: CPU Time: '274671.890000'
2024-10-18 03:34:03 (6548): VM state change detected. (old = 'running', new = 'paused')
2024-10-18 03:34:24 (6548): VM state change detected. (old = 'paused', new = 'running')
2024-10-18 04:25:07 (6548): VM state change detected. (old = 'running', new = 'paused')
2024-10-18 04:25:27 (6548): VM state change detected. (old = 'paused', new = 'running')
2024-10-18 04:58:12 (6548): VM state change detected. (old = 'running', new = 'paused')
2024-10-18 04:58:32 (6548): VM state change detected. (old = 'paused', new = 'running')
2024-10-18 05:07:44 (6548): Status Report: Job Duration: '864000.000000'
2024-10-18 05:07:44 (6548): Status Report: Elapsed Time: '289888.000000'
2024-10-18 05:07:44 (6548): Status Report: CPU Time: '280514.330000'
2024-10-18 05:29:34 (6548): VM state change detected. (old = 'running', new = 'paused')
2024-10-18 05:29:54 (6548): VM state change detected. (old = 'paused', new = 'running')
2024-10-18 06:32:32 (6548): VM state change detected. (old = 'running', new = 'paused')
2024-10-18 06:32:52 (6548): VM state change detected. (old = 'paused', new = 'running')
2024-10-18 06:44:37 (6548): VM state change detected. (old = 'running', new = 'paused')
2024-10-18 06:44:57 (6548): VM state change detected. (old = 'paused', new = 'running')
2024-10-18 06:47:49 (6548): Status Report: Job Duration: '864000.000000'
2024-10-18 06:47:49 (6548): Status Report: Elapsed Time: '295888.000000'
2024-10-18 06:47:49 (6548): Status Report: CPU Time: '286359.290000'
2024-10-18 07:47:06 (6548): VM state change detected. (old = 'running', new = 'paused')
2024-10-18 07:47:26 (6548): VM state change detected. (old = 'paused', new = 'running')
2024-10-18 07:57:00 (6548): VM state change detected. (old = 'running', new = 'paused')
2024-10-18 07:57:20 (6548): VM state change detected. (old = 'paused', new = 'running')
2024-10-18 08:27:34 (6548): Status Report: Job Duration: '864000.000000'
2024-10-18 08:27:34 (6548): Status Report: Elapsed Time: '301888.000000'
2024-10-18 08:27:34 (6548): Status Report: CPU Time: '292211.550000'
2024-10-18 08:59:48 (6548): VM state change detected. (old = 'running', new = 'paused')
2024-10-18 09:00:07 (6548): VM state change detected. (old = 'paused', new = 'running')
2024-10-18 09:12:12 (6548): VM state change detected. (old = 'running', new = 'paused')
2024-10-18 09:12:32 (6548): VM state change detected. (old = 'paused', new = 'running')
2024-10-18 09:44:06 (6548): VM state change detected. (old = 'running', new = 'paused')
2024-10-18 09:44:25 (6548): VM state change detected. (old = 'paused', new = 'running')
2024-10-18 10:07:39 (6548): Status Report: Job Duration: '864000.000000'
2024-10-18 10:07:39 (6548): Status Report: Elapsed Time: '307888.000000'
2024-10-18 10:07:39 (6548): Status Report: CPU Time: '298042.740000'
2024-10-18 10:22:43 (6548): VM state change detected. (old = 'running', new = 'paused')
2024-10-18 10:23:03 (6548): VM state change detected. (old = 'paused', new = 'running')
2024-10-18 10:54:37 (6548): VM state change detected. (old = 'running', new = 'paused')
2024-10-18 10:54:57 (6548): VM state change detected. (old = 'paused', new = 'running')
2024-10-18 11:31:03 (6548): VM state change detected. (old = 'running', new = 'paused')
2024-10-18 11:31:23 (6548): VM state change detected. (old = 'paused', new = 'running')
2024-10-18 11:47:45 (6548): Status Report: Job Duration: '864000.000000'
2024-10-18 11:47:45 (6548): Status Report: Elapsed Time: '313888.000000'
2024-10-18 11:47:45 (6548): Status Report: CPU Time: '303883.950000'
2024-10-18 12:04:16 (6548): VM state change detected. (old = 'running', new = 'paused')
2024-10-18 12:04:36 (6548): VM state change detected. (old = 'paused', new = 'running')
2024-10-18 12:42:02 (6548): VM state change detected. (old = 'running', new = 'paused')
2024-10-18 12:42:23 (6548): VM state change detected. (old = 'paused', new = 'running')
2024-10-18 13:13:16 (6548): VM state change detected. (old = 'running', new = 'paused')
2024-10-18 13:13:36 (6548): VM state change detected. (old = 'paused', new = 'running')
2024-10-18 13:27:50 (6548): Status Report: Job Duration: '864000.000000'
2024-10-18 13:27:50 (6548): Status Report: Elapsed Time: '319888.000000'
2024-10-18 13:27:50 (6548): Status Report: CPU Time: '309736.120000'
2024-10-18 13:53:54 (6548): VM state change detected. (old = 'running', new = 'paused')
2024-10-18 13:54:14 (6548): VM state change detected. (old = 'paused', new = 'running')
2024-10-18 14:28:49 (6548): VM state change detected. (old = 'running', new = 'paused')
2024-10-18 14:29:09 (6548): VM state change detected. (old = 'paused', new = 'running')
2024-10-18 15:07:35 (6548): Status Report: Job Duration: '864000.000000'
2024-10-18 15:07:35 (6548): Status Report: Elapsed Time: '325888.000000'
2024-10-18 15:07:35 (6548): Status Report: CPU Time: '315577.050000'
2024-10-18 15:16:41 (6548): VM state change detected. (old = 'running', new = 'paused')
2024-10-18 15:17:01 (6548): VM state change detected. (old = 'paused', new = 'running')
2024-10-18 15:18:11 (6548): VM state change detected. (old = 'running', new = 'paused')
2024-10-18 15:18:31 (6548): VM state change detected. (old = 'paused', new = 'running')
2024-10-18 16:46:42 (6548): VM state change detected. (old = 'running', new = 'paused')
2024-10-18 16:47:03 (6548): VM state change detected. (old = 'paused', new = 'running')
2024-10-18 16:47:43 (6548): Status Report: Job Duration: '864000.000000'
2024-10-18 16:47:43 (6548): Status Report: Elapsed Time: '331888.000000'
2024-10-18 16:47:43 (6548): Status Report: CPU Time: '321415.760000'
2024-10-18 16:47:53 (6548): VM state change detected. (old = 'running', new = 'paused')
2024-10-18 16:48:13 (6548): VM state change detected. (old = 'paused', new = 'running')
2024-10-18 18:15:33 (6548): VM state change detected. (old = 'running', new = 'paused')
2024-10-18 18:15:53 (6548): VM state change detected. (old = 'paused', new = 'running')
2024-10-18 18:23:36 (6548): VM state change detected. (old = 'running', new = 'paused')
2024-10-18 18:23:56 (6548): VM state change detected. (old = 'paused', new = 'running')
2024-10-18 18:27:49 (6548): Status Report: Job Duration: '864000.000000'
2024-10-18 18:27:49 (6548): Status Report: Elapsed Time: '337888.000000'
2024-10-18 18:27:49 (6548): Status Report: CPU Time: '327266.480000'
2024-10-18 19:36:21 (6548): VM state change detected. (old = 'running', new = 'paused')
2024-10-18 19:36:41 (6548): VM state change detected. (old = 'paused', new = 'running')
2024-10-18 19:45:13 (6548): VM state change detected. (old = 'running', new = 'paused')
2024-10-18 19:45:33 (6548): VM state change detected. (old = 'paused', new = 'running')
2024-10-18 20:07:33 (6548): Status Report: Job Duration: '864000.000000'
2024-10-18 20:07:33 (6548): Status Report: Elapsed Time: '343888.000000'
2024-10-18 20:07:33 (6548): Status Report: CPU Time: '333057.990000'
2024-10-18 21:06:25 (6548): VM state change detected. (old = 'running', new = 'paused')
2024-10-18 21:06:45 (6548): VM state change detected. (old = 'paused', new = 'running')
2024-10-18 21:10:45 (6548): VM state change detected. (old = 'running', new = 'paused')
2024-10-18 21:11:06 (6548): VM state change detected. (old = 'paused', new = 'running')
2024-10-18 21:47:18 (6548): Status Report: Job Duration: '864000.000000'
2024-10-18 21:47:18 (6548): Status Report: Elapsed Time: '349888.000000'
2024-10-18 21:47:18 (6548): Status Report: CPU Time: '338858.730000'
2024-10-18 22:26:56 (6548): VM state change detected. (old = 'running', new = 'paused')
2024-10-18 22:27:17 (6548): VM state change detected. (old = 'paused', new = 'running')
2024-10-18 22:35:08 (6548): VM state change detected. (old = 'running', new = 'paused')
2024-10-18 22:35:28 (6548): VM state change detected. (old = 'paused', new = 'running')
2024-10-18 23:15:58 (6548): VM state change detected. (old = 'running', new = 'paused')
2024-10-18 23:16:18 (6548): VM state change detected. (old = 'paused', new = 'running')
2024-10-18 23:27:24 (6548): Status Report: Job Duration: '864000.000000'
2024-10-18 23:27:24 (6548): Status Report: Elapsed Time: '355888.000000'
2024-10-18 23:27:24 (6548): Status Report: CPU Time: '344678.180000'
2024-10-18 23:57:59 (6548): VM state change detected. (old = 'running', new = 'paused')
2024-10-18 23:58:20 (6548): VM state change detected. (old = 'paused', new = 'running')
2024-10-19 00:41:02 (6548): VM state change detected. (old = 'running', new = 'paused')
2024-10-19 00:41:21 (6548): VM state change detected. (old = 'paused', new = 'running')
2024-10-19 01:07:09 (6548): Status Report: Job Duration: '864000.000000'
2024-10-19 01:07:09 (6548): Status Report: Elapsed Time: '361888.000000'
2024-10-19 01:07:09 (6548): Status Report: CPU Time: '350519.770000'
2024-10-19 01:23:43 (6548): VM state change detected. (old = 'running', new = 'paused')
2024-10-19 01:24:03 (6548): VM state change detected. (old = 'paused', new = 'running')
2024-10-19 01:50:09 (6548): VM state change detected. (old = 'running', new = 'paused')
2024-10-19 01:50:29 (6548): VM state change detected. (old = 'paused', new = 'running')
2024-10-19 02:34:01 (6548): VM state change detected. (old = 'running', new = 'paused')
2024-10-19 02:34:21 (6548): VM state change detected. (old = 'paused', new = 'running')
2024-10-19 02:47:14 (6548): Status Report: Job Duration: '864000.000000'
2024-10-19 02:47:14 (6548): Status Report: Elapsed Time: '367888.000000'
2024-10-19 02:47:14 (6548): Status Report: CPU Time: '356361.800000'
2024-10-19 02:59:37 (6548): VM state change detected. (old = 'running', new = 'paused')
2024-10-19 02:59:58 (6548): VM state change detected. (old = 'paused', new = 'running')
2024-10-19 03:33:06 (6548): VM state change detected. (old = 'running', new = 'paused')
2024-10-19 03:33:26 (6548): VM state change detected. (old = 'paused', new = 'running')
2024-10-19 04:11:56 (6548): VM state change detected. (old = 'running', new = 'paused')
2024-10-19 04:12:17 (6548): VM state change detected. (old = 'paused', new = 'running')
2024-10-19 04:27:21 (6548): Status Report: Job Duration: '864000.000000'
2024-10-19 04:27:21 (6548): Status Report: Elapsed Time: '373888.000000'
2024-10-19 04:27:21 (6548): Status Report: CPU Time: '362213.800000'
2024-10-19 04:42:35 (6548): VM state change detected. (old = 'running', new = 'paused')
2024-10-19 04:42:54 (6548): VM state change detected. (old = 'paused', new = 'running')
2024-10-19 05:25:06 (6548): VM state change detected. (old = 'running', new = 'paused')
2024-10-19 05:25:26 (6548): VM state change detected. (old = 'paused', new = 'running')
2024-10-19 05:52:43 (6548): VM state change detected. (old = 'running', new = 'paused')
2024-10-19 05:53:03 (6548): VM state change detected. (old = 'paused', new = 'running')
2024-10-19 06:07:26 (6548): Status Report: Job Duration: '864000.000000'
2024-10-19 06:07:26 (6548): Status Report: Elapsed Time: '379888.000000'
2024-10-19 06:07:26 (6548): Status Report: CPU Time: '368057.300000'
2024-10-19 06:35:55 (6548): VM state change detected. (old = 'running', new = 'paused')
2024-10-19 06:36:15 (6548): VM state change detected. (old = 'paused', new = 'running')
2024-10-19 06:59:10 (6548): VM state change detected. (old = 'running', new = 'paused')
2024-10-19 06:59:30 (6548): VM state change detected. (old = 'paused', new = 'running')
2024-10-19 07:45:13 (6548): VM state change detected. (old = 'running', new = 'paused')
2024-10-19 07:45:33 (6548): VM state change detected. (old = 'paused', new = 'running')
2024-10-19 07:47:32 (6548): Status Report: Job Duration: '864000.000000'
2024-10-19 07:47:32 (6548): Status Report: Elapsed Time: '385888.000000'
2024-10-19 07:47:32 (6548): Status Report: CPU Time: '373897.460000'
2024-10-19 08:23:13 (6548): VM state change detected. (old = 'running', new = 'paused')
2024-10-19 08:23:33 (6548): VM state change detected. (old = 'paused', new = 'running')
2024-10-19 08:56:32 (6548): VM state change detected. (old = 'running', new = 'paused')
2024-10-19 08:56:51 (6548): VM state change detected. (old = 'paused', new = 'running')
2024-10-19 09:27:16 (6548): Status Report: Job Duration: '864000.000000'
2024-10-19 09:27:16 (6548): Status Report: Elapsed Time: '391888.000000'
2024-10-19 09:27:16 (6548): Status Report: CPU Time: '379740.950000'
2024-10-19 09:34:01 (6548): VM state change detected. (old = 'running', new = 'paused')
2024-10-19 09:34:21 (6548): VM state change detected. (old = 'paused', new = 'running')
2024-10-19 10:08:41 (6548): VM state change detected. (old = 'running', new = 'paused')
2024-10-19 10:09:01 (6548): VM state change detected. (old = 'paused', new = 'running')
2024-10-19 10:48:10 (6548): VM state change detected. (old = 'running', new = 'paused')
2024-10-19 10:48:31 (6548): VM state change detected. (old = 'paused', new = 'running')
2024-10-19 11:07:22 (6548): Status Report: Job Duration: '864000.000000'
2024-10-19 11:07:22 (6548): Status Report: Elapsed Time: '397888.000000'
2024-10-19 11:07:22 (6548): Status Report: CPU Time: '385580.260000'
2024-10-19 11:23:10 (6548): VM state change detected. (old = 'running', new = 'paused')
2024-10-19 11:23:30 (6548): VM state change detected. (old = 'paused', new = 'running')
2024-10-19 11:56:08 (6548): VM state change detected. (old = 'running', new = 'paused')
2024-10-19 11:56:28 (6548): VM state change detected. (old = 'paused', new = 'running')
2024-10-19 12:34:29 (6548): VM state change detected. (old = 'running', new = 'paused')
2024-10-19 12:34:48 (6548): VM state change detected. (old = 'paused', new = 'running')
2024-10-19 12:47:28 (6548): Status Report: Job Duration: '864000.000000'
2024-10-19 12:47:28 (6548): Status Report: Elapsed Time: '403888.000000'
2024-10-19 12:47:28 (6548): Status Report: CPU Time: '391421.050000'
2024-10-19 13:19:41 (6548): VM state change detected. (old = 'running', new = 'paused')
2024-10-19 13:20:00 (6548): VM state change detected. (old = 'paused', new = 'running')
2024-10-19 13:44:06 (6548): VM state change detected. (old = 'running', new = 'paused')
2024-10-19 13:44:27 (6548): VM state change detected. (old = 'paused', new = 'running')
2024-10-19 14:27:13 (6548): Status Report: Job Duration: '864000.000000'
2024-10-19 14:27:13 (6548): Status Report: Elapsed Time: '409888.000000'
2024-10-19 14:27:13 (6548): Status Report: CPU Time: '397270.380000'
2024-10-19 14:29:29 (6548): VM state change detected. (old = 'running', new = 'paused')
2024-10-19 14:29:49 (6548): VM state change detected. (old = 'paused', new = 'running')
2024-10-19 14:55:25 (6548): VM state change detected. (old = 'running', new = 'paused')
2024-10-19 14:55:46 (6548): VM state change detected. (old = 'paused', new = 'running')
2024-10-19 15:12:49 (6548): VM state change detected. (old = 'running', new = 'paused')
2024-10-19 15:13:09 (6548): VM state change detected. (old = 'paused', new = 'running')
2024-10-19 16:07:13 (6548): VM state change detected. (old = 'running', new = 'paused')
2024-10-19 16:07:34 (6548): VM state change detected. (old = 'paused', new = 'running')
2024-10-19 16:07:41 (6548): Status Report: Job Duration: '864000.000000'
2024-10-19 16:07:41 (6548): Status Report: Elapsed Time: '415888.000000'
2024-10-19 16:07:41 (6548): Status Report: CPU Time: '403111.360000'
2024-10-19 16:24:27 (6548): VM state change detected. (old = 'running', new = 'paused')
2024-10-19 16:24:48 (6548): VM state change detected. (old = 'paused', new = 'running')
2024-10-19 17:21:04 (6548): VM state change detected. (old = 'running', new = 'paused')
2024-10-19 17:21:24 (6548): VM state change detected. (old = 'paused', new = 'running')
2024-10-19 17:35:46 (6548): VM state change detected. (old = 'running', new = 'paused')
2024-10-19 17:36:07 (6548): VM state change detected. (old = 'paused', new = 'running')
2024-10-19 17:47:48 (6548): Status Report: Job Duration: '864000.000000'
2024-10-19 17:47:48 (6548): Status Report: Elapsed Time: '421888.000000'
2024-10-19 17:47:48 (6548): Status Report: CPU Time: '408964.500000'
2024-10-19 18:34:03 (6548): VM state change detected. (old = 'running', new = 'paused')
2024-10-19 18:34:23 (6548): VM state change detected. (old = 'paused', new = 'running')
2024-10-19 18:49:56 (6548): VM state change detected. (old = 'running', new = 'paused')
2024-10-19 18:50:16 (6548): VM state change detected. (old = 'paused', new = 'running')
2024-10-19 19:27:33 (6548): Status Report: Job Duration: '864000.000000'
2024-10-19 19:27:33 (6548): Status Report: Elapsed Time: '427888.000000'
2024-10-19 19:27:33 (6548): Status Report: CPU Time: '414805.320000'
2024-10-19 19:50:03 (6548): VM state change detected. (old = 'running', new = 'paused')
2024-10-19 19:50:22 (6548): VM state change detected. (old = 'paused', new = 'running')
2024-10-19 20:05:35 (6548): VM state change detected. (old = 'running', new = 'paused')
2024-10-19 20:05:56 (6548): VM state change detected. (old = 'paused', new = 'running')
2024-10-19 21:07:18 (6548): Status Report: Job Duration: '864000.000000'
2024-10-19 21:07:18 (6548): Status Report: Elapsed Time: '433888.000000'
2024-10-19 21:07:18 (6548): Status Report: CPU Time: '420600.350000'
2024-10-19 21:10:03 (6548): VM state change detected. (old = 'running', new = 'paused')
2024-10-19 21:10:23 (6548): VM state change detected. (old = 'paused', new = 'running')
2024-10-19 21:23:16 (6548): VM state change detected. (old = 'running', new = 'paused')
2024-10-19 21:23:36 (6548): VM state change detected. (old = 'paused', new = 'running')
2024-10-19 22:26:53 (6548): VM state change detected. (old = 'running', new = 'paused')
2024-10-19 22:27:13 (6548): VM state change detected. (old = 'paused', new = 'running')
2024-10-19 22:41:26 (6548): VM state change detected. (old = 'running', new = 'paused')
2024-10-19 22:41:46 (6548): VM state change detected. (old = 'paused', new = 'running')
2024-10-19 22:47:43 (6548): Status Report: Job Duration: '864000.000000'
2024-10-19 22:47:43 (6548): Status Report: Elapsed Time: '439888.000000'
2024-10-19 22:47:43 (6548): Status Report: CPU Time: '426425.720000'
2024-10-19 23:39:01 (6548): VM state change detected. (old = 'running', new = 'paused')
2024-10-19 23:39:21 (6548): VM state change detected. (old = 'paused', new = 'running')
2024-10-19 23:57:05 (6548): VM state change detected. (old = 'running', new = 'paused')
2024-10-19 23:57:25 (6548): VM state change detected. (old = 'paused', new = 'running')
2024-10-20 00:27:27 (6548): Status Report: Job Duration: '864000.000000'
2024-10-20 00:27:27 (6548): Status Report: Elapsed Time: '445888.000000'
2024-10-20 00:27:27 (6548): Status Report: CPU Time: '432258.470000'
2024-10-20 00:50:11 (6548): VM state change detected. (old = 'running', new = 'paused')
2024-10-20 00:50:30 (6548): VM state change detected. (old = 'paused', new = 'running')
2024-10-20 01:08:04 (6548): VM state change detected. (old = 'running', new = 'paused')
2024-10-20 01:08:24 (6548): VM state change detected. (old = 'paused', new = 'running')
2024-10-20 02:01:49 (6548): VM state change detected. (old = 'running', new = 'paused')
2024-10-20 02:02:10 (6548): VM state change detected. (old = 'paused', new = 'running')
2024-10-20 02:07:34 (6548): Status Report: Job Duration: '864000.000000'
2024-10-20 02:07:34 (6548): Status Report: Elapsed Time: '451888.000000'
2024-10-20 02:07:34 (6548): Status Report: CPU Time: '438104.910000'
2024-10-20 02:17:12 (6548): VM state change detected. (old = 'running', new = 'paused')
2024-10-20 02:17:33 (6548): VM state change detected. (old = 'paused', new = 'running')
2024-10-20 02:59:53 (6548): VM state change detected. (old = 'running', new = 'paused')
2024-10-20 03:00:14 (6548): VM state change detected. (old = 'paused', new = 'running')
2024-10-20 03:13:58 (6548): VM state change detected. (old = 'running', new = 'paused')
2024-10-20 03:14:18 (6548): VM state change detected. (old = 'paused', new = 'running')
2024-10-20 03:27:10 (6548): VM state change detected. (old = 'running', new = 'paused')
2024-10-20 03:27:31 (6548): VM state change detected. (old = 'paused', new = 'running')
2024-10-20 03:48:02 (6548): Status Report: Job Duration: '864000.000000'
2024-10-20 03:48:02 (6548): Status Report: Elapsed Time: '457888.000000'
2024-10-20 03:48:02 (6548): Status Report: CPU Time: '443965.110000'
2024-10-20 04:19:13 (6548): VM state change detected. (old = 'running', new = 'paused')
2024-10-20 04:19:34 (6548): VM state change detected. (old = 'paused', new = 'running')
2024-10-20 04:48:41 (6548): VM state change detected. (old = 'running', new = 'paused')
2024-10-20 04:49:00 (6548): VM state change detected. (old = 'paused', new = 'running')
2024-10-20 04:49:30 (6548): VM state change detected. (old = 'running', new = 'paused')
2024-10-20 04:49:51 (6548): VM state change detected. (old = 'paused', new = 'running')
2024-10-20 05:27:10 (6548): VM state change detected. (old = 'running', new = 'paused')
2024-10-20 05:27:30 (6548): VM state change detected. (old = 'paused', new = 'running')
2024-10-20 05:28:29 (6548): Status Report: Job Duration: '864000.000000'
2024-10-20 05:28:29 (6548): Status Report: Elapsed Time: '463888.000000'
2024-10-20 05:28:29 (6548): Status Report: CPU Time: '449826.480000'
2024-10-20 05:53:45 (6548): VM state change detected. (old = 'running', new = 'paused')
2024-10-20 05:54:06 (6548): VM state change detected. (old = 'paused', new = 'running')
2024-10-20 06:38:59 (6548): VM state change detected. (old = 'running', new = 'paused')
2024-10-20 06:39:19 (6548): VM state change detected. (old = 'paused', new = 'running')
2024-10-20 07:08:16 (6548): Status Report: Job Duration: '864000.000000'
2024-10-20 07:08:16 (6548): Status Report: Elapsed Time: '469888.000000'
2024-10-20 07:08:16 (6548): Status Report: CPU Time: '455667.650000'
2024-10-20 07:18:43 (6548): VM state change detected. (old = 'running', new = 'paused')
2024-10-20 07:19:03 (6548): VM state change detected. (old = 'paused', new = 'running')
2024-10-20 07:24:25 (6548): VM state change detected. (old = 'running', new = 'paused')
2024-10-20 07:24:44 (6548): VM state change detected. (old = 'paused', new = 'running')
2024-10-20 08:00:46 (6548): VM state change detected. (old = 'running', new = 'paused')
2024-10-20 08:01:06 (6548): VM state change detected. (old = 'paused', new = 'running')
2024-10-20 08:04:53 (6548): Guest Log: job: run exitcode=0
2024-10-20 08:04:53 (6548): Guest Log: job: diskusage=82056
2024-10-20 08:04:53 (6548): Guest Log: job: logsize=26460 k
2024-10-20 08:04:53 (6548): Guest Log: job: times=
2024-10-20 08:04:53 (6548): Guest Log: 0m0.003s 0m0.009s
2024-10-20 08:04:53 (6548): Guest Log: 3495m37.375s 5m15.699s
2024-10-20 08:04:53 (6548): Guest Log: job: cpuusage=210053
2024-10-20 08:04:53 (6548): Guest Log: 07:52:22 EDT -04:00 2024-10-20: cranky: [INFO] Container 'runc' finished with status code 0.
2024-10-20 08:04:53 (6548): Guest Log: 07:52:22 EDT -04:00 2024-10-20: cranky: [INFO] Preparing output.
2024-10-20 08:04:53 (6548): Guest Log: [INFO] Job Finished
2024-10-20 08:04:53 (6548): Guest Log: [INFO] Shutting Down.
2024-10-20 08:04:53 (6548): VM Completion File Detected.
2024-10-20 08:04:53 (6548): VM Completion Message: Job Finished
.
2024-10-20 08:04:53 (6548): Powering off VM.
2024-10-20 08:04:54 (6548): Successfully stopped VM.
2024-10-20 08:04:54 (6548): Deregistering VM. (boinc_7607e99a93e74b2a, slot#1)
2024-10-20 08:04:54 (6548): Removing network bandwidth throttle group from VM.
2024-10-20 08:04:54 (6548): Removing VM from VirtualBox.
2024-10-20 08:04:59 (6548): called boinc_finish(0)

</stderr_txt>
]]>


©2025 CERN