Stderr output

<core_client_version>8.0.2</core_client_version>
<![CDATA[
<message>
Unspecified error
 (0x80004005) - exit code 2147500037 (0x80004005)</message>
<stderr_txt>
025-01-22 16:47:59 (24928): VM state change detected. (old = 'running', new = 'paused')
2025-01-22 16:48:19 (24928): VM state change detected. (old = 'paused', new = 'running')
2025-01-22 16:48:29 (24928): VM state change detected. (old = 'running', new = 'paused')
2025-01-22 16:48:49 (24928): VM state change detected. (old = 'paused', new = 'running')
2025-01-22 16:48:59 (24928): VM state change detected. (old = 'running', new = 'paused')
2025-01-22 16:49:19 (24928): VM state change detected. (old = 'paused', new = 'running')
2025-01-22 16:49:29 (24928): VM state change detected. (old = 'running', new = 'paused')
2025-01-22 16:49:49 (24928): VM state change detected. (old = 'paused', new = 'running')
2025-01-22 16:49:59 (24928): VM state change detected. (old = 'running', new = 'paused')
2025-01-22 16:50:19 (24928): VM state change detected. (old = 'paused', new = 'running')
2025-01-22 16:50:29 (24928): VM state change detected. (old = 'running', new = 'paused')
2025-01-22 16:51:09 (24928): VM state change detected. (old = 'paused', new = 'running')
2025-01-22 16:51:19 (24928): VM state change detected. (old = 'running', new = 'paused')
2025-01-22 16:51:39 (24928): VM state change detected. (old = 'paused', new = 'running')
2025-01-22 16:51:49 (24928): VM state change detected. (old = 'running', new = 'paused')
2025-01-22 16:52:10 (24928): VM state change detected. (old = 'paused', new = 'running')
2025-01-22 16:52:20 (24928): VM state change detected. (old = 'running', new = 'paused')
2025-01-22 16:52:40 (24928): VM state change detected. (old = 'paused', new = 'running')
2025-01-22 16:52:50 (24928): VM state change detected. (old = 'running', new = 'paused')
2025-01-22 16:53:10 (24928): VM state change detected. (old = 'paused', new = 'running')
2025-01-22 16:53:30 (24928): VM state change detected. (old = 'running', new = 'paused')
2025-01-22 16:53:50 (24928): VM state change detected. (old = 'paused', new = 'running')
2025-01-22 16:54:00 (24928): VM state change detected. (old = 'running', new = 'paused')
2025-01-22 16:54:20 (24928): VM state change detected. (old = 'paused', new = 'running')
2025-01-22 16:54:30 (24928): VM state change detected. (old = 'running', new = 'paused')
2025-01-22 16:54:50 (24928): VM state change detected. (old = 'paused', new = 'running')
2025-01-22 16:55:00 (24928): VM state change detected. (old = 'running', new = 'paused')
2025-01-22 16:55:20 (24928): VM state change detected. (old = 'paused', new = 'running')
2025-01-22 16:55:30 (24928): VM state change detected. (old = 'running', new = 'paused')
2025-01-22 16:55:50 (24928): VM state change detected. (old = 'paused', new = 'running')
2025-01-22 16:56:00 (24928): VM state change detected. (old = 'running', new = 'paused')
2025-01-22 16:56:20 (24928): VM state change detected. (old = 'paused', new = 'running')
2025-01-22 16:56:30 (24928): VM state change detected. (old = 'running', new = 'paused')
2025-01-22 16:56:50 (24928): VM state change detected. (old = 'paused', new = 'running')
2025-01-22 16:57:00 (24928): VM state change detected. (old = 'running', new = 'paused')
2025-01-22 16:57:20 (24928): VM state change detected. (old = 'paused', new = 'running')
2025-01-22 16:57:30 (24928): VM state change detected. (old = 'running', new = 'paused')
2025-01-22 16:57:50 (24928): VM state change detected. (old = 'paused', new = 'running')
2025-01-22 16:58:00 (24928): VM state change detected. (old = 'running', new = 'paused')
2025-01-22 16:58:40 (24928): VM state change detected. (old = 'paused', new = 'running')
2025-01-22 16:58:50 (24928): VM state change detected. (old = 'running', new = 'paused')
2025-01-22 16:59:10 (24928): VM state change detected. (old = 'paused', new = 'running')
2025-01-22 16:59:20 (24928): VM state change detected. (old = 'running', new = 'paused')
2025-01-22 16:59:40 (24928): VM state change detected. (old = 'paused', new = 'running')
2025-01-22 16:59:50 (24928): VM state change detected. (old = 'running', new = 'paused')
2025-01-22 17:00:10 (24928): VM state change detected. (old = 'paused', new = 'running')
2025-01-22 17:00:20 (24928): VM state change detected. (old = 'running', new = 'paused')
2025-01-22 17:00:40 (24928): VM state change detected. (old = 'paused', new = 'running')
2025-01-22 17:00:50 (24928): VM state change detected. (old = 'running', new = 'paused')
2025-01-22 17:01:10 (24928): VM state change detected. (old = 'paused', new = 'running')
2025-01-22 17:01:20 (24928): VM state change detected. (old = 'running', new = 'paused')
2025-01-22 17:01:40 (24928): VM state change detected. (old = 'paused', new = 'running')
2025-01-22 17:01:50 (24928): VM state change detected. (old = 'running', new = 'paused')
2025-01-22 17:02:10 (24928): VM state change detected. (old = 'paused', new = 'running')
2025-01-22 17:02:20 (24928): VM state change detected. (old = 'running', new = 'paused')
2025-01-22 17:02:40 (24928): VM state change detected. (old = 'paused', new = 'running')
2025-01-22 17:02:50 (24928): VM state change detected. (old = 'running', new = 'paused')
2025-01-22 17:03:10 (24928): VM state change detected. (old = 'paused', new = 'running')
2025-01-22 17:03:20 (24928): VM state change detected. (old = 'running', new = 'paused')
2025-01-22 17:03:40 (24928): VM state change detected. (old = 'paused', new = 'running')
2025-01-22 17:03:50 (24928): VM state change detected. (old = 'running', new = 'paused')
2025-01-22 17:04:10 (24928): VM state change detected. (old = 'paused', new = 'running')
2025-01-22 17:04:20 (24928): VM state change detected. (old = 'running', new = 'paused')
2025-01-22 17:04:40 (24928): VM state change detected. (old = 'paused', new = 'running')
2025-01-22 17:04:50 (24928): VM state change detected. (old = 'running', new = 'paused')
2025-01-22 17:05:10 (24928): VM state change detected. (old = 'paused', new = 'running')
2025-01-22 17:05:20 (24928): VM state change detected. (old = 'running', new = 'paused')
2025-01-22 17:05:40 (24928): VM state change detected. (old = 'paused', new = 'running')
2025-01-22 17:05:50 (24928): VM state change detected. (old = 'running', new = 'paused')
2025-01-22 17:06:10 (24928): VM state change detected. (old = 'paused', new = 'running')
2025-01-22 17:06:20 (24928): VM state change detected. (old = 'running', new = 'paused')
2025-01-22 17:06:40 (24928): VM state change detected. (old = 'paused', new = 'running')
2025-01-22 17:06:51 (24928): VM state change detected. (old = 'running', new = 'paused')
2025-01-22 17:07:11 (24928): VM state change detected. (old = 'paused', new = 'running')
2025-01-22 17:07:21 (24928): VM state change detected. (old = 'running', new = 'paused')
2025-01-22 17:07:41 (24928): VM state change detected. (old = 'paused', new = 'running')
2025-01-22 17:07:51 (24928): VM state change detected. (old = 'running', new = 'paused')
2025-01-22 17:08:11 (24928): VM state change detected. (old = 'paused', new = 'running')
2025-01-22 17:08:21 (24928): VM state change detected. (old = 'running', new = 'paused')
2025-01-22 17:08:41 (24928): VM state change detected. (old = 'paused', new = 'running')
2025-01-22 17:08:51 (24928): VM state change detected. (old = 'running', new = 'paused')
2025-01-22 17:09:11 (24928): VM state change detected. (old = 'paused', new = 'running')
2025-01-22 17:09:21 (24928): VM state change detected. (old = 'running', new = 'paused')
2025-01-22 17:09:41 (24928): VM state change detected. (old = 'paused', new = 'running')
2025-01-22 17:09:51 (24928): VM state change detected. (old = 'running', new = 'paused')
2025-01-22 17:10:11 (24928): VM state change detected. (old = 'paused', new = 'running')
2025-01-22 17:10:21 (24928): VM state change detected. (old = 'running', new = 'paused')
2025-01-22 17:10:41 (24928): VM state change detected. (old = 'paused', new = 'running')
2025-01-22 17:10:51 (24928): VM state change detected. (old = 'running', new = 'paused')
2025-01-22 17:11:11 (24928): VM state change detected. (old = 'paused', new = 'running')
2025-01-22 17:11:21 (24928): VM state change detected. (old = 'running', new = 'paused')
2025-01-22 17:11:41 (24928): VM state change detected. (old = 'paused', new = 'running')
2025-01-22 17:11:51 (24928): VM state change detected. (old = 'running', new = 'paused')
2025-01-22 17:12:11 (24928): VM state change detected. (old = 'paused', new = 'running')
2025-01-22 17:12:21 (24928): VM state change detected. (old = 'running', new = 'paused')
2025-01-22 17:12:41 (24928): VM state change detected. (old = 'paused', new = 'running')
2025-01-22 17:12:51 (24928): VM state change detected. (old = 'running', new = 'paused')
2025-01-22 17:13:11 (24928): VM state change detected. (old = 'paused', new = 'running')
2025-01-22 17:13:21 (24928): VM state change detected. (old = 'running', new = 'paused')
2025-01-22 17:13:41 (24928): VM state change detected. (old = 'paused', new = 'running')
2025-01-22 17:13:51 (24928): VM state change detected. (old = 'running', new = 'paused')
2025-01-22 17:14:11 (24928): VM state change detected. (old = 'paused', new = 'running')
2025-01-22 17:14:21 (24928): VM state change detected. (old = 'running', new = 'paused')
2025-01-22 17:14:41 (24928): VM state change detected. (old = 'paused', new = 'running')
2025-01-22 17:14:51 (24928): VM state change detected. (old = 'running', new = 'paused')
2025-01-22 17:15:11 (24928): VM state change detected. (old = 'paused', new = 'running')
2025-01-22 17:15:21 (24928): VM state change detected. (old = 'running', new = 'paused')
2025-01-22 17:15:41 (24928): VM state change detected. (old = 'paused', new = 'running')
2025-01-22 17:15:51 (24928): VM state change detected. (old = 'running', new = 'paused')
2025-01-22 17:16:11 (24928): VM state change detected. (old = 'paused', new = 'running')
2025-01-22 17:16:21 (24928): VM state change detected. (old = 'running', new = 'paused')
2025-01-22 17:16:41 (24928): VM state change detected. (old = 'paused', new = 'running')
2025-01-22 17:16:51 (24928): VM state change detected. (old = 'running', new = 'paused')
2025-01-22 17:17:11 (24928): VM state change detected. (old = 'paused', new = 'running')
2025-01-22 17:17:21 (24928): VM state change detected. (old = 'running', new = 'paused')
2025-01-22 17:17:41 (24928): VM state change detected. (old = 'paused', new = 'running')
2025-01-22 17:17:51 (24928): VM state change detected. (old = 'running', new = 'paused')
2025-01-22 17:18:11 (24928): VM state change detected. (old = 'paused', new = 'running')
2025-01-22 17:18:21 (24928): VM state change detected. (old = 'running', new = 'paused')
2025-01-22 17:18:41 (24928): VM state change detected. (old = 'paused', new = 'running')
2025-01-22 17:18:51 (24928): VM state change detected. (old = 'running', new = 'paused')
2025-01-22 17:19:12 (24928): VM state change detected. (old = 'paused', new = 'running')
2025-01-22 17:19:22 (24928): VM state change detected. (old = 'running', new = 'paused')
2025-01-22 17:19:42 (24928): VM state change detected. (old = 'paused', new = 'running')
2025-01-22 17:19:52 (24928): VM state change detected. (old = 'running', new = 'paused')
2025-01-22 17:20:12 (24928): VM state change detected. (old = 'paused', new = 'running')
2025-01-22 17:20:22 (24928): VM state change detected. (old = 'running', new = 'paused')
2025-01-22 17:20:42 (24928): VM state change detected. (old = 'paused', new = 'running')
2025-01-22 17:20:52 (24928): VM state change detected. (old = 'running', new = 'paused')
2025-01-22 17:21:12 (24928): VM state change detected. (old = 'paused', new = 'running')
2025-01-22 17:21:22 (24928): VM state change detected. (old = 'running', new = 'paused')
2025-01-22 17:21:42 (24928): VM state change detected. (old = 'paused', new = 'running')
2025-01-22 17:21:52 (24928): VM state change detected. (old = 'running', new = 'paused')
2025-01-22 17:22:12 (24928): VM state change detected. (old = 'paused', new = 'running')
2025-01-22 17:22:22 (24928): VM state change detected. (old = 'running', new = 'paused')
2025-01-22 17:22:42 (24928): VM state change detected. (old = 'paused', new = 'running')
2025-01-22 17:22:52 (24928): VM state change detected. (old = 'running', new = 'paused')
2025-01-22 17:23:12 (24928): VM state change detected. (old = 'paused', new = 'running')
2025-01-22 17:23:22 (24928): VM state change detected. (old = 'running', new = 'paused')
2025-01-22 17:23:42 (24928): VM state change detected. (old = 'paused', new = 'running')
2025-01-22 17:23:52 (24928): VM state change detected. (old = 'running', new = 'paused')
2025-01-22 17:24:12 (24928): VM state change detected. (old = 'paused', new = 'running')
2025-01-22 17:24:22 (24928): VM state change detected. (old = 'running', new = 'paused')
2025-01-22 17:24:42 (24928): VM state change detected. (old = 'paused', new = 'running')
2025-01-22 17:24:52 (24928): VM state change detected. (old = 'running', new = 'paused')
2025-01-22 17:25:12 (24928): VM state change detected. (old = 'paused', new = 'running')
2025-01-22 17:25:22 (24928): VM state change detected. (old = 'running', new = 'paused')
2025-01-22 17:25:42 (24928): VM state change detected. (old = 'paused', new = 'running')
2025-01-22 17:25:52 (24928): VM state change detected. (old = 'running', new = 'paused')
2025-01-22 17:26:12 (24928): VM state change detected. (old = 'paused', new = 'running')
2025-01-22 17:26:22 (24928): VM state change detected. (old = 'running', new = 'paused')
2025-01-22 17:26:42 (24928): VM state change detected. (old = 'paused', new = 'running')
2025-01-22 17:26:52 (24928): VM state change detected. (old = 'running', new = 'paused')
2025-01-22 17:27:12 (24928): VM state change detected. (old = 'paused', new = 'running')
2025-01-22 17:27:22 (24928): VM state change detected. (old = 'running', new = 'paused')
2025-01-22 17:27:42 (24928): VM state change detected. (old = 'paused', new = 'running')
2025-01-22 17:27:52 (24928): VM state change detected. (old = 'running', new = 'paused')
2025-01-22 17:28:12 (24928): VM state change detected. (old = 'paused', new = 'running')
2025-01-22 17:28:22 (24928): VM state change detected. (old = 'running', new = 'paused')
2025-01-22 17:28:42 (24928): VM state change detected. (old = 'paused', new = 'running')
2025-01-22 17:28:52 (24928): VM state change detected. (old = 'running', new = 'paused')
2025-01-22 17:29:12 (24928): VM state change detected. (old = 'paused', new = 'running')
2025-01-22 17:29:22 (24928): VM state change detected. (old = 'running', new = 'paused')
2025-01-22 17:29:42 (24928): VM state change detected. (old = 'paused', new = 'running')
2025-01-22 17:29:52 (24928): VM state change detected. (old = 'running', new = 'paused')
2025-01-22 17:30:12 (24928): VM state change detected. (old = 'paused', new = 'running')
2025-01-22 17:30:22 (24928): VM state change detected. (old = 'running', new = 'paused')
2025-01-22 17:30:42 (24928): VM state change detected. (old = 'paused', new = 'running')
2025-01-22 17:30:52 (24928): VM state change detected. (old = 'running', new = 'paused')
2025-01-22 17:31:12 (24928): VM state change detected. (old = 'paused', new = 'running')
2025-01-22 17:31:22 (24928): VM state change detected. (old = 'running', new = 'paused')
2025-01-22 17:31:42 (24928): VM state change detected. (old = 'paused', new = 'running')
2025-01-22 17:31:52 (24928): VM state change detected. (old = 'running', new = 'paused')
2025-01-22 17:32:12 (24928): VM state change detected. (old = 'paused', new = 'running')
2025-01-22 17:32:22 (24928): VM state change detected. (old = 'running', new = 'paused')
2025-01-22 17:32:43 (24928): VM state change detected. (old = 'paused', new = 'running')
2025-01-22 17:32:53 (24928): VM state change detected. (old = 'running', new = 'paused')
2025-01-22 17:33:13 (24928): VM state change detected. (old = 'paused', new = 'running')
2025-01-22 17:33:23 (24928): VM state change detected. (old = 'running', new = 'paused')
2025-01-22 17:33:43 (24928): VM state change detected. (old = 'paused', new = 'running')
2025-01-22 17:33:53 (24928): VM state change detected. (old = 'running', new = 'paused')
2025-01-22 17:34:13 (24928): VM state change detected. (old = 'paused', new = 'running')
2025-01-22 17:34:23 (24928): VM state change detected. (old = 'running', new = 'paused')
2025-01-22 17:34:43 (24928): VM state change detected. (old = 'paused', new = 'running')
2025-01-22 17:34:53 (24928): VM state change detected. (old = 'running', new = 'paused')
2025-01-22 17:35:13 (24928): VM state change detected. (old = 'paused', new = 'running')
2025-01-22 17:35:23 (24928): VM state change detected. (old = 'running', new = 'paused')
2025-01-22 17:35:43 (24928): VM state change detected. (old = 'paused', new = 'running')
2025-01-22 17:35:53 (24928): VM state change detected. (old = 'running', new = 'paused')
2025-01-22 17:36:13 (24928): VM state change detected. (old = 'paused', new = 'running')
2025-01-22 17:36:23 (24928): VM state change detected. (old = 'running', new = 'paused')
2025-01-22 17:36:43 (24928): VM state change detected. (old = 'paused', new = 'running')
2025-01-22 17:36:53 (24928): VM state change detected. (old = 'running', new = 'paused')
2025-01-22 17:37:13 (24928): VM state change detected. (old = 'paused', new = 'running')
2025-01-22 17:37:23 (24928): VM state change detected. (old = 'running', new = 'paused')
2025-01-22 17:37:43 (24928): VM state change detected. (old = 'paused', new = 'running')
2025-01-22 17:37:53 (24928): VM state change detected. (old = 'running', new = 'paused')
2025-01-22 17:38:13 (24928): VM state change detected. (old = 'paused', new = 'running')
2025-01-22 17:38:23 (24928): VM state change detected. (old = 'running', new = 'paused')
2025-01-22 17:38:43 (24928): VM state change detected. (old = 'paused', new = 'running')
2025-01-22 17:38:53 (24928): VM state change detected. (old = 'running', new = 'paused')
2025-01-22 17:39:13 (24928): VM state change detected. (old = 'paused', new = 'running')
2025-01-22 17:39:23 (24928): VM state change detected. (old = 'running', new = 'paused')
2025-01-22 17:39:43 (24928): VM state change detected. (old = 'paused', new = 'running')
2025-01-22 17:39:53 (24928): VM state change detected. (old = 'running', new = 'paused')
2025-01-22 17:40:13 (24928): VM state change detected. (old = 'paused', new = 'running')
2025-01-22 17:40:23 (24928): VM state change detected. (old = 'running', new = 'paused')
2025-01-22 17:40:43 (24928): VM state change detected. (old = 'paused', new = 'running')
2025-01-22 17:40:53 (24928): VM state change detected. (old = 'running', new = 'paused')
2025-01-22 17:41:13 (24928): VM state change detected. (old = 'paused', new = 'running')
2025-01-22 17:41:23 (24928): VM state change detected. (old = 'running', new = 'paused')
2025-01-22 17:41:43 (24928): VM state change detected. (old = 'paused', new = 'running')
2025-01-22 17:42:03 (24928): VM state change detected. (old = 'running', new = 'paused')
2025-01-22 17:42:23 (24928): VM state change detected. (old = 'paused', new = 'running')
2025-01-22 17:42:33 (24928): VM state change detected. (old = 'running', new = 'paused')
2025-01-22 17:42:53 (24928): VM state change detected. (old = 'paused', new = 'running')
2025-01-22 17:43:03 (24928): VM state change detected. (old = 'running', new = 'paused')
2025-01-22 17:43:23 (24928): VM state change detected. (old = 'paused', new = 'running')
2025-01-22 17:43:33 (24928): VM state change detected. (old = 'running', new = 'paused')
2025-01-22 17:43:53 (24928): VM state change detected. (old = 'paused', new = 'running')
2025-01-22 17:44:03 (24928): VM state change detected. (old = 'running', new = 'paused')
2025-01-22 17:44:23 (24928): VM state change detected. (old = 'paused', new = 'running')
2025-01-22 17:44:33 (24928): VM state change detected. (old = 'running', new = 'paused')
2025-01-22 17:45:13 (24928): VM state change detected. (old = 'paused', new = 'running')
2025-01-22 17:45:23 (24928): VM state change detected. (old = 'running', new = 'paused')
2025-01-22 17:45:43 (24928): VM state change detected. (old = 'paused', new = 'running')
2025-01-22 17:46:03 (24928): VM state change detected. (old = 'running', new = 'paused')
2025-01-22 17:46:23 (24928): VM state change detected. (old = 'paused', new = 'running')
2025-01-22 17:46:34 (24928): VM state change detected. (old = 'running', new = 'paused')
2025-01-22 17:46:54 (24928): VM state change detected. (old = 'paused', new = 'running')
2025-01-22 17:47:05 (24928): VM state change detected. (old = 'running', new = 'paused')
2025-01-22 17:47:24 (24928): VM state change detected. (old = 'paused', new = 'running')
2025-01-22 17:47:35 (24928): VM state change detected. (old = 'running', new = 'paused')
2025-01-22 17:47:54 (24928): VM state change detected. (old = 'paused', new = 'running')
2025-01-22 17:48:04 (24928): VM state change detected. (old = 'running', new = 'paused')
2025-01-22 17:48:24 (24928): VM state change detected. (old = 'paused', new = 'running')
2025-01-22 17:48:34 (24928): VM state change detected. (old = 'running', new = 'paused')
2025-01-22 17:48:55 (24928): VM state change detected. (old = 'paused', new = 'running')
2025-01-22 17:49:04 (24928): VM state change detected. (old = 'running', new = 'paused')
2025-01-22 17:49:24 (24928): VM state change detected. (old = 'paused', new = 'running')
2025-01-22 17:49:35 (24928): VM state change detected. (old = 'running', new = 'paused')
2025-01-22 17:49:55 (24928): VM state change detected. (old = 'paused', new = 'running')
2025-01-22 17:50:04 (24928): VM state change detected. (old = 'running', new = 'paused')
2025-01-22 17:50:24 (24928): VM state change detected. (old = 'paused', new = 'running')
2025-01-22 17:50:35 (24928): VM state change detected. (old = 'running', new = 'paused')
2025-01-22 17:50:55 (24928): VM state change detected. (old = 'paused', new = 'running')
2025-01-22 17:51:04 (24928): VM state change detected. (old = 'running', new = 'paused')
2025-01-22 17:51:24 (24928): VM state change detected. (old = 'paused', new = 'running')
2025-01-22 17:51:35 (24928): VM state change detected. (old = 'running', new = 'paused')
2025-01-22 17:51:55 (24928): VM state change detected. (old = 'paused', new = 'running')
2025-01-22 17:52:05 (24928): VM state change detected. (old = 'running', new = 'paused')
2025-01-22 17:52:25 (24928): VM state change detected. (old = 'paused', new = 'running')
2025-01-22 17:52:35 (24928): VM state change detected. (old = 'running', new = 'paused')
2025-01-22 17:52:55 (24928): VM state change detected. (old = 'paused', new = 'running')
2025-01-22 17:53:05 (24928): VM state change detected. (old = 'running', new = 'paused')
2025-01-22 17:53:25 (24928): VM state change detected. (old = 'paused', new = 'running')
2025-01-22 17:53:35 (24928): VM state change detected. (old = 'running', new = 'paused')
2025-01-22 17:53:55 (24928): VM state change detected. (old = 'paused', new = 'running')
2025-01-22 17:54:05 (24928): VM state change detected. (old = 'running', new = 'paused')
2025-01-22 17:54:25 (24928): VM state change detected. (old = 'paused', new = 'running')
2025-01-22 17:54:35 (24928): VM state change detected. (old = 'running', new = 'paused')
2025-01-22 17:54:55 (24928): VM state change detected. (old = 'paused', new = 'running')
2025-01-22 17:55:05 (24928): VM state change detected. (old = 'running', new = 'paused')
2025-01-22 17:55:25 (24928): VM state change detected. (old = 'paused', new = 'running')
2025-01-22 17:55:35 (24928): VM state change detected. (old = 'running', new = 'paused')
2025-01-22 17:55:55 (24928): VM state change detected. (old = 'paused', new = 'running')
2025-01-22 17:56:05 (24928): VM state change detected. (old = 'running', new = 'paused')
2025-01-22 17:56:25 (24928): VM state change detected. (old = 'paused', new = 'running')
2025-01-22 17:56:35 (24928): VM state change detected. (old = 'running', new = 'paused')
2025-01-22 17:56:55 (24928): VM state change detected. (old = 'paused', new = 'running')
2025-01-22 17:56:55 (24928): Status Report: Job Duration: '864000.000000'
2025-01-22 17:56:55 (24928): Status Report: Elapsed Time: '6000.000000'
2025-01-22 17:56:55 (24928): Status Report: CPU Time: '3714.906250'
2025-01-22 17:57:05 (24928): VM state change detected. (old = 'running', new = 'paused')
2025-01-22 17:57:25 (24928): VM state change detected. (old = 'paused', new = 'running')
2025-01-22 17:57:35 (24928): VM state change detected. (old = 'running', new = 'paused')
2025-01-22 17:57:55 (24928): VM state change detected. (old = 'paused', new = 'running')
2025-01-22 17:58:05 (24928): VM state change detected. (old = 'running', new = 'paused')
2025-01-22 17:58:25 (24928): VM state change detected. (old = 'paused', new = 'running')
2025-01-22 17:58:35 (24928): VM state change detected. (old = 'running', new = 'paused')
2025-01-22 17:58:55 (24928): VM state change detected. (old = 'paused', new = 'running')
2025-01-22 17:59:05 (24928): VM state change detected. (old = 'running', new = 'paused')
2025-01-22 17:59:25 (24928): VM state change detected. (old = 'paused', new = 'running')
2025-01-22 17:59:35 (24928): VM state change detected. (old = 'running', new = 'paused')
2025-01-22 17:59:55 (24928): VM state change detected. (old = 'paused', new = 'running')
2025-01-22 18:00:05 (24928): VM state change detected. (old = 'running', new = 'paused')
2025-01-22 18:00:25 (24928): VM state change detected. (old = 'paused', new = 'running')
2025-01-22 18:00:35 (24928): VM state change detected. (old = 'running', new = 'paused')
2025-01-22 18:00:55 (24928): VM state change detected. (old = 'paused', new = 'running')
2025-01-22 18:01:05 (24928): VM state change detected. (old = 'running', new = 'paused')
2025-01-22 18:01:25 (24928): VM state change detected. (old = 'paused', new = 'running')
2025-01-22 18:01:35 (24928): VM state change detected. (old = 'running', new = 'paused')
2025-01-22 18:01:56 (24928): VM state change detected. (old = 'paused', new = 'running')
2025-01-22 18:02:06 (24928): VM state change detected. (old = 'running', new = 'paused')
2025-01-22 18:02:26 (24928): VM state change detected. (old = 'paused', new = 'running')
2025-01-22 18:02:36 (24928): VM state change detected. (old = 'running', new = 'paused')
2025-01-22 18:02:56 (24928): VM state change detected. (old = 'paused', new = 'running')
2025-01-22 18:03:06 (24928): VM state change detected. (old = 'running', new = 'paused')
2025-01-22 18:04:06 (24928): VM state change detected. (old = 'paused', new = 'running')
2025-01-22 18:04:16 (24928): VM state change detected. (old = 'running', new = 'paused')
2025-01-22 18:04:56 (24928): VM state change detected. (old = 'paused', new = 'running')
2025-01-22 18:05:06 (24928): VM state change detected. (old = 'running', new = 'paused')
2025-01-22 18:05:26 (24928): VM state change detected. (old = 'paused', new = 'running')
2025-01-22 18:05:36 (24928): VM state change detected. (old = 'running', new = 'paused')
2025-01-22 18:05:56 (24928): VM state change detected. (old = 'paused', new = 'running')
2025-01-22 18:06:06 (24928): VM state change detected. (old = 'running', new = 'paused')
2025-01-22 18:06:26 (24928): VM state change detected. (old = 'paused', new = 'running')
2025-01-22 18:06:36 (24928): VM state change detected. (old = 'running', new = 'paused')
2025-01-22 18:07:16 (24928): VM state change detected. (old = 'paused', new = 'running')
2025-01-22 18:07:26 (24928): VM state change detected. (old = 'running', new = 'paused')
2025-01-22 18:07:46 (24928): VM state change detected. (old = 'paused', new = 'running')
2025-01-22 18:07:56 (24928): VM state change detected. (old = 'running', new = 'paused')
2025-01-22 18:08:16 (24928): VM state change detected. (old = 'paused', new = 'running')
2025-01-22 18:08:26 (24928): VM state change detected. (old = 'running', new = 'paused')
2025-01-22 18:08:46 (24928): VM state change detected. (old = 'paused', new = 'running')
2025-01-22 18:09:06 (24928): VM state change detected. (old = 'running', new = 'paused')
2025-01-22 18:09:26 (24928): VM state change detected. (old = 'paused', new = 'running')
2025-01-22 18:09:36 (24928): VM state change detected. (old = 'running', new = 'paused')
2025-01-22 18:09:56 (24928): VM state change detected. (old = 'paused', new = 'running')
2025-01-22 18:10:06 (24928): VM state change detected. (old = 'running', new = 'paused')
2025-01-22 18:10:26 (24928): VM state change detected. (old = 'paused', new = 'running')
2025-01-22 18:10:36 (24928): VM state change detected. (old = 'running', new = 'paused')
2025-01-22 18:10:56 (24928): VM state change detected. (old = 'paused', new = 'running')
2025-01-22 18:11:06 (24928): VM state change detected. (old = 'running', new = 'paused')
2025-01-22 18:11:26 (24928): VM state change detected. (old = 'paused', new = 'running')
2025-01-22 18:11:36 (24928): VM state change detected. (old = 'running', new = 'paused')
2025-01-22 18:11:56 (24928): VM state change detected. (old = 'paused', new = 'running')
2025-01-22 18:12:06 (24928): VM state change detected. (old = 'running', new = 'paused')
2025-01-22 18:12:26 (24928): VM state change detected. (old = 'paused', new = 'running')
2025-01-22 18:12:36 (24928): VM state change detected. (old = 'running', new = 'paused')
2025-01-22 18:13:16 (24928): VM state change detected. (old = 'paused', new = 'running')
2025-01-22 18:13:26 (24928): VM state change detected. (old = 'running', new = 'paused')
2025-01-22 18:13:46 (24928): VM state change detected. (old = 'paused', new = 'running')
2025-01-22 18:13:56 (24928): VM state change detected. (old = 'running', new = 'paused')
2025-01-22 18:14:16 (24928): VM state change detected. (old = 'paused', new = 'running')
2025-01-22 18:14:26 (24928): VM state change detected. (old = 'running', new = 'paused')
2025-01-22 18:14:46 (24928): VM state change detected. (old = 'paused', new = 'running')
2025-01-22 18:14:56 (24928): VM state change detected. (old = 'running', new = 'paused')
2025-01-22 18:15:16 (24928): VM state change detected. (old = 'paused', new = 'running')
2025-01-22 18:15:26 (24928): VM state change detected. (old = 'running', new = 'paused')
2025-01-22 18:15:46 (24928): VM state change detected. (old = 'paused', new = 'running')
2025-01-22 18:15:56 (24928): VM state change detected. (old = 'running', new = 'paused')
2025-01-22 18:16:16 (24928): VM state change detected. (old = 'paused', new = 'running')
2025-01-22 18:16:26 (24928): VM state change detected. (old = 'running', new = 'paused')
2025-01-22 18:16:46 (24928): VM state change detected. (old = 'paused', new = 'running')
2025-01-22 18:16:56 (24928): VM state change detected. (old = 'running', new = 'paused')
2025-01-22 18:17:16 (24928): VM state change detected. (old = 'paused', new = 'running')
2025-01-22 18:17:26 (24928): VM state change detected. (old = 'running', new = 'paused')
2025-01-22 18:17:47 (24928): VM state change detected. (old = 'paused', new = 'running')
2025-01-22 18:17:57 (24928): VM state change detected. (old = 'running', new = 'paused')
2025-01-22 18:18:17 (24928): VM state change detected. (old = 'paused', new = 'running')
2025-01-22 18:18:27 (24928): VM state change detected. (old = 'running', new = 'paused')
2025-01-22 18:18:47 (24928): VM state change detected. (old = 'paused', new = 'running')
2025-01-22 18:18:57 (24928): VM state change detected. (old = 'running', new = 'paused')
2025-01-22 18:19:17 (24928): VM state change detected. (old = 'paused', new = 'running')
2025-01-22 18:19:27 (24928): VM state change detected. (old = 'running', new = 'paused')
2025-01-22 18:19:47 (24928): VM state change detected. (old = 'paused', new = 'running')
2025-01-22 18:19:57 (24928): VM state change detected. (old = 'running', new = 'paused')
2025-01-22 18:20:17 (24928): VM state change detected. (old = 'paused', new = 'running')
2025-01-22 18:20:27 (24928): VM state change detected. (old = 'running', new = 'paused')
2025-01-22 18:20:47 (24928): VM state change detected. (old = 'paused', new = 'running')
2025-01-22 18:20:57 (24928): VM state change detected. (old = 'running', new = 'paused')
2025-01-22 18:21:17 (24928): VM state change detected. (old = 'paused', new = 'running')
2025-01-22 18:21:27 (24928): VM state change detected. (old = 'running', new = 'paused')
2025-01-22 18:21:47 (24928): VM state change detected. (old = 'paused', new = 'running')
2025-01-22 18:21:57 (24928): VM state change detected. (old = 'running', new = 'paused')
2025-01-22 18:22:17 (24928): VM state change detected. (old = 'paused', new = 'running')
2025-01-22 18:22:27 (24928): VM state change detected. (old = 'running', new = 'paused')
2025-01-22 18:22:47 (24928): VM state change detected. (old = 'paused', new = 'running')
2025-01-22 18:22:57 (24928): VM state change detected. (old = 'running', new = 'paused')
2025-01-22 18:23:17 (24928): VM state change detected. (old = 'paused', new = 'running')
2025-01-22 18:23:27 (24928): VM state change detected. (old = 'running', new = 'paused')
2025-01-22 18:23:47 (24928): VM state change detected. (old = 'paused', new = 'running')
2025-01-22 18:23:57 (24928): VM state change detected. (old = 'running', new = 'paused')
2025-01-22 18:24:17 (24928): VM state change detected. (old = 'paused', new = 'running')
2025-01-22 18:24:27 (24928): VM state change detected. (old = 'running', new = 'paused')
2025-01-22 18:24:47 (24928): VM state change detected. (old = 'paused', new = 'running')
2025-01-22 18:24:57 (24928): VM state change detected. (old = 'running', new = 'paused')
2025-01-22 18:25:37 (24928): VM state change detected. (old = 'paused', new = 'running')
2025-01-22 18:25:47 (24928): VM state change detected. (old = 'running', new = 'paused')
2025-01-22 18:26:07 (24928): VM state change detected. (old = 'paused', new = 'running')
2025-01-22 18:26:17 (24928): VM state change detected. (old = 'running', new = 'paused')
2025-01-22 18:26:37 (24928): VM state change detected. (old = 'paused', new = 'running')
2025-01-22 18:26:57 (24928): VM state change detected. (old = 'running', new = 'paused')
2025-01-22 18:27:17 (24928): VM state change detected. (old = 'paused', new = 'running')
2025-01-22 18:27:27 (24928): VM state change detected. (old = 'running', new = 'paused')
2025-01-22 18:27:47 (24928): VM state change detected. (old = 'paused', new = 'running')
2025-01-22 18:27:58 (24928): VM state change detected. (old = 'running', new = 'paused')
2025-01-22 18:28:18 (24928): VM state change detected. (old = 'paused', new = 'running')
2025-01-22 18:28:27 (24928): VM state change detected. (old = 'running', new = 'paused')
2025-01-22 18:28:47 (24928): VM state change detected. (old = 'paused', new = 'running')
2025-01-22 18:28:57 (24928): VM state change detected. (old = 'running', new = 'paused')
2025-01-22 18:29:17 (24928): VM state change detected. (old = 'paused', new = 'running')
2025-01-22 18:29:27 (24928): VM state change detected. (old = 'running', new = 'paused')
2025-01-22 18:29:48 (24928): VM state change detected. (old = 'paused', new = 'running')
2025-01-22 18:29:58 (24928): VM state change detected. (old = 'running', new = 'paused')
2025-01-22 18:30:18 (24928): VM state change detected. (old = 'paused', new = 'running')
2025-01-22 18:30:28 (24928): VM state change detected. (old = 'running', new = 'paused')
2025-01-22 18:30:48 (24928): VM state change detected. (old = 'paused', new = 'running')
2025-01-22 18:30:59 (24928): VM state change detected. (old = 'running', new = 'paused')
2025-01-22 18:31:19 (24928): VM state change detected. (old = 'paused', new = 'running')
2025-01-22 18:31:29 (24928): VM state change detected. (old = 'running', new = 'paused')
2025-01-22 18:31:49 (24928): VM state change detected. (old = 'paused', new = 'running')
2025-01-22 18:31:59 (24928): VM state change detected. (old = 'running', new = 'paused')
2025-01-22 18:32:19 (24928): VM state change detected. (old = 'paused', new = 'running')
2025-01-22 18:32:29 (24928): VM state change detected. (old = 'running', new = 'paused')
2025-01-22 18:32:49 (24928): VM state change detected. (old = 'paused', new = 'running')
2025-01-22 18:32:59 (24928): VM state change detected. (old = 'running', new = 'paused')
2025-01-22 18:33:19 (24928): VM state change detected. (old = 'paused', new = 'running')
2025-01-22 18:33:29 (24928): VM state change detected. (old = 'running', new = 'paused')
2025-01-22 18:33:49 (24928): VM state change detected. (old = 'paused', new = 'running')
2025-01-22 18:34:09 (24928): VM state change detected. (old = 'running', new = 'paused')
2025-01-22 18:34:29 (24928): VM state change detected. (old = 'paused', new = 'running')
2025-01-22 18:34:39 (24928): VM state change detected. (old = 'running', new = 'paused')
2025-01-22 18:34:59 (24928): VM state change detected. (old = 'paused', new = 'running')
2025-01-22 18:35:09 (24928): VM state change detected. (old = 'running', new = 'paused')
2025-01-22 18:35:29 (24928): VM state change detected. (old = 'paused', new = 'running')
2025-01-22 18:35:39 (24928): VM state change detected. (old = 'running', new = 'paused')
2025-01-22 18:35:59 (24928): VM state change detected. (old = 'paused', new = 'running')
2025-01-22 18:36:09 (24928): VM state change detected. (old = 'running', new = 'paused')
2025-01-22 18:36:29 (24928): VM state change detected. (old = 'paused', new = 'running')
2025-01-22 18:36:39 (24928): VM state change detected. (old = 'running', new = 'paused')
2025-01-22 18:37:00 (24928): VM state change detected. (old = 'paused', new = 'running')
2025-01-22 18:37:09 (24928): VM state change detected. (old = 'running', new = 'paused')
2025-01-22 18:37:29 (24928): VM state change detected. (old = 'paused', new = 'running')
2025-01-22 18:37:39 (24928): VM state change detected. (old = 'running', new = 'paused')
2025-01-22 18:38:00 (24928): VM state change detected. (old = 'paused', new = 'running')
2025-01-22 18:38:09 (24928): VM state change detected. (old = 'running', new = 'paused')
2025-01-22 18:38:29 (24928): VM state change detected. (old = 'paused', new = 'running')
2025-01-22 18:38:39 (24928): VM state change detected. (old = 'running', new = 'paused')
2025-01-22 18:39:00 (24928): VM state change detected. (old = 'paused', new = 'running')
2025-01-22 18:39:09 (24928): VM state change detected. (old = 'running', new = 'paused')
2025-01-22 18:39:29 (24928): VM state change detected. (old = 'paused', new = 'running')
2025-01-22 18:39:39 (24928): VM state change detected. (old = 'running', new = 'paused')
2025-01-22 18:40:00 (24928): VM state change detected. (old = 'paused', new = 'running')
2025-01-22 18:40:09 (24928): VM state change detected. (old = 'running', new = 'paused')
2025-01-22 18:40:29 (24928): VM state change detected. (old = 'paused', new = 'running')
2025-01-22 18:40:39 (24928): VM state change detected. (old = 'running', new = 'paused')
2025-01-22 18:41:00 (24928): VM state change detected. (old = 'paused', new = 'running')
2025-01-22 18:41:09 (24928): VM state change detected. (old = 'running', new = 'paused')
2025-01-22 18:41:29 (24928): VM state change detected. (old = 'paused', new = 'running')
2025-01-22 18:41:39 (24928): VM state change detected. (old = 'running', new = 'paused')
2025-01-22 18:42:00 (24928): VM state change detected. (old = 'paused', new = 'running')
2025-01-22 18:42:09 (24928): VM state change detected. (old = 'running', new = 'paused')
2025-01-22 18:42:29 (24928): VM state change detected. (old = 'paused', new = 'running')
2025-01-22 18:42:39 (24928): VM state change detected. (old = 'running', new = 'paused')
2025-01-22 18:43:00 (24928): VM state change detected. (old = 'paused', new = 'running')
2025-01-22 18:43:09 (24928): VM state change detected. (old = 'running', new = 'paused')
2025-01-22 18:43:29 (24928): VM state change detected. (old = 'paused', new = 'running')
2025-01-22 18:43:39 (24928): VM state change detected. (old = 'running', new = 'paused')
2025-01-22 18:44:00 (24928): VM state change detected. (old = 'paused', new = 'running')
2025-01-22 18:44:09 (24928): VM state change detected. (old = 'running', new = 'paused')
2025-01-22 18:44:30 (24928): VM state change detected. (old = 'paused', new = 'running')
2025-01-22 18:44:40 (24928): VM state change detected. (old = 'running', new = 'paused')
2025-01-22 18:45:01 (24928): VM state change detected. (old = 'paused', new = 'running')
2025-01-22 18:45:10 (24928): VM state change detected. (old = 'running', new = 'paused')
2025-01-22 18:45:30 (24928): VM state change detected. (old = 'paused', new = 'running')
2025-01-22 18:45:40 (24928): VM state change detected. (old = 'running', new = 'paused')
2025-01-22 18:46:00 (24928): VM state change detected. (old = 'paused', new = 'running')
2025-01-22 18:46:10 (24928): VM state change detected. (old = 'running', new = 'paused')
2025-01-22 18:46:30 (24928): VM state change detected. (old = 'paused', new = 'running')
2025-01-22 18:46:40 (24928): VM state change detected. (old = 'running', new = 'paused')
2025-01-22 18:47:00 (24928): VM state change detected. (old = 'paused', new = 'running')
2025-01-22 18:47:10 (24928): VM state change detected. (old = 'running', new = 'paused')
2025-01-22 18:47:30 (24928): VM state change detected. (old = 'paused', new = 'running')
2025-01-22 18:47:40 (24928): VM state change detected. (old = 'running', new = 'paused')
2025-01-23 08:09:14 (15920): vboxwrapper version 26208
2025-01-23 08:09:14 (15920): BOINC client version: 8.0.2
2025-01-23 08:09:19 (15920): Detected: VirtualBox VboxManage Interface (Version: 7.0.8)
2025-01-23 08:09:20 (15920): Detected: Heartbeat check (file: 'heartbeat' every 1200.000000 seconds)
2025-01-23 08:09:26 (15920): Guest Log: BIOS: VirtualBox 7.0.8
2025-01-23 08:09:26 (15920): Guest Log: CPUID EDX: 0x178bfbff
2025-01-23 08:09:26 (15920): Guest Log: BIOS: No PCI IDE controller, not probing IDE
2025-01-23 08:09:26 (15920): Guest Log: BIOS: AHCI 0-P#0: PCHS=16383/16/63 LCHS=1024/255/63 0x0000000002800000 sectors
2025-01-23 08:09:26 (15920): Guest Log: BIOS: Boot : bseqnr=1, bootseq=0032
2025-01-23 08:09:26 (15920): Guest Log: BIOS: Booting from Hard Disk...
2025-01-23 08:09:26 (15920): Guest Log: BIOS: KBD: unsupported int 16h function 03
2025-01-23 08:09:26 (15920): Guest Log: BIOS: AX=0305 BX=0000 CX=0000 DX=0000 
2025-01-23 08:09:26 (15920): Guest Log: vgdrvHeartbeatInit: Setting up heartbeat to trigger every 2000 milliseconds
2025-01-23 08:09:26 (15920): Guest Log: vboxguest: misc device minor 56, IRQ 20, I/O port d020, MMIO at 00000000f0400000 (size 0x400000)
2025-01-23 08:09:26 (15920): Guest Log: VBoxService 5.2.6 r120293 (verbosity: 0) linux.amd64 (Jan 15 2018 14:51:00) release log
2025-01-23 08:09:26 (15920): Guest Log: 00:00:00.000074 main     Log opened 2025-01-22T12:20:18.777844000Z
2025-01-23 08:09:26 (15920): Guest Log: 00:00:00.000219 main     OS Product: Linux
2025-01-23 08:09:26 (15920): Guest Log: 00:00:00.000273 main     OS Release: 4.14.76-13.cernvm.x86_64
2025-01-23 08:09:26 (15920): Guest Log: 00:00:00.000327 main     OS Version: #1 SMP Tue Oct 16 18:26:15 CEST 2018
2025-01-23 08:09:26 (15920): Guest Log: 00:00:00.000381 main     Executable: /usr/sbin/VBoxService
2025-01-23 08:09:26 (15920): Guest Log: 00:00:00.000382 main     Process ID: 3222
2025-01-23 08:09:26 (15920): Guest Log: 00:00:00.000383 main     Package type: LINUX_64BITS_GENERIC
2025-01-23 08:09:26 (15920): Guest Log: 00:00:00.002507 main     5.2.6 r120293 started. Verbose level = 0
2025-01-23 08:09:26 (15920): Guest Log: 13:20:50 CET +01:00 2025-01-22: cranky: [INFO] Detected Theory App
2025-01-23 08:09:26 (15920): Guest Log: 13:20:50 CET +01:00 2025-01-22: cranky: [INFO] Checking CVMFS.
2025-01-23 08:09:26 (15920): Guest Log: Probing /cvmfs/sft.cern.ch... OK
2025-01-23 08:09:26 (15920): 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
2025-01-23 08:09:26 (15920): Guest Log: 2.5.2.0 4064 0 28344 31540 3 1 278943 4096000 0 65024 0 0 n/a 5 10 http://s1ral-cvmfs.openhtc.io/cvmfs/sft.cern.ch DIRECT 1
2025-01-23 08:09:26 (15920): Guest Log: Probing /cvmfs/grid.cern.ch... OK
2025-01-23 08:09:26 (15920): 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
2025-01-23 08:09:26 (15920): Guest Log: 2.5.2.0 4088 0 27516 26289 3 2 278943 4096000 0 65024 0 2 -100 10085 6643 http://s1cern-cvmfs.openhtc.io/cvmfs/grid.cern.ch DIRECT 1
2025-01-23 08:09:26 (15920): Guest Log: Probing /cvmfs/cernvm-prod.cern.ch... OK
2025-01-23 08:09:26 (15920): 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
2025-01-23 08:09:26 (15920): Guest Log: 2.5.2.0 4114 0 25176 272 3 1 278943 4096000 0 65024 0 0 n/a 4 6 http://s1ral-cvmfs.openhtc.io/cvmfs/cernvm-prod.cern.ch DIRECT 1
2025-01-23 08:09:26 (15920): Guest Log: Probing /cvmfs/alice.cern.ch... OK
2025-01-23 08:09:26 (15920): 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
2025-01-23 08:09:26 (15920): Guest Log: 2.5.2.0 4135 0 42400 20937 3 1 278943 4096000 0 65024 0 0 n/a 6591 2412 http://s1cern-cvmfs.openhtc.io/cvmfs/alice.cern.ch DIRECT 1
2025-01-23 08:09:26 (15920): Guest Log: 13:20:58 CET +01:00 2025-01-22: cranky: [INFO] Checking runc.
2025-01-23 08:09:26 (15920): Guest Log: 13:20:58 CET +01:00 2025-01-22: cranky: [INFO] Creating the filesystem.
2025-01-23 08:09:26 (15920): Guest Log: 13:20:58 CET +01:00 2025-01-22: cranky: [INFO] Using /cvmfs/cernvm-prod.cern.ch/cvm4
2025-01-23 08:09:26 (15920): Guest Log: 13:20:58 CET +01:00 2025-01-22: cranky: [INFO] Updating config.json.
2025-01-23 08:09:26 (15920): Guest Log: 13:20:58 CET +01:00 2025-01-22: cranky: [INFO] Running Container 'runc'.
2025-01-23 08:09:26 (15920): Guest Log: job: htmld=/shared/html/job
2025-01-23 08:09:26 (15920): Guest Log: job: unpack exitcode=0
2025-01-23 08:09:26 (15920): Guest Log: INFO: activated the work-around for ld:
2025-01-23 08:09:26 (15920): Guest Log: lrwxrwxrwx 1 0 0 15 Jan 22 12:21 /tmp/tmp.2eMiqx5vJH/ld -> /usr/bin/ld.bfd
2025-01-23 08:09:26 (15920): Guest Log: 13:21:06 CET +01:00 2025-01-22: cranky: [INFO] ===> [runRivet] Wed Jan 22 12:21:05 UTC 2025 [boinc pp jets 13000 150 - powheg-box r3744 pthard0 100000 389]
2025-01-23 08:09:26 (15920): Starting VM using VBoxManage interface. (boinc_1db44abfd7ee6285, slot#3)
2025-01-23 08:23:33 (15920): Error in start VM for VM: -2147467259
Command:
VBoxManage -q startvm "boinc_1db44abfd7ee6285" --type headless
Output:
VBoxManage.exe: error: The VM session was aborted
VBoxManage.exe: error: Details: code E_FAIL (0x80004005), component SessionMachine, interface ISession
Waiting for VM "boinc_1db44abfd7ee6285" to power on...

2025-01-23 08:23:33 (15920): VM failed to start.
2025-01-23 08:23:33 (15920): Could not start 
2025-01-23 08:23:33 (15920): ERROR: VM failed to start
2025-01-23 08:23:33 (15920): Powering off VM.
2025-01-23 08:23:33 (15920): Deregistering VM. (boinc_1db44abfd7ee6285, slot#3)
2025-01-23 08:23:33 (15920): Removing network bandwidth throttle group from VM.
2025-01-23 08:23:34 (15920): Removing VM from VirtualBox.

    Hypervisor System Log:

00:00:14.990090          Saving settings file "C:\ProgramData\BOINC\slots\10\boinc_f4db73b4e31a9576\boinc_f4db73b4e31a9576.vbox" with version "1.19-windows"
00:00:15.001683          Finished saving settings file "C:\ProgramData\BOINC\slots\10\boinc_f4db73b4e31a9576\boinc_f4db73b4e31a9576.vbox"
00:00:15.247497          Saving settings file "C:\ProgramData\BOINC\slots\10\boinc_f4db73b4e31a9576\boinc_f4db73b4e31a9576.vbox" with version "1.19-windows"
00:00:15.254610          Finished saving settings file "C:\ProgramData\BOINC\slots\10\boinc_f4db73b4e31a9576\boinc_f4db73b4e31a9576.vbox"
00:00:15.544417          ERROR [COM]: aRC=VBOX_E_NOT_SUPPORTED (0x80bb0009) aIID={300763af-5d6b-46e6-aa96-273eac15538a} aComponent={SessionMachine} aText={This VM is not encrypted}, preserve=false aResultDetail=0
00:00:15.553742          ERROR [COM]: aRC=VBOX_E_OBJECT_NOT_FOUND (0x80bb0001) aIID={300763af-5d6b-46e6-aa96-273eac15538a} aComponent={SessionMachine} aText={No storage device attached to device slot 0 on port 2 of controller 'Hard Disk Controller'}, preserve=false aResultDetail=0
00:00:15.553846          ERROR [COM]: aRC=VBOX_E_OBJECT_NOT_FOUND (0x80bb0001) aIID={300763af-5d6b-46e6-aa96-273eac15538a} aComponent={SessionMachine} aText={No storage device attached to device slot 0 on port 2 of controller 'Hard Disk Controller'}, preserve=false aResultDetail=0
00:00:15.929861          ERROR [COM]: aRC=E_FAIL (0x80004005) aIID={300763af-5d6b-46e6-aa96-273eac15538a} aComponent={SessionMachine} aText={This machine does not have any snapshots}, preserve=false aResultDetail=0
00:00:16.339897          Launched VM: 1453549408 pid: 18572 (0x488c) frontend: headless name: boinc_f4db73b4e31a9576
00:00:18.618806          ERROR [COM]: aRC=VBOX_E_OBJECT_NOT_FOUND (0x80bb0001) aIID={ad47ad09-787b-44ab-b343-a082a3f2dfb1} aComponent={MediumWrap} aText={Property 'CRYPT/KeyId' does not exist}, preserve=false aResultDetail=0
00:00:18.619472          ERROR [COM]: aRC=VBOX_E_OBJECT_NOT_FOUND (0x80bb0001) aIID={ad47ad09-787b-44ab-b343-a082a3f2dfb1} aComponent={MediumWrap} aText={Property 'CRYPT/KeyId' does not exist}, preserve=false aResultDetail=0
00:00:21.138299          ERROR [COM]: aRC=VBOX_E_OBJECT_NOT_FOUND (0x80bb0001) aIID={ad47ad09-787b-44ab-b343-a082a3f2dfb1} aComponent={MediumWrap} aText={Property 'CRYPT/KeyId' does not exist}, preserve=false aResultDetail=0
00:00:21.138953          ERROR [COM]: aRC=VBOX_E_OBJECT_NOT_FOUND (0x80bb0001) aIID={ad47ad09-787b-44ab-b343-a082a3f2dfb1} aComponent={MediumWrap} aText={Property 'CRYPT/KeyId' does not exist}, preserve=false aResultDetail=0
00:00:23.195777          ERROR [COM]: aRC=VBOX_E_OBJECT_NOT_FOUND (0x80bb0001) aIID={ad47ad09-787b-44ab-b343-a082a3f2dfb1} aComponent={MediumWrap} aText={Property 'CRYPT/KeyId' does not exist}, preserve=false aResultDetail=0
00:00:23.196574          ERROR [COM]: aRC=VBOX_E_OBJECT_NOT_FOUND (0x80bb0001) aIID={ad47ad09-787b-44ab-b343-a082a3f2dfb1} aComponent={MediumWrap} aText={Property 'CRYPT/KeyId' does not exist}, preserve=false aResultDetail=0
00:00:28.565002          Saving settings file "C:\ProgramData\BOINC\slots\9\boinc_97bd385f2886b26b\boinc_97bd385f2886b26b.vbox" with version "1.19-windows"
00:00:28.572348          Finished saving settings file "C:\ProgramData\BOINC\slots\9\boinc_97bd385f2886b26b\boinc_97bd385f2886b26b.vbox"
00:00:28.623953          Saving settings file "C:\ProgramData\BOINC\slots\10\boinc_f4db73b4e31a9576\boinc_f4db73b4e31a9576.vbox" with version "1.19-windows"
00:00:28.629728          Finished saving settings file "C:\ProgramData\BOINC\slots\10\boinc_f4db73b4e31a9576\boinc_f4db73b4e31a9576.vbox"
00:00:29.038271          Saving settings file "C:\ProgramData\BOINC\slots\6\boinc_ed1d1f4997db0301\boinc_ed1d1f4997db0301.vbox" with version "1.19-windows"
00:00:29.044594          Finished saving settings file "C:\ProgramData\BOINC\slots\6\boinc_ed1d1f4997db0301\boinc_ed1d1f4997db0301.vbox"
00:00:35.128245 USBPROXY usbLibGetDevices: Starting USB device enumeration
00:00:35.128551 USBPROXY Getting USB descriptor (id 0) failed (dwErr=31) on hub USB#VID_0BDA&PID_5409#5&38e96659&0&1#{f18a0e88-c30c-11d0-8815-00a0c906bed8} port 6
00:00:35.142793 USBPROXY usbLibGetDevices: Found 3 USB devices, 0 captured
00:14:17.278302 Watcher  Saving settings file "C:\ProgramData\BOINC\slots\3\boinc_1db44abfd7ee6285\boinc_1db44abfd7ee6285.vbox" with version "1.19-windows"
00:14:17.291143 Watcher  Finished saving settings file "C:\ProgramData\BOINC\slots\3\boinc_1db44abfd7ee6285\boinc_1db44abfd7ee6285.vbox"
00:14:17.462259          ERROR [COM]: aRC=E_FAIL (0x80004005) aIID={300763af-5d6b-46e6-aa96-273eac15538a} aComponent={SessionMachine} aText={This machine does not have any snapshots}, preserve=false aResultDetail=0
00:14:17.462347 Watcher  Reaper: Pid 19176 (0x4ae8) exited normally: -2147483645 (0x80000003)
00:14:17.617603          Saving settings file "C:\ProgramData\BOINC\slots\3\boinc_1db44abfd7ee6285\boinc_1db44abfd7ee6285.vbox" with version "1.19-windows"
00:14:17.625929          Finished saving settings file "C:\ProgramData\BOINC\slots\3\boinc_1db44abfd7ee6285\boinc_1db44abfd7ee6285.vbox"
00:14:17.822942 Watcher  Saving settings file "C:\ProgramData\BOINC\slots\4\boinc_117b55bdf4ac3f65\boinc_117b55bdf4ac3f65.vbox" with version "1.19-windows"
00:14:17.830047 Watcher  Finished saving settings file "C:\ProgramData\BOINC\slots\4\boinc_117b55bdf4ac3f65\boinc_117b55bdf4ac3f65.vbox"
00:14:17.857314          Saving settings file "C:\Users\Mario\.VirtualBox\VirtualBox.xml" with version "1.12-windows"
00:14:17.865762          Finished saving settings file "C:\Users\Mario\.VirtualBox\VirtualBox.xml"
00:14:17.867256 DeleteVM Saving settings file "C:\ProgramData\BOINC\slots\7\boinc_d0cbb26deceda34f\boinc_d0cbb26deceda34f.vbox" with version "1.19-windows"
00:14:17.867622 DeleteVM Finished saving settings file "C:\ProgramData\BOINC\slots\7\boinc_d0cbb26deceda34f\boinc_d0cbb26deceda34f.vbox" with failure
00:14:17.867697 DeleteVM ERROR [COM]: aRC=E_FAIL (0x80004005) aIID={300763af-5d6b-46e6-aa96-273eac15538a} aComponent={MachineWrap} aText={Runtime error opening 'C:\ProgramData\BOINC\slots\7\boinc_d0cbb26deceda34f\boinc_d0cbb26deceda34f.vbox-tmp' for overwriting VERR_PATH_NOT_FOUND (Path not found.).
00:14:17.867701 DeleteVM F:\tinderbox\win-7.0\src\VBox\Main\src-server\MachineImpl.cpp[10456] (long __cdecl Machine::i_saveSettings(bool *,class util::AutoWriteLock &,int))}, preserve=true aResultDetail=0
00:14:17.980256          ERROR [COM]: aRC=E_FAIL (0x80004005) aIID={300763af-5d6b-46e6-aa96-273eac15538a} aComponent={SessionMachine} aText={This machine does not have any snapshots}, preserve=false aResultDetail=0
00:14:17.980415 Watcher  Reaper: Pid 3812 (0xee4) exited normally: -2147483645 (0x80000003)
00:14:18.109032          Saving settings file "C:\ProgramData\BOINC\slots\4\boinc_117b55bdf4ac3f65\boinc_117b55bdf4ac3f65.vbox" with version "1.19-windows"
00:14:18.118137          Finished saving settings file "C:\ProgramData\BOINC\slots\4\boinc_117b55bdf4ac3f65\boinc_117b55bdf4ac3f65.vbox"
00:14:18.379614          Saving settings file "C:\Users\Mario\.VirtualBox\VirtualBox.xml" with version "1.12-windows"
00:14:18.387009          Finished saving settings file "C:\Users\Mario\.VirtualBox\VirtualBox.xml"
00:14:18.388220 DeleteVM Saving settings file "C:\ProgramData\BOINC\slots\7\boinc_d0cbb26deceda34f\boinc_d0cbb26deceda34f.vbox" with version "1.19-windows"
00:14:18.388551 DeleteVM Finished saving settings file "C:\ProgramData\BOINC\slots\7\boinc_d0cbb26deceda34f\boinc_d0cbb26deceda34f.vbox" with failure
00:14:18.388628 DeleteVM ERROR [COM]: aRC=E_FAIL (0x80004005) aIID={300763af-5d6b-46e6-aa96-273eac15538a} aComponent={MachineWrap} aText={Runtime error opening 'C:\ProgramData\BOINC\slots\7\boinc_d0cbb26deceda34f\boinc_d0cbb26deceda34f.vbox-tmp' for overwriting VERR_PATH_NOT_FOUND (Path not found.).
00:14:18.388632 DeleteVM F:\tinderbox\win-7.0\src\VBox\Main\src-server\MachineImpl.cpp[10456] (long __cdecl Machine::i_saveSettings(bool *,class util::AutoWriteLock &,int))}, preserve=true aResultDetail=0

    VM Execution Log:


    VM Startup Log:


    VM Trace Log:

aximum Devices per virtio-scsi Port:   1
Maximum PIIX3 Floppy Controllers:1
Maximum ICH9 Floppy Controllers: 1
Maximum Floppy Port count:       1
Maximum Devices per Floppy Port: 2
Default machine folder:          D:\Virtual_machines
Raw-mode Supported:              no
Exclusive HW virtualization use: off
Default hard disk format:        VDI
VRDE auth library:               VBoxAuth
Webservice auth. library:        VBoxAuth
Remote desktop ExtPack:          Oracle VM VirtualBox Extension Pack
VM encryption ExtPack:           Oracle VM VirtualBox Extension Pack
Log history count:               3
Default frontend:                
Default audio driver:            Windows Audio Session
Autostart database path:         
Default Guest Additions ISO:     C:\Program Files\Oracle\VirtualBox/VBoxGuestAdditions.iso
Logging Level:                   all
Proxy Mode:                      System
Proxy URL:                       
User language:                   C

2025-01-23 08:09:20 (15920): 
Command: VBoxManage -q list hostinfo 
Exit Code: 0
Output:
Host Information:

Host time: 2025-01-23T07:09:19.971000000Z
Processor online count: 8
Processor count: 8
Processor online core count: 4
Processor core count: 4
Processor supports HW virtualization: yes
Processor supports PAE: yes
Processor supports long mode: yes
Processor supports nested paging: yes
Processor supports unrestricted guest: yes
Processor supports nested HW virtualization: yes
Processor supports virt. vmsave/vmload: no
Processor#0 speed: unknown
Processor#0 description: Intel(R) Core(TM) i7-6700 CPU @ 3.40GHz
Processor#1 speed: unknown
Processor#1 description: Intel(R) Core(TM) i7-6700 CPU @ 3.40GHz
Processor#2 speed: unknown
Processor#2 description: Intel(R) Core(TM) i7-6700 CPU @ 3.40GHz
Processor#3 speed: unknown
Processor#3 description: Intel(R) Core(TM) i7-6700 CPU @ 3.40GHz
Processor#4 speed: unknown
Processor#4 description: Intel(R) Core(TM) i7-6700 CPU @ 3.40GHz
Processor#5 speed: unknown
Processor#5 description: Intel(R) Core(TM) i7-6700 CPU @ 3.40GHz
Processor#6 speed: unknown
Processor#6 description: Intel(R) Core(TM) i7-6700 CPU @ 3.40GHz
Processor#7 speed: unknown
Processor#7 description: Intel(R) Core(TM) i7-6700 CPU @ 3.40GHz
Memory size: 65455 MByte
Memory available: 60291 MByte
Operating system: Windows 10
Operating system version: 10.0.19045

2025-01-23 08:09:23 (15920): 
Command: VBoxManage -q showvminfo "boinc_1db44abfd7ee6285" --machinereadable 
Exit Code: 0
Output:
name="boinc_1db44abfd7ee6285"
Encryption:     disabled
groups="/"
ostype="Linux 2.6 / 3.x / 4.x / 5.x (64-bit)"
UUID="c0bdd271-e6ac-4cec-bc66-95e6cc30262b"
CfgFile="C:\\ProgramData\\BOINC\\slots\\3\\boinc_1db44abfd7ee6285\\boinc_1db44abfd7ee6285.vbox"
SnapFldr="C:\\ProgramData\\BOINC\\slots\\3\\boinc_1db44abfd7ee6285\\Snapshots"
LogFldr="C:\\ProgramData\\BOINC\\slots\\3\\boinc_1db44abfd7ee6285\\Logs"
hardwareuuid="c0bdd271-e6ac-4cec-bc66-95e6cc30262b"
memory=630
pagefusion="off"
vram=16
cpuexecutioncap=60
hpet="off"
cpu-profile="host"
chipset="piix3"
firmware="BIOS"
cpus=1
pae="on"
longmode="on"
triplefaultreset="off"
apic="on"
x2apic="on"
nested-hw-virt="off"
cpuid-portability-level=0
bootmenu="messageandmenu"
boot1="disk"
boot2="dvd"
boot3="none"
boot4="none"
acpi="on"
ioapic="on"
biosapic="apic"
biossystemtimeoffset=0
BIOS NVRAM File="C:\\ProgramData\\BOINC\\slots\\3\\boinc_1db44abfd7ee6285\\boinc_1db44abfd7ee6285.nvram"
rtcuseutc="on"
hwvirtex="on"
nestedpaging="on"
largepages="on"
vtxvpid="on"
vtxux="on"
virtvmsavevmload="on"
iommu="none"
paravirtprovider="default"
effparavirtprovider="kvm"
VMState="poweroff"
VMStateChangeTime="2025-01-22T12:19:49.000000000"
graphicscontroller="vboxvga"
monitorcount=1
accelerate3d="off"
accelerate2dvideo="off"
teleporterenabled="off"
teleporterport=0
teleporteraddress=""
teleporterpassword=""
tracing-enabled="off"
tracing-allow-vm-access="off"
tracing-config=""
autostart-enabled="off"
autostart-delay=0
defaultfrontend=""
vmprocpriority="default"
storagecontrollername0="Hard Disk Controller"
storagecontrollertype0="IntelAhci"
storagecontrollerinstance0="0"
storagecontrollermaxportcount0="30"
storagecontrollerportcount0="3"
storagecontrollerbootable0="on"
"Hard Disk Controller-0-0"="C:\\ProgramData\\BOINC\\slots\\3\\boinc_1db44abfd7ee6285\\Snapshots\\{63c33f32-d95b-45c8-94d7-6f8b2e56b1be}.vdi"
"Hard Disk Controller-ImageUUID-0-0"="63c33f32-d95b-45c8-94d7-6f8b2e56b1be"
"Hard Disk Controller-nonrotational-0-0"="off"
"Hard Disk Controller-discard-0-0"="off"
"Hard Disk Controller-1-0"="C:\\Program Files\\Oracle\\VirtualBox\\VBoxGuestAdditions.iso"
"Hard Disk Controller-ImageUUID-1-0"="59821fe4-6ba1-4922-aad4-0deb6ba6a138"
"Hard Disk Controller-tempeject-1-0"="off"
"Hard Disk Controller-IsEjected-1-0"="off"
"Hard Disk Controller-nonrotational-1-0"="off"
"Hard Disk Controller-discard-1-0"="off"
"Hard Disk Controller-2-0"="none"
natnet1="nat"
macaddress1="0800270F0286"
cableconnected1="on"
nic1="nat"
nictype1="82540EM"
nicspeed1="0"
mtu="0"
sockSnd="64"
sockRcv="64"
tcpWndSnd="64"
tcpWndRcv="64"
Forwarding(0)="tcp_4659_80,tcp,127.0.0.1,4659,,80"
nic2="none"
nic3="none"
nic4="none"
nic5="none"
nic6="none"
nic7="none"
nic8="none"
hidpointing="ps2mouse"
hidkeyboard="ps2kbd"
uart1="off"
uart2="off"
uart3="off"
uart4="off"
lpt1="off"
lpt2="off"
audio="none"
audio_out="off"
audio_in="off"
clipboard="disabled"
draganddrop="disabled"
vrde="on"
vrdeport=-1
vrdeports="4660"
vrdeaddress=""
vrdeauthtype="null"
vrdemulticon="off"
vrdereusecon="off"
vrdevideochannel="off"
vrdeproperty[TCP/Ports]="4660"
vrdeproperty[TCP/Address]=<not set>
vrdeproperty[VideoChannel/Enabled]=<not set>
vrdeproperty[VideoChannel/Quality]=<not set>
vrdeproperty[VideoChannel/DownscaleProtection]=<not set>
vrdeproperty[Client/DisableDisplay]=<not set>
vrdeproperty[Client/DisableInput]=<not set>
vrdeproperty[Client/DisableAudio]=<not set>
vrdeproperty[Client/DisableUSB]=<not set>
vrdeproperty[Client/DisableClipboard]=<not set>
vrdeproperty[Client/DisableUpstreamAudio]=<not set>
vrdeproperty[Client/DisableRDPDR]=<not set>
vrdeproperty[H3DRedirect/Enabled]=<not set>
vrdeproperty[Security/Method]="RDP"
vrdeproperty[Security/ServerCertificate]=<not set>
vrdeproperty[Security/ServerPrivateKey]=<not set>
vrdeproperty[Security/CACertificate]=<not set>
vrdeproperty[Audio/RateCorrectionMode]=<not set>
vrdeproperty[Audio/LogPath]=<not set>
usb="off"
ehci="off"
xhci="off"
BandwidthGroup0="boinc_1db44abfd7ee6285_net",Network,1099511627776
SharedFolderNameMachineMapping1="shared"
SharedFolderPathMachineMapping1="C:\\ProgramData\\BOINC\\slots\\3\\shared"
recording_enabled="off"
recording_screens=1
 rec_screen0
rec_screen_enabled="on"
rec_screen_id=0
rec_screen_video_enabled="on"
rec_screen_audio_enabled="off"
rec_screen_dest=

©2025 CERN