| Name | Theory_2743-2791862-145_1 |
| Workunit | 222840164 |
| Created | 8 May 2024, 7:52:09 UTC |
| Sent | 8 May 2024, 11:27:25 UTC |
| Report deadline | 19 May 2024, 11:27:25 UTC |
| Received | 20 May 2024, 12:38:32 UTC |
| Server state | Over |
| Outcome | Success |
| Client state | Done |
| Exit status | 0 (0x00000000) |
| Computer ID | 10850090 |
| Run time | 1 days 2 hours 53 min 59 sec |
| CPU time | 13 hours 40 min 43 sec |
| Validate state | Valid |
| Credit | 791.88 |
| Device peak FLOPS | 3.53 GFLOPS |
| Application version | Theory Simulation v300.50 (vbox64_theory) x86_64-apple-darwin |
| Peak working set size | 735.54 MB |
| Peak swap size | 9.17 GB |
| Peak disk usage | 1.42 MB |
Stderr output
<core_client_version>7.20.2</core_client_version> <![CDATA[ <stderr_txt> 2024-05-08 13:27:28 (1905): vboxwrapper version 26207 2024-05-08 13:27:28 (1905): BOINC client version: 7.20.2 2024-05-08 13:27:28 (1905): Detected: VirtualBox VboxManage Interface (Version: 6.1.36) 2024-05-08 13:27:28 (1905): Detected: Sandbox Configuration Enabled 2024-05-08 13:27:28 (1905): Detected: Heartbeat check (file: 'heartbeat' every 1200.000000 seconds) 2024-05-08 13:27:28 (1905): Successfully copied 'init_data.xml' to the shared directory. 2024-05-08 13:27:28 (1905): Successfully copied 'input' to the shared directory. 2024-05-08 13:27:28 (1905): Create VM. (boinc_3b6a5716b3dcb7d0, slot#4) 2024-05-08 13:27:28 (1905): Setting Memory Size for VM. (630MB) 2024-05-08 13:27:29 (1905): Setting CPU Count for VM. (1) 2024-05-08 13:27:29 (1905): Setting Chipset Options for VM. 2024-05-08 13:27:29 (1905): Setting Graphics Controller Options for VM. 2024-05-08 13:27:29 (1905): Setting Boot Options for VM. 2024-05-08 13:27:29 (1905): Setting Network Configuration for NAT. 2024-05-08 13:27:29 (1905): Enabling VM Network Access. 2024-05-08 13:27:29 (1905): Disabling USB Support for VM. 2024-05-08 13:27:29 (1905): Disabling COM Port Support for VM. 2024-05-08 13:27:29 (1905): Disabling Audio Support for VM. 2024-05-08 13:27:29 (1905): Disabling Clipboard Support for VM. 2024-05-08 13:27:30 (1905): Disabling Drag and Drop Support for VM. 2024-05-08 13:27:30 (1905): Adding storage controller(s) to VM. 2024-05-08 13:27:30 (1905): Adding virtual disk drive to VM. (Theory_2024_05_03_prod.vdi) 2024-05-08 13:27:30 (1905): Adding VirtualBox Guest Additions to VM. 2024-05-08 13:27:30 (1905): Adding network bandwidth throttle group to VM. (Defaulting to 1024GB) 2024-05-08 13:27:30 (1905): forwarding host port 50948 to guest port 80 2024-05-08 13:27:30 (1905): Enabling remote desktop for VM. 2024-05-08 13:27:30 (1905): Required extension pack not installed, remote desktop not enabled. 2024-05-08 13:27:30 (1905): Enabling shared directory for VM. 2024-05-08 13:27:30 (1905): Starting VM using VBoxManage interface. (boinc_3b6a5716b3dcb7d0, slot#4) 2024-05-08 13:27:32 (1905): Successfully started VM. (PID = '2088') 2024-05-08 13:27:32 (1905): Reporting VM Process ID to BOINC. 2024-05-08 13:27:32 (1905): Guest Log: BIOS: VirtualBox 6.1.36 2024-05-08 13:27:32 (1905): Guest Log: CPUID EDX: 0x178bfbff 2024-05-08 13:27:32 (1905): Guest Log: BIOS: No PCI IDE controller, not probing IDE 2024-05-08 13:27:32 (1905): Guest Log: BIOS: AHCI 0-P#0: PCHS=16383/16/63 LCHS=1024/255/63 0x0000000002800000 sectors 2024-05-08 13:27:32 (1905): VM state change detected. (old = 'poweredoff', new = 'running') 2024-05-08 13:27:32 (1905): Detected: Web Application Enabled (http://localhost:50948) 2024-05-08 13:27:32 (1905): Preference change detected 2024-05-08 13:27:32 (1905): Setting CPU throttle for VM. (50%) 2024-05-08 13:27:32 (1905): Setting checkpoint interval to 600 seconds. (Higher value of (Preference: 60 seconds) or (Vbox_job.xml: 600 seconds)) 2024-05-08 13:27:34 (1905): Guest Log: BIOS: Boot : bseqnr=1, bootseq=0032 2024-05-08 13:27:34 (1905): Guest Log: BIOS: Booting from Hard Disk... 2024-05-08 13:27:37 (1905): Guest Log: BIOS: KBD: unsupported int 16h function 03 2024-05-08 13:27:37 (1905): Guest Log: BIOS: AX=0305 BX=0000 CX=0000 DX=0000 2024-05-08 13:28:07 (1905): Guest Log: vgdrvHeartbeatInit: Setting up heartbeat to trigger every 2000 milliseconds 2024-05-08 13:28:07 (1905): Guest Log: vboxguest: misc device minor 56, IRQ 20, I/O port d020, MMIO at 00000000f0400000 (size 0x400000) 2024-05-08 13:28:16 (1905): Guest Log: VBoxService 5.2.6 r120293 (verbosity: 0) linux.amd64 (Jan 15 2018 14:51:00) release log 2024-05-08 13:28:16 (1905): Guest Log: 00:00:00.000199 main Log opened 2024-05-08T11:28:15.199534000Z 2024-05-08 13:28:16 (1905): Guest Log: 00:00:00.001531 main OS Product: Linux 2024-05-08 13:28:16 (1905): Guest Log: 00:00:00.001779 main OS Release: 4.14.76-13.cernvm.x86_64 2024-05-08 13:28:16 (1905): Guest Log: 00:00:00.001881 main OS Version: #1 SMP Tue Oct 16 18:26:15 CEST 2018 2024-05-08 13:28:16 (1905): Guest Log: 00:00:00.001975 main Executable: /usr/sbin/VBoxService 2024-05-08 13:28:16 (1905): Guest Log: 00:00:00.001977 main Process ID: 3219 2024-05-08 13:28:16 (1905): Guest Log: 00:00:00.001979 main Package type: LINUX_64BITS_GENERIC 2024-05-08 13:28:16 (1905): Guest Log: 00:00:00.008952 main 5.2.6 r120293 started. Verbose level = 0 2024-05-08 13:29:17 (1905): Guest Log: 13:29:16 CEST +02:00 2024-05-08: cranky: [INFO] Detected Theory App 2024-05-08 13:29:17 (1905): Guest Log: 13:29:16 CEST +02:00 2024-05-08: cranky: [INFO] Checking CVMFS. 2024-05-08 13:29:21 (1905): Guest Log: Probing /cvmfs/sft.cern.ch... OK 2024-05-08 13:29:23 (1905): 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-05-08 13:29:23 (1905): Guest Log: 2.5.2.0 4070 0 27288 29266 3 1 297002 4096000 0 65024 0 0 n/a 5 10 http://s1cern-cvmfs.openhtc.io/cvmfs/sft.cern.ch DIRECT 1 2024-05-08 13:29:27 (1905): Guest Log: Probing /cvmfs/grid.cern.ch... OK 2024-05-08 13:29:29 (1905): 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-05-08 13:29:29 (1905): Guest Log: 2.5.2.0 4125 0 27528 24163 3 2 297002 4096000 0 65024 0 2 -100 7960 983 http://s1unl-cvmfs.openhtc.io/cvmfs/grid.cern.ch DIRECT 1 2024-05-08 13:29:33 (1905): Guest Log: Probing /cvmfs/cernvm-prod.cern.ch... OK 2024-05-08 13:29:35 (1905): 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-05-08 13:29:35 (1905): Guest Log: 2.5.2.0 4099 0 27200 268 3 1 297002 4096000 0 65024 0 0 n/a 4 6 http://s1cern-cvmfs.openhtc.io/cvmfs/cernvm-prod.cern.ch DIRECT 1 2024-05-08 13:29:40 (1905): Guest Log: Probing /cvmfs/alice.cern.ch... OK 2024-05-08 13:29:42 (1905): 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-05-08 13:29:42 (1905): Guest Log: 2.5.2.0 4150 0 38600 18604 3 1 297002 4096000 0 65024 0 0 n/a 18461 1770 http://s1cern-cvmfs.openhtc.io/cvmfs/alice.cern.ch DIRECT 1 2024-05-08 13:29:42 (1905): Guest Log: 13:29:42 CEST +02:00 2024-05-08: cranky: [INFO] Checking runc. 2024-05-08 13:29:42 (1905): Guest Log: 13:29:42 CEST +02:00 2024-05-08: cranky: [INFO] Creating the filesystem. 2024-05-08 13:29:42 (1905): Guest Log: 13:29:42 CEST +02:00 2024-05-08: cranky: [INFO] Using /cvmfs/cernvm-prod.cern.ch/cvm4 2024-05-08 13:29:43 (1905): Guest Log: 13:29:42 CEST +02:00 2024-05-08: cranky: [INFO] Updating config.json. 2024-05-08 13:29:43 (1905): Guest Log: 13:29:43 CEST +02:00 2024-05-08: cranky: [INFO] Running Container 'runc'. 2024-05-08 13:30:10 (1905): Guest Log: job: htmld=/shared/html/job 2024-05-08 13:30:11 (1905): Guest Log: job: unpack exitcode=0 2024-05-08 13:30:12 (1905): Guest Log: INFO: activated the work-around for ld: 2024-05-08 13:30:13 (1905): Guest Log: lrwxrwxrwx 1 0 0 15 May 8 11:30 /tmp/tmp.2XGBWdc8xq/ld -> /usr/bin/ld.bfd 2024-05-08 13:30:13 (1905): Guest Log: 13:30:13 CEST +02:00 2024-05-08: cranky: [INFO] ===> [runRivet] Wed May 8 11:30:12 UTC 2024 [boinc pp jets 8000 150 - powheg-box r3744 default 100000 145] 2024-05-08 13:30:22 (1905): VM state change detected. (old = 'running', new = 'paused') 2024-05-08 13:30:32 (1905): VM state change detected. (old = 'paused', new = 'running') 2024-05-08 13:50:15 (1905): VM state change detected. (old = 'running', new = 'paused') 2024-05-08 13:50:25 (1905): VM state change detected. (old = 'paused', new = 'running') 2024-05-08 15:01:04 (1905): VM state change detected. (old = 'running', new = 'paused') 2024-05-08 15:01:14 (1905): VM state change detected. (old = 'paused', new = 'running') 2024-05-08 15:07:28 (1905): Status Report: Job Duration: '864000.000000' 2024-05-08 15:07:28 (1905): Status Report: Elapsed Time: '6000.000000' 2024-05-08 15:07:28 (1905): Status Report: CPU Time: '3084.940000' 2024-05-08 16:24:55 (1905): VM state change detected. (old = 'running', new = 'paused') 2024-05-08 16:25:05 (1905): VM state change detected. (old = 'paused', new = 'running') 2024-05-08 16:47:11 (1905): Status Report: Job Duration: '864000.000000' 2024-05-08 16:47:11 (1905): Status Report: Elapsed Time: '12000.000000' 2024-05-08 16:47:11 (1905): Status Report: CPU Time: '6109.220000' 2024-05-08 18:26:53 (1905): Status Report: Job Duration: '864000.000000' 2024-05-08 18:26:53 (1905): Status Report: Elapsed Time: '18000.000000' 2024-05-08 18:26:53 (1905): Status Report: CPU Time: '9144.680000' 2024-05-08 18:58:42 (1905): VM state change detected. (old = 'running', new = 'paused') 2024-05-08 18:59:02 (1905): VM state change detected. (old = 'paused', new = 'running') 2024-05-08 19:34:20 (1905): VM state change detected. (old = 'running', new = 'paused') 2024-05-08 19:34:30 (1905): VM state change detected. (old = 'paused', new = 'running') 2024-05-08 20:06:52 (1905): Status Report: Job Duration: '864000.000000' 2024-05-08 20:06:52 (1905): Status Report: Elapsed Time: '24000.000000' 2024-05-08 20:06:52 (1905): Status Report: CPU Time: '12162.220000' 2024-05-08 21:20:16 (1905): Stopping VM. 2024-05-08 21:20:20 (1905): Successfully stopped VM. 2024-05-09 14:43:43 (707): vboxwrapper version 26207 2024-05-09 14:43:43 (707): BOINC client version: 7.20.2 2024-05-09 14:43:44 (707): Detected: VirtualBox VboxManage Interface (Version: 6.1.36) 2024-05-09 14:43:44 (707): Detected: Sandbox Configuration Enabled 2024-05-09 14:43:44 (707): Detected: Heartbeat check (file: 'heartbeat' every 1200.000000 seconds) 2024-05-09 14:43:47 (707): Guest Log: BIOS: VirtualBox 6.1.36 2024-05-09 14:43:47 (707): Guest Log: CPUID EDX: 0x178bfbff 2024-05-09 14:43:47 (707): Guest Log: BIOS: No PCI IDE controller, not probing IDE 2024-05-09 14:43:47 (707): Guest Log: BIOS: AHCI 0-P#0: PCHS=16383/16/63 LCHS=1024/255/63 0x0000000002800000 sectors 2024-05-09 14:43:47 (707): Guest Log: BIOS: Boot : bseqnr=1, bootseq=0032 2024-05-09 14:43:47 (707): Guest Log: BIOS: Booting from Hard Disk... 2024-05-09 14:43:47 (707): Guest Log: BIOS: KBD: unsupported int 16h function 03 2024-05-09 14:43:47 (707): Guest Log: BIOS: AX=0305 BX=0000 CX=0000 DX=0000 2024-05-09 14:43:47 (707): Guest Log: vgdrvHeartbeatInit: Setting up heartbeat to trigger every 2000 milliseconds 2024-05-09 14:43:47 (707): Guest Log: vboxguest: misc device minor 56, IRQ 20, I/O port d020, MMIO at 00000000f0400000 (size 0x400000) 2024-05-09 14:43:47 (707): Guest Log: VBoxService 5.2.6 r120293 (verbosity: 0) linux.amd64 (Jan 15 2018 14:51:00) release log 2024-05-09 14:43:47 (707): Guest Log: 00:00:00.000199 main Log opened 2024-05-08T11:28:15.199534000Z 2024-05-09 14:43:47 (707): Guest Log: 00:00:00.001531 main OS Product: Linux 2024-05-09 14:43:47 (707): Guest Log: 00:00:00.001779 main OS Release: 4.14.76-13.cernvm.x86_64 2024-05-09 14:43:47 (707): Guest Log: 00:00:00.001881 main OS Version: #1 SMP Tue Oct 16 18:26:15 CEST 2018 2024-05-09 14:43:47 (707): Guest Log: 00:00:00.001975 main Executable: /usr/sbin/VBoxService 2024-05-09 14:43:47 (707): Guest Log: 00:00:00.001977 main Process ID: 3219 2024-05-09 14:43:47 (707): Guest Log: 00:00:00.001979 main Package type: LINUX_64BITS_GENERIC 2024-05-09 14:43:47 (707): Guest Log: 00:00:00.008952 main 5.2.6 r120293 started. Verbose level = 0 2024-05-09 14:43:47 (707): Guest Log: 13:29:16 CEST +02:00 2024-05-08: cranky: [INFO] Detected Theory App 2024-05-09 14:43:47 (707): Guest Log: 13:29:16 CEST +02:00 2024-05-08: cranky: [INFO] Checking CVMFS. 2024-05-09 14:43:47 (707): Guest Log: Probing /cvmfs/sft.cern.ch... OK 2024-05-09 14:43:47 (707): 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-05-09 14:43:47 (707): Guest Log: 2.5.2.0 4070 0 27288 29266 3 1 297002 4096000 0 65024 0 0 n/a 5 10 http://s1cern-cvmfs.openhtc.io/cvmfs/sft.cern.ch DIRECT 1 2024-05-09 14:43:47 (707): Guest Log: Probing /cvmfs/grid.cern.ch... OK 2024-05-09 14:43:47 (707): 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-05-09 14:43:47 (707): Guest Log: 2.5.2.0 4125 0 27528 24163 3 2 297002 4096000 0 65024 0 2 -100 7960 983 http://s1unl-cvmfs.openhtc.io/cvmfs/grid.cern.ch DIRECT 1 2024-05-09 14:43:47 (707): Guest Log: Probing /cvmfs/cernvm-prod.cern.ch... OK 2024-05-09 14:43:47 (707): 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-05-09 14:43:47 (707): Guest Log: 2.5.2.0 4099 0 27200 268 3 1 297002 4096000 0 65024 0 0 n/a 4 6 http://s1cern-cvmfs.openhtc.io/cvmfs/cernvm-prod.cern.ch DIRECT 1 2024-05-09 14:43:47 (707): Guest Log: Probing /cvmfs/alice.cern.ch... OK 2024-05-09 14:43:47 (707): 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-05-09 14:43:47 (707): Guest Log: 2.5.2.0 4150 0 38600 18604 3 1 297002 4096000 0 65024 0 0 n/a 18461 1770 http://s1cern-cvmfs.openhtc.io/cvmfs/alice.cern.ch DIRECT 1 2024-05-09 14:43:47 (707): Guest Log: 13:29:42 CEST +02:00 2024-05-08: cranky: [INFO] Checking runc. 2024-05-09 14:43:47 (707): Guest Log: 13:29:42 CEST +02:00 2024-05-08: cranky: [INFO] Creating the filesystem. 2024-05-09 14:43:47 (707): Guest Log: 13:29:42 CEST +02:00 2024-05-08: cranky: [INFO] Using /cvmfs/cernvm-prod.cern.ch/cvm4 2024-05-09 14:43:47 (707): Guest Log: 13:29:42 CEST +02:00 2024-05-08: cranky: [INFO] Updating config.json. 2024-05-09 14:43:47 (707): Guest Log: 13:29:43 CEST +02:00 2024-05-08: cranky: [INFO] Running Container 'runc'. 2024-05-09 14:43:47 (707): Guest Log: job: htmld=/shared/html/job 2024-05-09 14:43:47 (707): Guest Log: job: unpack exitcode=0 2024-05-09 14:43:47 (707): Guest Log: INFO: activated the work-around for ld: 2024-05-09 14:43:47 (707): Guest Log: lrwxrwxrwx 1 0 0 15 May 8 11:30 /tmp/tmp.2XGBWdc8xq/ld -> /usr/bin/ld.bfd 2024-05-09 14:43:47 (707): Guest Log: 13:30:13 CEST +02:00 2024-05-08: cranky: [INFO] ===> [runRivet] Wed May 8 11:30:12 UTC 2024 [boinc pp jets 8000 150 - powheg-box r3744 default 100000 145] 2024-05-09 14:43:47 (707): Starting VM using VBoxManage interface. (boinc_3b6a5716b3dcb7d0, slot#4) 2024-05-09 14:43:58 (707): Successfully started VM. (PID = '752') 2024-05-09 14:43:58 (707): Reporting VM Process ID to BOINC. 2024-05-09 14:43:58 (707): VM state change detected. (old = 'poweredoff', new = 'running') 2024-05-09 14:43:58 (707): Detected: Web Application Enabled (http://localhost:50948) 2024-05-09 14:43:59 (707): VM state change detected. (old = 'running', new = 'paused') 2024-05-09 14:46:08 (707): Status Report: Job Duration: '864000.000000' 2024-05-09 14:46:08 (707): Status Report: Elapsed Time: '28430.000000' 2024-05-09 14:46:08 (707): Status Report: CPU Time: '14384.100000' 2024-05-09 14:46:08 (707): Preference change detected 2024-05-09 14:46:08 (707): Setting CPU throttle for VM. (50%) 2024-05-09 14:46:08 (707): Setting checkpoint interval to 600 seconds. (Higher value of (Preference: 60 seconds) or (Vbox_job.xml: 600 seconds)) 2024-05-09 14:46:09 (707): VM state change detected. (old = 'paused', new = 'running') 2024-05-09 14:46:17 (707): Guest Log: 07:51:15.189901 timesync vgsvcTimeSyncWorker: Radical host time change: 62 760 822 000 000ns (HostNow=1 715 258 777 225 000 000 ns HostLast=1 715 196 016 403 000 000 ns) 2024-05-09 14:46:19 (707): VM state change detected. (old = 'running', new = 'paused') 2024-05-09 14:46:29 (707): VM state change detected. (old = 'paused', new = 'running') 2024-05-09 14:46:37 (707): Guest Log: 07:51:25.257909 timesync vgsvcTimeSyncWorker: Radical guest time change: 62 817 239 498 000ns (GuestNow=1 715 258 787 445 239 000 ns GuestLast=1 715 195 970 205 741 000 ns fSetTimeLastLoop=true ) 2024-05-09 14:50:24 (707): VM state change detected. (old = 'running', new = 'paused') 2024-05-09 14:50:34 (707): VM state change detected. (old = 'paused', new = 'running') 2024-05-09 16:14:11 (707): VM state change detected. (old = 'running', new = 'paused') 2024-05-09 16:14:22 (707): VM state change detected. (old = 'paused', new = 'running') 2024-05-09 16:26:17 (707): Status Report: Job Duration: '864000.000000' 2024-05-09 16:26:17 (707): Status Report: Elapsed Time: '34430.000000' 2024-05-09 16:26:17 (707): Status Report: CPU Time: '17433.440000' 2024-05-09 17:22:31 (707): VM state change detected. (old = 'running', new = 'paused') 2024-05-09 17:22:41 (707): VM state change detected. (old = 'paused', new = 'running') 2024-05-09 18:05:55 (707): Status Report: Job Duration: '864000.000000' 2024-05-09 18:05:55 (707): Status Report: Elapsed Time: '40430.000000' 2024-05-09 18:05:55 (707): Status Report: CPU Time: '20464.900000' 2024-05-09 18:18:40 (707): VM state change detected. (old = 'running', new = 'paused') 2024-05-09 18:18:49 (707): VM state change detected. (old = 'paused', new = 'running') 2024-05-09 19:19:17 (707): VM state change detected. (old = 'running', new = 'paused') 2024-05-09 19:19:27 (707): VM state change detected. (old = 'paused', new = 'running') 2024-05-09 19:19:48 (707): VM state change detected. (old = 'running', new = 'paused') 2024-05-09 19:19:58 (707): VM state change detected. (old = 'paused', new = 'running') 2024-05-09 19:45:56 (707): Status Report: Job Duration: '864000.000000' 2024-05-09 19:45:56 (707): Status Report: Elapsed Time: '46430.000000' 2024-05-09 19:45:56 (707): Status Report: CPU Time: '23503.480000' 2024-05-09 20:03:04 (707): Stopping VM. 2024-05-09 20:03:08 (707): Successfully stopped VM. 2024-05-10 12:41:37 (683): vboxwrapper version 26207 2024-05-10 12:41:37 (683): BOINC client version: 7.20.2 2024-05-10 12:41:37 (683): Detected: VirtualBox VboxManage Interface (Version: 6.1.36) 2024-05-10 12:41:37 (683): Detected: Sandbox Configuration Enabled 2024-05-10 12:41:38 (683): Detected: Heartbeat check (file: 'heartbeat' every 1200.000000 seconds) 2024-05-10 12:41:39 (683): Guest Log: 07:51:15.189901 timesync vgsvcTimeSyncWorker: Radical host time change: 62 760 822 000 000ns (HostNow=1 715 258 777 225 000 000 ns HostLast=1 715 196 016 403 000 000 ns) 2024-05-10 12:41:39 (683): Guest Log: 07:51:25.257909 timesync vgsvcTimeSyncWorker: Radical guest time change: 62 817 239 498 000ns (GuestNow=1 715 258 787 445 239 000 ns GuestLast=1 715 195 970 205 741 000 ns fSetTimeLastLoop=true ) 2024-05-10 12:41:39 (683): Starting VM using VBoxManage interface. (boinc_3b6a5716b3dcb7d0, slot#4) 2024-05-10 12:41:50 (683): Successfully started VM. (PID = '707') 2024-05-10 12:41:50 (683): Reporting VM Process ID to BOINC. 2024-05-10 12:41:50 (683): Guest Log: 13:07:02.385770 timesync vgsvcTimeSyncWorker: Radical host time change: 59 934 515 000 000ns (HostNow=1 715 337 710 342 000 000 ns HostLast=1 715 277 775 827 000 000 ns) 2024-05-10 12:41:50 (683): VM state change detected. (old = 'poweredoff', new = 'running') 2024-05-10 12:41:50 (683): Detected: Web Application Enabled (http://localhost:50948) 2024-05-10 12:41:51 (683): VM state change detected. (old = 'running', new = 'paused') 2024-05-10 12:43:20 (683): Status Report: Job Duration: '864000.000000' 2024-05-10 12:43:20 (683): Status Report: Elapsed Time: '47463.000000' 2024-05-10 12:43:20 (683): Status Report: CPU Time: '24027.170000' 2024-05-10 12:43:20 (683): Preference change detected 2024-05-10 12:43:20 (683): Setting CPU throttle for VM. (50%) 2024-05-10 12:43:20 (683): Setting checkpoint interval to 600 seconds. (Higher value of (Preference: 60 seconds) or (Vbox_job.xml: 600 seconds)) 2024-05-10 12:43:21 (683): VM state change detected. (old = 'paused', new = 'running') 2024-05-10 12:43:30 (683): Guest Log: 13:07:12.417288 timesync vgsvcTimeSyncWorker: Radical guest time change: 59 995 800 613 000ns (GuestNow=1 715 337 720 373 609 000 ns GuestLast=1 715 277 724 572 996 000 ns fSetTimeLastLoop=true ) 2024-05-10 12:43:53 (683): VM state change detected. (old = 'running', new = 'paused') 2024-05-10 12:44:13 (683): VM state change detected. (old = 'paused', new = 'running') 2024-05-10 12:44:54 (683): VM state change detected. (old = 'running', new = 'paused') 2024-05-10 12:45:03 (683): VM state change detected. (old = 'paused', new = 'running') 2024-05-10 12:45:44 (683): VM state change detected. (old = 'running', new = 'paused') 2024-05-10 12:45:54 (683): VM state change detected. (old = 'paused', new = 'running') 2024-05-10 12:46:25 (683): VM state change detected. (old = 'running', new = 'paused') 2024-05-10 12:46:36 (683): VM state change detected. (old = 'paused', new = 'running') 2024-05-10 13:53:39 (683): VM state change detected. (old = 'running', new = 'paused') 2024-05-10 13:53:49 (683): VM state change detected. (old = 'paused', new = 'running') 2024-05-10 14:23:45 (683): Status Report: Job Duration: '864000.000000' 2024-05-10 14:23:45 (683): Status Report: Elapsed Time: '53463.000000' 2024-05-10 14:23:45 (683): Status Report: CPU Time: '27055.440000' 2024-05-10 14:56:51 (683): VM state change detected. (old = 'running', new = 'paused') 2024-05-10 14:57:01 (683): VM state change detected. (old = 'paused', new = 'running') 2024-05-10 16:03:22 (683): Status Report: Job Duration: '864000.000000' 2024-05-10 16:03:22 (683): Status Report: Elapsed Time: '59463.000000' 2024-05-10 16:03:22 (683): Status Report: CPU Time: '30073.750000' 2024-05-10 16:12:27 (683): VM state change detected. (old = 'running', new = 'paused') 2024-05-10 16:12:37 (683): VM state change detected. (old = 'paused', new = 'running') 2024-05-10 17:43:15 (683): Status Report: Job Duration: '864000.000000' 2024-05-10 17:43:15 (683): Status Report: Elapsed Time: '65463.000000' 2024-05-10 17:43:15 (683): Status Report: CPU Time: '33115.540000' 2024-05-10 19:22:56 (683): Status Report: Job Duration: '864000.000000' 2024-05-10 19:22:56 (683): Status Report: Elapsed Time: '71463.000000' 2024-05-10 19:22:56 (683): Status Report: CPU Time: '36147.580000' 2024-05-10 20:48:34 (683): Stopping VM. 2024-05-10 20:48:38 (683): Successfully stopped VM. 2024-05-19 16:04:16 (733): vboxwrapper version 26207 2024-05-19 16:04:16 (733): BOINC client version: 7.20.2 2024-05-19 16:04:17 (733): Detected: VirtualBox VboxManage Interface (Version: 6.1.36) 2024-05-19 16:04:17 (733): Detected: Sandbox Configuration Enabled 2024-05-19 16:04:17 (733): Detected: Heartbeat check (file: 'heartbeat' every 1200.000000 seconds) 2024-05-19 16:04:19 (733): Guest Log: 13:07:02.385770 timesync vgsvcTimeSyncWorker: Radical host time change: 59 934 515 000 000ns (HostNow=1 715 337 710 342 000 000 ns HostLast=1 715 277 775 827 000 000 ns) 2024-05-19 16:04:19 (733): Guest Log: 13:07:12.417288 timesync vgsvcTimeSyncWorker: Radical guest time change: 59 995 800 613 000ns (GuestNow=1 715 337 720 373 609 000 ns GuestLast=1 715 277 724 572 996 000 ns fSetTimeLastLoop=true ) 2024-05-19 16:04:19 (733): Starting VM using VBoxManage interface. (boinc_3b6a5716b3dcb7d0, slot#4) 2024-05-19 16:04:28 (733): Successfully started VM. (PID = '763') 2024-05-19 16:04:28 (733): Reporting VM Process ID to BOINC. 2024-05-19 16:04:28 (733): VM state change detected. (old = 'poweredoff', new = 'running') 2024-05-19 16:04:28 (733): Detected: Web Application Enabled (http://localhost:50948) 2024-05-19 16:04:28 (733): Status Report: Job Duration: '864000.000000' 2024-05-19 16:04:28 (733): Status Report: Elapsed Time: '76623.000000' 2024-05-19 16:04:28 (733): Status Report: CPU Time: '38749.390000' 2024-05-19 16:04:28 (733): Preference change detected 2024-05-19 16:04:28 (733): Setting CPU throttle for VM. (50%) 2024-05-19 16:04:29 (733): Setting checkpoint interval to 600 seconds. (Higher value of (Preference: 60 seconds) or (Vbox_job.xml: 600 seconds)) 2024-05-19 16:04:30 (733): VM state change detected. (old = 'running', new = 'paused') 2024-05-19 16:06:35 (733): VM state change detected. (old = 'paused', new = 'running') 2024-05-19 16:06:40 (733): Guest Log: 21:11:18.302552 timesync vgsvcTimeSyncWorker: Radical host time change: 760 687 550 000 000ns (HostNow=1 716 127 600 558 000 000 ns HostLast=1 715 366 913 008 000 000 ns) 2024-05-19 16:06:45 (733): VM state change detected. (old = 'running', new = 'paused') 2024-05-19 16:07:05 (733): VM state change detected. (old = 'paused', new = 'running') 2024-05-19 16:07:10 (733): Guest Log: 21:11:28.332835 timesync vgsvcTimeSyncWorker: Radical guest time change: 760 844 329 421 000ns (GuestNow=1 716 127 610 588 270 000 ns GuestLast=1 715 366 766 258 849 000 ns fSetTimeLastLoop=true ) 2024-05-19 16:08:07 (733): VM state change detected. (old = 'running', new = 'paused') 2024-05-19 16:08:18 (733): VM state change detected. (old = 'paused', new = 'running') 2024-05-19 16:08:27 (733): VM state change detected. (old = 'running', new = 'paused') 2024-05-19 16:08:57 (733): VM state change detected. (old = 'paused', new = 'running') 2024-05-19 16:15:22 (733): VM state change detected. (old = 'running', new = 'paused') 2024-05-19 16:15:32 (733): VM state change detected. (old = 'paused', new = 'running') 2024-05-19 16:16:23 (733): VM state change detected. (old = 'running', new = 'paused') 2024-05-19 16:16:43 (733): VM state change detected. (old = 'paused', new = 'running') 2024-05-19 16:16:53 (733): VM state change detected. (old = 'running', new = 'paused') 2024-05-19 16:17:04 (733): VM state change detected. (old = 'paused', new = 'running') 2024-05-19 16:18:24 (733): VM state change detected. (old = 'running', new = 'paused') 2024-05-19 16:18:34 (733): VM state change detected. (old = 'paused', new = 'running') 2024-05-19 16:19:05 (733): VM state change detected. (old = 'running', new = 'paused') 2024-05-19 16:19:35 (733): VM state change detected. (old = 'paused', new = 'running') 2024-05-19 16:20:15 (733): VM state change detected. (old = 'running', new = 'paused') 2024-05-19 16:20:46 (733): VM state change detected. (old = 'paused', new = 'running') 2024-05-19 16:20:56 (733): VM state change detected. (old = 'running', new = 'paused') 2024-05-19 16:21:06 (733): VM state change detected. (old = 'paused', new = 'running') 2024-05-19 16:21:16 (733): VM state change detected. (old = 'running', new = 'paused') 2024-05-19 16:21:37 (733): VM state change detected. (old = 'paused', new = 'running') 2024-05-19 16:22:16 (733): VM state change detected. (old = 'running', new = 'paused') 2024-05-19 16:22:37 (733): VM state change detected. (old = 'paused', new = 'running') 2024-05-19 16:23:07 (733): VM state change detected. (old = 'running', new = 'paused') 2024-05-19 16:23:18 (733): VM state change detected. (old = 'paused', new = 'running') 2024-05-19 16:23:48 (733): VM state change detected. (old = 'running', new = 'paused') 2024-05-19 16:23:58 (733): VM state change detected. (old = 'paused', new = 'running') 2024-05-19 16:24:08 (733): VM state change detected. (old = 'running', new = 'paused') 2024-05-19 16:24:28 (733): VM state change detected. (old = 'paused', new = 'running') 2024-05-19 16:29:33 (733): VM state change detected. (old = 'running', new = 'paused') 2024-05-19 16:29:42 (733): VM state change detected. (old = 'paused', new = 'running') 2024-05-19 16:34:35 (733): VM state change detected. (old = 'running', new = 'paused') 2024-05-19 16:34:45 (733): VM state change detected. (old = 'paused', new = 'running') 2024-05-19 16:35:56 (733): VM state change detected. (old = 'running', new = 'paused') 2024-05-19 16:36:07 (733): VM state change detected. (old = 'paused', new = 'running') 2024-05-19 16:52:14 (733): VM state change detected. (old = 'running', new = 'paused') 2024-05-19 16:52:24 (733): VM state change detected. (old = 'paused', new = 'running') 2024-05-19 16:52:34 (733): VM state change detected. (old = 'running', new = 'paused') 2024-05-19 16:52:44 (733): VM state change detected. (old = 'paused', new = 'running') 2024-05-19 17:22:05 (733): VM state change detected. (old = 'running', new = 'paused') 2024-05-19 17:22:15 (733): VM state change detected. (old = 'paused', new = 'running') 2024-05-19 17:35:54 (733): VM state change detected. (old = 'running', new = 'paused') 2024-05-19 17:36:04 (733): VM state change detected. (old = 'paused', new = 'running') 2024-05-19 17:42:29 (733): VM state change detected. (old = 'running', new = 'paused') 2024-05-19 17:42:39 (733): VM state change detected. (old = 'paused', new = 'running') 2024-05-19 17:52:07 (733): Status Report: Job Duration: '864000.000000' 2024-05-19 17:52:07 (733): Status Report: Elapsed Time: '82623.000000' 2024-05-19 17:52:07 (733): Status Report: CPU Time: '41790.190000' 2024-05-19 18:34:26 (733): VM state change detected. (old = 'running', new = 'paused') 2024-05-19 18:34:36 (733): VM state change detected. (old = 'paused', new = 'running') 2024-05-19 19:31:44 (733): Status Report: Job Duration: '864000.000000' 2024-05-19 19:31:44 (733): Status Report: Elapsed Time: '88623.000000' 2024-05-19 19:31:44 (733): Status Report: CPU Time: '44823.580000' 2024-05-19 19:58:21 (733): Stopping VM. 2024-05-19 19:58:25 (733): Successfully stopped VM. 2024-05-20 12:34:49 (693): vboxwrapper version 26207 2024-05-20 12:34:49 (693): BOINC client version: 7.20.2 2024-05-20 12:34:49 (693): Detected: VirtualBox VboxManage Interface (Version: 6.1.36) 2024-05-20 12:34:49 (693): Detected: Sandbox Configuration Enabled 2024-05-20 12:34:49 (693): Detected: Heartbeat check (file: 'heartbeat' every 1200.000000 seconds) 2024-05-20 12:34:50 (693): Guest Log: 21:11:18.302552 timesync vgsvcTimeSyncWorker: Radical host time change: 760 687 550 000 000ns (HostNow=1 716 127 600 558 000 000 ns HostLast=1 715 366 913 008 000 000 ns) 2024-05-20 12:34:50 (693): Guest Log: 21:11:28.332835 timesync vgsvcTimeSyncWorker: Radical guest time change: 760 844 329 421 000ns (GuestNow=1 716 127 610 588 270 000 ns GuestLast=1 715 366 766 258 849 000 ns fSetTimeLastLoop=true ) 2024-05-20 12:34:50 (693): Starting VM using VBoxManage interface. (boinc_3b6a5716b3dcb7d0, slot#4) 2024-05-20 12:34:59 (693): Successfully started VM. (PID = '719') 2024-05-20 12:34:59 (693): Reporting VM Process ID to BOINC. 2024-05-20 12:34:59 (693): VM state change detected. (old = 'poweredoff', new = 'running') 2024-05-20 12:34:59 (693): Detected: Web Application Enabled (http://localhost:50948) 2024-05-20 12:34:59 (693): Status Report: Job Duration: '864000.000000' 2024-05-20 12:34:59 (693): Status Report: Elapsed Time: '90230.000000' 2024-05-20 12:34:59 (693): Status Report: CPU Time: '45632.950000' 2024-05-20 12:34:59 (693): Preference change detected 2024-05-20 12:34:59 (693): Setting CPU throttle for VM. (50%) 2024-05-20 12:34:59 (693): Setting checkpoint interval to 600 seconds. (Higher value of (Preference: 60 seconds) or (Vbox_job.xml: 600 seconds)) 2024-05-20 12:35:01 (693): VM state change detected. (old = 'running', new = 'paused') 2024-05-20 12:37:02 (693): VM state change detected. (old = 'paused', new = 'running') 2024-05-20 12:37:04 (693): Guest Log: 24:57:16.532456 timesync vgsvcTimeSyncWorker: Radical host time change: 59 927 566 000 000ns (HostNow=1 716 201 424 421 000 000 ns HostLast=1 716 141 496 855 000 000 ns) 2024-05-20 12:37:13 (693): VM state change detected. (old = 'running', new = 'paused') 2024-05-20 12:37:43 (693): VM state change detected. (old = 'paused', new = 'running') 2024-05-20 12:37:44 (693): Guest Log: 24:57:26.547900 timesync vgsvcTimeSyncWorker: Radical guest time change: 60 275 648 640 000ns (GuestNow=1 716 201 434 436 485 000 ns GuestLast=1 716 141 158 787 845 000 ns fSetTimeLastLoop=true ) 2024-05-20 12:39:55 (693): VM state change detected. (old = 'running', new = 'paused') 2024-05-20 12:40:06 (693): VM state change detected. (old = 'paused', new = 'running') 2024-05-20 12:55:36 (693): VM state change detected. (old = 'running', new = 'paused') 2024-05-20 12:55:46 (693): VM state change detected. (old = 'paused', new = 'running') 2024-05-20 12:56:06 (693): VM state change detected. (old = 'running', new = 'paused') 2024-05-20 12:56:17 (693): VM state change detected. (old = 'paused', new = 'running') 2024-05-20 12:56:27 (693): VM state change detected. (old = 'running', new = 'paused') 2024-05-20 12:56:37 (693): VM state change detected. (old = 'paused', new = 'running') 2024-05-20 12:56:46 (693): VM state change detected. (old = 'running', new = 'paused') 2024-05-20 12:57:06 (693): VM state change detected. (old = 'paused', new = 'running') 2024-05-20 12:57:27 (693): VM state change detected. (old = 'running', new = 'paused') 2024-05-20 12:57:57 (693): VM state change detected. (old = 'paused', new = 'running') 2024-05-20 12:58:07 (693): VM state change detected. (old = 'running', new = 'paused') 2024-05-20 12:58:28 (693): VM state change detected. (old = 'paused', new = 'running') 2024-05-20 12:59:18 (693): VM state change detected. (old = 'running', new = 'paused') 2024-05-20 12:59:28 (693): VM state change detected. (old = 'paused', new = 'running') 2024-05-20 13:00:19 (693): VM state change detected. (old = 'running', new = 'paused') 2024-05-20 13:00:29 (693): VM state change detected. (old = 'paused', new = 'running') 2024-05-20 13:02:51 (693): VM state change detected. (old = 'running', new = 'paused') 2024-05-20 13:03:01 (693): VM state change detected. (old = 'paused', new = 'running') 2024-05-20 14:19:30 (693): Status Report: Job Duration: '864000.000000' 2024-05-20 14:19:30 (693): Status Report: Elapsed Time: '96230.000000' 2024-05-20 14:19:30 (693): Status Report: CPU Time: '48673.790000' 2024-05-20 14:38:12 (693): Guest Log: job: run exitcode=0 2024-05-20 14:38:12 (693): Guest Log: job: diskusage=99624 2024-05-20 14:38:12 (693): Guest Log: job: logsize=76 k 2024-05-20 14:38:12 (693): Guest Log: job: times= 2024-05-20 14:38:12 (693): Guest Log: 0m0.052s 0m0.092s 2024-05-20 14:38:12 (693): Guest Log: 1559m50.039s 14m18.553s 2024-05-20 14:38:12 (693): Guest Log: job: cpuusage=94449 2024-05-20 14:38:13 (693): Guest Log: 14:35:24 CEST +02:00 2024-05-20: cranky: [INFO] Container 'runc' finished with status code 0. 2024-05-20 14:38:13 (693): Guest Log: 14:35:24 CEST +02:00 2024-05-20: cranky: [INFO] Preparing output. 2024-05-20 14:38:14 (693): Guest Log: [INFO] Job Finished 2024-05-20 14:38:14 (693): Guest Log: [INFO] Shutting Down. 2024-05-20 14:38:14 (693): VM Completion File Detected. 2024-05-20 14:38:14 (693): VM Completion Message: Job Finished . 2024-05-20 14:38:14 (693): Powering off VM. 2024-05-20 14:38:14 (693): Successfully stopped VM. 2024-05-20 14:38:14 (693): Deregistering VM. (boinc_3b6a5716b3dcb7d0, slot#4) 2024-05-20 14:38:14 (693): Removing network bandwidth throttle group from VM. 2024-05-20 14:38:14 (693): Removing VM from VirtualBox. 2024-05-20 14:38:19 (693): called boinc_finish(0) </stderr_txt> ]]>
©2025 CERN