| Name | Theory_2743-2780277-274_1 |
| Workunit | 223856305 |
| Created | 2 Jul 2024, 13:17:10 UTC |
| Sent | 2 Jul 2024, 15:30:11 UTC |
| Report deadline | 13 Jul 2024, 15:30:11 UTC |
| Received | 3 Jul 2024, 19:56:00 UTC |
| Server state | Over |
| Outcome | Success |
| Client state | Done |
| Exit status | 0 (0x00000000) |
| Computer ID | 10700350 |
| Run time | 3 hours 46 min 28 sec |
| CPU time | 3 hours 41 min 6 sec |
| Validate state | Valid |
| Credit | 179.71 |
| Device peak FLOPS | 5.71 GFLOPS |
| Application version | Theory Simulation v300.30 (vbox64_theory) windows_x86_64 |
| Peak working set size | 84.09 MB |
| Peak swap size | 78.21 MB |
| Peak disk usage | 1.57 GB |
Stderr output
<core_client_version>7.20.2</core_client_version>
<![CDATA[
<stderr_txt>
ion: 6.1.34)
2024-07-02 10:11:44 (43292): Detected: Heartbeat check (file: 'heartbeat' every 1200.000000 seconds)
2024-07-02 10:11:44 (43292): Successfully copied 'init_data.xml' to the shared directory.
2024-07-02 10:11:44 (43292): Successfully copied 'input' to the shared directory.
2024-07-02 10:11:45 (43292): Create VM. (boinc_47560b18e7c82d21, slot#19)
2024-07-02 10:11:45 (43292): Setting Memory Size for VM. (630MB)
2024-07-02 10:11:46 (43292): Setting CPU Count for VM. (1)
2024-07-02 10:11:46 (43292): Setting Chipset Options for VM.
2024-07-02 10:11:46 (43292): Setting Graphics Controller Options for VM.
2024-07-02 10:11:46 (43292): Setting Boot Options for VM.
2024-07-02 10:11:47 (43292): Setting Network Configuration for NAT.
2024-07-02 10:11:47 (43292): Enabling VM Network Access.
2024-07-02 10:11:47 (43292): Disabling USB Support for VM.
2024-07-02 10:11:48 (43292): Disabling COM Port Support for VM.
2024-07-02 10:11:48 (43292): Disabling LPT Port Support for VM.
2024-07-02 10:11:48 (43292): Disabling Audio Support for VM.
2024-07-02 10:11:48 (43292): Disabling Clipboard Support for VM.
2024-07-02 10:11:49 (43292): Disabling Drag and Drop Support for VM.
2024-07-02 10:11:49 (43292): Adding storage controller(s) to VM.
2024-07-02 10:11:49 (43292): Adding virtual disk drive to VM. (Theory_2024_04_30_prod.vdi)
2024-07-02 10:11:57 (43292): Attempts: 5
2024-07-02 10:11:57 (43292): Adding VirtualBox Guest Additions to VM.
2024-07-02 10:11:57 (43292): Adding network bandwidth throttle group to VM. (Defaulting to 1024GB)
2024-07-02 10:11:58 (43292): forwarding host port 63659 to guest port 80
2024-07-02 10:11:58 (43292): Enabling remote desktop for VM.
2024-07-02 10:11:58 (43292): Required extension pack not installed, remote desktop not enabled.
2024-07-02 10:11:58 (43292): Enabling shared directory for VM.
2024-07-02 10:11:59 (43292): Starting VM using VBoxManage interface. (boinc_47560b18e7c82d21, slot#19)
2024-07-02 10:12:02 (43292): Successfully started VM. (PID = '40588')
2024-07-02 10:12:02 (43292): Reporting VM Process ID to BOINC.
2024-07-02 10:12:02 (43292): Guest Log: BIOS: VirtualBox 6.1.34
2024-07-02 10:12:02 (43292): Guest Log: CPUID EDX: 0x178bfbff
2024-07-02 10:12:02 (43292): Guest Log: BIOS: No PCI IDE controller, not probing IDE
2024-07-02 10:12:02 (43292): Guest Log: BIOS: AHCI 0-P#0: PCHS=16383/16/63 LCHS=1024/255/63 0x0000000002800000 sectors
2024-07-02 10:12:02 (43292): VM state change detected. (old = 'poweredoff', new = 'running')
2024-07-02 10:12:02 (43292): Detected: Web Application Enabled (http://localhost:63659)
2024-07-02 10:12:03 (43292): VM state change detected. (old = 'running', new = 'paused')
2024-07-02 10:15:03 (43292): Preference change detected
2024-07-02 10:15:03 (43292): Setting CPU throttle for VM. (100%)
2024-07-02 10:15:03 (43292): Setting checkpoint interval to 600 seconds. (Higher value of (Preference: 60 seconds) or (Vbox_job.xml: 600 seconds))
2024-07-02 10:15:03 (43292): VM state change detected. (old = 'paused', new = 'running')
2024-07-02 10:15:04 (43292): Guest Log: BIOS: Boot : bseqnr=1, bootseq=0032
2024-07-02 10:15:04 (43292): Guest Log: BIOS: Booting from Hard Disk...
2024-07-02 10:15:06 (43292): Guest Log: BIOS: KBD: unsupported int 16h function 03
2024-07-02 10:15:06 (43292): Guest Log: BIOS: AX=0305 BX=0000 CX=0000 DX=0000
2024-07-02 10:15:23 (43292): Guest Log: vgdrvHeartbeatInit: Setting up heartbeat to trigger every 2000 milliseconds
2024-07-02 10:15:23 (43292): Guest Log: vboxguest: misc device minor 56, IRQ 20, I/O port d020, MMIO at 00000000f0400000 (size 0x400000)
2024-07-02 10:15:26 (43292): Guest Log: VBoxService 5.2.6 r120293 (verbosity: 0) linux.amd64 (Jan 15 2018 14:51:00) release log
2024-07-02 10:15:26 (43292): Guest Log: 00:00:00.000064 main Log opened 2024-07-02T17:15:26.578355000Z
2024-07-02 10:15:26 (43292): Guest Log: 00:00:00.000143 main OS Product: Linux
2024-07-02 10:15:26 (43292): Guest Log: 00:00:00.000178 main OS Release: 4.14.76-13.cernvm.x86_64
2024-07-02 10:15:26 (43292): Guest Log: 00:00:00.000217 main OS Version: #1 SMP Tue Oct 16 18:26:15 CEST 2018
2024-07-02 10:15:26 (43292): Guest Log: 00:00:00.000240 main Executable: /usr/sbin/VBoxService
2024-07-02 10:15:26 (43292): Guest Log: 00:00:00.000241 main Process ID: 3214
2024-07-02 10:15:26 (43292): Guest Log: 00:00:00.000241 main Package type: LINUX_64BITS_GENERIC
2024-07-02 10:15:26 (43292): Guest Log: 00:00:00.001807 main 5.2.6 r120293 started. Verbose level = 0
2024-07-02 10:15:49 (43292): Guest Log: 10:15:50 MST -07:00 2024-07-02: cranky: [INFO] Detected Theory App
2024-07-02 10:15:49 (43292): Guest Log: 10:15:50 MST -07:00 2024-07-02: cranky: [INFO] Checking CVMFS.
2024-07-02 10:15:49 (43292): Guest Log: Probing /cvmfs/sft.cern.ch... OK
2024-07-02 10:15:50 (43292): 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-02 10:15:51 (43292): Guest Log: 2.5.2.0 4122 0 28064 29831 3 1 272442 4096000 0 65024 0 0 n/a 5 7 http://s1unl-cvmfs.openhtc.io/cvmfs/sft.cern.ch DIRECT 1
2024-07-02 10:15:51 (43292): Guest Log: Probing /cvmfs/grid.cern.ch... OK
2024-07-02 10:15:51 (43292): 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-02 10:15:51 (43292): Guest Log: 2.5.2.0 4052 0 27420 24617 3 2 272442 4096000 0 65024 0 2 -100 7958 5938 http://s1unl-cvmfs.openhtc.io/cvmfs/grid.cern.ch DIRECT 1
2024-07-02 10:15:51 (43292): Guest Log: Probing /cvmfs/cernvm-prod.cern.ch... OK
2024-07-02 10:15:52 (43292): 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-02 10:15:52 (43292): Guest Log: 2.5.2.0 4078 0 27216 272 3 1 272442 4096000 0 65024 0 0 n/a 4 7 http://s1fnal-cvmfs.openhtc.io/cvmfs/cernvm-prod.cern.ch DIRECT 1
2024-07-02 10:15:52 (43292): Guest Log: Probing /cvmfs/alice.cern.ch... OK
2024-07-02 10:15:52 (43292): 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-02 10:15:52 (43292): Guest Log: 2.5.2.0 4099 0 39636 19048 3 1 272442 4096000 0 65024 0 0 n/a 5551 6545 http://s1unl-cvmfs.openhtc.io/cvmfs/alice.cern.ch DIRECT 1
2024-07-02 10:15:52 (43292): Guest Log: 10:15:52 MST -07:00 2024-07-02: cranky: [INFO] Checking runc.
2024-07-02 10:15:52 (43292): Guest Log: 10:15:52 MST -07:00 2024-07-02: cranky: [INFO] Creating the filesystem.
2024-07-02 10:15:52 (43292): Guest Log: 10:15:52 MST -07:00 2024-07-02: cranky: [INFO] Using /cvmfs/cernvm-prod.cern.ch/cvm4
2024-07-02 10:15:52 (43292): Guest Log: 10:15:52 MST -07:00 2024-07-02: cranky: [INFO] Updating config.json.
2024-07-02 10:15:52 (43292): Guest Log: 10:15:52 MST -07:00 2024-07-02: cranky: [INFO] Running Container 'runc'.
2024-07-02 10:15:54 (43292): Guest Log: job: htmld=/shared/html/job
2024-07-02 10:15:54 (43292): Guest Log: job: unpack exitcode=0
2024-07-02 10:15:55 (43292): Guest Log: INFO: activated the work-around for ld:
2024-07-02 10:15:55 (43292): Guest Log: lrwxrwxrwx 1 0 0 15 Jul 2 17:15 /tmp/tmp.PdhEbcvDaY/ld -> /usr/bin/ld.bfd
2024-07-02 10:15:56 (43292): Guest Log: 10:15:56 MST -07:00 2024-07-02: cranky: [INFO] ===> [runRivet] Tue Jul 2 17:15:54 UTC 2024 [boinc pp jets 7000 500 - pythia8 8.305 CP2-CR1 100000 274]
2024-07-02 10:17:03 (43292): Stopping VM.
2024-07-02 10:17:05 (43292): Successfully stopped VM.
2024-07-02 10:20:11 (40860): vboxwrapper version 26207
2024-07-02 10:20:11 (40860): BOINC client version: 7.20.2
2024-07-02 10:20:11 (40860): Detected: VirtualBox VboxManage Interface (Version: 6.1.34)
2024-07-02 10:20:12 (40860): Detected: Heartbeat check (file: 'heartbeat' every 1200.000000 seconds)
2024-07-02 10:20:12 (40860): Guest Log: BIOS: VirtualBox 6.1.34
2024-07-02 10:20:12 (40860): Guest Log: CPUID EDX: 0x178bfbff
2024-07-02 10:20:12 (40860): Guest Log: BIOS: No PCI IDE controller, not probing IDE
2024-07-02 10:20:12 (40860): Guest Log: BIOS: AHCI 0-P#0: PCHS=16383/16/63 LCHS=1024/255/63 0x0000000002800000 sectors
2024-07-02 10:20:12 (40860): Guest Log: BIOS: Boot : bseqnr=1, bootseq=0032
2024-07-02 10:20:12 (40860): Guest Log: BIOS: Booting from Hard Disk...
2024-07-02 10:20:12 (40860): Guest Log: BIOS: KBD: unsupported int 16h function 03
2024-07-02 10:20:12 (40860): Guest Log: BIOS: AX=0305 BX=0000 CX=0000 DX=0000
2024-07-02 10:20:12 (40860): Guest Log: vgdrvHeartbeatInit: Setting up heartbeat to trigger every 2000 milliseconds
2024-07-02 10:20:12 (40860): Guest Log: vboxguest: misc device minor 56, IRQ 20, I/O port d020, MMIO at 00000000f0400000 (size 0x400000)
2024-07-02 10:20:12 (40860): Guest Log: VBoxService 5.2.6 r120293 (verbosity: 0) linux.amd64 (Jan 15 2018 14:51:00) release log
2024-07-02 10:20:12 (40860): Guest Log: 00:00:00.000064 main Log opened 2024-07-02T17:15:26.578355000Z
2024-07-02 10:20:12 (40860): Guest Log: 00:00:00.000143 main OS Product: Linux
2024-07-02 10:20:12 (40860): Guest Log: 00:00:00.000178 main OS Release: 4.14.76-13.cernvm.x86_64
2024-07-02 10:20:12 (40860): Guest Log: 00:00:00.000217 main OS Version: #1 SMP Tue Oct 16 18:26:15 CEST 2018
2024-07-02 10:20:12 (40860): Guest Log: 00:00:00.000240 main Executable: /usr/sbin/VBoxService
2024-07-02 10:20:12 (40860): Guest Log: 00:00:00.000241 main Process ID: 3214
2024-07-02 10:20:12 (40860): Guest Log: 00:00:00.000241 main Package type: LINUX_64BITS_GENERIC
2024-07-02 10:20:12 (40860): Guest Log: 00:00:00.001807 main 5.2.6 r120293 started. Verbose level = 0
2024-07-02 10:20:12 (40860): Guest Log: 10:15:50 MST -07:00 2024-07-02: cranky: [INFO] Detected Theory App
2024-07-02 10:20:12 (40860): Guest Log: 10:15:50 MST -07:00 2024-07-02: cranky: [INFO] Checking CVMFS.
2024-07-02 10:20:12 (40860): Guest Log: Probing /cvmfs/sft.cern.ch... OK
2024-07-02 10:20:12 (40860): 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-02 10:20:12 (40860): Guest Log: 2.5.2.0 4122 0 28064 29831 3 1 272442 4096000 0 65024 0 0 n/a 5 7 http://s1unl-cvmfs.openhtc.io/cvmfs/sft.cern.ch DIRECT 1
2024-07-02 10:20:12 (40860): Guest Log: Probing /cvmfs/grid.cern.ch... OK
2024-07-02 10:20:12 (40860): 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-02 10:20:12 (40860): Guest Log: 2.5.2.0 4052 0 27420 24617 3 2 272442 4096000 0 65024 0 2 -100 7958 5938 http://s1unl-cvmfs.openhtc.io/cvmfs/grid.cern.ch DIRECT 1
2024-07-02 10:20:12 (40860): Guest Log: Probing /cvmfs/cernvm-prod.cern.ch... OK
2024-07-02 10:20:12 (40860): 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-02 10:20:12 (40860): Guest Log: 2.5.2.0 4078 0 27216 272 3 1 272442 4096000 0 65024 0 0 n/a 4 7 http://s1fnal-cvmfs.openhtc.io/cvmfs/cernvm-prod.cern.ch DIRECT 1
2024-07-02 10:20:12 (40860): Guest Log: Probing /cvmfs/alice.cern.ch... OK
2024-07-02 10:20:12 (40860): 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-02 10:20:12 (40860): Guest Log: 2.5.2.0 4099 0 39636 19048 3 1 272442 4096000 0 65024 0 0 n/a 5551 6545 http://s1unl-cvmfs.openhtc.io/cvmfs/alice.cern.ch DIRECT 1
2024-07-02 10:20:12 (40860): Guest Log: 10:15:52 MST -07:00 2024-07-02: cranky: [INFO] Checking runc.
2024-07-02 10:20:12 (40860): Guest Log: 10:15:52 MST -07:00 2024-07-02: cranky: [INFO] Creating the filesystem.
2024-07-02 10:20:12 (40860): Guest Log: 10:15:52 MST -07:00 2024-07-02: cranky: [INFO] Using /cvmfs/cernvm-prod.cern.ch/cvm4
2024-07-02 10:20:12 (40860): Guest Log: 10:15:52 MST -07:00 2024-07-02: cranky: [INFO] Updating config.json.
2024-07-02 10:20:12 (40860): Guest Log: 10:15:52 MST -07:00 2024-07-02: cranky: [INFO] Running Container 'runc'.
2024-07-02 10:20:12 (40860): Guest Log: job: htmld=/shared/html/job
2024-07-02 10:20:12 (40860): Guest Log: job: unpack exitcode=0
2024-07-02 10:20:12 (40860): Guest Log: INFO: activated the work-around for ld:
2024-07-02 10:20:12 (40860): Guest Log: lrwxrwxrwx 1 0 0 15 Jul 2 17:15 /tmp/tmp.PdhEbcvDaY/ld -> /usr/bin/ld.bfd
2024-07-02 10:20:12 (40860): Guest Log: 10:15:56 MST -07:00 2024-07-02: cranky: [INFO] ===> [runRivet] Tue Jul 2 17:15:54 UTC 2024 [boinc pp jets 7000 500 - pythia8 8.305 CP2-CR1 100000 274]
2024-07-02 10:20:12 (40860): Starting VM using VBoxManage interface. (boinc_47560b18e7c82d21, slot#19)
2024-07-02 10:20:19 (40860): Successfully started VM. (PID = '37900')
2024-07-02 10:20:19 (40860): Reporting VM Process ID to BOINC.
2024-07-02 10:20:19 (40860): VM state change detected. (old = 'poweredoff', new = 'running')
2024-07-02 10:20:19 (40860): Detected: Web Application Enabled (http://localhost:63659)
2024-07-02 10:20:19 (40860): Preference change detected
2024-07-02 10:20:19 (40860): Setting CPU throttle for VM. (100%)
2024-07-02 10:20:19 (40860): Setting checkpoint interval to 600 seconds. (Higher value of (Preference: 60 seconds) or (Vbox_job.xml: 600 seconds))
2024-07-02 10:47:29 (40860): VM state change detected. (old = 'running', new = 'paused')
2024-07-02 13:42:27 (41512): vboxwrapper version 26207
2024-07-02 13:42:27 (41512): BOINC client version: 7.20.2
2024-07-02 13:42:27 (41512): Detected: VirtualBox VboxManage Interface (Version: 6.1.34)
2024-07-02 13:42:27 (41512): Detected: Heartbeat check (file: 'heartbeat' every 1200.000000 seconds)
2024-07-02 13:42:28 (41512): ERROR: VM failed to start
2024-07-02 13:42:33 (41512):
BOINC will be notified that it needs to clean up the environment.
This is a temporary problem and so this job will be rescheduled for another time.
2024-07-02 17:20:43 (33168): vboxwrapper version 26207
2024-07-02 17:20:43 (33168): BOINC client version: 7.20.2
2024-07-02 17:20:44 (33168): Detected: VirtualBox VboxManage Interface (Version: 6.1.34)
2024-07-02 17:20:44 (33168): Detected: Heartbeat check (file: 'heartbeat' every 1200.000000 seconds)
2024-07-02 17:20:45 (33168): Starting VM using VBoxManage interface. (boinc_47560b18e7c82d21, slot#19)
2024-07-02 17:20:51 (33168): Successfully started VM. (PID = '42880')
2024-07-02 17:20:51 (33168): Reporting VM Process ID to BOINC.
2024-07-02 17:20:51 (33168): Guest Log: BIOS: VirtualBox 6.1.34
2024-07-02 17:20:51 (33168): Guest Log: CPUID EDX: 0x178bfbff
2024-07-02 17:20:51 (33168): Guest Log: BIOS: No PCI IDE controller, not probing IDE
2024-07-02 17:20:51 (33168): Guest Log: BIOS: AHCI 0-P#0: PCHS=16383/16/63 LCHS=1024/255/63 0x0000000002800000 sectors
2024-07-02 17:20:51 (33168): VM state change detected. (old = 'poweredoff', new = 'running')
2024-07-02 17:20:51 (33168): Detected: Web Application Enabled (http://localhost:63659)
2024-07-02 17:20:51 (33168): Preference change detected
2024-07-02 17:20:51 (33168): Setting CPU throttle for VM. (100%)
2024-07-02 17:20:51 (33168): Setting checkpoint interval to 600 seconds. (Higher value of (Preference: 60 seconds) or (Vbox_job.xml: 600 seconds))
2024-07-02 17:20:53 (33168): Guest Log: BIOS: Boot : bseqnr=1, bootseq=0032
2024-07-02 17:20:53 (33168): Guest Log: BIOS: Booting from Hard Disk...
2024-07-02 17:20:55 (33168): Guest Log: BIOS: KBD: unsupported int 16h function 03
2024-07-02 17:20:55 (33168): Guest Log: BIOS: AX=0305 BX=0000 CX=0000 DX=0000
2024-07-02 17:21:15 (33168): Guest Log: vgdrvHeartbeatInit: Setting up heartbeat to trigger every 2000 milliseconds
2024-07-02 17:21:15 (33168): Guest Log: vboxguest: misc device minor 56, IRQ 20, I/O port d020, MMIO at 00000000f0400000 (size 0x400000)
2024-07-02 17:21:17 (33168): Guest Log: VBoxService 5.2.6 r120293 (verbosity: 0) linux.amd64 (Jan 15 2018 14:51:00) release log
2024-07-02 17:21:18 (33168): Guest Log: 00:00:00.000075 main Log opened 2024-07-03T00:21:18.568709000Z
2024-07-02 17:21:18 (33168): Guest Log: 00:00:00.000195 main OS Product: Linux
2024-07-02 17:21:18 (33168): Guest Log: 00:00:00.000227 main OS Release: 4.14.76-13.cernvm.x86_64
2024-07-02 17:21:18 (33168): Guest Log: 00:00:00.000263 main OS Version: #1 SMP Tue Oct 16 18:26:15 CEST 2018
2024-07-02 17:21:18 (33168): Guest Log: 00:00:00.000289 main Executable: /usr/sbin/VBoxService
2024-07-02 17:21:18 (33168): Guest Log: 00:00:00.000290 main Process ID: 3220
2024-07-02 17:21:18 (33168): Guest Log: 00:00:00.000291 main Package type: LINUX_64BITS_GENERIC
2024-07-02 17:21:18 (33168): Guest Log: 00:00:00.013432 main 5.2.6 r120293 started. Verbose level = 0
2024-07-02 17:21:59 (33168): Guest Log: 17:21:59 MST -07:00 2024-07-02: cranky: [INFO] Detected Theory App
2024-07-02 17:21:59 (33168): Guest Log: 17:21:59 MST -07:00 2024-07-02: cranky: [INFO] Checking CVMFS.
2024-07-02 17:21:59 (33168): Guest Log: Probing /cvmfs/sft.cern.ch... OK
2024-07-02 17:22:00 (33168): 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-02 17:22:00 (33168): Guest Log: 2.5.2.0 4097 0 28288 29833 3 1 1123266 4096000 0 65024 0 0 n/a 5 7 http://s1unl-cvmfs.openhtc.io/cvmfs/sft.cern.ch DIRECT 1
2024-07-02 17:22:00 (33168): Guest Log: Probing /cvmfs/grid.cern.ch... OK
2024-07-02 17:22:00 (33168): 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-02 17:22:00 (33168): Guest Log: 2.5.2.0 4050 0 27536 24619 3 2 1123266 4096000 0 65024 0 2 0 5820 2383 http://s1fnal-cvmfs.openhtc.io/cvmfs/grid.cern.ch DIRECT 1
2024-07-02 17:22:00 (33168): Guest Log: Probing /cvmfs/cernvm-prod.cern.ch... OK
2024-07-02 17:22:01 (33168): 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-02 17:22:01 (33168): Guest Log: 2.5.2.0 4138 0 25568 272 3 1 1123266 4096000 0 65024 0 0 n/a 0 0 http://s1cern-cvmfs.openhtc.io/cvmfs/cernvm-prod.cern.ch DIRECT 1
2024-07-02 17:22:01 (33168): Guest Log: Probing /cvmfs/alice.cern.ch... OK
2024-07-02 17:22:02 (33168): 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-02 17:22:02 (33168): Guest Log: 2.5.2.0 4072 0 40232 19049 3 1 1123266 4096000 0 65024 0 0 n/a 5551 4708 http://s1cern-cvmfs.openhtc.io/cvmfs/alice.cern.ch DIRECT 1
2024-07-02 17:22:02 (33168): Guest Log: 17:22:02 MST -07:00 2024-07-02: cranky: [INFO] Checking runc.
2024-07-02 17:22:02 (33168): Guest Log: 17:22:02 MST -07:00 2024-07-02: cranky: [INFO] Creating the filesystem.
2024-07-02 17:22:02 (33168): Guest Log: 17:22:02 MST -07:00 2024-07-02: cranky: [INFO] Using /cvmfs/cernvm-prod.cern.ch/cvm4
2024-07-02 17:22:02 (33168): Guest Log: 17:22:02 MST -07:00 2024-07-02: cranky: [INFO] Updating config.json.
2024-07-02 17:22:02 (33168): Guest Log: 17:22:02 MST -07:00 2024-07-02: cranky: [INFO] Running Container 'runc'.
2024-07-02 17:22:03 (33168): Guest Log: job: htmld=/shared/html/job
2024-07-02 17:22:03 (33168): Guest Log: job: unpack exitcode=0
2024-07-02 17:22:03 (33168): Guest Log: INFO: activated the work-around for ld:
2024-07-02 17:22:03 (33168): Guest Log: lrwxrwxrwx 1 0 0 15 Jul 3 00:22 /tmp/tmp.QqgegYJi4C/ld -> /usr/bin/ld.bfd
2024-07-02 17:22:04 (33168): Guest Log: 17:22:05 MST -07:00 2024-07-02: cranky: [INFO] ===> [runRivet] Wed Jul 3 00:22:04 UTC 2024 [boinc pp jets 7000 500 - pythia8 8.305 CP2-CR1 100000 274]
2024-07-02 17:37:06 (33168): VM state change detected. (old = 'running', new = 'paused')
2024-07-02 17:37:16 (33168): VM state change detected. (old = 'paused', new = 'running')
2024-07-02 17:45:37 (33168): VM state change detected. (old = 'running', new = 'paused')
2024-07-02 17:45:47 (33168): VM state change detected. (old = 'paused', new = 'running')
2024-07-02 17:49:28 (33168): VM state change detected. (old = 'running', new = 'paused')
2024-07-02 17:49:38 (33168): VM state change detected. (old = 'paused', new = 'running')
2024-07-02 17:52:58 (33168): VM state change detected. (old = 'running', new = 'paused')
2024-07-02 17:53:08 (33168): VM state change detected. (old = 'paused', new = 'running')
2024-07-02 17:56:30 (33168): VM state change detected. (old = 'running', new = 'paused')
2024-07-02 17:56:39 (33168): VM state change detected. (old = 'paused', new = 'running')
2024-07-02 18:01:41 (33168): VM state change detected. (old = 'running', new = 'paused')
2024-07-02 18:01:51 (33168): VM state change detected. (old = 'paused', new = 'running')
2024-07-02 18:07:31 (33168): VM state change detected. (old = 'running', new = 'paused')
2024-07-02 18:07:40 (33168): VM state change detected. (old = 'paused', new = 'running')
2024-07-02 18:10:33 (33168): VM state change detected. (old = 'running', new = 'paused')
2024-07-02 18:10:41 (33168): VM state change detected. (old = 'paused', new = 'running')
2024-07-02 18:14:47 (33168): VM state change detected. (old = 'running', new = 'paused')
2024-07-02 18:14:50 (33168): VM state change detected. (old = 'paused', new = 'running')
2024-07-02 18:17:51 (33168): VM state change detected. (old = 'running', new = 'paused')
2024-07-02 18:18:00 (33168): VM state change detected. (old = 'paused', new = 'running')
2024-07-02 18:31:52 (33168): VM state change detected. (old = 'running', new = 'paused')
2024-07-02 18:32:01 (33168): VM state change detected. (old = 'paused', new = 'running')
2024-07-02 18:38:23 (33168): VM state change detected. (old = 'running', new = 'paused')
2024-07-02 18:38:33 (33168): VM state change detected. (old = 'paused', new = 'running')
2024-07-02 18:40:18 (33168): Status Report: Job Duration: '864000.000000'
2024-07-02 18:40:18 (33168): Status Report: Elapsed Time: '6000.362885'
2024-07-02 18:40:18 (33168): Status Report: CPU Time: '5577.828125'
2024-07-02 18:42:18 (33168): VM state change detected. (old = 'running', new = 'paused')
2024-07-02 18:42:24 (33168): VM state change detected. (old = 'paused', new = 'running')
2024-07-02 18:46:16 (33168): VM state change detected. (old = 'running', new = 'paused')
2024-07-02 18:46:26 (33168): VM state change detected. (old = 'paused', new = 'running')
2024-07-02 19:00:45 (33168): VM state change detected. (old = 'running', new = 'paused')
2024-07-02 19:00:55 (33168): VM state change detected. (old = 'paused', new = 'running')
2024-07-02 19:02:55 (33168): VM state change detected. (old = 'running', new = 'paused')
2024-07-02 19:03:05 (33168): VM state change detected. (old = 'paused', new = 'running')
2024-07-02 19:07:15 (33168): VM state change detected. (old = 'running', new = 'paused')
2024-07-03 06:49:26 (47072): vboxwrapper version 26207
2024-07-03 06:49:26 (47072): BOINC client version: 7.20.2
2024-07-03 06:49:27 (47072): Detected: VirtualBox VboxManage Interface (Version: 6.1.34)
2024-07-03 06:49:27 (47072): Detected: Heartbeat check (file: 'heartbeat' every 1200.000000 seconds)
2024-07-03 06:49:28 (47072): Guest Log: BIOS: VirtualBox 6.1.34
2024-07-03 06:49:28 (47072): Guest Log: CPUID EDX: 0x178bfbff
2024-07-03 06:49:28 (47072): Guest Log: BIOS: No PCI IDE controller, not probing IDE
2024-07-03 06:49:28 (47072): Guest Log: BIOS: AHCI 0-P#0: PCHS=16383/16/63 LCHS=1024/255/63 0x0000000002800000 sectors
2024-07-03 06:49:28 (47072): Guest Log: BIOS: Boot : bseqnr=1, bootseq=0032
2024-07-03 06:49:28 (47072): Guest Log: BIOS: Booting from Hard Disk...
2024-07-03 06:49:28 (47072): Guest Log: BIOS: KBD: unsupported int 16h function 03
2024-07-03 06:49:28 (47072): Guest Log: BIOS: AX=0305 BX=0000 CX=0000 DX=0000
2024-07-03 06:49:28 (47072): Guest Log: vgdrvHeartbeatInit: Setting up heartbeat to trigger every 2000 milliseconds
2024-07-03 06:49:28 (47072): Guest Log: vboxguest: misc device minor 56, IRQ 20, I/O port d020, MMIO at 00000000f0400000 (size 0x400000)
2024-07-03 06:49:28 (47072): Guest Log: VBoxService 5.2.6 r120293 (verbosity: 0) linux.amd64 (Jan 15 2018 14:51:00) release log
2024-07-03 06:49:28 (47072): Guest Log: 00:00:00.000075 main Log opened 2024-07-03T00:21:18.568709000Z
2024-07-03 06:49:28 (47072): Guest Log: 00:00:00.000195 main OS Product: Linux
2024-07-03 06:49:28 (47072): Guest Log: 00:00:00.000227 main OS Release: 4.14.76-13.cernvm.x86_64
2024-07-03 06:49:28 (47072): Guest Log: 00:00:00.000263 main OS Version: #1 SMP Tue Oct 16 18:26:15 CEST 2018
2024-07-03 06:49:28 (47072): Guest Log: 00:00:00.000289 main Executable: /usr/sbin/VBoxService
2024-07-03 06:49:28 (47072): Guest Log: 00:00:00.000290 main Process ID: 3220
2024-07-03 06:49:28 (47072): Guest Log: 00:00:00.000291 main Package type: LINUX_64BITS_GENERIC
2024-07-03 06:49:28 (47072): Guest Log: 00:00:00.013432 main 5.2.6 r120293 started. Verbose level = 0
2024-07-03 06:49:28 (47072): Guest Log: 17:21:59 MST -07:00 2024-07-02: cranky: [INFO] Detected Theory App
2024-07-03 06:49:28 (47072): Guest Log: 17:21:59 MST -07:00 2024-07-02: cranky: [INFO] Checking CVMFS.
2024-07-03 06:49:28 (47072): Guest Log: Probing /cvmfs/sft.cern.ch... OK
2024-07-03 06:49:28 (47072): 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 06:49:28 (47072): Guest Log: 2.5.2.0 4097 0 28288 29833 3 1 1123266 4096000 0 65024 0 0 n/a 5 7 http://s1unl-cvmfs.openhtc.io/cvmfs/sft.cern.ch DIRECT 1
2024-07-03 06:49:28 (47072): Guest Log: Probing /cvmfs/grid.cern.ch... OK
2024-07-03 06:49:28 (47072): 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 06:49:28 (47072): Guest Log: 2.5.2.0 4050 0 27536 24619 3 2 1123266 4096000 0 65024 0 2 0 5820 2383 http://s1fnal-cvmfs.openhtc.io/cvmfs/grid.cern.ch DIRECT 1
2024-07-03 06:49:28 (47072): Guest Log: Probing /cvmfs/cernvm-prod.cern.ch... OK
2024-07-03 06:49:28 (47072): 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 06:49:28 (47072): Guest Log: 2.5.2.0 4138 0 25568 272 3 1 1123266 4096000 0 65024 0 0 n/a 0 0 http://s1cern-cvmfs.openhtc.io/cvmfs/cernvm-prod.cern.ch DIRECT 1
2024-07-03 06:49:28 (47072): Guest Log: Probing /cvmfs/alice.cern.ch... OK
2024-07-03 06:49:28 (47072): 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 06:49:28 (47072): Guest Log: 2.5.2.0 4072 0 40232 19049 3 1 1123266 4096000 0 65024 0 0 n/a 5551 4708 http://s1cern-cvmfs.openhtc.io/cvmfs/alice.cern.ch DIRECT 1
2024-07-03 06:49:28 (47072): Guest Log: 17:22:02 MST -07:00 2024-07-02: cranky: [INFO] Checking runc.
2024-07-03 06:49:28 (47072): Guest Log: 17:22:02 MST -07:00 2024-07-02: cranky: [INFO] Creating the filesystem.
2024-07-03 06:49:28 (47072): Guest Log: 17:22:02 MST -07:00 2024-07-02: cranky: [INFO] Using /cvmfs/cernvm-prod.cern.ch/cvm4
2024-07-03 06:49:28 (47072): Guest Log: 17:22:02 MST -07:00 2024-07-02: cranky: [INFO] Updating config.json.
2024-07-03 06:49:28 (47072): Guest Log: 17:22:02 MST -07:00 2024-07-02: cranky: [INFO] Running Container 'runc'.
2024-07-03 06:49:28 (47072): Guest Log: job: htmld=/shared/html/job
2024-07-03 06:49:28 (47072): Guest Log: job: unpack exitcode=0
2024-07-03 06:49:28 (47072): Guest Log: INFO: activated the work-around for ld:
2024-07-03 06:49:28 (47072): Guest Log: lrwxrwxrwx 1 0 0 15 Jul 3 00:22 /tmp/tmp.QqgegYJi4C/ld -> /usr/bin/ld.bfd
2024-07-03 06:49:28 (47072): Guest Log: 17:22:05 MST -07:00 2024-07-02: cranky: [INFO] ===> [runRivet] Wed Jul 3 00:22:04 UTC 2024 [boinc pp jets 7000 500 - pythia8 8.305 CP2-CR1 100000 274]
2024-07-03 06:49:28 (47072): Guest Log: 01:43:53.235134 timesync vgsvcTimeSyncWorker: Radical host time change: 40 591 608 000 000ns (HostNow=1 720 013 017 044 000 000 ns HostLast=1 719 972 425 436 000 000 ns)
2024-07-03 06:49:28 (47072): Starting VM using VBoxManage interface. (boinc_47560b18e7c82d21, slot#19)
2024-07-03 06:49:33 (47072): Successfully started VM. (PID = '42784')
2024-07-03 06:49:33 (47072): Reporting VM Process ID to BOINC.
2024-07-03 06:49:33 (47072): Guest Log: BIOS: VirtualBox 6.1.34
2024-07-03 06:49:33 (47072): Guest Log: CPUID EDX: 0x178bfbff
2024-07-03 06:49:33 (47072): Guest Log: BIOS: No PCI IDE controller, not probing IDE
2024-07-03 06:49:33 (47072): Guest Log: BIOS: AHCI 0-P#0: PCHS=16383/16/63 LCHS=1024/255/63 0x0000000002800000 sectors
2024-07-03 06:49:33 (47072): VM state change detected. (old = 'poweredoff', new = 'running')
2024-07-03 06:49:33 (47072): Detected: Web Application Enabled (http://localhost:63659)
2024-07-03 06:49:33 (47072): Status Report: Job Duration: '864000.000000'
2024-07-03 06:49:33 (47072): Status Report: Elapsed Time: '7461.747095'
2024-07-03 06:49:33 (47072): Status Report: CPU Time: '7109.671875'
2024-07-03 06:49:33 (47072): Preference change detected
2024-07-03 06:49:33 (47072): Setting CPU throttle for VM. (100%)
2024-07-03 06:49:33 (47072): Setting checkpoint interval to 600 seconds. (Higher value of (Preference: 60 seconds) or (Vbox_job.xml: 600 seconds))
2024-07-03 06:49:35 (47072): Guest Log: BIOS: Boot : bseqnr=1, bootseq=0032
2024-07-03 06:49:35 (47072): Guest Log: BIOS: Booting from Hard Disk...
2024-07-03 06:49:37 (47072): Guest Log: BIOS: KBD: unsupported int 16h function 03
2024-07-03 06:49:37 (47072): Guest Log: BIOS: AX=0305 BX=0000 CX=0000 DX=0000
2024-07-03 06:49:56 (47072): Guest Log: vgdrvHeartbeatInit: Setting up heartbeat to trigger every 2000 milliseconds
2024-07-03 06:49:56 (47072): Guest Log: vboxguest: misc device minor 56, IRQ 20, I/O port d020, MMIO at 00000000f0400000 (size 0x400000)
2024-07-03 06:50:01 (47072): Guest Log: VBoxService 5.2.6 r120293 (verbosity: 0) linux.amd64 (Jan 15 2018 14:51:00) release log
2024-07-03 06:50:01 (47072): Guest Log: 00:00:00.000101 main Log opened 2024-07-03T13:49:59.662915000Z
2024-07-03 06:50:01 (47072): Guest Log: 00:00:00.000799 main OS Product: Linux
2024-07-03 06:50:01 (47072): Guest Log: 00:00:00.000918 main OS Release: 4.14.76-13.cernvm.x86_64
2024-07-03 06:50:01 (47072): Guest Log: 00:00:00.000960 main OS Version: #1 SMP Tue Oct 16 18:26:15 CEST 2018
2024-07-03 06:50:01 (47072): Guest Log: 00:00:00.000989 main Executable: /usr/sbin/VBoxService
2024-07-03 06:50:01 (47072): Guest Log: 00:00:00.000990 main Process ID: 3222
2024-07-03 06:50:01 (47072): Guest Log: 00:00:00.000990 main Package type: LINUX_64BITS_GENERIC
2024-07-03 06:50:01 (47072): Guest Log: 00:00:00.014145 main 5.2.6 r120293 started. Verbose level = 0
2024-07-03 06:50:23 (47072): Guest Log: 06:50:21 MST -07:00 2024-07-03: cranky: [INFO] Detected Theory App
2024-07-03 06:50:23 (47072): Guest Log: 06:50:21 MST -07:00 2024-07-03: cranky: [INFO] Checking CVMFS.
2024-07-03 06:50:24 (47072): Guest Log: Probing /cvmfs/sft.cern.ch... OK
2024-07-03 06:50:24 (47072): 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 06:50:24 (47072): Guest Log: 2.5.2.0 4126 0 28200 29840 3 1 1151045 4096000 0 65024 0 0 n/a 5 9 http://s1cern-cvmfs.openhtc.io/cvmfs/sft.cern.ch DIRECT 1
2024-07-03 06:50:24 (47072): Guest Log: Probing /cvmfs/grid.cern.ch... OK
2024-07-03 06:50:24 (47072): 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 06:50:24 (47072): Guest Log: 2.5.2.0 4083 0 27704 24623 3 2 1151045 4096000 0 65024 0 2 0 5819 7175 http://s1unl-cvmfs.openhtc.io/cvmfs/grid.cern.ch DIRECT 1
2024-07-03 06:50:24 (47072): Guest Log: Probing /cvmfs/cernvm-prod.cern.ch... OK
2024-07-03 06:50:25 (47072): 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 06:50:25 (47072): Guest Log: 2.5.2.0 4061 0 27208 272 3 1 1151045 4096000 0 65024 0 0 n/a 0 0 http://s1cern-cvmfs.openhtc.io/cvmfs/cernvm-prod.cern.ch DIRECT 1
2024-07-03 06:50:25 (47072): Guest Log: Probing /cvmfs/alice.cern.ch... OK
2024-07-03 06:50:25 (47072): 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 06:50:25 (47072): Guest Log: 2.5.2.0 4105 0 39652 19053 3 1 1151045 4096000 0 65024 0 0 n/a 5555 3925 http://s1cern-cvmfs.openhtc.io/cvmfs/alice.cern.ch DIRECT 1
2024-07-03 06:50:25 (47072): Guest Log: 06:50:23 MST -07:00 2024-07-03: cranky: [INFO] Checking runc.
2024-07-03 06:50:25 (47072): Guest Log: 06:50:23 MST -07:00 2024-07-03: cranky: [INFO] Creating the filesystem.
2024-07-03 06:50:25 (47072): Guest Log: 06:50:23 MST -07:00 2024-07-03: cranky: [INFO] Using /cvmfs/cernvm-prod.cern.ch/cvm4
2024-07-03 06:50:25 (47072): Guest Log: 06:50:23 MST -07:00 2024-07-03: cranky: [INFO] Updating config.json.
2024-07-03 06:50:25 (47072): Guest Log: 06:50:23 MST -07:00 2024-07-03: cranky: [INFO] Running Container 'runc'.
2024-07-03 06:50:26 (47072): Guest Log: job: htmld=/shared/html/job
2024-07-03 06:50:26 (47072): Guest Log: job: unpack exitcode=0
2024-07-03 06:50:26 (47072): Guest Log: INFO: activated the work-around for ld:
2024-07-03 06:50:26 (47072): Guest Log: lrwxrwxrwx 1 0 0 15 Jul 3 13:50 /tmp/tmp.KQHbiYgXQ4/ld -> /usr/bin/ld.bfd
2024-07-03 06:50:27 (47072): Guest Log: 06:50:25 MST -07:00 2024-07-03: cranky: [INFO] ===> [runRivet] Wed Jul 3 13:50:24 UTC 2024 [boinc pp jets 7000 500 - pythia8 8.305 CP2-CR1 100000 274]
2024-07-03 06:51:26 (47072): Stopping VM.
2024-07-03 06:51:29 (47072): Successfully stopped VM.
2024-07-03 06:57:28 (31268): vboxwrapper version 26207
2024-07-03 06:57:28 (31268): BOINC client version: 7.20.2
2024-07-03 06:57:29 (31268): Detected: VirtualBox VboxManage Interface (Version: 6.1.34)
2024-07-03 06:57:29 (31268): Detected: Heartbeat check (file: 'heartbeat' every 1200.000000 seconds)
2024-07-03 06:57:29 (31268): Guest Log: BIOS: VirtualBox 6.1.34
2024-07-03 06:57:29 (31268): Guest Log: CPUID EDX: 0x178bfbff
2024-07-03 06:57:29 (31268): Guest Log: BIOS: No PCI IDE controller, not probing IDE
2024-07-03 06:57:29 (31268): Guest Log: BIOS: AHCI 0-P#0: PCHS=16383/16/63 LCHS=1024/255/63 0x0000000002800000 sectors
2024-07-03 06:57:29 (31268): Guest Log: BIOS: Boot : bseqnr=1, bootseq=0032
2024-07-03 06:57:29 (31268): Guest Log: BIOS: Booting from Hard Disk...
2024-07-03 06:57:29 (31268): Guest Log: BIOS: KBD: unsupported int 16h function 03
2024-07-03 06:57:29 (31268): Guest Log: BIOS: AX=0305 BX=0000 CX=0000 DX=0000
2024-07-03 06:57:29 (31268): Guest Log: vgdrvHeartbeatInit: Setting up heartbeat to trigger every 2000 milliseconds
2024-07-03 06:57:29 (31268): Guest Log: vboxguest: misc device minor 56, IRQ 20, I/O port d020, MMIO at 00000000f0400000 (size 0x400000)
2024-07-03 06:57:29 (31268): Guest Log: VBoxService 5.2.6 r120293 (verbosity: 0) linux.amd64 (Jan 15 2018 14:51:00) release log
2024-07-03 06:57:29 (31268): Guest Log: 00:00:00.000101 main Log opened 2024-07-03T13:49:59.662915000Z
2024-07-03 06:57:29 (31268): Guest Log: 00:00:00.000799 main OS Product: Linux
2024-07-03 06:57:29 (31268): Guest Log: 00:00:00.000918 main OS Release: 4.14.76-13.cernvm.x86_64
2024-07-03 06:57:29 (31268): Guest Log: 00:00:00.000960 main OS Version: #1 SMP Tue Oct 16 18:26:15 CEST 2018
2024-07-03 06:57:29 (31268): Guest Log: 00:00:00.000989 main Executable: /usr/sbin/VBoxService
2024-07-03 06:57:29 (31268): Guest Log: 00:00:00.000990 main Process ID: 3222
2024-07-03 06:57:29 (31268): Guest Log: 00:00:00.000990 main Package type: LINUX_64BITS_GENERIC
2024-07-03 06:57:29 (31268): Guest Log: 00:00:00.014145 main 5.2.6 r120293 started. Verbose level = 0
2024-07-03 06:57:29 (31268): Guest Log: 06:50:21 MST -07:00 2024-07-03: cranky: [INFO] Detected Theory App
2024-07-03 06:57:29 (31268): Guest Log: 06:50:21 MST -07:00 2024-07-03: cranky: [INFO] Checking CVMFS.
2024-07-03 06:57:29 (31268): Guest Log: Probing /cvmfs/sft.cern.ch... OK
2024-07-03 06:57:29 (31268): 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 06:57:29 (31268): Guest Log: 2.5.2.0 4126 0 28200 29840 3 1 1151045 4096000 0 65024 0 0 n/a 5 9 http://s1cern-cvmfs.openhtc.io/cvmfs/sft.cern.ch DIRECT 1
2024-07-03 06:57:29 (31268): Guest Log: Probing /cvmfs/grid.cern.ch... OK
2024-07-03 06:57:29 (31268): 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 06:57:29 (31268): Guest Log: 2.5.2.0 4083 0 27704 24623 3 2 1151045 4096000 0 65024 0 2 0 5819 7175 http://s1unl-cvmfs.openhtc.io/cvmfs/grid.cern.ch DIRECT 1
2024-07-03 06:57:29 (31268): Guest Log: Probing /cvmfs/cernvm-prod.cern.ch... OK
2024-07-03 06:57:29 (31268): 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 06:57:29 (31268): Guest Log: 2.5.2.0 4061 0 27208 272 3 1 1151045 4096000 0 65024 0 0 n/a 0 0 http://s1cern-cvmfs.openhtc.io/cvmfs/cernvm-prod.cern.ch DIRECT 1
2024-07-03 06:57:29 (31268): Guest Log: Probing /cvmfs/alice.cern.ch... OK
2024-07-03 06:57:29 (31268): 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 06:57:29 (31268): Guest Log: 2.5.2.0 4105 0 39652 19053 3 1 1151045 4096000 0 65024 0 0 n/a 5555 3925 http://s1cern-cvmfs.openhtc.io/cvmfs/alice.cern.ch DIRECT 1
2024-07-03 06:57:29 (31268): Guest Log: 06:50:23 MST -07:00 2024-07-03: cranky: [INFO] Checking runc.
2024-07-03 06:57:29 (31268): Guest Log: 06:50:23 MST -07:00 2024-07-03: cranky: [INFO] Creating the filesystem.
2024-07-03 06:57:29 (31268): Guest Log: 06:50:23 MST -07:00 2024-07-03: cranky: [INFO] Using /cvmfs/cernvm-prod.cern.ch/cvm4
2024-07-03 06:57:29 (31268): Guest Log: 06:50:23 MST -07:00 2024-07-03: cranky: [INFO] Updating config.json.
2024-07-03 06:57:29 (31268): Guest Log: 06:50:23 MST -07:00 2024-07-03: cranky: [INFO] Running Container 'runc'.
2024-07-03 06:57:29 (31268): Guest Log: job: htmld=/shared/html/job
2024-07-03 06:57:29 (31268): Guest Log: job: unpack exitcode=0
2024-07-03 06:57:29 (31268): Guest Log: INFO: activated the work-around for ld:
2024-07-03 06:57:29 (31268): Guest Log: lrwxrwxrwx 1 0 0 15 Jul 3 13:50 /tmp/tmp.KQHbiYgXQ4/ld -> /usr/bin/ld.bfd
2024-07-03 06:57:29 (31268): Guest Log: 06:50:25 MST -07:00 2024-07-03: cranky: [INFO] ===> [runRivet] Wed Jul 3 13:50:24 UTC 2024 [boinc pp jets 7000 500 - pythia8 8.305 CP2-CR1 100000 274]
2024-07-03 06:57:29 (31268): Starting VM using VBoxManage interface. (boinc_47560b18e7c82d21, slot#19)
2024-07-03 06:57:36 (31268): Successfully started VM. (PID = '39428')
2024-07-03 06:57:36 (31268): Reporting VM Process ID to BOINC.
2024-07-03 06:57:36 (31268): VM state change detected. (old = 'poweredoff', new = 'running')
2024-07-03 06:57:36 (31268): Detected: Web Application Enabled (http://localhost:63659)
2024-07-03 06:57:36 (31268): Status Report: Job Duration: '864000.000000'
2024-07-03 06:57:36 (31268): Status Report: Elapsed Time: '7574.747095'
2024-07-03 06:57:36 (31268): Status Report: CPU Time: '7186.812500'
2024-07-03 06:57:36 (31268): Preference change detected
2024-07-03 06:57:36 (31268): Setting CPU throttle for VM. (100%)
2024-07-03 06:57:37 (31268): Setting checkpoint interval to 600 seconds. (Higher value of (Preference: 60 seconds) or (Vbox_job.xml: 600 seconds))
2024-07-03 06:58:56 (31268): Stopping VM.
2024-07-03 06:58:58 (31268): Successfully stopped VM.
2024-07-03 07:02:37 (46496): vboxwrapper version 26207
2024-07-03 07:02:37 (46496): BOINC client version: 7.20.2
2024-07-03 07:02:38 (46496): Detected: VirtualBox VboxManage Interface (Version: 6.1.34)
2024-07-03 07:02:38 (46496): Detected: Heartbeat check (file: 'heartbeat' every 1200.000000 seconds)
2024-07-03 07:02:39 (46496): Starting VM using VBoxManage interface. (boinc_47560b18e7c82d21, slot#19)
2024-07-03 07:02:46 (46496): Successfully started VM. (PID = '6428')
2024-07-03 07:02:46 (46496): Reporting VM Process ID to BOINC.
2024-07-03 07:02:46 (46496): VM state change detected. (old = 'poweredoff', new = 'running')
2024-07-03 07:02:46 (46496): Detected: Web Application Enabled (http://localhost:63659)
2024-07-03 07:02:46 (46496): Status Report: Job Duration: '864000.000000'
2024-07-03 07:02:46 (46496): Status Report: Elapsed Time: '7653.747095'
2024-07-03 07:02:46 (46496): Status Report: CPU Time: '7261.796875'
2024-07-03 07:02:46 (46496): Preference change detected
2024-07-03 07:02:46 (46496): Setting CPU throttle for VM. (100%)
2024-07-03 07:02:47 (46496): Setting checkpoint interval to 600 seconds. (Higher value of (Preference: 60 seconds) or (Vbox_job.xml: 600 seconds))
2024-07-03 07:30:00 (46496): VM state change detected. (old = 'running', new = 'paused')
2024-07-03 07:30:06 (46496): Error in resume VM for VM: -182
Command:
VBoxManage -q controlvm "boinc_47560b18e7c82d21" resume
Output:
VBoxManage.exe: error: VM is paused due to host power management
VBoxManage.exe: error: Details: code VBOX_E_INVALID_VM_STATE (0x80bb0002), component ConsoleWrap, interface IConsole, callee IUnknown
VBoxManage.exe: error: Context: "Resume()" at line 410 of file VBoxManageControlVM.cpp
2024-07-03 07:30:06 (46496): Stopping VM.
2024-07-03 07:30:09 (46496): Successfully stopped VM.
2024-07-03 07:34:40 (47716): vboxwrapper version 26207
2024-07-03 07:34:40 (47716): BOINC client version: 7.20.2
2024-07-03 07:34:41 (47716): Detected: VirtualBox VboxManage Interface (Version: 6.1.34)
2024-07-03 07:34:41 (47716): Detected: Heartbeat check (file: 'heartbeat' every 1200.000000 seconds)
2024-07-03 07:34:42 (47716): ERROR: VM failed to start
2024-07-03 07:34:47 (47716):
BOINC will be notified that it needs to clean up the environment.
This is a temporary problem and so this job will be rescheduled for another time.
2024-07-03 07:52:41 (42604): vboxwrapper version 26207
2024-07-03 07:52:41 (42604): BOINC client version: 7.20.2
2024-07-03 07:52:42 (42604): Detected: VirtualBox VboxManage Interface (Version: 6.1.34)
2024-07-03 07:52:42 (42604): Detected: Heartbeat check (file: 'heartbeat' every 1200.000000 seconds)
2024-07-03 07:52:43 (42604): Starting VM using VBoxManage interface. (boinc_47560b18e7c82d21, slot#19)
2024-07-03 07:52:50 (42604): Successfully started VM. (PID = '43936')
2024-07-03 07:52:50 (42604): Reporting VM Process ID to BOINC.
2024-07-03 07:52:50 (42604): VM state change detected. (old = 'poweredoff', new = 'running')
2024-07-03 07:52:50 (42604): Detected: Web Application Enabled (http://localhost:63659)
2024-07-03 07:52:51 (42604): VM state change detected. (old = 'running', new = 'paused')
2024-07-03 07:52:59 (42604): Status Report: Job Duration: '864000.000000'
2024-07-03 07:52:59 (42604): Status Report: Elapsed Time: '9233.747095'
2024-07-03 07:52:59 (42604): Status Report: CPU Time: '8896.171875'
2024-07-03 07:52:59 (42604): Preference change detected
2024-07-03 07:52:59 (42604): Setting CPU throttle for VM. (100%)
2024-07-03 07:52:59 (42604): Setting checkpoint interval to 600 seconds. (Higher value of (Preference: 60 seconds) or (Vbox_job.xml: 600 seconds))
2024-07-03 07:52:59 (42604): VM state change detected. (old = 'paused', new = 'running')
2024-07-03 07:53:45 (42604): Stopping VM.
2024-07-03 07:53:50 (42604): Successfully stopped VM.
2024-07-03 08:35:16 (37728): vboxwrapper version 26207
2024-07-03 08:35:16 (37728): BOINC client version: 7.20.2
2024-07-03 08:35:17 (37728): Detected: VirtualBox VboxManage Interface (Version: 6.1.34)
2024-07-03 08:35:17 (37728): Detected: Heartbeat check (file: 'heartbeat' every 1200.000000 seconds)
2024-07-03 08:35:17 (37728): Starting VM using VBoxManage interface. (boinc_47560b18e7c82d21, slot#19)
2024-07-03 08:35:25 (37728): Successfully started VM. (PID = '47500')
2024-07-03 08:35:25 (37728): Reporting VM Process ID to BOINC.
2024-07-03 08:35:25 (37728): VM state change detected. (old = 'poweredoff', new = 'running')
2024-07-03 08:35:25 (37728): Detected: Web Application Enabled (http://localhost:63659)
2024-07-03 08:35:26 (37728): VM state change detected. (old = 'running', new = 'paused')
2024-07-03 08:35:32 (37728): Status Report: Job Duration: '864000.000000'
2024-07-03 08:35:32 (37728): Status Report: Elapsed Time: '9277.747095'
2024-07-03 08:35:32 (37728): Status Report: CPU Time: '8945.859375'
2024-07-03 08:35:32 (37728): Preference change detected
2024-07-03 08:35:32 (37728): Setting CPU throttle for VM. (100%)
2024-07-03 08:35:34 (37728): Setting checkpoint interval to 600 seconds. (Higher value of (Preference: 60 seconds) or (Vbox_job.xml: 600 seconds))
2024-07-03 08:35:34 (37728): VM state change detected. (old = 'paused', new = 'running')
2024-07-03 08:35:41 (37728): Guest Log: 00:31:00.960757 timesync vgsvcTimeSyncWorker: Radical host time change: 2 512 995 000 000ns (HostNow=1 720 020 940 407 000 000 ns HostLast=1 720 018 427 412 000 000 ns)
2024-07-03 08:35:51 (37728): Guest Log: 00:31:10.972287 timesync vgsvcTimeSyncWorker: Radical guest time change: 2 520 341 858 000ns (GuestNow=1 720 020 950 429 071 000 ns GuestLast=1 720 018 430 087 213 000 ns fSetTimeLastLoop=true )
2024-07-03 08:36:08 (37728): Stopping VM.
2024-07-03 08:36:11 (37728): Successfully stopped VM.
2024-07-03 08:40:24 (41776): vboxwrapper version 26207
2024-07-03 08:40:24 (41776): BOINC client version: 7.20.2
2024-07-03 08:40:25 (41776): Detected: VirtualBox VboxManage Interface (Version: 6.1.34)
2024-07-03 08:40:25 (41776): Detected: Heartbeat check (file: 'heartbeat' every 1200.000000 seconds)
2024-07-03 08:40:26 (41776): Guest Log: 00:31:00.960757 timesync vgsvcTimeSyncWorker: Radical host time change: 2 512 995 000 000ns (HostNow=1 720 020 940 407 000 000 ns HostLast=1 720 018 427 412 000 000 ns)
2024-07-03 08:40:26 (41776): Guest Log: 00:31:10.972287 timesync vgsvcTimeSyncWorker: Radical guest time change: 2 520 341 858 000ns (GuestNow=1 720 020 950 429 071 000 ns GuestLast=1 720 018 430 087 213 000 ns fSetTimeLastLoop=true )
2024-07-03 08:40:26 (41776): Starting VM using VBoxManage interface. (boinc_47560b18e7c82d21, slot#19)
2024-07-03 08:40:34 (41776): Successfully started VM. (PID = '44396')
2024-07-03 08:40:34 (41776): Reporting VM Process ID to BOINC.
2024-07-03 08:40:34 (41776): VM state change detected. (old = 'poweredoff', new = 'running')
2024-07-03 08:40:34 (41776): Detected: Web Application Enabled (http://localhost:63659)
2024-07-03 08:40:35 (41776): VM state change detected. (old = 'running', new = 'paused')
2024-07-03 08:40:45 (41776): Status Report: Job Duration: '864000.000000'
2024-07-03 08:40:45 (41776): Status Report: Elapsed Time: '9313.104095'
2024-07-03 08:40:45 (41776): Status Report: CPU Time: '8986.156250'
2024-07-03 08:40:45 (41776): Preference change detected
2024-07-03 08:40:45 (41776): Setting CPU throttle for VM. (100%)
2024-07-03 08:40:45 (41776): Setting checkpoint interval to 600 seconds. (Higher value of (Preference: 60 seconds) or (Vbox_job.xml: 600 seconds))
2024-07-03 08:40:45 (41776): VM state change detected. (old = 'paused', new = 'running')
2024-07-03 08:48:59 (41776): Stopping VM.
2024-07-03 08:49:03 (41776): Successfully stopped VM.
2024-07-03 08:54:26 (33680): vboxwrapper version 26207
2024-07-03 08:54:26 (33680): BOINC client version: 7.20.2
2024-07-03 08:54:27 (33680): Detected: VirtualBox VboxManage Interface (Version: 6.1.34)
2024-07-03 08:54:27 (33680): Detected: Heartbeat check (file: 'heartbeat' every 1200.000000 seconds)
2024-07-03 08:54:28 (33680): Starting VM using VBoxManage interface. (boinc_47560b18e7c82d21, slot#19)
2024-07-03 08:54:36 (33680): Successfully started VM. (PID = '37728')
2024-07-03 08:54:36 (33680): Reporting VM Process ID to BOINC.
2024-07-03 08:54:36 (33680): VM state change detected. (old = 'poweredoff', new = 'running')
2024-07-03 08:54:36 (33680): Detected: Web Application Enabled (http://localhost:63659)
2024-07-03 08:54:36 (33680): Status Report: Job Duration: '864000.000000'
2024-07-03 08:54:36 (33680): Status Report: Elapsed Time: '9801.104095'
2024-07-03 08:54:36 (33680): Status Report: CPU Time: '9477.468750'
2024-07-03 08:54:36 (33680): Preference change detected
2024-07-03 08:54:36 (33680): Setting CPU throttle for VM. (100%)
2024-07-03 08:54:37 (33680): Setting checkpoint interval to 600 seconds. (Higher value of (Preference: 60 seconds) or (Vbox_job.xml: 600 seconds))
2024-07-03 08:55:25 (33680): Stopping VM.
2024-07-03 08:55:29 (33680): Successfully stopped VM.
2024-07-03 08:59:35 (41888): vboxwrapper version 26207
2024-07-03 08:59:35 (41888): BOINC client version: 7.20.2
2024-07-03 08:59:36 (41888): Detected: VirtualBox VboxManage Interface (Version: 6.1.34)
2024-07-03 08:59:37 (41888): Detected: Heartbeat check (file: 'heartbeat' every 1200.000000 seconds)
2024-07-03 08:59:37 (41888): Starting VM using VBoxManage interface. (boinc_47560b18e7c82d21, slot#19)
2024-07-03 08:59:44 (41888): Successfully started VM. (PID = '46580')
2024-07-03 08:59:44 (41888): Reporting VM Process ID to BOINC.
2024-07-03 08:59:44 (41888): VM state change detected. (old = 'poweredoff', new = 'running')
2024-07-03 08:59:44 (41888): Detected: Web Application Enabled (http://localhost:63659)
2024-07-03 08:59:46 (41888): VM state change detected. (old = 'running', new = 'paused')
2024-07-03 08:59:50 (41888): Status Report: Job Duration: '864000.000000'
2024-07-03 08:59:50 (41888): Status Report: Elapsed Time: '9850.240161'
2024-07-03 08:59:50 (41888): Status Report: CPU Time: '9523.218750'
2024-07-03 08:59:50 (41888): Preference change detected
2024-07-03 08:59:50 (41888): Setting CPU throttle for VM. (100%)
2024-07-03 08:59:51 (41888): Setting checkpoint interval to 600 seconds. (Higher value of (Preference: 60 seconds) or (Vbox_job.xml: 600 seconds))
2024-07-03 08:59:51 (41888): VM state change detected. (old = 'paused', new = 'running')
2024-07-03 09:01:42 (41888): Stopping VM.
2024-07-03 09:01:47 (41888): Successfully stopped VM.
2024-07-03 09:05:00 (24524): vboxwrapper version 26207
2024-07-03 09:05:00 (24524): BOINC client version: 7.20.2
2024-07-03 09:05:00 (24524): Detected: VirtualBox VboxManage Interface (Version: 6.1.34)
2024-07-03 09:05:01 (24524): Detected: Heartbeat check (file: 'heartbeat' every 1200.000000 seconds)
2024-07-03 09:05:01 (24524): Starting VM using VBoxManage interface. (boinc_47560b18e7c82d21, slot#19)
2024-07-03 09:05:09 (24524): Successfully started VM. (PID = '32724')
2024-07-03 09:05:09 (24524): Reporting VM Process ID to BOINC.
2024-07-03 09:05:09 (24524): VM state change detected. (old = 'poweredoff', new = 'running')
2024-07-03 09:05:09 (24524): Detected: Web Application Enabled (http://localhost:63659)
2024-07-03 09:05:09 (24524): Status Report: Job Duration: '864000.000000'
2024-07-03 09:05:09 (24524): Status Report: Elapsed Time: '9960.653922'
2024-07-03 09:05:09 (24524): Status Report: CPU Time: '9636.000000'
2024-07-03 09:05:09 (24524): Preference change detected
2024-07-03 09:05:09 (24524): Setting CPU throttle for VM. (100%)
2024-07-03 09:05:10 (24524): Setting checkpoint interval to 600 seconds. (Higher value of (Preference: 60 seconds) or (Vbox_job.xml: 600 seconds))
2024-07-03 09:07:01 (24524): Stopping VM.
2024-07-03 09:07:05 (24524): Successfully stopped VM.
2024-07-03 10:19:30 (46152): vboxwrapper version 26207
2024-07-03 10:19:30 (46152): BOINC client version: 7.20.2
2024-07-03 10:19:31 (46152): Detected: VirtualBox VboxManage Interface (Version: 6.1.34)
2024-07-03 10:19:31 (46152): Detected: Heartbeat check (file: 'heartbeat' every 1200.000000 seconds)
2024-07-03 10:19:32 (46152): Starting VM using VBoxManage interface. (boinc_47560b18e7c82d21, slot#19)
2024-07-03 10:19:40 (46152): Successfully started VM. (PID = '41908')
2024-07-03 10:19:40 (46152): Reporting VM Process ID to BOINC.
2024-07-03 10:19:40 (46152): VM state change detected. (old = 'poweredoff', new = 'running')
2024-07-03 10:19:40 (46152): Detected: Web Application Enabled (http://localhost:63659)
2024-07-03 10:19:42 (46152): VM state change detected. (old = 'running', new = 'paused')
2024-07-03 10:19:48 (46152): Status Report: Job Duration: '864000.000000'
2024-07-03 10:19:48 (46152): Status Report: Elapsed Time: '10072.251637'
2024-07-03 10:19:48 (46152): Status Report: CPU Time: '9751.421875'
2024-07-03 10:19:48 (46152): Preference change detected
2024-07-03 10:19:48 (46152): Setting CPU throttle for VM. (100%)
2024-07-03 10:19:50 (46152): Setting checkpoint interval to 600 seconds. (Higher value of (Preference: 60 seconds) or (Vbox_job.xml: 600 seconds))
2024-07-03 10:19:50 (46152): VM state change detected. (old = 'paused', new = 'running')
2024-07-03 10:19:56 (46152): Guest Log: 00:44:41.305517 timesync vgsvcTimeSyncWorker: Radical host time change: 4 373 146 000 000ns (HostNow=1 720 027 195 575 000 000 ns HostLast=1 720 022 822 429 000 000 ns)
2024-07-03 10:20:06 (46152): Guest Log: 00:44:51.308444 timesync vgsvcTimeSyncWorker: Radical guest time change: 4 373 141 972 000ns (GuestNow=1 720 027 205 577 936 000 ns GuestLast=1 720 022 832 435 964 000 ns fSetTimeLastLoop=true )
2024-07-03 10:21:08 (46152): Stopping VM.
2024-07-03 10:21:12 (46152): Successfully stopped VM.
2024-07-03 10:24:40 (17176): vboxwrapper version 26207
2024-07-03 10:24:40 (17176): BOINC client version: 7.20.2
2024-07-03 10:24:40 (17176): Detected: VirtualBox VboxManage Interface (Version: 6.1.34)
2024-07-03 10:24:41 (17176): Detected: Heartbeat check (file: 'heartbeat' every 1200.000000 seconds)
2024-07-03 10:24:41 (17176): Guest Log: 00:44:41.305517 timesync vgsvcTimeSyncWorker: Radical host time change: 4 373 146 000 000ns (HostNow=1 720 027 195 575 000 000 ns HostLast=1 720 022 822 429 000 000 ns)
2024-07-03 10:24:41 (17176): Guest Log: 00:44:51.308444 timesync vgsvcTimeSyncWorker: Radical guest time change: 4 373 141 972 000ns (GuestNow=1 720 027 205 577 936 000 ns GuestLast=1 720 022 832 435 964 000 ns fSetTimeLastLoop=true )
2024-07-03 10:24:41 (17176): Starting VM using VBoxManage interface. (boinc_47560b18e7c82d21, slot#19)
2024-07-03 10:24:49 (17176): Successfully started VM. (PID = '42108')
2024-07-03 10:24:49 (17176): Reporting VM Process ID to BOINC.
2024-07-03 10:24:49 (17176): VM state change detected. (old = 'poweredoff', new = 'running')
2024-07-03 10:24:49 (17176): Detected: Web Application Enabled (http://localhost:63659)
2024-07-03 10:24:51 (17176): VM state change detected. (old = 'running', new = 'paused')
2024-07-03 10:25:00 (17176): Status Report: Job Duration: '864000.000000'
2024-07-03 10:25:00 (17176): Status Report: Elapsed Time: '10151.728325'
2024-07-03 10:25:00 (17176): Status Report: CPU Time: '9832.343750'
2024-07-03 10:25:00 (17176): Preference change detected
2024-07-03 10:25:00 (17176): Setting CPU throttle for VM. (100%)
2024-07-03 10:25:01 (17176): Setting checkpoint interval to 600 seconds. (Higher value of (Preference: 60 seconds) or (Vbox_job.xml: 600 seconds))
2024-07-03 10:25:02 (17176): VM state change detected. (old = 'paused', new = 'running')
2024-07-03 10:26:41 (17176): Stopping VM.
2024-07-03 10:26:46 (17176): Successfully stopped VM.
2024-07-03 10:30:13 (43884): vboxwrapper version 26207
2024-07-03 10:30:13 (43884): BOINC client version: 7.20.2
2024-07-03 10:30:14 (43884): Detected: VirtualBox VboxManage Interface (Version: 6.1.34)
2024-07-03 10:30:14 (43884): Detected: Heartbeat check (file: 'heartbeat' every 1200.000000 seconds)
2024-07-03 10:30:15 (43884): Starting VM using VBoxManage interface. (boinc_47560b18e7c82d21, slot#19)
2024-07-03 10:30:23 (43884): Successfully started VM. (PID = '30724')
2024-07-03 10:30:23 (43884): Reporting VM Process ID to BOINC.
2024-07-03 10:30:23 (43884): VM state change detected. (old = 'poweredoff', new = 'running')
2024-07-03 10:30:23 (43884): Detected: Web Application Enabled (http://localhost:63659)
2024-07-03 10:30:23 (43884): Stopping VM.
2024-07-03 10:30:27 (43884): Successfully stopped VM.
2024-07-03 10:41:01 (45580): vboxwrapper version 26207
2024-07-03 10:41:01 (45580): BOINC client version: 7.20.2
2024-07-03 10:41:02 (45580): Detected: VirtualBox VboxManage Interface (Version: 6.1.34)
2024-07-03 10:41:02 (45580): Detected: Heartbeat check (file: 'heartbeat' every 1200.000000 seconds)
2024-07-03 10:41:02 (45580): Starting VM using VBoxManage interface. (boinc_47560b18e7c82d21, slot#19)
2024-07-03 10:41:10 (45580): Successfully started VM. (PID = '35428')
2024-07-03 10:41:10 (45580): Reporting VM Process ID to BOINC.
2024-07-03 10:41:10 (45580): VM state change detected. (old = 'poweredoff', new = 'running')
2024-07-03 10:41:10 (45580): Detected: Web Application Enabled (http://localhost:63659)
2024-07-03 10:41:10 (45580): Status Report: Job Duration: '864000.000000'
2024-07-03 10:41:10 (45580): Status Report: Elapsed Time: '10250.668617'
2024-07-03 10:41:10 (45580): Status Report: CPU Time: '9929.437500'
2024-07-03 10:41:10 (45580): Preference change detected
2024-07-03 10:41:10 (45580): Setting CPU throttle for VM. (100%)
2024-07-03 10:41:12 (45580): Setting checkpoint interval to 600 seconds. (Higher value of (Preference: 60 seconds) or (Vbox_job.xml: 600 seconds))
2024-07-03 10:42:14 (45580): Stopping VM.
2024-07-03 10:42:39 (45580): Successfully stopped VM.
2024-07-03 10:45:13 (46340): vboxwrapper version 26207
2024-07-03 10:45:13 (46340): BOINC client version: 7.20.2
2024-07-03 10:45:14 (46340): Detected: VirtualBox VboxManage Interface (Version: 6.1.34)
2024-07-03 10:45:14 (46340): Detected: Heartbeat check (file: 'heartbeat' every 1200.000000 seconds)
2024-07-03 10:45:14 (46340): Starting VM using VBoxManage interface. (boinc_47560b18e7c82d21, slot#19)
2024-07-03 10:45:23 (46340): Successfully started VM. (PID = '39744')
2024-07-03 10:45:23 (46340): Reporting VM Process ID to BOINC.
2024-07-03 10:45:23 (46340): VM state change detected. (old = 'poweredoff', new = 'running')
2024-07-03 10:45:23 (46340): Detected: Web Application Enabled (http://localhost:63659)
2024-07-03 10:45:23 (46340): Status Report: Job Duration: '864000.000000'
2024-07-03 10:45:23 (46340): Status Report: Elapsed Time: '10294.483515'
2024-07-03 10:45:23 (46340): Status Report: CPU Time: '9993.109375'
2024-07-03 10:45:23 (46340): Preference change detected
2024-07-03 10:45:23 (46340): Setting CPU throttle for VM. (100%)
2024-07-03 10:45:37 (46340): Setting checkpoint interval to 600 seconds. (Higher value of (Preference: 60 seconds) or (Vbox_job.xml: 600 seconds))
2024-07-03 11:21:23 (46340): Stopping VM.
2024-07-03 11:21:28 (46340): Successfully stopped VM.
2024-07-03 11:25:22 (47776): vboxwrapper version 26207
2024-07-03 11:25:22 (47776): BOINC client version: 7.20.2
2024-07-03 11:25:22 (47776): Detected: VirtualBox VboxManage Interface (Version: 6.1.34)
2024-07-03 11:25:22 (47776): Detected: Heartbeat check (file: 'heartbeat' every 1200.000000 seconds)
2024-07-03 11:25:23 (47776): Starting VM using VBoxManage interface. (boinc_47560b18e7c82d21, slot#19)
2024-07-03 11:25:31 (47776): Successfully started VM. (PID = '33464')
2024-07-03 11:25:31 (47776): Reporting VM Process ID to BOINC.
2024-07-03 11:25:31 (47776): VM state change detected. (old = 'poweredoff', new = 'running')
2024-07-03 11:25:31 (47776): Detected: Web Application Enabled (http://localhost:63659)
2024-07-03 11:25:31 (47776): Status Report: Job Duration: '864000.000000'
2024-07-03 11:25:31 (47776): Status Report: Elapsed Time: '12439.284857'
2024-07-03 11:25:31 (47776): Status Report: CPU Time: '12151.421875'
2024-07-03 11:25:31 (47776): Preference change detected
2024-07-03 11:25:31 (47776): Setting CPU throttle for VM. (100%)
2024-07-03 11:25:32 (47776): Setting checkpoint interval to 600 seconds. (Higher value of (Preference: 60 seconds) or (Vbox_job.xml: 600 seconds))
2024-07-03 11:25:33 (47776): VM state change detected. (old = 'running', new = 'paused')
2024-07-03 11:25:43 (47776): VM state change detected. (old = 'paused', new = 'running')
2024-07-03 11:26:55 (47776): Stopping VM.
2024-07-03 11:26:58 (47776): Successfully stopped VM.
2024-07-03 11:40:53 (18244): vboxwrapper version 26207
2024-07-03 11:40:53 (18244): BOINC client version: 7.20.2
2024-07-03 11:40:54 (18244): Detected: VirtualBox VboxManage Interface (Version: 6.1.34)
2024-07-03 11:40:54 (18244): Detected: Heartbeat check (file: 'heartbeat' every 1200.000000 seconds)
2024-07-03 11:40:54 (18244): Starting VM using VBoxManage interface. (boinc_47560b18e7c82d21, slot#19)
2024-07-03 11:41:02 (18244): Successfully started VM. (PID = '39432')
2024-07-03 11:41:02 (18244): Reporting VM Process ID to BOINC.
2024-07-03 11:41:02 (18244): VM state change detected. (old = 'poweredoff', new = 'running')
2024-07-03 11:41:02 (18244): Detected: Web Application Enabled (http://localhost:63659)
2024-07-03 11:41:04 (18244): VM state change detected. (old = 'running', new = 'paused')
2024-07-03 11:41:10 (18244): Status Report: Job Duration: '864000.000000'
2024-07-03 11:41:10 (18244): Status Report: Elapsed Time: '12512.284857'
2024-07-03 11:41:10 (18244): Status Report: CPU Time: '12226.703125'
2024-07-03 11:41:10 (18244): Preference change detected
2024-07-03 11:41:10 (18244): Setting CPU throttle for VM. (100%)
2024-07-03 11:41:10 (18244): Setting checkpoint interval to 600 seconds. (Higher value of (Preference: 60 seconds) or (Vbox_job.xml: 600 seconds))
2024-07-03 11:41:11 (18244): VM state change detected. (old = 'paused', new = 'running')
2024-07-03 11:58:37 (18244): Guest Log: job: run exitcode=0
2024-07-03 11:58:37 (18244): Guest Log: job: diskusage=3916
2024-07-03 11:58:37 (18244): Guest Log: job: logsize=76 k
2024-07-03 11:58:37 (18244): Guest Log: job: times=
2024-07-03 11:58:37 (18244): Guest Log: 0m0.000s 0m0.009s
2024-07-03 11:58:37 (18244): Guest Log: 102m0.316s 0m46.201s
2024-07-03 11:58:37 (18244): Guest Log: job: cpuusage=6167
2024-07-03 11:58:37 (18244): Guest Log: 11:58:36 MST -07:00 2024-07-03: cranky: [INFO] Container 'runc' finished with status code 0.
2024-07-03 11:58:37 (18244): Guest Log: 11:58:36 MST -07:00 2024-07-03: cranky: [INFO] Preparing output.
2024-07-03 11:58:37 (18244): Guest Log: [INFO] Job Finished
2024-07-03 11:58:37 (18244): Guest Log: [INFO] Shutting Down.
2024-07-03 11:58:37 (18244): VM Completion File Detected.
2024-07-03 11:58:37 (18244): VM Completion Message: Job Finished
.
2024-07-03 11:58:37 (18244): Powering off VM.
2024-07-03 11:58:37 (18244): Successfully stopped VM.
2024-07-03 11:58:37 (18244): Deregistering VM. (boinc_47560b18e7c82d21, slot#19)
2024-07-03 11:58:37 (18244): Removing network bandwidth throttle group from VM.
2024-07-03 11:58:38 (18244): Removing VM from VirtualBox.
2024-07-03 11:58:43 (18244): called boinc_finish(0)
</stderr_txt>
]]>
©2024 CERN