[02:54:59.634] New invocation is queued and will start shortly
[02:55:01.047] Starting the invocation (attempt 1)
[02:55:01.269] Popped buildset tag "buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/b480a0d2c936d9b7f309cf39067bee0ea2072a21"
[02:55:01.269] Popped gitiles commit info from properties and tags
[02:55:01.269] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[02:55:01.269] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[02:55:01.270] Buildbucket request:
{
"requestId": "8970595490940643920",
"builder": {
"project": "chromium",
"bucket": "ci",
"builder": "Win 10 Fast Ring"
},
"properties": {
},
"gitilesCommit": {
"host": "chromium.googlesource.com",
"project": "chromium/src",
"id": "b480a0d2c936d9b7f309cf39067bee0ea2072a21",
"ref": "refs/heads/main"
},
"tags": [
{
"key": "scheduler_invocation_id",
"value": "8970595490940643920"
},
{
"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"
}
}
[02:55:02.109] Scheduled build:
{
"id": "8805165428196078017",
"builder": {
"project": "chromium",
"bucket": "ci",
"builder": "Win 10 Fast Ring"
},
"number": 11777,
"createdBy": "project:chromium",
"createTime": "2022-08-22T02:55:01.629668547Z",
"updateTime": "2022-08-22T02:55:01.629668547Z",
"status": "SCHEDULED",
"input": {
"gitilesCommit": {
"host": "chromium.googlesource.com",
"project": "chromium/src",
"id": "b480a0d2c936d9b7f309cf39067bee0ea2072a21",
"ref": "refs/heads/main"
}
}
}
[02:55:02.109] Task URL: https://cr-buildbucket.appspot.com/build/8805165428196078017
[02:55:02.109] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8970595490940643920:2:0) after 9m12s
[03:00:12.670] Received PubSub notification, asking Buildbucket for the build status
[03:00:12.692] Build status: STARTED
[03:04:14.128] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8970595490940643920:2:0)
[03:04:14.155] Build status: STARTED
[03:04:14.155] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8970595490940643920:4:0) after 3m32s
[03:07:46.287] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8970595490940643920:4:0)
[03:07:46.307] Build status: STARTED
[03:07:46.307] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8970595490940643920:5:0) after 5m57s
[03:13:43.327] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8970595490940643920:5:0)
[03:13:43.348] Build status: STARTED
[03:13:43.348] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8970595490940643920:6:0) after 8m35s
[03:22:18.463] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8970595490940643920:6:0)
[03:22:18.486] Build status: STARTED
[03:22:18.486] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8970595490940643920:7:0) after 7m38s
[03:29:56.506] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8970595490940643920:7:0)
[03:29:56.527] Build status: STARTED
[03:29:56.527] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8970595490940643920:8:0) after 2m15s
[03:32:11.764] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8970595490940643920:8:0)
[03:32:11.789] Build status: STARTED
[03:32:11.789] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8970595490940643920:9:0) after 4m15s
[03:36:26.918] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8970595490940643920:9:0)
[03:36:26.944] Build status: STARTED
[03:36:26.944] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8970595490940643920:10:0) after 8m9s
[03:44:36.065] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8970595490940643920:10:0)
[03:44:36.088] Build status: STARTED
[03:44:36.088] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8970595490940643920:11:0) after 1m25s
[03:46:01.161] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8970595490940643920:11:0)
[03:46:01.234] Build status: STARTED
[03:46:01.234] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8970595490940643920:12:0) after 5m56s
[03:51:57.287] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8970595490940643920:12:0)
[03:51:57.309] Build status: STARTED
[03:51:57.309] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8970595490940643920:13:0) after 4m31s
[03:56:28.352] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8970595490940643920:13:0)
[03:56:28.375] Build status: STARTED
[03:56:28.375] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8970595490940643920:14:0) after 4m54s
[04:01:22.421] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8970595490940643920:14:0)
[04:01:22.446] Build status: STARTED
[04:01:22.446] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8970595490940643920:15:0) after 2m14s
[04:03:36.505] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8970595490940643920:15:0)
[04:03:36.534] Build status: STARTED
[04:03:36.534] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8970595490940643920:16:0) after 6m39s
[04:10:15.650] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8970595490940643920:16:0)
[04:10:15.692] Build status: STARTED
[04:10:15.692] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8970595490940643920:17:0) after 1m0s
[04:11:15.712] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8970595490940643920:17:0)
[04:11:15.735] Build status: STARTED
[04:11:15.735] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8970595490940643920:18:0) after 5m59s
[04:17:14.756] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8970595490940643920:18:0)
[04:17:14.782] Build status: STARTED
[04:17:14.783] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8970595490940643920:19:0) after 7m4s
[04:24:18.813] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8970595490940643920:19:0)
[04:24:18.833] Build status: STARTED
[04:24:18.833] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8970595490940643920:20:0) after 7m5s
[04:31:23.856] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8970595490940643920:20:0)
[04:31:23.896] Build status: STARTED
[04:31:23.896] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8970595490940643920:21:0) after 8m39s
[04:40:02.915] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8970595490940643920:21:0)
[04:40:02.939] Build status: STARTED
[04:40:02.939] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8970595490940643920:22:0) after 3m24s
[04:43:27.017] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8970595490940643920:22:0)
[04:43:27.040] Build status: STARTED
[04:43:27.040] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8970595490940643920:23:0) after 9m29s
[04:52:56.064] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8970595490940643920:23:0)
[04:52:56.115] Build status: STARTED
[04:52:56.116] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8970595490940643920:24:0) after 8m46s
[05:01:42.195] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8970595490940643920:24:0)
[05:01:42.217] Build status: STARTED
[05:01:42.217] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8970595490940643920:25:0) after 4m18s
[05:06:00.306] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8970595490940643920:25:0)
[05:06:00.328] Build status: STARTED
[05:06:00.328] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8970595490940643920:26:0) after 5m7s
[05:11:07.613] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8970595490940643920:26:0)
[05:11:07.640] Build status: STARTED
[05:11:07.640] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8970595490940643920:27:0) after 5m47s
[05:16:54.670] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8970595490940643920:27:0)
[05:16:54.761] Build status: STARTED
[05:16:54.761] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8970595490940643920:28:0) after 8m37s
[05:25:31.778] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8970595490940643920:28:0)
[05:25:31.811] Build status: STARTED
[05:25:31.811] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8970595490940643920:29:0) after 9m43s
[05:35:14.832] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8970595490940643920:29:0)
[05:35:14.883] Build status: STARTED
[05:35:14.884] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8970595490940643920:30:0) after 8m5s
[05:43:19.940] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8970595490940643920:30:0)
[05:43:19.961] Build status: STARTED
[05:43:19.961] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8970595490940643920:31:0) after 5m19s
[05:48:39.059] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8970595490940643920:31:0)
[05:48:39.082] Build status: STARTED
[05:48:39.082] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8970595490940643920:32:0) after 6m45s
[05:55:24.176] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8970595490940643920:32:0)
[05:55:24.200] Build status: STARTED
[05:55:24.200] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8970595490940643920:33:0) after 7m40s
[06:03:04.231] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8970595490940643920:33:0)
[06:03:04.256] Build status: STARTED
[06:03:04.256] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8970595490940643920:34:0) after 9m21s
[06:12:25.311] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8970595490940643920:34:0)
[06:12:25.334] Build status: STARTED
[06:12:25.334] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8970595490940643920:35:0) after 1m23s
[06:13:48.522] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8970595490940643920:35:0)
[06:13:48.551] Build status: STARTED
[06:13:48.551] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8970595490940643920:36:0) after 4m16s
[06:18:04.763] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8970595490940643920:36:0)
[06:18:04.784] Build status: STARTED
[06:18:04.784] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8970595490940643920:37:0) after 1m51s
[06:19:55.802] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8970595490940643920:37:0)
[06:19:55.824] Build status: STARTED
[06:19:55.824] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8970595490940643920:38:0) after 5m13s
[06:25:08.924] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8970595490940643920:38:0)
[06:25:08.947] Build status: STARTED
[06:25:08.947] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8970595490940643920:39:0) after 7m53s
[06:33:02.070] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8970595490940643920:39:0)
[06:33:02.122] Build status: STARTED
[06:33:02.122] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8970595490940643920:40:0) after 3m39s
[06:36:41.220] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8970595490940643920:40:0)
[06:36:41.250] Build status: STARTED
[06:36:41.250] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8970595490940643920:41:0) after 2m25s
[06:39:06.275] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8970595490940643920:41:0)
[06:39:06.297] Build status: STARTED
[06:39:06.297] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8970595490940643920:42:0) after 6m22s
[06:45:28.419] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8970595490940643920:42:0)
[06:45:28.449] Build status: STARTED
[06:45:28.449] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8970595490940643920:43:0) after 9m46s
[06:55:14.592] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8970595490940643920:43:0)
[06:55:14.631] Build status: STARTED
[06:55:14.631] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8970595490940643920:44:0) after 6m41s
[07:01:55.781] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8970595490940643920:44:0)
[07:01:55.809] Build status: STARTED
[07:01:55.809] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8970595490940643920:45:0) after 7m39s
[07:09:34.881] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8970595490940643920:45:0)
[07:09:34.903] Build status: STARTED
[07:09:34.903] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8970595490940643920:46:0) after 4m25s
[07:14:00.030] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8970595490940643920:46:0)
[07:14:00.054] Build status: STARTED
[07:14:00.055] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8970595490940643920:47:0) after 8m7s
[07:22:07.112] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8970595490940643920:47:0)
[07:22:07.138] Build status: STARTED
[07:22:07.138] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8970595490940643920:48:0) after 8m10s
[07:30:17.269] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8970595490940643920:48:0)
[07:30:17.296] Build status: STARTED
[07:30:17.296] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8970595490940643920:49:0) after 6m36s
[07:36:53.315] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8970595490940643920:49:0)
[07:36:53.351] Build status: STARTED
[07:36:53.351] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8970595490940643920:50:0) after 9m54s
[07:46:47.525] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8970595490940643920:50:0)
[07:46:47.549] Build status: STARTED
[07:46:47.549] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8970595490940643920:51:0) after 2m42s
[07:49:29.568] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8970595490940643920:51:0)
[07:49:29.592] Build status: STARTED
[07:49:29.592] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8970595490940643920:52:0) after 9m50s
[07:59:19.614] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8970595490940643920:52:0)
[07:59:19.640] Build status: STARTED
[07:59:19.640] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8970595490940643920:53:0) after 4m41s
[08:04:00.659] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8970595490940643920:53:0)
[08:04:00.682] Build status: STARTED
[08:04:00.682] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8970595490940643920:54:0) after 3m0s
[08:07:00.881] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8970595490940643920:54:0)
[08:07:00.913] Build status: STARTED
[08:07:00.913] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8970595490940643920:55:0) after 4m20s
[08:11:20.978] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8970595490940643920:55:0)
[08:11:21.002] Build status: STARTED
[08:11:21.002] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8970595490940643920:56:0) after 4m30s
[08:15:51.168] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8970595490940643920:56:0)
[08:15:51.208] Build status: STARTED
[08:15:51.208] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8970595490940643920:57:0) after 1m36s
[08:17:27.228] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8970595490940643920:57:0)
[08:17:27.252] Build status: STARTED
[08:17:27.252] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8970595490940643920:58:0) after 6m38s
[08:24:05.385] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8970595490940643920:58:0)
[08:24:05.412] Build status: STARTED
[08:24:05.412] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8970595490940643920:59:0) after 6m41s
[08:30:46.433] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8970595490940643920:59:0)
[08:30:46.458] Build status: STARTED
[08:30:46.458] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8970595490940643920:60:0) after 9m46s
[08:40:32.475] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8970595490940643920:60:0)
[08:40:32.499] Build status: STARTED
[08:40:32.499] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8970595490940643920:61:0) after 8m2s
[08:48:34.553] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8970595490940643920:61:0)
[08:48:34.586] Build status: STARTED
[08:48:34.586] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8970595490940643920:62:0) after 3m32s
[08:52:06.772] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8970595490940643920:62:0)
[08:52:06.796] Build status: STARTED
[08:52:06.796] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8970595490940643920:63:0) after 3m38s
[08:55:45.049] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8970595490940643920:63:0)
[08:55:45.076] Build status: STARTED
[08:55:45.076] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8970595490940643920:64:0) after 8m10s
[09:03:55.097] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8970595490940643920:64:0)
[09:03:55.124] Build status: STARTED
[09:03:55.124] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8970595490940643920:65:0) after 3m22s
[09:07:17.222] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8970595490940643920:65:0)
[09:07:17.250] Build status: STARTED
[09:07:17.250] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8970595490940643920:66:0) after 4m47s
[09:12:04.370] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8970595490940643920:66:0)
[09:12:04.392] Build status: STARTED
[09:12:04.392] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8970595490940643920:67:0) after 6m25s
[09:18:29.408] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8970595490940643920:67:0)
[09:18:29.431] Build status: STARTED
[09:18:29.431] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8970595490940643920:68:0) after 4m24s
[09:22:53.584] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8970595490940643920:68:0)
[09:22:53.606] Build status: STARTED
[09:22:53.606] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8970595490940643920:69:0) after 3m40s
[09:26:33.896] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8970595490940643920:69:0)
[09:26:33.929] Build status: STARTED
[09:26:33.929] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8970595490940643920:70:0) after 1m5s
[09:27:38.947] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8970595490940643920:70:0)
[09:27:38.976] Build status: STARTED
[09:27:38.976] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8970595490940643920:71:0) after 3m19s
[09:30:58.486] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8970595490940643920:71:0)
[09:30:58.510] Build status: STARTED
[09:30:58.510] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8970595490940643920:72:0) after 9m59s
[09:40:57.500] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8970595490940643920:72:0)
[09:40:57.522] Build status: STARTED
[09:40:57.522] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8970595490940643920:73:0) after 4m18s
[09:45:15.588] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8970595490940643920:73:0)
[09:45:15.608] Build status: STARTED
[09:45:15.608] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8970595490940643920:74:0) after 6m34s
[09:51:49.727] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8970595490940643920:74:0)
[09:51:49.752] Build status: STARTED
[09:51:49.752] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8970595490940643920:75:0) after 8m54s
[10:00:44.090] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8970595490940643920:75:0)
[10:00:44.122] Build status: STARTED
[10:00:44.122] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8970595490940643920:76:0) after 9m56s
[10:10:40.296] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8970595490940643920:76:0)
[10:10:40.316] Build status: STARTED
[10:10:40.316] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8970595490940643920:77:0) after 6m2s
[10:16:42.365] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8970595490940643920:77:0)
[10:16:42.391] Build status: STARTED
[10:16:42.391] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8970595490940643920:78:0) after 6m21s
[10:23:03.832] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8970595490940643920:78:0)
[10:23:03.858] Build status: STARTED
[10:23:03.858] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8970595490940643920:79:0) after 4m37s
[10:27:40.881] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8970595490940643920:79:0)
[10:27:40.907] Build status: STARTED
[10:27:40.907] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8970595490940643920:80:0) after 4m52s
[10:32:32.955] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8970595490940643920:80:0)
[10:32:32.979] Build status: STARTED
[10:32:32.979] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8970595490940643920:81:0) after 2m49s
[10:35:21.997] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8970595490940643920:81:0)
[10:35:22.181] Build status: STARTED
[10:35:22.181] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8970595490940643920:82:0) after 4m5s
[10:39:27.305] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8970595490940643920:82:0)
[10:39:27.331] Build status: STARTED
[10:39:27.331] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8970595490940643920:83:0) after 3m47s
[10:43:14.341] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8970595490940643920:83:0)
[10:43:14.367] Build status: STARTED
[10:43:14.367] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8970595490940643920:84:0) after 2m14s
[10:45:28.479] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8970595490940643920:84:0)
[10:45:28.692] Build status: STARTED
[10:45:28.692] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8970595490940643920:85:0) after 5m5s
[10:50:33.676] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8970595490940643920:85:0)
[10:50:33.699] Build status: STARTED
[10:50:33.699] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8970595490940643920:86:0) after 1m52s
[10:52:25.901] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8970595490940643920:86:0)
[10:52:25.925] Build status: STARTED
[10:52:25.925] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8970595490940643920:87:0) after 2m48s
[10:55:14.206] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8970595490940643920:87:0)
[10:55:14.228] Build status: STARTED
[10:55:14.228] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8970595490940643920:88:0) after 4m21s
[10:59:35.252] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8970595490940643920:88:0)
[10:59:35.277] Build status: STARTED
[10:59:35.277] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8970595490940643920:89:0) after 5m25s
[11:05:00.312] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8970595490940643920:89:0)
[11:05:00.339] Build status: STARTED
[11:05:00.339] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8970595490940643920:90:0) after 8m35s
[11:13:35.746] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8970595490940643920:90:0)
[11:13:35.769] Build status: STARTED
[11:13:35.769] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8970595490940643920:91:0) after 6m14s
[11:19:50.222] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8970595490940643920:91:0)
[11:19:50.249] Build status: STARTED
[11:19:50.249] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8970595490940643920:92:0) after 7m49s
[11:27:39.374] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8970595490940643920:92:0)
[11:27:39.397] Build status: STARTED
[11:27:39.397] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8970595490940643920:93:0) after 7m15s
[11:34:54.385] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8970595490940643920:93:0)
[11:34:54.409] Build status: STARTED
[11:34:54.409] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8970595490940643920:94:0) after 2m48s
[11:37:42.514] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8970595490940643920:94:0)
[11:37:42.538] Build status: STARTED
[11:37:42.538] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8970595490940643920:95:0) after 7m54s
[11:45:36.746] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8970595490940643920:95:0)
[11:45:36.770] Build status: STARTED
[11:45:36.770] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8970595490940643920:96:0) after 8m22s
[11:53:58.873] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8970595490940643920:96:0)
[11:53:58.902] Build status: STARTED
[11:53:58.902] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8970595490940643920:97:0) after 3m41s
[11:57:39.941] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8970595490940643920:97:0)
[11:57:39.970] Build status: STARTED
[11:57:39.970] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8970595490940643920:98:0) after 8m6s
[12:05:46.096] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8970595490940643920:98:0)
[12:05:46.130] Build status: STARTED
[12:05:46.130] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8970595490940643920:99:0) after 3m27s
[12:09:13.179] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8970595490940643920:99:0)
[12:09:13.212] Build status: STARTED
[12:09:13.212] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8970595490940643920:100:0) after 1m50s
[12:11:03.309] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8970595490940643920:100:0)
[12:11:03.337] Build status: STARTED
[12:11:03.337] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8970595490940643920:101:0) after 3m15s
[12:14:18.423] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8970595490940643920:101:0)
[12:14:18.446] Build status: STARTED
[12:14:18.446] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8970595490940643920:102:0) after 2m19s
[12:16:37.502] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8970595490940643920:102:0)
[12:16:37.529] Build status: STARTED
[12:16:37.529] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8970595490940643920:103:0) after 2m15s
[12:18:52.547] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8970595490940643920:103:0)
[12:18:52.572] Build status: STARTED
[12:18:52.572] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8970595490940643920:104:0) after 8m46s
[12:27:38.737] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8970595490940643920:104:0)
[12:27:38.764] Build status: STARTED
[12:27:38.764] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8970595490940643920:105:0) after 8m50s
[12:36:28.767] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8970595490940643920:105:0)
[12:36:28.790] Build status: STARTED
[12:36:28.790] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8970595490940643920:106:0) after 8m18s
[12:44:46.910] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8970595490940643920:106:0)
[12:44:46.945] Build status: STARTED
[12:44:46.945] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8970595490940643920:107:0) after 4m54s
[12:49:40.985] Handling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8970595490940643920:107:0)
[12:49:41.014] Build status: STARTED
[12:49:41.014] Scheduling timer "check-buildbucket-build-status" (chromium/Win 10 Fast Ring:8970595490940643920:108:0) after 8m25s
[12:56:11.442] Received PubSub notification, asking Buildbucket for the build status
[12:56:11.473] Build:
{
"id": "8805165428196078017",
"builder": {
"project": "chromium",
"bucket": "ci",
"builder": "Win 10 Fast Ring"
},
"number": 11777,
"createdBy": "project:chromium",
"createTime": "2022-08-22T02:55:01.629668547Z",
"startTime": "2022-08-22T03:00:11.591254Z",
"endTime": "2022-08-22T12:56:10.965681647Z",
"updateTime": "2022-08-22T12:56:10.965681647Z",
"status": "FAILURE",
"input": {
"gitilesCommit": {
"host": "chromium.googlesource.com",
"project": "chromium/src",
"id": "b480a0d2c936d9b7f309cf39067bee0ea2072a21",
"ref": "refs/heads/main"
}
}
}
[12:56:11.473] Invocation finished in 10h1m11.844478751s with status FAILED