Name CMS_2064103_1564786555.772295_0
Workunit 1912533
Created 2 Aug 2019, 22:55:56 UTC
Sent 4 Aug 2019, 14:40:16 UTC
Report deadline 11 Aug 2019, 14:40:16 UTC
Received 7 Aug 2019, 21:37:40 UTC
Server state Over
Outcome Success
Client state Done
Exit status 0 (0x00000000)
Computer ID 3678
Run time 18 hours 40 min 41 sec
CPU time 4 hours 58 min 43 sec
Validate state Valid
Credit 571.16
Device peak FLOPS 3.67 GFLOPS
Application version CMS Simulation v49.00 (vbox64_mt_mcore_cms)
windows_x86_64
Peak working set size 76.36 MB
Peak swap size 86.66 MB
Peak disk usage 3.22 GB

Stderr output

<core_client_version>7.14.2</core_client_version>
<![CDATA[
<stderr_txt>
2019-08-04 09:40:14 (10708): Detected: vboxwrapper 26197
2019-08-04 09:40:14 (10708): Detected: BOINC client v7.7
2019-08-04 09:40:14 (10708): Detected: VirtualBox VboxManage Interface (Version: 5.2.12)
2019-08-04 09:40:15 (10708): Detected: Heartbeat check (file: 'heartbeat' every 1200.000000 seconds)
2019-08-04 09:40:15 (10708): Successfully copied 'init_data.xml' to the shared directory.
2019-08-04 09:40:17 (10708): Create VM. (boinc_2383544927f9900c, slot#14)
2019-08-04 09:40:18 (10708): Setting Memory Size for VM. (1896MB)
2019-08-04 09:40:18 (10708): Setting CPU Count for VM. (1)
2019-08-04 09:40:19 (10708): Setting Chipset Options for VM.
2019-08-04 09:40:19 (10708): Setting Boot Options for VM.
2019-08-04 09:40:20 (10708): Setting Network Configuration for NAT.
2019-08-04 09:40:20 (10708): Enabling VM Network Access.
2019-08-04 09:40:21 (10708): Disabling USB Support for VM.
2019-08-04 09:40:21 (10708): Disabling COM Port Support for VM.
2019-08-04 09:40:21 (10708): Disabling LPT Port Support for VM.
2019-08-04 09:40:22 (10708): Disabling Audio Support for VM.
2019-08-04 09:40:22 (10708): Disabling Clipboard Support for VM.
2019-08-04 09:40:23 (10708): Disabling Drag and Drop Support for VM.
2019-08-04 09:40:23 (10708): Adding storage controller(s) to VM.
2019-08-04 09:40:23 (10708): Adding virtual disk drive to VM. (vm_image.vdi)
2019-08-04 09:40:24 (10708): Adding VirtualBox Guest Additions to VM.
2019-08-04 09:40:24 (10708): Adding network bandwidth throttle group to VM. (Defaulting to 1024GB)
2019-08-04 09:40:24 (10708): forwarding host port 65332 to guest port 80
2019-08-04 09:40:25 (10708): Enabling remote desktop for VM.
2019-08-04 09:40:25 (10708): Required extension pack not installed, remote desktop not enabled.
2019-08-04 09:40:25 (10708): Enabling shared directory for VM.
2019-08-04 09:40:25 (10708): Starting VM using VBoxManage interface. (boinc_2383544927f9900c, slot#14)
2019-08-04 09:40:33 (10708): Successfully started VM. (PID = '10964')
2019-08-04 09:40:33 (10708): Reporting VM Process ID to BOINC.
2019-08-04 09:40:33 (10708): Guest Log: BIOS: VirtualBox 5.2.12

2019-08-04 09:40:33 (10708): Guest Log: CPUID EDX: 0x078bfbff

2019-08-04 09:40:33 (10708): Guest Log: BIOS: ata0-0: PCHS=16383/16/63 LCHS=1024/255/63

2019-08-04 09:40:33 (10708): VM state change detected. (old = 'PoweredOff', new = 'Running')
2019-08-04 09:40:33 (10708): Detected: Web Application Enabled (http://localhost:65332)
2019-08-04 09:40:33 (10708): Preference change detected
2019-08-04 09:40:33 (10708): Setting CPU throttle for VM. (100%)
2019-08-04 09:40:34 (10708): Setting checkpoint interval to 600 seconds. (Higher value of (Preference: 60 seconds) or (Vbox_job.xml: 600 seconds))
2019-08-04 09:40:35 (10708): Guest Log: BIOS: Boot : bseqnr=1, bootseq=0032

2019-08-04 09:40:35 (10708): Guest Log: BIOS: Booting from Hard Disk...

2019-08-04 09:40:37 (10708): Guest Log: BIOS: KBD: unsupported int 16h function 03

2019-08-04 09:40:37 (10708): Guest Log: BIOS: AX=0305 BX=0000 CX=0000 DX=0000 

2019-08-04 09:41:00 (10708): Guest Log: vgdrvHeartbeatInit: Setting up heartbeat to trigger every 2000 milliseconds

2019-08-04 09:41:00 (10708): Guest Log: vboxguest: misc device minor 56, IRQ 20, I/O port d020, MMIO at 00000000f0400000 (size 0x400000)

2019-08-04 09:41:36 (10708): Guest Log: VBoxService 5.2.6 r120293 (verbosity: 0) linux.amd64 (Jan 15 2018 14:51:00) release log

2019-08-04 09:41:36 (10708): Guest Log: 00:00:00.000372 main     Log opened 2019-08-04T14:43:31.032852000Z

2019-08-04 09:41:36 (10708): Guest Log: 00:00:00.000665 main     OS Product: Linux

2019-08-04 09:41:36 (10708): Guest Log: 00:00:00.000718 main     OS Release: 4.14.44-11.cernvm.x86_64

2019-08-04 09:41:36 (10708): Guest Log: 00:00:00.000791 main     OS Version: #1 SMP Mon May 28 16:49:00 CEST 2018

2019-08-04 09:41:36 (10708): Guest Log: 00:00:00.000840 main     Executable: /usr/share/vboxguest52/usr/sbin/VBoxService

2019-08-04 09:41:36 (10708): Guest Log: 00:00:00.000842 main     Process ID: 2963

2019-08-04 09:41:36 (10708): Guest Log: 00:00:00.000844 main     Package type: LINUX_64BITS_GENERIC

2019-08-04 09:41:36 (10708): Guest Log: 00:00:00.002714 main     5.2.6 r120293 started. Verbose level = 0

2019-08-04 09:42:14 (10708): Guest Log: [INFO] Mounting the shared directory

2019-08-04 09:42:14 (10708): Guest Log: [INFO] Shared directory mounted, enabling vboxmonitor

2019-08-04 09:42:14 (10708): Guest Log: [DEBUG] Testing network connection to cern.ch on port 80

2019-08-04 09:42:15 (10708): Guest Log: [DEBUG] Connection to cern.ch 80 port [tcp/http] succeeded!

2019-08-04 09:42:15 (10708): Guest Log: [DEBUG] 0

2019-08-04 09:42:15 (10708): Guest Log: [DEBUG] Testing VCCS connection to vccs.cern.ch on port 443

2019-08-04 09:42:15 (10708): Guest Log: [DEBUG] Connection to vccs.cern.ch 443 port [tcp/https] succeeded!

2019-08-04 09:42:15 (10708): Guest Log: [DEBUG] 0

2019-08-04 09:42:15 (10708): Guest Log: [DEBUG] Testing connection to Condor server on port 9618

2019-08-04 09:42:16 (10708): Guest Log: [DEBUG] Connection to vccondor01.cern.ch 9618 port [tcp/condor] succeeded!

2019-08-04 09:42:16 (10708): Guest Log: [DEBUG] 0

2019-08-04 09:43:27 (10708): Guest Log: [DEBUG] Probing CVMFS ...

2019-08-04 09:43:30 (10708): Guest Log: Probing /cvmfs/grid.cern.ch... OK

2019-08-04 09:43:32 (10708): 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

2019-08-04 09:43:32 (10708): Guest Log: 2.4.4.0 3704 1 25392 9909 3 1 1454385 10240001 2 65024 0 3 100 0 0 http://s1unl-cvmfs.openhtc.io/cvmfs/grid.cern.ch DIRECT 1

2019-08-04 09:43:49 (10708): Guest Log: [INFO] Reading volunteer information

2019-08-04 09:43:49 (10708): Guest Log: [INFO] Volunteer: Coleslaw (55)

2019-08-04 09:43:49 (10708): Guest Log: [INFO] VMID: c5ab4400-4ef6-44a9-aaed-bee78432355d

2019-08-04 09:43:50 (10708): Guest Log: [INFO] Requesting an X509 credential from LHC@home

2019-08-04 09:43:51 (10708): Guest Log: [INFO] Requesting an X509 credential from vLHC@home-dev

2019-08-04 09:43:52 (10708): Guest Log: [INFO] Running the fast benchmark.

2019-08-04 09:47:52 (10708): Guest Log: [INFO] Machine performance 2.15 HEPSPEC06

2019-08-04 09:47:52 (10708): Guest Log: [INFO] CMS application starting. Check log files.

2019-08-04 09:47:54 (10708): Guest Log: [DEBUG] HTCondor ping

2019-08-04 09:47:56 (10708): Guest Log: [DEBUG] 0

2019-08-04 10:26:14 (10708): VM state change detected. (old = 'Running', new = 'Paused')
2019-08-04 10:26:30 (10708): VM state change detected. (old = 'Paused', new = 'Running')
2019-08-04 11:27:30 (10708): Status Report: Job Duration: '64800.000000'
2019-08-04 11:27:30 (10708): Status Report: Elapsed Time: '6000.814682'
2019-08-04 11:27:30 (10708): Status Report: CPU Time: '6018.656250'
2019-08-04 11:35:11 (10708): VM state change detected. (old = 'Running', new = 'Paused')
2019-08-04 12:00:56 (10708): VM state change detected. (old = 'Paused', new = 'Running')
2019-08-04 13:00:10 (10708): VM state change detected. (old = 'Running', new = 'Paused')
2019-08-04 16:23:07 (10708): VM state change detected. (old = 'Paused', new = 'Running')
2019-08-04 16:23:09 (10708): Guest Log: 02:52:40.929438 timesync vgsvcTimeSyncWorker: Radical host time change: 12 186 202 000 000ns (HostNow=1 564 953 788 524 000 000 ns HostLast=1 564 941 602 322 000 000 ns)

2019-08-04 16:23:19 (10708): Guest Log: 02:52:50.929857 timesync vgsvcTimeSyncWorker: Radical guest time change: 12 070 270 177 000ns (GuestNow=1 564 953 798 545 571 000 ns GuestLast=1 564 941 728 275 394 000 ns fSetTimeLastLoop=true )

2019-08-04 16:28:46 (10708): VM state change detected. (old = 'Running', new = 'Paused')
2019-08-05 02:39:43 (10708): VM state change detected. (old = 'Paused', new = 'Running')
2019-08-05 02:39:46 (10708): Guest Log: 02:58:20.953036 timesync vgsvcTimeSyncWorker: Radical host time change: 36 667 458 000 000ns (HostNow=1 564 990 785 863 000 000 ns HostLast=1 564 954 118 405 000 000 ns)

2019-08-05 02:39:56 (10708): Guest Log: 02:58:30.954138 timesync vgsvcTimeSyncWorker: Radical guest time change: 36 667 295 455 000ns (GuestNow=1 564 990 795 864 152 000 ns GuestLast=1 564 954 128 568 697 000 ns fSetTimeLastLoop=true )

2019-08-05 03:22:08 (10708): Status Report: Job Duration: '64800.000000'
2019-08-05 03:22:08 (10708): Status Report: Elapsed Time: '12001.137230'
2019-08-05 03:22:08 (10708): Status Report: CPU Time: '12788.218750'
2019-08-05 03:26:14 (10708): VM state change detected. (old = 'Running', new = 'Paused')
2019-08-05 04:30:33 (10708): VM state change detected. (old = 'Paused', new = 'Running')
2019-08-05 04:30:35 (10708): Guest Log: 03:44:51.234620 timesync vgsvcTimeSyncWorker: Radical host time change: 3 869 350 000 000ns (HostNow=1 564 997 435 292 000 000 ns HostLast=1 564 993 565 942 000 000 ns)

2019-08-05 04:30:43 (10708): VM state change detected. (old = 'Running', new = 'Paused')
2019-08-05 05:07:57 (10708): VM state change detected. (old = 'Paused', new = 'Running')
2019-08-05 05:08:00 (10708): Guest Log: 03:45:01.234991 timesync vgsvcTimeSyncWorker: Radical host time change: 2 244 588 000 000ns (HostNow=1 564 999 679 880 000 000 ns HostLast=1 564 997 435 292 000 000 ns)

2019-08-05 05:08:00 (10708): Guest Log: 03:45:01.235119 timesync vgsvcTimeSyncWorker: Radical guest time change: 3 869 147 769 000ns (GuestNow=1 564 997 445 292 371 000 ns GuestLast=1 564 993 576 144 602 000 ns fSetTimeLastLoop=true )

2019-08-05 05:08:06 (10708): VM state change detected. (old = 'Running', new = 'Paused')
2019-08-05 06:12:29 (10708): VM state change detected. (old = 'Paused', new = 'Running')
2019-08-05 06:12:32 (10708): Guest Log: 03:45:11.235630 timesync vgsvcTimeSyncWorker: Radical host time change: 3 872 253 000 000ns (HostNow=1 565 003 552 133 000 000 ns HostLast=1 564 999 679 880 000 000 ns)

2019-08-05 06:12:32 (10708): Guest Log: 03:45:11.235722 timesync vgsvcTimeSyncWorker: Radical guest time change: 2 244 588 263 000ns (GuestNow=1 564 999 689 880 634 000 ns GuestLast=1 564 997 445 292 371 000 ns fSetTimeLastLoop=true )

2019-08-05 06:12:37 (10708): VM state change detected. (old = 'Running', new = 'Paused')
2019-08-05 10:25:38 (10708): VM state change detected. (old = 'Paused', new = 'Running')
2019-08-05 10:25:43 (10708): Guest Log: 03:45:21.237039 timesync vgsvcTimeSyncWorker: Radical host time change: 15 190 944 000 000ns (HostNow=1 565 018 743 077 000 000 ns HostLast=1 565 003 552 133 000 000 ns)

2019-08-05 10:25:43 (10708): Guest Log: 03:45:21.237175 timesync vgsvcTimeSyncWorker: Radical guest time change: 3 872 253 749 000ns (GuestNow=1 565 003 562 134 383 000 ns GuestLast=1 564 999 689 880 634 000 ns fSetTimeLastLoop=true )

2019-08-05 10:25:53 (10708): Guest Log: 03:45:31.238031 timesync vgsvcTimeSyncWorker: Radical guest time change: 15 190 943 654 000ns (GuestNow=1 565 018 753 078 037 000 ns GuestLast=1 565 003 562 134 383 000 ns fSetTimeLastLoop=true )

2019-08-05 11:18:02 (10708): VM state change detected. (old = 'Running', new = 'Paused')
2019-08-05 11:30:34 (10708): VM state change detected. (old = 'Paused', new = 'Running')
2019-08-05 12:17:39 (10708): Status Report: Job Duration: '64800.000000'
2019-08-05 12:17:39 (10708): Status Report: Elapsed Time: '18001.734274'
2019-08-05 12:17:39 (10708): Status Report: CPU Time: '16981.140625'
2019-08-05 12:25:35 (10708): VM state change detected. (old = 'Running', new = 'Paused')
2019-08-05 12:37:38 (10708): VM state change detected. (old = 'Paused', new = 'Running')
2019-08-05 14:09:55 (10708): Status Report: Job Duration: '64800.000000'
2019-08-05 14:09:55 (10708): Status Report: Elapsed Time: '24001.734274'
2019-08-05 14:09:55 (10708): Status Report: CPU Time: '17098.656250'
2019-08-05 15:50:07 (10708): Status Report: Job Duration: '64800.000000'
2019-08-05 15:50:07 (10708): Status Report: Elapsed Time: '30001.734274'
2019-08-05 15:50:07 (10708): Status Report: CPU Time: '17216.671875'
2019-08-05 17:30:24 (10708): Status Report: Job Duration: '64800.000000'
2019-08-05 17:30:24 (10708): Status Report: Elapsed Time: '36001.734274'
2019-08-05 17:30:24 (10708): Status Report: CPU Time: '17342.046875'
2019-08-05 17:36:34 (10708): VM state change detected. (old = 'Running', new = 'Paused')
2019-08-05 17:58:26 (10708): VM state change detected. (old = 'Paused', new = 'Running')
2019-08-05 17:58:36 (10708): VM state change detected. (old = 'Running', new = 'Paused')
2019-08-05 18:14:38 (10708): VM state change detected. (old = 'Paused', new = 'Running')
2019-08-05 18:14:48 (10708): Guest Log: 10:31:53.087397 timesync vgsvcTimeSyncWorker: Radical guest time change: 2 168 853 123 000ns (GuestNow=1 565 046 887 530 207 000 ns GuestLast=1 565 044 718 677 084 000 ns fSetTimeLastLoop=true )

2019-08-05 18:15:08 (10708): VM state change detected. (old = 'Running', new = 'Paused')
2019-08-05 18:40:02 (10708): VM state change detected. (old = 'Paused', new = 'Running')
2019-08-05 18:40:43 (10708): VM state change detected. (old = 'Running', new = 'Paused')
2019-08-05 20:11:05 (10708): VM state change detected. (old = 'Paused', new = 'Running')
2019-08-05 20:11:06 (10708): VM state change detected. (old = 'Running', new = 'Paused')
2019-08-05 20:29:58 (10708): VM state change detected. (old = 'Paused', new = 'Running')
2019-08-05 20:30:05 (10708): Guest Log: 10:33:03.090471 timesync vgsvcTimeSyncWorker: Radical host time change: 6 564 130 000 000ns (HostNow=1 565 055 005 191 000 000 ns HostLast=1 565 048 441 061 000 000 ns)

2019-08-05 20:30:16 (10708): Guest Log: 10:33:13.091490 timesync vgsvcTimeSyncWorker: Radical guest time change: 6 564 117 366 000ns (GuestNow=1 565 055 015 192 020 000 ns GuestLast=1 565 048 451 074 654 000 ns fSetTimeLastLoop=true )

2019-08-05 20:31:00 (10708): VM state change detected. (old = 'Running', new = 'Paused')
2019-08-05 20:51:42 (10708): VM state change detected. (old = 'Paused', new = 'Running')
2019-08-05 20:52:23 (10708): VM state change detected. (old = 'Running', new = 'Paused')
2019-08-05 21:16:36 (10708): VM state change detected. (old = 'Paused', new = 'Running')
2019-08-05 21:17:07 (10708): VM state change detected. (old = 'Running', new = 'Paused')
2019-08-05 22:02:04 (10708): VM state change detected. (old = 'Paused', new = 'Running')
2019-08-05 22:02:07 (10708): Guest Log: 10:35:13.100223 timesync vgsvcTimeSyncWorker: Radical host time change: 2 706 368 000 000ns (HostNow=1 565 060 526 883 000 000 ns HostLast=1 565 057 820 515 000 000 ns)

2019-08-05 22:02:12 (10708): VM state change detected. (old = 'Running', new = 'Paused')
2019-08-06 01:14:09 (10708): VM state change detected. (old = 'Paused', new = 'Running')
2019-08-06 01:14:14 (10708): Guest Log: 10:35:23.101462 timesync vgsvcTimeSyncWorker: Radical host time change: 11 527 276 000 000ns (HostNow=1 565 072 054 159 000 000 ns HostLast=1 565 060 526 883 000 000 ns)

2019-08-06 01:14:14 (10708): Guest Log: 10:35:23.101592 timesync vgsvcTimeSyncWorker: Radical guest time change: 2 706 361 228 000ns (GuestNow=1 565 060 536 884 232 000 ns GuestLast=1 565 057 830 523 004 000 ns fSetTimeLastLoop=true )

2019-08-06 01:14:18 (10708): VM state change detected. (old = 'Running', new = 'Paused')
2019-08-06 01:43:52 (10708): VM state change detected. (old = 'Paused', new = 'Running')
2019-08-06 01:43:59 (10708): Guest Log: 10:35:33.102271 timesync vgsvcTimeSyncWorker: Radical guest time change: 11 527 275 572 000ns (GuestNow=1 565 072 064 159 804 000 ns GuestLast=1 565 060 536 884 232 000 ns fSetTimeLastLoop=true )

2019-08-06 01:44:01 (10708): VM state change detected. (old = 'Running', new = 'Paused')
2019-08-06 03:26:35 (10708): VM state change detected. (old = 'Paused', new = 'Running')
2019-08-06 03:26:43 (10708): Guest Log: 10:35:43.103456 timesync vgsvcTimeSyncWorker: Radical host time change: 6 164 591 000 000ns (HostNow=1 565 080 002 816 000 000 ns HostLast=1 565 073 838 225 000 000 ns)

2019-08-06 03:26:47 (10708): VM state change detected. (old = 'Running', new = 'Paused')
2019-08-06 03:35:57 (10708): VM state change detected. (old = 'Paused', new = 'Running')
2019-08-06 03:36:03 (10708): Guest Log: 10:35:53.104491 timesync vgsvcTimeSyncWorker: Radical guest time change: 6 164 590 856 000ns (GuestNow=1 565 080 012 817 037 000 ns GuestLast=1 565 073 848 226 181 000 ns fSetTimeLastLoop=true )

2019-08-06 03:36:06 (10708): VM state change detected. (old = 'Running', new = 'Paused')
2019-08-06 04:11:53 (10708): VM state change detected. (old = 'Paused', new = 'Running')
2019-08-06 04:11:59 (10708): Guest Log: 10:36:03.105260 timesync vgsvcTimeSyncWorker: Radical host time change: 2 156 164 000 000ns (HostNow=1 565 082 718 816 000 000 ns HostLast=1 565 080 562 652 000 000 ns)

2019-08-06 04:12:00 (10708): VM state change detected. (old = 'Running', new = 'Paused')
2019-08-06 04:36:38 (10708): VM state change detected. (old = 'Paused', new = 'Running')
2019-08-06 04:36:45 (10708): VM state change detected. (old = 'Running', new = 'Paused')
2019-08-06 04:51:51 (10708): VM state change detected. (old = 'Paused', new = 'Running')
2019-08-06 04:51:52 (10708): Guest Log: 10:36:13.106040 timesync vgsvcTimeSyncWorker: Radical host time change: 2 393 062 000 000ns (HostNow=1 565 085 111 878 000 000 ns HostLast=1 565 082 718 816 000 000 ns)

2019-08-06 04:51:52 (10708): Guest Log: 10:36:13.106134 timesync vgsvcTimeSyncWorker: Radical guest time change: 2 705 998 976 000ns (GuestNow=1 565 082 728 816 777 000 ns GuestLast=1 565 080 022 817 801 000 ns fSetTimeLastLoop=true )

2019-08-06 04:52:00 (10708): VM state change detected. (old = 'Running', new = 'Paused')
2019-08-06 04:55:14 (10708): VM state change detected. (old = 'Paused', new = 'Running')
2019-08-06 04:55:16 (10708): Guest Log: 10:36:23.106720 timesync vgsvcTimeSyncWorker: Radical guest time change: 2 393 061 908 000ns (GuestNow=1 565 085 121 878 685 000 ns GuestLast=1 565 082 728 816 777 000 ns fSetTimeLastLoop=true )

2019-08-06 04:55:24 (10708): VM state change detected. (old = 'Running', new = 'Paused')
2019-08-06 04:57:22 (10708): VM state change detected. (old = 'Paused', new = 'Running')
2019-08-06 04:57:34 (10708): VM state change detected. (old = 'Running', new = 'Paused')
2019-08-06 05:43:27 (10708): Guest Log: 10:36:43.133842 timesync vgsvcTimeSyncWorker: Radical host time change: 2 763 836 000 000ns (HostNow=1 565 088 207 865 000 000 ns HostLast=1 565 085 444 029 000 000 ns)

2019-08-06 05:43:27 (10708): VM state change detected. (old = 'Paused', new = 'Running')
2019-08-06 05:43:37 (10708): VM state change detected. (old = 'Running', new = 'Paused')
2019-08-06 05:44:07 (10708): VM state change detected. (old = 'Paused', new = 'Running')
2019-08-06 05:44:08 (10708): Guest Log: 10:36:53.134231 timesync vgsvcTimeSyncWorker: Radical guest time change: 3 075 959 621 000ns (GuestNow=1 565 088 217 865 407 000 ns GuestLast=1 565 085 141 905 786 000 ns fSetTimeLastLoop=true )

2019-08-06 05:44:47 (10708): VM state change detected. (old = 'Running', new = 'Paused')
2019-08-06 07:31:36 (10708): Guest Log: 10:37:33.137255 timesync vgsvcTimeSyncWorker: Radical host time change: 6 417 878 000 000ns (HostNow=1 565 094 695 553 000 000 ns HostLast=1 565 088 277 675 000 000 ns)

2019-08-06 07:31:36 (10708): VM state change detected. (old = 'Paused', new = 'Running')
2019-08-06 07:31:44 (10708): VM state change detected. (old = 'Running', new = 'Paused')
2019-08-06 08:16:29 (10708): VM state change detected. (old = 'Paused', new = 'Running')
2019-08-06 08:16:30 (10708): Guest Log: 10:37:43.137995 timesync vgsvcTimeSyncWorker: Radical host time change: 2 694 707 000 000ns (HostNow=1 565 097 390 260 000 000 ns HostLast=1 565 094 695 553 000 000 ns)

2019-08-06 08:16:30 (10708): Guest Log: 10:37:43.138082 timesync vgsvcTimeSyncWorker: Radical guest time change: 6 447 685 306 000ns (GuestNow=1 565 094 705 553 729 000 ns GuestLast=1 565 088 257 868 423 000 ns fSetTimeLastLoop=true )

2019-08-06 08:16:40 (10708): Guest Log: 10:37:53.139062 timesync vgsvcTimeSyncWorker: Radical guest time change: 2 694 707 357 000ns (GuestNow=1 565 097 400 261 086 000 ns GuestLast=1 565 094 705 553 729 000 ns fSetTimeLastLoop=true )

2019-08-06 08:16:59 (10708): VM state change detected. (old = 'Running', new = 'Paused')
2019-08-06 08:42:33 (10708): VM state change detected. (old = 'Paused', new = 'Running')
2019-08-06 08:43:03 (10708): VM state change detected. (old = 'Running', new = 'Paused')
2019-08-06 09:13:45 (10708): Guest Log: 10:38:43.142534 timesync vgsvcTimeSyncWorker: Radical host time change: 1 852 147 000 000ns (HostNow=1 565 100 825 695 000 000 ns HostLast=1 565 098 973 548 000 000 ns)

2019-08-06 09:13:45 (10708): VM state change detected. (old = 'Paused', new = 'Running')
2019-08-06 09:13:55 (10708): Guest Log: 10:38:53.143695 timesync vgsvcTimeSyncWorker: Radical guest time change: 1 852 139 687 000ns (GuestNow=1 565 100 835 696 195 000 ns GuestLast=1 565 098 983 556 508 000 ns fSetTimeLastLoop=true )

2019-08-06 09:14:36 (10708): VM state change detected. (old = 'Running', new = 'Paused')
2019-08-06 09:51:31 (10708): VM state change detected. (old = 'Paused', new = 'Running')
2019-08-06 09:51:40 (10708): Guest Log: 10:39:43.146303 timesync vgsvcTimeSyncWorker: Radical host time change: 2 223 950 000 000ns (HostNow=1 565 103 099 625 000 000 ns HostLast=1 565 100 875 675 000 000 ns)

2019-08-06 09:51:50 (10708): Guest Log: 10:39:53.147251 timesync vgsvcTimeSyncWorker: Radical guest time change: 2 223 927 244 000ns (GuestNow=1 565 103 109 625 996 000 ns GuestLast=1 565 100 885 698 752 000 ns fSetTimeLastLoop=true )

2019-08-06 09:52:11 (10708): VM state change detected. (old = 'Running', new = 'Paused')
2019-08-06 10:28:37 (10708): VM state change detected. (old = 'Paused', new = 'Running')
2019-08-06 10:28:45 (10708): Guest Log: 10:40:23.149618 timesync vgsvcTimeSyncWorker: Radical host time change: 2 194 777 000 000ns (HostNow=1 565 105 324 390 000 000 ns HostLast=1 565 103 129 613 000 000 ns)

2019-08-06 10:28:55 (10708): Guest Log: 10:40:33.150645 timesync vgsvcTimeSyncWorker: Radical guest time change: 2 194 762 688 000ns (GuestNow=1 565 105 334 391 037 000 ns GuestLast=1 565 103 139 628 349 000 ns fSetTimeLastLoop=true )

2019-08-06 10:29:07 (10708): VM state change detected. (old = 'Running', new = 'Paused')
2019-08-06 11:05:00 (10708): VM state change detected. (old = 'Paused', new = 'Running')
2019-08-06 11:05:07 (10708): Guest Log: 10:40:53.152189 timesync vgsvcTimeSyncWorker: Radical host time change: 2 162 426 000 000ns (HostNow=1 565 107 506 808 000 000 ns HostLast=1 565 105 344 382 000 000 ns)

2019-08-06 11:05:17 (10708): Guest Log: 10:41:03.153147 timesync vgsvcTimeSyncWorker: Radical guest time change: 2 162 416 495 000ns (GuestNow=1 565 107 516 809 016 000 ns GuestLast=1 565 105 354 392 521 000 ns fSetTimeLastLoop=true )

2019-08-06 11:05:41 (10708): VM state change detected. (old = 'Running', new = 'Paused')
2019-08-06 12:14:18 (10708): VM state change detected. (old = 'Paused', new = 'Running')
2019-08-06 12:14:25 (10708): Guest Log: 10:41:33.155491 timesync vgsvcTimeSyncWorker: Radical host time change: 4 127 330 000 000ns (HostNow=1 565 111 664 127 000 000 ns HostLast=1 565 107 536 797 000 000 ns)

2019-08-06 12:14:35 (10708): Guest Log: 10:41:43.156513 timesync vgsvcTimeSyncWorker: Radical guest time change: 4 127 316 690 000ns (GuestNow=1 565 111 674 128 034 000 ns GuestLast=1 565 107 546 811 344 000 ns fSetTimeLastLoop=true )

2019-08-06 12:14:48 (10708): VM state change detected. (old = 'Running', new = 'Paused')
2019-08-06 12:38:02 (10708): VM state change detected. (old = 'Paused', new = 'Running')
2019-08-06 12:38:43 (10708): VM state change detected. (old = 'Running', new = 'Paused')
2019-08-06 14:03:56 (10708): VM state change detected. (old = 'Paused', new = 'Running')
2019-08-06 14:04:00 (10708): Guest Log: 10:42:43.161544 timesync vgsvcTimeSyncWorker: Radical host time change: 5 121 854 000 000ns (HostNow=1 565 118 239 152 000 000 ns HostLast=1 565 113 117 298 000 000 ns)

2019-08-06 14:04:10 (10708): Guest Log: 10:42:53.162533 timesync vgsvcTimeSyncWorker: Radical guest time change: 5 121 839 955 000ns (GuestNow=1 565 118 249 152 998 000 ns GuestLast=1 565 113 127 313 043 000 ns fSetTimeLastLoop=true )

2019-08-06 15:27:52 (10708): Status Report: Job Duration: '64800.000000'
2019-08-06 15:27:52 (10708): Status Report: Elapsed Time: '42002.684076'
2019-08-06 15:27:52 (10708): Status Report: CPU Time: '17473.187500'
2019-08-06 17:08:55 (10708): Status Report: Job Duration: '64800.000000'
2019-08-06 17:08:55 (10708): Status Report: Elapsed Time: '48003.156836'
2019-08-06 17:08:55 (10708): Status Report: CPU Time: '17586.718750'
2019-08-06 18:50:19 (10708): Status Report: Job Duration: '64800.000000'
2019-08-06 18:50:19 (10708): Status Report: Elapsed Time: '54003.156836'
2019-08-06 18:50:19 (10708): Status Report: CPU Time: '17698.406250'
2019-08-06 18:55:28 (10708): VM state change detected. (old = 'Running', new = 'Paused')
2019-08-06 22:07:46 (10708): VM state change detected. (old = 'Paused', new = 'Running')
2019-08-06 22:07:48 (10708): Guest Log: 15:34:14.532275 timesync vgsvcTimeSyncWorker: Radical host time change: 11 547 860 000 000ns (HostNow=1 565 147 268 397 000 000 ns HostLast=1 565 135 720 537 000 000 ns)

2019-08-06 22:07:58 (10708): Guest Log: 15:34:24.533277 timesync vgsvcTimeSyncWorker: Radical guest time change: 11 434 737 285 000ns (GuestNow=1 565 147 278 398 010 000 ns GuestLast=1 565 135 843 660 725 000 ns fSetTimeLastLoop=true )

2019-08-06 22:13:57 (10708): VM state change detected. (old = 'Running', new = 'Paused')
2019-08-06 22:39:24 (10708): VM state change detected. (old = 'Paused', new = 'Running')
2019-08-06 22:43:54 (10708): VM state change detected. (old = 'Running', new = 'Paused')
2019-08-06 23:09:28 (10708): VM state change detected. (old = 'Paused', new = 'Running')
2019-08-06 23:13:49 (10708): VM state change detected. (old = 'Running', new = 'Paused')
2019-08-06 23:43:31 (10708): VM state change detected. (old = 'Paused', new = 'Running')
2019-08-06 23:49:32 (10708): VM state change detected. (old = 'Running', new = 'Paused')
2019-08-07 00:34:05 (10708): VM state change detected. (old = 'Paused', new = 'Running')
2019-08-07 00:34:13 (10708): Guest Log: 15:55:24.602279 timesync vgsvcTimeSyncWorker: Radical host time change: 2 682 541 000 000ns (HostNow=1 565 156 053 124 000 000 ns HostLast=1 565 153 370 583 000 000 ns)

2019-08-07 00:34:23 (10708): Guest Log: 15:55:34.603309 timesync vgsvcTimeSyncWorker: Radical guest time change: 2 682 366 753 000ns (GuestNow=1 565 156 063 125 038 000 ns GuestLast=1 565 153 380 758 285 000 ns fSetTimeLastLoop=true )

2019-08-07 01:48:27 (10708): VM state change detected. (old = 'Running', new = 'Paused')
2019-08-07 02:07:21 (10708): VM state change detected. (old = 'Paused', new = 'Running')
2019-08-07 02:10:08 (10708): Status Report: Job Duration: '64800.000000'
2019-08-07 02:10:08 (10708): Status Report: Elapsed Time: '60003.330442'
2019-08-07 02:10:08 (10708): Status Report: CPU Time: '17829.718750'
2019-08-07 02:19:02 (10708): VM state change detected. (old = 'Running', new = 'Paused')
2019-08-07 06:01:20 (10708): VM state change detected. (old = 'Paused', new = 'Running')
2019-08-07 06:01:24 (10708): Guest Log: 17:21:24.967808 timesync vgsvcTimeSyncWorker: Radical host time change: 13 347 892 000 000ns (HostNow=1 565 175 684 058 000 000 ns HostLast=1 565 162 336 166 000 000 ns)

2019-08-07 06:01:34 (10708): Guest Log: 17:21:34.968852 timesync vgsvcTimeSyncWorker: Radical guest time change: 14 480 569 529 000ns (GuestNow=1 565 175 694 059 053 000 ns GuestLast=1 565 161 213 489 524 000 ns fSetTimeLastLoop=true )

2019-08-07 06:39:45 (10708): VM state change detected. (old = 'Running', new = 'Paused')
2019-08-07 09:59:55 (10708): VM state change detected. (old = 'Paused', new = 'Running')
2019-08-07 10:00:04 (10708): Guest Log: 17:59:55.133549 timesync vgsvcTimeSyncWorker: Radical host time change: 12 019 882 000 000ns (HostNow=1 565 190 003 908 000 000 ns HostLast=1 565 177 984 026 000 000 ns)

2019-08-07 10:00:13 (10708): Guest Log: 18:00:05.134609 timesync vgsvcTimeSyncWorker: Radical guest time change: 12 019 685 351 000ns (GuestNow=1 565 190 013 909 068 000 ns GuestLast=1 565 177 994 223 717 000 ns fSetTimeLastLoop=true )

2019-08-07 10:16:24 (10708): VM state change detected. (old = 'Running', new = 'Paused')
2019-08-07 16:12:50 (10708): Guest Log: 18:16:15.209556 timesync vgsvcTimeSyncWorker: Radical host time change: 21 396 092 000 000ns (HostNow=1 565 212 369 878 000 000 ns HostLast=1 565 190 973 786 000 000 ns)

2019-08-07 16:12:50 (10708): VM state change detected. (old = 'Paused', new = 'Running')
2019-08-07 16:13:00 (10708): Guest Log: 18:16:25.210470 timesync vgsvcTimeSyncWorker: Radical guest time change: 21 395 894 904 000ns (GuestNow=1 565 212 379 878 926 000 ns GuestLast=1 565 190 983 984 022 000 ns fSetTimeLastLoop=true )

2019-08-07 16:30:14 (10708): Powering off VM.
2019-08-07 16:35:29 (10708): VM did not power off when requested.
2019-08-07 16:35:29 (10708): VM was successfully terminated.
2019-08-07 16:35:29 (10708): Deregistering VM. (boinc_2383544927f9900c, slot#14)
2019-08-07 16:35:30 (10708): Removing network bandwidth throttle group from VM.
2019-08-07 16:35:30 (10708): Removing VM from VirtualBox.
16:35:36 (10708): called boinc_finish(0)

</stderr_txt>
]]>


©2024 CERN