| Name | Theory_2673-2455405-86_1 |
| Workunit | 218416061 |
| Created | 29 Dec 2023, 17:22:04 UTC |
| Sent | 29 Dec 2023, 19:48:30 UTC |
| Report deadline | 9 Jan 2024, 19:48:30 UTC |
| Received | 10 Jan 2024, 2:51:59 UTC |
| Server state | Over |
| Outcome | Success |
| Client state | Done |
| Exit status | 0 (0x00000000) |
| Computer ID | 10681499 |
| Run time | 1 hours 12 min 13 sec |
| CPU time | 42 min 14 sec |
| Validate state | Valid |
| Credit | 35.93 |
| Device peak FLOPS | 3.58 GFLOPS |
| Application version | Theory Simulation v300.10 (vbox64_theory) windows_x86_64 |
| Peak working set size | 76.91 MB |
| Peak swap size | 75.66 MB |
| Peak disk usage | 1.43 GB |
Stderr output
<core_client_version>7.16.11</core_client_version>
<![CDATA[
<stderr_txt>
2023-12-29 14:53:13 (34736): Detected: vboxwrapper 26206
2023-12-29 14:53:13 (34736): Detected: BOINC client v7.16.11
2023-12-29 14:53:13 (34736): Detected: VirtualBox VboxManage Interface (Version: 6.1.12)
2023-12-29 14:53:14 (34736): Detected: Heartbeat check (file: 'heartbeat' every 1200.000000 seconds)
2023-12-29 14:53:14 (34736): Successfully copied 'init_data.xml' to the shared directory.
2023-12-29 14:53:14 (34736): Successfully copied 'input' to the shared directory.
2023-12-29 14:53:14 (34736): Create VM. (boinc_2316c7af891272d7, slot#10)
2023-12-29 14:53:15 (34736): Setting Memory Size for VM. (630MB)
2023-12-29 14:53:15 (34736): Setting CPU Count for VM. (1)
2023-12-29 14:53:15 (34736): Setting Chipset Options for VM.
2023-12-29 14:53:16 (34736): Setting Graphics Controller Options for VM.
2023-12-29 14:53:16 (34736): Setting Boot Options for VM.
2023-12-29 14:53:17 (34736): Setting Network Configuration for NAT.
2023-12-29 14:53:17 (34736): Enabling VM Network Access.
2023-12-29 14:53:17 (34736): Disabling USB Support for VM.
2023-12-29 14:53:18 (34736): Disabling COM Port Support for VM.
2023-12-29 14:53:18 (34736): Disabling LPT Port Support for VM.
2023-12-29 14:53:18 (34736): Disabling Audio Support for VM.
2023-12-29 14:53:18 (34736): Disabling Clipboard Support for VM.
2023-12-29 14:53:19 (34736): Disabling Drag and Drop Support for VM.
2023-12-29 14:53:19 (34736): Adding storage controller(s) to VM.
2023-12-29 14:53:19 (34736): Adding virtual disk drive to VM. (Theory_2023_12_13.vdi)
2023-12-29 14:53:22 (34736): Adding VirtualBox Guest Additions to VM.
2023-12-29 14:53:22 (34736): Adding network bandwidth throttle group to VM. (Defaulting to 1024GB)
2023-12-29 14:53:22 (34736): forwarding host port 51723 to guest port 80
2023-12-29 14:53:23 (34736): Enabling remote desktop for VM.
2023-12-29 14:53:23 (34736): Required extension pack not installed, remote desktop not enabled.
2023-12-29 14:53:23 (34736): Enabling shared directory for VM.
2023-12-29 14:53:23 (34736): Starting VM using VBoxManage interface. (boinc_2316c7af891272d7, slot#10)
2023-12-29 14:53:30 (34736): Successfully started VM. (PID = '35964')
2023-12-29 14:53:30 (34736): Reporting VM Process ID to BOINC.
2023-12-29 14:53:30 (34736): Guest Log: BIOS: VirtualBox 6.1.12
2023-12-29 14:53:30 (34736): Guest Log: CPUID EDX: 0x178bfbff
2023-12-29 14:53:30 (34736): Guest Log: BIOS: No PCI IDE controller, not probing IDE
2023-12-29 14:53:30 (34736): Guest Log: BIOS: AHCI 0-P#0: PCHS=16383/16/63 LCHS=1024/255/63 0x0000000002800000 sectors
2023-12-29 14:53:30 (34736): VM state change detected. (old = 'poweredoff', new = 'running')
2023-12-29 14:53:30 (34736): Detected: Web Application Enabled (http://localhost:51723)
2023-12-29 14:53:32 (34736): VM state change detected. (old = 'running', new = 'paused')
2023-12-29 14:53:38 (34736): Preference change detected
2023-12-29 14:53:38 (34736): Setting CPU throttle for VM. (100%)
2023-12-29 14:53:39 (34736): Setting checkpoint interval to 600 seconds. (Higher value of (Preference: 60 seconds) or (Vbox_job.xml: 600 seconds))
2023-12-29 14:53:39 (34736): VM state change detected. (old = 'paused', new = 'running')
2023-12-29 14:53:40 (34736): Guest Log: BIOS: Boot : bseqnr=1, bootseq=0032
2023-12-29 14:53:40 (34736): Guest Log: BIOS: Booting from Hard Disk...
2023-12-29 14:53:43 (34736): Guest Log: BIOS: KBD: unsupported int 16h function 03
2023-12-29 14:53:43 (34736): Guest Log: BIOS: AX=0305 BX=0000 CX=0000 DX=0000
2023-12-29 14:53:49 (34736): VM state change detected. (old = 'running', new = 'paused')
2023-12-29 14:53:59 (34736): VM state change detected. (old = 'paused', new = 'running')
2023-12-29 14:54:20 (34736): VM state change detected. (old = 'running', new = 'paused')
2023-12-29 14:54:30 (34736): VM state change detected. (old = 'paused', new = 'running')
2023-12-29 14:54:33 (34736): Guest Log: vgdrvHeartbeatInit: Setting up heartbeat to trigger every 2000 milliseconds
2023-12-29 14:54:33 (34736): Guest Log: vboxguest: misc device minor 56, IRQ 20, I/O port d020, MMIO at 00000000f0400000 (size 0x400000)
2023-12-29 14:54:40 (34736): VM state change detected. (old = 'running', new = 'paused')
2023-12-29 14:54:50 (34736): VM state change detected. (old = 'paused', new = 'running')
2023-12-29 14:54:54 (34736): Guest Log: VBoxService 5.2.6 r120293 (verbosity: 0) linux.amd64 (Jan 15 2018 14:51:00) release log
2023-12-29 14:54:54 (34736): Guest Log: 00:00:00.000141 main Log opened 2023-12-29T19:54:27.402343000Z
2023-12-29 14:54:54 (34736): Guest Log: 00:00:00.000456 main OS Product: Linux
2023-12-29 14:54:54 (34736): Guest Log: 00:00:00.000536 main OS Release: 4.14.76-13.cernvm.x86_64
2023-12-29 14:54:54 (34736): Guest Log: 00:00:00.000611 main OS Version: #1 SMP Tue Oct 16 18:26:15 CEST 2018
2023-12-29 14:54:54 (34736): Guest Log: 00:00:00.000672 main Executable: /usr/sbin/VBoxService
2023-12-29 14:54:54 (34736): Guest Log: 00:00:00.000673 main Process ID: 3236
2023-12-29 14:54:54 (34736): Guest Log: 00:00:00.000674 main Package type: LINUX_64BITS_GENERIC
2023-12-29 14:54:54 (34736): Guest Log: 00:00:00.033229 main 5.2.6 r120293 started. Verbose level = 0
2023-12-29 14:55:00 (34736): VM state change detected. (old = 'running', new = 'paused')
2023-12-29 15:01:59 (34736): VM state change detected. (old = 'paused', new = 'running')
2023-12-29 15:02:20 (34736): Guest Log: 14:54:55 EST -05:00 2023-12-29: cranky: [INFO] Detected Theory App
2023-12-29 15:02:20 (34736): Guest Log: 14:54:55 EST -05:00 2023-12-29: cranky: [INFO] Checking CVMFS.
2023-12-29 15:02:20 (34736): Guest Log: Probing /cvmfs/sft.cern.ch... OK
2023-12-29 15:02:21 (34736): 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
2023-12-29 15:02:21 (34736): Guest Log: 2.5.2.0 4097 0 28236 28039 3 1 270121 4096000 0 65024 0 0 n/a 5 2 http://s1fnal-cvmfs.openhtc.io/cvmfs/sft.cern.ch DIRECT 1
2023-12-29 15:02:21 (34736): Guest Log: Probing /cvmfs/grid.cern.ch... OK
2023-12-29 15:02:22 (34736): 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
2023-12-29 15:02:22 (34736): Guest Log: 2.5.2.0 4123 0 27524 23087 3 2 270121 4096000 0 65024 0 2 -100 7839 2111 http://s1ral-cvmfs.openhtc.io/cvmfs/grid.cern.ch DIRECT 1
2023-12-29 15:02:22 (34736): Guest Log: Probing /cvmfs/cernvm-prod.cern.ch... OK
2023-12-29 15:02:23 (34736): 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
2023-12-29 15:02:23 (34736): Guest Log: 2.5.2.0 4146 0 28480 268 3 1 270121 4096000 0 65024 0 0 n/a 4 2 http://s1ral-cvmfs.openhtc.io/cvmfs/cernvm-prod.cern.ch DIRECT 1
2023-12-29 15:02:23 (34736): Guest Log: Probing /cvmfs/alice.cern.ch... OK
2023-12-29 15:02:24 (34736): 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
2023-12-29 15:02:24 (34736): Guest Log: 2.5.2.0 4076 0 37600 17510 3 1 270121 4096000 0 65024 0 0 n/a 4880 1691 http://s1fnal-cvmfs.openhtc.io/cvmfs/alice.cern.ch DIRECT 1
2023-12-29 15:02:24 (34736): Guest Log: 14:54:59 EST -05:00 2023-12-29: cranky: [INFO] Checking runc.
2023-12-29 15:02:24 (34736): Guest Log: 14:54:59 EST -05:00 2023-12-29: cranky: [INFO] Creating the filesystem.
2023-12-29 15:02:24 (34736): Guest Log: 14:54:59 EST -05:00 2023-12-29: cranky: [INFO] Using /cvmfs/cernvm-prod.cern.ch/cvm4
2023-12-29 15:02:24 (34736): Guest Log: 14:54:59 EST -05:00 2023-12-29: cranky: [INFO] Updating config.json.
2023-12-29 15:02:24 (34736): Guest Log: 14:54:59 EST -05:00 2023-12-29: cranky: [INFO] Running Container 'runc'.
2023-12-29 15:02:34 (34736): Stopping VM.
2023-12-29 15:02:37 (34736): Successfully stopped VM.
2023-12-31 15:57:05 (14236): Detected: vboxwrapper 26206
2023-12-31 15:57:05 (14236): Detected: BOINC client v7.16.11
2023-12-31 15:57:08 (14236): Detected: VirtualBox VboxManage Interface (Version: 6.1.12)
2023-12-31 15:57:09 (14236): Detected: Heartbeat check (file: 'heartbeat' every 1200.000000 seconds)
2023-12-31 15:57:09 (14236): Guest Log: BIOS: VirtualBox 6.1.12
2023-12-31 15:57:09 (14236): Guest Log: CPUID EDX: 0x178bfbff
2023-12-31 15:57:09 (14236): Guest Log: BIOS: No PCI IDE controller, not probing IDE
2023-12-31 15:57:09 (14236): Guest Log: BIOS: AHCI 0-P#0: PCHS=16383/16/63 LCHS=1024/255/63 0x0000000002800000 sectors
2023-12-31 15:57:09 (14236): Guest Log: BIOS: Boot : bseqnr=1, bootseq=0032
2023-12-31 15:57:09 (14236): Guest Log: BIOS: Booting from Hard Disk...
2023-12-31 15:57:09 (14236): Guest Log: BIOS: KBD: unsupported int 16h function 03
2023-12-31 15:57:09 (14236): Guest Log: BIOS: AX=0305 BX=0000 CX=0000 DX=0000
2023-12-31 15:57:09 (14236): Guest Log: vgdrvHeartbeatInit: Setting up heartbeat to trigger every 2000 milliseconds
2023-12-31 15:57:09 (14236): Guest Log: vboxguest: misc device minor 56, IRQ 20, I/O port d020, MMIO at 00000000f0400000 (size 0x400000)
2023-12-31 15:57:09 (14236): Guest Log: VBoxService 5.2.6 r120293 (verbosity: 0) linux.amd64 (Jan 15 2018 14:51:00) release log
2023-12-31 15:57:09 (14236): Guest Log: 00:00:00.000141 main Log opened 2023-12-29T19:54:27.402343000Z
2023-12-31 15:57:09 (14236): Guest Log: 00:00:00.000456 main OS Product: Linux
2023-12-31 15:57:09 (14236): Guest Log: 00:00:00.000536 main OS Release: 4.14.76-13.cernvm.x86_64
2023-12-31 15:57:09 (14236): Guest Log: 00:00:00.000611 main OS Version: #1 SMP Tue Oct 16 18:26:15 CEST 2018
2023-12-31 15:57:09 (14236): Guest Log: 00:00:00.000672 main Executable: /usr/sbin/VBoxService
2023-12-31 15:57:09 (14236): Guest Log: 00:00:00.000673 main Process ID: 3236
2023-12-31 15:57:09 (14236): Guest Log: 00:00:00.000674 main Package type: LINUX_64BITS_GENERIC
2023-12-31 15:57:09 (14236): Guest Log: 00:00:00.033229 main 5.2.6 r120293 started. Verbose level = 0
2023-12-31 15:57:09 (14236): Guest Log: 14:54:55 EST -05:00 2023-12-29: cranky: [INFO] Detected Theory App
2023-12-31 15:57:09 (14236): Guest Log: 14:54:55 EST -05:00 2023-12-29: cranky: [INFO] Checking CVMFS.
2023-12-31 15:57:09 (14236): Guest Log: Probing /cvmfs/sft.cern.ch... OK
2023-12-31 15:57:09 (14236): 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
2023-12-31 15:57:09 (14236): Guest Log: 2.5.2.0 4097 0 28236 28039 3 1 270121 4096000 0 65024 0 0 n/a 5 2 http://s1fnal-cvmfs.openhtc.io/cvmfs/sft.cern.ch DIRECT 1
2023-12-31 15:57:09 (14236): Guest Log: Probing /cvmfs/grid.cern.ch... OK
2023-12-31 15:57:09 (14236): 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
2023-12-31 15:57:09 (14236): Guest Log: 2.5.2.0 4123 0 27524 23087 3 2 270121 4096000 0 65024 0 2 -100 7839 2111 http://s1ral-cvmfs.openhtc.io/cvmfs/grid.cern.ch DIRECT 1
2023-12-31 15:57:09 (14236): Guest Log: Probing /cvmfs/cernvm-prod.cern.ch... OK
2023-12-31 15:57:09 (14236): 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
2023-12-31 15:57:09 (14236): Guest Log: 2.5.2.0 4146 0 28480 268 3 1 270121 4096000 0 65024 0 0 n/a 4 2 http://s1ral-cvmfs.openhtc.io/cvmfs/cernvm-prod.cern.ch DIRECT 1
2023-12-31 15:57:09 (14236): Guest Log: Probing /cvmfs/alice.cern.ch... OK
2023-12-31 15:57:09 (14236): 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
2023-12-31 15:57:09 (14236): Guest Log: 2.5.2.0 4076 0 37600 17510 3 1 270121 4096000 0 65024 0 0 n/a 4880 1691 http://s1fnal-cvmfs.openhtc.io/cvmfs/alice.cern.ch DIRECT 1
2023-12-31 15:57:09 (14236): Guest Log: 14:54:59 EST -05:00 2023-12-29: cranky: [INFO] Checking runc.
2023-12-31 15:57:09 (14236): Guest Log: 14:54:59 EST -05:00 2023-12-29: cranky: [INFO] Creating the filesystem.
2023-12-31 15:57:09 (14236): Guest Log: 14:54:59 EST -05:00 2023-12-29: cranky: [INFO] Using /cvmfs/cernvm-prod.cern.ch/cvm4
2023-12-31 15:57:09 (14236): Guest Log: 14:54:59 EST -05:00 2023-12-29: cranky: [INFO] Updating config.json.
2023-12-31 15:57:09 (14236): Guest Log: 14:54:59 EST -05:00 2023-12-29: cranky: [INFO] Running Container 'runc'.
2023-12-31 15:57:09 (14236): Starting VM using VBoxManage interface. (boinc_2316c7af891272d7, slot#10)
2023-12-31 15:57:22 (14236): Successfully started VM. (PID = '18204')
2023-12-31 15:57:22 (14236): Reporting VM Process ID to BOINC.
2023-12-31 15:57:22 (14236): VM state change detected. (old = 'poweredoff', new = 'running')
2023-12-31 15:57:22 (14236): Detected: Web Application Enabled (http://localhost:51723)
2023-12-31 15:57:22 (14236): Preference change detected
2023-12-31 15:57:22 (14236): Setting CPU throttle for VM. (100%)
2023-12-31 15:57:23 (14236): Setting checkpoint interval to 600 seconds. (Higher value of (Preference: 60 seconds) or (Vbox_job.xml: 600 seconds))
2023-12-31 15:57:28 (14236): Guest Log: 00:00:50.069457 timesync vgsvcTimeSyncWorker: Radical host time change: 176 096 263 000 000ns (HostNow=1 704 056 248 699 000 000 ns HostLast=1 703 880 152 436 000 000 ns)
2023-12-31 15:57:38 (14236): Guest Log: job: htmld=/shared/html/job
2023-12-31 15:57:38 (14236): Guest Log: 00:01:00.069823 timesync vgsvcTimeSyncWorker: Radical guest time change: 176 541 228 740 000ns (GuestNow=1 704 056 258 699 823 000 ns GuestLast=1 703 879 717 471 083 000 ns fSetTimeLastLoop=true )
2023-12-31 15:57:39 (14236): Guest Log: job: unpack exitcode=0
2023-12-31 15:57:39 (14236): Guest Log: which: no ld in (/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/shared/bin)
2023-12-31 15:57:40 (14236): Guest Log: INFO: activated the work-around for ld:
2023-12-31 15:57:40 (14236): Guest Log: lrwxrwxrwx 1 0 0 15 Dec 31 20:57 /tmp/tmp.puKCBFyLaA/ld -> /usr/bin/ld.bfd
2023-12-31 15:57:41 (14236): Guest Log: 15:57:41 EST -05:00 2023-12-31: cranky: [INFO] ===> [runRivet] Sun Dec 31 20:57:40 UTC 2023 [boinc pp zinclusive 7000 -,-,50,130 - pythia6 6.428 361 100000 86]
2023-12-31 16:20:42 (14236): Stopping VM.
2023-12-31 16:20:54 (14236): Successfully stopped VM.
2024-01-04 10:51:11 (14816): Detected: vboxwrapper 26206
2024-01-04 10:51:11 (14816): Detected: BOINC client v7.16.11
2024-01-04 10:51:14 (14816): Detected: VirtualBox VboxManage Interface (Version: 6.1.12)
2024-01-04 10:51:15 (14816): Detected: Heartbeat check (file: 'heartbeat' every 1200.000000 seconds)
2024-01-04 10:51:15 (14816): Guest Log: 00:00:50.069457 timesync vgsvcTimeSyncWorker: Radical host time change: 176 096 263 000 000ns (HostNow=1 704 056 248 699 000 000 ns HostLast=1 703 880 152 436 000 000 ns)
2024-01-04 10:51:15 (14816): Guest Log: job: htmld=/shared/html/job
2024-01-04 10:51:15 (14816): Guest Log: 00:01:00.069823 timesync vgsvcTimeSyncWorker: Radical guest time change: 176 541 228 740 000ns (GuestNow=1 704 056 258 699 823 000 ns GuestLast=1 703 879 717 471 083 000 ns fSetTimeLastLoop=true )
2024-01-04 10:51:15 (14816): Guest Log: job: unpack exitcode=0
2024-01-04 10:51:15 (14816): Guest Log: which: no ld in (/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/shared/bin)
2024-01-04 10:51:15 (14816): Guest Log: INFO: activated the work-around for ld:
2024-01-04 10:51:15 (14816): Guest Log: lrwxrwxrwx 1 0 0 15 Dec 31 20:57 /tmp/tmp.puKCBFyLaA/ld -> /usr/bin/ld.bfd
2024-01-04 10:51:15 (14816): Guest Log: 15:57:41 EST -05:00 2023-12-31: cranky: [INFO] ===> [runRivet] Sun Dec 31 20:57:40 UTC 2023 [boinc pp zinclusive 7000 -,-,50,130 - pythia6 6.428 361 100000 86]
2024-01-04 10:51:15 (14816): Starting VM using VBoxManage interface. (boinc_2316c7af891272d7, slot#10)
2024-01-04 10:51:28 (14816): Successfully started VM. (PID = '28592')
2024-01-04 10:51:28 (14816): Reporting VM Process ID to BOINC.
2024-01-04 10:51:28 (14816): VM state change detected. (old = 'poweredoff', new = 'running')
2024-01-04 10:51:28 (14816): Detected: Web Application Enabled (http://localhost:51723)
2024-01-04 10:51:29 (14816): VM state change detected. (old = 'running', new = 'paused')
2024-01-04 10:51:33 (14816): Preference change detected
2024-01-04 10:51:33 (14816): Setting CPU throttle for VM. (100%)
2024-01-04 10:51:34 (14816): Setting checkpoint interval to 600 seconds. (Higher value of (Preference: 60 seconds) or (Vbox_job.xml: 600 seconds))
2024-01-04 10:51:34 (14816): Guest Log: 00:24:10.927912 timesync vgsvcTimeSyncWorker: Radical host time change: 325 854 226 000 000ns (HostNow=1 704 383 493 760 000 000 ns HostLast=1 704 057 639 534 000 000 ns)
2024-01-04 10:51:34 (14816): VM state change detected. (old = 'paused', new = 'running')
2024-01-04 10:51:44 (14816): Guest Log: 00:24:20.933930 timesync vgsvcTimeSyncWorker: Radical guest time change: 325 854 246 376 000ns (GuestNow=1 704 383 503 785 193 000 ns GuestLast=1 704 057 649 538 817 000 ns fSetTimeLastLoop=true )
2024-01-04 11:01:08 (14816): Stopping VM.
2024-01-04 11:01:14 (14816): Successfully stopped VM.
2024-01-04 11:10:19 (7108): Detected: vboxwrapper 26206
2024-01-04 11:10:19 (7108): Detected: BOINC client v7.16.11
2024-01-04 11:10:22 (7108): Detected: VirtualBox VboxManage Interface (Version: 6.1.12)
2024-01-04 11:10:22 (7108): Detected: Heartbeat check (file: 'heartbeat' every 1200.000000 seconds)
2024-01-04 11:10:22 (7108): Guest Log: 00:24:10.927912 timesync vgsvcTimeSyncWorker: Radical host time change: 325 854 226 000 000ns (HostNow=1 704 383 493 760 000 000 ns HostLast=1 704 057 639 534 000 000 ns)
2024-01-04 11:10:22 (7108): Guest Log: 00:24:20.933930 timesync vgsvcTimeSyncWorker: Radical guest time change: 325 854 246 376 000ns (GuestNow=1 704 383 503 785 193 000 ns GuestLast=1 704 057 649 538 817 000 ns fSetTimeLastLoop=true )
2024-01-04 11:10:22 (7108): Starting VM using VBoxManage interface. (boinc_2316c7af891272d7, slot#10)
2024-01-04 11:10:35 (7108): Successfully started VM. (PID = '32948')
2024-01-04 11:10:35 (7108): Reporting VM Process ID to BOINC.
2024-01-04 11:10:35 (7108): VM state change detected. (old = 'poweredoff', new = 'running')
2024-01-04 11:10:35 (7108): Detected: Web Application Enabled (http://localhost:51723)
2024-01-04 11:10:36 (7108): VM state change detected. (old = 'running', new = 'paused')
2024-01-04 11:10:42 (7108): Preference change detected
2024-01-04 11:10:42 (7108): Setting CPU throttle for VM. (100%)
2024-01-04 11:10:43 (7108): Setting checkpoint interval to 600 seconds. (Higher value of (Preference: 60 seconds) or (Vbox_job.xml: 600 seconds))
2024-01-04 11:10:43 (7108): VM state change detected. (old = 'paused', new = 'running')
2024-01-04 11:25:57 (7108): Stopping VM.
2024-01-04 11:26:06 (7108): Successfully stopped VM.
2024-01-05 06:30:14 (26536): Detected: vboxwrapper 26206
2024-01-05 06:30:14 (26536): Detected: BOINC client v7.16.11
2024-01-05 06:30:17 (26536): Detected: VirtualBox VboxManage Interface (Version: 6.1.12)
2024-01-05 06:30:17 (26536): Detected: Heartbeat check (file: 'heartbeat' every 1200.000000 seconds)
2024-01-05 06:30:18 (26536): Starting VM using VBoxManage interface. (boinc_2316c7af891272d7, slot#10)
2024-01-05 06:30:40 (26536): Successfully started VM. (PID = '14956')
2024-01-05 06:30:40 (26536): Reporting VM Process ID to BOINC.
2024-01-05 06:30:40 (26536): VM state change detected. (old = 'poweredoff', new = 'running')
2024-01-05 06:30:40 (26536): Detected: Web Application Enabled (http://localhost:51723)
2024-01-05 06:30:41 (26536): VM state change detected. (old = 'running', new = 'paused')
2024-01-05 06:30:49 (26536): Preference change detected
2024-01-05 06:30:49 (26536): Setting CPU throttle for VM. (100%)
2024-01-05 06:30:50 (26536): Setting checkpoint interval to 600 seconds. (Higher value of (Preference: 60 seconds) or (Vbox_job.xml: 600 seconds))
2024-01-05 06:30:50 (26536): VM state change detected. (old = 'paused', new = 'running')
2024-01-05 06:30:53 (26536): Guest Log: 00:49:12.571041 timesync vgsvcTimeSyncWorker: Radical host time change: 68 697 172 000 000ns (HostNow=1 704 454 253 420 000 000 ns HostLast=1 704 385 556 248 000 000 ns)
2024-01-05 06:31:03 (26536): Guest Log: 00:49:22.575439 timesync vgsvcTimeSyncWorker: Radical guest time change: 68 697 172 367 000ns (GuestNow=1 704 454 263 424 413 000 ns GuestLast=1 704 385 566 252 046 000 ns fSetTimeLastLoop=true )
2024-01-05 06:31:48 (26536): Stopping VM.
2024-01-05 06:31:52 (26536): Successfully stopped VM.
2024-01-05 16:18:08 (15160): Detected: vboxwrapper 26206
2024-01-05 16:18:08 (15160): Detected: BOINC client v7.16.11
2024-01-05 16:18:11 (15160): Detected: VirtualBox VboxManage Interface (Version: 6.1.12)
2024-01-05 16:18:11 (15160): Detected: Heartbeat check (file: 'heartbeat' every 1200.000000 seconds)
2024-01-05 16:18:12 (15160): Guest Log: 00:49:12.571041 timesync vgsvcTimeSyncWorker: Radical host time change: 68 697 172 000 000ns (HostNow=1 704 454 253 420 000 000 ns HostLast=1 704 385 556 248 000 000 ns)
2024-01-05 16:18:12 (15160): Guest Log: 00:49:22.575439 timesync vgsvcTimeSyncWorker: Radical guest time change: 68 697 172 367 000ns (GuestNow=1 704 454 263 424 413 000 ns GuestLast=1 704 385 566 252 046 000 ns fSetTimeLastLoop=true )
2024-01-05 16:18:12 (15160): Starting VM using VBoxManage interface. (boinc_2316c7af891272d7, slot#10)
2024-01-05 16:18:19 (15160): Successfully started VM. (PID = '8484')
2024-01-05 16:18:19 (15160): Reporting VM Process ID to BOINC.
2024-01-05 16:18:19 (15160): VM state change detected. (old = 'poweredoff', new = 'running')
2024-01-05 16:18:19 (15160): Detected: Web Application Enabled (http://localhost:51723)
2024-01-05 16:18:19 (15160): Preference change detected
2024-01-05 16:18:19 (15160): Setting CPU throttle for VM. (100%)
2024-01-05 16:18:20 (15160): Setting checkpoint interval to 600 seconds. (Higher value of (Preference: 60 seconds) or (Vbox_job.xml: 600 seconds))
2024-01-05 16:18:22 (15160): Stopping VM.
2024-01-05 16:18:25 (15160): Successfully stopped VM.
2024-01-05 16:22:50 (22324): Detected: vboxwrapper 26206
2024-01-05 16:22:50 (22324): Detected: BOINC client v7.16.11
2024-01-05 16:22:53 (22324): Detected: VirtualBox VboxManage Interface (Version: 6.1.12)
2024-01-05 16:22:53 (22324): Detected: Heartbeat check (file: 'heartbeat' every 1200.000000 seconds)
2024-01-05 16:22:54 (22324): Starting VM using VBoxManage interface. (boinc_2316c7af891272d7, slot#10)
2024-01-05 16:23:01 (22324): Successfully started VM. (PID = '6788')
2024-01-05 16:23:01 (22324): Reporting VM Process ID to BOINC.
2024-01-05 16:23:01 (22324): Guest Log: 00:50:12.624757 timesync vgsvcTimeSyncWorker: Radical host time change: 35 477 545 000 000ns (HostNow=1 704 489 781 000 000 000 ns HostLast=1 704 454 303 455 000 000 ns)
2024-01-05 16:23:01 (22324): VM state change detected. (old = 'poweredoff', new = 'running')
2024-01-05 16:23:01 (22324): Detected: Web Application Enabled (http://localhost:51723)
2024-01-05 16:23:01 (22324): Preference change detected
2024-01-05 16:23:01 (22324): Setting CPU throttle for VM. (100%)
2024-01-05 16:23:01 (22324): Setting checkpoint interval to 600 seconds. (Higher value of (Preference: 60 seconds) or (Vbox_job.xml: 600 seconds))
2024-01-05 16:23:11 (22324): Guest Log: 00:50:22.632078 timesync vgsvcTimeSyncWorker: Radical guest time change: 35 477 533 650 000ns (GuestNow=1 704 489 791 007 344 000 ns GuestLast=1 704 454 313 473 694 000 ns fSetTimeLastLoop=true )
2024-01-05 16:25:28 (22324): Stopping VM.
2024-01-05 16:25:33 (22324): Successfully stopped VM.
2024-01-09 08:49:53 (18836): Detected: vboxwrapper 26206
2024-01-09 08:49:53 (18836): Detected: BOINC client v7.16.11
2024-01-09 08:49:56 (18836): Detected: VirtualBox VboxManage Interface (Version: 6.1.12)
2024-01-09 08:49:56 (18836): Detected: Heartbeat check (file: 'heartbeat' every 1200.000000 seconds)
2024-01-09 08:49:56 (18836): Guest Log: 00:50:12.624757 timesync vgsvcTimeSyncWorker: Radical host time change: 35 477 545 000 000ns (HostNow=1 704 489 781 000 000 000 ns HostLast=1 704 454 303 455 000 000 ns)
2024-01-09 08:49:56 (18836): Guest Log: 00:50:22.632078 timesync vgsvcTimeSyncWorker: Radical guest time change: 35 477 533 650 000ns (GuestNow=1 704 489 791 007 344 000 ns GuestLast=1 704 454 313 473 694 000 ns fSetTimeLastLoop=true )
2024-01-09 08:49:56 (18836): ERROR: VM failed to start
2024-01-09 08:50:01 (18836):
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-01-09 08:55:16 (31552): Detected: vboxwrapper 26206
2024-01-09 08:55:16 (31552): Detected: BOINC client v7.16.11
2024-01-09 08:55:18 (31552): Detected: VirtualBox VboxManage Interface (Version: 6.1.12)
2024-01-09 08:55:19 (31552): Detected: Heartbeat check (file: 'heartbeat' every 1200.000000 seconds)
2024-01-09 08:55:19 (31552): Guest Log: 00:50:12.624757 timesync vgsvcTimeSyncWorker: Radical host time change: 35 477 545 000 000ns (HostNow=1 704 489 781 000 000 000 ns HostLast=1 704 454 303 455 000 000 ns)
2024-01-09 08:55:19 (31552): Guest Log: 00:50:22.632078 timesync vgsvcTimeSyncWorker: Radical guest time change: 35 477 533 650 000ns (GuestNow=1 704 489 791 007 344 000 ns GuestLast=1 704 454 313 473 694 000 ns fSetTimeLastLoop=true )
2024-01-09 08:55:19 (31552): Starting VM using VBoxManage interface. (boinc_2316c7af891272d7, slot#10)
2024-01-09 08:55:34 (31552): Successfully started VM. (PID = '45008')
2024-01-09 08:55:34 (31552): Reporting VM Process ID to BOINC.
2024-01-09 08:55:34 (31552): VM state change detected. (old = 'poweredoff', new = 'running')
2024-01-09 08:55:34 (31552): Detected: Web Application Enabled (http://localhost:51723)
2024-01-09 08:55:35 (31552): VM state change detected. (old = 'running', new = 'paused')
2024-01-09 08:55:41 (31552): Preference change detected
2024-01-09 08:55:41 (31552): Setting CPU throttle for VM. (100%)
2024-01-09 08:55:42 (31552): Setting checkpoint interval to 600 seconds. (Higher value of (Preference: 60 seconds) or (Vbox_job.xml: 600 seconds))
2024-01-09 08:55:42 (31552): VM state change detected. (old = 'paused', new = 'running')
2024-01-09 08:55:43 (31552): Guest Log: 00:52:42.804156 timesync vgsvcTimeSyncWorker: Radical host time change: 318 621 583 000 000ns (HostNow=1 704 808 542 740 000 000 ns HostLast=1 704 489 921 157 000 000 ns)
2024-01-09 08:55:53 (31552): Guest Log: 00:52:52.813342 timesync vgsvcTimeSyncWorker: Radical guest time change: 318 621 569 822 000ns (GuestNow=1 704 808 552 749 191 000 ns GuestLast=1 704 489 931 179 369 000 ns fSetTimeLastLoop=true )
2024-01-09 08:57:02 (31552): Stopping VM.
2024-01-09 08:57:06 (31552): Successfully stopped VM.
2024-01-09 21:08:49 (23816): Detected: vboxwrapper 26206
2024-01-09 21:08:49 (23816): Detected: BOINC client v7.16.11
2024-01-09 21:08:51 (23816): Detected: VirtualBox VboxManage Interface (Version: 6.1.12)
2024-01-09 21:08:52 (23816): Detected: Heartbeat check (file: 'heartbeat' every 1200.000000 seconds)
2024-01-09 21:08:52 (23816): Guest Log: 00:52:42.804156 timesync vgsvcTimeSyncWorker: Radical host time change: 318 621 583 000 000ns (HostNow=1 704 808 542 740 000 000 ns HostLast=1 704 489 921 157 000 000 ns)
2024-01-09 21:08:52 (23816): Guest Log: 00:52:52.813342 timesync vgsvcTimeSyncWorker: Radical guest time change: 318 621 569 822 000ns (GuestNow=1 704 808 552 749 191 000 ns GuestLast=1 704 489 931 179 369 000 ns fSetTimeLastLoop=true )
2024-01-09 21:08:52 (23816): Starting VM using VBoxManage interface. (boinc_2316c7af891272d7, slot#10)
2024-01-09 21:09:06 (23816): Successfully started VM. (PID = '25380')
2024-01-09 21:09:06 (23816): Reporting VM Process ID to BOINC.
2024-01-09 21:09:06 (23816): VM state change detected. (old = 'poweredoff', new = 'running')
2024-01-09 21:09:06 (23816): Detected: Web Application Enabled (http://localhost:51723)
2024-01-09 21:09:07 (23816): VM state change detected. (old = 'running', new = 'paused')
2024-01-09 21:09:14 (23816): Preference change detected
2024-01-09 21:09:14 (23816): Setting CPU throttle for VM. (100%)
2024-01-09 21:09:15 (23816): Setting checkpoint interval to 600 seconds. (Higher value of (Preference: 60 seconds) or (Vbox_job.xml: 600 seconds))
2024-01-09 21:09:15 (23816): VM state change detected. (old = 'paused', new = 'running')
2024-01-09 21:09:23 (23816): Guest Log: 00:54:12.845277 timesync vgsvcTimeSyncWorker: Radical host time change: 43 940 542 000 000ns (HostNow=1 704 852 563 322 000 000 ns HostLast=1 704 808 622 780 000 000 ns)
2024-01-09 21:09:33 (23816): Guest Log: 00:54:22.846251 timesync vgsvcTimeSyncWorker: Radical guest time change: 43 940 541 975 000ns (GuestNow=1 704 852 573 323 015 000 ns GuestLast=1 704 808 632 781 040 000 ns fSetTimeLastLoop=true )
2024-01-09 21:21:54 (23816): Stopping VM.
2024-01-09 21:22:29 (23816): Successfully stopped VM.
2024-01-09 21:25:18 (25640): Detected: vboxwrapper 26206
2024-01-09 21:25:18 (25640): Detected: BOINC client v7.16.11
2024-01-09 21:25:21 (25640): Detected: VirtualBox VboxManage Interface (Version: 6.1.12)
2024-01-09 21:25:21 (25640): Detected: Heartbeat check (file: 'heartbeat' every 1200.000000 seconds)
2024-01-09 21:25:22 (25640): Guest Log: 00:54:12.845277 timesync vgsvcTimeSyncWorker: Radical host time change: 43 940 542 000 000ns (HostNow=1 704 852 563 322 000 000 ns HostLast=1 704 808 622 780 000 000 ns)
2024-01-09 21:25:22 (25640): Guest Log: 00:54:22.846251 timesync vgsvcTimeSyncWorker: Radical guest time change: 43 940 541 975 000ns (GuestNow=1 704 852 573 323 015 000 ns GuestLast=1 704 808 632 781 040 000 ns fSetTimeLastLoop=true )
2024-01-09 21:25:22 (25640): Starting VM using VBoxManage interface. (boinc_2316c7af891272d7, slot#10)
2024-01-09 21:25:37 (25640): Successfully started VM. (PID = '1096')
2024-01-09 21:25:37 (25640): Reporting VM Process ID to BOINC.
2024-01-09 21:25:37 (25640): VM state change detected. (old = 'poweredoff', new = 'running')
2024-01-09 21:25:37 (25640): Detected: Web Application Enabled (http://localhost:51723)
2024-01-09 21:25:38 (25640): VM state change detected. (old = 'running', new = 'paused')
2024-01-09 21:25:39 (25640): Preference change detected
2024-01-09 21:25:39 (25640): Setting CPU throttle for VM. (100%)
2024-01-09 21:25:40 (25640): Setting checkpoint interval to 600 seconds. (Higher value of (Preference: 60 seconds) or (Vbox_job.xml: 600 seconds))
2024-01-09 21:25:40 (25640): VM state change detected. (old = 'paused', new = 'running')
2024-01-09 21:27:50 (25640): Stopping VM.
2024-01-09 21:27:57 (25640): Successfully stopped VM.
2024-01-09 21:33:22 (2064): Detected: vboxwrapper 26206
2024-01-09 21:33:22 (2064): Detected: BOINC client v7.16.11
2024-01-09 21:33:25 (2064): Detected: VirtualBox VboxManage Interface (Version: 6.1.12)
2024-01-09 21:33:25 (2064): Detected: Heartbeat check (file: 'heartbeat' every 1200.000000 seconds)
2024-01-09 21:33:26 (2064): Starting VM using VBoxManage interface. (boinc_2316c7af891272d7, slot#10)
2024-01-09 21:33:38 (2064): Successfully started VM. (PID = '22876')
2024-01-09 21:33:38 (2064): Reporting VM Process ID to BOINC.
2024-01-09 21:33:38 (2064): VM state change detected. (old = 'poweredoff', new = 'running')
2024-01-09 21:33:38 (2064): Detected: Web Application Enabled (http://localhost:51723)
2024-01-09 21:33:39 (2064): VM state change detected. (old = 'running', new = 'paused')
2024-01-09 21:33:43 (2064): Preference change detected
2024-01-09 21:33:43 (2064): Setting CPU throttle for VM. (100%)
2024-01-09 21:33:43 (2064): Setting checkpoint interval to 600 seconds. (Higher value of (Preference: 60 seconds) or (Vbox_job.xml: 600 seconds))
2024-01-09 21:33:43 (2064): VM state change detected. (old = 'paused', new = 'running')
2024-01-09 21:34:43 (2064): Stopping VM.
2024-01-09 21:34:52 (2064): Successfully stopped VM.
2024-01-09 21:44:09 (8316): Detected: vboxwrapper 26206
2024-01-09 21:44:09 (8316): Detected: BOINC client v7.16.11
2024-01-09 21:44:12 (8316): Detected: VirtualBox VboxManage Interface (Version: 6.1.12)
2024-01-09 21:44:12 (8316): Detected: Heartbeat check (file: 'heartbeat' every 1200.000000 seconds)
2024-01-09 21:44:13 (8316): Starting VM using VBoxManage interface. (boinc_2316c7af891272d7, slot#10)
2024-01-09 21:44:29 (8316): Successfully started VM. (PID = '4000')
2024-01-09 21:44:29 (8316): Reporting VM Process ID to BOINC.
2024-01-09 21:44:29 (8316): VM state change detected. (old = 'poweredoff', new = 'running')
2024-01-09 21:44:29 (8316): Detected: Web Application Enabled (http://localhost:51723)
2024-01-09 21:44:30 (8316): VM state change detected. (old = 'running', new = 'paused')
2024-01-09 21:44:38 (8316): Preference change detected
2024-01-09 21:44:38 (8316): Setting CPU throttle for VM. (100%)
2024-01-09 21:44:39 (8316): Setting checkpoint interval to 600 seconds. (Higher value of (Preference: 60 seconds) or (Vbox_job.xml: 600 seconds))
2024-01-09 21:44:39 (8316): VM state change detected. (old = 'paused', new = 'running')
2024-01-09 21:47:35 (8316): Stopping VM.
2024-01-09 21:47:42 (8316): Successfully stopped VM.
2024-01-09 21:50:35 (25072): Detected: vboxwrapper 26206
2024-01-09 21:50:35 (25072): Detected: BOINC client v7.16.11
2024-01-09 21:50:38 (25072): Detected: VirtualBox VboxManage Interface (Version: 6.1.12)
2024-01-09 21:50:38 (25072): Detected: Heartbeat check (file: 'heartbeat' every 1200.000000 seconds)
2024-01-09 21:50:39 (25072): Starting VM using VBoxManage interface. (boinc_2316c7af891272d7, slot#10)
2024-01-09 21:50:52 (25072): Successfully started VM. (PID = '7244')
2024-01-09 21:50:52 (25072): Reporting VM Process ID to BOINC.
2024-01-09 21:50:52 (25072): VM state change detected. (old = 'poweredoff', new = 'running')
2024-01-09 21:50:52 (25072): Detected: Web Application Enabled (http://localhost:51723)
2024-01-09 21:50:53 (25072): VM state change detected. (old = 'running', new = 'paused')
2024-01-09 21:51:02 (25072): Preference change detected
2024-01-09 21:51:02 (25072): Setting CPU throttle for VM. (100%)
2024-01-09 21:51:04 (25072): Setting checkpoint interval to 600 seconds. (Higher value of (Preference: 60 seconds) or (Vbox_job.xml: 600 seconds))
2024-01-09 21:51:04 (25072): VM state change detected. (old = 'paused', new = 'running')
2024-01-09 21:51:34 (25072): Guest Log: job: run exitcode=0
2024-01-09 21:51:34 (25072): Guest Log: job: diskusage=3268
2024-01-09 21:51:34 (25072): Guest Log: job: logsize=60 k
2024-01-09 21:51:34 (25072): Guest Log: job: times=
2024-01-09 21:51:34 (25072): Guest Log: 0m0.013s 0m0.074s
2024-01-09 21:51:34 (25072): Guest Log: 69m7.642s 0m19.394s
2024-01-09 21:51:34 (25072): Guest Log: job: cpuusage=4167
2024-01-09 21:51:35 (25072): Guest Log: 21:51:24 EST -05:00 2024-01-09: cranky: [INFO] Container 'runc' finished with status code 0.
2024-01-09 21:51:35 (25072): Guest Log: 21:51:24 EST -05:00 2024-01-09: cranky: [INFO] Preparing output.
2024-01-09 21:51:36 (25072): Guest Log: [INFO] Job Finished
2024-01-09 21:51:36 (25072): Guest Log: [INFO] Shutting Down.
2024-01-09 21:51:36 (25072): VM Completion File Detected.
2024-01-09 21:51:36 (25072): VM Completion Message: Job Finished
.
2024-01-09 21:51:36 (25072): Powering off VM.
2024-01-09 21:51:38 (25072): Successfully stopped VM.
2024-01-09 21:51:38 (25072): Deregistering VM. (boinc_2316c7af891272d7, slot#10)
2024-01-09 21:51:40 (25072): Removing network bandwidth throttle group from VM.
2024-01-09 21:51:40 (25072): Removing VM from VirtualBox.
21:51:46 (25072): called boinc_finish(0)
</stderr_txt>
]]>
©2025 CERN