[21:31:20.236] New invocation is queued and will start shortly
[21:31:21.501] Starting the invocation (attempt 1)
[21:31:21.542] Popped buildset tag "buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/94a61a25a605d2fba4b00f50e2c313acbc0033df"
[21:31:21.542] Popped gitiles commit info from properties and tags
[21:31:21.542] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[21:31:21.542] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[21:31:21.542] Buildbucket request:
{
"requestId": "8995801810324579056",
"builder": {
"project": "chromium",
"bucket": "ci",
"builder": "ToTWin(dbg)"
},
"properties": {
},
"gitilesCommit": {
"host": "chromium.googlesource.com",
"project": "chromium/src",
"id": "94a61a25a605d2fba4b00f50e2c313acbc0033df",
"ref": "refs/heads/main"
},
"tags": [
{
"key": "scheduler_invocation_id",
"value": "8995801810324579056"
},
{
"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"
}
}
[21:31:22.100] Scheduled build:
{
"id": "8830371748203509857",
"builder": {
"project": "chromium",
"bucket": "ci",
"builder": "ToTWin(dbg)"
},
"number": 8322,
"createdBy": "project:chromium",
"createTime": "2021-11-16T21:31:21.626210559Z",
"updateTime": "2021-11-16T21:31:21.626210559Z",
"status": "SCHEDULED",
"input": {
"gitilesCommit": {
"host": "chromium.googlesource.com",
"project": "chromium/src",
"id": "94a61a25a605d2fba4b00f50e2c313acbc0033df",
"ref": "refs/heads/main"
}
}
}
[21:31:22.100] Task URL: https://cr-buildbucket.appspot.com/build/8830371748203509857
[21:31:22.100] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8995801810324579056:2:0) after 6m8s
[21:37:30.182] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8995801810324579056:2:0)
[21:37:30.250] Build status: SCHEDULED
[21:37:30.250] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8995801810324579056:3:0) after 8m29s
[21:39:18.012] Received PubSub notification, asking Buildbucket for the build status
[21:39:18.044] Build status: STARTED
[21:45:59.275] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8995801810324579056:3:0)
[21:45:59.375] Build status: STARTED
[21:45:59.375] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8995801810324579056:5:0) after 9m20s
[21:55:19.402] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8995801810324579056:5:0)
[21:55:19.436] Build status: STARTED
[21:55:19.436] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8995801810324579056:6:0) after 2m27s
[21:57:46.613] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8995801810324579056:6:0)
[21:57:46.647] Build status: STARTED
[21:57:46.647] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8995801810324579056:7:0) after 8m56s
[22:06:42.883] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8995801810324579056:7:0)
[22:06:42.951] Build status: STARTED
[22:06:42.951] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8995801810324579056:8:0) after 8m59s
[22:15:41.983] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8995801810324579056:8:0)
[22:15:42.180] Build status: STARTED
[22:15:42.180] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8995801810324579056:9:0) after 7m35s
[22:23:17.205] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8995801810324579056:9:0)
[22:23:17.240] Build status: STARTED
[22:23:17.240] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8995801810324579056:10:0) after 6m36s
[22:29:53.321] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8995801810324579056:10:0)
[22:29:53.359] Build status: STARTED
[22:29:53.359] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8995801810324579056:11:0) after 9m12s
[22:39:05.436] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8995801810324579056:11:0)
[22:39:05.470] Build status: STARTED
[22:39:05.470] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8995801810324579056:12:0) after 9m6s
[22:48:11.495] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8995801810324579056:12:0)
[22:48:11.795] Build status: STARTED
[22:48:11.795] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8995801810324579056:13:0) after 3m10s
[22:51:21.894] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8995801810324579056:13:0)
[22:51:21.924] Build status: STARTED
[22:51:21.924] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8995801810324579056:14:0) after 9m16s
[23:00:37.961] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8995801810324579056:14:0)
[23:00:38.091] Build status: STARTED
[23:00:38.091] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8995801810324579056:15:0) after 4m45s
[23:05:23.119] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8995801810324579056:15:0)
[23:05:23.161] Build status: STARTED
[23:05:23.161] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8995801810324579056:16:0) after 5m34s
[23:10:57.240] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8995801810324579056:16:0)
[23:10:57.270] Build status: STARTED
[23:10:57.270] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8995801810324579056:17:0) after 8m2s
[23:18:59.386] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8995801810324579056:17:0)
[23:18:59.419] Build status: STARTED
[23:18:59.419] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8995801810324579056:18:0) after 1m36s
[23:20:35.516] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8995801810324579056:18:0)
[23:20:35.652] Build status: STARTED
[23:20:35.652] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8995801810324579056:19:0) after 3m18s
[23:23:53.830] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8995801810324579056:19:0)
[23:23:53.865] Build status: STARTED
[23:23:53.865] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8995801810324579056:20:0) after 4m48s
[23:28:41.958] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8995801810324579056:20:0)
[23:28:41.990] Build status: STARTED
[23:28:41.990] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8995801810324579056:21:0) after 8m23s
[23:37:05.099] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8995801810324579056:21:0)
[23:37:05.136] Build status: STARTED
[23:37:05.136] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8995801810324579056:22:0) after 3m2s
[23:40:07.147] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8995801810324579056:22:0)
[23:40:07.188] Build status: STARTED
[23:40:07.188] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8995801810324579056:23:0) after 7m1s
[23:47:08.213] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8995801810324579056:23:0)
[23:47:08.254] Build status: STARTED
[23:47:08.255] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8995801810324579056:24:0) after 7m45s
[23:54:53.282] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8995801810324579056:24:0)
[23:54:53.313] Build status: STARTED
[23:54:53.313] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8995801810324579056:25:0) after 8m31s
[00:03:24.480] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8995801810324579056:25:0)
[00:03:24.518] Build status: STARTED
[00:03:24.518] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8995801810324579056:26:0) after 1m58s
[00:05:22.739] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8995801810324579056:26:0)
[00:05:22.773] Build status: STARTED
[00:05:22.773] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8995801810324579056:27:0) after 8m36s
[00:13:58.996] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8995801810324579056:27:0)
[00:13:59.028] Build status: STARTED
[00:13:59.028] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8995801810324579056:28:0) after 6m45s
[00:20:44.157] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8995801810324579056:28:0)
[00:20:44.192] Build status: STARTED
[00:20:44.192] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8995801810324579056:29:0) after 3m33s
[00:24:17.528] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8995801810324579056:29:0)
[00:24:17.569] Build status: STARTED
[00:24:17.569] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8995801810324579056:30:0) after 1m27s
[00:25:44.609] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8995801810324579056:30:0)
[00:25:44.651] Build status: STARTED
[00:25:44.651] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8995801810324579056:31:0) after 1m7s
[00:26:51.681] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8995801810324579056:31:0)
[00:26:51.736] Build status: STARTED
[00:26:51.736] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8995801810324579056:32:0) after 6m21s
[00:33:12.962] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8995801810324579056:32:0)
[00:33:12.993] Build status: STARTED
[00:33:12.993] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8995801810324579056:33:0) after 5m39s
[00:38:52.029] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8995801810324579056:33:0)
[00:38:52.068] Build status: STARTED
[00:38:52.068] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8995801810324579056:34:0) after 2m10s
[00:41:02.216] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8995801810324579056:34:0)
[00:41:02.260] Build status: STARTED
[00:41:02.260] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8995801810324579056:35:0) after 6m13s
[00:47:15.446] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8995801810324579056:35:0)
[00:47:15.484] Build status: STARTED
[00:47:15.484] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8995801810324579056:36:0) after 6m19s
[00:53:34.509] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8995801810324579056:36:0)
[00:53:34.553] Build status: STARTED
[00:53:34.553] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8995801810324579056:37:0) after 6m12s
[00:59:46.591] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8995801810324579056:37:0)
[00:59:46.620] Build status: STARTED
[00:59:46.620] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8995801810324579056:38:0) after 2m34s
[01:02:20.646] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8995801810324579056:38:0)
[01:02:20.682] Build status: STARTED
[01:02:20.682] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8995801810324579056:39:0) after 8m23s
[01:10:43.711] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8995801810324579056:39:0)
[01:10:43.746] Build status: STARTED
[01:10:43.746] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8995801810324579056:40:0) after 8m28s
[01:19:11.777] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8995801810324579056:40:0)
[01:19:11.870] Build status: STARTED
[01:19:11.870] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8995801810324579056:41:0) after 1m43s
[01:20:55.158] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8995801810324579056:41:0)
[01:20:55.196] Build status: STARTED
[01:20:55.196] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8995801810324579056:42:0) after 9m4s
[01:29:59.220] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8995801810324579056:42:0)
[01:29:59.276] Build status: STARTED
[01:29:59.276] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8995801810324579056:43:0) after 3m28s
[01:33:27.303] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8995801810324579056:43:0)
[01:33:27.336] Build status: STARTED
[01:33:27.336] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8995801810324579056:44:0) after 1m59s
[01:35:26.362] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8995801810324579056:44:0)
[01:35:26.393] Build status: STARTED
[01:35:26.393] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8995801810324579056:45:0) after 3m9s
[01:38:35.411] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8995801810324579056:45:0)
[01:38:35.439] Build status: STARTED
[01:38:35.439] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8995801810324579056:46:0) after 8m44s
[01:47:19.554] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8995801810324579056:46:0)
[01:47:19.604] Build status: STARTED
[01:47:19.604] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8995801810324579056:47:0) after 5m50s
[01:53:09.604] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8995801810324579056:47:0)
[01:53:09.632] Build status: STARTED
[01:53:09.632] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8995801810324579056:48:0) after 9m44s
[02:02:53.918] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8995801810324579056:48:0)
[02:02:53.966] Build status: STARTED
[02:02:53.966] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8995801810324579056:49:0) after 7m43s
[02:10:37.057] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8995801810324579056:49:0)
[02:10:37.177] Build status: STARTED
[02:10:37.177] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8995801810324579056:50:0) after 7m56s
[02:18:33.418] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8995801810324579056:50:0)
[02:18:33.458] Build status: STARTED
[02:18:33.458] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8995801810324579056:51:0) after 6m10s
[02:24:43.484] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8995801810324579056:51:0)
[02:24:43.512] Build status: STARTED
[02:24:43.512] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8995801810324579056:52:0) after 7m4s
[02:31:47.800] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8995801810324579056:52:0)
[02:31:47.925] Build status: STARTED
[02:31:47.925] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8995801810324579056:53:0) after 9m10s
[02:40:58.047] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8995801810324579056:53:0)
[02:40:58.074] Build status: STARTED
[02:40:58.074] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8995801810324579056:54:0) after 2m21s
[02:43:19.202] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8995801810324579056:54:0)
[02:43:19.233] Build status: STARTED
[02:43:19.233] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8995801810324579056:55:0) after 8m41s
[02:52:00.263] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8995801810324579056:55:0)
[02:52:00.291] Build status: STARTED
[02:52:00.291] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8995801810324579056:56:0) after 9m6s
[03:01:06.288] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8995801810324579056:56:0)
[03:01:06.450] Build status: STARTED
[03:01:06.450] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8995801810324579056:57:0) after 7m32s
[03:08:38.713] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8995801810324579056:57:0)
[03:08:38.752] Build status: STARTED
[03:08:38.752] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8995801810324579056:58:0) after 7m13s
[03:15:51.788] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8995801810324579056:58:0)
[03:15:51.819] Build status: STARTED
[03:15:51.819] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8995801810324579056:59:0) after 9m39s
[03:25:31.429] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8995801810324579056:59:0)
[03:25:31.459] Build status: STARTED
[03:25:31.459] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8995801810324579056:60:0) after 7m19s
[03:32:50.687] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8995801810324579056:60:0)
[03:32:50.719] Build status: STARTED
[03:32:50.719] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8995801810324579056:61:0) after 9m12s
[03:42:02.843] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8995801810324579056:61:0)
[03:42:02.875] Build status: STARTED
[03:42:02.875] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8995801810324579056:62:0) after 7m52s
[03:49:55.096] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8995801810324579056:62:0)
[03:49:55.128] Build status: STARTED
[03:49:55.128] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8995801810324579056:63:0) after 7m37s
[03:57:32.217] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8995801810324579056:63:0)
[03:57:32.255] Build status: STARTED
[03:57:32.255] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8995801810324579056:64:0) after 8m47s
[04:06:19.385] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8995801810324579056:64:0)
[04:06:19.423] Build status: STARTED
[04:06:19.423] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8995801810324579056:65:0) after 4m41s
[04:11:00.748] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8995801810324579056:65:0)
[04:11:00.784] Build status: STARTED
[04:11:00.784] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8995801810324579056:66:0) after 9m33s
[04:20:33.826] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8995801810324579056:66:0)
[04:20:33.856] Build status: STARTED
[04:20:33.856] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8995801810324579056:67:0) after 2m11s
[04:22:44.931] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8995801810324579056:67:0)
[04:22:45.031] Build status: STARTED
[04:22:45.031] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8995801810324579056:68:0) after 6m31s
[04:29:16.124] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8995801810324579056:68:0)
[04:29:16.157] Build status: STARTED
[04:29:16.157] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8995801810324579056:69:0) after 3m34s
[04:32:50.230] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8995801810324579056:69:0)
[04:32:50.259] Build status: STARTED
[04:32:50.259] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8995801810324579056:70:0) after 7m30s
[04:40:20.333] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8995801810324579056:70:0)
[04:40:20.400] Build status: STARTED
[04:40:20.400] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8995801810324579056:71:0) after 9m38s
[04:49:58.637] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8995801810324579056:71:0)
[04:49:58.684] Build status: STARTED
[04:49:58.684] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8995801810324579056:72:0) after 5m53s
[04:55:51.696] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8995801810324579056:72:0)
[04:55:51.728] Build status: STARTED
[04:55:51.728] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8995801810324579056:73:0) after 1m29s
[04:57:20.761] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8995801810324579056:73:0)
[04:57:20.794] Build status: STARTED
[04:57:20.794] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8995801810324579056:74:0) after 7m36s
[05:04:56.930] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8995801810324579056:74:0)
[05:04:56.962] Build status: STARTED
[05:04:56.962] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8995801810324579056:75:0) after 2m21s
[05:07:18.055] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8995801810324579056:75:0)
[05:07:18.092] Build status: STARTED
[05:07:18.092] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8995801810324579056:76:0) after 6m2s
[05:13:20.126] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8995801810324579056:76:0)
[05:13:20.160] Build status: STARTED
[05:13:20.160] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8995801810324579056:77:0) after 2m31s
[05:15:51.215] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8995801810324579056:77:0)
[05:15:51.248] Build status: STARTED
[05:15:51.248] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8995801810324579056:78:0) after 4m31s
[05:20:22.279] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8995801810324579056:78:0)
[05:20:22.309] Build status: STARTED
[05:20:22.309] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8995801810324579056:79:0) after 1m2s
[05:21:24.516] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8995801810324579056:79:0)
[05:21:24.565] Build status: STARTED
[05:21:24.565] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8995801810324579056:80:0) after 7m51s
[05:29:15.746] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8995801810324579056:80:0)
[05:29:15.781] Build status: STARTED
[05:29:15.781] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8995801810324579056:81:0) after 3m23s
[05:32:38.809] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8995801810324579056:81:0)
[05:32:39.056] Build status: STARTED
[05:32:39.056] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8995801810324579056:82:0) after 1m54s
[05:34:33.182] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8995801810324579056:82:0)
[05:34:33.284] Build status: STARTED
[05:34:33.284] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8995801810324579056:83:0) after 6m28s
[05:41:01.367] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8995801810324579056:83:0)
[05:41:01.402] Build status: STARTED
[05:41:01.402] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8995801810324579056:84:0) after 2m31s
[05:43:32.381] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8995801810324579056:84:0)
[05:43:32.409] Build status: STARTED
[05:43:32.409] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8995801810324579056:85:0) after 9m41s
[05:53:13.550] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8995801810324579056:85:0)
[05:53:13.580] Build status: STARTED
[05:53:13.580] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8995801810324579056:86:0) after 8m25s
[05:57:42.286] Received PubSub notification, asking Buildbucket for the build status
[05:57:42.317] Build:
{
"id": "8830371748203509857",
"builder": {
"project": "chromium",
"bucket": "ci",
"builder": "ToTWin(dbg)"
},
"number": 8322,
"createdBy": "project:chromium",
"createTime": "2021-11-16T21:31:21.626210559Z",
"startTime": "2021-11-16T21:39:16.429469Z",
"endTime": "2021-11-17T05:57:41.888848583Z",
"updateTime": "2021-11-17T05:57:41.888848583Z",
"status": "FAILURE",
"input": {
"gitilesCommit": {
"host": "chromium.googlesource.com",
"project": "chromium/src",
"id": "94a61a25a605d2fba4b00f50e2c313acbc0033df",
"ref": "refs/heads/main"
}
}
}
[05:57:42.318] Invocation finished in 8h26m22.097681701s with status FAILED