Name | Theory_2743-2696567-292_0 |
Workunit | 223886002 |
Created | 3 Jul 2024, 14:43:04 UTC |
Sent | 3 Jul 2024, 16:32:24 UTC |
Report deadline | 14 Jul 2024, 16:32:24 UTC |
Received | 4 Jul 2024, 21:29:39 UTC |
Server state | Over |
Outcome | Success |
Client state | Done |
Exit status | 0 (0x00000000) |
Computer ID | 10677116 |
Run time | 24 min 16 sec |
CPU time | 13 min 35 sec |
Validate state | Valid |
Credit | 18.56 |
Device peak FLOPS | 5.50 GFLOPS |
Application version | Theory Simulation v300.30 (vbox64_theory) windows_x86_64 |
Peak working set size | 83.45 MB |
Peak swap size | 75.46 MB |
Peak disk usage | 1.23 GB |
<core_client_version>7.24.1</core_client_version> <![CDATA[ <stderr_txt> 2024-07-03 18:55:19 (23812): vboxwrapper version 26207 2024-07-03 18:55:19 (23812): BOINC client version: 7.24.1 2024-07-03 18:55:19 (23812): Detected: VirtualBox VboxManage Interface (Version: 7.0.6) 2024-07-03 18:55:20 (23812): Detected: Heartbeat check (file: 'heartbeat' every 1200.000000 seconds) 2024-07-03 18:55:20 (23812): Successfully copied 'init_data.xml' to the shared directory. 2024-07-03 18:55:20 (23812): Successfully copied 'input' to the shared directory. 2024-07-03 18:55:20 (23812): Create VM. (boinc_0f5eced0e9f713ab, slot#11) 2024-07-03 18:55:21 (23812): Setting Memory Size for VM. (630MB) 2024-07-03 18:55:21 (23812): Setting CPU Count for VM. (1) 2024-07-03 18:55:22 (23812): Setting Chipset Options for VM. 2024-07-03 18:55:22 (23812): Setting Graphics Controller Options for VM. 2024-07-03 18:55:22 (23812): Setting Boot Options for VM. 2024-07-03 18:55:23 (23812): Setting Network Configuration for NAT. 2024-07-03 18:55:23 (23812): Enabling VM Network Access. 2024-07-03 18:55:23 (23812): Disabling USB Support for VM. 2024-07-03 18:55:24 (23812): Disabling COM Port Support for VM. 2024-07-03 18:55:24 (23812): Disabling LPT Port Support for VM. 2024-07-03 18:55:24 (23812): Disabling Audio Support for VM. 2024-07-03 18:55:25 (23812): Disabling Clipboard Support for VM. 2024-07-03 18:55:25 (23812): Disabling Drag and Drop Support for VM. 2024-07-03 18:55:25 (23812): Adding storage controller(s) to VM. 2024-07-03 18:55:25 (23812): Adding virtual disk drive to VM. (Theory_2024_04_30_prod.vdi) 2024-07-03 18:55:26 (23812): Adding VirtualBox Guest Additions to VM. 2024-07-03 18:55:26 (23812): Adding network bandwidth throttle group to VM. (Defaulting to 1024GB) 2024-07-03 18:55:27 (23812): forwarding host port 62131 to guest port 80 2024-07-03 18:55:27 (23812): Enabling remote desktop for VM. 2024-07-03 18:55:27 (23812): Required extension pack not installed, remote desktop not enabled. 2024-07-03 18:55:27 (23812): Enabling shared directory for VM. 2024-07-03 18:55:28 (23812): Starting VM using VBoxManage interface. (boinc_0f5eced0e9f713ab, slot#11) 2024-07-03 18:55:34 (23812): Successfully started VM. (PID = '38468') 2024-07-03 18:55:34 (23812): Reporting VM Process ID to BOINC. 2024-07-03 18:55:34 (23812): Guest Log: BIOS: VirtualBox 7.0.6 2024-07-03 18:55:34 (23812): Guest Log: CPUID EDX: 0x178bfbff 2024-07-03 18:55:34 (23812): Guest Log: BIOS: No PCI IDE controller, not probing IDE 2024-07-03 18:55:34 (23812): Guest Log: BIOS: AHCI 0-P#0: PCHS=16383/16/63 LCHS=1024/255/63 0x0000000002800000 sectors 2024-07-03 18:55:34 (23812): VM state change detected. (old = 'poweredoff', new = 'running') 2024-07-03 18:55:34 (23812): Detected: Web Application Enabled (http://localhost:62131) 2024-07-03 18:55:35 (23812): VM state change detected. (old = 'running', new = 'paused') 2024-07-03 18:55:49 (23812): Preference change detected 2024-07-03 18:55:49 (23812): Setting CPU throttle for VM. (100%) 2024-07-03 18:55:50 (23812): Setting checkpoint interval to 600 seconds. (Higher value of (Preference: 60 seconds) or (Vbox_job.xml: 600 seconds)) 2024-07-03 18:55:50 (23812): VM state change detected. (old = 'paused', new = 'running') 2024-07-03 18:55:51 (23812): Guest Log: BIOS: Boot : bseqnr=1, bootseq=0032 2024-07-03 18:55:51 (23812): Guest Log: BIOS: Booting from Hard Disk... 2024-07-03 18:55:54 (23812): Guest Log: BIOS: KBD: unsupported int 16h function 03 2024-07-03 18:55:54 (23812): Guest Log: BIOS: AX=0305 BX=0000 CX=0000 DX=0000 2024-07-03 18:56:00 (23812): VM state change detected. (old = 'running', new = 'paused') 2024-07-03 18:56:08 (23812): Stopping VM. 2024-07-03 18:56:10 (23812): Successfully stopped VM. 2024-07-03 22:26:17 (18612): vboxwrapper version 26207 2024-07-03 22:26:17 (18612): BOINC client version: 7.24.1 2024-07-03 22:26:18 (18612): Detected: VirtualBox VboxManage Interface (Version: 7.0.6) 2024-07-03 22:26:18 (18612): Detected: Heartbeat check (file: 'heartbeat' every 1200.000000 seconds) 2024-07-03 22:26:19 (18612): Guest Log: BIOS: VirtualBox 7.0.6 2024-07-03 22:26:19 (18612): Guest Log: CPUID EDX: 0x178bfbff 2024-07-03 22:26:19 (18612): Guest Log: BIOS: No PCI IDE controller, not probing IDE 2024-07-03 22:26:19 (18612): Guest Log: BIOS: AHCI 0-P#0: PCHS=16383/16/63 LCHS=1024/255/63 0x0000000002800000 sectors 2024-07-03 22:26:19 (18612): Guest Log: BIOS: Boot : bseqnr=1, bootseq=0032 2024-07-03 22:26:19 (18612): Guest Log: BIOS: Booting from Hard Disk... 2024-07-03 22:26:19 (18612): Guest Log: BIOS: KBD: unsupported int 16h function 03 2024-07-03 22:26:19 (18612): Guest Log: BIOS: AX=0305 BX=0000 CX=0000 DX=0000 2024-07-03 22:26:19 (18612): Starting VM using VBoxManage interface. (boinc_0f5eced0e9f713ab, slot#11) 2024-07-03 22:26:28 (18612): Successfully started VM. (PID = '12440') 2024-07-03 22:26:28 (18612): Reporting VM Process ID to BOINC. 2024-07-03 22:26:28 (18612): VM state change detected. (old = 'poweredoff', new = 'running') 2024-07-03 22:26:28 (18612): Detected: Web Application Enabled (http://localhost:62131) 2024-07-03 22:26:29 (18612): VM state change detected. (old = 'running', new = 'paused') 2024-07-03 22:26:48 (18612): Preference change detected 2024-07-03 22:26:48 (18612): Setting CPU throttle for VM. (100%) 2024-07-03 22:26:49 (18612): Setting checkpoint interval to 600 seconds. (Higher value of (Preference: 60 seconds) or (Vbox_job.xml: 600 seconds)) 2024-07-03 22:26:49 (18612): VM state change detected. (old = 'paused', new = 'running') 2024-07-03 22:26:59 (18612): VM state change detected. (old = 'running', new = 'paused') 2024-07-03 22:27:19 (18612): VM state change detected. (old = 'paused', new = 'running') 2024-07-03 22:27:20 (18612): Guest Log: vgdrvHeartbeatInit: Setting up heartbeat to trigger every 2000 milliseconds 2024-07-03 22:27:20 (18612): Guest Log: vboxguest: misc device minor 56, IRQ 20, I/O port d020, MMIO at 00000000f0400000 (size 0x400000) 2024-07-03 22:27:24 (18612): Guest Log: VBoxService 5.2.6 r120293 (verbosity: 0) linux.amd64 (Jan 15 2018 14:51:00) release log 2024-07-03 22:27:24 (18612): Guest Log: 00:00:00.000072 main Log opened 2024-07-03T20:27:04.491282000Z 2024-07-03 22:27:24 (18612): Guest Log: 00:00:00.000158 main OS Product: Linux 2024-07-03 22:27:24 (18612): Guest Log: 00:00:00.000183 main OS Release: 4.14.76-13.cernvm.x86_64 2024-07-03 22:27:24 (18612): Guest Log: 00:00:00.000202 main OS Version: #1 SMP Tue Oct 16 18:26:15 CEST 2018 2024-07-03 22:27:24 (18612): Guest Log: 00:00:00.000219 main Executable: /usr/sbin/VBoxService 2024-07-03 22:27:24 (18612): Guest Log: 00:00:00.000220 main Process ID: 3219 2024-07-03 22:27:24 (18612): Guest Log: 00:00:00.000220 main Package type: LINUX_64BITS_GENERIC 2024-07-03 22:27:24 (18612): Guest Log: 00:00:00.002185 main 5.2.6 r120293 started. Verbose level = 0 2024-07-03 22:27:29 (18612): VM state change detected. (old = 'running', new = 'paused') 2024-07-03 22:27:49 (18612): VM state change detected. (old = 'paused', new = 'running') 2024-07-03 22:27:59 (18612): VM state change detected. (old = 'running', new = 'paused') 2024-07-03 22:28:18 (18612): VM state change detected. (old = 'paused', new = 'running') 2024-07-03 22:28:29 (18612): VM state change detected. (old = 'running', new = 'paused') 2024-07-03 22:28:49 (18612): VM state change detected. (old = 'paused', new = 'running') 2024-07-03 22:28:59 (18612): VM state change detected. (old = 'running', new = 'paused') 2024-07-03 22:29:19 (18612): VM state change detected. (old = 'paused', new = 'running') 2024-07-03 22:29:21 (18612): Guest Log: 22:27:45 CEST +02:00 2024-07-03: cranky: [INFO] Detected Theory App 2024-07-03 22:29:21 (18612): Guest Log: 22:27:45 CEST +02:00 2024-07-03: cranky: [INFO] Checking CVMFS. 2024-07-03 22:29:22 (18612): Guest Log: Probing /cvmfs/sft.cern.ch... OK 2024-07-03 22:29:22 (18612): 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-07-03 22:29:22 (18612): Guest Log: 2.5.2.0 4094 0 28220 29841 3 1 272460 4096000 0 65024 0 0 n/a 5 7 http://s1unl-cvmfs.openhtc.io/cvmfs/sft.cern.ch DIRECT 1 2024-07-03 22:29:22 (18612): Guest Log: Probing /cvmfs/grid.cern.ch... OK 2024-07-03 22:29:23 (18612): 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-07-03 22:29:23 (18612): Guest Log: 2.5.2.0 4130 0 25472 24457 3 2 272460 4096000 0 65024 0 2 -100 7962 401 http://s1cern-cvmfs.openhtc.io/cvmfs/grid.cern.ch DIRECT 1 2024-07-03 22:29:23 (18612): Guest Log: Probing /cvmfs/cernvm-prod.cern.ch... OK 2024-07-03 22:29:23 (18612): 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-07-03 22:29:23 (18612): Guest Log: 2.5.2.0 4046 0 25208 272 3 1 272460 4096000 0 65024 0 0 n/a 4 11 http://s1cern-cvmfs.openhtc.io/cvmfs/cernvm-prod.cern.ch DIRECT 1 2024-07-03 22:29:24 (18612): Guest Log: Probing /cvmfs/alice.cern.ch... OK 2024-07-03 22:29:24 (18612): 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-07-03 22:29:24 (18612): Guest Log: 2.5.2.0 4069 0 39872 19054 3 1 272460 4096000 0 65024 0 0 n/a 5555 4784 http://s1fnal-cvmfs.openhtc.io/cvmfs/alice.cern.ch DIRECT 1 2024-07-03 22:29:24 (18612): Guest Log: 22:27:48 CEST +02:00 2024-07-03: cranky: [INFO] Checking runc. 2024-07-03 22:29:24 (18612): Guest Log: 22:27:48 CEST +02:00 2024-07-03: cranky: [INFO] Creating the filesystem. 2024-07-03 22:29:24 (18612): Guest Log: 22:27:48 CEST +02:00 2024-07-03: cranky: [INFO] Using /cvmfs/cernvm-prod.cern.ch/cvm4 2024-07-03 22:29:25 (18612): Guest Log: 22:27:48 CEST +02:00 2024-07-03: cranky: [INFO] Updating config.json. 2024-07-03 22:29:25 (18612): Guest Log: 22:27:48 CEST +02:00 2024-07-03: cranky: [INFO] Running Container 'runc'. 2024-07-03 22:29:27 (18612): Guest Log: job: htmld=/shared/html/job 2024-07-03 22:29:28 (18612): Guest Log: job: unpack exitcode=0 2024-07-03 22:29:28 (18612): Guest Log: INFO: activated the work-around for ld: 2024-07-03 22:29:28 (18612): Guest Log: lrwxrwxrwx 1 0 0 15 Jul 3 20:27 /tmp/tmp.g4nC1XhSof/ld -> /usr/bin/ld.bfd 2024-07-03 22:29:29 (18612): Guest Log: 22:27:52 CEST +02:00 2024-07-03: cranky: [INFO] ===> [runRivet] Wed Jul 3 20:27:51 UTC 2024 [boinc ppbar mb-inelastic 630 - - pythia8 8.230 tune-2c 100000 292] 2024-07-03 22:29:29 (18612): VM state change detected. (old = 'running', new = 'paused') 2024-07-03 22:29:49 (18612): VM state change detected. (old = 'paused', new = 'running') 2024-07-03 22:29:59 (18612): VM state change detected. (old = 'running', new = 'paused') 2024-07-03 22:30:19 (18612): VM state change detected. (old = 'paused', new = 'running') 2024-07-03 22:30:29 (18612): VM state change detected. (old = 'running', new = 'paused') 2024-07-03 22:30:49 (18612): VM state change detected. (old = 'paused', new = 'running') 2024-07-03 22:30:59 (18612): VM state change detected. (old = 'running', new = 'paused') 2024-07-03 22:31:19 (18612): VM state change detected. (old = 'paused', new = 'running') 2024-07-03 22:31:29 (18612): VM state change detected. (old = 'running', new = 'paused') 2024-07-03 22:31:49 (18612): VM state change detected. (old = 'paused', new = 'running') 2024-07-03 22:31:59 (18612): VM state change detected. (old = 'running', new = 'paused') 2024-07-03 22:32:19 (18612): VM state change detected. (old = 'paused', new = 'running') 2024-07-03 22:32:29 (18612): VM state change detected. (old = 'running', new = 'paused') 2024-07-03 22:32:49 (18612): VM state change detected. (old = 'paused', new = 'running') 2024-07-03 22:32:59 (18612): VM state change detected. (old = 'running', new = 'paused') 2024-07-03 22:33:19 (18612): VM state change detected. (old = 'paused', new = 'running') 2024-07-03 22:33:29 (18612): VM state change detected. (old = 'running', new = 'paused') 2024-07-03 22:33:49 (18612): VM state change detected. (old = 'paused', new = 'running') 2024-07-03 22:33:59 (18612): VM state change detected. (old = 'running', new = 'paused') 2024-07-03 22:34:19 (18612): VM state change detected. (old = 'paused', new = 'running') 2024-07-03 22:34:29 (18612): VM state change detected. (old = 'running', new = 'paused') 2024-07-03 22:34:49 (18612): VM state change detected. (old = 'paused', new = 'running') 2024-07-03 22:34:59 (18612): VM state change detected. (old = 'running', new = 'paused') 2024-07-03 22:35:19 (18612): VM state change detected. (old = 'paused', new = 'running') 2024-07-03 22:35:29 (18612): VM state change detected. (old = 'running', new = 'paused') 2024-07-03 22:35:49 (18612): VM state change detected. (old = 'paused', new = 'running') 2024-07-03 22:35:59 (18612): VM state change detected. (old = 'running', new = 'paused') 2024-07-03 22:36:19 (18612): VM state change detected. (old = 'paused', new = 'running') 2024-07-03 22:36:29 (18612): VM state change detected. (old = 'running', new = 'paused') 2024-07-03 22:36:49 (18612): VM state change detected. (old = 'paused', new = 'running') 2024-07-03 22:36:59 (18612): VM state change detected. (old = 'running', new = 'paused') 2024-07-03 22:37:19 (18612): VM state change detected. (old = 'paused', new = 'running') 2024-07-03 22:37:30 (18612): VM state change detected. (old = 'running', new = 'paused') 2024-07-03 22:37:50 (18612): VM state change detected. (old = 'paused', new = 'running') 2024-07-03 22:38:00 (18612): VM state change detected. (old = 'running', new = 'paused') 2024-07-03 22:38:20 (18612): VM state change detected. (old = 'paused', new = 'running') 2024-07-03 22:38:30 (18612): VM state change detected. (old = 'running', new = 'paused') 2024-07-03 22:38:50 (18612): VM state change detected. (old = 'paused', new = 'running') 2024-07-03 22:39:00 (18612): VM state change detected. (old = 'running', new = 'paused') 2024-07-03 22:39:20 (18612): VM state change detected. (old = 'paused', new = 'running') 2024-07-03 22:39:30 (18612): VM state change detected. (old = 'running', new = 'paused') 2024-07-03 22:39:50 (18612): VM state change detected. (old = 'paused', new = 'running') 2024-07-03 22:40:00 (18612): VM state change detected. (old = 'running', new = 'paused') 2024-07-03 22:40:20 (18612): VM state change detected. (old = 'paused', new = 'running') 2024-07-03 22:40:30 (18612): VM state change detected. (old = 'running', new = 'paused') 2024-07-03 22:40:50 (18612): VM state change detected. (old = 'paused', new = 'running') 2024-07-03 22:41:00 (18612): VM state change detected. (old = 'running', new = 'paused') 2024-07-03 22:41:20 (18612): VM state change detected. (old = 'paused', new = 'running') 2024-07-03 22:41:30 (18612): VM state change detected. (old = 'running', new = 'paused') 2024-07-03 22:41:50 (18612): VM state change detected. (old = 'paused', new = 'running') 2024-07-03 22:42:00 (18612): VM state change detected. (old = 'running', new = 'paused') 2024-07-03 22:42:20 (18612): VM state change detected. (old = 'paused', new = 'running') 2024-07-03 22:42:31 (18612): VM state change detected. (old = 'running', new = 'paused') 2024-07-03 22:42:50 (18612): VM state change detected. (old = 'paused', new = 'running') 2024-07-03 22:43:01 (18612): VM state change detected. (old = 'running', new = 'paused') 2024-07-03 22:43:20 (18612): VM state change detected. (old = 'paused', new = 'running') 2024-07-03 22:43:31 (18612): VM state change detected. (old = 'running', new = 'paused') 2024-07-03 22:43:51 (18612): VM state change detected. (old = 'paused', new = 'running') 2024-07-03 22:44:01 (18612): VM state change detected. (old = 'running', new = 'paused') 2024-07-03 22:44:21 (18612): VM state change detected. (old = 'paused', new = 'running') 2024-07-03 22:44:31 (18612): VM state change detected. (old = 'running', new = 'paused') 2024-07-03 22:44:51 (18612): VM state change detected. (old = 'paused', new = 'running') 2024-07-03 22:45:01 (18612): VM state change detected. (old = 'running', new = 'paused') 2024-07-03 22:45:21 (18612): VM state change detected. (old = 'paused', new = 'running') 2024-07-03 22:45:31 (18612): VM state change detected. (old = 'running', new = 'paused') 2024-07-03 22:45:51 (18612): VM state change detected. (old = 'paused', new = 'running') 2024-07-03 22:46:01 (18612): VM state change detected. (old = 'running', new = 'paused') 2024-07-03 22:46:21 (18612): VM state change detected. (old = 'paused', new = 'running') 2024-07-03 22:46:31 (18612): VM state change detected. (old = 'running', new = 'paused') 2024-07-03 22:46:51 (18612): VM state change detected. (old = 'paused', new = 'running') 2024-07-03 22:47:01 (18612): VM state change detected. (old = 'running', new = 'paused') 2024-07-03 22:47:03 (18612): Stopping VM. 2024-07-03 22:47:07 (18612): Successfully stopped VM. 2024-07-03 23:58:20 (31720): vboxwrapper version 26207 2024-07-03 23:58:20 (31720): BOINC client version: 7.24.1 2024-07-03 23:58:21 (31720): Detected: VirtualBox VboxManage Interface (Version: 7.0.6) 2024-07-03 23:58:22 (31720): Detected: Heartbeat check (file: 'heartbeat' every 1200.000000 seconds) 2024-07-03 23:58:22 (31720): Guest Log: vgdrvHeartbeatInit: Setting up heartbeat to trigger every 2000 milliseconds 2024-07-03 23:58:22 (31720): Guest Log: vboxguest: misc device minor 56, IRQ 20, I/O port d020, MMIO at 00000000f0400000 (size 0x400000) 2024-07-03 23:58:22 (31720): Guest Log: VBoxService 5.2.6 r120293 (verbosity: 0) linux.amd64 (Jan 15 2018 14:51:00) release log 2024-07-03 23:58:22 (31720): Guest Log: 00:00:00.000072 main Log opened 2024-07-03T20:27:04.491282000Z 2024-07-03 23:58:22 (31720): Guest Log: 00:00:00.000158 main OS Product: Linux 2024-07-03 23:58:22 (31720): Guest Log: 00:00:00.000183 main OS Release: 4.14.76-13.cernvm.x86_64 2024-07-03 23:58:22 (31720): Guest Log: 00:00:00.000202 main OS Version: #1 SMP Tue Oct 16 18:26:15 CEST 2018 2024-07-03 23:58:22 (31720): Guest Log: 00:00:00.000219 main Executable: /usr/sbin/VBoxService 2024-07-03 23:58:22 (31720): Guest Log: 00:00:00.000220 main Process ID: 3219 2024-07-03 23:58:22 (31720): Guest Log: 00:00:00.000220 main Package type: LINUX_64BITS_GENERIC 2024-07-03 23:58:22 (31720): Guest Log: 00:00:00.002185 main 5.2.6 r120293 started. Verbose level = 0 2024-07-03 23:58:22 (31720): Guest Log: 22:27:45 CEST +02:00 2024-07-03: cranky: [INFO] Detected Theory App 2024-07-03 23:58:22 (31720): Guest Log: 22:27:45 CEST +02:00 2024-07-03: cranky: [INFO] Checking CVMFS. 2024-07-03 23:58:22 (31720): Guest Log: Probing /cvmfs/sft.cern.ch... OK 2024-07-03 23:58:22 (31720): 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-07-03 23:58:22 (31720): Guest Log: 2.5.2.0 4094 0 28220 29841 3 1 272460 4096000 0 65024 0 0 n/a 5 7 http://s1unl-cvmfs.openhtc.io/cvmfs/sft.cern.ch DIRECT 1 2024-07-03 23:58:22 (31720): Guest Log: Probing /cvmfs/grid.cern.ch... OK 2024-07-03 23:58:22 (31720): 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-07-03 23:58:22 (31720): Guest Log: 2.5.2.0 4130 0 25472 24457 3 2 272460 4096000 0 65024 0 2 -100 7962 401 http://s1cern-cvmfs.openhtc.io/cvmfs/grid.cern.ch DIRECT 1 2024-07-03 23:58:22 (31720): Guest Log: Probing /cvmfs/cernvm-prod.cern.ch... OK 2024-07-03 23:58:22 (31720): 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-07-03 23:58:22 (31720): Guest Log: 2.5.2.0 4046 0 25208 272 3 1 272460 4096000 0 65024 0 0 n/a 4 11 http://s1cern-cvmfs.openhtc.io/cvmfs/cernvm-prod.cern.ch DIRECT 1 2024-07-03 23:58:22 (31720): Guest Log: Probing /cvmfs/alice.cern.ch... OK 2024-07-03 23:58:22 (31720): 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-07-03 23:58:22 (31720): Guest Log: 2.5.2.0 4069 0 39872 19054 3 1 272460 4096000 0 65024 0 0 n/a 5555 4784 http://s1fnal-cvmfs.openhtc.io/cvmfs/alice.cern.ch DIRECT 1 2024-07-03 23:58:22 (31720): Guest Log: 22:27:48 CEST +02:00 2024-07-03: cranky: [INFO] Checking runc. 2024-07-03 23:58:22 (31720): Guest Log: 22:27:48 CEST +02:00 2024-07-03: cranky: [INFO] Creating the filesystem. 2024-07-03 23:58:22 (31720): Guest Log: 22:27:48 CEST +02:00 2024-07-03: cranky: [INFO] Using /cvmfs/cernvm-prod.cern.ch/cvm4 2024-07-03 23:58:22 (31720): Guest Log: 22:27:48 CEST +02:00 2024-07-03: cranky: [INFO] Updating config.json. 2024-07-03 23:58:22 (31720): Guest Log: 22:27:48 CEST +02:00 2024-07-03: cranky: [INFO] Running Container 'runc'. 2024-07-03 23:58:22 (31720): Guest Log: job: htmld=/shared/html/job 2024-07-03 23:58:22 (31720): Guest Log: job: unpack exitcode=0 2024-07-03 23:58:22 (31720): Guest Log: INFO: activated the work-around for ld: 2024-07-03 23:58:22 (31720): Guest Log: lrwxrwxrwx 1 0 0 15 Jul 3 20:27 /tmp/tmp.g4nC1XhSof/ld -> /usr/bin/ld.bfd 2024-07-03 23:58:22 (31720): Guest Log: 22:27:52 CEST +02:00 2024-07-03: cranky: [INFO] ===> [runRivet] Wed Jul 3 20:27:51 UTC 2024 [boinc ppbar mb-inelastic 630 - - pythia8 8.230 tune-2c 100000 292] 2024-07-03 23:58:22 (31720): Starting VM using VBoxManage interface. (boinc_0f5eced0e9f713ab, slot#11) 2024-07-03 23:58:33 (31720): Successfully started VM. (PID = '27032') 2024-07-03 23:58:33 (31720): Reporting VM Process ID to BOINC. 2024-07-03 23:58:33 (31720): VM state change detected. (old = 'poweredoff', new = 'running') 2024-07-03 23:58:33 (31720): Detected: Web Application Enabled (http://localhost:62131) 2024-07-03 23:58:34 (31720): VM state change detected. (old = 'running', new = 'paused') 2024-07-03 23:58:51 (31720): Preference change detected 2024-07-03 23:58:51 (31720): Setting CPU throttle for VM. (100%) 2024-07-03 23:58:52 (31720): Setting checkpoint interval to 600 seconds. (Higher value of (Preference: 60 seconds) or (Vbox_job.xml: 600 seconds)) 2024-07-03 23:58:52 (31720): VM state change detected. (old = 'paused', new = 'running') 2024-07-03 23:59:00 (31720): Guest Log: 00:07:00.297935 timesync vgsvcTimeSyncWorker: Radical host time change: 4 319 590 000 000ns (HostNow=1 720 043 939 707 000 000 ns HostLast=1 720 039 620 117 000 000 ns) 2024-07-03 23:59:02 (31720): VM state change detected. (old = 'running', new = 'paused') 2024-07-03 23:59:22 (31720): VM state change detected. (old = 'paused', new = 'running') 2024-07-03 23:59:29 (31720): Guest Log: 00:07:10.322684 timesync vgsvcTimeSyncWorker: Radical guest time change: 5 105 022 711 000ns (GuestNow=1 720 043 949 751 554 000 ns GuestLast=1 720 038 844 728 843 000 ns fSetTimeLastLoop=true ) 2024-07-03 23:59:32 (31720): VM state change detected. (old = 'running', new = 'paused') 2024-07-03 23:59:52 (31720): VM state change detected. (old = 'paused', new = 'running') 2024-07-04 00:00:02 (31720): VM state change detected. (old = 'running', new = 'paused') 2024-07-04 00:00:22 (31720): VM state change detected. (old = 'paused', new = 'running') 2024-07-04 00:00:32 (31720): VM state change detected. (old = 'running', new = 'paused') 2024-07-04 00:00:52 (31720): VM state change detected. (old = 'paused', new = 'running') 2024-07-04 00:01:02 (31720): VM state change detected. (old = 'running', new = 'paused') 2024-07-04 00:01:22 (31720): VM state change detected. (old = 'paused', new = 'running') 2024-07-04 00:01:32 (31720): VM state change detected. (old = 'running', new = 'paused') 2024-07-04 00:01:52 (31720): VM state change detected. (old = 'paused', new = 'running') 2024-07-04 00:02:02 (31720): VM state change detected. (old = 'running', new = 'paused') 2024-07-04 00:02:22 (31720): VM state change detected. (old = 'paused', new = 'running') 2024-07-04 00:02:32 (31720): VM state change detected. (old = 'running', new = 'paused') 2024-07-04 00:02:52 (31720): VM state change detected. (old = 'paused', new = 'running') 2024-07-04 00:03:04 (31720): VM state change detected. (old = 'running', new = 'paused') 2024-07-04 00:03:23 (31720): VM state change detected. (old = 'paused', new = 'running') 2024-07-04 00:03:34 (31720): VM state change detected. (old = 'running', new = 'paused') 2024-07-04 00:03:52 (31720): VM state change detected. (old = 'paused', new = 'running') 2024-07-04 00:04:04 (31720): VM state change detected. (old = 'running', new = 'paused') 2024-07-04 00:04:23 (31720): VM state change detected. (old = 'paused', new = 'running') 2024-07-04 00:04:34 (31720): VM state change detected. (old = 'running', new = 'paused') 2024-07-04 00:04:53 (31720): VM state change detected. (old = 'paused', new = 'running') 2024-07-04 00:05:03 (31720): VM state change detected. (old = 'running', new = 'paused') 2024-07-04 00:05:23 (31720): VM state change detected. (old = 'paused', new = 'running') 2024-07-04 00:05:33 (31720): VM state change detected. (old = 'running', new = 'paused') 2024-07-04 00:05:53 (31720): VM state change detected. (old = 'paused', new = 'running') 2024-07-04 00:06:03 (31720): VM state change detected. (old = 'running', new = 'paused') 2024-07-04 00:06:23 (31720): VM state change detected. (old = 'paused', new = 'running') 2024-07-04 00:06:34 (31720): VM state change detected. (old = 'running', new = 'paused') 2024-07-04 00:06:53 (31720): VM state change detected. (old = 'paused', new = 'running') 2024-07-04 00:07:04 (31720): VM state change detected. (old = 'running', new = 'paused') 2024-07-04 00:07:23 (31720): VM state change detected. (old = 'paused', new = 'running') 2024-07-04 00:07:34 (31720): VM state change detected. (old = 'running', new = 'paused') 2024-07-04 00:07:53 (31720): VM state change detected. (old = 'paused', new = 'running') 2024-07-04 00:08:04 (31720): VM state change detected. (old = 'running', new = 'paused') 2024-07-04 00:08:23 (31720): VM state change detected. (old = 'paused', new = 'running') 2024-07-04 00:08:36 (31720): VM state change detected. (old = 'running', new = 'paused') 2024-07-04 00:08:54 (31720): VM state change detected. (old = 'paused', new = 'running') 2024-07-04 00:09:05 (31720): VM state change detected. (old = 'running', new = 'paused') 2024-07-04 00:09:24 (31720): VM state change detected. (old = 'paused', new = 'running') 2024-07-04 00:09:36 (31720): VM state change detected. (old = 'running', new = 'paused') 2024-07-04 00:09:54 (31720): VM state change detected. (old = 'paused', new = 'running') 2024-07-04 00:10:05 (31720): VM state change detected. (old = 'running', new = 'paused') 2024-07-04 00:10:24 (31720): VM state change detected. (old = 'paused', new = 'running') 2024-07-04 00:10:35 (31720): VM state change detected. (old = 'running', new = 'paused') 2024-07-04 00:10:54 (31720): VM state change detected. (old = 'paused', new = 'running') 2024-07-04 00:11:05 (31720): VM state change detected. (old = 'running', new = 'paused') 2024-07-04 00:11:24 (31720): VM state change detected. (old = 'paused', new = 'running') 2024-07-04 00:12:27 (31720): VM state change detected. (old = 'running', new = 'paused') 2024-07-04 00:12:54 (31720): VM state change detected. (old = 'paused', new = 'running') 2024-07-04 00:13:43 (31720): VM state change detected. (old = 'running', new = 'paused') 2024-07-04 00:13:47 (31720): Stopping VM. 2024-07-04 00:13:53 (31720): Error in stop VM for VM: -108 Command: VBoxManage -q controlvm "boinc_0f5eced0e9f713ab" savestate Output: 0%...10%...20%...30%...40%...50%...60%...70%...80%... 2024-07-04 00:13:53 (31720): VM did not stop when requested. 2024-07-04 00:13:53 (31720): VM was NOT successfully terminated. 2024-07-04 16:25:06 (36932): vboxwrapper version 26207 2024-07-04 16:25:06 (36932): BOINC client version: 7.24.1 2024-07-04 16:25:07 (36932): Detected: VirtualBox VboxManage Interface (Version: 7.0.6) 2024-07-04 16:25:07 (36932): Detected: Heartbeat check (file: 'heartbeat' every 1200.000000 seconds) 2024-07-04 16:25:09 (36932): Guest Log: 00:07:00.297935 timesync vgsvcTimeSyncWorker: Radical host time change: 4 319 590 000 000ns (HostNow=1 720 043 939 707 000 000 ns HostLast=1 720 039 620 117 000 000 ns) 2024-07-04 16:25:09 (36932): Guest Log: 00:07:10.322684 timesync vgsvcTimeSyncWorker: Radical guest time change: 5 105 022 711 000ns (GuestNow=1 720 043 949 751 554 000 ns GuestLast=1 720 038 844 728 843 000 ns fSetTimeLastLoop=true ) 2024-07-04 16:25:09 (36932): Starting VM using VBoxManage interface. (boinc_0f5eced0e9f713ab, slot#11) 2024-07-04 16:25:22 (36932): Successfully started VM. (PID = '27028') 2024-07-04 16:25:22 (36932): Reporting VM Process ID to BOINC. 2024-07-04 16:25:22 (36932): Guest Log: BIOS: VirtualBox 7.0.6 2024-07-04 16:25:22 (36932): Guest Log: CPUID EDX: 0x178bfbff 2024-07-04 16:25:22 (36932): Guest Log: BIOS: No PCI IDE controller, not probing IDE 2024-07-04 16:25:22 (36932): Guest Log: BIOS: AHCI 0-P#0: PCHS=16383/16/63 LCHS=1024/255/63 0x0000000002800000 sectors 2024-07-04 16:25:22 (36932): VM state change detected. (old = 'poweredoff', new = 'running') 2024-07-04 16:25:22 (36932): Detected: Web Application Enabled (http://localhost:62131) 2024-07-04 16:25:23 (36932): VM state change detected. (old = 'running', new = 'paused') 2024-07-04 16:25:56 (36932): Preference change detected 2024-07-04 16:25:56 (36932): Setting CPU throttle for VM. (100%) 2024-07-04 16:25:57 (36932): Setting checkpoint interval to 600 seconds. (Higher value of (Preference: 60 seconds) or (Vbox_job.xml: 600 seconds)) 2024-07-04 16:25:57 (36932): Guest Log: BIOS: Boot : bseqnr=1, bootseq=0032 2024-07-04 16:25:57 (36932): Guest Log: BIOS: Booting from Hard Disk... 2024-07-04 16:25:57 (36932): VM state change detected. (old = 'paused', new = 'running') 2024-07-04 16:26:00 (36932): Guest Log: BIOS: KBD: unsupported int 16h function 03 2024-07-04 16:26:00 (36932): Guest Log: BIOS: AX=0305 BX=0000 CX=0000 DX=0000 2024-07-04 16:26:07 (36932): VM state change detected. (old = 'running', new = 'paused') 2024-07-04 16:26:27 (36932): VM state change detected. (old = 'paused', new = 'running') 2024-07-04 16:26:37 (36932): VM state change detected. (old = 'running', new = 'paused') 2024-07-04 16:26:57 (36932): VM state change detected. (old = 'paused', new = 'running') 2024-07-04 16:27:05 (36932): Guest Log: vgdrvHeartbeatInit: Setting up heartbeat to trigger every 2000 milliseconds 2024-07-04 16:27:05 (36932): Guest Log: vboxguest: misc device minor 56, IRQ 20, I/O port d020, MMIO at 00000000f0400000 (size 0x400000) 2024-07-04 16:27:09 (36932): Guest Log: VBoxService 5.2.6 r120293 (verbosity: 0) linux.amd64 (Jan 15 2018 14:51:00) release log 2024-07-04 16:27:09 (36932): Guest Log: 00:00:00.000126 main Log opened 2024-07-04T14:27:11.072039000Z 2024-07-04 16:27:09 (36932): Guest Log: 00:00:00.000289 main OS Product: Linux 2024-07-04 16:27:09 (36932): Guest Log: 00:00:00.000334 main OS Release: 4.14.76-13.cernvm.x86_64 2024-07-04 16:27:09 (36932): Guest Log: 00:00:00.000362 main OS Version: #1 SMP Tue Oct 16 18:26:15 CEST 2018 2024-07-04 16:27:09 (36932): Guest Log: 00:00:00.000404 main Executable: /usr/sbin/VBoxService 2024-07-04 16:27:09 (36932): Guest Log: 00:00:00.000404 main Process ID: 3209 2024-07-04 16:27:09 (36932): Guest Log: 00:00:00.000405 main Package type: LINUX_64BITS_GENERIC 2024-07-04 16:27:09 (36932): Guest Log: 00:00:00.005735 main 5.2.6 r120293 started. Verbose level = 0 2024-07-04 16:27:09 (36932): VM state change detected. (old = 'running', new = 'paused') 2024-07-04 16:27:28 (36932): VM state change detected. (old = 'paused', new = 'running') 2024-07-04 16:27:38 (36932): VM state change detected. (old = 'running', new = 'paused') 2024-07-04 16:27:58 (36932): VM state change detected. (old = 'paused', new = 'running') 2024-07-04 16:28:07 (36932): Guest Log: 16:27:32 CEST +02:00 2024-07-04: cranky: [INFO] Detected Theory App 2024-07-04 16:28:07 (36932): Guest Log: 16:27:32 CEST +02:00 2024-07-04: cranky: [INFO] Checking CVMFS. 2024-07-04 16:28:09 (36932): Guest Log: Probing /cvmfs/sft.cern.ch... OK 2024-07-04 16:28:09 (36932): 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-07-04 16:28:09 (36932): Guest Log: 2.5.2.0 4102 0 27164 29848 3 1 1101792 4096000 0 65024 0 0 n/a 5 18 http://s1cern-cvmfs.openhtc.io/cvmfs/sft.cern.ch DIRECT 1 2024-07-04 16:28:09 (36932): VM state change detected. (old = 'running', new = 'paused') 2024-07-04 16:28:47 (36932): Guest Log: Probing /cvmfs/grid.cern.ch... OK 2024-07-04 16:28:47 (36932): 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-07-04 16:28:47 (36932): Guest Log: 2.5.2.0 4034 0 27588 24631 3 2 1101792 4096000 0 65024 0 2 0 5818 4404 http://s1bnl-cvmfs.openhtc.io/cvmfs/grid.cern.ch DIRECT 1 2024-07-04 16:28:47 (36932): VM state change detected. (old = 'paused', new = 'running') 2024-07-04 16:28:48 (36932): Guest Log: Probing /cvmfs/cernvm-prod.cern.ch... OK 2024-07-04 16:28:48 (36932): 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-07-04 16:28:48 (36932): Guest Log: 2.5.2.0 4081 0 27216 272 3 1 1101792 4096000 0 65024 0 0 n/a 0 0 http://s1cern-cvmfs.openhtc.io/cvmfs/cernvm-prod.cern.ch DIRECT 1 2024-07-04 16:28:49 (36932): Guest Log: Probing /cvmfs/alice.cern.ch... OK 2024-07-04 16:28:49 (36932): 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-07-04 16:28:49 (36932): Guest Log: 2.5.2.0 4056 0 39748 19062 3 1 1101792 4096000 0 65024 0 0 n/a 5563 2230 http://s1unl-cvmfs.openhtc.io/cvmfs/alice.cern.ch DIRECT 1 2024-07-04 16:28:49 (36932): Guest Log: 16:27:36 CEST +02:00 2024-07-04: cranky: [INFO] Checking runc. 2024-07-04 16:28:49 (36932): Guest Log: 16:27:36 CEST +02:00 2024-07-04: cranky: [INFO] Creating the filesystem. 2024-07-04 16:28:49 (36932): Guest Log: 16:27:36 CEST +02:00 2024-07-04: cranky: [INFO] Using /cvmfs/cernvm-prod.cern.ch/cvm4 2024-07-04 16:28:49 (36932): Guest Log: 16:27:36 CEST +02:00 2024-07-04: cranky: [INFO] Updating config.json. 2024-07-04 16:28:50 (36932): Guest Log: 16:27:36 CEST +02:00 2024-07-04: cranky: [INFO] Running Container 'runc'. 2024-07-04 16:28:50 (36932): Guest Log: job: htmld=/shared/html/job 2024-07-04 16:28:50 (36932): Guest Log: job: unpack exitcode=0 2024-07-04 16:28:50 (36932): Guest Log: INFO: activated the work-around for ld: 2024-07-04 16:28:50 (36932): Guest Log: lrwxrwxrwx 1 0 0 15 Jul 4 14:27 /tmp/tmp.FgWakQnDab/ld -> /usr/bin/ld.bfd 2024-07-04 16:28:52 (36932): Guest Log: 16:27:38 CEST +02:00 2024-07-04: cranky: [INFO] ===> [runRivet] Thu Jul 4 14:27:37 UTC 2024 [boinc ppbar mb-inelastic 630 - - pythia8 8.230 tune-2c 100000 292] 2024-07-04 16:28:57 (36932): VM state change detected. (old = 'running', new = 'paused') 2024-07-04 16:29:17 (36932): VM state change detected. (old = 'paused', new = 'running') 2024-07-04 16:29:28 (36932): VM state change detected. (old = 'running', new = 'paused') 2024-07-04 16:29:48 (36932): VM state change detected. (old = 'paused', new = 'running') 2024-07-04 16:29:58 (36932): VM state change detected. (old = 'running', new = 'paused') 2024-07-04 16:30:18 (36932): VM state change detected. (old = 'paused', new = 'running') 2024-07-04 16:30:28 (36932): VM state change detected. (old = 'running', new = 'paused') 2024-07-04 16:30:48 (36932): VM state change detected. (old = 'paused', new = 'running') 2024-07-04 16:30:58 (36932): VM state change detected. (old = 'running', new = 'paused') 2024-07-04 16:31:18 (36932): VM state change detected. (old = 'paused', new = 'running') 2024-07-04 16:31:29 (36932): VM state change detected. (old = 'running', new = 'paused') 2024-07-04 16:31:48 (36932): VM state change detected. (old = 'paused', new = 'running') 2024-07-04 16:31:58 (36932): VM state change detected. (old = 'running', new = 'paused') 2024-07-04 16:32:18 (36932): VM state change detected. (old = 'paused', new = 'running') 2024-07-04 16:32:28 (36932): VM state change detected. (old = 'running', new = 'paused') 2024-07-04 16:32:48 (36932): VM state change detected. (old = 'paused', new = 'running') 2024-07-04 16:32:58 (36932): VM state change detected. (old = 'running', new = 'paused') 2024-07-04 16:33:18 (36932): VM state change detected. (old = 'paused', new = 'running') 2024-07-04 16:33:28 (36932): VM state change detected. (old = 'running', new = 'paused') 2024-07-04 16:33:48 (36932): VM state change detected. (old = 'paused', new = 'running') 2024-07-04 16:33:58 (36932): VM state change detected. (old = 'running', new = 'paused') 2024-07-04 16:34:18 (36932): VM state change detected. (old = 'paused', new = 'running') 2024-07-04 16:34:28 (36932): VM state change detected. (old = 'running', new = 'paused') 2024-07-04 16:34:48 (36932): VM state change detected. (old = 'paused', new = 'running') 2024-07-04 16:34:58 (36932): VM state change detected. (old = 'running', new = 'paused') 2024-07-04 16:35:18 (36932): VM state change detected. (old = 'paused', new = 'running') 2024-07-04 16:35:28 (36932): VM state change detected. (old = 'running', new = 'paused') 2024-07-04 16:35:48 (36932): VM state change detected. (old = 'paused', new = 'running') 2024-07-04 16:35:58 (36932): VM state change detected. (old = 'running', new = 'paused') 2024-07-04 16:36:18 (36932): VM state change detected. (old = 'paused', new = 'running') 2024-07-04 16:36:28 (36932): VM state change detected. (old = 'running', new = 'paused') 2024-07-04 16:36:48 (36932): VM state change detected. (old = 'paused', new = 'running') 2024-07-04 16:36:58 (36932): VM state change detected. (old = 'running', new = 'paused') 2024-07-04 16:37:18 (36932): VM state change detected. (old = 'paused', new = 'running') 2024-07-04 16:37:28 (36932): VM state change detected. (old = 'running', new = 'paused') 2024-07-04 16:37:48 (36932): VM state change detected. (old = 'paused', new = 'running') 2024-07-04 16:37:59 (36932): VM state change detected. (old = 'running', new = 'paused') 2024-07-04 16:38:19 (36932): VM state change detected. (old = 'paused', new = 'running') 2024-07-04 16:38:29 (36932): VM state change detected. (old = 'running', new = 'paused') 2024-07-04 16:38:49 (36932): VM state change detected. (old = 'paused', new = 'running') 2024-07-04 16:38:59 (36932): VM state change detected. (old = 'running', new = 'paused') 2024-07-04 16:39:19 (36932): VM state change detected. (old = 'paused', new = 'running') 2024-07-04 16:39:29 (36932): VM state change detected. (old = 'running', new = 'paused') 2024-07-04 16:39:49 (36932): VM state change detected. (old = 'paused', new = 'running') 2024-07-04 16:39:59 (36932): VM state change detected. (old = 'running', new = 'paused') 2024-07-04 16:40:19 (36932): VM state change detected. (old = 'paused', new = 'running') 2024-07-04 16:40:29 (36932): VM state change detected. (old = 'running', new = 'paused') 2024-07-04 16:40:49 (36932): VM state change detected. (old = 'paused', new = 'running') 2024-07-04 16:40:59 (36932): VM state change detected. (old = 'running', new = 'paused') 2024-07-04 16:41:19 (36932): VM state change detected. (old = 'paused', new = 'running') 2024-07-04 16:41:29 (36932): VM state change detected. (old = 'running', new = 'paused') 2024-07-04 16:41:49 (36932): VM state change detected. (old = 'paused', new = 'running') 2024-07-04 16:41:59 (36932): VM state change detected. (old = 'running', new = 'paused') 2024-07-04 16:42:19 (36932): VM state change detected. (old = 'paused', new = 'running') 2024-07-04 16:42:29 (36932): VM state change detected. (old = 'running', new = 'paused') 2024-07-04 16:42:49 (36932): VM state change detected. (old = 'paused', new = 'running') 2024-07-04 16:42:59 (36932): VM state change detected. (old = 'running', new = 'paused') 2024-07-04 16:43:19 (36932): VM state change detected. (old = 'paused', new = 'running') 2024-07-04 16:43:29 (36932): VM state change detected. (old = 'running', new = 'paused') 2024-07-04 16:43:49 (36932): VM state change detected. (old = 'paused', new = 'running') 2024-07-04 16:43:59 (36932): VM state change detected. (old = 'running', new = 'paused') 2024-07-04 16:44:19 (36932): VM state change detected. (old = 'paused', new = 'running') 2024-07-04 16:44:29 (36932): VM state change detected. (old = 'running', new = 'paused') 2024-07-04 16:44:49 (36932): VM state change detected. (old = 'paused', new = 'running') 2024-07-04 16:44:59 (36932): VM state change detected. (old = 'running', new = 'paused') 2024-07-04 16:45:19 (36932): VM state change detected. (old = 'paused', new = 'running') 2024-07-04 16:45:30 (36932): VM state change detected. (old = 'running', new = 'paused') 2024-07-04 16:45:49 (36932): VM state change detected. (old = 'paused', new = 'running') 2024-07-04 16:45:59 (36932): VM state change detected. (old = 'running', new = 'paused') 2024-07-04 16:46:19 (36932): VM state change detected. (old = 'paused', new = 'running') 2024-07-04 16:46:29 (36932): VM state change detected. (old = 'running', new = 'paused') 2024-07-04 16:46:49 (36932): VM state change detected. (old = 'paused', new = 'running') 2024-07-04 16:47:00 (36932): VM state change detected. (old = 'running', new = 'paused') 2024-07-04 16:47:20 (36932): VM state change detected. (old = 'paused', new = 'running') 2024-07-04 16:47:31 (36932): VM state change detected. (old = 'running', new = 'paused') 2024-07-04 16:47:45 (36932): Stopping VM. 2024-07-04 16:47:51 (36932): Successfully stopped VM. 2024-07-04 21:12:51 (27328): vboxwrapper version 26207 2024-07-04 21:12:51 (27328): BOINC client version: 7.24.1 2024-07-04 21:12:52 (27328): Detected: VirtualBox VboxManage Interface (Version: 7.0.6) 2024-07-04 21:12:52 (27328): Detected: Heartbeat check (file: 'heartbeat' every 1200.000000 seconds) 2024-07-04 21:12:53 (27328): Guest Log: BIOS: VirtualBox 7.0.6 2024-07-04 21:12:53 (27328): Guest Log: CPUID EDX: 0x178bfbff 2024-07-04 21:12:53 (27328): Guest Log: BIOS: No PCI IDE controller, not probing IDE 2024-07-04 21:12:53 (27328): Guest Log: BIOS: AHCI 0-P#0: PCHS=16383/16/63 LCHS=1024/255/63 0x0000000002800000 sectors 2024-07-04 21:12:53 (27328): Guest Log: BIOS: Boot : bseqnr=1, bootseq=0032 2024-07-04 21:12:53 (27328): Guest Log: BIOS: Booting from Hard Disk... 2024-07-04 21:12:53 (27328): Guest Log: BIOS: KBD: unsupported int 16h function 03 2024-07-04 21:12:53 (27328): Guest Log: BIOS: AX=0305 BX=0000 CX=0000 DX=0000 2024-07-04 21:12:53 (27328): Guest Log: vgdrvHeartbeatInit: Setting up heartbeat to trigger every 2000 milliseconds 2024-07-04 21:12:53 (27328): Guest Log: vboxguest: misc device minor 56, IRQ 20, I/O port d020, MMIO at 00000000f0400000 (size 0x400000) 2024-07-04 21:12:53 (27328): Guest Log: VBoxService 5.2.6 r120293 (verbosity: 0) linux.amd64 (Jan 15 2018 14:51:00) release log 2024-07-04 21:12:53 (27328): Guest Log: 00:00:00.000126 main Log opened 2024-07-04T14:27:11.072039000Z 2024-07-04 21:12:53 (27328): Guest Log: 00:00:00.000289 main OS Product: Linux 2024-07-04 21:12:53 (27328): Guest Log: 00:00:00.000334 main OS Release: 4.14.76-13.cernvm.x86_64 2024-07-04 21:12:53 (27328): Guest Log: 00:00:00.000362 main OS Version: #1 SMP Tue Oct 16 18:26:15 CEST 2018 2024-07-04 21:12:53 (27328): Guest Log: 00:00:00.000404 main Executable: /usr/sbin/VBoxService 2024-07-04 21:12:53 (27328): Guest Log: 00:00:00.000404 main Process ID: 3209 2024-07-04 21:12:53 (27328): Guest Log: 00:00:00.000405 main Package type: LINUX_64BITS_GENERIC 2024-07-04 21:12:53 (27328): Guest Log: 00:00:00.005735 main 5.2.6 r120293 started. Verbose level = 0 2024-07-04 21:12:53 (27328): Guest Log: 16:27:32 CEST +02:00 2024-07-04: cranky: [INFO] Detected Theory App 2024-07-04 21:12:53 (27328): Guest Log: 16:27:32 CEST +02:00 2024-07-04: cranky: [INFO] Checking CVMFS. 2024-07-04 21:12:53 (27328): Guest Log: Probing /cvmfs/sft.cern.ch... OK 2024-07-04 21:12:53 (27328): 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-07-04 21:12:53 (27328): Guest Log: 2.5.2.0 4102 0 27164 29848 3 1 1101792 4096000 0 65024 0 0 n/a 5 18 http://s1cern-cvmfs.openhtc.io/cvmfs/sft.cern.ch DIRECT 1 2024-07-04 21:12:53 (27328): Guest Log: Probing /cvmfs/grid.cern.ch... OK 2024-07-04 21:12:53 (27328): 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-07-04 21:12:53 (27328): Guest Log: 2.5.2.0 4034 0 27588 24631 3 2 1101792 4096000 0 65024 0 2 0 5818 4404 http://s1bnl-cvmfs.openhtc.io/cvmfs/grid.cern.ch DIRECT 1 2024-07-04 21:12:53 (27328): Guest Log: Probing /cvmfs/cernvm-prod.cern.ch... OK 2024-07-04 21:12:53 (27328): 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-07-04 21:12:53 (27328): Guest Log: 2.5.2.0 4081 0 27216 272 3 1 1101792 4096000 0 65024 0 0 n/a 0 0 http://s1cern-cvmfs.openhtc.io/cvmfs/cernvm-prod.cern.ch DIRECT 1 2024-07-04 21:12:53 (27328): Guest Log: Probing /cvmfs/alice.cern.ch... OK 2024-07-04 21:12:53 (27328): 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-07-04 21:12:53 (27328): Guest Log: 2.5.2.0 4056 0 39748 19062 3 1 1101792 4096000 0 65024 0 0 n/a 5563 2230 http://s1unl-cvmfs.openhtc.io/cvmfs/alice.cern.ch DIRECT 1 2024-07-04 21:12:53 (27328): Guest Log: 16:27:36 CEST +02:00 2024-07-04: cranky: [INFO] Checking runc. 2024-07-04 21:12:53 (27328): Guest Log: 16:27:36 CEST +02:00 2024-07-04: cranky: [INFO] Creating the filesystem. 2024-07-04 21:12:53 (27328): Guest Log: 16:27:36 CEST +02:00 2024-07-04: cranky: [INFO] Using /cvmfs/cernvm-prod.cern.ch/cvm4 2024-07-04 21:12:53 (27328): Guest Log: 16:27:36 CEST +02:00 2024-07-04: cranky: [INFO] Updating config.json. 2024-07-04 21:12:53 (27328): Guest Log: 16:27:36 CEST +02:00 2024-07-04: cranky: [INFO] Running Container 'runc'. 2024-07-04 21:12:53 (27328): Guest Log: job: htmld=/shared/html/job 2024-07-04 21:12:53 (27328): Guest Log: job: unpack exitcode=0 2024-07-04 21:12:53 (27328): Guest Log: INFO: activated the work-around for ld: 2024-07-04 21:12:53 (27328): Guest Log: lrwxrwxrwx 1 0 0 15 Jul 4 14:27 /tmp/tmp.FgWakQnDab/ld -> /usr/bin/ld.bfd 2024-07-04 21:12:53 (27328): Guest Log: 16:27:38 CEST +02:00 2024-07-04: cranky: [INFO] ===> [runRivet] Thu Jul 4 14:27:37 UTC 2024 [boinc ppbar mb-inelastic 630 - - pythia8 8.230 tune-2c 100000 292] 2024-07-04 21:12:53 (27328): Starting VM using VBoxManage interface. (boinc_0f5eced0e9f713ab, slot#11) 2024-07-04 21:13:03 (27328): Successfully started VM. (PID = '36072') 2024-07-04 21:13:03 (27328): Reporting VM Process ID to BOINC. 2024-07-04 21:13:03 (27328): VM state change detected. (old = 'poweredoff', new = 'running') 2024-07-04 21:13:03 (27328): Detected: Web Application Enabled (http://localhost:62131) 2024-07-04 21:13:04 (27328): VM state change detected. (old = 'running', new = 'paused') 2024-07-04 21:13:22 (27328): Preference change detected 2024-07-04 21:13:22 (27328): Setting CPU throttle for VM. (100%) 2024-07-04 21:13:23 (27328): Setting checkpoint interval to 600 seconds. (Higher value of (Preference: 60 seconds) or (Vbox_job.xml: 600 seconds)) 2024-07-04 21:13:23 (27328): VM state change detected. (old = 'paused', new = 'running') 2024-07-04 21:13:27 (27328): Guest Log: 00:07:10.649802 timesync vgsvcTimeSyncWorker: Radical host time change: 15 959 572 000 000ns (HostNow=1 720 120 406 705 000 000 ns HostLast=1 720 104 447 133 000 000 ns) 2024-07-04 21:13:33 (27328): VM state change detected. (old = 'running', new = 'paused') 2024-07-04 21:13:52 (27328): VM state change detected. (old = 'paused', new = 'running') 2024-07-04 21:13:55 (27328): Guest Log: 00:07:20.674795 timesync vgsvcTimeSyncWorker: Radical guest time change: 16 755 156 228 000ns (GuestNow=1 720 120 416 764 291 000 ns GuestLast=1 720 103 661 608 063 000 ns fSetTimeLastLoop=true ) 2024-07-04 21:14:02 (27328): VM state change detected. (old = 'running', new = 'paused') 2024-07-04 21:14:22 (27328): VM state change detected. (old = 'paused', new = 'running') 2024-07-04 21:14:33 (27328): VM state change detected. (old = 'running', new = 'paused') 2024-07-04 21:14:52 (27328): VM state change detected. (old = 'paused', new = 'running') 2024-07-04 21:15:04 (27328): VM state change detected. (old = 'running', new = 'paused') 2024-07-04 21:15:23 (27328): VM state change detected. (old = 'paused', new = 'running') 2024-07-04 21:15:34 (27328): VM state change detected. (old = 'running', new = 'paused') 2024-07-04 21:15:53 (27328): VM state change detected. (old = 'paused', new = 'running') 2024-07-04 21:16:05 (27328): VM state change detected. (old = 'running', new = 'paused') 2024-07-04 21:16:23 (27328): VM state change detected. (old = 'paused', new = 'running') 2024-07-04 21:16:34 (27328): VM state change detected. (old = 'running', new = 'paused') 2024-07-04 21:16:53 (27328): VM state change detected. (old = 'paused', new = 'running') 2024-07-04 21:17:04 (27328): VM state change detected. (old = 'running', new = 'paused') 2024-07-04 21:17:23 (27328): VM state change detected. (old = 'paused', new = 'running') 2024-07-04 21:17:33 (27328): VM state change detected. (old = 'running', new = 'paused') 2024-07-04 21:17:53 (27328): VM state change detected. (old = 'paused', new = 'running') 2024-07-04 21:18:05 (27328): VM state change detected. (old = 'running', new = 'paused') 2024-07-04 21:18:23 (27328): VM state change detected. (old = 'paused', new = 'running') 2024-07-04 21:18:33 (27328): VM state change detected. (old = 'running', new = 'paused') 2024-07-04 21:18:53 (27328): VM state change detected. (old = 'paused', new = 'running') 2024-07-04 21:19:03 (27328): VM state change detected. (old = 'running', new = 'paused') 2024-07-04 21:19:23 (27328): VM state change detected. (old = 'paused', new = 'running') 2024-07-04 21:19:33 (27328): VM state change detected. (old = 'running', new = 'paused') 2024-07-04 21:19:54 (27328): VM state change detected. (old = 'paused', new = 'running') 2024-07-04 21:20:04 (27328): VM state change detected. (old = 'running', new = 'paused') 2024-07-04 21:20:23 (27328): VM state change detected. (old = 'paused', new = 'running') 2024-07-04 21:20:35 (27328): VM state change detected. (old = 'running', new = 'paused') 2024-07-04 21:20:53 (27328): VM state change detected. (old = 'paused', new = 'running') 2024-07-04 21:21:04 (27328): VM state change detected. (old = 'running', new = 'paused') 2024-07-04 21:21:24 (27328): VM state change detected. (old = 'paused', new = 'running') 2024-07-04 21:21:34 (27328): VM state change detected. (old = 'running', new = 'paused') 2024-07-04 21:21:54 (27328): VM state change detected. (old = 'paused', new = 'running') 2024-07-04 21:22:04 (27328): VM state change detected. (old = 'running', new = 'paused') 2024-07-04 21:22:24 (27328): VM state change detected. (old = 'paused', new = 'running') 2024-07-04 21:22:34 (27328): VM state change detected. (old = 'running', new = 'paused') 2024-07-04 21:22:54 (27328): VM state change detected. (old = 'paused', new = 'running') 2024-07-04 21:23:06 (27328): VM state change detected. (old = 'running', new = 'paused') 2024-07-04 21:23:24 (27328): VM state change detected. (old = 'paused', new = 'running') 2024-07-04 21:23:34 (27328): VM state change detected. (old = 'running', new = 'paused') 2024-07-04 21:23:54 (27328): VM state change detected. (old = 'paused', new = 'running') 2024-07-04 21:24:05 (27328): VM state change detected. (old = 'running', new = 'paused') 2024-07-04 21:24:24 (27328): VM state change detected. (old = 'paused', new = 'running') 2024-07-04 21:24:35 (27328): VM state change detected. (old = 'running', new = 'paused') 2024-07-04 21:24:54 (27328): VM state change detected. (old = 'paused', new = 'running') 2024-07-04 21:25:06 (27328): VM state change detected. (old = 'running', new = 'paused') 2024-07-04 21:25:24 (27328): VM state change detected. (old = 'paused', new = 'running') 2024-07-04 21:25:38 (27328): VM state change detected. (old = 'running', new = 'paused') 2024-07-04 21:25:55 (27328): VM state change detected. (old = 'paused', new = 'running') 2024-07-04 21:26:06 (27328): VM state change detected. (old = 'running', new = 'paused') 2024-07-04 21:26:24 (27328): VM state change detected. (old = 'paused', new = 'running') 2024-07-04 21:26:36 (27328): VM state change detected. (old = 'running', new = 'paused') 2024-07-04 21:26:54 (27328): VM state change detected. (old = 'paused', new = 'running') 2024-07-04 21:27:06 (27328): VM state change detected. (old = 'running', new = 'paused') 2024-07-04 21:27:25 (27328): VM state change detected. (old = 'paused', new = 'running') 2024-07-04 21:27:37 (27328): VM state change detected. (old = 'running', new = 'paused') 2024-07-04 21:27:55 (27328): VM state change detected. (old = 'paused', new = 'running') 2024-07-04 21:28:07 (27328): VM state change detected. (old = 'running', new = 'paused') 2024-07-04 21:28:26 (27328): VM state change detected. (old = 'paused', new = 'running') 2024-07-04 21:28:55 (27328): VM state change detected. (old = 'running', new = 'paused') 2024-07-04 21:29:15 (27328): VM state change detected. (old = 'paused', new = 'running') 2024-07-04 21:29:27 (27328): VM state change detected. (old = 'running', new = 'paused') 2024-07-04 21:29:44 (27328): VM state change detected. (old = 'paused', new = 'running') 2024-07-04 21:29:49 (27328): Guest Log: job: run exitcode=0 2024-07-04 21:29:49 (27328): Guest Log: job: diskusage=3284 2024-07-04 21:29:49 (27328): Guest Log: job: logsize=76 k 2024-07-04 21:29:49 (27328): Guest Log: job: times= 2024-07-04 21:29:49 (27328): Guest Log: 0m0.002s 0m0.016s 2024-07-04 21:29:49 (27328): Guest Log: 8m8.646s 0m11.005s 2024-07-04 21:29:49 (27328): Guest Log: job: cpuusage=500 2024-07-04 21:29:49 (27328): Guest Log: 21:20:08 CEST +02:00 2024-07-04: cranky: [INFO] Container 'runc' finished with status code 0. 2024-07-04 21:29:49 (27328): Guest Log: 21:20:08 CEST +02:00 2024-07-04: cranky: [INFO] Preparing output. 2024-07-04 21:29:51 (27328): Guest Log: [INFO] Job Finished 2024-07-04 21:29:51 (27328): Guest Log: [INFO] Shutting Down. 2024-07-04 21:29:51 (27328): VM Completion File Detected. 2024-07-04 21:29:51 (27328): VM Completion Message: Job Finished . 2024-07-04 21:29:51 (27328): Powering off VM. 2024-07-04 21:29:52 (27328): Successfully stopped VM. 2024-07-04 21:29:52 (27328): Deregistering VM. (boinc_0f5eced0e9f713ab, slot#11) 2024-07-04 21:29:52 (27328): Removing network bandwidth throttle group from VM. 2024-07-04 21:29:53 (27328): Removing VM from VirtualBox. 2024-07-04 21:29:58 (27328): called boinc_finish(0) </stderr_txt> ]]>
©2024 CERN