| Name | Theory_2773-2890469-180_2 |
| Workunit | 229773831 |
| Created | 17 Jan 2025, 20:48:52 UTC |
| Sent | 18 Jan 2025, 1:18:36 UTC |
| Report deadline | 29 Jan 2025, 1:18:36 UTC |
| Received | 19 Jan 2025, 16:16:00 UTC |
| Server state | Over |
| Outcome | Success |
| Client state | Done |
| Exit status | 0 (0x00000000) |
| Computer ID | 10863111 |
| Run time | 11 hours 9 min 5 sec |
| CPU time | 6 hours 27 min 35 sec |
| Validate state | Valid |
| Credit | 245.81 |
| Device peak FLOPS | 2.65 GFLOPS |
| Application version | Theory Simulation v300.60 (vbox64_theory) x86_64-pc-linux-gnu |
| Peak working set size | 745.21 MB |
| Peak swap size | 2.42 GB |
| Peak disk usage | 2.10 GB |
Stderr output
<core_client_version>8.0.2</core_client_version> <![CDATA[ <stderr_txt> 2025-01-18 07:30:38 (607025): vboxwrapper version 26208 2025-01-18 07:30:38 (607025): BOINC client version: 8.0.2 2025-01-18 07:30:38 (607025): Detected: VirtualBox VboxManage Interface (Version: 7.0.22) 2025-01-18 07:30:38 (607025): Detected: Heartbeat check (file: 'heartbeat' every 1200.000000 seconds) 2025-01-18 07:30:38 (607025): Successfully copied 'init_data.xml' to the shared directory. 2025-01-18 07:30:38 (607025): Successfully copied 'input' to the shared directory. 2025-01-18 07:30:38 (607025): Create VM. (boinc_ed8ea6e5b7682369, slot#3) 2025-01-18 07:30:38 (607025): Setting Memory Size for VM. (630MB) 2025-01-18 07:30:38 (607025): Setting CPU Count for VM. (1) 2025-01-18 07:30:38 (607025): Setting Chipset Options for VM. 2025-01-18 07:30:38 (607025): Setting Graphics Controller Options for VM. 2025-01-18 07:30:38 (607025): Setting Boot Options for VM. 2025-01-18 07:30:39 (607025): Setting Network Configuration for NAT. 2025-01-18 07:30:39 (607025): Enabling VM Network Access. 2025-01-18 07:30:39 (607025): Disabling USB Support for VM. 2025-01-18 07:30:39 (607025): Disabling COM Port Support for VM. 2025-01-18 07:30:39 (607025): Disabling LPT Port Support for VM. 2025-01-18 07:30:39 (607025): Disabling Audio Support for VM. 2025-01-18 07:30:39 (607025): Disabling Clipboard Support for VM. 2025-01-18 07:30:39 (607025): Disabling Drag and Drop Support for VM. 2025-01-18 07:30:39 (607025): Adding storage controller(s) to VM. 2025-01-18 07:30:39 (607025): Adding virtual disk drive to VM. (Theory_2025_01_16_prod.vdi) 2025-01-18 07:30:41 (607025): Attempts: 2 2025-01-18 07:30:41 (607025): Adding VirtualBox Guest Additions to VM. 2025-01-18 07:30:41 (607025): Adding network bandwidth throttle group to VM. (Defaulting to 1024GB) 2025-01-18 07:30:41 (607025): forwarding host port 38169 to guest port 80 2025-01-18 07:30:42 (607025): Enabling remote desktop for VM. 2025-01-18 07:30:42 (607025): Enabling shared directory for VM. 2025-01-18 07:30:42 (607025): Starting VM using VBoxManage interface. (boinc_ed8ea6e5b7682369, slot#3) 2025-01-18 07:30:43 (607025): Successfully started VM. (PID = '608497') 2025-01-18 07:30:43 (607025): Reporting VM Process ID to BOINC. 2025-01-18 07:30:43 (607025): Guest Log: BIOS: VirtualBox 7.0.22 2025-01-18 07:30:43 (607025): Guest Log: CPUID EDX: 0x178bfbff 2025-01-18 07:30:43 (607025): Guest Log: BIOS: No PCI IDE controller, not probing IDE 2025-01-18 07:30:43 (607025): Guest Log: BIOS: AHCI 0-P#0: PCHS=16383/16/63 LCHS=1024/255/63 0x0000000002800000 sectors 2025-01-18 07:30:43 (607025): VM state change detected. (old = 'poweredoff', new = 'running') 2025-01-18 07:30:43 (607025): Detected: Web Application Enabled (http://localhost:38169) 2025-01-18 07:30:43 (607025): Detected: Remote Desktop Enabled (localhost:34471) 2025-01-18 07:30:43 (607025): Preference change detected 2025-01-18 07:30:43 (607025): Setting CPU throttle for VM. (60%) 2025-01-18 07:30:44 (607025): Setting checkpoint interval to 600 seconds. (Higher value of (Preference: 60 seconds) or (Vbox_job.xml: 600 seconds)) 2025-01-18 07:30:45 (607025): Guest Log: BIOS: Boot : bseqnr=1, bootseq=0032 2025-01-18 07:30:45 (607025): Guest Log: BIOS: Booting from Hard Disk... 2025-01-18 07:30:48 (607025): Guest Log: BIOS: KBD: unsupported int 16h function 03 2025-01-18 07:30:48 (607025): Guest Log: BIOS: AX=0305 BX=0000 CX=0000 DX=0000 2025-01-18 07:31:08 (607025): Guest Log: vgdrvHeartbeatInit: Setting up heartbeat to trigger every 2000 milliseconds 2025-01-18 07:31:08 (607025): Guest Log: vboxguest: misc device minor 56, IRQ 20, I/O port d020, MMIO at 00000000f0400000 (size 0x400000) 2025-01-18 07:31:12 (607025): Guest Log: VBoxService 5.2.6 r120293 (verbosity: 0) linux.amd64 (Jan 15 2018 14:51:00) release log 2025-01-18 07:31:12 (607025): Guest Log: 00:00:00.000078 main Log opened 2025-01-18T12:31:11.985782000Z 2025-01-18 07:31:12 (607025): Guest Log: 00:00:00.000155 main OS Product: Linux 2025-01-18 07:31:12 (607025): Guest Log: 00:00:00.000175 main OS Release: 4.14.76-13.cernvm.x86_64 2025-01-18 07:31:12 (607025): Guest Log: 00:00:00.000187 main OS Version: #1 SMP Tue Oct 16 18:26:15 CEST 2018 2025-01-18 07:31:12 (607025): Guest Log: 00:00:00.000200 main Executable: /usr/sbin/VBoxService 2025-01-18 07:31:12 (607025): Guest Log: 00:00:00.000200 main Process ID: 3219 2025-01-18 07:31:12 (607025): Guest Log: 00:00:00.000200 main Package type: LINUX_64BITS_GENERIC 2025-01-18 07:31:12 (607025): Guest Log: 00:00:00.002017 main 5.2.6 r120293 started. Verbose level = 0 2025-01-18 07:31:34 (607025): Guest Log: 06:31:34 CST -06:00 2025-01-18: cranky: [INFO] Detected Theory App 2025-01-18 07:31:34 (607025): Guest Log: 06:31:34 CST -06:00 2025-01-18: cranky: [INFO] Checking CVMFS. 2025-01-18 07:31:35 (607025): Guest Log: Probing /cvmfs/sft.cern.ch... OK 2025-01-18 07:31:36 (607025): 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 2025-01-18 07:31:36 (607025): Guest Log: 2.5.2.0 4102 0 27204 31500 3 1 278903 4096000 0 65024 0 0 n/a 5 3 http://s1ihep-cvmfs.openhtc.io/cvmfs/sft.cern.ch DIRECT 1 2025-01-18 07:31:36 (607025): Guest Log: Probing /cvmfs/grid.cern.ch... OK 2025-01-18 07:31:37 (607025): 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 2025-01-18 07:31:37 (607025): Guest Log: 2.5.2.0 4054 0 25468 26257 3 2 278903 4096000 0 65024 0 2 -100 10085 6093 http://s1cern-cvmfs.openhtc.io/cvmfs/grid.cern.ch DIRECT 1 2025-01-18 07:31:38 (607025): Guest Log: Probing /cvmfs/cernvm-prod.cern.ch... OK 2025-01-18 07:31:38 (607025): 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 2025-01-18 07:31:38 (607025): Guest Log: 2.5.2.0 4124 0 25508 272 3 1 278903 4096000 0 65024 0 0 n/a 4 4 http://s1bnl-cvmfs.openhtc.io/cvmfs/cernvm-prod.cern.ch DIRECT 1 2025-01-18 07:31:39 (607025): Guest Log: Probing /cvmfs/alice.cern.ch... OK 2025-01-18 07:31:39 (607025): 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 2025-01-18 07:31:39 (607025): Guest Log: 2.5.2.0 4076 0 41680 20892 3 1 278903 4096000 0 65024 0 0 n/a 6576 6440 http://s1cern-cvmfs.openhtc.io/cvmfs/alice.cern.ch DIRECT 1 2025-01-18 07:31:39 (607025): Guest Log: 06:31:39 CST -06:00 2025-01-18: cranky: [INFO] Checking runc. 2025-01-18 07:31:39 (607025): Guest Log: 06:31:39 CST -06:00 2025-01-18: cranky: [INFO] Creating the filesystem. 2025-01-18 07:31:39 (607025): Guest Log: 06:31:39 CST -06:00 2025-01-18: cranky: [INFO] Using /cvmfs/cernvm-prod.cern.ch/cvm4 2025-01-18 07:31:40 (607025): Guest Log: 06:31:39 CST -06:00 2025-01-18: cranky: [INFO] Updating config.json. 2025-01-18 07:31:40 (607025): Guest Log: 06:31:39 CST -06:00 2025-01-18: cranky: [INFO] Running Container 'runc'. 2025-01-18 07:31:42 (607025): Guest Log: job: htmld=/shared/html/job 2025-01-18 07:31:42 (607025): Guest Log: job: unpack exitcode=0 2025-01-18 07:31:42 (607025): Guest Log: INFO: activated the work-around for ld: 2025-01-18 07:31:43 (607025): Guest Log: lrwxrwxrwx 1 0 0 15 Jan 18 12:31 /tmp/tmp.IzqvbnifyF/ld -> /usr/bin/ld.bfd 2025-01-18 07:31:44 (607025): Guest Log: 06:31:43 CST -06:00 2025-01-18: cranky: [INFO] ===> [runRivet] Sat Jan 18 12:31:42 UTC 2025 [boinc ppbar jets 1960 65 - powheg-box r3744 pthard2 100000 180] 2025-01-18 07:50:58 (607025): VM state change detected. (old = 'running', new = 'paused') 2025-01-18 07:51:18 (607025): VM state change detected. (old = 'paused', new = 'running') 2025-01-18 08:04:02 (607025): VM state change detected. (old = 'running', new = 'paused') 2025-01-18 08:04:23 (607025): VM state change detected. (old = 'paused', new = 'running') 2025-01-18 08:06:03 (607025): VM state change detected. (old = 'running', new = 'paused') 2025-01-18 08:06:24 (607025): VM state change detected. (old = 'paused', new = 'running') 2025-01-18 08:26:02 (607025): VM state change detected. (old = 'running', new = 'paused') 2025-01-18 08:26:22 (607025): VM state change detected. (old = 'paused', new = 'running') 2025-01-18 08:31:04 (607025): VM state change detected. (old = 'running', new = 'paused') 2025-01-18 08:31:25 (607025): VM state change detected. (old = 'paused', new = 'running') 2025-01-18 08:33:25 (607025): VM state change detected. (old = 'running', new = 'paused') 2025-01-18 08:33:46 (607025): VM state change detected. (old = 'paused', new = 'running') 2025-01-18 08:54:13 (607025): VM state change detected. (old = 'running', new = 'paused') 2025-01-18 08:54:34 (607025): VM state change detected. (old = 'paused', new = 'running') 2025-01-18 08:55:46 (607025): Stopping VM. 2025-01-18 08:55:49 (607025): Successfully stopped VM. 2025-01-18 09:51:19 (707524): vboxwrapper version 26208 2025-01-18 09:51:19 (707524): BOINC client version: 8.0.2 2025-01-18 09:51:19 (707524): Detected: VirtualBox VboxManage Interface (Version: 7.0.22) 2025-01-18 09:51:19 (707524): Detected: Heartbeat check (file: 'heartbeat' every 1200.000000 seconds) 2025-01-18 09:51:20 (707524): Guest Log: BIOS: VirtualBox 7.0.22 2025-01-18 09:51:20 (707524): Guest Log: CPUID EDX: 0x178bfbff 2025-01-18 09:51:20 (707524): Guest Log: BIOS: No PCI IDE controller, not probing IDE 2025-01-18 09:51:20 (707524): Guest Log: BIOS: AHCI 0-P#0: PCHS=16383/16/63 LCHS=1024/255/63 0x0000000002800000 sectors 2025-01-18 09:51:20 (707524): Guest Log: BIOS: Boot : bseqnr=1, bootseq=0032 2025-01-18 09:51:20 (707524): Guest Log: BIOS: Booting from Hard Disk... 2025-01-18 09:51:20 (707524): Guest Log: BIOS: KBD: unsupported int 16h function 03 2025-01-18 09:51:20 (707524): Guest Log: BIOS: AX=0305 BX=0000 CX=0000 DX=0000 2025-01-18 09:51:20 (707524): Guest Log: vgdrvHeartbeatInit: Setting up heartbeat to trigger every 2000 milliseconds 2025-01-18 09:51:20 (707524): Guest Log: vboxguest: misc device minor 56, IRQ 20, I/O port d020, MMIO at 00000000f0400000 (size 0x400000) 2025-01-18 09:51:20 (707524): Guest Log: VBoxService 5.2.6 r120293 (verbosity: 0) linux.amd64 (Jan 15 2018 14:51:00) release log 2025-01-18 09:51:20 (707524): Guest Log: 00:00:00.000078 main Log opened 2025-01-18T12:31:11.985782000Z 2025-01-18 09:51:20 (707524): Guest Log: 00:00:00.000155 main OS Product: Linux 2025-01-18 09:51:20 (707524): Guest Log: 00:00:00.000175 main OS Release: 4.14.76-13.cernvm.x86_64 2025-01-18 09:51:20 (707524): Guest Log: 00:00:00.000187 main OS Version: #1 SMP Tue Oct 16 18:26:15 CEST 2018 2025-01-18 09:51:20 (707524): Guest Log: 00:00:00.000200 main Executable: /usr/sbin/VBoxService 2025-01-18 09:51:20 (707524): Guest Log: 00:00:00.000200 main Process ID: 3219 2025-01-18 09:51:20 (707524): Guest Log: 00:00:00.000200 main Package type: LINUX_64BITS_GENERIC 2025-01-18 09:51:20 (707524): Guest Log: 00:00:00.002017 main 5.2.6 r120293 started. Verbose level = 0 2025-01-18 09:51:20 (707524): Guest Log: 06:31:34 CST -06:00 2025-01-18: cranky: [INFO] Detected Theory App 2025-01-18 09:51:20 (707524): Guest Log: 06:31:34 CST -06:00 2025-01-18: cranky: [INFO] Checking CVMFS. 2025-01-18 09:51:20 (707524): Guest Log: Probing /cvmfs/sft.cern.ch... OK 2025-01-18 09:51:20 (707524): 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 2025-01-18 09:51:20 (707524): Guest Log: 2.5.2.0 4102 0 27204 31500 3 1 278903 4096000 0 65024 0 0 n/a 5 3 http://s1ihep-cvmfs.openhtc.io/cvmfs/sft.cern.ch DIRECT 1 2025-01-18 09:51:20 (707524): Guest Log: Probing /cvmfs/grid.cern.ch... OK 2025-01-18 09:51:20 (707524): 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 2025-01-18 09:51:20 (707524): Guest Log: 2.5.2.0 4054 0 25468 26257 3 2 278903 4096000 0 65024 0 2 -100 10085 6093 http://s1cern-cvmfs.openhtc.io/cvmfs/grid.cern.ch DIRECT 1 2025-01-18 09:51:20 (707524): Guest Log: Probing /cvmfs/cernvm-prod.cern.ch... OK 2025-01-18 09:51:20 (707524): 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 2025-01-18 09:51:20 (707524): Guest Log: 2.5.2.0 4124 0 25508 272 3 1 278903 4096000 0 65024 0 0 n/a 4 4 http://s1bnl-cvmfs.openhtc.io/cvmfs/cernvm-prod.cern.ch DIRECT 1 2025-01-18 09:51:20 (707524): Guest Log: Probing /cvmfs/alice.cern.ch... OK 2025-01-18 09:51:20 (707524): 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 2025-01-18 09:51:20 (707524): Guest Log: 2.5.2.0 4076 0 41680 20892 3 1 278903 4096000 0 65024 0 0 n/a 6576 6440 http://s1cern-cvmfs.openhtc.io/cvmfs/alice.cern.ch DIRECT 1 2025-01-18 09:51:20 (707524): Guest Log: 06:31:39 CST -06:00 2025-01-18: cranky: [INFO] Checking runc. 2025-01-18 09:51:20 (707524): Guest Log: 06:31:39 CST -06:00 2025-01-18: cranky: [INFO] Creating the filesystem. 2025-01-18 09:51:20 (707524): Guest Log: 06:31:39 CST -06:00 2025-01-18: cranky: [INFO] Using /cvmfs/cernvm-prod.cern.ch/cvm4 2025-01-18 09:51:20 (707524): Guest Log: 06:31:39 CST -06:00 2025-01-18: cranky: [INFO] Updating config.json. 2025-01-18 09:51:20 (707524): Guest Log: 06:31:39 CST -06:00 2025-01-18: cranky: [INFO] Running Container 'runc'. 2025-01-18 09:51:20 (707524): Guest Log: job: htmld=/shared/html/job 2025-01-18 09:51:20 (707524): Guest Log: job: unpack exitcode=0 2025-01-18 09:51:20 (707524): Guest Log: INFO: activated the work-around for ld: 2025-01-18 09:51:20 (707524): Guest Log: lrwxrwxrwx 1 0 0 15 Jan 18 12:31 /tmp/tmp.IzqvbnifyF/ld -> /usr/bin/ld.bfd 2025-01-18 09:51:20 (707524): Guest Log: 06:31:43 CST -06:00 2025-01-18: cranky: [INFO] ===> [runRivet] Sat Jan 18 12:31:42 UTC 2025 [boinc ppbar jets 1960 65 - powheg-box r3744 pthard2 100000 180] 2025-01-18 09:51:20 (707524): Starting VM using VBoxManage interface. (boinc_ed8ea6e5b7682369, slot#3) 2025-01-18 09:51:22 (707524): Successfully started VM. (PID = '707642') 2025-01-18 09:51:22 (707524): Reporting VM Process ID to BOINC. 2025-01-18 09:51:22 (707524): VM state change detected. (old = 'poweredoff', new = 'running') 2025-01-18 09:51:22 (707524): Detected: Web Application Enabled (http://localhost:38169) 2025-01-18 09:51:22 (707524): Detected: Remote Desktop Enabled (localhost:34471) 2025-01-18 09:51:22 (707524): Preference change detected 2025-01-18 09:51:22 (707524): Setting CPU throttle for VM. (60%) 2025-01-18 09:51:22 (707524): Setting checkpoint interval to 600 seconds. (Higher value of (Preference: 60 seconds) or (Vbox_job.xml: 600 seconds)) 2025-01-18 09:51:26 (707524): VM state change detected. (old = 'running', new = 'paused') 2025-01-18 09:51:47 (707524): Guest Log: 01:22:17.751328 timesync vgsvcTimeSyncWorker: Radical host time change: 3 365 963 000 000ns (HostNow=1 737 211 907 423 000 000 ns HostLast=1 737 208 541 460 000 000 ns) 2025-01-18 09:51:47 (707524): VM state change detected. (old = 'paused', new = 'running') 2025-01-18 09:51:58 (707524): Guest Log: 01:22:27.832655 timesync vgsvcTimeSyncWorker: Radical guest time change: 3 507 834 888 000ns (GuestNow=1 737 211 917 538 106 000 ns GuestLast=1 737 208 409 703 218 000 ns fSetTimeLastLoop=true ) 2025-01-18 09:52:27 (707524): VM state change detected. (old = 'running', new = 'paused') 2025-01-18 09:52:48 (707524): VM state change detected. (old = 'paused', new = 'running') 2025-01-18 09:52:57 (707524): VM state change detected. (old = 'running', new = 'paused') 2025-01-18 09:53:18 (707524): VM state change detected. (old = 'paused', new = 'running') 2025-01-18 09:53:27 (707524): VM state change detected. (old = 'running', new = 'paused') 2025-01-18 09:53:48 (707524): VM state change detected. (old = 'paused', new = 'running') 2025-01-18 10:01:31 (707524): VM state change detected. (old = 'running', new = 'paused') 2025-01-18 10:01:51 (707524): VM state change detected. (old = 'paused', new = 'running') 2025-01-18 10:05:43 (5316): vboxwrapper version 26208 2025-01-18 10:05:43 (5316): BOINC client version: 8.0.2 2025-01-18 10:05:43 (5316): Detected: VirtualBox VboxManage Interface (Version: 7.0.22) 2025-01-18 10:05:44 (5316): Detected: Heartbeat check (file: 'heartbeat' every 1200.000000 seconds) 2025-01-18 10:05:44 (5316): Guest Log: 01:22:17.751328 timesync vgsvcTimeSyncWorker: Radical host time change: 3 365 963 000 000ns (HostNow=1 737 211 907 423 000 000 ns HostLast=1 737 208 541 460 000 000 ns) 2025-01-18 10:05:44 (5316): Guest Log: 01:22:27.832655 timesync vgsvcTimeSyncWorker: Radical guest time change: 3 507 834 888 000ns (GuestNow=1 737 211 917 538 106 000 ns GuestLast=1 737 208 409 703 218 000 ns fSetTimeLastLoop=true ) 2025-01-18 10:05:44 (5316): Starting VM using VBoxManage interface. (boinc_ed8ea6e5b7682369, slot#3) 2025-01-18 10:05:46 (5316): Successfully started VM. (PID = '7189') 2025-01-18 10:05:46 (5316): Reporting VM Process ID to BOINC. 2025-01-18 10:05:46 (5316): Guest Log: BIOS: VirtualBox 7.0.22 2025-01-18 10:05:46 (5316): Guest Log: CPUID EDX: 0x178bfbff 2025-01-18 10:05:46 (5316): Guest Log: BIOS: No PCI IDE controller, not probing IDE 2025-01-18 10:05:46 (5316): Guest Log: BIOS: AHCI 0-P#0: PCHS=16383/16/63 LCHS=1024/255/63 0x0000000002800000 sectors 2025-01-18 10:05:46 (5316): VM state change detected. (old = 'poweredoff', new = 'running') 2025-01-18 10:05:46 (5316): Detected: Web Application Enabled (http://localhost:38169) 2025-01-18 10:05:46 (5316): Detected: Remote Desktop Enabled (localhost:34471) 2025-01-18 10:05:46 (5316): Preference change detected 2025-01-18 10:05:46 (5316): Setting CPU throttle for VM. (60%) 2025-01-18 10:05:46 (5316): Setting checkpoint interval to 600 seconds. (Higher value of (Preference: 60 seconds) or (Vbox_job.xml: 600 seconds)) 2025-01-18 10:05:48 (5316): Guest Log: BIOS: Boot : bseqnr=1, bootseq=0032 2025-01-18 10:05:48 (5316): Guest Log: BIOS: Booting from Hard Disk... 2025-01-18 10:05:51 (5316): Guest Log: BIOS: KBD: unsupported int 16h function 03 2025-01-18 10:05:51 (5316): Guest Log: BIOS: AX=0305 BX=0000 CX=0000 DX=0000 2025-01-18 10:05:53 (5316): VM state change detected. (old = 'running', new = 'paused') 2025-01-18 10:06:12 (5316): VM state change detected. (old = 'paused', new = 'running') 2025-01-18 10:06:30 (5316): Guest Log: vgdrvHeartbeatInit: Setting up heartbeat to trigger every 2000 milliseconds 2025-01-18 10:06:30 (5316): Guest Log: vboxguest: misc device minor 56, IRQ 20, I/O port d020, MMIO at 00000000f0400000 (size 0x400000) 2025-01-18 10:06:33 (5316): Guest Log: VBoxService 5.2.6 r120293 (verbosity: 0) linux.amd64 (Jan 15 2018 14:51:00) release log 2025-01-18 10:06:33 (5316): Guest Log: 00:00:00.000077 main Log opened 2025-01-18T15:06:33.494578000Z 2025-01-18 10:06:33 (5316): Guest Log: 00:00:00.000149 main OS Product: Linux 2025-01-18 10:06:33 (5316): Guest Log: 00:00:00.000166 main OS Release: 4.14.76-13.cernvm.x86_64 2025-01-18 10:06:33 (5316): Guest Log: 00:00:00.000178 main OS Version: #1 SMP Tue Oct 16 18:26:15 CEST 2018 2025-01-18 10:06:33 (5316): Guest Log: 00:00:00.000194 main Executable: /usr/sbin/VBoxService 2025-01-18 10:06:33 (5316): Guest Log: 00:00:00.000194 main Process ID: 3218 2025-01-18 10:06:33 (5316): Guest Log: 00:00:00.000195 main Package type: LINUX_64BITS_GENERIC 2025-01-18 10:06:33 (5316): Guest Log: 00:00:00.001809 main 5.2.6 r120293 started. Verbose level = 0 2025-01-18 10:06:55 (5316): Guest Log: 09:06:54 CST -06:00 2025-01-18: cranky: [INFO] Detected Theory App 2025-01-18 10:06:55 (5316): Guest Log: 09:06:54 CST -06:00 2025-01-18: cranky: [INFO] Checking CVMFS. 2025-01-18 10:06:55 (5316): Guest Log: Probing /cvmfs/sft.cern.ch... OK 2025-01-18 10:06:56 (5316): 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 2025-01-18 10:06:56 (5316): Guest Log: 2.5.2.0 4121 0 25756 31502 3 1 1711408 4096001 0 65024 0 0 n/a 0 0 http://s1cern-cvmfs.openhtc.io/cvmfs/sft.cern.ch DIRECT 1 2025-01-18 10:06:56 (5316): Guest Log: Probing /cvmfs/grid.cern.ch... OK 2025-01-18 10:06:57 (5316): 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 2025-01-18 10:06:57 (5316): Guest Log: 2.5.2.0 4050 0 27504 26257 3 2 1711408 4096001 0 65024 0 2 100 0 0 http://s1cern-cvmfs.openhtc.io/cvmfs/grid.cern.ch DIRECT 1 2025-01-18 10:06:57 (5316): Guest Log: Probing /cvmfs/cernvm-prod.cern.ch... OK 2025-01-18 10:06:58 (5316): 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 2025-01-18 10:06:58 (5316): Guest Log: 2.5.2.0 4072 0 27232 272 3 1 1711408 4096001 0 65024 0 0 n/a 0 0 http://s1cern-cvmfs.openhtc.io/cvmfs/cernvm-prod.cern.ch DIRECT 1 2025-01-18 10:06:59 (5316): Guest Log: Probing /cvmfs/alice.cern.ch... OK 2025-01-18 10:06:59 (5316): 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 2025-01-18 10:06:59 (5316): Guest Log: 2.5.2.0 4097 0 41656 20892 3 1 1711408 4096001 0 65024 0 0 n/a 0 0 http://s1cern-cvmfs.openhtc.io/cvmfs/alice.cern.ch DIRECT 1 2025-01-18 10:06:59 (5316): Guest Log: 09:06:59 CST -06:00 2025-01-18: cranky: [INFO] Checking runc. 2025-01-18 10:06:59 (5316): Guest Log: 09:06:59 CST -06:00 2025-01-18: cranky: [INFO] Creating the filesystem. 2025-01-18 10:06:59 (5316): Guest Log: 09:06:59 CST -06:00 2025-01-18: cranky: [INFO] Using /cvmfs/cernvm-prod.cern.ch/cvm4 2025-01-18 10:06:59 (5316): Guest Log: 09:06:59 CST -06:00 2025-01-18: cranky: [INFO] Updating config.json. 2025-01-18 10:06:59 (5316): Guest Log: 09:06:59 CST -06:00 2025-01-18: cranky: [INFO] Running Container 'runc'. 2025-01-18 10:07:00 (5316): Guest Log: job: htmld=/shared/html/job 2025-01-18 10:07:00 (5316): Guest Log: job: unpack exitcode=0 2025-01-18 10:07:00 (5316): Guest Log: INFO: activated the work-around for ld: 2025-01-18 10:07:00 (5316): Guest Log: lrwxrwxrwx 1 0 0 15 Jan 18 15:06 /tmp/tmp.EbaSEGXAnS/ld -> /usr/bin/ld.bfd 2025-01-18 10:07:01 (5316): Guest Log: 09:07:01 CST -06:00 2025-01-18: cranky: [INFO] ===> [runRivet] Sat Jan 18 15:06:59 UTC 2025 [boinc ppbar jets 1960 65 - powheg-box r3744 pthard2 100000 180] 2025-01-18 10:14:06 (5316): Status Report: Job Duration: '864000.000000' 2025-01-18 10:14:06 (5316): Status Report: Elapsed Time: '6000.000000' 2025-01-18 10:14:06 (5316): Status Report: CPU Time: '3356.840000' 2025-01-18 10:28:58 (5316): VM state change detected. (old = 'running', new = 'paused') 2025-01-18 10:29:19 (5316): VM state change detected. (old = 'paused', new = 'running') 2025-01-18 10:38:51 (5316): VM state change detected. (old = 'running', new = 'paused') 2025-01-18 10:39:11 (5316): VM state change detected. (old = 'paused', new = 'running') 2025-01-18 10:42:22 (5316): VM state change detected. (old = 'running', new = 'paused') 2025-01-18 10:42:42 (5316): VM state change detected. (old = 'paused', new = 'running') 2025-01-18 11:02:26 (5316): VM state change detected. (old = 'running', new = 'paused') 2025-01-18 11:02:46 (5316): VM state change detected. (old = 'paused', new = 'running') 2025-01-18 11:05:57 (5316): VM state change detected. (old = 'running', new = 'paused') 2025-01-18 11:06:18 (5316): VM state change detected. (old = 'paused', new = 'running') 2025-01-18 11:09:38 (5316): VM state change detected. (old = 'running', new = 'paused') 2025-01-18 11:09:58 (5316): VM state change detected. (old = 'paused', new = 'running') 2025-01-18 11:10:48 (5316): Stopping VM. 2025-01-18 11:10:51 (5316): Successfully stopped VM. 2025-01-18 22:36:20 (648393): vboxwrapper version 26208 2025-01-18 22:36:20 (648393): BOINC client version: 8.0.2 2025-01-18 22:36:20 (648393): Detected: VirtualBox VboxManage Interface (Version: 7.0.22) 2025-01-18 22:36:20 (648393): Detected: Heartbeat check (file: 'heartbeat' every 1200.000000 seconds) 2025-01-18 22:36:20 (648393): Guest Log: BIOS: VirtualBox 7.0.22 2025-01-18 22:36:20 (648393): Guest Log: CPUID EDX: 0x178bfbff 2025-01-18 22:36:20 (648393): Guest Log: BIOS: AHCI 0-P#0: PCHS=16383/16/63 LCHS=1024/255/63 0x0000000002800000 sectors 2025-01-18 22:36:20 (648393): Guest Log: BIOS: Boot : bseqnr=1, bootseq=0032 2025-01-18 22:36:20 (648393): Guest Log: BIOS: Booting from Hard Disk... 2025-01-18 22:36:20 (648393): Guest Log: BIOS: KBD: unsupported int 16h function 03 2025-01-18 22:36:20 (648393): Guest Log: BIOS: AX=0305 BX=0000 CX=0000 DX=0000 2025-01-18 22:36:20 (648393): Guest Log: vgdrvHeartbeatInit: Setting up heartbeat to trigger every 2000 milliseconds 2025-01-18 22:36:20 (648393): Guest Log: vboxguest: misc device minor 56, IRQ 20, I/O port d020, MMIO at 00000000f0400000 (size 0x400000) 2025-01-18 22:36:20 (648393): Guest Log: VBoxService 5.2.6 r120293 (verbosity: 0) linux.amd64 (Jan 15 2018 14:51:00) release log 2025-01-18 22:36:20 (648393): Guest Log: 00:00:00.000077 main Log opened 2025-01-18T15:06:33.494578000Z 2025-01-18 22:36:20 (648393): Guest Log: 00:00:00.000149 main OS Product: Linux 2025-01-18 22:36:20 (648393): Guest Log: 00:00:00.000166 main OS Release: 4.14.76-13.cernvm.x86_64 2025-01-18 22:36:20 (648393): Guest Log: 00:00:00.000178 main OS Version: #1 SMP Tue Oct 16 18:26:15 CEST 2018 2025-01-18 22:36:20 (648393): Guest Log: 00:00:00.000194 main Executable: /usr/sbin/VBoxService 2025-01-18 22:36:20 (648393): Guest Log: 00:00:00.000194 main Process ID: 3218 2025-01-18 22:36:20 (648393): Guest Log: 00:00:00.000195 main Package type: LINUX_64BITS_GENERIC 2025-01-18 22:36:20 (648393): Guest Log: 00:00:00.001809 main 5.2.6 r120293 started. Verbose level = 0 2025-01-18 22:36:20 (648393): Guest Log: 09:06:54 CST -06:00 2025-01-18: cranky: [INFO] Detected Theory App 2025-01-18 22:36:20 (648393): Guest Log: 09:06:54 CST -06:00 2025-01-18: cranky: [INFO] Checking CVMFS. 2025-01-18 22:36:20 (648393): Guest Log: Probing /cvmfs/sft.cern.ch... OK 2025-01-18 22:36:20 (648393): 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 2025-01-18 22:36:20 (648393): Guest Log: 2.5.2.0 4121 0 25756 31502 3 1 1711408 4096001 0 65024 0 0 n/a 0 0 http://s1cern-cvmfs.openhtc.io/cvmfs/sft.cern.ch DIRECT 1 2025-01-18 22:36:20 (648393): Guest Log: Probing /cvmfs/grid.cern.ch... OK 2025-01-18 22:36:20 (648393): 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 2025-01-18 22:36:20 (648393): Guest Log: 2.5.2.0 4050 0 27504 26257 3 2 1711408 4096001 0 65024 0 2 100 0 0 http://s1cern-cvmfs.openhtc.io/cvmfs/grid.cern.ch DIRECT 1 2025-01-18 22:36:20 (648393): Guest Log: Probing /cvmfs/cernvm-prod.cern.ch... OK 2025-01-18 22:36:20 (648393): 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 2025-01-18 22:36:20 (648393): Guest Log: 2.5.2.0 4072 0 27232 272 3 1 1711408 4096001 0 65024 0 0 n/a 0 0 http://s1cern-cvmfs.openhtc.io/cvmfs/cernvm-prod.cern.ch DIRECT 1 2025-01-18 22:36:20 (648393): Guest Log: Probing /cvmfs/alice.cern.ch... OK 2025-01-18 22:36:20 (648393): 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 2025-01-18 22:36:20 (648393): Guest Log: 2.5.2.0 4097 0 41656 20892 3 1 1711408 4096001 0 65024 0 0 n/a 0 0 http://s1cern-cvmfs.openhtc.io/cvmfs/alice.cern.ch DIRECT 1 2025-01-18 22:36:20 (648393): Guest Log: 09:06:59 CST -06:00 2025-01-18: cranky: [INFO] Checking runc. 2025-01-18 22:36:20 (648393): Guest Log: 09:06:59 CST -06:00 2025-01-18: cranky: [INFO] Creating the filesystem. 2025-01-18 22:36:20 (648393): Guest Log: 09:06:59 CST -06:00 2025-01-18: cranky: [INFO] Using /cvmfs/cernvm-prod.cern.ch/cvm4 2025-01-18 22:36:20 (648393): Guest Log: 09:06:59 CST -06:00 2025-01-18: cranky: [INFO] Updating config.json. 2025-01-18 22:36:20 (648393): Guest Log: 09:06:59 CST -06:00 2025-01-18: cranky: [INFO] Running Container 'runc'. 2025-01-18 22:36:20 (648393): Guest Log: job: htmld=/shared/html/job 2025-01-18 22:36:20 (648393): Guest Log: job: unpack exitcode=0 2025-01-18 22:36:20 (648393): Guest Log: INFO: activated the work-around for ld: 2025-01-18 22:36:20 (648393): Guest Log: lrwxrwxrwx 1 0 0 15 Jan 18 15:06 /tmp/tmp.EbaSEGXAnS/ld -> /usr/bin/ld.bfd 2025-01-18 22:36:20 (648393): Guest Log: 09:07:01 CST -06:00 2025-01-18: cranky: [INFO] ===> [runRivet] Sat Jan 18 15:06:59 UTC 2025 [boinc ppbar jets 1960 65 - powheg-box r3744 pthard2 100000 180] 2025-01-18 22:36:20 (648393): Starting VM using VBoxManage interface. (boinc_ed8ea6e5b7682369, slot#3) 2025-01-18 22:36:23 (648393): Successfully started VM. (PID = '649020') 2025-01-18 22:36:23 (648393): Reporting VM Process ID to BOINC. 2025-01-18 22:36:23 (648393): VM state change detected. (old = 'poweredoff', new = 'running') 2025-01-18 22:36:23 (648393): Detected: Web Application Enabled (http://localhost:38169) 2025-01-18 22:36:23 (648393): Detected: Remote Desktop Enabled (localhost:34471) 2025-01-18 22:36:23 (648393): Status Report: Job Duration: '864000.000000' 2025-01-18 22:36:23 (648393): Status Report: Elapsed Time: '9304.000000' 2025-01-18 22:36:23 (648393): Status Report: CPU Time: '5264.000000' 2025-01-18 22:36:23 (648393): Preference change detected 2025-01-18 22:36:23 (648393): Setting CPU throttle for VM. (60%) 2025-01-18 22:36:23 (648393): Setting checkpoint interval to 600 seconds. (Higher value of (Preference: 60 seconds) or (Vbox_job.xml: 600 seconds)) 2025-01-18 22:36:24 (648393): Guest Log: 01:02:14.845627 timesync vgsvcTimeSyncWorker: Radical host time change: 41 144 237 000 000ns (HostNow=1 737 257 784 289 000 000 ns HostLast=1 737 216 640 052 000 000 ns) 2025-01-18 22:36:32 (648393): VM state change detected. (old = 'running', new = 'paused') 2025-01-18 22:36:52 (648393): VM state change detected. (old = 'paused', new = 'running') 2025-01-18 22:36:54 (648393): Guest Log: 01:02:24.873546 timesync vgsvcTimeSyncWorker: Radical guest time change: 41 266 023 610 000ns (GuestNow=1 737 257 794 340 301 000 ns GuestLast=1 737 216 528 316 691 000 ns fSetTimeLastLoop=true ) 2025-01-18 22:43:23 (648393): VM state change detected. (old = 'running', new = 'paused') 2025-01-18 22:43:44 (648393): VM state change detected. (old = 'paused', new = 'running') 2025-01-18 22:44:20 (648393): Stopping VM. 2025-01-18 22:44:23 (648393): Successfully stopped VM. 2025-01-19 01:23:30 (787442): vboxwrapper version 26208 2025-01-19 01:23:30 (787442): BOINC client version: 8.0.2 2025-01-19 01:23:30 (787442): Detected: VirtualBox VboxManage Interface (Version: 7.0.22) 2025-01-19 01:23:30 (787442): Detected: Heartbeat check (file: 'heartbeat' every 1200.000000 seconds) 2025-01-19 01:23:30 (787442): Guest Log: 01:02:14.845627 timesync vgsvcTimeSyncWorker: Radical host time change: 41 144 237 000 000ns (HostNow=1 737 257 784 289 000 000 ns HostLast=1 737 216 640 052 000 000 ns) 2025-01-19 01:23:30 (787442): Guest Log: 01:02:24.873546 timesync vgsvcTimeSyncWorker: Radical guest time change: 41 266 023 610 000ns (GuestNow=1 737 257 794 340 301 000 ns GuestLast=1 737 216 528 316 691 000 ns fSetTimeLastLoop=true ) 2025-01-19 01:23:30 (787442): Starting VM using VBoxManage interface. (boinc_ed8ea6e5b7682369, slot#3) 2025-01-19 01:23:33 (787442): Successfully started VM. (PID = '787573') 2025-01-19 01:23:33 (787442): Reporting VM Process ID to BOINC. 2025-01-19 01:23:33 (787442): VM state change detected. (old = 'poweredoff', new = 'running') 2025-01-19 01:23:33 (787442): Detected: Web Application Enabled (http://localhost:38169) 2025-01-19 01:23:33 (787442): Detected: Remote Desktop Enabled (localhost:34471) 2025-01-19 01:23:33 (787442): Status Report: Job Duration: '864000.000000' 2025-01-19 01:23:33 (787442): Status Report: Elapsed Time: '9743.000000' 2025-01-19 01:23:33 (787442): Status Report: CPU Time: '5519.030000' 2025-01-19 01:23:33 (787442): Preference change detected 2025-01-19 01:23:33 (787442): Setting CPU throttle for VM. (60%) 2025-01-19 01:23:33 (787442): Setting checkpoint interval to 600 seconds. (Higher value of (Preference: 60 seconds) or (Vbox_job.xml: 600 seconds)) 2025-01-19 01:23:37 (787442): Guest Log: 01:09:35.465642 timesync vgsvcTimeSyncWorker: Radical host time change: 9 561 571 000 000ns (HostNow=1 737 267 816 902 000 000 ns HostLast=1 737 258 255 331 000 000 ns) 2025-01-19 01:23:47 (787442): Guest Log: 01:09:45.466574 timesync vgsvcTimeSyncWorker: Radical guest time change: 9 601 970 572 000ns (GuestNow=1 737 267 826 902 947 000 ns GuestLast=1 737 258 224 932 375 000 ns fSetTimeLastLoop=true ) 2025-01-19 01:28:41 (787442): VM state change detected. (old = 'running', new = 'paused') 2025-01-19 01:29:01 (787442): VM state change detected. (old = 'paused', new = 'running') 2025-01-19 01:33:42 (787442): VM state change detected. (old = 'running', new = 'paused') 2025-01-19 01:34:02 (787442): VM state change detected. (old = 'paused', new = 'running') 2025-01-19 01:35:22 (787442): VM state change detected. (old = 'running', new = 'paused') 2025-01-19 01:35:43 (787442): VM state change detected. (old = 'paused', new = 'running') 2025-01-19 01:46:15 (787442): VM state change detected. (old = 'running', new = 'paused') 2025-01-19 01:46:36 (787442): VM state change detected. (old = 'paused', new = 'running') 2025-01-19 01:47:25 (787442): VM state change detected. (old = 'running', new = 'paused') 2025-01-19 01:47:45 (787442): VM state change detected. (old = 'paused', new = 'running') 2025-01-19 02:12:51 (787442): VM state change detected. (old = 'running', new = 'paused') 2025-01-19 02:13:12 (787442): VM state change detected. (old = 'paused', new = 'running') 2025-01-19 02:23:34 (787442): VM state change detected. (old = 'running', new = 'paused') 2025-01-19 02:23:55 (787442): VM state change detected. (old = 'paused', new = 'running') 2025-01-19 02:24:24 (787442): VM state change detected. (old = 'running', new = 'paused') 2025-01-19 02:24:44 (787442): VM state change detected. (old = 'paused', new = 'running') 2025-01-19 02:24:54 (787442): VM state change detected. (old = 'running', new = 'paused') 2025-01-19 02:25:15 (787442): VM state change detected. (old = 'paused', new = 'running') 2025-01-19 02:26:14 (787442): VM state change detected. (old = 'running', new = 'paused') 2025-01-19 02:26:35 (787442): VM state change detected. (old = 'paused', new = 'running') 2025-01-19 02:26:55 (787442): VM state change detected. (old = 'running', new = 'paused') 2025-01-19 02:27:15 (787442): VM state change detected. (old = 'paused', new = 'running') 2025-01-19 02:27:55 (787442): VM state change detected. (old = 'running', new = 'paused') 2025-01-19 02:28:15 (787442): VM state change detected. (old = 'paused', new = 'running') 2025-01-19 02:28:35 (787442): VM state change detected. (old = 'running', new = 'paused') 2025-01-19 02:28:55 (787442): VM state change detected. (old = 'paused', new = 'running') 2025-01-19 02:29:16 (787442): VM state change detected. (old = 'running', new = 'paused') 2025-01-19 02:29:35 (787442): VM state change detected. (old = 'paused', new = 'running') 2025-01-19 03:07:34 (787442): Status Report: Job Duration: '864000.000000' 2025-01-19 03:07:34 (787442): Status Report: Elapsed Time: '15743.000000' 2025-01-19 03:07:34 (787442): Status Report: CPU Time: '8988.080000' 2025-01-19 03:15:36 (787442): VM state change detected. (old = 'running', new = 'paused') 2025-01-19 03:15:57 (787442): VM state change detected. (old = 'paused', new = 'running') 2025-01-19 03:16:37 (787442): VM state change detected. (old = 'running', new = 'paused') 2025-01-19 03:17:17 (787442): VM state change detected. (old = 'paused', new = 'running') 2025-01-19 03:24:29 (787442): VM state change detected. (old = 'running', new = 'paused') 2025-01-19 03:24:49 (787442): VM state change detected. (old = 'paused', new = 'running') 2025-01-19 03:28:00 (787442): VM state change detected. (old = 'running', new = 'paused') 2025-01-19 03:28:20 (787442): VM state change detected. (old = 'paused', new = 'running') 2025-01-19 03:35:32 (787442): VM state change detected. (old = 'running', new = 'paused') 2025-01-19 03:35:51 (787442): VM state change detected. (old = 'paused', new = 'running') 2025-01-19 03:47:34 (787442): VM state change detected. (old = 'running', new = 'paused') 2025-01-19 03:47:54 (787442): VM state change detected. (old = 'paused', new = 'running') 2025-01-19 03:59:47 (787442): VM state change detected. (old = 'running', new = 'paused') 2025-01-19 04:00:06 (787442): VM state change detected. (old = 'paused', new = 'running') 2025-01-19 04:10:19 (787442): VM state change detected. (old = 'running', new = 'paused') 2025-01-19 04:10:39 (787442): VM state change detected. (old = 'paused', new = 'running') 2025-01-19 04:11:49 (787442): VM state change detected. (old = 'running', new = 'paused') 2025-01-19 04:12:09 (787442): VM state change detected. (old = 'paused', new = 'running') 2025-01-19 04:18:00 (787442): VM state change detected. (old = 'running', new = 'paused') 2025-01-19 04:18:20 (787442): VM state change detected. (old = 'paused', new = 'running') 2025-01-19 04:29:32 (787442): VM state change detected. (old = 'running', new = 'paused') 2025-01-19 04:29:53 (787442): VM state change detected. (old = 'paused', new = 'running') 2025-01-19 04:35:14 (787442): VM state change detected. (old = 'running', new = 'paused') 2025-01-19 04:35:34 (787442): VM state change detected. (old = 'paused', new = 'running') 2025-01-19 04:36:34 (787442): VM state change detected. (old = 'running', new = 'paused') 2025-01-19 04:36:54 (787442): VM state change detected. (old = 'paused', new = 'running') 2025-01-19 04:39:05 (787442): VM state change detected. (old = 'running', new = 'paused') 2025-01-19 04:39:26 (787442): VM state change detected. (old = 'paused', new = 'running') 2025-01-19 04:43:15 (787442): VM state change detected. (old = 'running', new = 'paused') 2025-01-19 04:43:37 (787442): VM state change detected. (old = 'paused', new = 'running') 2025-01-19 04:52:16 (787442): Status Report: Job Duration: '864000.000000' 2025-01-19 04:52:16 (787442): Status Report: Elapsed Time: '21743.000000' 2025-01-19 04:52:16 (787442): Status Report: CPU Time: '12444.010000' 2025-01-19 04:54:28 (787442): VM state change detected. (old = 'running', new = 'paused') 2025-01-19 04:54:48 (787442): VM state change detected. (old = 'paused', new = 'running') 2025-01-19 04:55:18 (787442): VM state change detected. (old = 'running', new = 'paused') 2025-01-19 04:55:38 (787442): VM state change detected. (old = 'paused', new = 'running') 2025-01-19 04:56:39 (787442): VM state change detected. (old = 'running', new = 'paused') 2025-01-19 04:56:58 (787442): VM state change detected. (old = 'paused', new = 'running') 2025-01-19 05:05:00 (787442): VM state change detected. (old = 'running', new = 'paused') 2025-01-19 05:05:21 (787442): VM state change detected. (old = 'paused', new = 'running') 2025-01-19 05:09:21 (787442): VM state change detected. (old = 'running', new = 'paused') 2025-01-19 05:09:42 (787442): VM state change detected. (old = 'paused', new = 'running') 2025-01-19 05:13:32 (787442): VM state change detected. (old = 'running', new = 'paused') 2025-01-19 05:13:53 (787442): VM state change detected. (old = 'paused', new = 'running') 2025-01-19 05:14:32 (787442): VM state change detected. (old = 'running', new = 'paused') 2025-01-19 05:14:53 (787442): VM state change detected. (old = 'paused', new = 'running') 2025-01-19 05:22:24 (787442): VM state change detected. (old = 'running', new = 'paused') 2025-01-19 05:22:43 (787442): VM state change detected. (old = 'paused', new = 'running') 2025-01-19 05:26:24 (787442): VM state change detected. (old = 'running', new = 'paused') 2025-01-19 05:26:44 (787442): VM state change detected. (old = 'paused', new = 'running') 2025-01-19 05:38:57 (787442): VM state change detected. (old = 'running', new = 'paused') 2025-01-19 05:39:18 (787442): VM state change detected. (old = 'paused', new = 'running') 2025-01-19 05:48:30 (787442): VM state change detected. (old = 'running', new = 'paused') 2025-01-19 05:48:49 (787442): VM state change detected. (old = 'paused', new = 'running') 2025-01-19 05:51:59 (787442): VM state change detected. (old = 'running', new = 'paused') 2025-01-19 05:52:20 (787442): VM state change detected. (old = 'paused', new = 'running') 2025-01-19 06:04:32 (787442): VM state change detected. (old = 'running', new = 'paused') 2025-01-19 06:05:13 (787442): VM state change detected. (old = 'paused', new = 'running') 2025-01-19 06:17:25 (787442): VM state change detected. (old = 'running', new = 'paused') 2025-01-19 06:17:45 (787442): VM state change detected. (old = 'paused', new = 'running') 2025-01-19 06:21:16 (787442): VM state change detected. (old = 'running', new = 'paused') 2025-01-19 06:21:35 (787442): VM state change detected. (old = 'paused', new = 'running') 2025-01-19 06:25:37 (787442): VM state change detected. (old = 'running', new = 'paused') 2025-01-19 06:25:57 (787442): VM state change detected. (old = 'paused', new = 'running') 2025-01-19 06:30:07 (787442): VM state change detected. (old = 'running', new = 'paused') 2025-01-19 06:30:28 (787442): VM state change detected. (old = 'paused', new = 'running') 2025-01-19 06:37:40 (787442): Status Report: Job Duration: '864000.000000' 2025-01-19 06:37:40 (787442): Status Report: Elapsed Time: '27743.000000' 2025-01-19 06:37:40 (787442): Status Report: CPU Time: '15898.090000' 2025-01-19 06:41:10 (787442): VM state change detected. (old = 'running', new = 'paused') 2025-01-19 06:41:30 (787442): VM state change detected. (old = 'paused', new = 'running') 2025-01-19 06:42:30 (787442): VM state change detected. (old = 'running', new = 'paused') 2025-01-19 06:42:50 (787442): VM state change detected. (old = 'paused', new = 'running') 2025-01-19 06:52:23 (787442): VM state change detected. (old = 'running', new = 'paused') 2025-01-19 06:52:42 (787442): VM state change detected. (old = 'paused', new = 'running') 2025-01-19 07:07:56 (787442): VM state change detected. (old = 'running', new = 'paused') 2025-01-19 07:08:15 (787442): VM state change detected. (old = 'paused', new = 'running') 2025-01-19 07:11:06 (787442): VM state change detected. (old = 'running', new = 'paused') 2025-01-19 07:11:26 (787442): VM state change detected. (old = 'paused', new = 'running') 2025-01-19 07:20:48 (787442): VM state change detected. (old = 'running', new = 'paused') 2025-01-19 07:21:09 (787442): VM state change detected. (old = 'paused', new = 'running') 2025-01-19 07:25:59 (787442): VM state change detected. (old = 'running', new = 'paused') 2025-01-19 07:26:19 (787442): VM state change detected. (old = 'paused', new = 'running') 2025-01-19 07:31:51 (787442): VM state change detected. (old = 'running', new = 'paused') 2025-01-19 07:32:10 (787442): VM state change detected. (old = 'paused', new = 'running') 2025-01-19 07:40:02 (787442): VM state change detected. (old = 'running', new = 'paused') 2025-01-19 07:40:22 (787442): VM state change detected. (old = 'paused', new = 'running') 2025-01-19 08:04:47 (787442): VM state change detected. (old = 'running', new = 'paused') 2025-01-19 08:05:07 (787442): VM state change detected. (old = 'paused', new = 'running') 2025-01-19 08:20:13 (787442): Status Report: Job Duration: '864000.000000' 2025-01-19 08:20:13 (787442): Status Report: Elapsed Time: '33743.000000' 2025-01-19 08:20:13 (787442): Status Report: CPU Time: '19355.740000' 2025-01-19 08:20:21 (787442): VM state change detected. (old = 'running', new = 'paused') 2025-01-19 08:20:41 (787442): VM state change detected. (old = 'paused', new = 'running') 2025-01-19 08:38:24 (787442): VM state change detected. (old = 'running', new = 'paused') 2025-01-19 08:38:25 (787442): VM state change detected. (old = 'paused', new = 'running') 2025-01-19 08:56:38 (787442): VM state change detected. (old = 'running', new = 'paused') 2025-01-19 08:56:58 (787442): VM state change detected. (old = 'paused', new = 'running') 2025-01-19 09:27:54 (787442): VM state change detected. (old = 'running', new = 'paused') 2025-01-19 09:28:15 (787442): VM state change detected. (old = 'paused', new = 'running') 2025-01-19 09:42:16 (787442): VM state change detected. (old = 'running', new = 'paused') 2025-01-19 09:42:37 (787442): VM state change detected. (old = 'paused', new = 'running') 2025-01-19 09:43:38 (787442): VM state change detected. (old = 'running', new = 'paused') 2025-01-19 09:43:57 (787442): VM state change detected. (old = 'paused', new = 'running') 2025-01-19 09:48:18 (787442): VM state change detected. (old = 'running', new = 'paused') 2025-01-19 09:48:38 (787442): VM state change detected. (old = 'paused', new = 'running') 2025-01-19 09:52:09 (787442): VM state change detected. (old = 'running', new = 'paused') 2025-01-19 09:52:29 (787442): VM state change detected. (old = 'paused', new = 'running') 2025-01-19 10:01:45 (787442): Status Report: Job Duration: '864000.000000' 2025-01-19 10:01:45 (787442): Status Report: Elapsed Time: '39743.000000' 2025-01-19 10:01:45 (787442): Status Report: CPU Time: '22805.710000' 2025-01-19 10:14:49 (787442): Guest Log: job: run exitcode=0 2025-01-19 10:14:49 (787442): Guest Log: job: diskusage=99792 2025-01-19 10:14:49 (787442): Guest Log: job: logsize=80 k 2025-01-19 10:14:49 (787442): Guest Log: job: times= 2025-01-19 10:14:49 (787442): Guest Log: 0m0.006s 0m0.009s 2025-01-19 10:14:49 (787442): Guest Log: 572m27.869s 1m47.886s 2025-01-19 10:14:49 (787442): Guest Log: job: cpuusage=34456 2025-01-19 10:14:49 (787442): Guest Log: 09:13:09 CST -06:00 2025-01-19: cranky: [INFO] Container 'runc' finished with status code 0. 2025-01-19 10:14:49 (787442): Guest Log: 09:13:09 CST -06:00 2025-01-19: cranky: [INFO] Preparing output. 2025-01-19 10:14:49 (787442): Guest Log: [INFO] Job Finished 2025-01-19 10:14:49 (787442): Guest Log: [INFO] Shutting Down. 2025-01-19 10:14:49 (787442): VM Completion File Detected. 2025-01-19 10:14:49 (787442): VM Completion Message: Job Finished . 2025-01-19 10:14:49 (787442): Powering off VM. 2025-01-19 10:14:49 (787442): Successfully stopped VM. 2025-01-19 10:14:49 (787442): Deregistering VM. (boinc_ed8ea6e5b7682369, slot#3) 2025-01-19 10:14:49 (787442): Removing network bandwidth throttle group from VM. 2025-01-19 10:14:50 (787442): Removing VM from VirtualBox. 2025-01-19 10:14:55 (787442): called boinc_finish(0) </stderr_txt> ]]>
©2025 CERN