[06:24:57.132] New invocation is queued and will start shortly
[06:24:58.440] Starting the invocation (attempt 1)
[06:24:58.472] Popped buildset tag "buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/cc7ef2bb7f8ad078016e88cedaef7c7c491df957"
[06:24:58.472] Popped gitiles commit info from properties and tags
[06:24:58.472] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[06:24:58.473] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[06:24:58.473] Buildbucket request:
{
"requestId": "8954003036656737248",
"builder": {
"project": "chromium",
"bucket": "ci",
"builder": "Win 10 Fast Ring"
},
"properties": {
},
"gitilesCommit": {
"host": "chromium.googlesource.com",
"project": "chromium/src",
"id": "cc7ef2bb7f8ad078016e88cedaef7c7c491df957",
"ref": "refs/heads/main"
},
"tags": [
{
"key": "scheduler_invocation_id",
"value": "8954003036656737248"
},
{
"key": "scheduler_job_id",
"value": "chromium/Win 10 Fast Ring"
},
{
"key": "user_agent",
"value": "luci-scheduler"
}
],
"notify": {
"pubsubTopic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
}
}
[06:24:59.195] Scheduled build:
{
"id": "8788572974340215185",
"builder": {
"project": "chromium",
"bucket": "ci",
"builder": "Win 10 Fast Ring"
},
"number": 13172,
"createdBy": "project:chromium",
"createTime": "2023-02-21T06:24:58.717461810Z",
"updateTime": "2023-02-21T06:24:58.717461810Z",
"status": "SCHEDULED",
"input": {
"gitilesCommit": {
"host": "chromium.googlesource.com",
"project": "chromium/src",
"id": "cc7ef2bb7f8ad078016e88cedaef7c7c491df957",
"ref": "refs/heads/main"
}
}
}
[06:24:59.195] Task URL: https://cr-buildbucket.appspot.com/build/8788572974340215185
[06:24:59.195] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8954003036656737248:2:0) after 2m38s
[06:27:37.219] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8954003036656737248:2:0)
[06:27:37.251] Build status: SCHEDULED
[06:27:37.251] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8954003036656737248:3:0) after 8m20s
[06:35:57.280] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8954003036656737248:3:0)
[06:35:57.303] Build status: SCHEDULED
[06:35:57.303] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8954003036656737248:4:0) after 9m53s
[06:40:49.597] Received PubSub notification, asking Buildbucket for the build status
[06:40:49.624] Build status: STARTED
[06:45:50.358] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8954003036656737248:4:0)
[06:45:50.386] Build status: STARTED
[06:45:50.386] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8954003036656737248:6:0) after 5m15s
[06:51:05.480] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8954003036656737248:6:0)
[06:51:05.500] Build status: STARTED
[06:51:05.500] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8954003036656737248:7:0) after 9m53s
[07:00:58.535] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8954003036656737248:7:0)
[07:00:58.556] Build status: STARTED
[07:00:58.556] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8954003036656737248:8:0) after 2m21s
[07:03:19.597] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8954003036656737248:8:0)
[07:03:19.617] Build status: STARTED
[07:03:19.617] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8954003036656737248:9:0) after 1m24s
[07:04:43.673] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8954003036656737248:9:0)
[07:04:43.699] Build status: STARTED
[07:04:43.699] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8954003036656737248:10:0) after 5m22s
[07:10:05.749] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8954003036656737248:10:0)
[07:10:05.774] Build status: STARTED
[07:10:05.774] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8954003036656737248:11:0) after 6m49s
[07:16:54.961] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8954003036656737248:11:0)
[07:16:54.990] Build status: STARTED
[07:16:54.990] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8954003036656737248:12:0) after 2m24s
[07:19:19.130] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8954003036656737248:12:0)
[07:19:19.153] Build status: STARTED
[07:19:19.153] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8954003036656737248:13:0) after 7m39s
[07:26:58.174] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8954003036656737248:13:0)
[07:26:58.203] Build status: STARTED
[07:26:58.203] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8954003036656737248:14:0) after 1m35s
[07:28:33.460] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8954003036656737248:14:0)
[07:28:33.491] Build status: STARTED
[07:28:33.491] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8954003036656737248:15:0) after 7m9s
[07:35:42.556] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8954003036656737248:15:0)
[07:35:42.580] Build status: STARTED
[07:35:42.580] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8954003036656737248:16:0) after 5m3s
[07:40:45.645] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8954003036656737248:16:0)
[07:40:45.669] Build status: STARTED
[07:40:45.669] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8954003036656737248:17:0) after 7m27s
[07:48:12.814] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8954003036656737248:17:0)
[07:48:12.839] Build status: STARTED
[07:48:12.839] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8954003036656737248:18:0) after 1m16s
[07:49:28.875] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8954003036656737248:18:0)
[07:49:28.903] Build status: STARTED
[07:49:28.903] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8954003036656737248:19:0) after 4m11s
[07:53:40.134] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8954003036656737248:19:0)
[07:53:40.184] Build status: STARTED
[07:53:40.184] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8954003036656737248:20:0) after 5m49s
[07:59:29.204] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8954003036656737248:20:0)
[07:59:29.283] Build status: STARTED
[07:59:29.283] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8954003036656737248:21:0) after 3m45s
[08:03:14.404] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8954003036656737248:21:0)
[08:03:14.434] Build status: STARTED
[08:03:14.434] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8954003036656737248:22:0) after 3m9s
[08:06:23.455] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8954003036656737248:22:0)
[08:06:23.517] Build status: STARTED
[08:06:23.517] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8954003036656737248:23:0) after 2m41s
[08:09:04.546] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8954003036656737248:23:0)
[08:09:04.623] Build status: STARTED
[08:09:04.623] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8954003036656737248:24:0) after 2m39s
[08:11:43.645] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8954003036656737248:24:0)
[08:11:43.667] Build status: STARTED
[08:11:43.667] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8954003036656737248:25:0) after 9m53s
[08:21:36.689] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8954003036656737248:25:0)
[08:21:36.720] Build status: STARTED
[08:21:36.720] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8954003036656737248:26:0) after 7m32s
[08:29:08.735] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8954003036656737248:26:0)
[08:29:08.761] Build status: STARTED
[08:29:08.761] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8954003036656737248:27:0) after 3m20s
[08:32:28.806] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8954003036656737248:27:0)
[08:32:28.872] Build status: STARTED
[08:32:28.872] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8954003036656737248:28:0) after 4m52s
[08:37:20.891] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8954003036656737248:28:0)
[08:37:20.922] Build status: STARTED
[08:37:20.922] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8954003036656737248:29:0) after 9m45s
[08:47:06.142] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8954003036656737248:29:0)
[08:47:06.166] Build status: STARTED
[08:47:06.166] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8954003036656737248:30:0) after 3m54s
[08:51:00.185] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8954003036656737248:30:0)
[08:51:00.208] Build status: STARTED
[08:51:00.208] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8954003036656737248:31:0) after 7m34s
[08:58:34.251] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8954003036656737248:31:0)
[08:58:34.278] Build status: STARTED
[08:58:34.278] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8954003036656737248:32:0) after 2m42s
[09:01:16.311] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8954003036656737248:32:0)
[09:01:16.331] Build status: STARTED
[09:01:16.331] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8954003036656737248:33:0) after 5m9s
[09:06:25.362] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8954003036656737248:33:0)
[09:06:25.388] Build status: STARTED
[09:06:25.388] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8954003036656737248:34:0) after 4m42s
[09:11:07.411] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8954003036656737248:34:0)
[09:11:07.436] Build status: STARTED
[09:11:07.436] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8954003036656737248:35:0) after 5m20s
[09:16:27.634] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8954003036656737248:35:0)
[09:16:27.672] Build status: STARTED
[09:16:27.672] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8954003036656737248:36:0) after 7m44s
[09:24:11.795] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8954003036656737248:36:0)
[09:24:11.826] Build status: STARTED
[09:24:11.826] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8954003036656737248:37:0) after 1m17s
[09:25:28.851] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8954003036656737248:37:0)
[09:25:28.870] Build status: STARTED
[09:25:28.870] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8954003036656737248:38:0) after 5m17s
[09:30:45.906] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8954003036656737248:38:0)
[09:30:45.926] Build status: STARTED
[09:30:45.926] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8954003036656737248:39:0) after 9m26s
[09:40:12.137] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8954003036656737248:39:0)
[09:40:12.158] Build status: STARTED
[09:40:12.158] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8954003036656737248:40:0) after 3m6s
[09:43:18.188] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8954003036656737248:40:0)
[09:43:18.210] Build status: STARTED
[09:43:18.210] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8954003036656737248:41:0) after 2m4s
[09:45:22.241] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8954003036656737248:41:0)
[09:45:22.264] Build status: STARTED
[09:45:22.264] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8954003036656737248:42:0) after 1m23s
[09:46:45.281] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8954003036656737248:42:0)
[09:46:45.309] Build status: STARTED
[09:46:45.309] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8954003036656737248:43:0) after 8m56s
[09:55:41.338] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8954003036656737248:43:0)
[09:55:41.365] Build status: STARTED
[09:55:41.365] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8954003036656737248:44:0) after 7m42s
[10:03:23.455] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8954003036656737248:44:0)
[10:03:23.475] Build status: STARTED
[10:03:23.475] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8954003036656737248:45:0) after 7m48s
[10:11:11.694] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8954003036656737248:45:0)
[10:11:11.717] Build status: STARTED
[10:11:11.717] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8954003036656737248:46:0) after 8m30s
[10:19:41.805] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8954003036656737248:46:0)
[10:19:41.833] Build status: STARTED
[10:19:41.833] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8954003036656737248:47:0) after 5m59s
[10:25:40.949] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8954003036656737248:47:0)
[10:25:40.973] Build status: STARTED
[10:25:40.973] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8954003036656737248:48:0) after 5m46s
[10:31:27.024] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8954003036656737248:48:0)
[10:31:27.100] Build status: STARTED
[10:31:27.100] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8954003036656737248:49:0) after 5m45s
[10:37:12.440] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8954003036656737248:49:0)
[10:37:12.461] Build status: STARTED
[10:37:12.461] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8954003036656737248:50:0) after 9m14s
[10:46:26.527] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8954003036656737248:50:0)
[10:46:26.550] Build status: STARTED
[10:46:26.551] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8954003036656737248:51:0) after 2m4s
[10:48:30.724] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8954003036656737248:51:0)
[10:48:30.751] Build status: STARTED
[10:48:30.751] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8954003036656737248:52:0) after 5m31s
[10:54:01.721] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8954003036656737248:52:0)
[10:54:01.746] Build status: STARTED
[10:54:01.746] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8954003036656737248:53:0) after 5m25s
[10:59:26.963] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8954003036656737248:53:0)
[10:59:26.985] Build status: STARTED
[10:59:26.985] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8954003036656737248:54:0) after 7m4s
[11:06:31.186] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8954003036656737248:54:0)
[11:06:31.215] Build status: STARTED
[11:06:31.215] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8954003036656737248:55:0) after 3m1s
[11:09:32.248] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8954003036656737248:55:0)
[11:09:32.271] Build status: STARTED
[11:09:32.271] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8954003036656737248:56:0) after 5m4s
[11:14:36.352] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8954003036656737248:56:0)
[11:14:36.391] Build status: STARTED
[11:14:36.391] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8954003036656737248:57:0) after 2m53s
[11:17:29.488] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8954003036656737248:57:0)
[11:17:29.540] Build status: STARTED
[11:17:29.540] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8954003036656737248:58:0) after 2m34s
[11:20:03.635] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8954003036656737248:58:0)
[11:20:03.657] Build status: STARTED
[11:20:03.657] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8954003036656737248:59:0) after 5m50s
[11:25:53.737] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8954003036656737248:59:0)
[11:25:53.758] Build status: STARTED
[11:25:53.758] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8954003036656737248:60:0) after 9m2s
[11:34:55.844] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8954003036656737248:60:0)
[11:34:55.876] Build status: STARTED
[11:34:55.876] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8954003036656737248:61:0) after 8m9s
[11:43:04.900] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8954003036656737248:61:0)
[11:43:04.919] Build status: STARTED
[11:43:04.919] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8954003036656737248:62:0) after 3m10s
[11:46:14.936] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8954003036656737248:62:0)
[11:46:14.963] Build status: STARTED
[11:46:14.963] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8954003036656737248:63:0) after 8m20s
[11:54:34.980] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8954003036656737248:63:0)
[11:54:35.005] Build status: STARTED
[11:54:35.005] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8954003036656737248:64:0) after 1m57s
[11:56:32.025] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8954003036656737248:64:0)
[11:56:32.058] Build status: STARTED
[11:56:32.058] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8954003036656737248:65:0) after 1m14s
[11:57:46.440] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8954003036656737248:65:0)
[11:57:46.460] Build status: STARTED
[11:57:46.460] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8954003036656737248:66:0) after 1m35s
[11:59:21.677] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8954003036656737248:66:0)
[11:59:21.696] Build status: STARTED
[11:59:21.696] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8954003036656737248:67:0) after 8m22s
[12:07:43.844] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8954003036656737248:67:0)
[12:07:43.870] Build status: STARTED
[12:07:43.870] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8954003036656737248:68:0) after 9m30s
[12:17:13.887] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8954003036656737248:68:0)
[12:17:13.910] Build status: STARTED
[12:17:13.910] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8954003036656737248:69:0) after 1m26s
[12:18:40.048] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8954003036656737248:69:0)
[12:18:40.073] Build status: STARTED
[12:18:40.073] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8954003036656737248:70:0) after 5m11s
[12:23:51.171] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8954003036656737248:70:0)
[12:23:51.193] Build status: STARTED
[12:23:51.193] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8954003036656737248:71:0) after 3m6s
[12:26:57.287] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8954003036656737248:71:0)
[12:26:57.313] Build status: STARTED
[12:26:57.313] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8954003036656737248:72:0) after 8m12s
[12:35:09.332] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8954003036656737248:72:0)
[12:35:09.351] Build status: STARTED
[12:35:09.351] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8954003036656737248:73:0) after 5m49s
[12:40:58.411] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8954003036656737248:73:0)
[12:40:58.434] Build status: STARTED
[12:40:58.434] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8954003036656737248:74:0) after 3m54s
[12:44:52.461] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8954003036656737248:74:0)
[12:44:52.491] Build status: STARTED
[12:44:52.491] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8954003036656737248:75:0) after 8m58s
[12:53:50.517] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8954003036656737248:75:0)
[12:53:50.536] Build status: STARTED
[12:53:50.536] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8954003036656737248:76:0) after 4m2s
[12:57:52.532] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8954003036656737248:76:0)
[12:57:52.553] Build status: STARTED
[12:57:52.553] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8954003036656737248:77:0) after 9m3s
[13:06:55.559] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8954003036656737248:77:0)
[13:06:55.582] Build status: STARTED
[13:06:55.582] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8954003036656737248:78:0) after 8m41s
[13:15:36.622] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8954003036656737248:78:0)
[13:15:36.664] Build status: STARTED
[13:15:36.664] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8954003036656737248:79:0) after 5m32s
[13:21:08.688] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8954003036656737248:79:0)
[13:21:08.708] Build status: STARTED
[13:21:08.708] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8954003036656737248:80:0) after 3m4s
[13:24:12.737] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8954003036656737248:80:0)
[13:24:12.757] Build status: STARTED
[13:24:12.757] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8954003036656737248:81:0) after 7m1s
[13:31:13.812] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8954003036656737248:81:0)
[13:31:13.844] Build status: STARTED
[13:31:13.844] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8954003036656737248:82:0) after 1m58s
[13:33:11.896] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8954003036656737248:82:0)
[13:33:11.923] Build status: STARTED
[13:33:11.923] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8954003036656737248:83:0) after 5m30s
[13:38:41.952] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8954003036656737248:83:0)
[13:38:41.971] Build status: STARTED
[13:38:41.971] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8954003036656737248:84:0) after 2m16s
[13:40:58.118] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8954003036656737248:84:0)
[13:40:58.155] Build status: STARTED
[13:40:58.155] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8954003036656737248:85:0) after 4m39s
[13:45:37.177] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8954003036656737248:85:0)
[13:45:37.198] Build status: STARTED
[13:45:37.198] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8954003036656737248:86:0) after 4m33s
[13:50:10.215] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8954003036656737248:86:0)
[13:50:10.237] Build status: STARTED
[13:50:10.237] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8954003036656737248:87:0) after 8m50s
[13:59:00.451] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8954003036656737248:87:0)
[13:59:00.490] Build status: STARTED
[13:59:00.490] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8954003036656737248:88:0) after 6m9s
[14:05:10.000] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8954003036656737248:88:0)
[14:05:10.042] Build status: STARTED
[14:05:10.042] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8954003036656737248:89:0) after 7m48s
[14:12:58.303] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8954003036656737248:89:0)
[14:12:58.331] Build status: STARTED
[14:12:58.331] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8954003036656737248:90:0) after 1m23s
[14:14:21.668] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8954003036656737248:90:0)
[14:14:21.762] Build status: STARTED
[14:14:21.762] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8954003036656737248:91:0) after 1m30s
[14:15:51.818] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8954003036656737248:91:0)
[14:15:51.843] Build status: STARTED
[14:15:51.843] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8954003036656737248:92:0) after 5m49s
[14:21:40.860] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8954003036656737248:92:0)
[14:21:40.879] Build status: STARTED
[14:21:40.879] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8954003036656737248:93:0) after 8m30s
[14:30:11.243] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8954003036656737248:93:0)
[14:30:11.290] Build status: STARTED
[14:30:11.290] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8954003036656737248:94:0) after 4m10s
[14:34:21.568] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8954003036656737248:94:0)
[14:34:21.596] Build status: STARTED
[14:34:21.596] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8954003036656737248:95:0) after 8m8s
[14:42:29.615] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8954003036656737248:95:0)
[14:42:29.636] Build status: STARTED
[14:42:29.636] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8954003036656737248:96:0) after 4m47s
[14:47:16.748] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8954003036656737248:96:0)
[14:47:16.770] Build status: STARTED
[14:47:16.770] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8954003036656737248:97:0) after 9m10s
[14:56:26.964] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8954003036656737248:97:0)
[14:56:26.984] Build status: STARTED
[14:56:26.984] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8954003036656737248:98:0) after 6m20s
[15:02:47.019] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8954003036656737248:98:0)
[15:02:47.046] Build status: STARTED
[15:02:47.046] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8954003036656737248:99:0) after 8m45s
[15:11:32.166] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8954003036656737248:99:0)
[15:11:32.198] Build status: STARTED
[15:11:32.198] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8954003036656737248:100:0) after 8m49s
[15:20:21.378] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8954003036656737248:100:0)
[15:20:21.428] Build status: STARTED
[15:20:21.428] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8954003036656737248:101:0) after 1m55s
[15:22:16.453] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8954003036656737248:101:0)
[15:22:16.478] Build status: STARTED
[15:22:16.478] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8954003036656737248:102:0) after 5m56s
[15:28:12.742] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8954003036656737248:102:0)
[15:28:12.762] Build status: STARTED
[15:28:12.762] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8954003036656737248:103:0) after 5m23s
[15:33:35.851] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8954003036656737248:103:0)
[15:33:35.878] Build status: STARTED
[15:33:35.878] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8954003036656737248:104:0) after 8m1s
[15:41:36.973] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8954003036656737248:104:0)
[15:41:37.037] Build status: STARTED
[15:41:37.037] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8954003036656737248:105:0) after 8m8s
[15:49:45.199] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8954003036656737248:105:0)
[15:49:45.222] Build status: STARTED
[15:49:45.222] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8954003036656737248:106:0) after 1m6s
[15:50:51.276] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8954003036656737248:106:0)
[15:50:51.302] Build status: STARTED
[15:50:51.302] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8954003036656737248:107:0) after 7m10s
[15:58:01.441] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8954003036656737248:107:0)
[15:58:01.464] Build status: STARTED
[15:58:01.464] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8954003036656737248:108:0) after 7m33s
[16:05:34.797] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8954003036656737248:108:0)
[16:05:34.817] Build status: STARTED
[16:05:34.817] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8954003036656737248:109:0) after 1m10s
[16:06:45.008] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8954003036656737248:109:0)
[16:06:45.029] Build status: STARTED
[16:06:45.029] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8954003036656737248:110:0) after 5m44s
[16:12:29.061] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8954003036656737248:110:0)
[16:12:29.092] Build status: STARTED
[16:12:29.092] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8954003036656737248:111:0) after 2m58s
[16:15:27.180] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8954003036656737248:111:0)
[16:15:27.239] Build status: STARTED
[16:15:27.239] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8954003036656737248:112:0) after 5m23s
[16:20:50.258] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8954003036656737248:112:0)
[16:20:50.280] Build status: STARTED
[16:20:50.281] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8954003036656737248:113:0) after 4m7s
[16:24:57.309] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8954003036656737248:113:0)
[16:24:57.372] Build status: STARTED
[16:24:57.372] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8954003036656737248:114:0) after 3m13s
[16:28:10.472] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8954003036656737248:114:0)
[16:28:10.493] Build status: STARTED
[16:28:10.493] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8954003036656737248:115:0) after 2m27s
[16:30:37.488] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8954003036656737248:115:0)
[16:30:37.514] Build status: STARTED
[16:30:37.514] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8954003036656737248:116:0) after 6m45s
[16:37:22.673] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8954003036656737248:116:0)
[16:37:22.694] Build status: STARTED
[16:37:22.694] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8954003036656737248:117:0) after 4m30s
[16:41:03.482] Received PubSub notification, asking Buildbucket for the build status
[16:41:03.511] Build:
{
"id": "8788572974340215185",
"builder": {
"project": "chromium",
"bucket": "ci",
"builder": "Win 10 Fast Ring"
},
"number": 13172,
"createdBy": "project:chromium",
"createTime": "2023-02-21T06:24:58.717461810Z",
"startTime": "2023-02-21T06:40:48.912225Z",
"endTime": "2023-02-21T16:41:03.160369102Z",
"updateTime": "2023-02-21T16:41:03.160369102Z",
"status": "CANCELED",
"statusDetails": {
"timeout": {
}
},
"input": {
"gitilesCommit": {
"host": "chromium.googlesource.com",
"project": "chromium/src",
"id": "cc7ef2bb7f8ad078016e88cedaef7c7c491df957",
"ref": "refs/heads/main"
}
}
}
[16:41:03.511] Invocation finished in 10h16m6.387264976s with status ABORTED