[10:56:26.700] New invocation is queued and will start shortly
[10:56:27.782] Starting the invocation (attempt 1)
[10:56:27.828] Popped buildset tag "buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/345bb84ce8989329ea33994585b662fbfa65df86"
[10:56:27.828] Popped gitiles commit info from properties and tags
[10:56:27.828] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[10:56:27.828] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[10:56:27.828] Buildbucket request:
{
"requestId": "8996747723954353696",
"builder": {
"project": "chromium",
"bucket": "ci",
"builder": "ToTWin64"
},
"properties": {
},
"gitilesCommit": {
"host": "chromium.googlesource.com",
"project": "chromium/src",
"id": "345bb84ce8989329ea33994585b662fbfa65df86",
"ref": "refs/heads/main"
},
"tags": [
{
"key": "scheduler_invocation_id",
"value": "8996747723954353696"
},
{
"key": "scheduler_job_id",
"value": "chromium/ToTWin64"
},
{
"key": "user_agent",
"value": "luci-scheduler"
}
],
"notify": {
"pubsubTopic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
}
}
[10:56:28.393] Scheduled build:
{
"id": "8831317662033515937",
"builder": {
"project": "chromium",
"bucket": "ci",
"builder": "ToTWin64"
},
"number": 688,
"createdBy": "project:chromium",
"createTime": "2021-11-06T10:56:27.901656219Z",
"updateTime": "2021-11-06T10:56:27.901656219Z",
"status": "SCHEDULED",
"input": {
"gitilesCommit": {
"host": "chromium.googlesource.com",
"project": "chromium/src",
"id": "345bb84ce8989329ea33994585b662fbfa65df86",
"ref": "refs/heads/main"
}
}
}
[10:56:28.393] Task URL: https://cr-buildbucket.appspot.com/build/8831317662033515937
[10:56:28.393] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64:8996747723954353696:2:0) after 1m53s
[10:58:21.423] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64:8996747723954353696:2:0)
[10:58:21.504] Build status: SCHEDULED
[10:58:21.504] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64:8996747723954353696:3:0) after 5m48s
[11:04:09.522] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64:8996747723954353696:3:0)
[11:04:09.550] Build status: SCHEDULED
[11:04:09.550] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64:8996747723954353696:4:0) after 4m7s
[11:08:16.948] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64:8996747723954353696:4:0)
[11:08:16.976] Build status: SCHEDULED
[11:08:16.976] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64:8996747723954353696:5:0) after 7m18s
[11:15:35.272] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64:8996747723954353696:5:0)
[11:15:35.312] Build status: SCHEDULED
[11:15:35.312] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64:8996747723954353696:6:0) after 2m32s
[11:18:07.346] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64:8996747723954353696:6:0)
[11:18:07.379] Build status: SCHEDULED
[11:18:07.379] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64:8996747723954353696:7:0) after 6m35s
[11:24:42.875] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64:8996747723954353696:7:0)
[11:24:42.931] Build status: SCHEDULED
[11:24:42.931] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64:8996747723954353696:8:0) after 9m25s
[11:34:07.951] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64:8996747723954353696:8:0)
[11:34:07.990] Build status: SCHEDULED
[11:34:07.991] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64:8996747723954353696:9:0) after 1m3s
[11:35:11.123] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64:8996747723954353696:9:0)
[11:35:11.171] Build status: SCHEDULED
[11:35:11.171] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64:8996747723954353696:10:0) after 4m26s
[11:39:37.913] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64:8996747723954353696:10:0)
[11:39:37.936] Build status: SCHEDULED
[11:39:37.936] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64:8996747723954353696:11:0) after 5m3s
[11:44:40.982] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64:8996747723954353696:11:0)
[11:44:41.017] Build status: SCHEDULED
[11:44:41.017] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64:8996747723954353696:12:0) after 5m50s
[11:49:54.060] Received PubSub notification, asking Buildbucket for the build status
[11:49:54.112] Build status: STARTED
[11:50:31.059] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64:8996747723954353696:12:0)
[11:50:31.088] Build status: STARTED
[11:50:31.088] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64:8996747723954353696:14:0) after 5m25s
[11:55:56.115] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64:8996747723954353696:14:0)
[11:55:56.160] Build status: STARTED
[11:55:56.160] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64:8996747723954353696:15:0) after 9m59s
[12:05:55.181] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64:8996747723954353696:15:0)
[12:05:55.215] Build status: STARTED
[12:05:55.215] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64:8996747723954353696:16:0) after 5m13s
[12:11:09.114] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64:8996747723954353696:16:0)
[12:11:09.157] Build status: STARTED
[12:11:09.157] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64:8996747723954353696:17:0) after 1m15s
[12:12:24.855] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64:8996747723954353696:17:0)
[12:12:24.915] Build status: STARTED
[12:12:24.915] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64:8996747723954353696:18:0) after 2m15s
[12:14:39.932] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64:8996747723954353696:18:0)
[12:14:39.956] Build status: STARTED
[12:14:39.956] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64:8996747723954353696:19:0) after 5m33s
[12:20:13.413] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64:8996747723954353696:19:0)
[12:20:13.440] Build status: STARTED
[12:20:13.440] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64:8996747723954353696:20:0) after 4m3s
[12:24:16.549] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64:8996747723954353696:20:0)
[12:24:16.600] Build status: STARTED
[12:24:16.600] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64:8996747723954353696:21:0) after 4m58s
[12:29:14.863] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64:8996747723954353696:21:0)
[12:29:14.897] Build status: STARTED
[12:29:14.897] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64:8996747723954353696:22:0) after 9m26s
[12:38:40.980] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64:8996747723954353696:22:0)
[12:38:41.010] Build status: STARTED
[12:38:41.010] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64:8996747723954353696:23:0) after 7m26s
[12:46:07.250] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64:8996747723954353696:23:0)
[12:46:07.303] Build status: STARTED
[12:46:07.303] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64:8996747723954353696:24:0) after 5m13s
[12:51:20.408] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64:8996747723954353696:24:0)
[12:51:20.442] Build status: STARTED
[12:51:20.442] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64:8996747723954353696:25:0) after 3m51s
[12:55:11.600] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64:8996747723954353696:25:0)
[12:55:11.636] Build status: STARTED
[12:55:11.636] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64:8996747723954353696:26:0) after 3m58s
[12:59:09.715] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64:8996747723954353696:26:0)
[12:59:09.743] Build status: STARTED
[12:59:09.744] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64:8996747723954353696:27:0) after 3m35s
[13:02:44.972] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64:8996747723954353696:27:0)
[13:02:45.050] Build status: STARTED
[13:02:45.050] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64:8996747723954353696:28:0) after 2m19s
[13:05:04.160] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64:8996747723954353696:28:0)
[13:05:04.213] Build status: STARTED
[13:05:04.213] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64:8996747723954353696:29:0) after 3m13s
[13:08:17.235] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64:8996747723954353696:29:0)
[13:08:17.315] Build status: STARTED
[13:08:17.315] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64:8996747723954353696:30:0) after 1m51s
[13:10:09.823] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64:8996747723954353696:30:0)
[13:10:09.849] Build status: STARTED
[13:10:09.849] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64:8996747723954353696:31:0) after 8m12s
[13:18:21.991] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64:8996747723954353696:31:0)
[13:18:22.037] Build status: STARTED
[13:18:22.037] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64:8996747723954353696:32:0) after 8m34s
[13:26:56.300] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64:8996747723954353696:32:0)
[13:26:56.330] Build status: STARTED
[13:26:56.330] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64:8996747723954353696:33:0) after 2m16s
[13:29:12.648] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64:8996747723954353696:33:0)
[13:29:12.688] Build status: STARTED
[13:29:12.688] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64:8996747723954353696:34:0) after 1m23s
[13:30:35.969] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64:8996747723954353696:34:0)
[13:30:35.999] Build status: STARTED
[13:30:35.999] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64:8996747723954353696:35:0) after 4m54s
[13:35:30.441] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64:8996747723954353696:35:0)
[13:35:30.474] Build status: STARTED
[13:35:30.474] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64:8996747723954353696:36:0) after 1m48s
[13:37:18.496] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64:8996747723954353696:36:0)
[13:37:18.530] Build status: STARTED
[13:37:18.530] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64:8996747723954353696:37:0) after 3m2s
[13:40:20.654] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64:8996747723954353696:37:0)
[13:40:20.681] Build status: STARTED
[13:40:20.681] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64:8996747723954353696:38:0) after 5m40s
[13:46:00.735] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64:8996747723954353696:38:0)
[13:46:00.763] Build status: STARTED
[13:46:00.763] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64:8996747723954353696:39:0) after 9m4s
[13:55:04.797] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64:8996747723954353696:39:0)
[13:55:04.829] Build status: STARTED
[13:55:04.829] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64:8996747723954353696:40:0) after 7m56s
[14:03:00.851] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64:8996747723954353696:40:0)
[14:03:00.882] Build status: STARTED
[14:03:00.882] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64:8996747723954353696:41:0) after 6m25s
[14:09:25.907] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64:8996747723954353696:41:0)
[14:09:25.940] Build status: STARTED
[14:09:25.940] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64:8996747723954353696:42:0) after 9m48s
[14:19:13.962] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64:8996747723954353696:42:0)
[14:19:14.026] Build status: STARTED
[14:19:14.026] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64:8996747723954353696:43:0) after 2m50s
[14:22:04.025] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64:8996747723954353696:43:0)
[14:22:04.075] Build status: STARTED
[14:22:04.075] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64:8996747723954353696:44:0) after 2m29s
[14:24:33.107] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64:8996747723954353696:44:0)
[14:24:33.169] Build status: STARTED
[14:24:33.169] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64:8996747723954353696:45:0) after 9m56s
[14:34:29.289] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64:8996747723954353696:45:0)
[14:34:29.315] Build status: STARTED
[14:34:29.315] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64:8996747723954353696:46:0) after 8m11s
[14:42:40.725] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64:8996747723954353696:46:0)
[14:42:40.760] Build status: STARTED
[14:42:40.760] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64:8996747723954353696:47:0) after 1m50s
[14:44:30.731] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64:8996747723954353696:47:0)
[14:44:30.790] Build status: STARTED
[14:44:30.790] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64:8996747723954353696:48:0) after 9m3s
[14:53:33.885] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64:8996747723954353696:48:0)
[14:53:33.911] Build status: STARTED
[14:53:33.911] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64:8996747723954353696:49:0) after 8m57s
[15:02:30.932] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64:8996747723954353696:49:0)
[15:02:30.964] Build status: STARTED
[15:02:30.964] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64:8996747723954353696:50:0) after 2m55s
[15:05:25.995] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64:8996747723954353696:50:0)
[15:05:26.028] Build status: STARTED
[15:05:26.028] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64:8996747723954353696:51:0) after 7m22s
[15:12:48.048] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64:8996747723954353696:51:0)
[15:12:48.088] Build status: STARTED
[15:12:48.088] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64:8996747723954353696:52:0) after 8m7s
[15:20:55.539] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64:8996747723954353696:52:0)
[15:20:55.573] Build status: STARTED
[15:20:55.573] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64:8996747723954353696:53:0) after 7m40s
[15:28:35.818] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64:8996747723954353696:53:0)
[15:28:35.845] Build status: STARTED
[15:28:35.845] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64:8996747723954353696:54:0) after 4m11s
[15:32:46.864] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64:8996747723954353696:54:0)
[15:32:46.891] Build status: STARTED
[15:32:46.891] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64:8996747723954353696:55:0) after 1m41s
[15:34:27.946] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64:8996747723954353696:55:0)
[15:34:27.973] Build status: STARTED
[15:34:27.973] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64:8996747723954353696:56:0) after 1m39s
[15:36:06.994] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64:8996747723954353696:56:0)
[15:36:07.085] Build status: STARTED
[15:36:07.085] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64:8996747723954353696:57:0) after 7m46s
[15:43:53.224] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64:8996747723954353696:57:0)
[15:43:53.253] Build status: STARTED
[15:43:53.253] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64:8996747723954353696:58:0) after 2m45s
[15:46:38.379] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64:8996747723954353696:58:0)
[15:46:38.449] Build status: STARTED
[15:46:38.449] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64:8996747723954353696:59:0) after 9m3s
[15:55:41.470] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64:8996747723954353696:59:0)
[15:55:41.504] Build status: STARTED
[15:55:41.504] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64:8996747723954353696:60:0) after 5m15s
[16:00:56.506] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64:8996747723954353696:60:0)
[16:00:56.537] Build status: STARTED
[16:00:56.537] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64:8996747723954353696:61:0) after 2m11s
[16:03:07.569] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64:8996747723954353696:61:0)
[16:03:07.613] Build status: STARTED
[16:03:07.613] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64:8996747723954353696:62:0) after 2m47s
[16:05:54.653] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64:8996747723954353696:62:0)
[16:05:54.681] Build status: STARTED
[16:05:54.681] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64:8996747723954353696:63:0) after 1m17s
[16:07:11.760] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64:8996747723954353696:63:0)
[16:07:11.799] Build status: STARTED
[16:07:11.799] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64:8996747723954353696:64:0) after 5m45s
[16:12:57.244] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64:8996747723954353696:64:0)
[16:12:57.275] Build status: STARTED
[16:12:57.275] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64:8996747723954353696:65:0) after 3m55s
[16:16:52.279] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64:8996747723954353696:65:0)
[16:16:52.315] Build status: STARTED
[16:16:52.315] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64:8996747723954353696:66:0) after 8m55s
[16:25:47.366] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64:8996747723954353696:66:0)
[16:25:47.397] Build status: STARTED
[16:25:47.397] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64:8996747723954353696:67:0) after 9m31s
[16:35:18.490] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64:8996747723954353696:67:0)
[16:35:18.518] Build status: STARTED
[16:35:18.518] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64:8996747723954353696:68:0) after 6m6s
[16:41:24.828] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64:8996747723954353696:68:0)
[16:41:24.855] Build status: STARTED
[16:41:24.855] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64:8996747723954353696:69:0) after 8m20s
[16:49:45.498] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64:8996747723954353696:69:0)
[16:49:45.561] Build status: STARTED
[16:49:45.561] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64:8996747723954353696:70:0) after 4m57s
[16:54:43.180] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64:8996747723954353696:70:0)
[16:54:43.213] Build status: STARTED
[16:54:43.213] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64:8996747723954353696:71:0) after 1m38s
[16:56:21.226] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64:8996747723954353696:71:0)
[16:56:21.252] Build status: STARTED
[16:56:21.252] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64:8996747723954353696:72:0) after 9m30s
[17:05:51.274] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64:8996747723954353696:72:0)
[17:05:51.314] Build status: STARTED
[17:05:51.314] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64:8996747723954353696:73:0) after 2m37s
[17:08:28.365] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64:8996747723954353696:73:0)
[17:08:28.398] Build status: STARTED
[17:08:28.398] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64:8996747723954353696:74:0) after 8m59s
[17:17:27.428] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64:8996747723954353696:74:0)
[17:17:27.458] Build status: STARTED
[17:17:27.458] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64:8996747723954353696:75:0) after 8m6s
[17:25:33.823] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64:8996747723954353696:75:0)
[17:25:33.865] Build status: STARTED
[17:25:33.865] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64:8996747723954353696:76:0) after 3m4s
[17:28:37.884] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64:8996747723954353696:76:0)
[17:28:37.918] Build status: STARTED
[17:28:37.919] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64:8996747723954353696:77:0) after 1m36s
[17:30:13.936] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64:8996747723954353696:77:0)
[17:30:13.978] Build status: STARTED
[17:30:13.978] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64:8996747723954353696:78:0) after 8m56s
[17:39:10.002] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64:8996747723954353696:78:0)
[17:39:10.035] Build status: STARTED
[17:39:10.035] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64:8996747723954353696:79:0) after 6m57s
[17:46:07.112] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64:8996747723954353696:79:0)
[17:46:07.150] Build status: STARTED
[17:46:07.150] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64:8996747723954353696:80:0) after 3m27s
[17:49:34.393] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64:8996747723954353696:80:0)
[17:49:34.433] Build status: STARTED
[17:49:34.433] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64:8996747723954353696:81:0) after 1m24s
[17:50:58.957] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64:8996747723954353696:81:0)
[17:50:58.991] Build status: STARTED
[17:50:58.991] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64:8996747723954353696:82:0) after 1m35s
[17:52:34.031] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64:8996747723954353696:82:0)
[17:52:34.080] Build status: STARTED
[17:52:34.080] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64:8996747723954353696:83:0) after 4m7s
[17:56:41.489] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64:8996747723954353696:83:0)
[17:56:41.518] Build status: STARTED
[17:56:41.518] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64:8996747723954353696:84:0) after 4m21s
[18:01:02.549] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64:8996747723954353696:84:0)
[18:01:02.588] Build status: STARTED
[18:01:02.588] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64:8996747723954353696:85:0) after 9m33s
[18:10:35.614] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64:8996747723954353696:85:0)
[18:10:35.644] Build status: STARTED
[18:10:35.644] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64:8996747723954353696:86:0) after 3m47s
[18:14:23.350] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64:8996747723954353696:86:0)
[18:14:23.395] Build status: STARTED
[18:14:23.395] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64:8996747723954353696:87:0) after 8m18s
[18:22:41.416] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64:8996747723954353696:87:0)
[18:22:41.442] Build status: STARTED
[18:22:41.442] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64:8996747723954353696:88:0) after 9m44s
[18:32:26.261] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64:8996747723954353696:88:0)
[18:32:26.292] Build status: STARTED
[18:32:26.292] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64:8996747723954353696:89:0) after 1m48s
[18:34:14.907] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64:8996747723954353696:89:0)
[18:34:14.952] Build status: STARTED
[18:34:14.952] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64:8996747723954353696:90:0) after 3m41s
[18:37:55.975] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64:8996747723954353696:90:0)
[18:37:56.035] Build status: STARTED
[18:37:56.035] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64:8996747723954353696:91:0) after 7m31s
[18:45:27.434] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64:8996747723954353696:91:0)
[18:45:27.461] Build status: STARTED
[18:45:27.461] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64:8996747723954353696:92:0) after 8m51s
[18:54:18.485] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64:8996747723954353696:92:0)
[18:54:18.557] Build status: STARTED
[18:54:18.557] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64:8996747723954353696:93:0) after 8m42s
[19:03:00.784] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64:8996747723954353696:93:0)
[19:03:00.830] Build status: STARTED
[19:03:00.830] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64:8996747723954353696:94:0) after 5m55s
[19:08:55.851] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64:8996747723954353696:94:0)
[19:08:55.885] Build status: STARTED
[19:08:55.885] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64:8996747723954353696:95:0) after 5m4s
[19:13:59.903] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64:8996747723954353696:95:0)
[19:13:59.945] Build status: STARTED
[19:13:59.945] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64:8996747723954353696:96:0) after 6m35s
[19:20:35.461] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64:8996747723954353696:96:0)
[19:20:35.499] Build status: STARTED
[19:20:35.499] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64:8996747723954353696:97:0) after 7m29s
[19:28:04.518] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64:8996747723954353696:97:0)
[19:28:04.551] Build status: STARTED
[19:28:04.551] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64:8996747723954353696:98:0) after 1m3s
[19:29:07.861] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64:8996747723954353696:98:0)
[19:29:07.888] Build status: STARTED
[19:29:07.888] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64:8996747723954353696:99:0) after 6m30s
[19:35:38.518] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64:8996747723954353696:99:0)
[19:35:38.577] Build status: STARTED
[19:35:38.577] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64:8996747723954353696:100:0) after 7m21s
[19:43:00.021] Handling timer "check-buildbucket-build-status" (chromium/ToTWin64:8996747723954353696:100:0)
[19:43:00.051] Build status: STARTED
[19:43:00.051] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin64:8996747723954353696:101:0) after 7m55s
[19:49:23.842] Received PubSub notification, asking Buildbucket for the build status
[19:49:23.878] Build:
{
"id": "8831317662033515937",
"builder": {
"project": "chromium",
"bucket": "ci",
"builder": "ToTWin64"
},
"number": 688,
"createdBy": "project:chromium",
"createTime": "2021-11-06T10:56:27.901656219Z",
"startTime": "2021-11-06T11:49:53.153078Z",
"endTime": "2021-11-06T19:49:23.148093058Z",
"updateTime": "2021-11-06T19:49:23.148093058Z",
"status": "FAILURE",
"input": {
"gitilesCommit": {
"host": "chromium.googlesource.com",
"project": "chromium/src",
"id": "345bb84ce8989329ea33994585b662fbfa65df86",
"ref": "refs/heads/main"
}
}
}
[19:49:23.878] Invocation finished in 8h52m57.191831021s with status FAILED