Stderr output

<core_client_version>8.0.2</core_client_version>
<![CDATA[
<stderr_txt>
2025-11-21 23:39:03 (1412): vboxwrapper version 26210
2025-11-21 23:39:03 (1412): BOINC client version: 8.0.2
2025-11-22 00:39:03 (1412): Detected: VirtualBox VboxManage Interface (Version: 7.1.6)
2025-11-22 00:39:04 (1412): Detected: Heartbeat check (file: 'heartbeat' every 1200.000000 seconds)
2025-11-22 00:39:04 (1412): Successfully copied 'init_data.xml' to the shared directory.
2025-11-22 00:39:04 (1412): Create VM. (boinc_b41b74feaa376c24, slot#2)
2025-11-22 01:39:04 (1412): Setting Memory Size for VM. (4584MB)
2025-11-22 02:39:04 (1412): Setting CPU Count for VM. (4)
2025-11-22 03:39:03 (1412): Setting Chipset Options for VM.
2025-11-22 03:39:04 (1412): Setting Graphics Controller Options for VM. (Driver: VBoxVGA, 16MB)
2025-11-22 03:39:04 (1412): Setting Boot Options for VM.
2025-11-22 04:39:03 (1412): Setting Network Configuration for NAT. (Driver: virtio)
2025-11-22 04:39:04 (1412): Enabling VM Network Access.
2025-11-22 04:39:04 (1412): Disabling USB Support for VM.
2025-11-22 04:39:04 (1412): Disabling COM Port Support for VM.
2025-11-22 04:39:04 (1412): Disabling LPT Port Support for VM.
2025-11-22 04:39:05 (1412): Disabling Audio Support for VM.
2025-11-22 04:39:05 (1412): Disabling Clipboard Support for VM.
2025-11-22 04:39:05 (1412): Disabling Drag and Drop Support for VM.
2025-11-22 04:39:06 (1412): Adding storage controller(s) to VM.
2025-11-22 04:39:06 (1412): Adding virtual disk drive to VM. (CMS_2025_04_08_prod.vdi)
2025-11-22 04:39:08 (1412): Adding VirtualBox Guest Additions to VM.
2025-11-22 04:39:08 (1412): Adding network bandwidth throttle group to VM. (Defaulting to 1024GB)
2025-11-22 04:39:08 (1412): forwarding host port 64147 to guest port 80
2025-11-22 04:39:09 (1412): Enabling remote desktop for VM.
2025-11-22 04:39:09 (1412): Required extension pack not installed, remote desktop not enabled.
2025-11-22 04:39:09 (1412): Enabling shared directory for VM.
2025-11-22 04:39:09 (1412): Starting VM using VBoxManage interface. (boinc_b41b74feaa376c24, slot#2)
2025-11-22 04:39:14 (1412): Successfully started VM. (PID = '2144')
2025-11-22 04:39:14 (1412): Reporting VM Process ID to BOINC.
2025-11-22 04:39:14 (1412): Guest Log: BIOS: VirtualBox 7.1.6
2025-11-22 04:39:14 (1412): Guest Log: CPUID EDX: 0x178bfbff
2025-11-22 04:39:14 (1412): Guest Log: BIOS: No PCI IDE controller, not probing IDE
2025-11-22 04:39:14 (1412): Guest Log: BIOS: AHCI 0-P#0: PCHS=16383/16/63 LCHS=1024/255/63 0x0000000002800000 sectors
2025-11-22 04:39:14 (1412): VM state change detected. (old = 'poweredoff', new = 'running')
2025-11-22 04:39:14 (1412): Detected: Web Application Enabled (http://localhost:64147)
2025-11-22 04:39:15 (1412): VM state change detected. (old = 'running', new = 'paused')
2025-11-22 04:39:34 (1412): Preference change detected
2025-11-22 04:39:34 (1412): Setting CPU throttle for VM. (100%)
2025-11-22 04:39:35 (1412): Setting checkpoint interval to 600 seconds. (Higher value of (Preference: 180 seconds) or (Vbox_job.xml: 600 seconds))
2025-11-22 04:39:35 (1412): VM state change detected. (old = 'paused', new = 'running')
2025-11-22 04:39:36 (1412): Guest Log: BIOS: Boot : bseqnr=1, bootseq=0032
2025-11-22 04:39:36 (1412): Guest Log: BIOS: Booting from Hard Disk...
2025-11-22 04:39:38 (1412): Guest Log: BIOS: KBD: unsupported int 16h function 03
2025-11-22 04:39:38 (1412): Guest Log: BIOS: AX=0305 BX=0000 CX=0000 DX=0000 
2025-11-22 05:39:05 (1412): Guest Log: vgdrvHeartbeatInit: Setting up heartbeat to trigger every 2000 milliseconds
2025-11-22 05:39:05 (1412): Guest Log: vboxguest: misc device minor 56, IRQ 20, I/O port d020, MMIO at 00000000f0400000 (size 0x400000)
2025-11-22 05:39:05 (1412): VM state change detected. (old = 'running', new = 'paused')
2025-11-22 09:09:24 (1412): Guest Log: VBoxService 5.2.6 r120293 (verbosity: 0) linux.amd64 (Jan 15 2018 14:51:00) release log
2025-11-22 09:09:24 (1412): Guest Log: 00:00:00.006668 main     Log opened 2025-11-22T11:39:05.157224000Z
2025-11-22 09:09:24 (1412): Guest Log: 00:00:00.006812 main     OS Product: Linux
2025-11-22 09:09:24 (1412): Guest Log: 00:00:00.006840 main     OS Release: 4.14.232-19.cernvm.x86_64
2025-11-22 09:09:24 (1412): Guest Log: 00:00:00.006861 main     OS Version: #1 SMP Fri Apr 30 17:12:25 CEST 2021
2025-11-22 09:09:24 (1412): Guest Log: 00:00:00.006880 main     Executable: /usr/sbin/VBoxService
2025-11-22 09:09:24 (1412): Guest Log: 00:00:00.006881 main     Process ID: 2288
2025-11-22 09:09:24 (1412): Guest Log: 00:00:00.006881 main     Package type: LINUX_64BITS_GENERIC
2025-11-22 09:09:24 (1412): Guest Log: 00:00:00.008711 main     5.2.6 r120293 started. Verbose level = 0
2025-11-22 09:09:24 (1412): VM state change detected. (old = 'paused', new = 'running')
2025-11-22 09:09:34 (1412): VM state change detected. (old = 'running', new = 'paused')
2025-11-22 16:39:24 (1412): Guest Log: 00:00:10.205144 timesync vgsvcTimeSyncWorker: Radical host time change: 26 998 798 000 000ns (HostNow=1 763 851 163 097 000 000 ns HostLast=1 763 824 164 299 000 000 ns)
2025-11-22 16:39:24 (1412): Guest Log: 00:00:10.205237 timesync vgsvcTimeSyncWorker: Radical guest time change: 12 629 331 496 000ns (GuestNow=1 763 824 174 493 031 000 ns GuestLast=1 763 811 545 161 535 000 ns fSetTimeLastLoop=true )
2025-11-22 16:39:24 (1412): VM state change detected. (old = 'paused', new = 'running')
2025-11-22 16:39:30 (1412): Guest Log: [INFO] Mounting the shared directory
2025-11-22 16:39:30 (1412): Guest Log: [INFO] Shared directory mounted, enabling vboxmonitor
2025-11-22 16:39:30 (1412): Guest Log: [INFO] Sourcing essential functions from /cvmfs/grid.cern.ch
2025-11-22 16:39:30 (1412): Guest Log: [INFO] Testing connection to cern.ch
2025-11-22 16:39:30 (1412): Guest Log: [INFO] Testing connection to VCCS
2025-11-22 16:39:31 (1412): Guest Log: [INFO] Testing connection to HTCondor-Collector
2025-11-22 16:39:31 (1412): Guest Log: [INFO] Testing connection to HTCondor-CCB
2025-11-22 16:39:32 (1412): Guest Log: [INFO] Testing connection to WMAgent
2025-11-22 16:39:32 (1412): Guest Log: [INFO] Testing connection to EOSCMS
2025-11-22 16:39:33 (1412): Guest Log: [INFO] Testing connection to CMS-Factory
2025-11-22 16:39:33 (1412): Guest Log: [INFO] Testing connection to CMS-Frontier
2025-11-22 16:39:34 (1412): VM state change detected. (old = 'running', new = 'paused')
2025-11-22 16:39:55 (1412): Guest Log: [INFO] Testing connection to Frontier
2025-11-22 16:39:55 (1412): Guest Log: [INFO] Testing connection to http://cms-frontier.openhtc.io:8080/FrontierProd/Frontier/
2025-11-22 16:39:55 (1412): Guest Log: 00:00:20.214484 timesync vgsvcTimeSyncWorker: Radical guest time change: 26 998 613 378 000ns (GuestNow=1 763 851 173 106 409 000 ns GuestLast=1 763 824 174 493 031 000 ns fSetTimeLastLoop=true )
2025-11-22 16:39:55 (1412): VM state change detected. (old = 'paused', new = 'running')
2025-11-22 16:39:56 (1412): Guest Log: [INFO] Could not find a local HTTP proxy
2025-11-22 16:39:56 (1412): Guest Log: [INFO] CVMFS and Frontier will have to use DIRECT connections
2025-11-22 16:39:56 (1412): Guest Log: [INFO] This makes the application less efficient
2025-11-22 16:39:56 (1412): Guest Log: [INFO] It also puts higher load on the project servers
2025-11-22 16:39:56 (1412): Guest Log: [INFO] Setting up a local HTTP proxy is highly recommended
2025-11-22 16:39:57 (1412): Guest Log: [INFO] Advice can be found in the project forum
2025-11-22 16:39:57 (1412): Guest Log: [INFO] Reloading and probing the CVMFS configuration
2025-11-22 16:40:10 (1412): Guest Log: [INFO] Probing /cvmfs/grid.cern.ch... OK
2025-11-22 16:40:14 (1412): Guest Log: [INFO] Probing /cvmfs/cms.cern.ch... OK
2025-11-22 16:40:14 (1412): Guest Log: [INFO] Probing /cvmfs/oasis.opensciencegrid.org... OK
2025-11-22 16:40:15 (1412): Guest Log: [INFO] Probing /cvmfs/singularity.opensciencegrid.org... OK
2025-11-22 16:40:15 (1412): Guest Log: [INFO] Probing /cvmfs/cms-ib.cern.ch... OK
2025-11-22 16:40:16 (1412): Guest Log: [INFO] Excerpt from "cvmfs_config stat": VERSION HOST PROXY
2025-11-22 16:40:17 (1412): Guest Log: [INFO] 2.7.2.0 http://s1fnal-cvmfs.openhtc.io:8080 DIRECT
2025-11-22 16:40:17 (1412): Guest Log: [INFO] Environment HTTP proxy: not set
2025-11-22 16:40:17 (1412): Guest Log: [INFO] Reading volunteer information
2025-11-22 16:40:26 (1412): Guest Log: [INFO] Requesting an X509 credential from LHC@home
2025-11-22 16:40:28 (1412): Guest Log: [INFO] Requesting an idtoken from LHC@home
2025-11-22 16:40:29 (1412): Guest Log: [INFO] CMS application starting. Check log files.
2025-11-22 16:41:05 (1412): VM state change detected. (old = 'running', new = 'paused')
2025-11-22 16:41:25 (1412): VM state change detected. (old = 'paused', new = 'running')
2025-11-22 16:41:35 (1412): VM state change detected. (old = 'running', new = 'paused')
2025-11-22 18:38:57 (1412): Guest Log: 00:25:02.254304 timesync vgsvcTimeSyncWorker: Radical host time change: 7 061 458 000 000ns (HostNow=1 763 858 337 075 000 000 ns HostLast=1 763 851 275 617 000 000 ns)
2025-11-22 18:38:57 (1412): VM state change detected. (old = 'paused', new = 'running')
2025-11-22 19:22:34 (1412): Guest Log: 01:08:39.105486 timesync vgsvcTimeSyncWorker: Radical guest time change: 8 298 832 482 000ns (GuestNow=1 763 860 953 952 455 000 ns GuestLast=1 763 852 655 119 973 000 ns fSetTimeLastLoop=true )
2025-11-22 20:32:34 (1412): Guest Log: 02:18:39.402327 timesync vgsvcTimeSyncWorker: Radical guest time change: 3 210 604 609 000ns (GuestNow=1 763 865 154 249 278 000 ns GuestLast=1 763 861 943 644 669 000 ns fSetTimeLastLoop=false)
2025-11-22 20:32:45 (1412): VM state change detected. (old = 'running', new = 'paused')
2025-11-22 21:39:03 (1412): Guest Log: 03:18:49.033235 timesync vgsvcTimeSyncWorker: Radical host time change: 3 980 131 000 000ns (HostNow=1 763 869 143 027 000 000 ns HostLast=1 763 865 162 896 000 000 ns)
2025-11-22 21:39:03 (1412): Guest Log: 03:18:49.033295 timesync vgsvcTimeSyncWorker: Radical guest time change: 3 599 625 067 000ns (GuestNow=1 763 868 763 880 220 000 ns GuestLast=1 763 865 164 255 153 000 ns fSetTimeLastLoop=false)
2025-11-22 21:39:03 (1412): VM state change detected. (old = 'paused', new = 'running')
2025-11-22 22:39:03 (1412): Guest Log: 04:18:51.008679 timesync vgsvcTimeSyncWorker: Radical host time change: 3 600 175 000 000ns (HostNow=1 763 872 743 202 000 000 ns HostLast=1 763 869 143 027 000 000 ns)
2025-11-22 22:39:03 (1412): Guest Log: 04:18:51.008793 timesync vgsvcTimeSyncWorker: Radical guest time change: 3 601 975 423 000ns (GuestNow=1 763 872 365 855 643 000 ns GuestLast=1 763 868 763 880 220 000 ns fSetTimeLastLoop=false)
2025-11-22 23:21:33 (1412): Guest Log: 05:01:21.842357 timesync vgsvcTimeSyncWorker: Radical host time change: 2 549 559 000 000ns (HostNow=1 763 875 292 761 000 000 ns HostLast=1 763 872 743 202 000 000 ns)
2025-11-22 23:21:33 (1412): Guest Log: 05:01:21.842453 timesync vgsvcTimeSyncWorker: Radical guest time change: 2 550 833 679 000ns (GuestNow=1 763 874 916 689 322 000 ns GuestLast=1 763 872 365 855 643 000 ns fSetTimeLastLoop=false)
2025-11-23 00:39:02 (1412): Guest Log: 06:18:53.919117 timesync vgsvcTimeSyncWorker: Radical host time change: 3 599 739 000 000ns (HostNow=1 763 879 942 513 000 000 ns HostLast=1 763 876 342 774 000 000 ns)
2025-11-23 00:39:02 (1412): Guest Log: 06:18:53.919193 timesync vgsvcTimeSyncWorker: Radical guest time change: 3 601 539 358 000ns (GuestNow=1 763 879 568 766 077 000 ns GuestLast=1 763 875 967 226 719 000 ns fSetTimeLastLoop=false)
2025-11-23 01:22:32 (1412): Guest Log: 07:02:25.087716 timesync vgsvcTimeSyncWorker: Radical host time change: 2 609 859 000 000ns (HostNow=1 763 882 552 372 000 000 ns HostLast=1 763 879 942 513 000 000 ns)
2025-11-23 01:22:32 (1412): Guest Log: 07:02:25.087872 timesync vgsvcTimeSyncWorker: Radical guest time change: 2 611 168 613 000ns (GuestNow=1 763 882 179 934 690 000 ns GuestLast=1 763 879 568 766 077 000 ns fSetTimeLastLoop=false)
2025-11-23 02:39:02 (1412): Guest Log: 08:18:56.792722 timesync vgsvcTimeSyncWorker: Radical host time change: 3 599 713 000 000ns (HostNow=1 763 887 141 786 000 000 ns HostLast=1 763 883 542 073 000 000 ns)
2025-11-23 02:39:02 (1412): Guest Log: 08:18:56.792836 timesync vgsvcTimeSyncWorker: Radical guest time change: 3 601 512 237 000ns (GuestNow=1 763 886 771 639 710 000 ns GuestLast=1 763 883 170 127 473 000 ns fSetTimeLastLoop=false)
2025-11-23 03:39:02 (1412): Guest Log: 09:18:58.317305 timesync vgsvcTimeSyncWorker: Radical host time change: 3 599 724 000 000ns (HostNow=1 763 890 741 510 000 000 ns HostLast=1 763 887 141 786 000 000 ns)
2025-11-23 03:39:02 (1412): Guest Log: 09:18:58.317387 timesync vgsvcTimeSyncWorker: Radical guest time change: 3 601 524 579 000ns (GuestNow=1 763 890 373 164 289 000 ns GuestLast=1 763 886 771 639 710 000 ns fSetTimeLastLoop=false)
2025-11-23 04:31:32 (1412): Guest Log: 10:11:29.933647 timesync vgsvcTimeSyncWorker: Radical host time change: 3 150 010 000 000ns (HostNow=1 763 893 891 520 000 000 ns HostLast=1 763 890 741 510 000 000 ns)
2025-11-23 04:31:32 (1412): Guest Log: 10:11:29.934174 timesync vgsvcTimeSyncWorker: Radical guest time change: 3 151 615 673 000ns (GuestNow=1 763 893 524 779 962 000 ns GuestLast=1 763 890 373 164 289 000 ns fSetTimeLastLoop=false)
2025-11-23 04:31:42 (1412): VM state change detected. (old = 'running', new = 'paused')
2025-11-23 04:32:02 (1412): VM state change detected. (old = 'paused', new = 'running')
2025-11-23 06:39:01 (1412): Guest Log: 11:18:42.010964 timesync vgsvcTimeSyncWorker: Radical host time change: 3 600 263 000 000ns (HostNow=1 763 897 941 298 000 000 ns HostLast=1 763 894 341 035 000 000 ns)
2025-11-23 06:39:01 (1412): Guest Log: 11:18:42.011034 timesync vgsvcTimeSyncWorker: Radical guest time change: 3 602 364 826 000ns (GuestNow=1 763 897 556 857 943 000 ns GuestLast=1 763 893 954 493 117 000 ns fSetTimeLastLoop=false)
2025-11-23 06:39:01 (1412): Guest Log: 12:18:42.808559 timesync vgsvcTimeSyncWorker: Radical host time change: 3 599 295 000 000ns (HostNow=1 763 901 540 593 000 000 ns HostLast=1 763 897 941 298 000 000 ns)
2025-11-23 06:39:01 (1412): Guest Log: 12:18:42.810147 timesync vgsvcTimeSyncWorker: Radical guest time change: 3 600 797 570 000ns (GuestNow=1 763 901 157 655 513 000 ns GuestLast=1 763 897 556 857 943 000 ns fSetTimeLastLoop=false)
2025-11-23 07:23:30 (1412): Guest Log: 13:03:14.194929 timesync vgsvcTimeSyncWorker: Radical host time change: 2 670 052 000 000ns (HostNow=1 763 904 210 645 000 000 ns HostLast=1 763 901 540 593 000 000 ns)
2025-11-23 07:23:30 (1412): Guest Log: 13:03:14.199542 timesync vgsvcTimeSyncWorker: Radical guest time change: 2 671 384 277 000ns (GuestNow=1 763 903 829 039 790 000 ns GuestLast=1 763 901 157 655 513 000 ns fSetTimeLastLoop=false)
2025-11-23 08:12:06 (1412): Guest Log: 13:51:51.159495 timesync vgsvcTimeSyncWorker: Radical host time change: 1 985 885 000 000ns (HostNow=1 763 907 126 146 000 000 ns HostLast=1 763 905 140 261 000 000 ns)
2025-11-23 08:12:06 (1412): Guest Log: 13:51:51.159556 timesync vgsvcTimeSyncWorker: Radical guest time change: 1 986 890 882 000ns (GuestNow=1 763 906 746 006 478 000 ns GuestLast=1 763 904 759 115 596 000 ns fSetTimeLastLoop=false)
2025-11-23 09:39:00 (1412): Guest Log: 15:18:47.623761 timesync vgsvcTimeSyncWorker: Radical host time change: 3 599 935 000 000ns (HostNow=1 763 912 340 011 000 000 ns HostLast=1 763 908 740 076 000 000 ns)
2025-11-23 09:39:00 (1412): Guest Log: 15:18:47.623897 timesync vgsvcTimeSyncWorker: Radical guest time change: 3 601 735 848 000ns (GuestNow=1 763 911 962 466 694 000 ns GuestLast=1 763 908 360 730 846 000 ns fSetTimeLastLoop=false)
2025-11-23 10:38:59 (1412): Guest Log: 16:18:49.021773 timesync vgsvcTimeSyncWorker: Radical host time change: 3 591 405 000 000ns (HostNow=1 763 915 939 613 000 000 ns HostLast=1 763 912 348 208 000 000 ns)
2025-11-23 10:38:59 (1412): Guest Log: 16:18:49.021857 timesync vgsvcTimeSyncWorker: Radical guest time change: 3 591 397 656 000ns (GuestNow=1 763 915 563 868 720 000 ns GuestLast=1 763 911 972 471 064 000 ns fSetTimeLastLoop=false)
2025-11-23 11:38:59 (1412): VM state change detected. (old = 'running', new = 'paused')
2025-11-23 14:36:50 (1412): VM state change detected. (old = 'paused', new = 'running')
2025-11-23 14:36:59 (1412): Guest Log: 16:18:59.022692 timesync vgsvcTimeSyncWorker: Radical host time change: 14 276 582 000 000ns (HostNow=1 763 930 216 195 000 000 ns HostLast=1 763 915 939 613 000 000 ns)
2025-11-23 14:37:00 (1412): VM state change detected. (old = 'running', new = 'paused')
2025-11-23 16:28:20 (1412): VM state change detected. (old = 'paused', new = 'running')
2025-11-23 16:28:29 (1412): Guest Log: 16:19:09.024210 timesync vgsvcTimeSyncWorker: Radical host time change: 6 689 161 000 000ns (HostNow=1 763 936 905 356 000 000 ns HostLast=1 763 930 216 195 000 000 ns)
2025-11-23 16:28:29 (1412): Guest Log: 16:19:09.024715 timesync vgsvcTimeSyncWorker: Radical guest time change: 14 652 327 977 000ns (GuestNow=1 763 930 226 196 952 000 ns GuestLast=1 763 915 573 868 975 000 ns fSetTimeLastLoop=true )
2025-11-23 16:28:30 (1412): VM state change detected. (old = 'running', new = 'paused')
2025-11-23 16:28:50 (1412): VM state change detected. (old = 'paused', new = 'running')
2025-11-23 16:28:59 (1412): Guest Log: 16:19:19.025399 timesync vgsvcTimeSyncWorker: Radical guest time change: 6 689 160 410 000ns (GuestNow=1 763 936 915 357 362 000 ns GuestLast=1 763 930 226 196 952 000 ns fSetTimeLastLoop=true )
2025-11-23 16:29:00 (1412): VM state change detected. (old = 'running', new = 'paused')
2025-11-23 16:29:20 (1412): VM state change detected. (old = 'paused', new = 'running')
2025-11-23 16:29:30 (1412): VM state change detected. (old = 'running', new = 'paused')
2025-11-23 16:29:50 (1412): VM state change detected. (old = 'paused', new = 'running')
2025-11-23 16:30:00 (1412): VM state change detected. (old = 'running', new = 'paused')
2025-11-23 16:30:20 (1412): VM state change detected. (old = 'paused', new = 'running')
2025-11-23 16:30:30 (1412): VM state change detected. (old = 'running', new = 'paused')
2025-11-23 16:39:00 (1412): VM state change detected. (old = 'paused', new = 'running')
2025-11-23 17:22:47 (1412): Guest Log: 17:03:38.600430 timesync vgsvcTimeSyncWorker: Radical host time change: 3 144 275 000 000ns (HostNow=1 763 940 166 792 000 000 ns HostLast=1 763 937 022 517 000 000 ns)
2025-11-23 17:22:47 (1412): Guest Log: 17:03:38.600535 timesync vgsvcTimeSyncWorker: Radical guest time change: 2 629 571 669 000ns (GuestNow=1 763 939 574 932 440 000 ns GuestLast=1 763 936 945 360 771 000 ns fSetTimeLastLoop=false)
2025-11-23 18:38:58 (1412): Guest Log: 18:19:51.859406 timesync vgsvcTimeSyncWorker: Radical host time change: 3 599 723 000 000ns (HostNow=1 763 944 737 765 000 000 ns HostLast=1 763 941 138 042 000 000 ns)
2025-11-23 18:38:58 (1412): Guest Log: 18:19:51.859497 timesync vgsvcTimeSyncWorker: Radical guest time change: 3 601 523 336 000ns (GuestNow=1 763 944 148 191 422 000 ns GuestLast=1 763 940 546 668 086 000 ns fSetTimeLastLoop=false)
2025-11-23 19:38:57 (1412): Guest Log: 19:06:23.274717 timesync vgsvcTimeSyncWorker: Radical host time change: 2 790 020 000 000ns (HostNow=1 763 947 527 785 000 000 ns HostLast=1 763 944 737 765 000 000 ns)
2025-11-23 19:38:57 (1412): Guest Log: 19:06:23.274808 timesync vgsvcTimeSyncWorker: Radical guest time change: 2 791 415 289 000ns (GuestNow=1 763 946 939 606 711 000 ns GuestLast=1 763 944 148 191 422 000 ns fSetTimeLastLoop=false)
2025-11-23 20:38:58 (1412): Guest Log: 20:19:54.902797 timesync vgsvcTimeSyncWorker: Radical host time change: 3 599 636 000 000ns (HostNow=1 763 951 937 208 000 000 ns HostLast=1 763 948 337 572 000 000 ns)
2025-11-23 20:38:58 (1412): Guest Log: 20:19:54.902863 timesync vgsvcTimeSyncWorker: Radical guest time change: 3 601 436 110 000ns (GuestNow=1 763 951 351 234 796 000 ns GuestLast=1 763 947 749 798 686 000 ns fSetTimeLastLoop=false)
2025-11-23 21:38:57 (1412): Guest Log: 21:19:56.752958 timesync vgsvcTimeSyncWorker: Radical host time change: 3 600 048 000 000ns (HostNow=1 763 955 537 256 000 000 ns HostLast=1 763 951 937 208 000 000 ns)
2025-11-23 21:38:57 (1412): Guest Log: 21:19:56.753069 timesync vgsvcTimeSyncWorker: Radical guest time change: 3 601 850 166 000ns (GuestNow=1 763 954 953 084 962 000 ns GuestLast=1 763 951 351 234 796 000 ns fSetTimeLastLoop=false)
2025-11-23 22:38:57 (1412): Guest Log: 22:19:58.467070 timesync vgsvcTimeSyncWorker: Radical host time change: 3 599 915 000 000ns (HostNow=1 763 959 137 171 000 000 ns HostLast=1 763 955 537 256 000 000 ns)
2025-11-23 22:38:57 (1412): Guest Log: 22:19:58.467151 timesync vgsvcTimeSyncWorker: Radical guest time change: 3 601 714 137 000ns (GuestNow=1 763 958 554 799 099 000 ns GuestLast=1 763 954 953 084 962 000 ns fSetTimeLastLoop=false)
2025-11-23 23:38:58 (1412): Guest Log: 23:20:00.617626 timesync vgsvcTimeSyncWorker: Radical host time change: 3 600 347 000 000ns (HostNow=1 763 962 737 518 000 000 ns HostLast=1 763 959 137 171 000 000 ns)
2025-11-23 23:38:58 (1412): Guest Log: 23:20:00.617733 timesync vgsvcTimeSyncWorker: Radical guest time change: 3 602 150 537 000ns (GuestNow=1 763 962 156 949 636 000 ns GuestLast=1 763 958 554 799 099 000 ns fSetTimeLastLoop=false)
2025-11-24 00:38:57 (1412): Guest Log: 24:20:02.219065 timesync vgsvcTimeSyncWorker: Radical host time change: 3 599 803 000 000ns (HostNow=1 763 966 337 321 000 000 ns HostLast=1 763 962 737 518 000 000 ns)
2025-11-24 00:38:57 (1412): Guest Log: 24:20:02.219226 timesync vgsvcTimeSyncWorker: Radical guest time change: 3 601 601 445 000ns (GuestNow=1 763 965 758 551 081 000 ns GuestLast=1 763 962 156 949 636 000 ns fSetTimeLastLoop=false)
2025-11-24 01:26:28 (1412): Guest Log: 25:07:33.885544 timesync vgsvcTimeSyncWorker: Radical host time change: 2 850 230 000 000ns (HostNow=1 763 969 187 551 000 000 ns HostLast=1 763 966 337 321 000 000 ns)
2025-11-24 01:26:28 (1412): Guest Log: 25:07:33.885631 timesync vgsvcTimeSyncWorker: Radical guest time change: 2 851 666 477 000ns (GuestNow=1 763 968 610 217 558 000 ns GuestLast=1 763 965 758 551 081 000 ns fSetTimeLastLoop=false)
2025-11-24 03:59:09 (1412): VM state change detected. (old = 'running', new = 'paused')
2025-11-24 03:59:29 (1412): Guest Log: 27:40:19.839448 timesync vgsvcTimeSyncWorker: Radical host time change: 9 170 907 000 000ns (HostNow=1 763 978 358 458 000 000 ns HostLast=1 763 969 187 551 000 000 ns)
2025-11-24 03:59:29 (1412): Guest Log: 27:40:19.839520 timesync vgsvcTimeSyncWorker: Radical guest time change: 9 165 953 916 000ns (GuestNow=1 763 977 776 171 474 000 ns GuestLast=1 763 968 610 217 558 000 ns fSetTimeLastLoop=false)
2025-11-24 03:59:29 (1412): VM state change detected. (old = 'paused', new = 'running')
2025-11-24 03:59:49 (1412): VM state change detected. (old = 'running', new = 'paused')
2025-11-24 04:00:09 (1412): VM state change detected. (old = 'paused', new = 'running')
2025-11-24 04:00:49 (1412): VM state change detected. (old = 'running', new = 'paused')
2025-11-24 04:01:09 (1412): VM state change detected. (old = 'paused', new = 'running')
2025-11-24 04:01:19 (1412): VM state change detected. (old = 'running', new = 'paused')
2025-11-24 04:01:39 (1412): VM state change detected. (old = 'paused', new = 'running')
2025-11-24 04:01:59 (1412): VM state change detected. (old = 'running', new = 'paused')
2025-11-24 04:02:19 (1412): VM state change detected. (old = 'paused', new = 'running')
2025-11-24 04:02:29 (1412): VM state change detected. (old = 'running', new = 'paused')
2025-11-24 04:02:50 (1412): VM state change detected. (old = 'paused', new = 'running')
2025-11-24 04:03:00 (1412): VM state change detected. (old = 'running', new = 'paused')
2025-11-24 04:03:20 (1412): VM state change detected. (old = 'paused', new = 'running')
2025-11-24 04:03:30 (1412): VM state change detected. (old = 'running', new = 'paused')
2025-11-24 04:03:50 (1412): VM state change detected. (old = 'paused', new = 'running')
2025-11-24 04:04:00 (1412): VM state change detected. (old = 'running', new = 'paused')
2025-11-24 04:04:20 (1412): VM state change detected. (old = 'paused', new = 'running')
2025-11-24 04:04:30 (1412): VM state change detected. (old = 'running', new = 'paused')
2025-11-24 04:04:50 (1412): VM state change detected. (old = 'paused', new = 'running')
2025-11-24 04:05:00 (1412): VM state change detected. (old = 'running', new = 'paused')
2025-11-24 04:05:20 (1412): VM state change detected. (old = 'paused', new = 'running')
2025-11-24 04:38:58 (1412): Guest Log: 28:16:30.078845 timesync vgsvcTimeSyncWorker: Radical host time change: 2 023 949 000 000ns (HostNow=1 763 980 737 428 000 000 ns HostLast=1 763 978 713 479 000 000 ns)
2025-11-24 04:38:58 (1412): Guest Log: 28:16:30.078932 timesync vgsvcTimeSyncWorker: Radical guest time change: 1 980 196 510 000ns (GuestNow=1 763 979 946 410 882 000 ns GuestLast=1 763 977 966 214 372 000 ns fSetTimeLastLoop=false)
2025-11-24 06:38:58 (1412): Guest Log: 29:16:32.369371 timesync vgsvcTimeSyncWorker: Radical host time change: 3 600 450 000 000ns (HostNow=1 763 984 337 878 000 000 ns HostLast=1 763 980 737 428 000 000 ns)
2025-11-24 06:38:58 (1412): Guest Log: 29:16:32.369460 timesync vgsvcTimeSyncWorker: Radical guest time change: 3 602 290 497 000ns (GuestNow=1 763 983 548 701 379 000 ns GuestLast=1 763 979 946 410 882 000 ns fSetTimeLastLoop=false)
2025-11-24 06:38:58 (1412): Guest Log: 30:16:33.516088 timesync vgsvcTimeSyncWorker: Radical host time change: 3 599 383 000 000ns (HostNow=1 763 987 937 261 000 000 ns HostLast=1 763 984 337 878 000 000 ns)
2025-11-24 06:38:58 (1412): Guest Log: 30:16:33.516212 timesync vgsvcTimeSyncWorker: Radical guest time change: 3 601 146 714 000ns (GuestNow=1 763 987 149 848 093 000 ns GuestLast=1 763 983 548 701 379 000 ns fSetTimeLastLoop=false)
2025-11-24 07:38:58 (1412): Guest Log: 31:05:06.780725 timesync vgsvcTimeSyncWorker: Radical host time change: 2 911 815 000 000ns (HostNow=1 763 990 849 076 000 000 ns HostLast=1 763 987 937 261 000 000 ns)
2025-11-24 07:38:58 (1412): Guest Log: 31:05:06.780836 timesync vgsvcTimeSyncWorker: Radical guest time change: 2 913 264 647 000ns (GuestNow=1 763 990 063 112 740 000 ns GuestLast=1 763 987 149 848 093 000 ns fSetTimeLastLoop=false)
2025-11-24 08:38:58 (1412): Guest Log: 32:16:37.281103 timesync vgsvcTimeSyncWorker: Radical host time change: 3 600 062 000 000ns (HostNow=1 763 995 137 431 000 000 ns HostLast=1 763 991 537 369 000 000 ns)
2025-11-24 08:38:58 (1412): Guest Log: 32:16:37.281424 timesync vgsvcTimeSyncWorker: Radical guest time change: 3 601 863 245 000ns (GuestNow=1 763 994 353 613 133 000 ns GuestLast=1 763 990 751 749 888 000 ns fSetTimeLastLoop=false)
2025-11-24 09:38:58 (1412): Guest Log: 33:16:39.160711 timesync vgsvcTimeSyncWorker: Radical host time change: 3 600 077 000 000ns (HostNow=1 763 998 737 508 000 000 ns HostLast=1 763 995 137 431 000 000 ns)
2025-11-24 09:38:58 (1412): Guest Log: 33:16:39.160822 timesync vgsvcTimeSyncWorker: Radical guest time change: 3 601 879 556 000ns (GuestNow=1 763 997 955 492 689 000 ns GuestLast=1 763 994 353 613 133 000 ns fSetTimeLastLoop=false)
2025-11-24 09:39:09 (1412): VM state change detected. (old = 'running', new = 'paused')
2025-11-24 09:39:29 (1412): VM state change detected. (old = 'paused', new = 'running')
2025-11-24 09:39:39 (1412): VM state change detected. (old = 'running', new = 'paused')
2025-11-24 12:39:19 (1412): Guest Log: 33:17:00.795708 timesync vgsvcTimeSyncWorker: Radical host time change: 10 789 630 000 000ns (HostNow=1 764 009 554 313 000 000 ns HostLast=1 763 998 764 683 000 000 ns)
2025-11-24 12:39:19 (1412): VM state change detected. (old = 'paused', new = 'running')
2025-11-24 12:39:29 (1412): VM state change detected. (old = 'running', new = 'paused')
2025-11-24 13:38:58 (1412): Guest Log: 33:26:39.833208 timesync vgsvcTimeSyncWorker: Radical host time change: 3 583 618 000 000ns (HostNow=1 764 013 137 931 000 000 ns HostLast=1 764 009 554 313 000 000 ns)
2025-11-24 13:38:58 (1412): Guest Log: 33:26:39.833355 timesync vgsvcTimeSyncWorker: Radical guest time change: 12 156 218 210 000ns (GuestNow=1 764 010 133 345 569 000 ns GuestLast=1 763 997 977 127 359 000 ns fSetTimeLastLoop=true )
2025-11-24 13:38:58 (1412): VM state change detected. (old = 'paused', new = 'running')
2025-11-24 14:38:58 (1412): Guest Log: 34:26:39.326125 timesync vgsvcTimeSyncWorker: Radical guest time change: 6 604 083 639 000ns (GuestNow=1 764 016 737 429 208 000 ns GuestLast=1 764 010 133 345 569 000 ns fSetTimeLastLoop=true )
2025-11-24 14:39:03 (1412): Guest Log: [INFO] glidein exited with return value 0.
2025-11-24 14:39:03 (1412): Guest Log: [INFO] Shutting Down.
2025-11-24 14:39:03 (1412): VM Completion File Detected.
2025-11-24 14:39:03 (1412): VM Completion Message: glidein exited with return value 0.
.
2025-11-24 14:39:03 (1412): Powering off VM.
2025-11-24 14:39:04 (1412): Successfully stopped VM.
2025-11-24 14:39:04 (1412): Deregistering VM. (boinc_b41b74feaa376c24, slot#2)
2025-11-24 14:39:04 (1412): Removing network bandwidth throttle group from VM.
2025-11-24 14:39:04 (1412): Removing VM from VirtualBox.
2025-11-24 14:39:10 (1412): called boinc_finish(0)

</stderr_txt>
]]>

©2025 CERN