| Name | Theory_2390-1132034-161_0 |
| Workunit | 150087631 |
| Created | 19 Dec 2020, 8:02:38 UTC |
| Sent | 19 Dec 2020, 11:17:22 UTC |
| Report deadline | 30 Dec 2020, 11:17:22 UTC |
| Received | 30 Dec 2020, 14:49:19 UTC |
| Server state | Over |
| Outcome | Success |
| Client state | Done |
| Exit status | 0 (0x00000000) |
| Computer ID | 10659218 |
| Run time | 2 hours 33 min 27 sec |
| CPU time | 1 hours 53 min 48 sec |
| Validate state | Valid |
| Credit | 64.99 |
| Device peak FLOPS | 3.05 GFLOPS |
| Application version | Theory Simulation v300.06 (vbox64_theory) windows_x86_64 |
| Peak working set size | 71.92 MB |
| Peak swap size | 77.32 MB |
| Peak disk usage | 1.94 GB |
Stderr output
<core_client_version>7.16.7</core_client_version> <![CDATA[ <stderr_txt> 2020-12-19 12:17:39 (2968): Detected: vboxwrapper 26197 2020-12-19 12:17:39 (2968): Detected: BOINC client v7.7 2020-12-19 12:17:40 (2968): Detected: VirtualBox VboxManage Interface (Version: 6.0.14) 2020-12-19 12:17:40 (2968): Detected: Heartbeat check (file: 'heartbeat' every 1200.000000 seconds) 2020-12-19 12:17:40 (2968): Successfully copied 'init_data.xml' to the shared directory. 2020-12-19 12:17:40 (2968): Successfully copied 'input' to the shared directory. 2020-12-19 12:17:42 (2968): Create VM. (boinc_dd9b8adfa876df41, slot#2) 2020-12-19 12:17:43 (2968): Setting Memory Size for VM. (630MB) 2020-12-19 12:17:43 (2968): Setting CPU Count for VM. (1) 2020-12-19 12:17:43 (2968): Setting Chipset Options for VM. 2020-12-19 12:17:44 (2968): Setting Boot Options for VM. 2020-12-19 12:17:44 (2968): Setting Network Configuration for NAT. 2020-12-19 12:17:44 (2968): Enabling VM Network Access. 2020-12-19 12:17:45 (2968): Disabling USB Support for VM. 2020-12-19 12:17:45 (2968): Disabling COM Port Support for VM. 2020-12-19 12:17:45 (2968): Disabling LPT Port Support for VM. 2020-12-19 12:17:46 (2968): Disabling Audio Support for VM. 2020-12-19 12:17:46 (2968): Disabling Clipboard Support for VM. 2020-12-19 12:17:46 (2968): Disabling Drag and Drop Support for VM. 2020-12-19 12:17:46 (2968): Adding storage controller(s) to VM. 2020-12-19 12:17:47 (2968): Adding virtual disk drive to VM. (vm_image.vdi) 2020-12-19 12:17:47 (2968): Adding VirtualBox Guest Additions to VM. 2020-12-19 12:17:47 (2968): Adding network bandwidth throttle group to VM. (Defaulting to 1024GB) 2020-12-19 12:17:48 (2968): forwarding host port 54080 to guest port 80 2020-12-19 12:17:48 (2968): Enabling remote desktop for VM. 2020-12-19 12:17:48 (2968): Required extension pack not installed, remote desktop not enabled. 2020-12-19 12:17:48 (2968): Enabling shared directory for VM. 2020-12-19 12:17:48 (2968): Starting VM using VBoxManage interface. (boinc_dd9b8adfa876df41, slot#2) 2020-12-19 12:17:54 (2968): Successfully started VM. (PID = '10796') 2020-12-19 12:17:54 (2968): Reporting VM Process ID to BOINC. 2020-12-19 12:17:55 (2968): Guest Log: BIOS: VirtualBox 6.0.14 2020-12-19 12:17:55 (2968): Guest Log: CPUID EDX: 0x178bfbff 2020-12-19 12:17:55 (2968): Guest Log: BIOS: ata0-0: PCHS=16383/16/63 LCHS=1024/255/63 2020-12-19 12:17:55 (2968): VM state change detected. (old = 'PoweredOff', new = 'Running') 2020-12-19 12:17:55 (2968): Detected: Web Application Enabled (http://localhost:54080) 2020-12-19 12:17:55 (2968): Preference change detected 2020-12-19 12:17:55 (2968): Setting CPU throttle for VM. (90%) 2020-12-19 12:17:55 (2968): Setting checkpoint interval to 600 seconds. (Higher value of (Preference: 60 seconds) or (Vbox_job.xml: 600 seconds)) 2020-12-19 12:17:57 (2968): Guest Log: BIOS: Boot : bseqnr=1, bootseq=0032 2020-12-19 12:17:57 (2968): Guest Log: BIOS: Booting from Hard Disk... 2020-12-19 12:17:59 (2968): Guest Log: BIOS: KBD: unsupported int 16h function 03 2020-12-19 12:17:59 (2968): Guest Log: BIOS: AX=0305 BX=0000 CX=0000 DX=0000 2020-12-19 12:18:23 (2968): Guest Log: vgdrvHeartbeatInit: Setting up heartbeat to trigger every 2000 milliseconds 2020-12-19 12:18:23 (2968): Guest Log: vboxguest: misc device minor 56, IRQ 20, I/O port d020, MMIO at 00000000f0400000 (size 0x400000) 2020-12-19 12:18:28 (2968): Guest Log: VBoxService 5.2.6 r120293 (verbosity: 0) linux.amd64 (Jan 15 2018 14:51:00) release log 2020-12-19 12:18:28 (2968): Guest Log: 00:00:00.000208 main Log opened 2020-12-19T11:18:29.730806000Z 2020-12-19 12:18:28 (2968): Guest Log: 00:00:00.000396 main OS Product: Linux 2020-12-19 12:18:28 (2968): Guest Log: 00:00:00.000475 main OS Release: 4.14.76-13.cernvm.x86_64 2020-12-19 12:18:28 (2968): Guest Log: 00:00:00.000552 main OS Version: #1 SMP Tue Oct 16 18:26:15 CEST 2018 2020-12-19 12:18:28 (2968): Guest Log: 00:00:00.000637 main Executable: /usr/sbin/VBoxService 2020-12-19 12:18:28 (2968): Guest Log: 00:00:00.000639 main Process ID: 3185 2020-12-19 12:18:28 (2968): Guest Log: 00:00:00.000640 main Package type: LINUX_64BITS_GENERIC 2020-12-19 12:18:28 (2968): Guest Log: 00:00:00.005479 main 5.2.6 r120293 started. Verbose level = 0 2020-12-19 12:19:10 (2968): Guest Log: 12:19:11 CET +01:00 2020-12-19: cranky: [INFO] Detected Theory App 2020-12-19 12:19:10 (2968): Guest Log: 12:19:11 CET +01:00 2020-12-19: cranky: [INFO] Checking CVMFS. 2020-12-19 12:19:13 (2968): Guest Log: Probing /cvmfs/sft.cern.ch... OK 2020-12-19 12:19:15 (2968): 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 2020-12-19 12:19:15 (2968): Guest Log: 2.5.2.0 4096 0 26204 19382 3 1 264991 4096000 0 65024 0 0 n/a 5 6 http://s1cern-cvmfs.openhtc.io/cvmfs/sft.cern.ch DIRECT 1 2020-12-19 12:19:18 (2968): Guest Log: Probing /cvmfs/grid.cern.ch... OK 2020-12-19 12:19:20 (2968): 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 2020-12-19 12:19:20 (2968): Guest Log: 2.5.2.0 4075 0 27540 13979 3 2 264991 4096000 0 65024 0 2 -100 6424 3181 http://s1cern-cvmfs.openhtc.io/cvmfs/grid.cern.ch DIRECT 1 2020-12-19 12:19:23 (2968): Guest Log: Probing /cvmfs/cernvm-prod.cern.ch... OK 2020-12-19 12:19:25 (2968): 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 2020-12-19 12:19:25 (2968): Guest Log: 2.5.2.0 4055 0 27232 259 3 1 264991 4096000 0 65024 0 0 n/a 4 11 http://s1cern-cvmfs.openhtc.io/cvmfs/cernvm-prod.cern.ch DIRECT 1 2020-12-19 12:19:28 (2968): Guest Log: Probing /cvmfs/alice.cern.ch... OK 2020-12-19 12:19:30 (2968): 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 2020-12-19 12:19:30 (2968): Guest Log: 2.5.2.0 4032 0 29388 8226 3 1 264991 4096000 0 65024 0 0 n/a 4685 2247 http://s1ral-cvmfs.openhtc.io/cvmfs/alice.cern.ch DIRECT 1 2020-12-19 12:19:30 (2968): Guest Log: 12:19:31 CET +01:00 2020-12-19: cranky: [INFO] Checking runc. 2020-12-19 12:19:30 (2968): Guest Log: 12:19:31 CET +01:00 2020-12-19: cranky: [INFO] Creating the filesystem. 2020-12-19 12:19:30 (2968): Guest Log: 12:19:31 CET +01:00 2020-12-19: cranky: [INFO] Using /cvmfs/cernvm-prod.cern.ch/cvm3 2020-12-19 12:19:30 (2968): Guest Log: 12:19:32 CET +01:00 2020-12-19: cranky: [INFO] Updating config.json. 2020-12-19 12:19:31 (2968): Guest Log: 12:19:32 CET +01:00 2020-12-19: cranky: [INFO] Running Container 'runc'. 2020-12-19 12:19:38 (2968): Guest Log: job: htmld=/shared/html/job 2020-12-19 12:19:38 (2968): Guest Log: job: unpack exitcode=0 2020-12-19 12:19:39 (2968): Guest Log: 12:19:40 CET +01:00 2020-12-19: cranky: [INFO] ===> [runRivet] Sat Dec 19 11:19:39 UTC 2020 [boinc pp jets 8000 180,-,3560 - pythia6 6.428 p2010 100000 161] 2020-12-19 12:23:49 (2968): Stopping VM. 2020-12-19 12:52:12 (6356): Detected: vboxwrapper 26197 2020-12-19 12:52:12 (6356): Detected: BOINC client v7.7 2020-12-19 12:52:14 (6356): Detected: VirtualBox VboxManage Interface (Version: 6.0.14) 2020-12-19 12:52:15 (6356): Detected: Heartbeat check (file: 'heartbeat' every 1200.000000 seconds) 2020-12-19 12:52:15 (6356): Starting VM using VBoxManage interface. (boinc_dd9b8adfa876df41, slot#2) 2020-12-19 12:52:42 (6356): Successfully started VM. (PID = '796') 2020-12-19 12:52:42 (6356): Reporting VM Process ID to BOINC. 2020-12-19 12:52:43 (6356): VM state change detected. (old = 'PoweredOff', new = 'Running') 2020-12-19 12:52:43 (6356): Detected: Web Application Enabled (http://localhost:54080) 2020-12-19 12:52:56 (6356): VM state change detected. (old = 'Running', new = 'Paused') 2020-12-19 12:52:57 (6356): Preference change detected 2020-12-19 12:52:57 (6356): Setting CPU throttle for VM. (90%) 2020-12-19 12:52:59 (6356): Setting checkpoint interval to 600 seconds. (Higher value of (Preference: 60 seconds) or (Vbox_job.xml: 600 seconds)) 2020-12-19 12:52:59 (6356): VM state change detected. (old = 'Paused', new = 'Running') 2020-12-19 12:53:11 (6356): VM state change detected. (old = 'Running', new = 'Paused') 2020-12-19 15:12:37 (6356): VM state change detected. (old = 'Paused', new = 'Running') 2020-12-19 15:12:41 (6356): Guest Log: 00:06:03.288693 timesync vgsvcTimeSyncWorker: Radical host time change: 8 375 210 000 000ns (HostNow=1 608 387 161 106 000 000 ns HostLast=1 608 378 785 896 000 000 ns) 2020-12-19 15:12:46 (6356): Stopping VM. 2020-12-19 15:13:51 (7260): Detected: vboxwrapper 26197 2020-12-19 15:13:51 (7260): Detected: BOINC client v7.7 2020-12-19 15:13:52 (7260): Detected: VirtualBox VboxManage Interface (Version: 6.0.14) 2020-12-19 15:13:52 (7260): Detected: Heartbeat check (file: 'heartbeat' every 1200.000000 seconds) 2020-12-19 15:13:53 (7260): Starting VM using VBoxManage interface. (boinc_dd9b8adfa876df41, slot#2) 2020-12-19 15:14:08 (7260): Successfully started VM. (PID = '11964') 2020-12-19 15:14:08 (7260): Reporting VM Process ID to BOINC. 2020-12-19 15:14:08 (7260): VM state change detected. (old = 'PoweredOff', new = 'Running') 2020-12-19 15:14:08 (7260): Detected: Web Application Enabled (http://localhost:54080) 2020-12-19 15:14:09 (7260): VM state change detected. (old = 'Running', new = 'Paused') 2020-12-19 15:14:12 (7260): Preference change detected 2020-12-19 15:14:12 (7260): Setting CPU throttle for VM. (90%) 2020-12-19 15:14:12 (7260): Setting checkpoint interval to 600 seconds. (Higher value of (Preference: 60 seconds) or (Vbox_job.xml: 600 seconds)) 2020-12-19 15:14:12 (7260): VM state change detected. (old = 'Paused', new = 'Running') 2020-12-19 15:14:14 (7260): Guest Log: 00:06:13.291765 timesync vgsvcTimeSyncWorker: Radical guest time change: 8 375 838 970 000ns (GuestNow=1 608 387 171 114 767 000 ns GuestLast=1 608 378 795 275 797 000 ns fSetTimeLastLoop=true ) 2020-12-19 15:16:16 (7260): Stopping VM. 2020-12-19 15:17:18 (2632): Detected: vboxwrapper 26197 2020-12-19 15:17:18 (2632): Detected: BOINC client v7.7 2020-12-19 15:17:20 (2632): Detected: VirtualBox VboxManage Interface (Version: 6.0.14) 2020-12-19 15:17:20 (2632): Detected: Heartbeat check (file: 'heartbeat' every 1200.000000 seconds) 2020-12-19 15:17:21 (2632): Starting VM using VBoxManage interface. (boinc_dd9b8adfa876df41, slot#2) 2020-12-19 15:18:04 (2632): Successfully started VM. (PID = '3584') 2020-12-19 15:18:04 (2632): Reporting VM Process ID to BOINC. 2020-12-19 15:18:04 (2632): VM state change detected. (old = 'PoweredOff', new = 'Running') 2020-12-19 15:18:04 (2632): Detected: Web Application Enabled (http://localhost:54080) 2020-12-19 15:19:34 (2632): VM state change detected. (old = 'Running', new = 'Paused') 2020-12-19 16:14:37 (2632): Preference change detected 2020-12-19 16:14:37 (2632): Setting CPU throttle for VM. (90%) 2020-12-19 16:14:37 (2632): Setting checkpoint interval to 600 seconds. (Higher value of (Preference: 60 seconds) or (Vbox_job.xml: 600 seconds)) 2020-12-19 16:14:37 (2632): VM state change detected. (old = 'Paused', new = 'Running') 2020-12-19 16:14:43 (2632): Guest Log: 00:10:13.421873 timesync vgsvcTimeSyncWorker: Radical host time change: 3 313 772 000 000ns (HostNow=1 608 390 883 706 000 000 ns HostLast=1 608 387 569 934 000 000 ns) 2020-12-19 16:14:53 (2632): Guest Log: 00:10:23.440765 timesync vgsvcTimeSyncWorker: Radical guest time change: 3 313 780 201 000ns (GuestNow=1 608 390 893 724 910 000 ns GuestLast=1 608 387 579 944 709 000 ns fSetTimeLastLoop=true ) 2020-12-19 16:15:07 (2632): VM state change detected. (old = 'Running', new = 'Paused') 2020-12-19 16:15:57 (2632): VM state change detected. (old = 'Paused', new = 'Running') 2020-12-19 16:17:08 (2632): VM state change detected. (old = 'Running', new = 'Paused') 2020-12-28 16:43:20 (2632): VM state change detected. (old = 'Paused', new = 'Running') 2020-12-28 16:43:25 (2632): Guest Log: 00:11:53.483659 timesync vgsvcTimeSyncWorker: Radical host time change: 779 181 897 000 000ns (HostNow=1 609 170 205 328 000 000 ns HostLast=1 608 391 023 431 000 000 ns) 2020-12-28 16:43:35 (2632): Guest Log: 00:12:03.509230 timesync vgsvcTimeSyncWorker: Radical guest time change: 779 231 585 809 000ns (GuestNow=1 609 170 215 353 591 000 ns GuestLast=1 608 390 983 767 782 000 ns fSetTimeLastLoop=true ) 2020-12-28 16:44:14 (2632): Stopping VM. 2020-12-28 16:57:21 (13708): Detected: vboxwrapper 26197 2020-12-28 16:57:21 (13708): Detected: BOINC client v7.7 2020-12-28 16:57:22 (13708): Detected: VirtualBox VboxManage Interface (Version: 6.0.14) 2020-12-28 16:57:23 (13708): Detected: Heartbeat check (file: 'heartbeat' every 1200.000000 seconds) 2020-12-28 16:57:24 (13708): Starting VM using VBoxManage interface. (boinc_dd9b8adfa876df41, slot#2) 2020-12-28 16:57:35 (13708): Successfully started VM. (PID = '13180') 2020-12-28 16:57:35 (13708): Reporting VM Process ID to BOINC. 2020-12-28 16:57:35 (13708): VM state change detected. (old = 'PoweredOff', new = 'Running') 2020-12-28 16:57:35 (13708): Detected: Web Application Enabled (http://localhost:54080) 2020-12-28 16:57:36 (13708): VM state change detected. (old = 'Running', new = 'Paused') 2020-12-28 16:57:42 (13708): Preference change detected 2020-12-28 16:57:42 (13708): Setting CPU throttle for VM. (90%) 2020-12-28 16:57:43 (13708): Setting checkpoint interval to 600 seconds. (Higher value of (Preference: 60 seconds) or (Vbox_job.xml: 600 seconds)) 2020-12-28 16:57:43 (13708): VM state change detected. (old = 'Paused', new = 'Running') 2020-12-28 17:01:04 (13708): Stopping VM. 2020-12-28 17:02:33 (14024): Detected: vboxwrapper 26197 2020-12-28 17:02:33 (14024): Detected: BOINC client v7.7 2020-12-28 17:02:34 (14024): Detected: VirtualBox VboxManage Interface (Version: 6.0.14) 2020-12-28 17:02:34 (14024): Detected: Heartbeat check (file: 'heartbeat' every 1200.000000 seconds) 2020-12-28 17:02:34 (14024): Starting VM using VBoxManage interface. (boinc_dd9b8adfa876df41, slot#2) 2020-12-28 17:02:48 (14024): Successfully started VM. (PID = '11812') 2020-12-28 17:02:48 (14024): Reporting VM Process ID to BOINC. 2020-12-28 17:02:48 (14024): VM state change detected. (old = 'PoweredOff', new = 'Running') 2020-12-28 17:02:48 (14024): Detected: Web Application Enabled (http://localhost:54080) 2020-12-28 17:02:49 (14024): VM state change detected. (old = 'Running', new = 'Paused') 2020-12-28 17:02:53 (14024): Preference change detected 2020-12-28 17:02:53 (14024): Setting CPU throttle for VM. (90%) 2020-12-28 17:02:53 (14024): Setting checkpoint interval to 600 seconds. (Higher value of (Preference: 60 seconds) or (Vbox_job.xml: 600 seconds)) 2020-12-28 17:02:54 (14024): VM state change detected. (old = 'Paused', new = 'Running') 2020-12-28 17:05:25 (14024): Stopping VM. 2020-12-29 14:34:00 (1520): Detected: vboxwrapper 26197 2020-12-29 14:34:00 (1520): Detected: BOINC client v7.7 2020-12-29 14:34:02 (1520): Detected: VirtualBox VboxManage Interface (Version: 6.0.14) 2020-12-29 14:34:02 (1520): Detected: Heartbeat check (file: 'heartbeat' every 1200.000000 seconds) 2020-12-29 14:34:02 (1520): Starting VM using VBoxManage interface. (boinc_dd9b8adfa876df41, slot#2) 2020-12-29 14:34:22 (1520): Successfully started VM. (PID = '8652') 2020-12-29 14:34:22 (1520): Reporting VM Process ID to BOINC. 2020-12-29 14:34:22 (1520): Guest Log: 00:18:43.801462 timesync vgsvcTimeSyncWorker: Radical host time change: 77 343 876 000 000ns (HostNow=1 609 248 861 426 000 000 ns HostLast=1 609 171 517 550 000 000 ns) 2020-12-29 14:34:22 (1520): VM state change detected. (old = 'PoweredOff', new = 'Running') 2020-12-29 14:34:22 (1520): Detected: Web Application Enabled (http://localhost:54080) 2020-12-29 14:34:23 (1520): VM state change detected. (old = 'Running', new = 'Paused') 2020-12-29 14:34:29 (1520): Preference change detected 2020-12-29 14:34:29 (1520): Setting CPU throttle for VM. (90%) 2020-12-29 14:34:30 (1520): Setting checkpoint interval to 600 seconds. (Higher value of (Preference: 60 seconds) or (Vbox_job.xml: 600 seconds)) 2020-12-29 14:34:30 (1520): VM state change detected. (old = 'Paused', new = 'Running') 2020-12-29 14:34:38 (1520): Guest Log: 00:18:53.809237 timesync vgsvcTimeSyncWorker: Radical guest time change: 77 343 878 147 000ns (GuestNow=1 609 248 871 433 782 000 ns GuestLast=1 609 171 527 555 635 000 ns fSetTimeLastLoop=true ) 2020-12-29 14:44:18 (1520): Stopping VM. 2020-12-29 14:47:32 (4636): Detected: vboxwrapper 26197 2020-12-29 14:47:32 (4636): Detected: BOINC client v7.7 2020-12-29 14:47:33 (4636): Detected: VirtualBox VboxManage Interface (Version: 6.0.14) 2020-12-29 14:47:34 (4636): Detected: Heartbeat check (file: 'heartbeat' every 1200.000000 seconds) 2020-12-29 14:47:34 (4636): Starting VM using VBoxManage interface. (boinc_dd9b8adfa876df41, slot#2) 2020-12-29 14:47:48 (4636): Successfully started VM. (PID = '6436') 2020-12-29 14:47:49 (4636): Reporting VM Process ID to BOINC. 2020-12-29 14:47:49 (4636): VM state change detected. (old = 'PoweredOff', new = 'Running') 2020-12-29 14:47:49 (4636): Detected: Web Application Enabled (http://localhost:54080) 2020-12-29 14:47:54 (4636): VM state change detected. (old = 'Running', new = 'Paused') 2020-12-29 14:47:55 (4636): Preference change detected 2020-12-29 14:47:55 (4636): Setting CPU throttle for VM. (90%) 2020-12-29 14:47:56 (4636): Setting checkpoint interval to 600 seconds. (Higher value of (Preference: 60 seconds) or (Vbox_job.xml: 600 seconds)) 2020-12-29 14:47:56 (4636): VM state change detected. (old = 'Paused', new = 'Running') 2020-12-29 14:54:54 (1092): Detected: vboxwrapper 26197 2020-12-29 14:54:54 (1092): Detected: BOINC client v7.7 2020-12-29 14:54:56 (1092): Detected: VirtualBox VboxManage Interface (Version: 6.0.14) 2020-12-29 14:54:56 (1092): Detected: Heartbeat check (file: 'heartbeat' every 1200.000000 seconds) 2020-12-29 14:54:56 (1092): Starting VM using VBoxManage interface. (boinc_dd9b8adfa876df41, slot#2) 2020-12-29 14:55:05 (1092): Successfully started VM. (PID = '1044') 2020-12-29 14:55:05 (1092): Reporting VM Process ID to BOINC. 2020-12-29 14:55:05 (1092): Guest Log: BIOS: VirtualBox 6.0.14 2020-12-29 14:55:05 (1092): Guest Log: CPUID EDX: 0x178bfbff 2020-12-29 14:55:05 (1092): Guest Log: BIOS: ata0-0: PCHS=16383/16/63 LCHS=1024/255/63 2020-12-29 14:55:05 (1092): VM state change detected. (old = 'PoweredOff', new = 'Running') 2020-12-29 14:55:06 (1092): VM state change detected. (old = 'Running', new = 'Paused') 2020-12-29 14:56:08 (1092): Preference change detected 2020-12-29 14:56:08 (1092): Setting CPU throttle for VM. (90%) 2020-12-29 14:56:08 (1092): Setting checkpoint interval to 600 seconds. (Higher value of (Preference: 60 seconds) or (Vbox_job.xml: 600 seconds)) 2020-12-29 14:56:09 (1092): VM state change detected. (old = 'Paused', new = 'Running') 2020-12-29 14:56:10 (1092): Guest Log: BIOS: Boot : bseqnr=1, bootseq=0032 2020-12-29 14:56:10 (1092): Guest Log: BIOS: Booting from Hard Disk... 2020-12-29 14:56:13 (1092): Guest Log: BIOS: KBD: unsupported int 16h function 03 2020-12-29 14:56:13 (1092): Guest Log: BIOS: AX=0305 BX=0000 CX=0000 DX=0000 2020-12-29 14:56:38 (1092): Guest Log: vgdrvHeartbeatInit: Setting up heartbeat to trigger every 2000 milliseconds 2020-12-29 14:56:38 (1092): Guest Log: vboxguest: misc device minor 56, IRQ 20, I/O port d020, MMIO at 00000000f0400000 (size 0x400000) 2020-12-29 14:56:44 (1092): Guest Log: VBoxService 5.2.6 r120293 (verbosity: 0) linux.amd64 (Jan 15 2018 14:51:00) release log 2020-12-29 14:56:44 (1092): Guest Log: 00:00:00.000262 main Log opened 2020-12-29T13:56:50.589997000Z 2020-12-29 14:56:44 (1092): Guest Log: 00:00:00.001812 main OS Product: Linux 2020-12-29 14:56:44 (1092): Guest Log: 00:00:00.001996 main OS Release: 4.14.76-13.cernvm.x86_64 2020-12-29 14:56:44 (1092): Guest Log: 00:00:00.002055 main OS Version: #1 SMP Tue Oct 16 18:26:15 CEST 2018 2020-12-29 14:56:44 (1092): Guest Log: 00:00:00.002110 main Executable: /usr/sbin/VBoxService 2020-12-29 14:56:44 (1092): Guest Log: 00:00:00.002112 main Process ID: 3188 2020-12-29 14:56:44 (1092): Guest Log: 00:00:00.002113 main Package type: LINUX_64BITS_GENERIC 2020-12-29 14:56:44 (1092): Guest Log: 00:00:00.009042 main 5.2.6 r120293 started. Verbose level = 0 2020-12-29 14:57:28 (1092): Guest Log: 14:57:34 CET +01:00 2020-12-29: cranky: [INFO] Detected Theory App 2020-12-29 14:57:28 (1092): Guest Log: 14:57:34 CET +01:00 2020-12-29: cranky: [INFO] Checking CVMFS. 2020-12-29 14:57:31 (1092): Guest Log: Probing /cvmfs/sft.cern.ch... OK 2020-12-29 14:57:32 (1092): 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 2020-12-29 14:57:32 (1092): Guest Log: 2.5.2.0 4036 0 26164 19402 3 1 1185723 4096001 0 65024 0 0 n/a 0 0 http://s1cern-cvmfs.openhtc.io/cvmfs/sft.cern.ch DIRECT 1 2020-12-29 14:57:36 (1092): Guest Log: Probing /cvmfs/grid.cern.ch... OK 2020-12-29 14:57:38 (1092): 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 2020-12-29 14:57:38 (1092): Guest Log: 2.5.2.0 4103 0 25504 14059 3 2 1185723 4096001 0 65024 0 2 0 4281 1980 http://s1ral-cvmfs.openhtc.io/cvmfs/grid.cern.ch DIRECT 1 2020-12-29 14:57:41 (1092): Guest Log: Probing /cvmfs/cernvm-prod.cern.ch... OK 2020-12-29 14:57:43 (1092): 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 2020-12-29 14:57:43 (1092): Guest Log: 2.5.2.0 4083 0 27188 259 3 1 1185723 4096001 0 65024 0 0 n/a 0 0 http://s1unl-cvmfs.openhtc.io/cvmfs/cernvm-prod.cern.ch DIRECT 1 2020-12-29 14:57:46 (1092): VM state change detected. (old = 'Running', new = 'Paused') 2020-12-29 14:57:56 (1092): Guest Log: Probing /cvmfs/alice.cern.ch... OK 2020-12-29 14:57:56 (1092): VM state change detected. (old = 'Paused', new = 'Running') 2020-12-29 14:57:58 (1092): 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 2020-12-29 14:57:58 (1092): Guest Log: 2.5.2.0 4062 0 30700 8284 3 1 1185723 4096001 0 65024 0 0 n/a 4697 619 http://s1asgc-cvmfs.openhtc.io:8080/cvmfs/alice.cern.ch DIRECT 1 2020-12-29 14:57:58 (1092): Guest Log: 14:57:54 CET +01:00 2020-12-29: cranky: [INFO] Checking runc. 2020-12-29 14:57:58 (1092): Guest Log: 14:57:55 CET +01:00 2020-12-29: cranky: [INFO] Creating the filesystem. 2020-12-29 14:57:58 (1092): Guest Log: 14:57:55 CET +01:00 2020-12-29: cranky: [INFO] Using /cvmfs/cernvm-prod.cern.ch/cvm3 2020-12-29 14:57:59 (1092): Guest Log: 14:57:55 CET +01:00 2020-12-29: cranky: [INFO] Updating config.json. 2020-12-29 14:57:59 (1092): Guest Log: 14:57:55 CET +01:00 2020-12-29: cranky: [INFO] Running Container 'runc'. 2020-12-29 14:58:00 (1092): Guest Log: job: htmld=/shared/html/job 2020-12-29 14:58:00 (1092): Guest Log: job: unpack exitcode=0 2020-12-29 14:58:01 (1092): Guest Log: 14:57:57 CET +01:00 2020-12-29: cranky: [INFO] ===> [runRivet] Tue Dec 29 13:57:57 UTC 2020 [boinc pp jets 8000 180,-,3560 - pythia6 6.428 p2010 100000 161] 2020-12-29 14:58:16 (1092): VM state change detected. (old = 'Running', new = 'Paused') 2020-12-29 14:58:26 (1092): VM state change detected. (old = 'Paused', new = 'Running') 2020-12-29 15:00:22 (1092): Stopping VM. 2020-12-29 15:01:23 (7360): Detected: vboxwrapper 26197 2020-12-29 15:01:23 (7360): Detected: BOINC client v7.7 2020-12-29 15:01:24 (7360): Detected: VirtualBox VboxManage Interface (Version: 6.0.14) 2020-12-29 15:01:24 (7360): Detected: Heartbeat check (file: 'heartbeat' every 1200.000000 seconds) 2020-12-29 15:01:24 (7360): Starting VM using VBoxManage interface. (boinc_dd9b8adfa876df41, slot#2) 2020-12-29 15:01:38 (7360): Successfully started VM. (PID = '928') 2020-12-29 15:01:38 (7360): Reporting VM Process ID to BOINC. 2020-12-29 15:01:38 (7360): VM state change detected. (old = 'PoweredOff', new = 'Running') 2020-12-29 15:01:39 (7360): VM state change detected. (old = 'Running', new = 'Paused') 2020-12-29 15:01:47 (7360): Preference change detected 2020-12-29 15:01:47 (7360): Setting CPU throttle for VM. (90%) 2020-12-29 15:01:47 (7360): Setting checkpoint interval to 600 seconds. (Higher value of (Preference: 60 seconds) or (Vbox_job.xml: 600 seconds)) 2020-12-29 15:01:48 (7360): VM state change detected. (old = 'Paused', new = 'Running') 2020-12-29 15:22:50 (7360): VM state change detected. (old = 'Running', new = 'Paused') 2020-12-29 15:23:10 (7360): VM state change detected. (old = 'Paused', new = 'Running') 2020-12-29 15:24:48 (7360): Stopping VM. 2020-12-29 15:26:08 (10400): Detected: vboxwrapper 26197 2020-12-29 15:26:08 (10400): Detected: BOINC client v7.7 2020-12-29 15:26:09 (10400): Detected: VirtualBox VboxManage Interface (Version: 6.0.14) 2020-12-29 15:26:09 (10400): Detected: Heartbeat check (file: 'heartbeat' every 1200.000000 seconds) 2020-12-29 15:26:09 (10400): Starting VM using VBoxManage interface. (boinc_dd9b8adfa876df41, slot#2) 2020-12-29 15:26:20 (10400): Successfully started VM. (PID = '3228') 2020-12-29 15:26:20 (10400): Reporting VM Process ID to BOINC. 2020-12-29 15:26:20 (10400): VM state change detected. (old = 'PoweredOff', new = 'Running') 2020-12-29 15:26:21 (10400): VM state change detected. (old = 'Running', new = 'Paused') 2020-12-29 15:26:30 (10400): Preference change detected 2020-12-29 15:26:30 (10400): Setting CPU throttle for VM. (90%) 2020-12-29 15:26:30 (10400): Setting checkpoint interval to 600 seconds. (Higher value of (Preference: 60 seconds) or (Vbox_job.xml: 600 seconds)) 2020-12-29 15:26:31 (10400): VM state change detected. (old = 'Paused', new = 'Running') 2020-12-29 15:27:59 (10400): Stopping VM. 2020-12-29 15:29:52 (840): Detected: vboxwrapper 26197 2020-12-29 15:29:52 (840): Detected: BOINC client v7.7 2020-12-29 15:29:53 (840): Detected: VirtualBox VboxManage Interface (Version: 6.0.14) 2020-12-29 15:29:53 (840): Detected: Heartbeat check (file: 'heartbeat' every 1200.000000 seconds) 2020-12-29 15:29:54 (840): Starting VM using VBoxManage interface. (boinc_dd9b8adfa876df41, slot#2) 2020-12-29 15:30:04 (840): Successfully started VM. (PID = '1164') 2020-12-29 15:30:04 (840): Reporting VM Process ID to BOINC. 2020-12-29 15:30:04 (840): VM state change detected. (old = 'PoweredOff', new = 'Running') 2020-12-29 15:30:05 (840): VM state change detected. (old = 'Running', new = 'Paused') 2020-12-29 15:30:11 (840): Preference change detected 2020-12-29 15:30:11 (840): Setting CPU throttle for VM. (90%) 2020-12-29 15:30:11 (840): Setting checkpoint interval to 600 seconds. (Higher value of (Preference: 60 seconds) or (Vbox_job.xml: 600 seconds)) 2020-12-29 15:30:11 (840): VM state change detected. (old = 'Paused', new = 'Running') 2020-12-29 15:30:46 (840): Stopping VM. 2020-12-29 15:32:43 (9452): Detected: vboxwrapper 26197 2020-12-29 15:32:43 (9452): Detected: BOINC client v7.7 2020-12-29 15:32:44 (9452): Detected: VirtualBox VboxManage Interface (Version: 6.0.14) 2020-12-29 15:32:44 (9452): Detected: Heartbeat check (file: 'heartbeat' every 1200.000000 seconds) 2020-12-29 15:32:44 (9452): Starting VM using VBoxManage interface. (boinc_dd9b8adfa876df41, slot#2) 2020-12-29 15:32:55 (9452): Successfully started VM. (PID = '9420') 2020-12-29 15:32:55 (9452): Reporting VM Process ID to BOINC. 2020-12-29 15:32:55 (9452): VM state change detected. (old = 'PoweredOff', new = 'Running') 2020-12-29 15:32:55 (9452): Stopping VM. 2020-12-29 15:38:34 (9064): Detected: vboxwrapper 26197 2020-12-29 15:38:34 (9064): Detected: BOINC client v7.7 2020-12-29 15:38:35 (9064): Detected: VirtualBox VboxManage Interface (Version: 6.0.14) 2020-12-29 15:38:35 (9064): Detected: Heartbeat check (file: 'heartbeat' every 1200.000000 seconds) 2020-12-29 15:38:35 (9064): Starting VM using VBoxManage interface. (boinc_dd9b8adfa876df41, slot#2) 2020-12-29 15:38:46 (9064): Successfully started VM. (PID = '8524') 2020-12-29 15:38:46 (9064): Reporting VM Process ID to BOINC. 2020-12-29 15:38:46 (9064): VM state change detected. (old = 'PoweredOff', new = 'Running') 2020-12-29 15:38:47 (9064): VM state change detected. (old = 'Running', new = 'Paused') 2020-12-29 15:41:09 (9064): Preference change detected 2020-12-29 15:41:09 (9064): Setting CPU throttle for VM. (90%) 2020-12-29 15:41:09 (9064): Setting checkpoint interval to 600 seconds. (Higher value of (Preference: 60 seconds) or (Vbox_job.xml: 600 seconds)) 2020-12-29 15:41:10 (9064): VM state change detected. (old = 'Paused', new = 'Running') 2020-12-29 15:41:31 (9064): Stopping VM. 2020-12-29 15:42:39 (3036): Detected: vboxwrapper 26197 2020-12-29 15:42:39 (3036): Detected: BOINC client v7.7 2020-12-29 15:42:40 (3036): Detected: VirtualBox VboxManage Interface (Version: 6.0.14) 2020-12-29 15:42:40 (3036): Detected: Heartbeat check (file: 'heartbeat' every 1200.000000 seconds) 2020-12-29 15:42:41 (3036): Starting VM using VBoxManage interface. (boinc_dd9b8adfa876df41, slot#2) 2020-12-29 15:42:51 (3036): Successfully started VM. (PID = '6200') 2020-12-29 15:42:51 (3036): Reporting VM Process ID to BOINC. 2020-12-29 15:42:51 (3036): VM state change detected. (old = 'PoweredOff', new = 'Running') 2020-12-29 15:42:51 (3036): Preference change detected 2020-12-29 15:42:51 (3036): Setting CPU throttle for VM. (90%) 2020-12-29 15:42:51 (3036): Setting checkpoint interval to 600 seconds. (Higher value of (Preference: 60 seconds) or (Vbox_job.xml: 600 seconds)) 2020-12-29 15:42:54 (3036): VM state change detected. (old = 'Running', new = 'Paused') 2020-12-29 15:43:04 (3036): VM state change detected. (old = 'Paused', new = 'Running') 2020-12-29 15:46:52 (3036): Stopping VM. 2020-12-29 15:47:53 (7224): Detected: vboxwrapper 26197 2020-12-29 15:47:53 (7224): Detected: BOINC client v7.7 2020-12-29 15:47:54 (7224): Detected: VirtualBox VboxManage Interface (Version: 6.0.14) 2020-12-29 15:47:54 (7224): Detected: Heartbeat check (file: 'heartbeat' every 1200.000000 seconds) 2020-12-29 15:47:54 (7224): Starting VM using VBoxManage interface. (boinc_dd9b8adfa876df41, slot#2) 2020-12-29 15:48:06 (7224): Successfully started VM. (PID = '7868') 2020-12-29 15:48:06 (7224): Reporting VM Process ID to BOINC. 2020-12-29 15:48:06 (7224): VM state change detected. (old = 'PoweredOff', new = 'Running') 2020-12-29 15:48:07 (7224): VM state change detected. (old = 'Running', new = 'Paused') 2020-12-29 15:48:14 (7224): Preference change detected 2020-12-29 15:48:14 (7224): Setting CPU throttle for VM. (90%) 2020-12-29 15:48:14 (7224): Setting checkpoint interval to 600 seconds. (Higher value of (Preference: 60 seconds) or (Vbox_job.xml: 600 seconds)) 2020-12-29 15:48:15 (7224): VM state change detected. (old = 'Paused', new = 'Running') 2020-12-29 15:49:12 (7224): Stopping VM. 2020-12-29 15:51:08 (6068): Detected: vboxwrapper 26197 2020-12-29 15:51:08 (6068): Detected: BOINC client v7.7 2020-12-29 15:51:09 (6068): Detected: VirtualBox VboxManage Interface (Version: 6.0.14) 2020-12-29 15:51:10 (6068): Detected: Heartbeat check (file: 'heartbeat' every 1200.000000 seconds) 2020-12-29 15:51:10 (6068): Starting VM using VBoxManage interface. (boinc_dd9b8adfa876df41, slot#2) 2020-12-29 15:51:21 (6068): Successfully started VM. (PID = '9916') 2020-12-29 15:51:21 (6068): Reporting VM Process ID to BOINC. 2020-12-29 15:51:21 (6068): VM state change detected. (old = 'PoweredOff', new = 'Running') 2020-12-29 15:51:22 (6068): VM state change detected. (old = 'Running', new = 'Paused') 2020-12-29 15:51:24 (6068): Preference change detected 2020-12-29 15:51:24 (6068): Setting CPU throttle for VM. (90%) 2020-12-29 15:51:24 (6068): Setting checkpoint interval to 600 seconds. (Higher value of (Preference: 60 seconds) or (Vbox_job.xml: 600 seconds)) 2020-12-29 15:51:25 (6068): VM state change detected. (old = 'Paused', new = 'Running') 2020-12-29 15:54:15 (6068): VM state change detected. (old = 'Running', new = 'Paused') 2020-12-29 15:54:25 (6068): VM state change detected. (old = 'Paused', new = 'Running') 2020-12-29 15:54:28 (6068): Stopping VM. 2020-12-29 15:58:15 (3460): Detected: vboxwrapper 26197 2020-12-29 15:58:15 (3460): Detected: BOINC client v7.7 2020-12-29 15:58:16 (3460): Detected: VirtualBox VboxManage Interface (Version: 6.0.14) 2020-12-29 15:58:16 (3460): Detected: Heartbeat check (file: 'heartbeat' every 1200.000000 seconds) 2020-12-29 15:58:17 (3460): Starting VM using VBoxManage interface. (boinc_dd9b8adfa876df41, slot#2) 2020-12-29 15:58:27 (3460): Successfully started VM. (PID = '3716') 2020-12-29 15:58:27 (3460): Reporting VM Process ID to BOINC. 2020-12-29 15:58:27 (3460): VM state change detected. (old = 'PoweredOff', new = 'Running') 2020-12-29 15:58:28 (3460): VM state change detected. (old = 'Running', new = 'Paused') 2020-12-29 15:58:34 (3460): Preference change detected 2020-12-29 15:58:34 (3460): Setting CPU throttle for VM. (90%) 2020-12-29 15:58:35 (3460): Setting checkpoint interval to 600 seconds. (Higher value of (Preference: 60 seconds) or (Vbox_job.xml: 600 seconds)) 2020-12-29 15:58:35 (3460): VM state change detected. (old = 'Paused', new = 'Running') 2020-12-29 16:02:07 (3460): Stopping VM. 2020-12-29 16:03:28 (11100): Detected: vboxwrapper 26197 2020-12-29 16:03:28 (11100): Detected: BOINC client v7.7 2020-12-29 16:03:29 (11100): Detected: VirtualBox VboxManage Interface (Version: 6.0.14) 2020-12-29 16:03:29 (11100): Detected: Heartbeat check (file: 'heartbeat' every 1200.000000 seconds) 2020-12-29 16:03:29 (11100): Starting VM using VBoxManage interface. (boinc_dd9b8adfa876df41, slot#2) 2020-12-29 16:03:39 (11100): Successfully started VM. (PID = '6004') 2020-12-29 16:03:39 (11100): Reporting VM Process ID to BOINC. 2020-12-29 16:03:39 (11100): VM state change detected. (old = 'PoweredOff', new = 'Running') 2020-12-29 16:03:40 (11100): VM state change detected. (old = 'Running', new = 'Paused') 2020-12-29 16:03:46 (11100): Preference change detected 2020-12-29 16:03:46 (11100): Setting CPU throttle for VM. (90%) 2020-12-29 16:03:46 (11100): Setting checkpoint interval to 600 seconds. (Higher value of (Preference: 60 seconds) or (Vbox_job.xml: 600 seconds)) 2020-12-29 16:03:46 (11100): VM state change detected. (old = 'Paused', new = 'Running') 2020-12-29 16:04:02 (11100): Stopping VM. 2020-12-29 16:05:03 (2428): Detected: vboxwrapper 26197 2020-12-29 16:05:03 (2428): Detected: BOINC client v7.7 2020-12-29 16:05:04 (2428): Detected: VirtualBox VboxManage Interface (Version: 6.0.14) 2020-12-29 16:05:04 (2428): Detected: Heartbeat check (file: 'heartbeat' every 1200.000000 seconds) 2020-12-29 16:05:05 (2428): Starting VM using VBoxManage interface. (boinc_dd9b8adfa876df41, slot#2) 2020-12-29 16:05:15 (2428): Successfully started VM. (PID = '7564') 2020-12-29 16:05:15 (2428): Reporting VM Process ID to BOINC. 2020-12-29 16:05:15 (2428): VM state change detected. (old = 'PoweredOff', new = 'Running') 2020-12-29 16:05:15 (2428): Preference change detected 2020-12-29 16:05:15 (2428): Setting CPU throttle for VM. (90%) 2020-12-29 16:05:16 (2428): Setting checkpoint interval to 600 seconds. (Higher value of (Preference: 60 seconds) or (Vbox_job.xml: 600 seconds)) 2020-12-29 16:05:17 (2428): VM state change detected. (old = 'Running', new = 'Paused') 2020-12-29 16:05:27 (2428): VM state change detected. (old = 'Paused', new = 'Running') 2020-12-29 16:06:47 (2428): Stopping VM. 2020-12-29 16:47:19 (9752): Detected: vboxwrapper 26197 2020-12-29 16:47:19 (9752): Detected: BOINC client v7.7 2020-12-29 16:47:20 (9752): Detected: VirtualBox VboxManage Interface (Version: 6.0.14) 2020-12-29 16:47:20 (9752): Detected: Heartbeat check (file: 'heartbeat' every 1200.000000 seconds) 2020-12-29 16:47:20 (9752): Starting VM using VBoxManage interface. (boinc_dd9b8adfa876df41, slot#2) 2020-12-29 16:47:36 (9752): Successfully started VM. (PID = '10844') 2020-12-29 16:47:36 (9752): Reporting VM Process ID to BOINC. 2020-12-29 16:47:36 (9752): VM state change detected. (old = 'PoweredOff', new = 'Running') 2020-12-29 16:47:41 (9752): VM state change detected. (old = 'Running', new = 'Paused') 2020-12-29 16:47:42 (9752): Preference change detected 2020-12-29 16:47:42 (9752): Setting CPU throttle for VM. (90%) 2020-12-29 16:47:44 (9752): Setting checkpoint interval to 600 seconds. (Higher value of (Preference: 60 seconds) or (Vbox_job.xml: 600 seconds)) 2020-12-29 16:47:44 (9752): Guest Log: 00:41:51.219788 timesync vgsvcTimeSyncWorker: Radical host time change: 2 456 860 000 000ns (HostNow=1 609 256 857 539 000 000 ns HostLast=1 609 254 400 679 000 000 ns) 2020-12-29 16:47:44 (9752): VM state change detected. (old = 'Paused', new = 'Running') 2020-12-29 16:47:52 (9752): VM state change detected. (old = 'Running', new = 'Paused') 2020-12-29 16:58:14 (9752): Stopping VM. 2020-12-29 16:58:14 (9752): Error in stop VM for VM: -108 Command: VBoxManage -q controlvm "boinc_dd9b8adfa876df41" savestate Output: 2020-12-29 16:58:14 (9752): VM did not stop when requested. 2020-12-29 16:58:14 (9752): VM was successfully terminated. 2020-12-29 23:29:48 (5352): Detected: vboxwrapper 26197 2020-12-29 23:29:48 (5352): Detected: BOINC client v7.7 2020-12-29 23:29:49 (5352): Detected: VirtualBox VboxManage Interface (Version: 6.0.14) 2020-12-29 23:29:49 (5352): Detected: Heartbeat check (file: 'heartbeat' every 1200.000000 seconds) 2020-12-29 23:29:50 (5352): Starting VM using VBoxManage interface. (boinc_dd9b8adfa876df41, slot#2) 2020-12-29 23:29:58 (5352): Successfully started VM. (PID = '7772') 2020-12-29 23:29:58 (5352): Reporting VM Process ID to BOINC. 2020-12-29 23:29:58 (5352): Guest Log: BIOS: VirtualBox 6.0.14 2020-12-29 23:29:58 (5352): Guest Log: CPUID EDX: 0x178bfbff 2020-12-29 23:29:58 (5352): Guest Log: BIOS: ata0-0: PCHS=16383/16/63 LCHS=1024/255/63 2020-12-29 23:29:58 (5352): VM state change detected. (old = 'PoweredOff', new = 'Running') 2020-12-29 23:29:59 (5352): VM state change detected. (old = 'Running', new = 'Paused') 2020-12-29 23:30:05 (5352): Preference change detected 2020-12-29 23:30:05 (5352): Setting CPU throttle for VM. (90%) 2020-12-29 23:30:05 (5352): Setting checkpoint interval to 600 seconds. (Higher value of (Preference: 60 seconds) or (Vbox_job.xml: 600 seconds)) 2020-12-29 23:30:06 (5352): VM state change detected. (old = 'Paused', new = 'Running') 2020-12-29 23:30:07 (5352): Guest Log: BIOS: Boot : bseqnr=1, bootseq=0032 2020-12-29 23:30:07 (5352): Guest Log: BIOS: Booting from Hard Disk... 2020-12-29 23:30:09 (5352): Guest Log: BIOS: KBD: unsupported int 16h function 03 2020-12-29 23:30:09 (5352): Guest Log: BIOS: AX=0305 BX=0000 CX=0000 DX=0000 2020-12-29 23:30:36 (5352): Guest Log: vgdrvHeartbeatInit: Setting up heartbeat to trigger every 2000 milliseconds 2020-12-29 23:30:36 (5352): Guest Log: vboxguest: misc device minor 56, IRQ 20, I/O port d020, MMIO at 00000000f0400000 (size 0x400000) 2020-12-29 23:30:45 (5352): Guest Log: VBoxService 5.2.6 r120293 (verbosity: 0) linux.amd64 (Jan 15 2018 14:51:00) release log 2020-12-29 23:30:45 (5352): Guest Log: 00:00:00.002905 main Log opened 2020-12-29T22:30:51.647259000Z 2020-12-29 23:30:45 (5352): Guest Log: 00:00:00.006741 main OS Product: Linux 2020-12-29 23:30:45 (5352): Guest Log: 00:00:00.007309 main OS Release: 4.14.76-13.cernvm.x86_64 2020-12-29 23:30:45 (5352): Guest Log: 00:00:00.008185 main OS Version: #1 SMP Tue Oct 16 18:26:15 CEST 2018 2020-12-29 23:30:45 (5352): Guest Log: 00:00:00.008532 main Executable: /usr/sbin/VBoxService 2020-12-29 23:30:45 (5352): Guest Log: 00:00:00.008534 main Process ID: 3202 2020-12-29 23:30:45 (5352): Guest Log: 00:00:00.008535 main Package type: LINUX_64BITS_GENERIC 2020-12-29 23:30:45 (5352): Guest Log: 00:00:00.015663 main 5.2.6 r120293 started. Verbose level = 0 2020-12-29 23:30:53 (5352): Stopping VM. 2020-12-30 11:04:33 (6824): Detected: vboxwrapper 26197 2020-12-30 11:04:33 (6824): Detected: BOINC client v7.7 2020-12-30 11:04:34 (6824): Detected: VirtualBox VboxManage Interface (Version: 6.0.14) 2020-12-30 11:04:34 (6824): Detected: Heartbeat check (file: 'heartbeat' every 1200.000000 seconds) 2020-12-30 11:04:35 (6824): Starting VM using VBoxManage interface. (boinc_dd9b8adfa876df41, slot#2) 2020-12-30 11:04:49 (6824): Successfully started VM. (PID = '10376') 2020-12-30 11:04:49 (6824): Reporting VM Process ID to BOINC. 2020-12-30 11:04:49 (6824): Guest Log: 00:00:10.042192 timesync vgsvcTimeSyncWorker: Radical host time change: 41 644 452 000 000ns (HostNow=1 609 322 689 467 000 000 ns HostLast=1 609 281 045 015 000 000 ns) 2020-12-30 11:04:49 (6824): VM state change detected. (old = 'PoweredOff', new = 'Running') 2020-12-30 11:04:50 (6824): VM state change detected. (old = 'Running', new = 'Paused') 2020-12-30 11:04:51 (6824): Preference change detected 2020-12-30 11:04:51 (6824): Setting CPU throttle for VM. (90%) 2020-12-30 11:04:52 (6824): Setting checkpoint interval to 600 seconds. (Higher value of (Preference: 60 seconds) or (Vbox_job.xml: 600 seconds)) 2020-12-30 11:04:52 (6824): VM state change detected. (old = 'Paused', new = 'Running') 2020-12-30 11:05:01 (6824): Guest Log: 00:00:20.049209 timesync vgsvcTimeSyncWorker: Radical guest time change: 41 637 787 690 000ns (GuestNow=1 609 322 699 474 044 000 ns GuestLast=1 609 281 061 686 354 000 ns fSetTimeLastLoop=true ) 2020-12-30 11:05:34 (6824): Guest Log: 11:05:32 CET +01:00 2020-12-30: cranky: [INFO] Detected Theory App 2020-12-30 11:05:34 (6824): Guest Log: 11:05:32 CET +01:00 2020-12-30: cranky: [INFO] Checking CVMFS. 2020-12-30 11:05:37 (6824): Guest Log: Probing /cvmfs/sft.cern.ch... OK 2020-12-30 11:05:39 (6824): 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 2020-12-30 11:05:39 (6824): Guest Log: 2.5.2.0 3920 0 26388 19403 3 1 1204490 4096001 0 65024 0 0 n/a 5 7 http://s1cern-cvmfs.openhtc.io/cvmfs/sft.cern.ch DIRECT 1 2020-12-30 11:05:42 (6824): Guest Log: Probing /cvmfs/grid.cern.ch... OK 2020-12-30 11:05:44 (6824): 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 2020-12-30 11:05:44 (6824): Guest Log: 2.5.2.0 3994 0 27572 14067 3 2 1204490 4096001 0 65024 0 2 0 4281 1999 http://s1cern-cvmfs.openhtc.io/cvmfs/grid.cern.ch DIRECT 1 2020-12-30 11:05:47 (6824): Guest Log: Probing /cvmfs/cernvm-prod.cern.ch... OK 2020-12-30 11:05:48 (6824): 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 2020-12-30 11:05:48 (6824): Guest Log: 2.5.2.0 3941 0 27212 259 3 1 1204490 4096001 0 65024 0 0 n/a 0 0 http://s1cern-cvmfs.openhtc.io/cvmfs/cernvm-prod.cern.ch DIRECT 1 2020-12-30 11:05:52 (6824): Guest Log: Probing /cvmfs/alice.cern.ch... OK 2020-12-30 11:05:54 (6824): 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 2020-12-30 11:05:54 (6824): Guest Log: 2.5.2.0 3973 0 30672 8290 3 1 1204490 4096001 0 65024 0 0 n/a 4698 2387 http://s1cern-cvmfs.openhtc.io/cvmfs/alice.cern.ch DIRECT 1 2020-12-30 11:05:54 (6824): Guest Log: 11:05:52 CET +01:00 2020-12-30: cranky: [INFO] Checking runc. 2020-12-30 11:05:54 (6824): Guest Log: 11:05:52 CET +01:00 2020-12-30: cranky: [INFO] Creating the filesystem. 2020-12-30 11:05:54 (6824): Guest Log: 11:05:52 CET +01:00 2020-12-30: cranky: [INFO] Using /cvmfs/cernvm-prod.cern.ch/cvm3 2020-12-30 11:05:55 (6824): Guest Log: 11:05:53 CET +01:00 2020-12-30: cranky: [INFO] Updating config.json. 2020-12-30 11:05:55 (6824): Guest Log: 11:05:53 CET +01:00 2020-12-30: cranky: [INFO] Running Container 'runc'. 2020-12-30 11:05:56 (6824): Guest Log: job: htmld=/shared/html/job 2020-12-30 11:05:56 (6824): Guest Log: job: unpack exitcode=0 2020-12-30 11:05:58 (6824): Guest Log: 11:05:56 CET +01:00 2020-12-30: cranky: [INFO] ===> [runRivet] Wed Dec 30 10:05:54 UTC 2020 [boinc pp jets 8000 180,-,3560 - pythia6 6.428 p2010 100000 161] 2020-12-30 11:06:43 (6824): VM state change detected. (old = 'Running', new = 'Paused') 2020-12-30 11:06:53 (6824): VM state change detected. (old = 'Paused', new = 'Running') 2020-12-30 11:16:47 (6824): Stopping VM. 2020-12-30 11:17:52 (4852): Detected: vboxwrapper 26197 2020-12-30 11:17:52 (4852): Detected: BOINC client v7.7 2020-12-30 11:17:53 (4852): Detected: VirtualBox VboxManage Interface (Version: 6.0.14) 2020-12-30 11:17:54 (4852): Detected: Heartbeat check (file: 'heartbeat' every 1200.000000 seconds) 2020-12-30 11:17:54 (4852): Starting VM using VBoxManage interface. (boinc_dd9b8adfa876df41, slot#2) 2020-12-30 11:18:05 (4852): Successfully started VM. (PID = '6064') 2020-12-30 11:18:05 (4852): Reporting VM Process ID to BOINC. 2020-12-30 11:18:05 (4852): VM state change detected. (old = 'PoweredOff', new = 'Running') 2020-12-30 11:18:06 (4852): VM state change detected. (old = 'Running', new = 'Paused') 2020-12-30 11:18:14 (4852): Preference change detected 2020-12-30 11:18:14 (4852): Setting CPU throttle for VM. (90%) 2020-12-30 11:18:14 (4852): Setting checkpoint interval to 600 seconds. (Higher value of (Preference: 60 seconds) or (Vbox_job.xml: 600 seconds)) 2020-12-30 11:18:14 (4852): VM state change detected. (old = 'Paused', new = 'Running') 2020-12-30 11:20:50 (4852): Stopping VM. 2020-12-30 11:24:18 (11560): Detected: vboxwrapper 26197 2020-12-30 11:24:18 (11560): Detected: BOINC client v7.7 2020-12-30 11:24:19 (11560): Detected: VirtualBox VboxManage Interface (Version: 6.0.14) 2020-12-30 11:24:19 (11560): Detected: Heartbeat check (file: 'heartbeat' every 1200.000000 seconds) 2020-12-30 11:24:20 (11560): Starting VM using VBoxManage interface. (boinc_dd9b8adfa876df41, slot#2) 2020-12-30 11:24:31 (11560): Successfully started VM. (PID = '3856') 2020-12-30 11:24:31 (11560): Reporting VM Process ID to BOINC. 2020-12-30 11:24:31 (11560): VM state change detected. (old = 'PoweredOff', new = 'Running') 2020-12-30 11:24:32 (11560): VM state change detected. (old = 'Running', new = 'Paused') 2020-12-30 11:24:36 (11560): Preference change detected 2020-12-30 11:24:36 (11560): Setting CPU throttle for VM. (90%) 2020-12-30 11:24:36 (11560): Setting checkpoint interval to 600 seconds. (Higher value of (Preference: 60 seconds) or (Vbox_job.xml: 600 seconds)) 2020-12-30 11:24:37 (11560): VM state change detected. (old = 'Paused', new = 'Running') 2020-12-30 11:27:58 (11560): Stopping VM. 2020-12-30 12:52:23 (2020): Detected: vboxwrapper 26197 2020-12-30 12:52:23 (2020): Detected: BOINC client v7.7 2020-12-30 12:52:24 (2020): Detected: VirtualBox VboxManage Interface (Version: 6.0.14) 2020-12-30 12:52:25 (2020): Detected: Heartbeat check (file: 'heartbeat' every 1200.000000 seconds) 2020-12-30 12:52:25 (2020): Starting VM using VBoxManage interface. (boinc_dd9b8adfa876df41, slot#2) 2020-12-30 12:52:37 (2020): Successfully started VM. (PID = '9404') 2020-12-30 12:52:37 (2020): Reporting VM Process ID to BOINC. 2020-12-30 12:52:37 (2020): VM state change detected. (old = 'PoweredOff', new = 'Running') 2020-12-30 12:52:37 (2020): Preference change detected 2020-12-30 12:52:37 (2020): Setting CPU throttle for VM. (90%) 2020-12-30 12:52:37 (2020): Setting checkpoint interval to 600 seconds. (Higher value of (Preference: 60 seconds) or (Vbox_job.xml: 600 seconds)) 2020-12-30 12:52:45 (2020): VM state change detected. (old = 'Running', new = 'Paused') 2020-12-30 12:53:16 (2020): Guest Log: 00:18:10.873226 timesync vgsvcTimeSyncWorker: Radical host time change: 5 117 455 000 000ns (HostNow=1 609 329 195 614 000 000 ns HostLast=1 609 324 078 159 000 000 ns) 2020-12-30 12:53:16 (2020): VM state change detected. (old = 'Paused', new = 'Running') 2020-12-30 12:53:32 (2020): Guest Log: 00:18:20.899403 timesync vgsvcTimeSyncWorker: Radical guest time change: 5 117 540 503 000ns (GuestNow=1 609 329 205 706 474 000 ns GuestLast=1 609 324 088 165 971 000 ns fSetTimeLastLoop=true ) 2020-12-30 12:53:32 (2020): VM state change detected. (old = 'Running', new = 'Paused') 2020-12-30 14:37:01 (2020): VM state change detected. (old = 'Paused', new = 'Running') 2020-12-30 14:37:05 (2020): Guest Log: 00:18:30.902808 timesync vgsvcTimeSyncWorker: Radical host time change: 6 219 056 000 000ns (HostNow=1 609 335 424 764 000 000 ns HostLast=1 609 329 205 708 000 000 ns) 2020-12-30 14:37:15 (2020): Guest Log: 00:18:40.907520 timesync vgsvcTimeSyncWorker: Radical guest time change: 6 219 058 916 000ns (GuestNow=1 609 335 434 768 752 000 ns GuestLast=1 609 329 215 709 836 000 ns fSetTimeLastLoop=true ) 2020-12-30 15:16:33 (2020): Status Report: Job Duration: '864000.000000' 2020-12-30 15:16:33 (2020): Status Report: Elapsed Time: '6000.881343' 2020-12-30 15:16:33 (2020): Status Report: CPU Time: '5356.937500' 2020-12-30 15:43:51 (2020): Guest Log: job: run exitcode=0 2020-12-30 15:43:51 (2020): Guest Log: job: diskusage=1896 2020-12-30 15:43:51 (2020): Guest Log: job: logsize=60 k 2020-12-30 15:43:51 (2020): Guest Log: job: times= 2020-12-30 15:43:51 (2020): Guest Log: 0m0.012s 0m0.024s 2020-12-30 15:43:51 (2020): Guest Log: 80m38.252s 1m32.931s 2020-12-30 15:43:51 (2020): Guest Log: job: cpuusage=4931 2020-12-30 15:43:51 (2020): Guest Log: 15:43:51 CET +01:00 2020-12-30: cranky: [INFO] Container 'runc' finished with status code 0. 2020-12-30 15:43:51 (2020): Guest Log: 15:43:51 CET +01:00 2020-12-30: cranky: [INFO] Preparing output. 2020-12-30 15:43:52 (2020): Guest Log: [INFO] Job Finished 2020-12-30 15:43:53 (2020): Guest Log: [INFO] Shutting Down. 2020-12-30 15:43:53 (2020): VM Completion File Detected. 2020-12-30 15:43:53 (2020): VM Completion Message: Job Finished . 2020-12-30 15:43:53 (2020): Powering off VM. 2020-12-30 15:48:54 (2020): VM did not power off when requested. 2020-12-30 15:48:54 (2020): VM was successfully terminated. 2020-12-30 15:48:54 (2020): Deregistering VM. (boinc_dd9b8adfa876df41, slot#2) 2020-12-30 15:48:55 (2020): Removing network bandwidth throttle group from VM. 2020-12-30 15:48:55 (2020): Removing VM from VirtualBox. 15:49:00 (2020): called boinc_finish(0) </stderr_txt> ]]>
©2024 CERN