Name Theory_2743-2780408-231_2
Workunit 223510087
Created 9 Jun 2024, 19:08:39 UTC
Sent 10 Jun 2024, 11:11:30 UTC
Report deadline 21 Jun 2024, 11:11:30 UTC
Received 21 Jun 2024, 11:03:23 UTC
Server state Over
Outcome Success
Client state Done
Exit status 0 (0x00000000)
Computer ID 10844384
Run time 55 min 42 sec
CPU time 17 min 29 sec
Validate state Valid
Credit 40.92
Device peak FLOPS 5.29 GFLOPS
Application version Theory Simulation v300.30 (vbox64_theory)
windows_x86_64
Peak working set size 87.60 MB
Peak swap size 101.34 MB
Peak disk usage 1.41 GB

Stderr output

<core_client_version>8.0.2</core_client_version>
<![CDATA[
<stderr_txt>
2024-06-14 10:02:08 (31176): vboxwrapper version 26207
2024-06-14 10:02:08 (31176): BOINC client version: 8.0.2
2024-06-14 10:02:08 (31176): Detected: VirtualBox VboxManage Interface (Version: 7.0.14)
2024-06-14 10:02:09 (31176): Detected: Heartbeat check (file: 'heartbeat' every 1200.000000 seconds)
2024-06-14 10:02:09 (31176): Successfully copied 'init_data.xml' to the shared directory.
2024-06-14 10:02:09 (31176): Successfully copied 'input' to the shared directory.
2024-06-14 10:02:09 (31176): Create VM. (boinc_30e5b259864af2b3, slot#7)
2024-06-14 10:02:09 (31176): Setting Memory Size for VM. (630MB)
2024-06-14 10:02:10 (31176): Setting CPU Count for VM. (1)
2024-06-14 10:02:10 (31176): Setting Chipset Options for VM.
2024-06-14 10:02:10 (31176): Setting Graphics Controller Options for VM.
2024-06-14 10:02:10 (31176): Setting Boot Options for VM.
2024-06-14 10:02:11 (31176): Setting Network Configuration for NAT.
2024-06-14 10:02:11 (31176): Enabling VM Network Access.
2024-06-14 10:02:11 (31176): Disabling USB Support for VM.
2024-06-14 10:02:12 (31176): Disabling COM Port Support for VM.
2024-06-14 10:02:12 (31176): Disabling LPT Port Support for VM.
2024-06-14 10:02:12 (31176): Disabling Audio Support for VM.
2024-06-14 10:02:12 (31176): Disabling Clipboard Support for VM.
2024-06-14 10:02:13 (31176): Disabling Drag and Drop Support for VM.
2024-06-14 10:02:13 (31176): Adding storage controller(s) to VM.
2024-06-14 10:02:13 (31176): Adding virtual disk drive to VM. (Theory_2024_04_30_prod.vdi)
2024-06-14 10:02:14 (31176): Adding VirtualBox Guest Additions to VM.
2024-06-14 10:02:14 (31176): Adding network bandwidth throttle group to VM. (Defaulting to 1024GB)
2024-06-14 10:02:14 (31176): forwarding host port 63722 to guest port 80
2024-06-14 10:02:14 (31176): Enabling remote desktop for VM.
2024-06-14 10:02:15 (31176): Enabling shared directory for VM.
2024-06-14 10:02:16 (31176): Starting VM using VBoxManage interface. (boinc_30e5b259864af2b3, slot#7)
2024-06-14 10:02:22 (31176): Successfully started VM. (PID = '39072')
2024-06-14 10:02:22 (31176): Reporting VM Process ID to BOINC.
2024-06-14 10:02:22 (31176): Guest Log: BIOS: VirtualBox 7.0.14
2024-06-14 10:02:22 (31176): Guest Log: CPUID EDX: 0x178bfbff
2024-06-14 10:02:22 (31176): Guest Log: BIOS: No PCI IDE controller, not probing IDE
2024-06-14 10:02:22 (31176): Guest Log: BIOS: AHCI 0-P#0: PCHS=16383/16/63 LCHS=1024/255/63 0x0000000002800000 sectors
2024-06-14 10:02:22 (31176): VM state change detected. (old = 'poweredoff', new = 'running')
2024-06-14 10:02:22 (31176): Detected: Web Application Enabled (http://localhost:63722)
2024-06-14 10:02:22 (31176): Detected: Remote Desktop Enabled (localhost:63727)
2024-06-14 10:02:22 (31176): Preference change detected
2024-06-14 10:02:22 (31176): Setting CPU throttle for VM. (80%)
2024-06-14 10:02:22 (31176): Setting checkpoint interval to 600 seconds. (Higher value of (Preference: 60 seconds) or (Vbox_job.xml: 600 seconds))
2024-06-14 10:02:24 (31176): Guest Log: BIOS: Boot : bseqnr=1, bootseq=0032
2024-06-14 10:02:24 (31176): Guest Log: BIOS: Booting from Hard Disk...
2024-06-14 10:02:27 (31176): Guest Log: BIOS: KBD: unsupported int 16h function 03
2024-06-14 10:02:27 (31176): Guest Log: BIOS: AX=0305 BX=0000 CX=0000 DX=0000 
2024-06-14 10:02:47 (31176): Guest Log: vgdrvHeartbeatInit: Setting up heartbeat to trigger every 2000 milliseconds
2024-06-14 10:02:47 (31176): Guest Log: vboxguest: misc device minor 56, IRQ 20, I/O port d020, MMIO at 00000000f0400000 (size 0x400000)
2024-06-14 10:02:52 (31176): Guest Log: VBoxService 5.2.6 r120293 (verbosity: 0) linux.amd64 (Jan 15 2018 14:51:00) release log
2024-06-14 10:02:52 (31176): Guest Log: 00:00:00.000158 main     Log opened 2024-06-14T08:02:52.010745000Z
2024-06-14 10:02:52 (31176): Guest Log: 00:00:00.000402 main     OS Product: Linux
2024-06-14 10:02:52 (31176): Guest Log: 00:00:00.000426 main     OS Release: 4.14.76-13.cernvm.x86_64
2024-06-14 10:02:52 (31176): Guest Log: 00:00:00.000444 main     OS Version: #1 SMP Tue Oct 16 18:26:15 CEST 2018
2024-06-14 10:02:52 (31176): Guest Log: 00:00:00.000463 main     Executable: /usr/sbin/VBoxService
2024-06-14 10:02:52 (31176): Guest Log: 00:00:00.000464 main     Process ID: 3225
2024-06-14 10:02:52 (31176): Guest Log: 00:00:00.000464 main     Package type: LINUX_64BITS_GENERIC
2024-06-14 10:02:52 (31176): Guest Log: 00:00:00.003037 main     5.2.6 r120293 started. Verbose level = 0
2024-06-14 10:03:18 (31176): Guest Log: 10:03:18 CEST +02:00 2024-06-14: cranky: [INFO] Detected Theory App
2024-06-14 10:03:18 (31176): Guest Log: 10:03:18 CEST +02:00 2024-06-14: cranky: [INFO] Checking CVMFS.
2024-06-14 10:03:19 (31176): Guest Log: Probing /cvmfs/sft.cern.ch... OK
2024-06-14 10:03:19 (31176): 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-06-14 10:03:19 (31176): Guest Log: 2.5.2.0 4053 0 28384 29590 3 1 272103 4096000 0 65024 0 0 n/a 5 4 http://s1cern-cvmfs.openhtc.io/cvmfs/sft.cern.ch DIRECT 1
2024-06-14 10:03:20 (31176): Guest Log: Probing /cvmfs/grid.cern.ch... OK
2024-06-14 10:03:20 (31176): 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-06-14 10:03:20 (31176): Guest Log: 2.5.2.0 4102 0 27552 24465 3 2 272103 4096000 0 65024 0 2 -100 7960 981 http://s1bnl-cvmfs.openhtc.io/cvmfs/grid.cern.ch DIRECT 1
2024-06-14 10:03:21 (31176): Guest Log: Probing /cvmfs/cernvm-prod.cern.ch... OK
2024-06-14 10:03:21 (31176): 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-06-14 10:03:21 (31176): Guest Log: 2.5.2.0 4124 0 27192 272 3 1 272103 4096000 0 65024 0 0 n/a 4 3 http://s1cern-cvmfs.openhtc.io/cvmfs/cernvm-prod.cern.ch DIRECT 1
2024-06-14 10:03:22 (31176): Guest Log: Probing /cvmfs/alice.cern.ch... OK
2024-06-14 10:03:23 (31176): 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-06-14 10:03:23 (31176): Guest Log: 2.5.2.0 4078 0 41720 18892 3 1 272103 4096000 0 65024 0 0 n/a 5425 1330 http://s1cern-cvmfs.openhtc.io/cvmfs/alice.cern.ch DIRECT 1
2024-06-14 10:03:23 (31176): Guest Log: 10:03:23 CEST +02:00 2024-06-14: cranky: [INFO] Checking runc.
2024-06-14 10:03:23 (31176): Guest Log: 10:03:23 CEST +02:00 2024-06-14: cranky: [INFO] Creating the filesystem.
2024-06-14 10:03:23 (31176): Guest Log: 10:03:23 CEST +02:00 2024-06-14: cranky: [INFO] Using /cvmfs/cernvm-prod.cern.ch/cvm4
2024-06-14 10:03:23 (31176): Guest Log: 10:03:23 CEST +02:00 2024-06-14: cranky: [INFO] Updating config.json.
2024-06-14 10:03:23 (31176): Guest Log: 10:03:23 CEST +02:00 2024-06-14: cranky: [INFO] Running Container 'runc'.
2024-06-14 10:03:31 (31176): Guest Log: job: htmld=/shared/html/job
2024-06-14 10:03:32 (31176): Guest Log: job: unpack exitcode=0
2024-06-14 10:03:33 (31176): Guest Log: INFO: activated the work-around for ld:
2024-06-14 10:03:33 (31176): Guest Log: lrwxrwxrwx 1 0 0 15 Jun 14 08:03 /tmp/tmp.DliWSLF0Ob/ld -> /usr/bin/ld.bfd
2024-06-14 10:03:33 (31176): Guest Log: 10:03:33 CEST +02:00 2024-06-14: cranky: [INFO] ===> [runRivet] Fri Jun 14 08:03:33 UTC 2024 [boinc pp jets 7000 500 - pythia8 8.308 CP1-CR2 100000 231]
2024-06-14 10:04:56 (31176): VM state change detected. (old = 'running', new = 'paused')
2024-06-14 10:05:17 (31176): VM state change detected. (old = 'paused', new = 'running')
2024-06-14 10:09:18 (31176): VM state change detected. (old = 'running', new = 'paused')
2024-06-14 10:09:38 (31176): VM state change detected. (old = 'paused', new = 'running')
2024-06-14 10:09:48 (31176): VM state change detected. (old = 'running', new = 'paused')
2024-06-14 10:10:08 (31176): VM state change detected. (old = 'paused', new = 'running')
2024-06-14 10:10:18 (31176): VM state change detected. (old = 'running', new = 'paused')
2024-06-14 10:10:38 (31176): VM state change detected. (old = 'paused', new = 'running')
2024-06-14 10:10:48 (31176): VM state change detected. (old = 'running', new = 'paused')
2024-06-14 10:11:08 (31176): VM state change detected. (old = 'paused', new = 'running')
2024-06-14 10:11:19 (31176): VM state change detected. (old = 'running', new = 'paused')
2024-06-14 10:11:39 (31176): VM state change detected. (old = 'paused', new = 'running')
2024-06-14 10:11:49 (31176): VM state change detected. (old = 'running', new = 'paused')
2024-06-14 10:12:09 (31176): VM state change detected. (old = 'paused', new = 'running')
2024-06-14 10:12:19 (31176): VM state change detected. (old = 'running', new = 'paused')
2024-06-14 10:12:39 (31176): VM state change detected. (old = 'paused', new = 'running')
2024-06-14 10:12:49 (31176): VM state change detected. (old = 'running', new = 'paused')
2024-06-14 10:13:09 (31176): VM state change detected. (old = 'paused', new = 'running')
2024-06-14 10:13:19 (31176): VM state change detected. (old = 'running', new = 'paused')
2024-06-14 10:13:39 (31176): VM state change detected. (old = 'paused', new = 'running')
2024-06-14 10:13:49 (31176): VM state change detected. (old = 'running', new = 'paused')
2024-06-14 10:14:10 (31176): VM state change detected. (old = 'paused', new = 'running')
2024-06-14 10:14:20 (31176): VM state change detected. (old = 'running', new = 'paused')
2024-06-14 10:14:40 (31176): VM state change detected. (old = 'paused', new = 'running')
2024-06-14 10:14:50 (31176): VM state change detected. (old = 'running', new = 'paused')
2024-06-14 10:15:10 (31176): VM state change detected. (old = 'paused', new = 'running')
2024-06-14 10:15:20 (31176): VM state change detected. (old = 'running', new = 'paused')
2024-06-14 10:15:40 (31176): VM state change detected. (old = 'paused', new = 'running')
2024-06-14 10:15:50 (31176): VM state change detected. (old = 'running', new = 'paused')
2024-06-14 10:16:10 (31176): VM state change detected. (old = 'paused', new = 'running')
2024-06-14 10:16:20 (31176): VM state change detected. (old = 'running', new = 'paused')
2024-06-14 10:16:40 (31176): VM state change detected. (old = 'paused', new = 'running')
2024-06-14 10:16:51 (31176): VM state change detected. (old = 'running', new = 'paused')
2024-06-14 10:17:11 (31176): VM state change detected. (old = 'paused', new = 'running')
2024-06-14 10:17:21 (31176): VM state change detected. (old = 'running', new = 'paused')
2024-06-14 10:17:41 (31176): VM state change detected. (old = 'paused', new = 'running')
2024-06-14 10:17:51 (31176): VM state change detected. (old = 'running', new = 'paused')
2024-06-14 10:18:11 (31176): VM state change detected. (old = 'paused', new = 'running')
2024-06-14 10:18:21 (31176): VM state change detected. (old = 'running', new = 'paused')
2024-06-14 10:18:41 (31176): VM state change detected. (old = 'paused', new = 'running')
2024-06-14 10:18:51 (31176): VM state change detected. (old = 'running', new = 'paused')
2024-06-14 10:19:11 (31176): VM state change detected. (old = 'paused', new = 'running')
2024-06-14 10:19:21 (31176): VM state change detected. (old = 'running', new = 'paused')
2024-06-14 10:19:41 (31176): VM state change detected. (old = 'paused', new = 'running')
2024-06-14 10:19:52 (31176): VM state change detected. (old = 'running', new = 'paused')
2024-06-14 10:20:13 (31176): VM state change detected. (old = 'paused', new = 'running')
2024-06-14 10:20:23 (31176): VM state change detected. (old = 'running', new = 'paused')
2024-06-14 10:20:42 (31176): VM state change detected. (old = 'paused', new = 'running')
2024-06-14 10:20:52 (31176): VM state change detected. (old = 'running', new = 'paused')
2024-06-14 10:21:12 (31176): VM state change detected. (old = 'paused', new = 'running')
2024-06-14 10:21:22 (31176): VM state change detected. (old = 'running', new = 'paused')
2024-06-14 10:21:43 (31176): VM state change detected. (old = 'paused', new = 'running')
2024-06-14 10:21:53 (31176): VM state change detected. (old = 'running', new = 'paused')
2024-06-14 10:22:13 (31176): VM state change detected. (old = 'paused', new = 'running')
2024-06-14 10:22:23 (31176): VM state change detected. (old = 'running', new = 'paused')
2024-06-14 10:22:43 (31176): VM state change detected. (old = 'paused', new = 'running')
2024-06-14 10:22:53 (31176): VM state change detected. (old = 'running', new = 'paused')
2024-06-14 10:23:13 (31176): VM state change detected. (old = 'paused', new = 'running')
2024-06-14 10:23:23 (31176): VM state change detected. (old = 'running', new = 'paused')
2024-06-14 10:23:43 (31176): VM state change detected. (old = 'paused', new = 'running')
2024-06-14 10:23:53 (31176): VM state change detected. (old = 'running', new = 'paused')
2024-06-14 10:24:14 (31176): VM state change detected. (old = 'paused', new = 'running')
2024-06-14 10:24:24 (31176): VM state change detected. (old = 'running', new = 'paused')
2024-06-14 10:24:44 (31176): VM state change detected. (old = 'paused', new = 'running')
2024-06-14 10:24:54 (31176): VM state change detected. (old = 'running', new = 'paused')
2024-06-14 10:25:14 (31176): VM state change detected. (old = 'paused', new = 'running')
2024-06-14 10:25:24 (31176): VM state change detected. (old = 'running', new = 'paused')
2024-06-14 10:25:44 (31176): VM state change detected. (old = 'paused', new = 'running')
2024-06-14 10:25:54 (31176): VM state change detected. (old = 'running', new = 'paused')
2024-06-14 10:26:14 (31176): VM state change detected. (old = 'paused', new = 'running')
2024-06-14 10:26:24 (31176): VM state change detected. (old = 'running', new = 'paused')
2024-06-14 10:26:45 (31176): VM state change detected. (old = 'paused', new = 'running')
2024-06-14 10:26:55 (31176): VM state change detected. (old = 'running', new = 'paused')
2024-06-14 10:27:15 (31176): VM state change detected. (old = 'paused', new = 'running')
2024-06-14 10:27:25 (31176): VM state change detected. (old = 'running', new = 'paused')
2024-06-14 10:27:45 (31176): VM state change detected. (old = 'paused', new = 'running')
2024-06-14 10:27:55 (31176): VM state change detected. (old = 'running', new = 'paused')
2024-06-14 10:28:15 (31176): VM state change detected. (old = 'paused', new = 'running')
2024-06-14 10:28:25 (31176): VM state change detected. (old = 'running', new = 'paused')
2024-06-14 10:28:45 (31176): VM state change detected. (old = 'paused', new = 'running')
2024-06-14 10:28:56 (31176): VM state change detected. (old = 'running', new = 'paused')
2024-06-14 10:29:17 (31176): VM state change detected. (old = 'paused', new = 'running')
2024-06-14 10:29:27 (31176): VM state change detected. (old = 'running', new = 'paused')
2024-06-14 10:29:47 (31176): VM state change detected. (old = 'paused', new = 'running')
2024-06-14 10:29:57 (31176): VM state change detected. (old = 'running', new = 'paused')
2024-06-14 10:30:17 (31176): VM state change detected. (old = 'paused', new = 'running')
2024-06-14 10:30:27 (31176): VM state change detected. (old = 'running', new = 'paused')
2024-06-14 10:30:47 (31176): VM state change detected. (old = 'paused', new = 'running')
2024-06-14 10:30:57 (31176): VM state change detected. (old = 'running', new = 'paused')
2024-06-14 10:31:17 (31176): VM state change detected. (old = 'paused', new = 'running')
2024-06-14 10:31:28 (31176): VM state change detected. (old = 'running', new = 'paused')
2024-06-14 10:31:48 (31176): VM state change detected. (old = 'paused', new = 'running')
2024-06-14 10:31:58 (31176): VM state change detected. (old = 'running', new = 'paused')
2024-06-14 10:32:18 (31176): VM state change detected. (old = 'paused', new = 'running')
2024-06-14 10:32:28 (31176): VM state change detected. (old = 'running', new = 'paused')
2024-06-14 10:32:48 (31176): VM state change detected. (old = 'paused', new = 'running')
2024-06-14 10:32:58 (31176): VM state change detected. (old = 'running', new = 'paused')
2024-06-14 10:33:18 (31176): VM state change detected. (old = 'paused', new = 'running')
2024-06-14 10:33:28 (31176): VM state change detected. (old = 'running', new = 'paused')
2024-06-14 10:33:48 (31176): VM state change detected. (old = 'paused', new = 'running')
2024-06-14 10:33:58 (31176): VM state change detected. (old = 'running', new = 'paused')
2024-06-14 10:34:18 (31176): VM state change detected. (old = 'paused', new = 'running')
2024-06-14 10:34:29 (31176): VM state change detected. (old = 'running', new = 'paused')
2024-06-14 10:34:49 (31176): VM state change detected. (old = 'paused', new = 'running')
2024-06-14 10:34:59 (31176): VM state change detected. (old = 'running', new = 'paused')
2024-06-14 10:35:19 (31176): VM state change detected. (old = 'paused', new = 'running')
2024-06-14 10:35:29 (31176): VM state change detected. (old = 'running', new = 'paused')
2024-06-14 10:35:49 (31176): VM state change detected. (old = 'paused', new = 'running')
2024-06-14 10:36:00 (31176): VM state change detected. (old = 'running', new = 'paused')
2024-06-14 10:37:12 (31176): VM state change detected. (old = 'paused', new = 'running')
2024-06-14 10:37:21 (31176): VM state change detected. (old = 'running', new = 'paused')
2024-06-14 10:37:41 (31176): VM state change detected. (old = 'paused', new = 'running')
2024-06-14 10:37:51 (31176): VM state change detected. (old = 'running', new = 'paused')
2024-06-14 10:38:11 (31176): VM state change detected. (old = 'paused', new = 'running')
2024-06-14 10:38:21 (31176): VM state change detected. (old = 'running', new = 'paused')
2024-06-14 10:38:41 (31176): VM state change detected. (old = 'paused', new = 'running')
2024-06-14 10:38:51 (31176): VM state change detected. (old = 'running', new = 'paused')
2024-06-14 10:39:11 (31176): VM state change detected. (old = 'paused', new = 'running')
2024-06-14 10:39:22 (31176): VM state change detected. (old = 'running', new = 'paused')
2024-06-14 10:39:42 (31176): VM state change detected. (old = 'paused', new = 'running')
2024-06-14 10:39:52 (31176): VM state change detected. (old = 'running', new = 'paused')
2024-06-14 10:40:12 (31176): VM state change detected. (old = 'paused', new = 'running')
2024-06-14 10:40:22 (31176): VM state change detected. (old = 'running', new = 'paused')
2024-06-14 10:40:42 (31176): VM state change detected. (old = 'paused', new = 'running')
2024-06-14 10:40:52 (31176): VM state change detected. (old = 'running', new = 'paused')
2024-06-14 10:41:12 (31176): VM state change detected. (old = 'paused', new = 'running')
2024-06-14 10:41:22 (31176): VM state change detected. (old = 'running', new = 'paused')
2024-06-14 10:41:42 (31176): VM state change detected. (old = 'paused', new = 'running')
2024-06-14 10:41:53 (31176): VM state change detected. (old = 'running', new = 'paused')
2024-06-14 10:42:13 (31176): VM state change detected. (old = 'paused', new = 'running')
2024-06-14 10:42:23 (31176): VM state change detected. (old = 'running', new = 'paused')
2024-06-14 10:42:43 (31176): VM state change detected. (old = 'paused', new = 'running')
2024-06-14 10:42:53 (31176): VM state change detected. (old = 'running', new = 'paused')
2024-06-14 10:43:13 (31176): VM state change detected. (old = 'paused', new = 'running')
2024-06-14 10:43:23 (31176): VM state change detected. (old = 'running', new = 'paused')
2024-06-14 10:43:43 (31176): VM state change detected. (old = 'paused', new = 'running')
2024-06-14 10:43:53 (31176): VM state change detected. (old = 'running', new = 'paused')
2024-06-14 10:44:14 (31176): VM state change detected. (old = 'paused', new = 'running')
2024-06-14 10:44:24 (31176): VM state change detected. (old = 'running', new = 'paused')
2024-06-14 10:44:44 (31176): VM state change detected. (old = 'paused', new = 'running')
2024-06-14 10:44:54 (31176): VM state change detected. (old = 'running', new = 'paused')
2024-06-14 10:45:14 (31176): VM state change detected. (old = 'paused', new = 'running')
2024-06-14 10:45:24 (31176): VM state change detected. (old = 'running', new = 'paused')
2024-06-14 10:45:44 (31176): VM state change detected. (old = 'paused', new = 'running')
2024-06-14 10:45:54 (31176): VM state change detected. (old = 'running', new = 'paused')
2024-06-14 10:46:14 (31176): VM state change detected. (old = 'paused', new = 'running')
2024-06-14 10:46:25 (31176): VM state change detected. (old = 'running', new = 'paused')
2024-06-14 10:46:45 (31176): VM state change detected. (old = 'paused', new = 'running')
2024-06-14 10:46:55 (31176): VM state change detected. (old = 'running', new = 'paused')
2024-06-14 10:47:15 (31176): VM state change detected. (old = 'paused', new = 'running')
2024-06-14 10:47:25 (31176): VM state change detected. (old = 'running', new = 'paused')
2024-06-14 10:47:45 (31176): VM state change detected. (old = 'paused', new = 'running')
2024-06-14 10:47:55 (31176): VM state change detected. (old = 'running', new = 'paused')
2024-06-14 10:48:15 (31176): VM state change detected. (old = 'paused', new = 'running')
2024-06-14 10:48:25 (31176): VM state change detected. (old = 'running', new = 'paused')
2024-06-14 10:48:45 (31176): VM state change detected. (old = 'paused', new = 'running')
2024-06-14 10:48:56 (31176): VM state change detected. (old = 'running', new = 'paused')
2024-06-14 10:49:16 (31176): VM state change detected. (old = 'paused', new = 'running')
2024-06-14 10:49:26 (31176): VM state change detected. (old = 'running', new = 'paused')
2024-06-14 10:49:46 (31176): VM state change detected. (old = 'paused', new = 'running')
2024-06-14 10:49:56 (31176): VM state change detected. (old = 'running', new = 'paused')
2024-06-14 10:50:16 (31176): VM state change detected. (old = 'paused', new = 'running')
2024-06-14 10:50:26 (31176): VM state change detected. (old = 'running', new = 'paused')
2024-06-14 10:50:46 (31176): VM state change detected. (old = 'paused', new = 'running')
2024-06-14 10:50:56 (31176): VM state change detected. (old = 'running', new = 'paused')
2024-06-14 10:51:17 (31176): VM state change detected. (old = 'paused', new = 'running')
2024-06-14 10:51:27 (31176): VM state change detected. (old = 'running', new = 'paused')
2024-06-14 10:51:47 (31176): VM state change detected. (old = 'paused', new = 'running')
2024-06-14 10:51:57 (31176): VM state change detected. (old = 'running', new = 'paused')
2024-06-14 10:52:17 (31176): VM state change detected. (old = 'paused', new = 'running')
2024-06-14 10:52:27 (31176): VM state change detected. (old = 'running', new = 'paused')
2024-06-14 10:52:47 (31176): VM state change detected. (old = 'paused', new = 'running')
2024-06-14 10:52:57 (31176): VM state change detected. (old = 'running', new = 'paused')
2024-06-14 10:53:17 (31176): VM state change detected. (old = 'paused', new = 'running')
2024-06-14 10:53:28 (31176): VM state change detected. (old = 'running', new = 'paused')
2024-06-14 10:53:47 (31176): VM state change detected. (old = 'paused', new = 'running')
2024-06-14 10:53:58 (31176): VM state change detected. (old = 'running', new = 'paused')
2024-06-14 10:54:18 (31176): VM state change detected. (old = 'paused', new = 'running')
2024-06-14 10:54:28 (31176): VM state change detected. (old = 'running', new = 'paused')
2024-06-14 10:54:48 (31176): VM state change detected. (old = 'paused', new = 'running')
2024-06-14 10:54:58 (31176): VM state change detected. (old = 'running', new = 'paused')
2024-06-14 10:57:05 (31176): VM state change detected. (old = 'paused', new = 'running')
2024-06-14 10:57:18 (31176): VM state change detected. (old = 'running', new = 'paused')
2024-06-14 10:57:38 (31176): VM state change detected. (old = 'paused', new = 'running')
2024-06-14 10:57:49 (31176): VM state change detected. (old = 'running', new = 'paused')
2024-06-14 10:58:09 (31176): VM state change detected. (old = 'paused', new = 'running')
2024-06-14 10:58:19 (31176): VM state change detected. (old = 'running', new = 'paused')
2024-06-14 10:58:39 (31176): VM state change detected. (old = 'paused', new = 'running')
2024-06-14 10:58:49 (31176): VM state change detected. (old = 'running', new = 'paused')
2024-06-14 10:59:09 (31176): VM state change detected. (old = 'paused', new = 'running')
2024-06-14 10:59:19 (31176): VM state change detected. (old = 'running', new = 'paused')
2024-06-14 10:59:39 (31176): VM state change detected. (old = 'paused', new = 'running')
2024-06-14 10:59:49 (31176): VM state change detected. (old = 'running', new = 'paused')
2024-06-14 11:00:09 (31176): VM state change detected. (old = 'paused', new = 'running')
2024-06-14 11:00:20 (31176): VM state change detected. (old = 'running', new = 'paused')
2024-06-14 11:00:40 (31176): VM state change detected. (old = 'paused', new = 'running')
2024-06-14 11:00:50 (31176): VM state change detected. (old = 'running', new = 'paused')
2024-06-14 11:01:10 (31176): VM state change detected. (old = 'paused', new = 'running')
2024-06-14 11:01:20 (31176): VM state change detected. (old = 'running', new = 'paused')
2024-06-14 11:01:40 (31176): VM state change detected. (old = 'paused', new = 'running')
2024-06-14 11:01:51 (31176): VM state change detected. (old = 'running', new = 'paused')
2024-06-14 11:02:11 (31176): VM state change detected. (old = 'paused', new = 'running')
2024-06-14 11:02:21 (31176): VM state change detected. (old = 'running', new = 'paused')
2024-06-14 11:02:41 (31176): VM state change detected. (old = 'paused', new = 'running')
2024-06-14 11:02:51 (31176): VM state change detected. (old = 'running', new = 'paused')
2024-06-14 11:03:11 (31176): VM state change detected. (old = 'paused', new = 'running')
2024-06-14 11:03:21 (31176): VM state change detected. (old = 'running', new = 'paused')
2024-06-14 11:03:41 (31176): VM state change detected. (old = 'paused', new = 'running')
2024-06-14 11:03:51 (31176): VM state change detected. (old = 'running', new = 'paused')
2024-06-14 11:04:11 (31176): VM state change detected. (old = 'paused', new = 'running')
2024-06-14 11:04:22 (31176): VM state change detected. (old = 'running', new = 'paused')
2024-06-14 11:04:43 (31176): VM state change detected. (old = 'paused', new = 'running')
2024-06-14 11:04:53 (31176): VM state change detected. (old = 'running', new = 'paused')
2024-06-14 11:05:13 (31176): VM state change detected. (old = 'paused', new = 'running')
2024-06-14 11:05:23 (31176): VM state change detected. (old = 'running', new = 'paused')
2024-06-14 11:05:43 (31176): VM state change detected. (old = 'paused', new = 'running')
2024-06-14 11:05:53 (31176): VM state change detected. (old = 'running', new = 'paused')
2024-06-14 11:06:14 (31176): VM state change detected. (old = 'paused', new = 'running')
2024-06-14 11:06:16 (31176): Stopping VM.
2024-06-14 11:06:19 (31176): Successfully stopped VM.
2024-06-14 11:06:46 (38780): vboxwrapper version 26207
2024-06-14 11:06:46 (38780): BOINC client version: 8.0.2
2024-06-14 11:06:47 (38780): Detected: VirtualBox VboxManage Interface (Version: 7.0.14)
2024-06-14 11:06:48 (38780): Detected: Heartbeat check (file: 'heartbeat' every 1200.000000 seconds)
2024-06-14 11:06:51 (38780): Guest Log: BIOS: VirtualBox 7.0.14
2024-06-14 11:06:51 (38780): Guest Log: CPUID EDX: 0x178bfbff
2024-06-14 11:06:51 (38780): Guest Log: BIOS: No PCI IDE controller, not probing IDE
2024-06-14 11:06:51 (38780): Guest Log: BIOS: AHCI 0-P#0: PCHS=16383/16/63 LCHS=1024/255/63 0x0000000002800000 sectors
2024-06-14 11:06:51 (38780): Guest Log: BIOS: Boot : bseqnr=1, bootseq=0032
2024-06-14 11:06:51 (38780): Guest Log: BIOS: Booting from Hard Disk...
2024-06-14 11:06:51 (38780): Guest Log: BIOS: KBD: unsupported int 16h function 03
2024-06-14 11:06:51 (38780): Guest Log: BIOS: AX=0305 BX=0000 CX=0000 DX=0000 
2024-06-14 11:06:51 (38780): Guest Log: vgdrvHeartbeatInit: Setting up heartbeat to trigger every 2000 milliseconds
2024-06-14 11:06:51 (38780): Guest Log: vboxguest: misc device minor 56, IRQ 20, I/O port d020, MMIO at 00000000f0400000 (size 0x400000)
2024-06-14 11:06:51 (38780): Guest Log: VBoxService 5.2.6 r120293 (verbosity: 0) linux.amd64 (Jan 15 2018 14:51:00) release log
2024-06-14 11:06:51 (38780): Guest Log: 00:00:00.000158 main     Log opened 2024-06-14T08:02:52.010745000Z
2024-06-14 11:06:51 (38780): Guest Log: 00:00:00.000402 main     OS Product: Linux
2024-06-14 11:06:51 (38780): Guest Log: 00:00:00.000426 main     OS Release: 4.14.76-13.cernvm.x86_64
2024-06-14 11:06:51 (38780): Guest Log: 00:00:00.000444 main     OS Version: #1 SMP Tue Oct 16 18:26:15 CEST 2018
2024-06-14 11:06:51 (38780): Guest Log: 00:00:00.000463 main     Executable: /usr/sbin/VBoxService
2024-06-14 11:06:51 (38780): Guest Log: 00:00:00.000464 main     Process ID: 3225
2024-06-14 11:06:51 (38780): Guest Log: 00:00:00.000464 main     Package type: LINUX_64BITS_GENERIC
2024-06-14 11:06:51 (38780): Guest Log: 00:00:00.003037 main     5.2.6 r120293 started. Verbose level = 0
2024-06-14 11:06:51 (38780): Guest Log: 10:03:18 CEST +02:00 2024-06-14: cranky: [INFO] Detected Theory App
2024-06-14 11:06:51 (38780): Guest Log: 10:03:18 CEST +02:00 2024-06-14: cranky: [INFO] Checking CVMFS.
2024-06-14 11:06:51 (38780): Guest Log: Probing /cvmfs/sft.cern.ch... OK
2024-06-14 11:06:51 (38780): 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-06-14 11:06:51 (38780): Guest Log: 2.5.2.0 4053 0 28384 29590 3 1 272103 4096000 0 65024 0 0 n/a 5 4 http://s1cern-cvmfs.openhtc.io/cvmfs/sft.cern.ch DIRECT 1
2024-06-14 11:06:51 (38780): Guest Log: Probing /cvmfs/grid.cern.ch... OK
2024-06-14 11:06:51 (38780): 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-06-14 11:06:51 (38780): Guest Log: 2.5.2.0 4102 0 27552 24465 3 2 272103 4096000 0 65024 0 2 -100 7960 981 http://s1bnl-cvmfs.openhtc.io/cvmfs/grid.cern.ch DIRECT 1
2024-06-14 11:06:51 (38780): Guest Log: Probing /cvmfs/cernvm-prod.cern.ch... OK
2024-06-14 11:06:51 (38780): 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-06-14 11:06:51 (38780): Guest Log: 2.5.2.0 4124 0 27192 272 3 1 272103 4096000 0 65024 0 0 n/a 4 3 http://s1cern-cvmfs.openhtc.io/cvmfs/cernvm-prod.cern.ch DIRECT 1
2024-06-14 11:06:51 (38780): Guest Log: Probing /cvmfs/alice.cern.ch... OK
2024-06-14 11:06:51 (38780): 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-06-14 11:06:51 (38780): Guest Log: 2.5.2.0 4078 0 41720 18892 3 1 272103 4096000 0 65024 0 0 n/a 5425 1330 http://s1cern-cvmfs.openhtc.io/cvmfs/alice.cern.ch DIRECT 1
2024-06-14 11:06:51 (38780): Guest Log: 10:03:23 CEST +02:00 2024-06-14: cranky: [INFO] Checking runc.
2024-06-14 11:06:51 (38780): Guest Log: 10:03:23 CEST +02:00 2024-06-14: cranky: [INFO] Creating the filesystem.
2024-06-14 11:06:51 (38780): Guest Log: 10:03:23 CEST +02:00 2024-06-14: cranky: [INFO] Using /cvmfs/cernvm-prod.cern.ch/cvm4
2024-06-14 11:06:51 (38780): Guest Log: 10:03:23 CEST +02:00 2024-06-14: cranky: [INFO] Updating config.json.
2024-06-14 11:06:51 (38780): Guest Log: 10:03:23 CEST +02:00 2024-06-14: cranky: [INFO] Running Container 'runc'.
2024-06-14 11:06:51 (38780): Guest Log: job: htmld=/shared/html/job
2024-06-14 11:06:51 (38780): Guest Log: job: unpack exitcode=0
2024-06-14 11:06:51 (38780): Guest Log: INFO: activated the work-around for ld:
2024-06-14 11:06:51 (38780): Guest Log: lrwxrwxrwx 1 0 0 15 Jun 14 08:03 /tmp/tmp.DliWSLF0Ob/ld -> /usr/bin/ld.bfd
2024-06-14 11:06:51 (38780): Guest Log: 10:03:33 CEST +02:00 2024-06-14: cranky: [INFO] ===> [runRivet] Fri Jun 14 08:03:33 UTC 2024 [boinc pp jets 7000 500 - pythia8 8.308 CP1-CR2 100000 231]
2024-06-14 11:06:51 (38780): Starting VM using VBoxManage interface. (boinc_30e5b259864af2b3, slot#7)
2024-06-14 11:07:03 (38780): Successfully started VM. (PID = '740')
2024-06-14 11:07:03 (38780): Reporting VM Process ID to BOINC.
2024-06-14 11:07:03 (38780): VM state change detected. (old = 'poweredoff', new = 'running')
2024-06-14 11:07:03 (38780): Detected: Web Application Enabled (http://localhost:63722)
2024-06-14 11:07:03 (38780): Detected: Remote Desktop Enabled (localhost:63727)
2024-06-14 11:07:04 (38780): VM state change detected. (old = 'running', new = 'paused')
2024-06-14 11:07:13 (38780): Preference change detected
2024-06-14 11:07:13 (38780): Setting CPU throttle for VM. (80%)
2024-06-14 11:07:13 (38780): Setting checkpoint interval to 600 seconds. (Higher value of (Preference: 60 seconds) or (Vbox_job.xml: 600 seconds))
2024-06-14 11:07:14 (38780): VM state change detected. (old = 'paused', new = 'running')
2024-06-14 11:07:24 (38780): VM state change detected. (old = 'running', new = 'paused')
2024-06-14 11:07:44 (38780): VM state change detected. (old = 'paused', new = 'running')
2024-06-14 11:07:55 (38780): VM state change detected. (old = 'running', new = 'paused')
2024-06-14 11:08:15 (38780): VM state change detected. (old = 'paused', new = 'running')
2024-06-14 11:08:25 (38780): VM state change detected. (old = 'running', new = 'paused')
2024-06-14 11:08:46 (38780): VM state change detected. (old = 'paused', new = 'running')
2024-06-14 11:08:56 (38780): VM state change detected. (old = 'running', new = 'paused')
2024-06-14 11:09:16 (38780): VM state change detected. (old = 'paused', new = 'running')
2024-06-14 11:09:26 (38780): VM state change detected. (old = 'running', new = 'paused')
2024-06-14 11:09:47 (38780): VM state change detected. (old = 'paused', new = 'running')
2024-06-14 11:09:57 (38780): VM state change detected. (old = 'running', new = 'paused')
2024-06-14 11:10:17 (38780): VM state change detected. (old = 'paused', new = 'running')
2024-06-14 11:10:27 (38780): VM state change detected. (old = 'running', new = 'paused')
2024-06-14 11:10:47 (38780): VM state change detected. (old = 'paused', new = 'running')
2024-06-14 11:10:57 (38780): VM state change detected. (old = 'running', new = 'paused')
2024-06-14 11:11:17 (38780): VM state change detected. (old = 'paused', new = 'running')
2024-06-14 11:11:27 (38780): VM state change detected. (old = 'running', new = 'paused')
2024-06-14 11:11:47 (38780): VM state change detected. (old = 'paused', new = 'running')
2024-06-14 11:11:57 (38780): VM state change detected. (old = 'running', new = 'paused')
2024-06-14 11:12:17 (38780): VM state change detected. (old = 'paused', new = 'running')
2024-06-14 11:12:27 (38780): VM state change detected. (old = 'running', new = 'paused')
2024-06-14 11:12:47 (38780): VM state change detected. (old = 'paused', new = 'running')
2024-06-14 11:12:58 (38780): VM state change detected. (old = 'running', new = 'paused')
2024-06-14 11:13:18 (38780): VM state change detected. (old = 'paused', new = 'running')
2024-06-14 11:13:28 (38780): VM state change detected. (old = 'running', new = 'paused')
2024-06-14 11:13:48 (38780): VM state change detected. (old = 'paused', new = 'running')
2024-06-14 11:13:58 (38780): VM state change detected. (old = 'running', new = 'paused')
2024-06-14 11:14:18 (38780): VM state change detected. (old = 'paused', new = 'running')
2024-06-14 11:14:28 (38780): VM state change detected. (old = 'running', new = 'paused')
2024-06-14 11:14:48 (38780): VM state change detected. (old = 'paused', new = 'running')
2024-06-14 11:14:58 (38780): VM state change detected. (old = 'running', new = 'paused')
2024-06-14 11:15:18 (38780): VM state change detected. (old = 'paused', new = 'running')
2024-06-14 11:15:29 (38780): VM state change detected. (old = 'running', new = 'paused')
2024-06-14 11:15:49 (38780): VM state change detected. (old = 'paused', new = 'running')
2024-06-14 11:15:59 (38780): VM state change detected. (old = 'running', new = 'paused')
2024-06-14 11:16:19 (38780): VM state change detected. (old = 'paused', new = 'running')
2024-06-14 11:16:29 (38780): VM state change detected. (old = 'running', new = 'paused')
2024-06-14 11:16:49 (38780): VM state change detected. (old = 'paused', new = 'running')
2024-06-14 11:17:00 (38780): VM state change detected. (old = 'running', new = 'paused')
2024-06-14 11:17:20 (38780): VM state change detected. (old = 'paused', new = 'running')
2024-06-14 11:17:30 (38780): VM state change detected. (old = 'running', new = 'paused')
2024-06-14 11:17:50 (38780): VM state change detected. (old = 'paused', new = 'running')
2024-06-14 11:18:00 (38780): VM state change detected. (old = 'running', new = 'paused')
2024-06-14 11:18:20 (38780): VM state change detected. (old = 'paused', new = 'running')
2024-06-14 11:18:31 (38780): VM state change detected. (old = 'running', new = 'paused')
2024-06-14 11:18:51 (38780): VM state change detected. (old = 'paused', new = 'running')
2024-06-14 11:19:01 (38780): VM state change detected. (old = 'running', new = 'paused')
2024-06-14 11:19:21 (38780): VM state change detected. (old = 'paused', new = 'running')
2024-06-14 11:19:31 (38780): VM state change detected. (old = 'running', new = 'paused')
2024-06-14 11:19:51 (38780): VM state change detected. (old = 'paused', new = 'running')
2024-06-14 11:20:01 (38780): VM state change detected. (old = 'running', new = 'paused')
2024-06-14 11:20:21 (38780): VM state change detected. (old = 'paused', new = 'running')
2024-06-14 11:20:31 (38780): VM state change detected. (old = 'running', new = 'paused')
2024-06-14 11:20:51 (38780): VM state change detected. (old = 'paused', new = 'running')
2024-06-14 11:21:02 (38780): VM state change detected. (old = 'running', new = 'paused')
2024-06-14 11:21:22 (38780): VM state change detected. (old = 'paused', new = 'running')
2024-06-14 11:21:32 (38780): VM state change detected. (old = 'running', new = 'paused')
2024-06-14 11:21:52 (38780): VM state change detected. (old = 'paused', new = 'running')
2024-06-14 11:22:02 (38780): VM state change detected. (old = 'running', new = 'paused')
2024-06-14 11:22:22 (38780): VM state change detected. (old = 'paused', new = 'running')
2024-06-14 11:22:32 (38780): VM state change detected. (old = 'running', new = 'paused')
2024-06-14 11:22:52 (38780): VM state change detected. (old = 'paused', new = 'running')
2024-06-14 11:23:02 (38780): VM state change detected. (old = 'running', new = 'paused')
2024-06-14 11:23:22 (38780): VM state change detected. (old = 'paused', new = 'running')
2024-06-14 11:23:33 (38780): VM state change detected. (old = 'running', new = 'paused')
2024-06-14 11:23:53 (38780): VM state change detected. (old = 'paused', new = 'running')
2024-06-14 11:24:03 (38780): VM state change detected. (old = 'running', new = 'paused')
2024-06-14 11:24:23 (38780): VM state change detected. (old = 'paused', new = 'running')
2024-06-14 11:24:33 (38780): VM state change detected. (old = 'running', new = 'paused')
2024-06-14 11:24:53 (38780): VM state change detected. (old = 'paused', new = 'running')
2024-06-14 11:25:03 (38780): VM state change detected. (old = 'running', new = 'paused')
2024-06-14 11:25:24 (38780): VM state change detected. (old = 'paused', new = 'running')
2024-06-14 11:25:34 (38780): VM state change detected. (old = 'running', new = 'paused')
2024-06-14 11:25:54 (38780): VM state change detected. (old = 'paused', new = 'running')
2024-06-14 11:26:05 (38780): VM state change detected. (old = 'running', new = 'paused')
2024-06-14 11:26:25 (38780): VM state change detected. (old = 'paused', new = 'running')
2024-06-14 11:26:35 (38780): VM state change detected. (old = 'running', new = 'paused')
2024-06-14 11:26:55 (38780): VM state change detected. (old = 'paused', new = 'running')
2024-06-14 11:27:06 (38780): VM state change detected. (old = 'running', new = 'paused')
2024-06-14 11:27:26 (38780): VM state change detected. (old = 'paused', new = 'running')
2024-06-14 11:27:36 (38780): VM state change detected. (old = 'running', new = 'paused')
2024-06-14 11:27:56 (38780): VM state change detected. (old = 'paused', new = 'running')
2024-06-14 11:28:06 (38780): VM state change detected. (old = 'running', new = 'paused')
2024-06-14 11:28:27 (38780): VM state change detected. (old = 'paused', new = 'running')
2024-06-14 11:28:37 (38780): VM state change detected. (old = 'running', new = 'paused')
2024-06-14 11:28:58 (38780): VM state change detected. (old = 'paused', new = 'running')
2024-06-14 11:29:08 (38780): VM state change detected. (old = 'running', new = 'paused')
2024-06-14 11:29:28 (38780): VM state change detected. (old = 'paused', new = 'running')
2024-06-14 11:29:38 (38780): VM state change detected. (old = 'running', new = 'paused')
2024-06-14 11:29:58 (38780): VM state change detected. (old = 'paused', new = 'running')
2024-06-14 11:30:08 (38780): VM state change detected. (old = 'running', new = 'paused')
2024-06-14 11:30:28 (38780): VM state change detected. (old = 'paused', new = 'running')
2024-06-14 11:30:39 (38780): VM state change detected. (old = 'running', new = 'paused')
2024-06-14 11:30:59 (38780): VM state change detected. (old = 'paused', new = 'running')
2024-06-14 11:31:09 (38780): VM state change detected. (old = 'running', new = 'paused')
2024-06-14 11:31:29 (38780): VM state change detected. (old = 'paused', new = 'running')
2024-06-14 11:31:41 (38780): VM state change detected. (old = 'running', new = 'paused')
2024-06-14 11:31:59 (38780): VM state change detected. (old = 'paused', new = 'running')
2024-06-14 11:32:09 (38780): VM state change detected. (old = 'running', new = 'paused')
2024-06-14 11:32:29 (38780): VM state change detected. (old = 'paused', new = 'running')
2024-06-14 11:32:40 (38780): VM state change detected. (old = 'running', new = 'paused')
2024-06-14 11:33:00 (38780): VM state change detected. (old = 'paused', new = 'running')
2024-06-14 11:33:10 (38780): VM state change detected. (old = 'running', new = 'paused')
2024-06-14 11:33:30 (38780): VM state change detected. (old = 'paused', new = 'running')
2024-06-14 11:33:40 (38780): VM state change detected. (old = 'running', new = 'paused')
2024-06-14 11:34:00 (38780): VM state change detected. (old = 'paused', new = 'running')
2024-06-14 11:34:10 (38780): VM state change detected. (old = 'running', new = 'paused')
2024-06-14 11:34:30 (38780): VM state change detected. (old = 'paused', new = 'running')
2024-06-14 11:34:41 (38780): VM state change detected. (old = 'running', new = 'paused')
2024-06-14 11:35:02 (38780): VM state change detected. (old = 'paused', new = 'running')
2024-06-14 11:35:12 (38780): VM state change detected. (old = 'running', new = 'paused')
2024-06-14 11:35:33 (38780): VM state change detected. (old = 'paused', new = 'running')
2024-06-14 11:35:43 (38780): VM state change detected. (old = 'running', new = 'paused')
2024-06-14 11:36:03 (38780): VM state change detected. (old = 'paused', new = 'running')
2024-06-14 11:36:13 (38780): VM state change detected. (old = 'running', new = 'paused')
2024-06-14 11:36:33 (38780): VM state change detected. (old = 'paused', new = 'running')
2024-06-14 11:36:43 (38780): VM state change detected. (old = 'running', new = 'paused')
2024-06-14 11:37:03 (38780): VM state change detected. (old = 'paused', new = 'running')
2024-06-14 11:37:13 (38780): VM state change detected. (old = 'running', new = 'paused')
2024-06-14 11:37:33 (38780): VM state change detected. (old = 'paused', new = 'running')
2024-06-14 11:37:44 (38780): VM state change detected. (old = 'running', new = 'paused')
2024-06-14 11:38:04 (38780): VM state change detected. (old = 'paused', new = 'running')
2024-06-14 11:38:14 (38780): VM state change detected. (old = 'running', new = 'paused')
2024-06-14 11:38:34 (38780): VM state change detected. (old = 'paused', new = 'running')
2024-06-14 11:38:45 (38780): VM state change detected. (old = 'running', new = 'paused')
2024-06-14 11:39:05 (38780): VM state change detected. (old = 'paused', new = 'running')
2024-06-14 11:39:15 (38780): VM state change detected. (old = 'running', new = 'paused')
2024-06-14 11:39:35 (38780): VM state change detected. (old = 'paused', new = 'running')
2024-06-14 11:39:45 (38780): VM state change detected. (old = 'running', new = 'paused')
2024-06-14 11:40:05 (38780): VM state change detected. (old = 'paused', new = 'running')
2024-06-14 11:40:15 (38780): VM state change detected. (old = 'running', new = 'paused')
2024-06-14 11:40:36 (38780): VM state change detected. (old = 'paused', new = 'running')
2024-06-14 11:40:46 (38780): VM state change detected. (old = 'running', new = 'paused')
2024-06-14 11:41:06 (38780): VM state change detected. (old = 'paused', new = 'running')
2024-06-14 11:41:16 (38780): VM state change detected. (old = 'running', new = 'paused')
2024-06-14 11:41:36 (38780): VM state change detected. (old = 'paused', new = 'running')
2024-06-14 11:41:46 (38780): VM state change detected. (old = 'running', new = 'paused')
2024-06-14 11:42:06 (38780): VM state change detected. (old = 'paused', new = 'running')
2024-06-14 11:42:17 (38780): VM state change detected. (old = 'running', new = 'paused')
2024-06-14 11:42:37 (38780): VM state change detected. (old = 'paused', new = 'running')
2024-06-14 11:42:47 (38780): VM state change detected. (old = 'running', new = 'paused')
2024-06-14 11:43:07 (38780): VM state change detected. (old = 'paused', new = 'running')
2024-06-14 11:43:18 (38780): VM state change detected. (old = 'running', new = 'paused')
2024-06-14 11:43:38 (38780): VM state change detected. (old = 'paused', new = 'running')
2024-06-14 11:43:48 (38780): VM state change detected. (old = 'running', new = 'paused')
2024-06-14 11:44:08 (38780): VM state change detected. (old = 'paused', new = 'running')
2024-06-14 11:44:18 (38780): VM state change detected. (old = 'running', new = 'paused')
2024-06-14 11:44:38 (38780): VM state change detected. (old = 'paused', new = 'running')
2024-06-14 11:44:48 (38780): VM state change detected. (old = 'running', new = 'paused')
2024-06-14 11:45:08 (38780): VM state change detected. (old = 'paused', new = 'running')
2024-06-14 11:45:18 (38780): VM state change detected. (old = 'running', new = 'paused')
2024-06-14 11:45:38 (38780): VM state change detected. (old = 'paused', new = 'running')
2024-06-14 11:45:49 (38780): VM state change detected. (old = 'running', new = 'paused')
2024-06-14 11:46:09 (38780): VM state change detected. (old = 'paused', new = 'running')
2024-06-14 11:46:19 (38780): VM state change detected. (old = 'running', new = 'paused')
2024-06-14 11:46:39 (38780): VM state change detected. (old = 'paused', new = 'running')
2024-06-14 11:46:49 (38780): VM state change detected. (old = 'running', new = 'paused')
2024-06-14 11:47:09 (38780): VM state change detected. (old = 'paused', new = 'running')
2024-06-14 11:47:19 (38780): VM state change detected. (old = 'running', new = 'paused')
2024-06-14 11:47:39 (38780): VM state change detected. (old = 'paused', new = 'running')
2024-06-14 11:47:49 (38780): VM state change detected. (old = 'running', new = 'paused')
2024-06-14 11:48:09 (38780): VM state change detected. (old = 'paused', new = 'running')
2024-06-14 11:48:20 (38780): VM state change detected. (old = 'running', new = 'paused')
2024-06-14 11:48:40 (38780): VM state change detected. (old = 'paused', new = 'running')
2024-06-14 11:48:50 (38780): VM state change detected. (old = 'running', new = 'paused')
2024-06-14 11:49:10 (38780): VM state change detected. (old = 'paused', new = 'running')
2024-06-14 11:49:20 (38780): VM state change detected. (old = 'running', new = 'paused')
2024-06-14 11:49:40 (38780): VM state change detected. (old = 'paused', new = 'running')
2024-06-14 11:49:50 (38780): VM state change detected. (old = 'running', new = 'paused')
2024-06-14 11:50:10 (38780): VM state change detected. (old = 'paused', new = 'running')
2024-06-14 11:50:20 (38780): VM state change detected. (old = 'running', new = 'paused')
2024-06-14 11:50:40 (38780): VM state change detected. (old = 'paused', new = 'running')
2024-06-14 11:50:51 (38780): VM state change detected. (old = 'running', new = 'paused')
2024-06-14 11:51:10 (38780): VM state change detected. (old = 'paused', new = 'running')
2024-06-14 11:51:21 (38780): VM state change detected. (old = 'running', new = 'paused')
2024-06-14 11:51:41 (38780): VM state change detected. (old = 'paused', new = 'running')
2024-06-14 11:51:51 (38780): VM state change detected. (old = 'running', new = 'paused')
2024-06-14 11:52:11 (38780): VM state change detected. (old = 'paused', new = 'running')
2024-06-14 11:52:21 (38780): VM state change detected. (old = 'running', new = 'paused')
2024-06-14 11:52:41 (38780): VM state change detected. (old = 'paused', new = 'running')
2024-06-14 11:52:51 (38780): VM state change detected. (old = 'running', new = 'paused')
2024-06-14 11:53:11 (38780): VM state change detected. (old = 'paused', new = 'running')
2024-06-14 11:53:21 (38780): VM state change detected. (old = 'running', new = 'paused')
2024-06-14 11:53:41 (38780): VM state change detected. (old = 'paused', new = 'running')
2024-06-14 11:53:49 (38780): VM state change detected. (old = 'running', new = 'paused')
2024-06-14 12:16:13 (38780): BOINC client no longer exists - exiting
2024-06-14 12:16:13 (38780): timer handler: client dead, exiting
2024-06-14 12:16:14 (38780): Stopping VM.
2024-06-14 12:16:15 (38780): Error in stop VM for VM: -108
Command:
VBoxManage -q controlvm "boinc_30e5b259864af2b3" savestate
Output:

2024-06-14 12:16:15 (38780): VM did not stop when requested.
2024-06-14 12:16:15 (38780): VM was NOT successfully terminated.
2024-06-14 12:22:44 (7052): vboxwrapper version 26207
2024-06-14 12:22:44 (7052): BOINC client version: 8.0.2
2024-06-14 12:22:46 (7052): Detected: VirtualBox VboxManage Interface (Version: 7.0.14)
2024-06-14 12:22:46 (7052): Detected: Heartbeat check (file: 'heartbeat' every 1200.000000 seconds)
2024-06-14 12:22:55 (7052): ERROR: VM failed to start
2024-06-14 12:23:00 (7052): 
   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-06-14 12:34:23 (2060): vboxwrapper version 26207
2024-06-14 12:34:23 (2060): BOINC client version: 8.0.2
2024-06-14 12:34:24 (2060): Detected: VirtualBox VboxManage Interface (Version: 7.0.14)
2024-06-14 12:34:25 (2060): Detected: Heartbeat check (file: 'heartbeat' every 1200.000000 seconds)
2024-06-14 12:34:34 (2060): Starting VM using VBoxManage interface. (boinc_30e5b259864af2b3, slot#7)
2024-06-14 12:34:44 (2060): Successfully started VM. (PID = '33528')
2024-06-14 12:34:44 (2060): Reporting VM Process ID to BOINC.
2024-06-14 12:34:44 (2060): Guest Log: BIOS: VirtualBox 7.0.14
2024-06-14 12:34:44 (2060): Guest Log: CPUID EDX: 0x178bfbff
2024-06-14 12:34:44 (2060): Guest Log: BIOS: No PCI IDE controller, not probing IDE
2024-06-14 12:34:44 (2060): Guest Log: BIOS: AHCI 0-P#0: PCHS=16383/16/63 LCHS=1024/255/63 0x0000000002800000 sectors
2024-06-14 12:34:44 (2060): VM state change detected. (old = 'poweredoff', new = 'running')
2024-06-14 12:34:44 (2060): Detected: Web Application Enabled (http://localhost:63722)
2024-06-14 12:34:44 (2060): Detected: Remote Desktop Enabled (localhost:63727)
2024-06-14 12:34:44 (2060): Preference change detected
2024-06-14 12:34:44 (2060): Setting CPU throttle for VM. (80%)
2024-06-14 12:34:44 (2060): Setting checkpoint interval to 600 seconds. (Higher value of (Preference: 60 seconds) or (Vbox_job.xml: 600 seconds))
2024-06-14 12:34:46 (2060): Guest Log: BIOS: Boot : bseqnr=1, bootseq=0032
2024-06-14 12:34:46 (2060): Guest Log: BIOS: Booting from Hard Disk...
2024-06-14 12:34:49 (2060): Guest Log: BIOS: KBD: unsupported int 16h function 03
2024-06-14 12:34:49 (2060): Guest Log: BIOS: AX=0305 BX=0000 CX=0000 DX=0000 
2024-06-14 12:35:14 (2060): VM state change detected. (old = 'running', new = 'paused')
2024-06-14 12:35:34 (2060): VM state change detected. (old = 'paused', new = 'running')
2024-06-14 12:35:36 (2060): Guest Log: vgdrvHeartbeatInit: Setting up heartbeat to trigger every 2000 milliseconds
2024-06-14 12:35:36 (2060): Guest Log: vboxguest: misc device minor 56, IRQ 20, I/O port d020, MMIO at 00000000f0400000 (size 0x400000)
2024-06-14 12:35:40 (2060): Guest Log: VBoxService 5.2.6 r120293 (verbosity: 0) linux.amd64 (Jan 15 2018 14:51:00) release log
2024-06-14 12:35:40 (2060): Guest Log: 00:00:00.000405 main     Log opened 2024-06-14T10:35:25.874021000Z
2024-06-14 12:35:40 (2060): Guest Log: 00:00:00.001545 main     OS Product: Linux
2024-06-14 12:35:40 (2060): Guest Log: 00:00:00.002379 main     OS Release: 4.14.76-13.cernvm.x86_64
2024-06-14 12:35:40 (2060): Guest Log: 00:00:00.002612 main     OS Version: #1 SMP Tue Oct 16 18:26:15 CEST 2018
2024-06-14 12:35:40 (2060): Guest Log: 00:00:00.002677 main     Executable: /usr/sbin/VBoxService
2024-06-14 12:35:40 (2060): Guest Log: 00:00:00.002678 main     Process ID: 3228
2024-06-14 12:35:40 (2060): Guest Log: 00:00:00.002678 main     Package type: LINUX_64BITS_GENERIC
2024-06-14 12:35:40 (2060): Guest Log: 00:00:00.006191 main     5.2.6 r120293 started. Verbose level = 0
2024-06-14 12:35:44 (2060): VM state change detected. (old = 'running', new = 'paused')
2024-06-14 12:36:04 (2060): VM state change detected. (old = 'paused', new = 'running')
2024-06-14 12:36:28 (2060): Guest Log: 12:35:53 CEST +02:00 2024-06-14: cranky: [INFO] Detected Theory App
2024-06-14 12:36:28 (2060): Guest Log: 12:35:53 CEST +02:00 2024-06-14: cranky: [INFO] Checking CVMFS.
2024-06-14 12:36:29 (2060): Guest Log: Probing /cvmfs/sft.cern.ch... OK
2024-06-14 12:36:29 (2060): 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-06-14 12:36:29 (2060): Guest Log: 2.5.2.0 4097 0 28764 29592 3 1 1246762 4096001 0 65024 0 0 n/a 5 5 http://s1bnl-cvmfs.openhtc.io/cvmfs/sft.cern.ch DIRECT 1
2024-06-14 12:36:30 (2060): Guest Log: Probing /cvmfs/grid.cern.ch... OK
2024-06-14 12:36:30 (2060): 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-06-14 12:36:30 (2060): Guest Log: 2.5.2.0 4127 0 25512 24467 3 2 1246762 4096001 0 65024 0 2 0 5823 750 http://s1cern-cvmfs.openhtc.io/cvmfs/grid.cern.ch DIRECT 1
2024-06-14 12:36:31 (2060): Guest Log: Probing /cvmfs/cernvm-prod.cern.ch... OK
2024-06-14 12:36:31 (2060): 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-06-14 12:36:31 (2060): Guest Log: 2.5.2.0 4055 0 27220 272 3 1 1246762 4096001 0 65024 0 0 n/a 0 0 http://s1unl-cvmfs.openhtc.io/cvmfs/cernvm-prod.cern.ch DIRECT 1
2024-06-14 12:36:32 (2060): Guest Log: Probing /cvmfs/alice.cern.ch... OK
2024-06-14 12:36:33 (2060): 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-06-14 12:36:33 (2060): Guest Log: 2.5.2.0 4076 0 36928 18892 3 1 1246762 4096001 0 65024 0 0 n/a 0 0 http://s1unl-cvmfs.openhtc.io/cvmfs/alice.cern.ch DIRECT 1
2024-06-14 12:36:33 (2060): Guest Log: 12:35:58 CEST +02:00 2024-06-14: cranky: [INFO] Checking runc.
2024-06-14 12:36:33 (2060): Guest Log: 12:35:58 CEST +02:00 2024-06-14: cranky: [INFO] Creating the filesystem.
2024-06-14 12:36:33 (2060): Guest Log: 12:35:58 CEST +02:00 2024-06-14: cranky: [INFO] Using /cvmfs/cernvm-prod.cern.ch/cvm4
2024-06-14 12:36:33 (2060): Guest Log: 12:35:58 CEST +02:00 2024-06-14: cranky: [INFO] Updating config.json.
2024-06-14 12:36:33 (2060): Guest Log: 12:35:58 CEST +02:00 2024-06-14: cranky: [INFO] Running Container 'runc'.
2024-06-14 12:36:34 (2060): Guest Log: job: htmld=/shared/html/job
2024-06-14 12:36:34 (2060): Guest Log: job: unpack exitcode=0
2024-06-14 12:36:34 (2060): Guest Log: INFO: activated the work-around for ld:
2024-06-14 12:36:34 (2060): Guest Log: lrwxrwxrwx 1 0 0 15 Jun 14 10:35 /tmp/tmp.TeWAhIuCJN/ld -> /usr/bin/ld.bfd
2024-06-14 12:36:35 (2060): Guest Log: 12:36:00 CEST +02:00 2024-06-14: cranky: [INFO] ===> [runRivet] Fri Jun 14 10:35:59 UTC 2024 [boinc pp jets 7000 500 - pythia8 8.308 CP1-CR2 100000 231]
2024-06-14 12:48:13 (2060): VM state change detected. (old = 'running', new = 'paused')
2024-06-14 12:48:33 (2060): VM state change detected. (old = 'paused', new = 'running')
2024-06-14 12:48:44 (2060): VM state change detected. (old = 'running', new = 'paused')
2024-06-14 12:49:03 (2060): VM state change detected. (old = 'paused', new = 'running')
2024-06-14 12:49:24 (2060): VM state change detected. (old = 'running', new = 'paused')
2024-06-14 12:49:44 (2060): VM state change detected. (old = 'paused', new = 'running')
2024-06-14 12:49:54 (2060): VM state change detected. (old = 'running', new = 'paused')
2024-06-14 12:50:14 (2060): VM state change detected. (old = 'paused', new = 'running')
2024-06-14 12:50:34 (2060): VM state change detected. (old = 'running', new = 'paused')
2024-06-14 12:50:54 (2060): VM state change detected. (old = 'paused', new = 'running')
2024-06-14 12:52:23 (30564): Can't acquire lockfile (32) - waiting 35s
2024-06-14 12:52:58 (30564): Can't acquire lockfile (32) - exiting
2024-06-14 12:52:58 (30564): Error: Der Prozess kann nicht auf die Datei zugreifen, da sie von einem anderen Prozess verwendet wird.

 (0x20)
2024-06-14 13:05:59 (2060): VM state change detected. (old = 'running', new = 'paused')
2024-06-14 13:06:01 (2060): VM state change detected. (old = 'paused', new = 'running')
2024-06-14 13:38:07 (2060): Status Report: Job Duration: '864000.000000'
2024-06-14 13:38:07 (2060): Status Report: Elapsed Time: '6000.608059'
2024-06-14 13:38:07 (2060): Status Report: CPU Time: '3653.453125'
2024-06-14 14:04:58 (2060): Guest Log: job: run exitcode=0
2024-06-14 14:04:58 (2060): Guest Log: job: diskusage=3940
2024-06-14 14:04:58 (2060): Guest Log: job: logsize=68 k
2024-06-14 14:04:58 (2060): Guest Log: job: times=
2024-06-14 14:04:58 (2060): Guest Log: 0m0.004s 0m0.016s
2024-06-14 14:04:58 (2060): Guest Log: 75m26.991s 0m43.906s
2024-06-14 14:04:58 (2060): Guest Log: job: cpuusage=4571
2024-06-14 14:04:59 (2060): Guest Log: 14:02:47 CEST +02:00 2024-06-14: cranky: [INFO] Container 'runc' finished with status code 0.
2024-06-14 14:04:59 (2060): Guest Log: 14:02:47 CEST +02:00 2024-06-14: cranky: [INFO] Preparing output.
2024-06-14 14:04:59 (2060): Guest Log: [INFO] Job Finished
2024-06-14 14:05:00 (2060): Guest Log: [INFO] Shutting Down.
2024-06-14 14:05:00 (2060): VM Completion File Detected.
2024-06-14 14:05:00 (2060): VM Completion Message: Job Finished
.
2024-06-14 14:05:00 (2060): Powering off VM.
2024-06-14 14:05:01 (2060): Successfully stopped VM.
2024-06-14 14:05:01 (2060): Deregistering VM. (boinc_30e5b259864af2b3, slot#7)
2024-06-14 14:05:01 (2060): Removing network bandwidth throttle group from VM.
2024-06-14 14:05:01 (2060): Removing VM from VirtualBox.
2024-06-14 14:05:06 (2060): called boinc_finish(0)

</stderr_txt>
]]>


©2024 CERN