[14:44:46.519] New invocation is queued and will start shortly
[14:44:48.069] Starting the invocation (attempt 1)
[14:44:48.109] Popped buildset tag "buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/7b345800247c80eaba0cc452d2f57f3ba736a57f"
[14:44:48.109] Popped gitiles commit info from properties and tags
[14:44:48.109] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[14:44:48.109] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[14:44:48.109] Buildbucket request:
{
"requestId": "8967923523335944064",
"builder": {
"project": "chromium",
"bucket": "ci",
"builder": "ToTWin(dbg)"
},
"properties": {
},
"gitilesCommit": {
"host": "chromium.googlesource.com",
"project": "chromium/src",
"id": "7b345800247c80eaba0cc452d2f57f3ba736a57f",
"ref": "refs/heads/main"
},
"tags": [
{
"key": "scheduler_invocation_id",
"value": "8967923523335944064"
},
{
"key": "scheduler_job_id",
"value": "chromium/ToTWin(dbg)"
},
{
"key": "user_agent",
"value": "luci-scheduler"
}
],
"notify": {
"pubsubTopic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
}
}
[14:44:49.508] Scheduled build:
{
"id": "8802493460912032737",
"builder": {
"project": "chromium",
"bucket": "ci",
"builder": "ToTWin(dbg)"
},
"number": 10331,
"createdBy": "project:chromium",
"createTime": "2022-09-20T14:44:48.202440068Z",
"updateTime": "2022-09-20T14:44:48.202440068Z",
"status": "SCHEDULED",
"input": {
"gitilesCommit": {
"host": "chromium.googlesource.com",
"project": "chromium/src",
"id": "7b345800247c80eaba0cc452d2f57f3ba736a57f",
"ref": "refs/heads/main"
}
}
}
[14:44:49.508] Task URL: https://cr-buildbucket.appspot.com/build/8802493460912032737
[14:44:49.508] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8967923523335944064:2:0) after 7m54s
[14:45:07.792] Received PubSub notification, asking Buildbucket for the build status
[14:45:07.830] Build status: STARTED
[14:52:43.540] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8967923523335944064:2:0)
[14:52:43.572] Build status: STARTED
[14:52:43.572] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8967923523335944064:4:0) after 5m18s
[14:58:01.612] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8967923523335944064:4:0)
[14:58:01.655] Build status: STARTED
[14:58:01.655] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8967923523335944064:5:0) after 1m48s
[14:59:49.684] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8967923523335944064:5:0)
[14:59:49.712] Build status: STARTED
[14:59:49.712] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8967923523335944064:6:0) after 9m9s
[15:08:58.742] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8967923523335944064:6:0)
[15:08:58.765] Build status: STARTED
[15:08:58.765] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8967923523335944064:7:0) after 9m22s
[15:18:20.796] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8967923523335944064:7:0)
[15:18:20.825] Build status: STARTED
[15:18:20.825] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8967923523335944064:8:0) after 8m42s
[15:27:02.899] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8967923523335944064:8:0)
[15:27:02.931] Build status: STARTED
[15:27:02.931] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8967923523335944064:9:0) after 9m48s
[15:36:50.979] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8967923523335944064:9:0)
[15:36:51.004] Build status: STARTED
[15:36:51.004] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8967923523335944064:10:0) after 7m58s
[15:44:49.041] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8967923523335944064:10:0)
[15:44:49.070] Build status: STARTED
[15:44:49.070] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8967923523335944064:11:0) after 6m52s
[15:51:41.093] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8967923523335944064:11:0)
[15:51:41.120] Build status: STARTED
[15:51:41.120] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8967923523335944064:12:0) after 2m58s
[15:54:39.986] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8967923523335944064:12:0)
[15:54:40.047] Build status: STARTED
[15:54:40.047] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8967923523335944064:13:0) after 3m30s
[15:58:10.098] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8967923523335944064:13:0)
[15:58:10.293] Build status: STARTED
[15:58:10.293] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8967923523335944064:14:0) after 5m17s
[16:03:27.320] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8967923523335944064:14:0)
[16:03:27.360] Build status: STARTED
[16:03:27.360] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8967923523335944064:15:0) after 5m48s
[16:09:15.460] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8967923523335944064:15:0)
[16:09:15.494] Build status: STARTED
[16:09:15.494] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8967923523335944064:16:0) after 4m54s
[16:14:09.516] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8967923523335944064:16:0)
[16:14:09.544] Build status: STARTED
[16:14:09.544] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8967923523335944064:17:0) after 1m50s
[16:15:59.535] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8967923523335944064:17:0)
[16:15:59.564] Build status: STARTED
[16:15:59.564] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8967923523335944064:18:0) after 5m16s
[16:21:15.640] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8967923523335944064:18:0)
[16:21:15.666] Build status: STARTED
[16:21:15.666] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8967923523335944064:19:0) after 9m21s
[16:30:36.823] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8967923523335944064:19:0)
[16:30:36.853] Build status: STARTED
[16:30:36.853] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8967923523335944064:20:0) after 8m34s
[16:39:10.879] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8967923523335944064:20:0)
[16:39:10.908] Build status: STARTED
[16:39:10.908] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8967923523335944064:21:0) after 4m33s
[16:43:44.051] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8967923523335944064:21:0)
[16:43:44.086] Build status: STARTED
[16:43:44.086] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8967923523335944064:22:0) after 3m39s
[16:47:23.149] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8967923523335944064:22:0)
[16:47:23.177] Build status: STARTED
[16:47:23.177] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8967923523335944064:23:0) after 5m47s
[16:53:10.217] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8967923523335944064:23:0)
[16:53:10.254] Build status: STARTED
[16:53:10.254] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8967923523335944064:24:0) after 4m16s
[16:57:26.371] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8967923523335944064:24:0)
[16:57:26.412] Build status: STARTED
[16:57:26.412] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8967923523335944064:25:0) after 7m30s
[17:04:56.453] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8967923523335944064:25:0)
[17:04:56.488] Build status: STARTED
[17:04:56.488] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8967923523335944064:26:0) after 4m30s
[17:09:26.514] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8967923523335944064:26:0)
[17:09:26.536] Build status: STARTED
[17:09:26.537] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8967923523335944064:27:0) after 6m44s
[17:16:10.565] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8967923523335944064:27:0)
[17:16:10.624] Build status: STARTED
[17:16:10.624] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8967923523335944064:28:0) after 3m11s
[17:19:21.768] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8967923523335944064:28:0)
[17:19:21.794] Build status: STARTED
[17:19:21.794] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8967923523335944064:29:0) after 6m31s
[17:25:52.824] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8967923523335944064:29:0)
[17:25:52.853] Build status: STARTED
[17:25:52.853] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8967923523335944064:30:0) after 6m34s
[17:32:26.881] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8967923523335944064:30:0)
[17:32:26.957] Build status: STARTED
[17:32:26.957] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8967923523335944064:31:0) after 8m9s
[17:40:35.987] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8967923523335944064:31:0)
[17:40:36.024] Build status: STARTED
[17:40:36.024] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8967923523335944064:32:0) after 1m11s
[17:41:47.048] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8967923523335944064:32:0)
[17:41:47.072] Build status: STARTED
[17:41:47.072] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8967923523335944064:33:0) after 3m1s
[17:44:48.103] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8967923523335944064:33:0)
[17:44:48.252] Build status: STARTED
[17:44:48.252] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8967923523335944064:34:0) after 2m54s
[17:47:42.278] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8967923523335944064:34:0)
[17:47:42.314] Build status: STARTED
[17:47:42.314] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8967923523335944064:35:0) after 8m50s
[17:56:32.355] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8967923523335944064:35:0)
[17:56:32.386] Build status: STARTED
[17:56:32.386] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8967923523335944064:36:0) after 3m17s
[17:59:49.477] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8967923523335944064:36:0)
[17:59:49.508] Build status: STARTED
[17:59:49.508] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8967923523335944064:37:0) after 7m37s
[18:07:26.574] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8967923523335944064:37:0)
[18:07:26.600] Build status: STARTED
[18:07:26.600] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8967923523335944064:38:0) after 2m6s
[18:09:32.644] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8967923523335944064:38:0)
[18:09:32.670] Build status: STARTED
[18:09:32.670] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8967923523335944064:39:0) after 7m0s
[18:16:32.697] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8967923523335944064:39:0)
[18:16:32.726] Build status: STARTED
[18:16:32.726] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8967923523335944064:40:0) after 6m20s
[18:22:52.780] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8967923523335944064:40:0)
[18:22:52.814] Build status: STARTED
[18:22:52.814] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8967923523335944064:41:0) after 1m52s
[18:24:44.892] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8967923523335944064:41:0)
[18:24:44.917] Build status: STARTED
[18:24:44.917] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8967923523335944064:42:0) after 4m5s
[18:28:49.936] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8967923523335944064:42:0)
[18:28:49.962] Build status: STARTED
[18:28:49.962] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8967923523335944064:43:0) after 2m59s
[18:31:49.041] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8967923523335944064:43:0)
[18:31:49.068] Build status: STARTED
[18:31:49.068] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8967923523335944064:44:0) after 6m8s
[18:37:57.095] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8967923523335944064:44:0)
[18:37:57.123] Build status: STARTED
[18:37:57.123] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8967923523335944064:45:0) after 6m34s
[18:44:31.146] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8967923523335944064:45:0)
[18:44:31.192] Build status: STARTED
[18:44:31.193] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8967923523335944064:46:0) after 7m56s
[18:52:27.251] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8967923523335944064:46:0)
[18:52:27.275] Build status: STARTED
[18:52:27.275] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8967923523335944064:47:0) after 6m58s
[18:59:25.308] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8967923523335944064:47:0)
[18:59:25.332] Build status: STARTED
[18:59:25.332] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8967923523335944064:48:0) after 2m20s
[19:01:45.365] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8967923523335944064:48:0)
[19:01:45.396] Build status: STARTED
[19:01:45.396] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8967923523335944064:49:0) after 1m59s
[19:03:44.573] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8967923523335944064:49:0)
[19:03:44.612] Build status: STARTED
[19:03:44.612] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8967923523335944064:50:0) after 9m45s
[19:13:29.676] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8967923523335944064:50:0)
[19:13:29.705] Build status: STARTED
[19:13:29.705] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8967923523335944064:51:0) after 4m59s
[19:18:28.765] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8967923523335944064:51:0)
[19:18:28.789] Build status: STARTED
[19:18:28.789] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8967923523335944064:52:0) after 3m35s
[19:22:03.839] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8967923523335944064:52:0)
[19:22:03.875] Build status: STARTED
[19:22:03.875] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8967923523335944064:53:0) after 4m22s
[19:26:25.916] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8967923523335944064:53:0)
[19:26:25.967] Build status: STARTED
[19:26:25.967] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8967923523335944064:54:0) after 4m53s
[19:31:19.242] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8967923523335944064:54:0)
[19:31:19.267] Build status: STARTED
[19:31:19.267] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8967923523335944064:55:0) after 2m31s
[19:33:50.622] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8967923523335944064:55:0)
[19:33:50.651] Build status: STARTED
[19:33:50.651] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8967923523335944064:56:0) after 8m41s
[19:42:31.900] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8967923523335944064:56:0)
[19:42:31.942] Build status: STARTED
[19:42:31.942] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8967923523335944064:57:0) after 9m10s
[19:51:41.965] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8967923523335944064:57:0)
[19:51:41.995] Build status: STARTED
[19:51:41.995] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8967923523335944064:58:0) after 6m5s
[19:57:47.108] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8967923523335944064:58:0)
[19:57:47.145] Build status: STARTED
[19:57:47.145] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8967923523335944064:59:0) after 8m41s
[20:06:28.167] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8967923523335944064:59:0)
[20:06:28.194] Build status: STARTED
[20:06:28.194] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8967923523335944064:60:0) after 7m58s
[20:14:26.252] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8967923523335944064:60:0)
[20:14:26.291] Build status: STARTED
[20:14:26.291] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8967923523335944064:61:0) after 7m55s
[20:22:21.314] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8967923523335944064:61:0)
[20:22:21.380] Build status: STARTED
[20:22:21.380] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8967923523335944064:62:0) after 1m23s
[20:23:44.412] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8967923523335944064:62:0)
[20:23:44.441] Build status: STARTED
[20:23:44.441] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8967923523335944064:63:0) after 1m47s
[20:25:31.474] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8967923523335944064:63:0)
[20:25:31.500] Build status: STARTED
[20:25:31.500] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8967923523335944064:64:0) after 9m56s
[20:35:27.543] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8967923523335944064:64:0)
[20:35:27.705] Build status: STARTED
[20:35:27.705] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8967923523335944064:65:0) after 1m38s
[20:37:06.021] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8967923523335944064:65:0)
[20:37:06.048] Build status: STARTED
[20:37:06.048] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8967923523335944064:66:0) after 3m32s
[20:40:38.085] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8967923523335944064:66:0)
[20:40:38.114] Build status: STARTED
[20:40:38.114] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8967923523335944064:67:0) after 5m8s
[20:45:46.165] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8967923523335944064:67:0)
[20:45:46.281] Build status: STARTED
[20:45:46.281] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8967923523335944064:68:0) after 3m5s
[20:48:51.409] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8967923523335944064:68:0)
[20:48:51.442] Build status: STARTED
[20:48:51.442] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8967923523335944064:69:0) after 7m35s
[20:56:26.426] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8967923523335944064:69:0)
[20:56:26.453] Build status: STARTED
[20:56:26.453] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8967923523335944064:70:0) after 5m41s
[21:02:07.485] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8967923523335944064:70:0)
[21:02:07.677] Build status: STARTED
[21:02:07.677] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8967923523335944064:71:0) after 4m57s
[21:07:04.778] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8967923523335944064:71:0)
[21:07:04.807] Build status: STARTED
[21:07:04.807] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8967923523335944064:72:0) after 4m57s
[21:12:01.833] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8967923523335944064:72:0)
[21:12:01.865] Build status: STARTED
[21:12:01.865] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8967923523335944064:73:0) after 7m13s
[21:19:15.176] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8967923523335944064:73:0)
[21:19:15.209] Build status: STARTED
[21:19:15.209] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8967923523335944064:74:0) after 9m5s
[21:28:20.241] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8967923523335944064:74:0)
[21:28:20.272] Build status: STARTED
[21:28:20.272] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8967923523335944064:75:0) after 4m7s
[21:32:27.385] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8967923523335944064:75:0)
[21:32:27.411] Build status: STARTED
[21:32:27.411] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8967923523335944064:76:0) after 1m55s
[21:34:22.435] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8967923523335944064:76:0)
[21:34:22.616] Build status: STARTED
[21:34:22.616] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8967923523335944064:77:0) after 8m44s
[21:43:06.593] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8967923523335944064:77:0)
[21:43:06.620] Build status: STARTED
[21:43:06.620] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8967923523335944064:78:0) after 1m25s
[21:44:31.658] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8967923523335944064:78:0)
[21:44:31.689] Build status: STARTED
[21:44:31.689] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8967923523335944064:79:0) after 3m14s
[21:47:46.581] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8967923523335944064:79:0)
[21:47:46.618] Build status: STARTED
[21:47:46.618] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8967923523335944064:80:0) after 6m8s
[21:53:54.704] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8967923523335944064:80:0)
[21:53:54.731] Build status: STARTED
[21:53:54.731] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8967923523335944064:81:0) after 8m35s
[22:02:30.056] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8967923523335944064:81:0)
[22:02:30.090] Build status: STARTED
[22:02:30.090] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8967923523335944064:82:0) after 7m30s
[22:10:00.116] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8967923523335944064:82:0)
[22:10:00.144] Build status: STARTED
[22:10:00.144] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8967923523335944064:83:0) after 5m9s
[22:15:09.156] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8967923523335944064:83:0)
[22:15:09.268] Build status: STARTED
[22:15:09.268] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8967923523335944064:84:0) after 9m5s
[22:24:14.334] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8967923523335944064:84:0)
[22:24:14.362] Build status: STARTED
[22:24:14.362] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8967923523335944064:85:0) after 2m22s
[22:26:36.720] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8967923523335944064:85:0)
[22:26:36.745] Build status: STARTED
[22:26:36.745] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8967923523335944064:86:0) after 3m11s
[22:29:48.363] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8967923523335944064:86:0)
[22:29:48.401] Build status: STARTED
[22:29:48.401] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8967923523335944064:87:0) after 9m2s
[22:38:50.595] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8967923523335944064:87:0)
[22:38:50.626] Build status: STARTED
[22:38:50.626] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8967923523335944064:88:0) after 3m41s
[22:42:31.974] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8967923523335944064:88:0)
[22:42:32.001] Build status: STARTED
[22:42:32.001] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8967923523335944064:89:0) after 4m42s
[22:47:14.141] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8967923523335944064:89:0)
[22:47:14.174] Build status: STARTED
[22:47:14.174] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8967923523335944064:90:0) after 4m50s
[22:52:04.670] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8967923523335944064:90:0)
[22:52:04.726] Build status: STARTED
[22:52:04.727] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8967923523335944064:91:0) after 2m43s
[22:54:47.794] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8967923523335944064:91:0)
[22:54:47.822] Build status: STARTED
[22:54:47.822] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8967923523335944064:92:0) after 7m41s
[23:02:28.843] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8967923523335944064:92:0)
[23:02:28.869] Build status: STARTED
[23:02:28.869] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8967923523335944064:93:0) after 4m1s
[23:06:30.076] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8967923523335944064:93:0)
[23:06:30.109] Build status: STARTED
[23:06:30.109] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8967923523335944064:94:0) after 2m24s
[23:08:54.146] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8967923523335944064:94:0)
[23:08:54.177] Build status: STARTED
[23:08:54.177] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8967923523335944064:95:0) after 2m7s
[23:11:01.240] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8967923523335944064:95:0)
[23:11:01.273] Build status: STARTED
[23:11:01.273] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8967923523335944064:96:0) after 8m3s
[23:19:04.300] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8967923523335944064:96:0)
[23:19:04.332] Build status: STARTED
[23:19:04.332] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8967923523335944064:97:0) after 6m4s
[23:25:08.475] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8967923523335944064:97:0)
[23:25:08.501] Build status: STARTED
[23:25:08.501] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8967923523335944064:98:0) after 3m35s
[23:28:43.657] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8967923523335944064:98:0)
[23:28:43.678] Build status: STARTED
[23:28:43.678] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8967923523335944064:99:0) after 7m13s
[23:35:57.096] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8967923523335944064:99:0)
[23:35:57.123] Build status: STARTED
[23:35:57.123] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8967923523335944064:100:0) after 7m43s
[23:43:40.195] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8967923523335944064:100:0)
[23:43:40.217] Build status: STARTED
[23:43:40.217] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8967923523335944064:101:0) after 7m12s
[23:50:52.250] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8967923523335944064:101:0)
[23:50:52.288] Build status: STARTED
[23:50:52.288] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8967923523335944064:102:0) after 4m18s
[23:55:10.427] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8967923523335944064:102:0)
[23:55:10.467] Build status: STARTED
[23:55:10.467] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8967923523335944064:103:0) after 1m32s
[23:56:42.802] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8967923523335944064:103:0)
[23:56:42.830] Build status: STARTED
[23:56:42.830] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8967923523335944064:104:0) after 3m44s
[00:00:27.006] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8967923523335944064:104:0)
[00:00:27.047] Build status: STARTED
[00:00:27.047] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8967923523335944064:105:0) after 4m0s
[00:04:27.174] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8967923523335944064:105:0)
[00:04:27.199] Build status: STARTED
[00:04:27.199] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8967923523335944064:106:0) after 3m21s
[00:07:48.259] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8967923523335944064:106:0)
[00:07:48.294] Build status: STARTED
[00:07:48.294] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8967923523335944064:107:0) after 3m48s
[00:11:37.453] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8967923523335944064:107:0)
[00:11:37.638] Build status: STARTED
[00:11:37.638] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8967923523335944064:108:0) after 8m26s
[00:20:03.955] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8967923523335944064:108:0)
[00:20:04.037] Build status: STARTED
[00:20:04.037] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8967923523335944064:109:0) after 5m0s
[00:25:04.063] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8967923523335944064:109:0)
[00:25:04.111] Build status: STARTED
[00:25:04.111] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8967923523335944064:110:0) after 4m41s
[00:29:45.316] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8967923523335944064:110:0)
[00:29:45.344] Build status: STARTED
[00:29:45.344] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8967923523335944064:111:0) after 3m43s
[00:33:28.544] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8967923523335944064:111:0)
[00:33:28.570] Build status: STARTED
[00:33:28.570] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8967923523335944064:112:0) after 2m43s
[00:36:11.728] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8967923523335944064:112:0)
[00:36:11.754] Build status: STARTED
[00:36:11.754] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8967923523335944064:113:0) after 9m5s
[00:45:16.778] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8967923523335944064:113:0)
[00:45:16.810] Build status: STARTED
[00:45:16.810] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8967923523335944064:114:0) after 8m16s
[00:47:46.713] Received PubSub notification, asking Buildbucket for the build status
[00:47:46.740] Build:
{
"id": "8802493460912032737",
"builder": {
"project": "chromium",
"bucket": "ci",
"builder": "ToTWin(dbg)"
},
"number": 10331,
"createdBy": "project:chromium",
"createTime": "2022-09-20T14:44:48.202440068Z",
"startTime": "2022-09-20T14:45:06.452054Z",
"endTime": "2022-09-21T00:47:46.112385520Z",
"updateTime": "2022-09-21T00:47:46.112385520Z",
"status": "FAILURE",
"input": {
"gitilesCommit": {
"host": "chromium.googlesource.com",
"project": "chromium/src",
"id": "7b345800247c80eaba0cc452d2f57f3ba736a57f",
"ref": "refs/heads/main"
}
}
}
[00:47:46.740] Invocation finished in 10h3m0.234025633s with status FAILED