[06:36:19.915] New invocation is queued and will start shortly
[06:36:20.993] Starting the invocation (attempt 1)
[06:36:21.026] Popped buildset tag "buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/a7e864d0a1b9099362589751f79b921962edb534"
[06:36:21.026] Popped gitiles commit info from properties and tags
[06:36:21.026] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[06:36:21.029] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[06:36:21.029] Buildbucket request:
{
"requestId": "8934523972935892608",
"builder": {
"project": "chromium",
"bucket": "reclient",
"builder": "Windows Cross deterministic"
},
"properties": {
},
"gitilesCommit": {
"host": "chromium.googlesource.com",
"project": "chromium/src",
"id": "a7e864d0a1b9099362589751f79b921962edb534",
"ref": "refs/heads/main"
},
"tags": [
{
"key": "scheduler_invocation_id",
"value": "8934523972935892608"
},
{
"key": "scheduler_job_id",
"value": "chromium/Windows Cross deterministic"
},
{
"key": "user_agent",
"value": "luci-scheduler"
}
],
"notify": {
"pubsubTopic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
}
}
[06:36:21.715] Scheduled build:
{
"id": "8769093911012404257",
"builder": {
"project": "chromium",
"bucket": "reclient",
"builder": "Windows Cross deterministic"
},
"number": 1688,
"createdBy": "project:chromium",
"createTime": "2023-09-24T06:36:21.121127185Z",
"updateTime": "2023-09-24T06:36:21.121127185Z",
"status": "SCHEDULED",
"input": {
"gitilesCommit": {
"host": "chromium.googlesource.com",
"project": "chromium/src",
"id": "a7e864d0a1b9099362589751f79b921962edb534",
"ref": "refs/heads/main"
}
}
}
[06:36:21.715] Task URL: https://cr-buildbucket.appspot.com/build/8769093911012404257
[06:36:21.716] Scheduling timer "check-buildbucket-build-status" (chromium/Windows Cross deterministic:8934523972935892608:2:0) after 3m15s
[06:36:22.591] Received PubSub notification, asking Buildbucket for the build status
[06:36:22.630] Build status: SCHEDULED
[06:36:23.637] Received PubSub notification, asking Buildbucket for the build status
[06:36:23.662] Build status: STARTED
[06:39:36.889] Handling timer "check-buildbucket-build-status" (chromium/Windows Cross deterministic:8934523972935892608:2:0)
[06:39:36.915] Build status: STARTED
[06:39:36.915] Scheduling timer "check-buildbucket-build-status" (chromium/Windows Cross deterministic:8934523972935892608:5:0) after 9m19s
[06:48:55.938] Handling timer "check-buildbucket-build-status" (chromium/Windows Cross deterministic:8934523972935892608:5:0)
[06:48:55.969] Build status: STARTED
[06:48:55.969] Scheduling timer "check-buildbucket-build-status" (chromium/Windows Cross deterministic:8934523972935892608:6:0) after 3m0s
[06:51:56.199] Handling timer "check-buildbucket-build-status" (chromium/Windows Cross deterministic:8934523972935892608:6:0)
[06:51:56.237] Build status: STARTED
[06:51:56.237] Scheduling timer "check-buildbucket-build-status" (chromium/Windows Cross deterministic:8934523972935892608:7:0) after 4m20s
[06:56:16.261] Handling timer "check-buildbucket-build-status" (chromium/Windows Cross deterministic:8934523972935892608:7:0)
[06:56:16.286] Build status: STARTED
[06:56:16.287] Scheduling timer "check-buildbucket-build-status" (chromium/Windows Cross deterministic:8934523972935892608:8:0) after 7m32s
[07:03:48.332] Handling timer "check-buildbucket-build-status" (chromium/Windows Cross deterministic:8934523972935892608:8:0)
[07:03:48.391] Build status: STARTED
[07:03:48.391] Scheduling timer "check-buildbucket-build-status" (chromium/Windows Cross deterministic:8934523972935892608:9:0) after 5m43s
[07:09:31.433] Handling timer "check-buildbucket-build-status" (chromium/Windows Cross deterministic:8934523972935892608:9:0)
[07:09:31.455] Build status: STARTED
[07:09:31.455] Scheduling timer "check-buildbucket-build-status" (chromium/Windows Cross deterministic:8934523972935892608:10:0) after 1m24s
[07:10:55.578] Handling timer "check-buildbucket-build-status" (chromium/Windows Cross deterministic:8934523972935892608:10:0)
[07:10:55.631] Build status: STARTED
[07:10:55.632] Scheduling timer "check-buildbucket-build-status" (chromium/Windows Cross deterministic:8934523972935892608:11:0) after 5m23s
[07:16:18.682] Handling timer "check-buildbucket-build-status" (chromium/Windows Cross deterministic:8934523972935892608:11:0)
[07:16:18.715] Build status: STARTED
[07:16:18.715] Scheduling timer "check-buildbucket-build-status" (chromium/Windows Cross deterministic:8934523972935892608:12:0) after 3m19s
[07:19:37.734] Handling timer "check-buildbucket-build-status" (chromium/Windows Cross deterministic:8934523972935892608:12:0)
[07:19:37.793] Build status: STARTED
[07:19:37.793] Scheduling timer "check-buildbucket-build-status" (chromium/Windows Cross deterministic:8934523972935892608:13:0) after 8m43s
[07:28:20.879] Handling timer "check-buildbucket-build-status" (chromium/Windows Cross deterministic:8934523972935892608:13:0)
[07:28:20.926] Build status: STARTED
[07:28:20.926] Scheduling timer "check-buildbucket-build-status" (chromium/Windows Cross deterministic:8934523972935892608:14:0) after 2m43s
[07:31:04.020] Handling timer "check-buildbucket-build-status" (chromium/Windows Cross deterministic:8934523972935892608:14:0)
[07:31:04.062] Build status: STARTED
[07:31:04.062] Scheduling timer "check-buildbucket-build-status" (chromium/Windows Cross deterministic:8934523972935892608:15:0) after 4m6s
[07:35:10.196] Handling timer "check-buildbucket-build-status" (chromium/Windows Cross deterministic:8934523972935892608:15:0)
[07:35:10.230] Build status: STARTED
[07:35:10.230] Scheduling timer "check-buildbucket-build-status" (chromium/Windows Cross deterministic:8934523972935892608:16:0) after 9m33s
[07:44:43.272] Handling timer "check-buildbucket-build-status" (chromium/Windows Cross deterministic:8934523972935892608:16:0)
[07:44:43.300] Build status: STARTED
[07:44:43.300] Scheduling timer "check-buildbucket-build-status" (chromium/Windows Cross deterministic:8934523972935892608:17:0) after 1m52s
[07:46:35.329] Handling timer "check-buildbucket-build-status" (chromium/Windows Cross deterministic:8934523972935892608:17:0)
[07:46:35.348] Build status: STARTED
[07:46:35.348] Scheduling timer "check-buildbucket-build-status" (chromium/Windows Cross deterministic:8934523972935892608:18:0) after 8m44s
[07:55:19.336] Handling timer "check-buildbucket-build-status" (chromium/Windows Cross deterministic:8934523972935892608:18:0)
[07:55:19.356] Build status: STARTED
[07:55:19.356] Scheduling timer "check-buildbucket-build-status" (chromium/Windows Cross deterministic:8934523972935892608:19:0) after 1m35s
[07:56:54.379] Handling timer "check-buildbucket-build-status" (chromium/Windows Cross deterministic:8934523972935892608:19:0)
[07:56:54.398] Build status: STARTED
[07:56:54.398] Scheduling timer "check-buildbucket-build-status" (chromium/Windows Cross deterministic:8934523972935892608:20:0) after 9m34s
[08:06:28.435] Handling timer "check-buildbucket-build-status" (chromium/Windows Cross deterministic:8934523972935892608:20:0)
[08:06:28.455] Build status: STARTED
[08:06:28.455] Scheduling timer "check-buildbucket-build-status" (chromium/Windows Cross deterministic:8934523972935892608:21:0) after 4m23s
[08:10:51.610] Handling timer "check-buildbucket-build-status" (chromium/Windows Cross deterministic:8934523972935892608:21:0)
[08:10:51.626] Build status: STARTED
[08:10:51.626] Scheduling timer "check-buildbucket-build-status" (chromium/Windows Cross deterministic:8934523972935892608:22:0) after 7m48s
[08:18:39.649] Handling timer "check-buildbucket-build-status" (chromium/Windows Cross deterministic:8934523972935892608:22:0)
[08:18:39.674] Build status: STARTED
[08:18:39.674] Scheduling timer "check-buildbucket-build-status" (chromium/Windows Cross deterministic:8934523972935892608:23:0) after 3m28s
[08:22:07.710] Handling timer "check-buildbucket-build-status" (chromium/Windows Cross deterministic:8934523972935892608:23:0)
[08:22:07.728] Build status: STARTED
[08:22:07.728] Scheduling timer "check-buildbucket-build-status" (chromium/Windows Cross deterministic:8934523972935892608:24:0) after 9m30s
[08:31:37.744] Handling timer "check-buildbucket-build-status" (chromium/Windows Cross deterministic:8934523972935892608:24:0)
[08:31:37.767] Build status: STARTED
[08:31:37.768] Scheduling timer "check-buildbucket-build-status" (chromium/Windows Cross deterministic:8934523972935892608:25:0) after 5m48s
[08:37:25.806] Handling timer "check-buildbucket-build-status" (chromium/Windows Cross deterministic:8934523972935892608:25:0)
[08:37:25.850] Build status: STARTED
[08:37:25.850] Scheduling timer "check-buildbucket-build-status" (chromium/Windows Cross deterministic:8934523972935892608:26:0) after 2m27s
[08:39:52.869] Handling timer "check-buildbucket-build-status" (chromium/Windows Cross deterministic:8934523972935892608:26:0)
[08:39:52.891] Build status: STARTED
[08:39:52.891] Scheduling timer "check-buildbucket-build-status" (chromium/Windows Cross deterministic:8934523972935892608:27:0) after 5m37s
[08:45:30.049] Handling timer "check-buildbucket-build-status" (chromium/Windows Cross deterministic:8934523972935892608:27:0)
[08:45:30.070] Build status: STARTED
[08:45:30.070] Scheduling timer "check-buildbucket-build-status" (chromium/Windows Cross deterministic:8934523972935892608:28:0) after 9m11s
[08:54:41.088] Handling timer "check-buildbucket-build-status" (chromium/Windows Cross deterministic:8934523972935892608:28:0)
[08:54:41.107] Build status: STARTED
[08:54:41.107] Scheduling timer "check-buildbucket-build-status" (chromium/Windows Cross deterministic:8934523972935892608:29:0) after 7m27s
[09:02:08.147] Handling timer "check-buildbucket-build-status" (chromium/Windows Cross deterministic:8934523972935892608:29:0)
[09:02:08.174] Build status: STARTED
[09:02:08.174] Scheduling timer "check-buildbucket-build-status" (chromium/Windows Cross deterministic:8934523972935892608:30:0) after 3m23s
[09:05:31.194] Handling timer "check-buildbucket-build-status" (chromium/Windows Cross deterministic:8934523972935892608:30:0)
[09:05:31.215] Build status: STARTED
[09:05:31.215] Scheduling timer "check-buildbucket-build-status" (chromium/Windows Cross deterministic:8934523972935892608:31:0) after 6m37s
[09:12:08.248] Handling timer "check-buildbucket-build-status" (chromium/Windows Cross deterministic:8934523972935892608:31:0)
[09:12:08.267] Build status: STARTED
[09:12:08.267] Scheduling timer "check-buildbucket-build-status" (chromium/Windows Cross deterministic:8934523972935892608:32:0) after 3m26s
[09:15:34.296] Handling timer "check-buildbucket-build-status" (chromium/Windows Cross deterministic:8934523972935892608:32:0)
[09:15:34.315] Build status: STARTED
[09:15:34.316] Scheduling timer "check-buildbucket-build-status" (chromium/Windows Cross deterministic:8934523972935892608:33:0) after 9m41s
[09:25:15.371] Handling timer "check-buildbucket-build-status" (chromium/Windows Cross deterministic:8934523972935892608:33:0)
[09:25:15.390] Build status: STARTED
[09:25:15.390] Scheduling timer "check-buildbucket-build-status" (chromium/Windows Cross deterministic:8934523972935892608:34:0) after 6m42s
[09:31:57.540] Handling timer "check-buildbucket-build-status" (chromium/Windows Cross deterministic:8934523972935892608:34:0)
[09:31:57.573] Build status: STARTED
[09:31:57.573] Scheduling timer "check-buildbucket-build-status" (chromium/Windows Cross deterministic:8934523972935892608:35:0) after 4m41s
[09:36:38.593] Handling timer "check-buildbucket-build-status" (chromium/Windows Cross deterministic:8934523972935892608:35:0)
[09:36:38.710] Build status: STARTED
[09:36:38.711] Scheduling timer "check-buildbucket-build-status" (chromium/Windows Cross deterministic:8934523972935892608:36:0) after 1m43s
[09:38:21.736] Handling timer "check-buildbucket-build-status" (chromium/Windows Cross deterministic:8934523972935892608:36:0)
[09:38:21.757] Build status: STARTED
[09:38:21.757] Scheduling timer "check-buildbucket-build-status" (chromium/Windows Cross deterministic:8934523972935892608:37:0) after 4m25s
[09:42:46.876] Handling timer "check-buildbucket-build-status" (chromium/Windows Cross deterministic:8934523972935892608:37:0)
[09:42:46.892] Build status: STARTED
[09:42:46.892] Scheduling timer "check-buildbucket-build-status" (chromium/Windows Cross deterministic:8934523972935892608:38:0) after 8m7s
[09:50:53.914] Handling timer "check-buildbucket-build-status" (chromium/Windows Cross deterministic:8934523972935892608:38:0)
[09:50:53.942] Build status: STARTED
[09:50:53.942] Scheduling timer "check-buildbucket-build-status" (chromium/Windows Cross deterministic:8934523972935892608:39:0) after 8m48s
[09:59:41.967] Handling timer "check-buildbucket-build-status" (chromium/Windows Cross deterministic:8934523972935892608:39:0)
[09:59:41.987] Build status: STARTED
[09:59:41.987] Scheduling timer "check-buildbucket-build-status" (chromium/Windows Cross deterministic:8934523972935892608:40:0) after 5m32s
[10:05:14.053] Handling timer "check-buildbucket-build-status" (chromium/Windows Cross deterministic:8934523972935892608:40:0)
[10:05:14.138] Build status: STARTED
[10:05:14.138] Scheduling timer "check-buildbucket-build-status" (chromium/Windows Cross deterministic:8934523972935892608:41:0) after 5m44s
[10:10:58.153] Handling timer "check-buildbucket-build-status" (chromium/Windows Cross deterministic:8934523972935892608:41:0)
[10:10:58.181] Build status: STARTED
[10:10:58.181] Scheduling timer "check-buildbucket-build-status" (chromium/Windows Cross deterministic:8934523972935892608:42:0) after 8m11s
[10:19:09.223] Handling timer "check-buildbucket-build-status" (chromium/Windows Cross deterministic:8934523972935892608:42:0)
[10:19:09.245] Build status: STARTED
[10:19:09.245] Scheduling timer "check-buildbucket-build-status" (chromium/Windows Cross deterministic:8934523972935892608:43:0) after 4m55s
[10:24:04.262] Handling timer "check-buildbucket-build-status" (chromium/Windows Cross deterministic:8934523972935892608:43:0)
[10:24:04.301] Build status: STARTED
[10:24:04.301] Scheduling timer "check-buildbucket-build-status" (chromium/Windows Cross deterministic:8934523972935892608:44:0) after 7m20s
[10:31:24.606] Handling timer "check-buildbucket-build-status" (chromium/Windows Cross deterministic:8934523972935892608:44:0)
[10:31:24.624] Build status: STARTED
[10:31:24.624] Scheduling timer "check-buildbucket-build-status" (chromium/Windows Cross deterministic:8934523972935892608:45:0) after 7m21s
[10:38:46.025] Handling timer "check-buildbucket-build-status" (chromium/Windows Cross deterministic:8934523972935892608:45:0)
[10:38:46.124] Build status: STARTED
[10:38:46.124] Scheduling timer "check-buildbucket-build-status" (chromium/Windows Cross deterministic:8934523972935892608:46:0) after 3m21s
[10:42:07.239] Handling timer "check-buildbucket-build-status" (chromium/Windows Cross deterministic:8934523972935892608:46:0)
[10:42:07.261] Build status: STARTED
[10:42:07.262] Scheduling timer "check-buildbucket-build-status" (chromium/Windows Cross deterministic:8934523972935892608:47:0) after 5m48s
[10:47:56.145] Handling timer "check-buildbucket-build-status" (chromium/Windows Cross deterministic:8934523972935892608:47:0)
[10:47:56.163] Build status: STARTED
[10:47:56.163] Scheduling timer "check-buildbucket-build-status" (chromium/Windows Cross deterministic:8934523972935892608:48:0) after 9m52s
[10:57:48.193] Handling timer "check-buildbucket-build-status" (chromium/Windows Cross deterministic:8934523972935892608:48:0)
[10:57:48.222] Build status: STARTED
[10:57:48.222] Scheduling timer "check-buildbucket-build-status" (chromium/Windows Cross deterministic:8934523972935892608:49:0) after 6m14s
[11:04:02.425] Handling timer "check-buildbucket-build-status" (chromium/Windows Cross deterministic:8934523972935892608:49:0)
[11:04:02.442] Build status: STARTED
[11:04:02.443] Scheduling timer "check-buildbucket-build-status" (chromium/Windows Cross deterministic:8934523972935892608:50:0) after 5m33s
[11:09:36.576] Handling timer "check-buildbucket-build-status" (chromium/Windows Cross deterministic:8934523972935892608:50:0)
[11:09:36.622] Build status: STARTED
[11:09:36.622] Scheduling timer "check-buildbucket-build-status" (chromium/Windows Cross deterministic:8934523972935892608:51:0) after 2m32s
[11:12:08.643] Handling timer "check-buildbucket-build-status" (chromium/Windows Cross deterministic:8934523972935892608:51:0)
[11:12:08.662] Build status: STARTED
[11:12:08.662] Scheduling timer "check-buildbucket-build-status" (chromium/Windows Cross deterministic:8934523972935892608:52:0) after 1m1s
[11:13:09.716] Handling timer "check-buildbucket-build-status" (chromium/Windows Cross deterministic:8934523972935892608:52:0)
[11:13:09.740] Build status: STARTED
[11:13:09.740] Scheduling timer "check-buildbucket-build-status" (chromium/Windows Cross deterministic:8934523972935892608:53:0) after 6m41s
[11:19:50.806] Handling timer "check-buildbucket-build-status" (chromium/Windows Cross deterministic:8934523972935892608:53:0)
[11:19:50.824] Build status: STARTED
[11:19:50.824] Scheduling timer "check-buildbucket-build-status" (chromium/Windows Cross deterministic:8934523972935892608:54:0) after 4m26s
[11:24:16.850] Handling timer "check-buildbucket-build-status" (chromium/Windows Cross deterministic:8934523972935892608:54:0)
[11:24:16.918] Build status: STARTED
[11:24:16.918] Scheduling timer "check-buildbucket-build-status" (chromium/Windows Cross deterministic:8934523972935892608:55:0) after 3m44s
[11:28:01.055] Handling timer "check-buildbucket-build-status" (chromium/Windows Cross deterministic:8934523972935892608:55:0)
[11:28:01.080] Build status: STARTED
[11:28:01.080] Scheduling timer "check-buildbucket-build-status" (chromium/Windows Cross deterministic:8934523972935892608:56:0) after 9m31s
[11:37:32.070] Handling timer "check-buildbucket-build-status" (chromium/Windows Cross deterministic:8934523972935892608:56:0)
[11:37:32.110] Build status: STARTED
[11:37:32.110] Scheduling timer "check-buildbucket-build-status" (chromium/Windows Cross deterministic:8934523972935892608:57:0) after 4m28s
[11:42:00.085] Handling timer "check-buildbucket-build-status" (chromium/Windows Cross deterministic:8934523972935892608:57:0)
[11:42:00.114] Build status: STARTED
[11:42:00.114] Scheduling timer "check-buildbucket-build-status" (chromium/Windows Cross deterministic:8934523972935892608:58:0) after 7m6s
[11:49:06.227] Handling timer "check-buildbucket-build-status" (chromium/Windows Cross deterministic:8934523972935892608:58:0)
[11:49:06.249] Build status: STARTED
[11:49:06.249] Scheduling timer "check-buildbucket-build-status" (chromium/Windows Cross deterministic:8934523972935892608:59:0) after 5m0s
[11:54:06.390] Handling timer "check-buildbucket-build-status" (chromium/Windows Cross deterministic:8934523972935892608:59:0)
[11:54:06.418] Build status: STARTED
[11:54:06.418] Scheduling timer "check-buildbucket-build-status" (chromium/Windows Cross deterministic:8934523972935892608:60:0) after 2m43s
[11:56:49.464] Handling timer "check-buildbucket-build-status" (chromium/Windows Cross deterministic:8934523972935892608:60:0)
[11:56:49.490] Build status: STARTED
[11:56:49.490] Scheduling timer "check-buildbucket-build-status" (chromium/Windows Cross deterministic:8934523972935892608:61:0) after 7m17s
[12:04:06.508] Handling timer "check-buildbucket-build-status" (chromium/Windows Cross deterministic:8934523972935892608:61:0)
[12:04:06.534] Build status: STARTED
[12:04:06.534] Scheduling timer "check-buildbucket-build-status" (chromium/Windows Cross deterministic:8934523972935892608:62:0) after 8m42s
[12:12:48.655] Handling timer "check-buildbucket-build-status" (chromium/Windows Cross deterministic:8934523972935892608:62:0)
[12:12:48.677] Build status: STARTED
[12:12:48.677] Scheduling timer "check-buildbucket-build-status" (chromium/Windows Cross deterministic:8934523972935892608:63:0) after 2m53s
[12:15:41.920] Handling timer "check-buildbucket-build-status" (chromium/Windows Cross deterministic:8934523972935892608:63:0)
[12:15:41.958] Build status: STARTED
[12:15:41.958] Scheduling timer "check-buildbucket-build-status" (chromium/Windows Cross deterministic:8934523972935892608:64:0) after 4m17s
[12:19:58.989] Handling timer "check-buildbucket-build-status" (chromium/Windows Cross deterministic:8934523972935892608:64:0)
[12:19:59.015] Build status: STARTED
[12:19:59.015] Scheduling timer "check-buildbucket-build-status" (chromium/Windows Cross deterministic:8934523972935892608:65:0) after 4m16s
[12:24:15.377] Handling timer "check-buildbucket-build-status" (chromium/Windows Cross deterministic:8934523972935892608:65:0)
[12:24:15.400] Build status: STARTED
[12:24:15.400] Scheduling timer "check-buildbucket-build-status" (chromium/Windows Cross deterministic:8934523972935892608:66:0) after 1m37s
[12:25:52.419] Handling timer "check-buildbucket-build-status" (chromium/Windows Cross deterministic:8934523972935892608:66:0)
[12:25:52.455] Build status: STARTED
[12:25:52.455] Scheduling timer "check-buildbucket-build-status" (chromium/Windows Cross deterministic:8934523972935892608:67:0) after 4m13s
[12:30:05.682] Handling timer "check-buildbucket-build-status" (chromium/Windows Cross deterministic:8934523972935892608:67:0)
[12:30:05.711] Build status: STARTED
[12:30:05.711] Scheduling timer "check-buildbucket-build-status" (chromium/Windows Cross deterministic:8934523972935892608:68:0) after 3m6s
[12:33:11.746] Handling timer "check-buildbucket-build-status" (chromium/Windows Cross deterministic:8934523972935892608:68:0)
[12:33:11.776] Build status: STARTED
[12:33:11.776] Scheduling timer "check-buildbucket-build-status" (chromium/Windows Cross deterministic:8934523972935892608:69:0) after 9m49s
[12:43:00.808] Handling timer "check-buildbucket-build-status" (chromium/Windows Cross deterministic:8934523972935892608:69:0)
[12:43:00.843] Build status: STARTED
[12:43:00.843] Scheduling timer "check-buildbucket-build-status" (chromium/Windows Cross deterministic:8934523972935892608:70:0) after 6m20s
[12:49:20.965] Handling timer "check-buildbucket-build-status" (chromium/Windows Cross deterministic:8934523972935892608:70:0)
[12:49:20.999] Build status: STARTED
[12:49:20.999] Scheduling timer "check-buildbucket-build-status" (chromium/Windows Cross deterministic:8934523972935892608:71:0) after 9m38s
[12:58:59.231] Handling timer "check-buildbucket-build-status" (chromium/Windows Cross deterministic:8934523972935892608:71:0)
[12:58:59.250] Build status: STARTED
[12:58:59.250] Scheduling timer "check-buildbucket-build-status" (chromium/Windows Cross deterministic:8934523972935892608:72:0) after 9m28s
[13:08:27.269] Handling timer "check-buildbucket-build-status" (chromium/Windows Cross deterministic:8934523972935892608:72:0)
[13:08:27.292] Build status: STARTED
[13:08:27.300] Scheduling timer "check-buildbucket-build-status" (chromium/Windows Cross deterministic:8934523972935892608:73:0) after 8m50s
[13:17:17.335] Handling timer "check-buildbucket-build-status" (chromium/Windows Cross deterministic:8934523972935892608:73:0)
[13:17:17.354] Build status: STARTED
[13:17:17.354] Scheduling timer "check-buildbucket-build-status" (chromium/Windows Cross deterministic:8934523972935892608:74:0) after 6m13s
[13:23:30.360] Handling timer "check-buildbucket-build-status" (chromium/Windows Cross deterministic:8934523972935892608:74:0)
[13:23:30.413] Build status: STARTED
[13:23:30.413] Scheduling timer "check-buildbucket-build-status" (chromium/Windows Cross deterministic:8934523972935892608:75:0) after 9m37s
[13:33:07.450] Handling timer "check-buildbucket-build-status" (chromium/Windows Cross deterministic:8934523972935892608:75:0)
[13:33:07.498] Build status: STARTED
[13:33:07.498] Scheduling timer "check-buildbucket-build-status" (chromium/Windows Cross deterministic:8934523972935892608:76:0) after 4m27s
[13:37:34.535] Handling timer "check-buildbucket-build-status" (chromium/Windows Cross deterministic:8934523972935892608:76:0)
[13:37:34.560] Build status: STARTED
[13:37:34.560] Scheduling timer "check-buildbucket-build-status" (chromium/Windows Cross deterministic:8934523972935892608:77:0) after 6m41s
[13:44:15.582] Handling timer "check-buildbucket-build-status" (chromium/Windows Cross deterministic:8934523972935892608:77:0)
[13:44:15.640] Build status: STARTED
[13:44:15.640] Scheduling timer "check-buildbucket-build-status" (chromium/Windows Cross deterministic:8934523972935892608:78:0) after 3m13s
[13:47:28.670] Handling timer "check-buildbucket-build-status" (chromium/Windows Cross deterministic:8934523972935892608:78:0)
[13:47:28.687] Build status: STARTED
[13:47:28.687] Scheduling timer "check-buildbucket-build-status" (chromium/Windows Cross deterministic:8934523972935892608:79:0) after 6m50s
[13:54:18.968] Handling timer "check-buildbucket-build-status" (chromium/Windows Cross deterministic:8934523972935892608:79:0)
[13:54:19.003] Build status: STARTED
[13:54:19.003] Scheduling timer "check-buildbucket-build-status" (chromium/Windows Cross deterministic:8934523972935892608:80:0) after 9m1s
[14:03:20.057] Handling timer "check-buildbucket-build-status" (chromium/Windows Cross deterministic:8934523972935892608:80:0)
[14:03:20.158] Build status: STARTED
[14:03:20.158] Scheduling timer "check-buildbucket-build-status" (chromium/Windows Cross deterministic:8934523972935892608:81:0) after 9m48s
[14:13:08.199] Handling timer "check-buildbucket-build-status" (chromium/Windows Cross deterministic:8934523972935892608:81:0)
[14:13:08.246] Build status: STARTED
[14:13:08.246] Scheduling timer "check-buildbucket-build-status" (chromium/Windows Cross deterministic:8934523972935892608:82:0) after 7m36s
[14:20:44.368] Handling timer "check-buildbucket-build-status" (chromium/Windows Cross deterministic:8934523972935892608:82:0)
[14:20:44.386] Build status: STARTED
[14:20:44.386] Scheduling timer "check-buildbucket-build-status" (chromium/Windows Cross deterministic:8934523972935892608:83:0) after 1m51s
[14:22:35.411] Handling timer "check-buildbucket-build-status" (chromium/Windows Cross deterministic:8934523972935892608:83:0)
[14:22:35.431] Build status: STARTED
[14:22:35.431] Scheduling timer "check-buildbucket-build-status" (chromium/Windows Cross deterministic:8934523972935892608:84:0) after 1m8s
[14:23:43.551] Handling timer "check-buildbucket-build-status" (chromium/Windows Cross deterministic:8934523972935892608:84:0)
[14:23:43.574] Build status: STARTED
[14:23:43.574] Scheduling timer "check-buildbucket-build-status" (chromium/Windows Cross deterministic:8934523972935892608:85:0) after 5m58s
[14:29:41.589] Handling timer "check-buildbucket-build-status" (chromium/Windows Cross deterministic:8934523972935892608:85:0)
[14:29:41.631] Build status: STARTED
[14:29:41.631] Scheduling timer "check-buildbucket-build-status" (chromium/Windows Cross deterministic:8934523972935892608:86:0) after 8m25s
[14:38:06.647] Handling timer "check-buildbucket-build-status" (chromium/Windows Cross deterministic:8934523972935892608:86:0)
[14:38:06.667] Build status: STARTED
[14:38:06.667] Scheduling timer "check-buildbucket-build-status" (chromium/Windows Cross deterministic:8934523972935892608:87:0) after 9m2s
[14:47:08.778] Handling timer "check-buildbucket-build-status" (chromium/Windows Cross deterministic:8934523972935892608:87:0)
[14:47:08.812] Build status: STARTED
[14:47:08.812] Scheduling timer "check-buildbucket-build-status" (chromium/Windows Cross deterministic:8934523972935892608:88:0) after 4m27s
[14:51:35.830] Handling timer "check-buildbucket-build-status" (chromium/Windows Cross deterministic:8934523972935892608:88:0)
[14:51:35.864] Build status: STARTED
[14:51:35.864] Scheduling timer "check-buildbucket-build-status" (chromium/Windows Cross deterministic:8934523972935892608:89:0) after 6m56s
[14:58:31.891] Handling timer "check-buildbucket-build-status" (chromium/Windows Cross deterministic:8934523972935892608:89:0)
[14:58:31.915] Build status: STARTED
[14:58:31.915] Scheduling timer "check-buildbucket-build-status" (chromium/Windows Cross deterministic:8934523972935892608:90:0) after 8m29s
[15:07:01.061] Handling timer "check-buildbucket-build-status" (chromium/Windows Cross deterministic:8934523972935892608:90:0)
[15:07:01.083] Build status: STARTED
[15:07:01.083] Scheduling timer "check-buildbucket-build-status" (chromium/Windows Cross deterministic:8934523972935892608:91:0) after 5m43s
[15:12:44.164] Handling timer "check-buildbucket-build-status" (chromium/Windows Cross deterministic:8934523972935892608:91:0)
[15:12:44.223] Build status: STARTED
[15:12:44.223] Scheduling timer "check-buildbucket-build-status" (chromium/Windows Cross deterministic:8934523972935892608:92:0) after 5m12s
[15:17:56.243] Handling timer "check-buildbucket-build-status" (chromium/Windows Cross deterministic:8934523972935892608:92:0)
[15:17:56.287] Build status: STARTED
[15:17:56.287] Scheduling timer "check-buildbucket-build-status" (chromium/Windows Cross deterministic:8934523972935892608:93:0) after 6m7s
[15:24:03.428] Handling timer "check-buildbucket-build-status" (chromium/Windows Cross deterministic:8934523972935892608:93:0)
[15:24:03.596] Build status: STARTED
[15:24:03.596] Scheduling timer "check-buildbucket-build-status" (chromium/Windows Cross deterministic:8934523972935892608:94:0) after 8m21s
[15:32:24.789] Handling timer "check-buildbucket-build-status" (chromium/Windows Cross deterministic:8934523972935892608:94:0)
[15:32:24.823] Build status: STARTED
[15:32:24.823] Scheduling timer "check-buildbucket-build-status" (chromium/Windows Cross deterministic:8934523972935892608:95:0) after 5m9s
[15:37:33.858] Handling timer "check-buildbucket-build-status" (chromium/Windows Cross deterministic:8934523972935892608:95:0)
[15:37:33.877] Build status: STARTED
[15:37:33.877] Scheduling timer "check-buildbucket-build-status" (chromium/Windows Cross deterministic:8934523972935892608:96:0) after 9m53s
[15:47:27.037] Handling timer "check-buildbucket-build-status" (chromium/Windows Cross deterministic:8934523972935892608:96:0)
[15:47:27.061] Build status: STARTED
[15:47:27.061] Scheduling timer "check-buildbucket-build-status" (chromium/Windows Cross deterministic:8934523972935892608:97:0) after 2m48s
[15:50:15.437] Handling timer "check-buildbucket-build-status" (chromium/Windows Cross deterministic:8934523972935892608:97:0)
[15:50:15.460] Build status: STARTED
[15:50:15.460] Scheduling timer "check-buildbucket-build-status" (chromium/Windows Cross deterministic:8934523972935892608:98:0) after 3m18s
[15:53:33.482] Handling timer "check-buildbucket-build-status" (chromium/Windows Cross deterministic:8934523972935892608:98:0)
[15:53:33.506] Build status: STARTED
[15:53:33.506] Scheduling timer "check-buildbucket-build-status" (chromium/Windows Cross deterministic:8934523972935892608:99:0) after 7m35s
[16:01:08.529] Handling timer "check-buildbucket-build-status" (chromium/Windows Cross deterministic:8934523972935892608:99:0)
[16:01:08.562] Build status: STARTED
[16:01:08.563] Scheduling timer "check-buildbucket-build-status" (chromium/Windows Cross deterministic:8934523972935892608:100:0) after 4m0s
[16:05:08.586] Handling timer "check-buildbucket-build-status" (chromium/Windows Cross deterministic:8934523972935892608:100:0)
[16:05:08.614] Build status: STARTED
[16:05:08.614] Scheduling timer "check-buildbucket-build-status" (chromium/Windows Cross deterministic:8934523972935892608:101:0) after 4m59s
[16:10:07.638] Handling timer "check-buildbucket-build-status" (chromium/Windows Cross deterministic:8934523972935892608:101:0)
[16:10:07.684] Build status: STARTED
[16:10:07.684] Scheduling timer "check-buildbucket-build-status" (chromium/Windows Cross deterministic:8934523972935892608:102:0) after 9m10s
[16:19:17.665] Handling timer "check-buildbucket-build-status" (chromium/Windows Cross deterministic:8934523972935892608:102:0)
[16:19:17.702] Build status: STARTED
[16:19:17.702] Scheduling timer "check-buildbucket-build-status" (chromium/Windows Cross deterministic:8934523972935892608:103:0) after 9m37s
[16:28:54.747] Handling timer "check-buildbucket-build-status" (chromium/Windows Cross deterministic:8934523972935892608:103:0)
[16:28:54.767] Build status: STARTED
[16:28:54.768] Scheduling timer "check-buildbucket-build-status" (chromium/Windows Cross deterministic:8934523972935892608:104:0) after 8m20s
[16:37:14.886] Handling timer "check-buildbucket-build-status" (chromium/Windows Cross deterministic:8934523972935892608:104:0)
[16:37:14.903] Build status: STARTED
[16:37:14.903] Scheduling timer "check-buildbucket-build-status" (chromium/Windows Cross deterministic:8934523972935892608:105:0) after 1m41s
[16:38:55.936] Handling timer "check-buildbucket-build-status" (chromium/Windows Cross deterministic:8934523972935892608:105:0)
[16:38:55.956] Build status: STARTED
[16:38:55.957] Scheduling timer "check-buildbucket-build-status" (chromium/Windows Cross deterministic:8934523972935892608:106:0) after 3m27s
[16:42:22.977] Handling timer "check-buildbucket-build-status" (chromium/Windows Cross deterministic:8934523972935892608:106:0)
[16:42:22.997] Build status: STARTED
[16:42:22.997] Scheduling timer "check-buildbucket-build-status" (chromium/Windows Cross deterministic:8934523972935892608:107:0) after 6m17s
[16:48:40.175] Handling timer "check-buildbucket-build-status" (chromium/Windows Cross deterministic:8934523972935892608:107:0)
[16:48:40.190] Build status: STARTED
[16:48:40.190] Scheduling timer "check-buildbucket-build-status" (chromium/Windows Cross deterministic:8934523972935892608:108:0) after 1m11s
[16:49:51.207] Handling timer "check-buildbucket-build-status" (chromium/Windows Cross deterministic:8934523972935892608:108:0)
[16:49:51.250] Build status: STARTED
[16:49:51.250] Scheduling timer "check-buildbucket-build-status" (chromium/Windows Cross deterministic:8934523972935892608:109:0) after 3m12s
[16:53:03.325] Handling timer "check-buildbucket-build-status" (chromium/Windows Cross deterministic:8934523972935892608:109:0)
[16:53:03.368] Build status: STARTED
[16:53:03.368] Scheduling timer "check-buildbucket-build-status" (chromium/Windows Cross deterministic:8934523972935892608:110:0) after 8m7s
[17:01:10.546] Handling timer "check-buildbucket-build-status" (chromium/Windows Cross deterministic:8934523972935892608:110:0)
[17:01:10.590] Build status: STARTED
[17:01:10.590] Scheduling timer "check-buildbucket-build-status" (chromium/Windows Cross deterministic:8934523972935892608:111:0) after 7m55s
[17:09:05.733] Handling timer "check-buildbucket-build-status" (chromium/Windows Cross deterministic:8934523972935892608:111:0)
[17:09:05.754] Build status: STARTED
[17:09:05.754] Scheduling timer "check-buildbucket-build-status" (chromium/Windows Cross deterministic:8934523972935892608:112:0) after 7m50s
[17:16:55.873] Handling timer "check-buildbucket-build-status" (chromium/Windows Cross deterministic:8934523972935892608:112:0)
[17:16:55.896] Build status: STARTED
[17:16:55.896] Scheduling timer "check-buildbucket-build-status" (chromium/Windows Cross deterministic:8934523972935892608:113:0) after 3m36s
[17:20:32.012] Handling timer "check-buildbucket-build-status" (chromium/Windows Cross deterministic:8934523972935892608:113:0)
[17:20:32.030] Build status: STARTED
[17:20:32.030] Scheduling timer "check-buildbucket-build-status" (chromium/Windows Cross deterministic:8934523972935892608:114:0) after 3m53s
[17:24:25.065] Handling timer "check-buildbucket-build-status" (chromium/Windows Cross deterministic:8934523972935892608:114:0)
[17:24:25.088] Build status: STARTED
[17:24:25.088] Scheduling timer "check-buildbucket-build-status" (chromium/Windows Cross deterministic:8934523972935892608:115:0) after 7m5s
[17:31:30.188] Handling timer "check-buildbucket-build-status" (chromium/Windows Cross deterministic:8934523972935892608:115:0)
[17:31:30.217] Build status: STARTED
[17:31:30.217] Scheduling timer "check-buildbucket-build-status" (chromium/Windows Cross deterministic:8934523972935892608:116:0) after 5m13s
[17:36:43.390] Handling timer "check-buildbucket-build-status" (chromium/Windows Cross deterministic:8934523972935892608:116:0)
[17:36:43.415] Build status: STARTED
[17:36:43.415] Scheduling timer "check-buildbucket-build-status" (chromium/Windows Cross deterministic:8934523972935892608:117:0) after 5m39s
[17:42:22.509] Handling timer "check-buildbucket-build-status" (chromium/Windows Cross deterministic:8934523972935892608:117:0)
[17:42:22.533] Build status: STARTED
[17:42:22.533] Scheduling timer "check-buildbucket-build-status" (chromium/Windows Cross deterministic:8934523972935892608:118:0) after 8m57s
[17:51:19.592] Handling timer "check-buildbucket-build-status" (chromium/Windows Cross deterministic:8934523972935892608:118:0)
[17:51:19.614] Build status: STARTED
[17:51:19.614] Scheduling timer "check-buildbucket-build-status" (chromium/Windows Cross deterministic:8934523972935892608:119:0) after 5m55s
[17:57:14.738] Handling timer "check-buildbucket-build-status" (chromium/Windows Cross deterministic:8934523972935892608:119:0)
[17:57:14.774] Build status: STARTED
[17:57:14.774] Scheduling timer "check-buildbucket-build-status" (chromium/Windows Cross deterministic:8934523972935892608:120:0) after 6m3s
[18:03:17.825] Handling timer "check-buildbucket-build-status" (chromium/Windows Cross deterministic:8934523972935892608:120:0)
[18:03:17.861] Build status: STARTED
[18:03:17.861] Scheduling timer "check-buildbucket-build-status" (chromium/Windows Cross deterministic:8934523972935892608:121:0) after 2m33s
[18:05:51.199] Handling timer "check-buildbucket-build-status" (chromium/Windows Cross deterministic:8934523972935892608:121:0)
[18:05:51.221] Build status: STARTED
[18:05:51.221] Scheduling timer "check-buildbucket-build-status" (chromium/Windows Cross deterministic:8934523972935892608:122:0) after 7m28s
[18:13:19.356] Handling timer "check-buildbucket-build-status" (chromium/Windows Cross deterministic:8934523972935892608:122:0)
[18:13:19.378] Build status: STARTED
[18:13:19.378] Scheduling timer "check-buildbucket-build-status" (chromium/Windows Cross deterministic:8934523972935892608:123:0) after 3m50s
[18:17:09.399] Handling timer "check-buildbucket-build-status" (chromium/Windows Cross deterministic:8934523972935892608:123:0)
[18:17:09.498] Build status: STARTED
[18:17:09.498] Scheduling timer "check-buildbucket-build-status" (chromium/Windows Cross deterministic:8934523972935892608:124:0) after 7m51s
[18:25:00.605] Handling timer "check-buildbucket-build-status" (chromium/Windows Cross deterministic:8934523972935892608:124:0)
[18:25:00.654] Build status: STARTED
[18:25:00.654] Scheduling timer "check-buildbucket-build-status" (chromium/Windows Cross deterministic:8934523972935892608:125:0) after 2m6s
[18:27:06.773] Handling timer "check-buildbucket-build-status" (chromium/Windows Cross deterministic:8934523972935892608:125:0)
[18:27:06.800] Build status: STARTED
[18:27:06.800] Scheduling timer "check-buildbucket-build-status" (chromium/Windows Cross deterministic:8934523972935892608:126:0) after 8m12s
[18:35:19.028] Handling timer "check-buildbucket-build-status" (chromium/Windows Cross deterministic:8934523972935892608:126:0)
[18:35:19.110] Build status: STARTED
[18:35:19.110] Scheduling timer "check-buildbucket-build-status" (chromium/Windows Cross deterministic:8934523972935892608:127:0) after 1m6s
[18:36:25.139] Handling timer "check-buildbucket-build-status" (chromium/Windows Cross deterministic:8934523972935892608:127:0)
[18:36:25.161] Build status: STARTED
[18:36:25.161] Scheduling timer "check-buildbucket-build-status" (chromium/Windows Cross deterministic:8934523972935892608:128:0) after 6m29s
[18:42:54.178] Handling timer "check-buildbucket-build-status" (chromium/Windows Cross deterministic:8934523972935892608:128:0)
[18:42:54.199] Build status: STARTED
[18:42:54.199] Scheduling timer "check-buildbucket-build-status" (chromium/Windows Cross deterministic:8934523972935892608:129:0) after 9m45s
[18:49:21.973] Received PubSub notification, asking Buildbucket for the build status
[18:49:21.993] Build:
{
"id": "8769093911012404257",
"builder": {
"project": "chromium",
"bucket": "reclient",
"builder": "Windows Cross deterministic"
},
"number": 1688,
"createdBy": "project:chromium",
"createTime": "2023-09-24T06:36:21.121127185Z",
"startTime": "2023-09-24T06:36:22.830675Z",
"endTime": "2023-09-24T18:49:21.369932Z",
"updateTime": "2023-09-24T18:49:21.369932Z",
"status": "INFRA_FAILURE",
"input": {
"gitilesCommit": {
"host": "chromium.googlesource.com",
"project": "chromium/src",
"id": "a7e864d0a1b9099362589751f79b921962edb534",
"ref": "refs/heads/main"
}
}
}
[18:49:21.993] Invocation finished in 12h13m2.090558828s with status FAILED