[20:32:26.225] New invocation is queued and will start shortly
[20:32:27.309] Starting the invocation (attempt 1)
[20:32:27.350] Popped buildset tag "buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/49fe57db22c12de7fc36d261fe38e7b5aaf2157d"
[20:32:27.350] Popped gitiles commit info from properties and tags
[20:32:27.350] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[20:32:27.351] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[20:32:27.351] Buildbucket request:
{
"requestId": "8959385535508330160",
"builder": {
"project": "chromium",
"bucket": "ci",
"builder": "Win 10 Fast Ring"
},
"properties": {
},
"gitilesCommit": {
"host": "chromium.googlesource.com",
"project": "chromium/src",
"id": "49fe57db22c12de7fc36d261fe38e7b5aaf2157d",
"ref": "refs/heads/main"
},
"tags": [
{
"key": "scheduler_invocation_id",
"value": "8959385535508330160"
},
{
"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"
}
}
[20:32:27.819] Scheduled build:
{
"id": "8793955473598406129",
"builder": {
"project": "chromium",
"bucket": "ci",
"builder": "Win 10 Fast Ring"
},
"number": 13030,
"createdBy": "project:chromium",
"createTime": "2022-12-23T20:32:27.417816932Z",
"updateTime": "2022-12-23T20:32:27.417816932Z",
"status": "SCHEDULED",
"input": {
"gitilesCommit": {
"host": "chromium.googlesource.com",
"project": "chromium/src",
"id": "49fe57db22c12de7fc36d261fe38e7b5aaf2157d",
"ref": "refs/heads/main"
}
}
}
[20:32:27.819] Task URL: https://cr-buildbucket.appspot.com/build/8793955473598406129
[20:32:27.819] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8959385535508330160:2:0) after 5m4s
[20:36:46.161] Received PubSub notification, asking Buildbucket for the build status
[20:36:46.205] Build status: STARTED
[20:37:31.850] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8959385535508330160:2:0)
[20:37:31.885] Build status: STARTED
[20:37:31.885] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8959385535508330160:4:0) after 3m49s
[20:41:20.923] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8959385535508330160:4:0)
[20:41:20.950] Build status: STARTED
[20:41:20.950] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8959385535508330160:5:0) after 5m4s
[20:46:25.070] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8959385535508330160:5:0)
[20:46:25.127] Build status: STARTED
[20:46:25.127] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8959385535508330160:6:0) after 3m45s
[20:50:10.160] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8959385535508330160:6:0)
[20:50:10.189] Build status: STARTED
[20:50:10.189] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8959385535508330160:7:0) after 6m58s
[20:57:08.222] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8959385535508330160:7:0)
[20:57:08.244] Build status: STARTED
[20:57:08.244] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8959385535508330160:8:0) after 8m29s
[21:05:37.271] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8959385535508330160:8:0)
[21:05:37.301] Build status: STARTED
[21:05:37.301] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8959385535508330160:9:0) after 5m48s
[21:11:25.324] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8959385535508330160:9:0)
[21:11:25.351] Build status: STARTED
[21:11:25.351] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8959385535508330160:10:0) after 2m3s
[21:13:28.445] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8959385535508330160:10:0)
[21:13:28.466] Build status: STARTED
[21:13:28.466] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8959385535508330160:11:0) after 6m50s
[21:20:18.494] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8959385535508330160:11:0)
[21:20:18.521] Build status: STARTED
[21:20:18.521] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8959385535508330160:12:0) after 7m20s
[21:27:38.660] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8959385535508330160:12:0)
[21:27:38.698] Build status: STARTED
[21:27:38.698] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8959385535508330160:13:0) after 5m57s
[21:33:35.723] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8959385535508330160:13:0)
[21:33:35.756] Build status: STARTED
[21:33:35.756] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8959385535508330160:14:0) after 5m25s
[21:39:00.854] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8959385535508330160:14:0)
[21:39:00.877] Build status: STARTED
[21:39:00.877] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8959385535508330160:15:0) after 4m52s
[21:43:53.015] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8959385535508330160:15:0)
[21:43:53.034] Build status: STARTED
[21:43:53.034] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8959385535508330160:16:0) after 6m34s
[21:50:27.171] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8959385535508330160:16:0)
[21:50:27.231] Build status: STARTED
[21:50:27.232] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8959385535508330160:17:0) after 5m3s
[21:55:30.452] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8959385535508330160:17:0)
[21:55:30.474] Build status: STARTED
[21:55:30.474] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8959385535508330160:18:0) after 4m19s
[21:59:49.652] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8959385535508330160:18:0)
[21:59:49.695] Build status: STARTED
[21:59:49.695] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8959385535508330160:19:0) after 5m27s
[22:05:16.808] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8959385535508330160:19:0)
[22:05:16.828] Build status: STARTED
[22:05:16.828] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8959385535508330160:20:0) after 1m55s
[22:07:11.881] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8959385535508330160:20:0)
[22:07:11.901] Build status: STARTED
[22:07:11.901] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8959385535508330160:21:0) after 8m13s
[22:15:24.932] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8959385535508330160:21:0)
[22:15:24.963] Build status: STARTED
[22:15:24.963] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8959385535508330160:22:0) after 6m9s
[22:21:33.993] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8959385535508330160:22:0)
[22:21:34.014] Build status: STARTED
[22:21:34.014] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8959385535508330160:23:0) after 8m56s
[22:30:30.071] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8959385535508330160:23:0)
[22:30:30.179] Build status: STARTED
[22:30:30.179] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8959385535508330160:24:0) after 3m11s
[22:33:41.317] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8959385535508330160:24:0)
[22:33:41.344] Build status: STARTED
[22:33:41.344] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8959385535508330160:25:0) after 6m25s
[22:40:06.370] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8959385535508330160:25:0)
[22:40:06.404] Build status: STARTED
[22:40:06.404] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8959385535508330160:26:0) after 2m43s
[22:42:49.525] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8959385535508330160:26:0)
[22:42:49.545] Build status: STARTED
[22:42:49.545] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8959385535508330160:27:0) after 6m33s
[22:49:22.563] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8959385535508330160:27:0)
[22:49:22.627] Build status: STARTED
[22:49:22.627] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8959385535508330160:28:0) after 3m42s
[22:53:04.719] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8959385535508330160:28:0)
[22:53:04.740] Build status: STARTED
[22:53:04.740] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8959385535508330160:29:0) after 1m8s
[22:54:12.763] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8959385535508330160:29:0)
[22:54:12.783] Build status: STARTED
[22:54:12.783] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8959385535508330160:30:0) after 9m57s
[23:04:09.911] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8959385535508330160:30:0)
[23:04:09.933] Build status: STARTED
[23:04:09.933] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8959385535508330160:31:0) after 5m59s
[23:10:08.959] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8959385535508330160:31:0)
[23:10:08.987] Build status: STARTED
[23:10:08.987] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8959385535508330160:32:0) after 4m50s
[23:14:59.007] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8959385535508330160:32:0)
[23:14:59.025] Build status: STARTED
[23:14:59.025] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8959385535508330160:33:0) after 9m38s
[23:24:37.053] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8959385535508330160:33:0)
[23:24:37.103] Build status: STARTED
[23:24:37.103] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8959385535508330160:34:0) after 7m26s
[23:32:03.167] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8959385535508330160:34:0)
[23:32:03.190] Build status: STARTED
[23:32:03.190] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8959385535508330160:35:0) after 2m53s
[23:34:56.294] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8959385535508330160:35:0)
[23:34:56.317] Build status: STARTED
[23:34:56.317] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8959385535508330160:36:0) after 6m42s
[23:41:38.477] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8959385535508330160:36:0)
[23:41:38.502] Build status: STARTED
[23:41:38.502] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8959385535508330160:37:0) after 2m48s
[23:44:26.699] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8959385535508330160:37:0)
[23:44:26.719] Build status: STARTED
[23:44:26.719] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8959385535508330160:38:0) after 3m46s
[23:48:12.739] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8959385535508330160:38:0)
[23:48:12.760] Build status: STARTED
[23:48:12.760] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8959385535508330160:39:0) after 4m32s
[23:52:44.798] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8959385535508330160:39:0)
[23:52:44.833] Build status: STARTED
[23:52:44.833] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8959385535508330160:40:0) after 6m31s
[23:59:15.885] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8959385535508330160:40:0)
[23:59:15.906] Build status: STARTED
[23:59:15.907] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8959385535508330160:41:0) after 4m4s
[00:03:19.929] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8959385535508330160:41:0)
[00:03:19.951] Build status: STARTED
[00:03:19.951] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8959385535508330160:42:0) after 1m9s
[00:04:29.009] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8959385535508330160:42:0)
[00:04:29.034] Build status: STARTED
[00:04:29.034] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8959385535508330160:43:0) after 1m52s
[00:06:22.312] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8959385535508330160:43:0)
[00:06:22.341] Build status: STARTED
[00:06:22.341] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8959385535508330160:44:0) after 6m51s
[00:13:13.377] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8959385535508330160:44:0)
[00:13:13.399] Build status: STARTED
[00:13:13.399] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8959385535508330160:45:0) after 7m45s
[00:20:58.647] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8959385535508330160:45:0)
[00:20:58.668] Build status: STARTED
[00:20:58.668] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8959385535508330160:46:0) after 3m7s
[00:24:05.911] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8959385535508330160:46:0)
[00:24:05.954] Build status: STARTED
[00:24:05.954] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8959385535508330160:47:0) after 9m15s
[00:33:21.101] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8959385535508330160:47:0)
[00:33:21.125] Build status: STARTED
[00:33:21.125] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8959385535508330160:48:0) after 9m45s
[00:43:06.325] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8959385535508330160:48:0)
[00:43:06.346] Build status: STARTED
[00:43:06.346] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8959385535508330160:49:0) after 7m37s
[00:50:43.695] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8959385535508330160:49:0)
[00:50:43.722] Build status: STARTED
[00:50:43.722] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8959385535508330160:50:0) after 6m33s
[00:57:16.747] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8959385535508330160:50:0)
[00:57:16.768] Build status: STARTED
[00:57:16.768] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8959385535508330160:51:0) after 2m36s
[00:59:52.786] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8959385535508330160:51:0)
[00:59:52.806] Build status: STARTED
[00:59:52.806] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8959385535508330160:52:0) after 5m30s
[01:05:22.928] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8959385535508330160:52:0)
[01:05:22.951] Build status: STARTED
[01:05:22.951] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8959385535508330160:53:0) after 9m55s
[01:15:18.035] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8959385535508330160:53:0)
[01:15:18.055] Build status: STARTED
[01:15:18.055] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8959385535508330160:54:0) after 2m42s
[01:18:00.037] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8959385535508330160:54:0)
[01:18:00.060] Build status: STARTED
[01:18:00.060] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8959385535508330160:55:0) after 2m55s
[01:20:55.125] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8959385535508330160:55:0)
[01:20:55.220] Build status: STARTED
[01:20:55.220] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8959385535508330160:56:0) after 3m59s
[01:24:54.229] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8959385535508330160:56:0)
[01:24:54.251] Build status: STARTED
[01:24:54.251] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8959385535508330160:57:0) after 5m48s
[01:30:42.273] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8959385535508330160:57:0)
[01:30:42.302] Build status: STARTED
[01:30:42.302] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8959385535508330160:58:0) after 6m22s
[01:37:04.431] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8959385535508330160:58:0)
[01:37:04.454] Build status: STARTED
[01:37:04.454] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8959385535508330160:59:0) after 4m58s
[01:42:02.788] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8959385535508330160:59:0)
[01:42:02.856] Build status: STARTED
[01:42:02.856] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8959385535508330160:60:0) after 2m57s
[01:44:59.909] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8959385535508330160:60:0)
[01:44:59.936] Build status: STARTED
[01:44:59.936] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8959385535508330160:61:0) after 6m27s
[01:51:27.069] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8959385535508330160:61:0)
[01:51:27.093] Build status: STARTED
[01:51:27.093] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8959385535508330160:62:0) after 4m58s
[01:56:25.113] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8959385535508330160:62:0)
[01:56:25.131] Build status: STARTED
[01:56:25.131] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8959385535508330160:63:0) after 5m23s
[02:01:48.296] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8959385535508330160:63:0)
[02:01:48.317] Build status: STARTED
[02:01:48.318] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8959385535508330160:64:0) after 7m33s
[02:09:21.350] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8959385535508330160:64:0)
[02:09:21.375] Build status: STARTED
[02:09:21.375] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8959385535508330160:65:0) after 3m1s
[02:12:22.535] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8959385535508330160:65:0)
[02:12:22.733] Build status: STARTED
[02:12:22.733] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8959385535508330160:66:0) after 7m34s
[02:19:56.753] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8959385535508330160:66:0)
[02:19:56.774] Build status: STARTED
[02:19:56.775] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8959385535508330160:67:0) after 2m25s
[02:22:21.814] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8959385535508330160:67:0)
[02:22:21.844] Build status: STARTED
[02:22:21.844] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8959385535508330160:68:0) after 7m37s
[02:29:58.963] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8959385535508330160:68:0)
[02:29:58.983] Build status: STARTED
[02:29:58.983] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8959385535508330160:69:0) after 7m1s
[02:37:00.106] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8959385535508330160:69:0)
[02:37:00.129] Build status: STARTED
[02:37:00.129] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8959385535508330160:70:0) after 8m58s
[02:45:58.199] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8959385535508330160:70:0)
[02:45:58.226] Build status: STARTED
[02:45:58.226] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8959385535508330160:71:0) after 9m23s
[02:55:21.301] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8959385535508330160:71:0)
[02:55:21.326] Build status: STARTED
[02:55:21.326] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8959385535508330160:72:0) after 7m6s
[03:02:27.449] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8959385535508330160:72:0)
[03:02:27.491] Build status: STARTED
[03:02:27.491] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8959385535508330160:73:0) after 4m40s
[03:07:07.618] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8959385535508330160:73:0)
[03:07:07.650] Build status: STARTED
[03:07:07.650] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8959385535508330160:74:0) after 3m1s
[03:10:08.678] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8959385535508330160:74:0)
[03:10:08.700] Build status: STARTED
[03:10:08.700] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8959385535508330160:75:0) after 6m55s
[03:17:03.910] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8959385535508330160:75:0)
[03:17:04.005] Build status: STARTED
[03:17:04.005] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8959385535508330160:76:0) after 1m10s
[03:18:14.138] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8959385535508330160:76:0)
[03:18:14.162] Build status: STARTED
[03:18:14.162] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8959385535508330160:77:0) after 5m34s
[03:23:48.311] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8959385535508330160:77:0)
[03:23:48.333] Build status: STARTED
[03:23:48.333] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8959385535508330160:78:0) after 4m45s
[03:28:33.462] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8959385535508330160:78:0)
[03:28:33.489] Build status: STARTED
[03:28:33.489] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8959385535508330160:79:0) after 8m47s
[03:37:20.547] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8959385535508330160:79:0)
[03:37:20.569] Build status: STARTED
[03:37:20.569] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8959385535508330160:80:0) after 8m41s
[03:46:01.597] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8959385535508330160:80:0)
[03:46:01.625] Build status: STARTED
[03:46:01.625] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8959385535508330160:81:0) after 6m49s
[03:52:50.649] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8959385535508330160:81:0)
[03:52:50.681] Build status: STARTED
[03:52:50.682] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8959385535508330160:82:0) after 3m58s
[03:56:48.704] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8959385535508330160:82:0)
[03:56:48.728] Build status: STARTED
[03:56:48.728] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8959385535508330160:83:0) after 7m55s
[04:04:43.856] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8959385535508330160:83:0)
[04:04:43.882] Build status: STARTED
[04:04:43.882] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8959385535508330160:84:0) after 6m39s
[04:11:22.904] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8959385535508330160:84:0)
[04:11:22.925] Build status: STARTED
[04:11:22.925] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8959385535508330160:85:0) after 4m23s
[04:15:45.949] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8959385535508330160:85:0)
[04:15:45.970] Build status: STARTED
[04:15:45.970] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8959385535508330160:86:0) after 3m40s
[04:19:26.295] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8959385535508330160:86:0)
[04:19:26.333] Build status: STARTED
[04:19:26.334] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8959385535508330160:87:0) after 1m6s
[04:20:32.355] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8959385535508330160:87:0)
[04:20:32.376] Build status: STARTED
[04:20:32.376] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8959385535508330160:88:0) after 1m27s
[04:21:59.450] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8959385535508330160:88:0)
[04:21:59.477] Build status: STARTED
[04:21:59.477] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8959385535508330160:89:0) after 8m18s
[04:30:17.482] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8959385535508330160:89:0)
[04:30:17.509] Build status: STARTED
[04:30:17.509] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8959385535508330160:90:0) after 8m55s
[04:39:12.603] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8959385535508330160:90:0)
[04:39:12.638] Build status: STARTED
[04:39:12.638] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8959385535508330160:91:0) after 2m12s
[04:41:24.753] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8959385535508330160:91:0)
[04:41:24.777] Build status: STARTED
[04:41:24.777] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8959385535508330160:92:0) after 6m48s
[04:48:12.811] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8959385535508330160:92:0)
[04:48:12.836] Build status: STARTED
[04:48:12.836] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8959385535508330160:93:0) after 2m15s
[04:50:27.860] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8959385535508330160:93:0)
[04:50:27.883] Build status: STARTED
[04:50:27.883] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8959385535508330160:94:0) after 9m20s
[04:59:47.903] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8959385535508330160:94:0)
[04:59:47.931] Build status: STARTED
[04:59:47.931] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8959385535508330160:95:0) after 8m30s
[05:08:18.045] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8959385535508330160:95:0)
[05:08:18.075] Build status: STARTED
[05:08:18.075] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8959385535508330160:96:0) after 1m45s
[05:10:03.100] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8959385535508330160:96:0)
[05:10:03.183] Build status: STARTED
[05:10:03.183] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8959385535508330160:97:0) after 3m5s
[05:13:08.301] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8959385535508330160:97:0)
[05:13:08.327] Build status: STARTED
[05:13:08.327] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8959385535508330160:98:0) after 5m14s
[05:18:22.354] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8959385535508330160:98:0)
[05:18:22.378] Build status: STARTED
[05:18:22.378] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8959385535508330160:99:0) after 5m15s
[05:23:37.569] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8959385535508330160:99:0)
[05:23:37.594] Build status: STARTED
[05:23:37.594] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8959385535508330160:100:0) after 1m55s
[05:25:32.714] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8959385535508330160:100:0)
[05:25:32.782] Build status: STARTED
[05:25:32.782] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8959385535508330160:101:0) after 5m45s
[05:31:17.805] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8959385535508330160:101:0)
[05:31:17.832] Build status: STARTED
[05:31:17.832] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8959385535508330160:102:0) after 1m6s
[05:32:23.862] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8959385535508330160:102:0)
[05:32:23.898] Build status: STARTED
[05:32:23.898] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8959385535508330160:103:0) after 1m47s
[05:34:10.952] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8959385535508330160:103:0)
[05:34:10.987] Build status: STARTED
[05:34:10.987] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8959385535508330160:104:0) after 2m26s
[05:36:37.008] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8959385535508330160:104:0)
[05:36:37.042] Build status: STARTED
[05:36:37.042] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8959385535508330160:105:0) after 4m7s
[05:40:44.072] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8959385535508330160:105:0)
[05:40:44.097] Build status: STARTED
[05:40:44.097] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8959385535508330160:106:0) after 2m29s
[05:43:13.137] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8959385535508330160:106:0)
[05:43:13.161] Build status: STARTED
[05:43:13.161] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8959385535508330160:107:0) after 6m58s
[05:50:11.480] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8959385535508330160:107:0)
[05:50:11.506] Build status: STARTED
[05:50:11.506] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8959385535508330160:108:0) after 6m51s
[05:56:25.537] Received PubSub notification, asking Buildbucket for the build status
[05:56:25.558] Build:
{
"id": "8793955473598406129",
"builder": {
"project": "chromium",
"bucket": "ci",
"builder": "Win 10 Fast Ring"
},
"number": 13030,
"createdBy": "project:chromium",
"createTime": "2022-12-23T20:32:27.417816932Z",
"startTime": "2022-12-23T20:36:45.407732Z",
"endTime": "2022-12-24T05:56:25.040067575Z",
"updateTime": "2022-12-24T05:56:25.040067575Z",
"status": "FAILURE",
"input": {
"gitilesCommit": {
"host": "chromium.googlesource.com",
"project": "chromium/src",
"id": "49fe57db22c12de7fc36d261fe38e7b5aaf2157d",
"ref": "refs/heads/main"
}
}
}
[05:56:25.558] Invocation finished in 9h23m59.34610369s with status FAILED