[11:39:35.315] New invocation is queued and will start shortly
[11:39:36.412] Starting the invocation (attempt 1)
[11:39:36.449] Popped buildset tag "buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/c273a78d45fdf29aa40f6e3b1255ff2d4d1442f5"
[11:39:36.449] Popped gitiles commit info from properties and tags
[11:39:36.449] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[11:39:36.449] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[11:39:36.449] Buildbucket request:
{
"requestId": "8954708017176948016",
"builder": {
"project": "chromium",
"bucket": "ci",
"builder": "Win 10 Fast Ring"
},
"properties": {
},
"gitilesCommit": {
"host": "chromium.googlesource.com",
"project": "chromium/src",
"id": "c273a78d45fdf29aa40f6e3b1255ff2d4d1442f5",
"ref": "refs/heads/main"
},
"tags": [
{
"key": "scheduler_invocation_id",
"value": "8954708017176948016"
},
{
"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"
}
}
[11:39:37.305] Scheduled build:
{
"id": "8789277955132271969",
"builder": {
"project": "chromium",
"bucket": "ci",
"builder": "Win 10 Fast Ring"
},
"number": 13153,
"createdBy": "project:chromium",
"createTime": "2023-02-13T11:39:36.642527766Z",
"updateTime": "2023-02-13T11:39:36.642527766Z",
"status": "SCHEDULED",
"input": {
"gitilesCommit": {
"host": "chromium.googlesource.com",
"project": "chromium/src",
"id": "c273a78d45fdf29aa40f6e3b1255ff2d4d1442f5",
"ref": "refs/heads/main"
}
},
"canary": true
}
[11:39:37.305] Task URL: https://cr-buildbucket.appspot.com/build/8789277955132271969
[11:39:37.305] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8954708017176948016:2:0) after 6m26s
[11:46:03.339] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8954708017176948016:2:0)
[11:46:03.361] Build status: SCHEDULED
[11:46:03.361] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8954708017176948016:3:0) after 8m33s
[11:51:26.311] Received PubSub notification, asking Buildbucket for the build status
[11:51:26.330] Build status: STARTED
[11:54:36.495] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8954708017176948016:3:0)
[11:54:36.519] Build status: STARTED
[11:54:36.519] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8954708017176948016:5:0) after 4m36s
[11:59:12.560] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8954708017176948016:5:0)
[11:59:12.619] Build status: STARTED
[11:59:12.619] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8954708017176948016:6:0) after 4m54s
[12:04:06.780] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8954708017176948016:6:0)
[12:04:06.807] Build status: STARTED
[12:04:06.807] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8954708017176948016:7:0) after 7m15s
[12:11:21.906] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8954708017176948016:7:0)
[12:11:21.928] Build status: STARTED
[12:11:21.928] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8954708017176948016:8:0) after 7m16s
[12:18:38.155] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8954708017176948016:8:0)
[12:18:38.180] Build status: STARTED
[12:18:38.180] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8954708017176948016:9:0) after 7m10s
[12:25:48.313] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8954708017176948016:9:0)
[12:25:48.334] Build status: STARTED
[12:25:48.334] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8954708017176948016:10:0) after 2m31s
[12:28:19.442] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8954708017176948016:10:0)
[12:28:19.463] Build status: STARTED
[12:28:19.463] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8954708017176948016:11:0) after 7m55s
[12:36:14.475] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8954708017176948016:11:0)
[12:36:14.501] Build status: STARTED
[12:36:14.501] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8954708017176948016:12:0) after 8m36s
[12:44:50.684] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8954708017176948016:12:0)
[12:44:50.703] Build status: STARTED
[12:44:50.703] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8954708017176948016:13:0) after 8m51s
[12:53:41.755] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8954708017176948016:13:0)
[12:53:41.774] Build status: STARTED
[12:53:41.774] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8954708017176948016:14:0) after 6m13s
[12:59:55.002] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8954708017176948016:14:0)
[12:59:55.023] Build status: STARTED
[12:59:55.023] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8954708017176948016:15:0) after 3m8s
[13:03:03.136] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8954708017176948016:15:0)
[13:03:03.160] Build status: STARTED
[13:03:03.160] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8954708017176948016:16:0) after 2m36s
[13:05:39.327] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8954708017176948016:16:0)
[13:05:39.400] Build status: STARTED
[13:05:39.400] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8954708017176948016:17:0) after 1m9s
[13:06:48.521] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8954708017176948016:17:0)
[13:06:48.563] Build status: STARTED
[13:06:48.563] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8954708017176948016:18:0) after 1m50s
[13:08:38.579] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8954708017176948016:18:0)
[13:08:38.602] Build status: STARTED
[13:08:38.602] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8954708017176948016:19:0) after 6m30s
[13:15:08.836] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8954708017176948016:19:0)
[13:15:08.866] Build status: STARTED
[13:15:08.866] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8954708017176948016:20:0) after 7m1s
[13:22:09.992] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8954708017176948016:20:0)
[13:22:10.013] Build status: STARTED
[13:22:10.013] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8954708017176948016:21:0) after 3m14s
[13:25:24.071] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8954708017176948016:21:0)
[13:25:24.097] Build status: STARTED
[13:25:24.097] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8954708017176948016:22:0) after 2m2s
[13:27:26.169] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8954708017176948016:22:0)
[13:27:26.191] Build status: STARTED
[13:27:26.191] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8954708017176948016:23:0) after 5m32s
[13:32:58.211] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8954708017176948016:23:0)
[13:32:58.253] Build status: STARTED
[13:32:58.253] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8954708017176948016:24:0) after 5m30s
[13:38:28.385] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8954708017176948016:24:0)
[13:38:28.406] Build status: STARTED
[13:38:28.406] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8954708017176948016:25:0) after 4m16s
[13:42:44.806] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8954708017176948016:25:0)
[13:42:44.829] Build status: STARTED
[13:42:44.829] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8954708017176948016:26:0) after 5m50s
[13:48:34.916] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8954708017176948016:26:0)
[13:48:34.946] Build status: STARTED
[13:48:34.946] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8954708017176948016:27:0) after 7m17s
[13:55:51.995] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8954708017176948016:27:0)
[13:55:52.018] Build status: STARTED
[13:55:52.018] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8954708017176948016:28:0) after 1m22s
[13:57:14.318] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8954708017176948016:28:0)
[13:57:14.340] Build status: STARTED
[13:57:14.340] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8954708017176948016:29:0) after 5m17s
[14:02:31.373] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8954708017176948016:29:0)
[14:02:31.398] Build status: STARTED
[14:02:31.398] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8954708017176948016:30:0) after 4m48s
[14:07:19.384] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8954708017176948016:30:0)
[14:07:19.401] Build status: STARTED
[14:07:19.401] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8954708017176948016:31:0) after 3m59s
[14:11:18.787] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8954708017176948016:31:0)
[14:11:18.809] Build status: STARTED
[14:11:18.809] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8954708017176948016:32:0) after 9m18s
[14:20:36.886] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8954708017176948016:32:0)
[14:20:36.933] Build status: STARTED
[14:20:36.933] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8954708017176948016:33:0) after 6m40s
[14:27:17.110] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8954708017176948016:33:0)
[14:27:17.135] Build status: STARTED
[14:27:17.135] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8954708017176948016:34:0) after 7m15s
[14:34:32.317] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8954708017176948016:34:0)
[14:34:32.344] Build status: STARTED
[14:34:32.344] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8954708017176948016:35:0) after 1m52s
[14:36:24.414] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8954708017176948016:35:0)
[14:36:24.443] Build status: STARTED
[14:36:24.443] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8954708017176948016:36:0) after 1m38s
[14:38:02.472] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8954708017176948016:36:0)
[14:38:02.496] Build status: STARTED
[14:38:02.496] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8954708017176948016:37:0) after 2m15s
[14:40:17.516] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8954708017176948016:37:0)
[14:40:17.541] Build status: STARTED
[14:40:17.541] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8954708017176948016:38:0) after 2m57s
[14:43:15.026] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8954708017176948016:38:0)
[14:43:15.063] Build status: STARTED
[14:43:15.063] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8954708017176948016:39:0) after 3m11s
[14:46:26.468] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8954708017176948016:39:0)
[14:46:26.537] Build status: STARTED
[14:46:26.537] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8954708017176948016:40:0) after 6m58s
[14:53:24.773] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8954708017176948016:40:0)
[14:53:24.794] Build status: STARTED
[14:53:24.794] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8954708017176948016:41:0) after 7m41s
[15:01:06.027] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8954708017176948016:41:0)
[15:01:06.057] Build status: STARTED
[15:01:06.058] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8954708017176948016:42:0) after 3m10s
[15:04:16.084] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8954708017176948016:42:0)
[15:04:16.111] Build status: STARTED
[15:04:16.112] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8954708017176948016:43:0) after 3m31s
[15:07:47.254] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8954708017176948016:43:0)
[15:07:47.273] Build status: STARTED
[15:07:47.273] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8954708017176948016:44:0) after 5m56s
[15:13:43.394] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8954708017176948016:44:0)
[15:13:43.525] Build status: STARTED
[15:13:43.525] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8954708017176948016:45:0) after 2m2s
[15:15:45.582] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8954708017176948016:45:0)
[15:15:45.609] Build status: STARTED
[15:15:45.609] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8954708017176948016:46:0) after 2m22s
[15:18:07.786] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8954708017176948016:46:0)
[15:18:07.812] Build status: STARTED
[15:18:07.812] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8954708017176948016:47:0) after 2m38s
[15:20:45.839] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8954708017176948016:47:0)
[15:20:45.862] Build status: STARTED
[15:20:45.862] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8954708017176948016:48:0) after 8m45s
[15:29:30.883] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8954708017176948016:48:0)
[15:29:31.042] Build status: STARTED
[15:29:31.042] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8954708017176948016:49:0) after 8m32s
[15:38:03.186] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8954708017176948016:49:0)
[15:38:03.210] Build status: STARTED
[15:38:03.211] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8954708017176948016:50:0) after 3m22s
[15:41:25.229] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8954708017176948016:50:0)
[15:41:25.297] Build status: STARTED
[15:41:25.297] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8954708017176948016:51:0) after 1m2s
[15:42:27.509] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8954708017176948016:51:0)
[15:42:27.529] Build status: STARTED
[15:42:27.529] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8954708017176948016:52:0) after 9m49s
[15:52:16.623] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8954708017176948016:52:0)
[15:52:16.644] Build status: STARTED
[15:52:16.644] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8954708017176948016:53:0) after 5m8s
[15:57:24.967] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8954708017176948016:53:0)
[15:57:24.989] Build status: STARTED
[15:57:24.989] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8954708017176948016:54:0) after 1m45s
[15:59:10.023] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8954708017176948016:54:0)
[15:59:10.064] Build status: STARTED
[15:59:10.064] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8954708017176948016:55:0) after 6m18s
[16:05:28.609] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8954708017176948016:55:0)
[16:05:28.629] Build status: STARTED
[16:05:28.629] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8954708017176948016:56:0) after 6m8s
[16:11:36.824] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8954708017176948016:56:0)
[16:11:36.848] Build status: STARTED
[16:11:36.848] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8954708017176948016:57:0) after 7m54s
[16:19:31.269] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8954708017176948016:57:0)
[16:19:31.308] Build status: STARTED
[16:19:31.308] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8954708017176948016:58:0) after 1m12s
[16:20:43.439] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8954708017176948016:58:0)
[16:20:43.472] Build status: STARTED
[16:20:43.472] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8954708017176948016:59:0) after 3m18s
[16:24:01.632] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8954708017176948016:59:0)
[16:24:01.657] Build status: STARTED
[16:24:01.657] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8954708017176948016:60:0) after 8m27s
[16:32:28.755] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8954708017176948016:60:0)
[16:32:28.823] Build status: STARTED
[16:32:28.823] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8954708017176948016:61:0) after 9m0s
[16:41:28.852] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8954708017176948016:61:0)
[16:41:29.135] Build status: STARTED
[16:41:29.135] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8954708017176948016:62:0) after 7m34s
[16:49:03.237] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8954708017176948016:62:0)
[16:49:03.272] Build status: STARTED
[16:49:03.272] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8954708017176948016:63:0) after 5m55s
[16:54:58.390] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8954708017176948016:63:0)
[16:54:58.619] Build status: STARTED
[16:54:58.619] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8954708017176948016:64:0) after 7m48s
[17:02:46.693] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8954708017176948016:64:0)
[17:02:46.801] Build status: STARTED
[17:02:46.801] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8954708017176948016:65:0) after 7m22s
[17:10:08.789] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8954708017176948016:65:0)
[17:10:08.867] Build status: STARTED
[17:10:08.867] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8954708017176948016:66:0) after 6m1s
[17:16:09.894] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8954708017176948016:66:0)
[17:16:09.918] Build status: STARTED
[17:16:09.918] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8954708017176948016:67:0) after 6m49s
[17:22:59.029] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8954708017176948016:67:0)
[17:22:59.058] Build status: STARTED
[17:22:59.058] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8954708017176948016:68:0) after 3m28s
[17:26:27.049] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8954708017176948016:68:0)
[17:26:27.071] Build status: STARTED
[17:26:27.071] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8954708017176948016:69:0) after 3m27s
[17:29:54.093] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8954708017176948016:69:0)
[17:29:54.116] Build status: STARTED
[17:29:54.116] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8954708017176948016:70:0) after 5m42s
[17:35:36.151] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8954708017176948016:70:0)
[17:35:36.180] Build status: STARTED
[17:35:36.180] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8954708017176948016:71:0) after 9m13s
[17:44:49.300] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8954708017176948016:71:0)
[17:44:49.325] Build status: STARTED
[17:44:49.325] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8954708017176948016:72:0) after 7m1s
[17:51:50.835] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8954708017176948016:72:0)
[17:51:50.866] Build status: STARTED
[17:51:50.866] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8954708017176948016:73:0) after 7m1s
[17:58:52.050] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8954708017176948016:73:0)
[17:58:52.086] Build status: STARTED
[17:58:52.086] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8954708017176948016:74:0) after 3m5s
[18:01:57.200] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8954708017176948016:74:0)
[18:01:57.221] Build status: STARTED
[18:01:57.221] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8954708017176948016:75:0) after 3m9s
[18:05:06.496] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8954708017176948016:75:0)
[18:05:06.529] Build status: STARTED
[18:05:06.529] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8954708017176948016:76:0) after 9m48s
[18:14:54.676] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8954708017176948016:76:0)
[18:14:54.714] Build status: STARTED
[18:14:54.714] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8954708017176948016:77:0) after 5m55s
[18:20:50.008] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8954708017176948016:77:0)
[18:20:50.042] Build status: STARTED
[18:20:50.042] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8954708017176948016:78:0) after 2m46s
[18:23:36.239] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8954708017176948016:78:0)
[18:23:36.261] Build status: STARTED
[18:23:36.261] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8954708017176948016:79:0) after 3m0s
[18:26:36.287] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8954708017176948016:79:0)
[18:26:36.307] Build status: STARTED
[18:26:36.307] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8954708017176948016:80:0) after 2m10s
[18:28:47.310] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8954708017176948016:80:0)
[18:28:47.338] Build status: STARTED
[18:28:47.338] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8954708017176948016:81:0) after 6m57s
[18:35:44.449] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8954708017176948016:81:0)
[18:35:44.534] Build status: STARTED
[18:35:44.534] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8954708017176948016:82:0) after 2m47s
[18:38:31.645] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8954708017176948016:82:0)
[18:38:31.669] Build status: STARTED
[18:38:31.669] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8954708017176948016:83:0) after 1m50s
[18:40:21.731] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8954708017176948016:83:0)
[18:40:21.754] Build status: STARTED
[18:40:21.754] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8954708017176948016:84:0) after 5m44s
[18:46:05.777] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8954708017176948016:84:0)
[18:46:05.800] Build status: STARTED
[18:46:05.800] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8954708017176948016:85:0) after 3m4s
[18:49:10.106] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8954708017176948016:85:0)
[18:49:10.206] Build status: STARTED
[18:49:10.206] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8954708017176948016:86:0) after 8m11s
[18:57:21.984] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8954708017176948016:86:0)
[18:57:22.160] Build status: STARTED
[18:57:22.161] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8954708017176948016:87:0) after 5m20s
[19:02:42.357] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8954708017176948016:87:0)
[19:02:42.384] Build status: STARTED
[19:02:42.385] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8954708017176948016:88:0) after 8m20s
[19:11:02.712] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8954708017176948016:88:0)
[19:11:02.737] Build status: STARTED
[19:11:02.737] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8954708017176948016:89:0) after 3m43s
[19:14:46.353] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8954708017176948016:89:0)
[19:14:46.377] Build status: STARTED
[19:14:46.377] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8954708017176948016:90:0) after 3m38s
[19:18:24.376] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8954708017176948016:90:0)
[19:18:24.402] Build status: STARTED
[19:18:24.402] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8954708017176948016:91:0) after 6m23s
[19:24:47.433] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8954708017176948016:91:0)
[19:24:47.451] Build status: STARTED
[19:24:47.451] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8954708017176948016:92:0) after 3m23s
[19:28:10.477] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8954708017176948016:92:0)
[19:28:10.503] Build status: STARTED
[19:28:10.503] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8954708017176948016:93:0) after 6m8s
[19:34:18.766] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8954708017176948016:93:0)
[19:34:18.797] Build status: STARTED
[19:34:18.797] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8954708017176948016:94:0) after 4m47s
[19:39:05.900] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8954708017176948016:94:0)
[19:39:05.931] Build status: STARTED
[19:39:05.931] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8954708017176948016:95:0) after 3m31s
[19:42:37.080] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8954708017176948016:95:0)
[19:42:37.101] Build status: STARTED
[19:42:37.101] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8954708017176948016:96:0) after 3m27s
[19:46:04.279] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8954708017176948016:96:0)
[19:46:04.303] Build status: STARTED
[19:46:04.303] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8954708017176948016:97:0) after 4m29s
[19:50:33.571] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8954708017176948016:97:0)
[19:50:33.590] Build status: STARTED
[19:50:33.590] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8954708017176948016:98:0) after 5m51s
[19:56:25.058] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8954708017176948016:98:0)
[19:56:25.098] Build status: STARTED
[19:56:25.098] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8954708017176948016:99:0) after 6m21s
[20:02:46.120] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8954708017176948016:99:0)
[20:02:46.156] Build status: STARTED
[20:02:46.156] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8954708017176948016:100:0) after 4m36s
[20:07:22.210] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8954708017176948016:100:0)
[20:07:22.236] Build status: STARTED
[20:07:22.236] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8954708017176948016:101:0) after 6m45s
[20:14:07.353] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8954708017176948016:101:0)
[20:14:07.372] Build status: STARTED
[20:14:07.372] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8954708017176948016:102:0) after 3m21s
[20:17:29.042] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8954708017176948016:102:0)
[20:17:29.071] Build status: STARTED
[20:17:29.071] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8954708017176948016:103:0) after 7m30s
[20:24:59.192] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8954708017176948016:103:0)
[20:24:59.218] Build status: STARTED
[20:24:59.218] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8954708017176948016:104:0) after 7m45s
[20:32:44.209] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8954708017176948016:104:0)
[20:32:44.250] Build status: STARTED
[20:32:44.250] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8954708017176948016:105:0) after 2m57s
[20:35:41.277] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8954708017176948016:105:0)
[20:35:41.301] Build status: STARTED
[20:35:41.301] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8954708017176948016:106:0) after 8m16s
[20:43:57.708] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8954708017176948016:106:0)
[20:43:57.730] Build status: STARTED
[20:43:57.730] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8954708017176948016:107:0) after 5m50s
[20:49:47.834] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8954708017176948016:107:0)
[20:49:47.855] Build status: STARTED
[20:49:47.855] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8954708017176948016:108:0) after 8m30s
[20:58:18.028] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8954708017176948016:108:0)
[20:58:18.058] Build status: STARTED
[20:58:18.058] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8954708017176948016:109:0) after 8m35s
[21:06:53.607] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8954708017176948016:109:0)
[21:06:53.631] Build status: STARTED
[21:06:53.631] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8954708017176948016:110:0) after 1m47s
[21:08:40.831] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8954708017176948016:110:0)
[21:08:40.852] Build status: STARTED
[21:08:40.852] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8954708017176948016:111:0) after 4m36s
[21:13:17.201] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8954708017176948016:111:0)
[21:13:17.227] Build status: STARTED
[21:13:17.227] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8954708017176948016:112:0) after 8m12s
[21:21:29.360] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8954708017176948016:112:0)
[21:21:29.382] Build status: STARTED
[21:21:29.382] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8954708017176948016:113:0) after 8m17s
[21:29:46.537] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8954708017176948016:113:0)
[21:29:46.564] Build status: STARTED
[21:29:46.564] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8954708017176948016:114:0) after 3m20s
[21:33:06.900] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8954708017176948016:114:0)
[21:33:06.922] Build status: STARTED
[21:33:06.922] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8954708017176948016:115:0) after 3m37s
[21:36:44.070] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8954708017176948016:115:0)
[21:36:44.094] Build status: STARTED
[21:36:44.094] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8954708017176948016:116:0) after 6m43s
[21:43:27.135] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8954708017176948016:116:0)
[21:43:27.163] Build status: STARTED
[21:43:27.163] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8954708017176948016:117:0) after 2m3s
[21:45:30.269] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8954708017176948016:117:0)
[21:45:30.318] Build status: STARTED
[21:45:30.318] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8954708017176948016:118:0) after 6m4s
[21:51:34.251] Received PubSub notification, asking Buildbucket for the build status
[21:51:34.276] Build:
{
"id": "8789277955132271969",
"builder": {
"project": "chromium",
"bucket": "ci",
"builder": "Win 10 Fast Ring"
},
"number": 13153,
"createdBy": "project:chromium",
"createTime": "2023-02-13T11:39:36.642527766Z",
"startTime": "2023-02-13T11:51:23.232646Z",
"endTime": "2023-02-13T21:51:34.000941289Z",
"updateTime": "2023-02-13T21:51:34.000941289Z",
"status": "CANCELED",
"statusDetails": {
"timeout": {
}
},
"input": {
"gitilesCommit": {
"host": "chromium.googlesource.com",
"project": "chromium/src",
"id": "c273a78d45fdf29aa40f6e3b1255ff2d4d1442f5",
"ref": "refs/heads/main"
}
},
"canary": true
}
[21:51:34.276] Invocation finished in 10h11m58.966843915s with status ABORTED