[11:38:42.669] New invocation is queued and will start shortly
[11:38:43.802] Starting the invocation (attempt 1)
[11:38:43.846] Popped buildset tag "buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/d820a83363a8f94c4b863b3e24d3ce85798f4e7b"
[11:38:43.846] Popped gitiles commit info from properties and tags
[11:38:43.846] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[11:38:43.846] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[11:38:43.846] Buildbucket request:
{
"requestId": "9003358643346748784",
"builder": {
"project": "chromium",
"bucket": "ci",
"builder": "ToTWin(dbg)"
},
"properties": {
},
"gitilesCommit": {
"host": "chromium.googlesource.com",
"project": "chromium/src",
"id": "d820a83363a8f94c4b863b3e24d3ce85798f4e7b",
"ref": "refs/heads/main"
},
"tags": [
{
"key": "scheduler_invocation_id",
"value": "9003358643346748784"
},
{
"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"
}
}
[11:38:44.384] Scheduled build:
{
"id": "8837928581359668641",
"builder": {
"project": "chromium",
"bucket": "ci",
"builder": "ToTWin(dbg)"
},
"number": 7800,
"createdBy": "project:chromium",
"createTime": "2021-08-25T11:38:43.932754638Z",
"updateTime": "2021-08-25T11:38:44.183471653Z",
"status": "SCHEDULED",
"input": {
"gitilesCommit": {
"host": "chromium.googlesource.com",
"project": "chromium/src",
"id": "d820a83363a8f94c4b863b3e24d3ce85798f4e7b",
"ref": "refs/heads/main"
}
}
}
[11:38:44.384] Task URL: https://cr-buildbucket.appspot.com/build/8837928581359668641
[11:38:44.384] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):9003358643346748784:2:0) after 3m0s
[11:41:44.469] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):9003358643346748784:2:0)
[11:41:44.507] Build status: SCHEDULED
[11:41:44.507] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):9003358643346748784:3:0) after 3m54s
[11:45:38.531] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):9003358643346748784:3:0)
[11:45:38.578] Build status: SCHEDULED
[11:45:38.578] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):9003358643346748784:4:0) after 8m29s
[11:50:49.863] Received PubSub notification, asking Buildbucket for the build status
[11:50:49.895] Build status: STARTED
[11:54:07.622] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):9003358643346748784:4:0)
[11:54:07.650] Build status: STARTED
[11:54:07.650] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):9003358643346748784:6:0) after 1m48s
[11:55:55.786] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):9003358643346748784:6:0)
[11:55:55.871] Build status: STARTED
[11:55:55.871] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):9003358643346748784:7:0) after 9m53s
[12:05:48.894] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):9003358643346748784:7:0)
[12:05:48.933] Build status: STARTED
[12:05:48.933] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):9003358643346748784:8:0) after 5m36s
[12:11:24.943] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):9003358643346748784:8:0)
[12:11:24.972] Build status: STARTED
[12:11:24.972] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):9003358643346748784:9:0) after 6m31s
[12:17:55.993] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):9003358643346748784:9:0)
[12:17:56.025] Build status: STARTED
[12:17:56.025] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):9003358643346748784:10:0) after 5m20s
[12:23:16.050] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):9003358643346748784:10:0)
[12:23:16.085] Build status: STARTED
[12:23:16.085] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):9003358643346748784:11:0) after 4m40s
[12:27:56.106] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):9003358643346748784:11:0)
[12:27:56.141] Build status: STARTED
[12:27:56.141] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):9003358643346748784:12:0) after 2m29s
[12:30:25.205] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):9003358643346748784:12:0)
[12:30:25.237] Build status: STARTED
[12:30:25.237] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):9003358643346748784:13:0) after 7m44s
[12:38:09.375] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):9003358643346748784:13:0)
[12:38:09.439] Build status: STARTED
[12:38:09.439] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):9003358643346748784:14:0) after 4m25s
[12:42:34.510] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):9003358643346748784:14:0)
[12:42:34.548] Build status: STARTED
[12:42:34.548] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):9003358643346748784:15:0) after 1m0s
[12:43:34.582] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):9003358643346748784:15:0)
[12:43:34.623] Build status: STARTED
[12:43:34.623] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):9003358643346748784:16:0) after 4m0s
[12:47:34.827] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):9003358643346748784:16:0)
[12:47:34.951] Build status: STARTED
[12:47:34.951] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):9003358643346748784:17:0) after 2m56s
[12:50:30.980] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):9003358643346748784:17:0)
[12:50:31.011] Build status: STARTED
[12:50:31.011] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):9003358643346748784:18:0) after 1m42s
[12:52:13.032] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):9003358643346748784:18:0)
[12:52:13.079] Build status: STARTED
[12:52:13.079] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):9003358643346748784:19:0) after 4m6s
[12:56:19.106] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):9003358643346748784:19:0)
[12:56:19.170] Build status: STARTED
[12:56:19.170] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):9003358643346748784:20:0) after 3m8s
[12:59:27.245] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):9003358643346748784:20:0)
[12:59:27.275] Build status: STARTED
[12:59:27.275] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):9003358643346748784:21:0) after 6m29s
[13:05:56.279] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):9003358643346748784:21:0)
[13:05:56.311] Build status: STARTED
[13:05:56.311] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):9003358643346748784:22:0) after 9m13s
[13:15:09.439] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):9003358643346748784:22:0)
[13:15:09.484] Build status: STARTED
[13:15:09.484] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):9003358643346748784:23:0) after 9m16s
[13:24:25.509] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):9003358643346748784:23:0)
[13:24:25.535] Build status: STARTED
[13:24:25.535] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):9003358643346748784:24:0) after 3m54s
[13:28:19.663] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):9003358643346748784:24:0)
[13:28:19.707] Build status: STARTED
[13:28:19.707] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):9003358643346748784:25:0) after 8m29s
[13:36:48.829] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):9003358643346748784:25:0)
[13:36:48.859] Build status: STARTED
[13:36:48.859] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):9003358643346748784:26:0) after 5m30s
[13:42:19.384] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):9003358643346748784:26:0)
[13:42:19.423] Build status: STARTED
[13:42:19.423] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):9003358643346748784:27:0) after 4m3s
[13:46:22.448] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):9003358643346748784:27:0)
[13:46:22.491] Build status: STARTED
[13:46:22.491] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):9003358643346748784:28:0) after 7m15s
[13:53:37.629] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):9003358643346748784:28:0)
[13:53:37.666] Build status: STARTED
[13:53:37.666] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):9003358643346748784:29:0) after 5m25s
[13:59:02.687] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):9003358643346748784:29:0)
[13:59:02.875] Build status: STARTED
[13:59:02.875] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):9003358643346748784:30:0) after 1m38s
[14:00:41.014] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):9003358643346748784:30:0)
[14:00:41.056] Build status: STARTED
[14:00:41.056] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):9003358643346748784:31:0) after 6m3s
[14:06:44.137] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):9003358643346748784:31:0)
[14:06:44.185] Build status: STARTED
[14:06:44.185] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):9003358643346748784:32:0) after 4m10s
[14:10:54.221] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):9003358643346748784:32:0)
[14:10:54.248] Build status: STARTED
[14:10:54.248] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):9003358643346748784:33:0) after 1m48s
[14:12:42.271] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):9003358643346748784:33:0)
[14:12:42.304] Build status: STARTED
[14:12:42.304] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):9003358643346748784:34:0) after 5m39s
[14:18:21.328] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):9003358643346748784:34:0)
[14:18:21.354] Build status: STARTED
[14:18:21.354] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):9003358643346748784:35:0) after 1m40s
[14:20:01.396] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):9003358643346748784:35:0)
[14:20:01.427] Build status: STARTED
[14:20:01.427] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):9003358643346748784:36:0) after 1m39s
[14:21:40.453] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):9003358643346748784:36:0)
[14:21:40.491] Build status: STARTED
[14:21:40.491] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):9003358643346748784:37:0) after 6m13s
[14:27:53.516] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):9003358643346748784:37:0)
[14:27:53.573] Build status: STARTED
[14:27:53.574] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):9003358643346748784:38:0) after 3m54s
[14:31:47.623] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):9003358643346748784:38:0)
[14:31:47.682] Build status: STARTED
[14:31:47.682] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):9003358643346748784:39:0) after 3m51s
[14:35:38.697] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):9003358643346748784:39:0)
[14:35:38.731] Build status: STARTED
[14:35:38.731] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):9003358643346748784:40:0) after 4m53s
[14:40:31.752] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):9003358643346748784:40:0)
[14:40:31.818] Build status: STARTED
[14:40:31.818] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):9003358643346748784:41:0) after 9m36s
[14:50:07.844] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):9003358643346748784:41:0)
[14:50:07.876] Build status: STARTED
[14:50:07.876] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):9003358643346748784:42:0) after 2m0s
[14:52:07.911] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):9003358643346748784:42:0)
[14:52:07.957] Build status: STARTED
[14:52:07.957] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):9003358643346748784:43:0) after 9m21s
[15:01:29.058] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):9003358643346748784:43:0)
[15:01:29.114] Build status: STARTED
[15:01:29.114] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):9003358643346748784:44:0) after 1m28s
[15:02:57.293] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):9003358643346748784:44:0)
[15:02:57.325] Build status: STARTED
[15:02:57.325] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):9003358643346748784:45:0) after 9m21s
[15:12:18.470] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):9003358643346748784:45:0)
[15:12:18.504] Build status: STARTED
[15:12:18.504] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):9003358643346748784:46:0) after 3m25s
[15:15:43.559] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):9003358643346748784:46:0)
[15:15:43.590] Build status: STARTED
[15:15:43.590] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):9003358643346748784:47:0) after 6m39s
[15:22:22.712] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):9003358643346748784:47:0)
[15:22:22.772] Build status: STARTED
[15:22:22.772] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):9003358643346748784:48:0) after 7m20s
[15:29:42.857] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):9003358643346748784:48:0)
[15:29:42.889] Build status: STARTED
[15:29:42.889] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):9003358643346748784:49:0) after 7m6s
[15:36:49.321] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):9003358643346748784:49:0)
[15:36:49.357] Build status: STARTED
[15:36:49.357] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):9003358643346748784:50:0) after 1m12s
[15:38:01.454] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):9003358643346748784:50:0)
[15:38:01.488] Build status: STARTED
[15:38:01.488] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):9003358643346748784:51:0) after 3m56s
[15:41:57.511] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):9003358643346748784:51:0)
[15:41:57.566] Build status: STARTED
[15:41:57.566] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):9003358643346748784:52:0) after 2m33s
[15:44:30.565] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):9003358643346748784:52:0)
[15:44:30.595] Build status: STARTED
[15:44:30.595] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):9003358643346748784:53:0) after 9m57s
[15:54:27.618] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):9003358643346748784:53:0)
[15:54:27.652] Build status: STARTED
[15:54:27.652] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):9003358643346748784:54:0) after 7m10s
[16:01:38.176] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):9003358643346748784:54:0)
[16:01:38.376] Build status: STARTED
[16:01:38.376] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):9003358643346748784:55:0) after 4m1s
[16:05:39.432] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):9003358643346748784:55:0)
[16:05:39.466] Build status: STARTED
[16:05:39.466] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):9003358643346748784:56:0) after 9m10s
[16:14:49.738] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):9003358643346748784:56:0)
[16:14:49.780] Build status: STARTED
[16:14:49.780] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):9003358643346748784:57:0) after 5m55s
[16:20:45.048] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):9003358643346748784:57:0)
[16:20:45.161] Build status: STARTED
[16:20:45.161] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):9003358643346748784:58:0) after 5m32s
[16:26:17.402] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):9003358643346748784:58:0)
[16:26:17.428] Build status: STARTED
[16:26:17.428] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):9003358643346748784:59:0) after 5m15s
[16:31:32.810] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):9003358643346748784:59:0)
[16:31:32.841] Build status: STARTED
[16:31:32.841] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):9003358643346748784:60:0) after 1m53s
[16:33:25.999] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):9003358643346748784:60:0)
[16:33:26.079] Build status: STARTED
[16:33:26.079] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):9003358643346748784:61:0) after 5m4s
[16:38:30.308] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):9003358643346748784:61:0)
[16:38:30.361] Build status: STARTED
[16:38:30.361] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):9003358643346748784:62:0) after 4m36s
[16:43:06.394] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):9003358643346748784:62:0)
[16:43:06.427] Build status: STARTED
[16:43:06.427] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):9003358643346748784:63:0) after 9m21s
[16:52:27.689] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):9003358643346748784:63:0)
[16:52:27.726] Build status: STARTED
[16:52:27.726] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):9003358643346748784:64:0) after 4m20s
[16:56:47.738] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):9003358643346748784:64:0)
[16:56:47.775] Build status: STARTED
[16:56:47.775] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):9003358643346748784:65:0) after 3m38s
[17:00:25.898] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):9003358643346748784:65:0)
[17:00:25.974] Build status: STARTED
[17:00:25.974] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):9003358643346748784:66:0) after 2m58s
[17:03:24.149] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):9003358643346748784:66:0)
[17:03:24.180] Build status: STARTED
[17:03:24.180] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):9003358643346748784:67:0) after 7m20s
[17:10:44.338] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):9003358643346748784:67:0)
[17:10:44.370] Build status: STARTED
[17:10:44.370] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):9003358643346748784:68:0) after 9m12s
[17:19:56.395] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):9003358643346748784:68:0)
[17:19:56.426] Build status: STARTED
[17:19:56.426] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):9003358643346748784:69:0) after 6m31s
[17:26:27.751] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):9003358643346748784:69:0)
[17:26:27.873] Build status: STARTED
[17:26:27.873] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):9003358643346748784:70:0) after 3m8s
[17:29:35.976] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):9003358643346748784:70:0)
[17:29:36.015] Build status: STARTED
[17:29:36.015] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):9003358643346748784:71:0) after 1m52s
[17:31:28.255] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):9003358643346748784:71:0)
[17:31:28.287] Build status: STARTED
[17:31:28.287] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):9003358643346748784:72:0) after 7m55s
[17:39:23.488] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):9003358643346748784:72:0)
[17:39:23.520] Build status: STARTED
[17:39:23.520] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):9003358643346748784:73:0) after 7m15s
[17:46:38.652] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):9003358643346748784:73:0)
[17:46:38.711] Build status: STARTED
[17:46:38.711] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):9003358643346748784:74:0) after 4m48s
[17:51:26.992] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):9003358643346748784:74:0)
[17:51:27.027] Build status: STARTED
[17:51:27.027] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):9003358643346748784:75:0) after 7m28s
[17:58:55.173] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):9003358643346748784:75:0)
[17:58:55.208] Build status: STARTED
[17:58:55.208] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):9003358643346748784:76:0) after 7m15s
[18:06:10.281] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):9003358643346748784:76:0)
[18:06:10.311] Build status: STARTED
[18:06:10.311] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):9003358643346748784:77:0) after 3m38s
[18:09:48.688] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):9003358643346748784:77:0)
[18:09:48.718] Build status: STARTED
[18:09:48.718] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):9003358643346748784:78:0) after 8m3s
[18:17:51.909] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):9003358643346748784:78:0)
[18:17:51.951] Build status: STARTED
[18:17:51.951] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):9003358643346748784:79:0) after 4m45s
[18:22:37.491] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):9003358643346748784:79:0)
[18:22:37.528] Build status: STARTED
[18:22:37.528] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):9003358643346748784:80:0) after 5m49s
[18:28:26.874] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):9003358643346748784:80:0)
[18:28:26.917] Build status: STARTED
[18:28:26.917] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):9003358643346748784:81:0) after 9m57s
[18:38:24.007] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):9003358643346748784:81:0)
[18:38:24.034] Build status: STARTED
[18:38:24.034] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):9003358643346748784:82:0) after 9m40s
[18:48:04.267] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):9003358643346748784:82:0)
[18:48:04.296] Build status: STARTED
[18:48:04.296] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):9003358643346748784:83:0) after 2m28s
[18:50:33.130] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):9003358643346748784:83:0)
[18:50:33.265] Build status: STARTED
[18:50:33.265] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):9003358643346748784:84:0) after 2m30s
[18:53:03.297] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):9003358643346748784:84:0)
[18:53:03.344] Build status: STARTED
[18:53:03.344] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):9003358643346748784:85:0) after 1m29s
[18:54:32.370] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):9003358643346748784:85:0)
[18:54:32.399] Build status: STARTED
[18:54:32.399] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):9003358643346748784:86:0) after 1m50s
[18:56:22.450] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):9003358643346748784:86:0)
[18:56:22.487] Build status: STARTED
[18:56:22.487] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):9003358643346748784:87:0) after 5m38s
[19:02:00.810] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):9003358643346748784:87:0)
[19:02:00.859] Build status: STARTED
[19:02:00.859] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):9003358643346748784:88:0) after 7m37s
[19:09:37.895] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):9003358643346748784:88:0)
[19:09:37.940] Build status: STARTED
[19:09:37.940] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):9003358643346748784:89:0) after 4m56s
[19:14:33.983] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):9003358643346748784:89:0)
[19:14:34.028] Build status: STARTED
[19:14:34.028] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):9003358643346748784:90:0) after 3m25s
[19:17:59.056] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):9003358643346748784:90:0)
[19:17:59.086] Build status: STARTED
[19:17:59.086] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):9003358643346748784:91:0) after 1m51s
[19:19:50.116] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):9003358643346748784:91:0)
[19:19:50.232] Build status: STARTED
[19:19:50.232] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):9003358643346748784:92:0) after 5m4s
[19:24:54.664] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):9003358643346748784:92:0)
[19:24:54.699] Build status: STARTED
[19:24:54.699] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):9003358643346748784:93:0) after 5m51s
[19:30:45.766] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):9003358643346748784:93:0)
[19:30:45.809] Build status: STARTED
[19:30:45.809] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):9003358643346748784:94:0) after 9m58s
[19:40:43.928] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):9003358643346748784:94:0)
[19:40:43.954] Build status: STARTED
[19:40:43.954] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):9003358643346748784:95:0) after 6m54s
[19:47:38.736] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):9003358643346748784:95:0)
[19:47:38.766] Build status: STARTED
[19:47:38.766] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):9003358643346748784:96:0) after 2m40s
[19:50:18.820] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):9003358643346748784:96:0)
[19:50:19.066] Build status: STARTED
[19:50:19.066] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):9003358643346748784:97:0) after 5m9s
[19:55:28.330] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):9003358643346748784:97:0)
[19:55:28.366] Build status: STARTED
[19:55:28.366] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):9003358643346748784:98:0) after 5m45s
[20:01:13.422] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):9003358643346748784:98:0)
[20:01:13.477] Build status: STARTED
[20:01:13.477] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):9003358643346748784:99:0) after 6m58s
[20:08:11.522] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):9003358643346748784:99:0)
[20:08:11.560] Build status: STARTED
[20:08:11.560] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):9003358643346748784:100:0) after 2m35s
[20:10:46.812] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):9003358643346748784:100:0)
[20:10:46.861] Build status: STARTED
[20:10:46.862] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):9003358643346748784:101:0) after 9m43s
[20:20:30.391] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):9003358643346748784:101:0)
[20:20:30.480] Build status: STARTED
[20:20:30.480] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):9003358643346748784:102:0) after 3m28s
[20:23:58.810] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):9003358643346748784:102:0)
[20:23:58.847] Build status: STARTED
[20:23:58.847] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):9003358643346748784:103:0) after 3m11s
[20:27:09.886] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):9003358643346748784:103:0)
[20:27:09.917] Build status: STARTED
[20:27:09.917] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):9003358643346748784:104:0) after 7m21s
[20:34:30.992] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):9003358643346748784:104:0)
[20:34:31.096] Build status: STARTED
[20:34:31.096] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):9003358643346748784:105:0) after 4m12s
[20:38:43.167] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):9003358643346748784:105:0)
[20:38:43.202] Build status: STARTED
[20:38:43.202] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):9003358643346748784:106:0) after 9m0s
[20:47:43.269] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):9003358643346748784:106:0)
[20:47:43.305] Build status: STARTED
[20:47:43.305] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):9003358643346748784:107:0) after 7m24s
[20:55:07.376] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):9003358643346748784:107:0)
[20:55:07.421] Build status: STARTED
[20:55:07.421] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):9003358643346748784:108:0) after 3m46s
[20:58:53.460] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):9003358643346748784:108:0)
[20:58:53.489] Build status: STARTED
[20:58:53.489] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):9003358643346748784:109:0) after 8m43s
[20:59:28.648] Received PubSub notification, asking Buildbucket for the build status
[20:59:28.677] Build:
{
"id": "8837928581359668641",
"builder": {
"project": "chromium",
"bucket": "ci",
"builder": "ToTWin(dbg)"
},
"number": 7800,
"createdBy": "project:chromium",
"createTime": "2021-08-25T11:38:43.932754638Z",
"startTime": "2021-08-25T11:50:49.178799Z",
"endTime": "2021-08-25T20:59:28.317447398Z",
"updateTime": "2021-08-25T20:59:28.348348934Z",
"status": "FAILURE",
"input": {
"gitilesCommit": {
"host": "chromium.googlesource.com",
"project": "chromium/src",
"id": "d820a83363a8f94c4b863b3e24d3ce85798f4e7b",
"ref": "refs/heads/main"
}
}
}
[20:59:28.677] Invocation finished in 9h20m46.023954953s with status FAILED