[05:12:50.086] New invocation is queued and will start shortly
[05:12:51.122] Starting the invocation (attempt 1)
[05:12:51.157] Popped buildset tag "buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/52a52db9b920decf92247cc1f5c418fd2cb3ee10"
[05:12:51.157] Popped gitiles commit info from properties and tags
[05:12:51.157] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[05:12:51.157] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[05:12:51.158] Buildbucket request:
{
"requestId": "8986984869670326976",
"builder": {
"project": "chromium",
"bucket": "ci",
"builder": "ToTWin(dbg)"
},
"properties": {
},
"gitilesCommit": {
"host": "chromium.googlesource.com",
"project": "chromium/src",
"id": "52a52db9b920decf92247cc1f5c418fd2cb3ee10",
"ref": "refs/heads/main"
},
"tags": [
{
"key": "scheduler_invocation_id",
"value": "8986984869670326976"
},
{
"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"
}
}
[05:12:51.713] Scheduled build:
{
"id": "8821554807817757745",
"builder": {
"project": "chromium",
"bucket": "ci",
"builder": "ToTWin(dbg)"
},
"number": 8762,
"createdBy": "project:chromium",
"createTime": "2022-02-22T05:12:51.222222863Z",
"updateTime": "2022-02-22T05:12:51.222222863Z",
"status": "SCHEDULED",
"input": {
"gitilesCommit": {
"host": "chromium.googlesource.com",
"project": "chromium/src",
"id": "52a52db9b920decf92247cc1f5c418fd2cb3ee10",
"ref": "refs/heads/main"
}
}
}
[05:12:51.713] Task URL: https://cr-buildbucket.appspot.com/build/8821554807817757745
[05:12:51.713] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8986984869670326976:2:0) after 2m55s
[05:15:46.766] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8986984869670326976:2:0)
[05:15:46.785] Build status: SCHEDULED
[05:15:46.785] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8986984869670326976:3:0) after 4m10s
[05:17:24.551] Received PubSub notification, asking Buildbucket for the build status
[05:17:25.055] Build status: STARTED
[05:19:57.011] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8986984869670326976:3:0)
[05:19:57.031] Build status: STARTED
[05:19:57.031] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8986984869670326976:5:0) after 4m11s
[05:24:08.127] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8986984869670326976:5:0)
[05:24:08.145] Build status: STARTED
[05:24:08.145] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8986984869670326976:6:0) after 6m1s
[05:30:09.162] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8986984869670326976:6:0)
[05:30:09.279] Build status: STARTED
[05:30:09.279] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8986984869670326976:7:0) after 2m52s
[05:33:01.365] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8986984869670326976:7:0)
[05:33:01.397] Build status: STARTED
[05:33:01.397] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8986984869670326976:8:0) after 1m56s
[05:34:57.430] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8986984869670326976:8:0)
[05:34:57.448] Build status: STARTED
[05:34:57.448] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8986984869670326976:9:0) after 5m6s
[05:40:03.468] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8986984869670326976:9:0)
[05:40:03.645] Build status: STARTED
[05:40:03.645] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8986984869670326976:10:0) after 4m55s
[05:44:58.644] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8986984869670326976:10:0)
[05:44:58.662] Build status: STARTED
[05:44:58.662] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8986984869670326976:11:0) after 3m41s
[05:48:39.794] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8986984869670326976:11:0)
[05:48:39.813] Build status: STARTED
[05:48:39.813] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8986984869670326976:12:0) after 6m32s
[05:55:11.832] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8986984869670326976:12:0)
[05:55:11.853] Build status: STARTED
[05:55:11.853] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8986984869670326976:13:0) after 6m37s
[06:01:49.000] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8986984869670326976:13:0)
[06:01:49.019] Build status: STARTED
[06:01:49.019] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8986984869670326976:14:0) after 4m36s
[06:06:25.091] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8986984869670326976:14:0)
[06:06:25.111] Build status: STARTED
[06:06:25.111] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8986984869670326976:15:0) after 5m15s
[06:11:40.115] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8986984869670326976:15:0)
[06:11:40.139] Build status: STARTED
[06:11:40.139] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8986984869670326976:16:0) after 6m13s
[06:17:53.259] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8986984869670326976:16:0)
[06:17:53.288] Build status: STARTED
[06:17:53.288] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8986984869670326976:17:0) after 9m45s
[06:27:38.408] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8986984869670326976:17:0)
[06:27:38.469] Build status: STARTED
[06:27:38.469] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8986984869670326976:18:0) after 4m14s
[06:31:52.488] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8986984869670326976:18:0)
[06:31:52.520] Build status: STARTED
[06:31:52.520] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8986984869670326976:19:0) after 6m16s
[06:38:08.563] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8986984869670326976:19:0)
[06:38:08.581] Build status: STARTED
[06:38:08.581] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8986984869670326976:20:0) after 6m44s
[06:44:52.789] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8986984869670326976:20:0)
[06:44:52.849] Build status: STARTED
[06:44:52.849] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8986984869670326976:21:0) after 3m50s
[06:48:43.247] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8986984869670326976:21:0)
[06:48:43.278] Build status: STARTED
[06:48:43.278] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8986984869670326976:22:0) after 7m51s
[06:56:34.337] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8986984869670326976:22:0)
[06:56:34.356] Build status: STARTED
[06:56:34.356] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8986984869670326976:23:0) after 8m18s
[07:04:52.511] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8986984869670326976:23:0)
[07:04:52.530] Build status: STARTED
[07:04:52.530] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8986984869670326976:24:0) after 9m54s
[07:14:46.784] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8986984869670326976:24:0)
[07:14:46.802] Build status: STARTED
[07:14:46.802] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8986984869670326976:25:0) after 9m17s
[07:24:04.131] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8986984869670326976:25:0)
[07:24:04.161] Build status: STARTED
[07:24:04.161] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8986984869670326976:26:0) after 4m55s
[07:28:59.159] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8986984869670326976:26:0)
[07:28:59.177] Build status: STARTED
[07:28:59.177] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8986984869670326976:27:0) after 2m28s
[07:31:27.293] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8986984869670326976:27:0)
[07:31:27.361] Build status: STARTED
[07:31:27.361] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8986984869670326976:28:0) after 8m52s
[07:40:20.076] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8986984869670326976:28:0)
[07:40:20.098] Build status: STARTED
[07:40:20.098] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8986984869670326976:29:0) after 5m59s
[07:46:19.135] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8986984869670326976:29:0)
[07:46:19.172] Build status: STARTED
[07:46:19.172] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8986984869670326976:30:0) after 2m18s
[07:48:37.271] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8986984869670326976:30:0)
[07:48:37.292] Build status: STARTED
[07:48:37.292] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8986984869670326976:31:0) after 4m8s
[07:52:45.311] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8986984869670326976:31:0)
[07:52:45.337] Build status: STARTED
[07:52:45.337] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8986984869670326976:32:0) after 7m37s
[08:00:22.388] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8986984869670326976:32:0)
[08:00:22.446] Build status: STARTED
[08:00:22.446] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8986984869670326976:33:0) after 6m3s
[08:06:25.467] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8986984869670326976:33:0)
[08:06:25.493] Build status: STARTED
[08:06:25.493] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8986984869670326976:34:0) after 1m48s
[08:08:13.515] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8986984869670326976:34:0)
[08:08:13.543] Build status: STARTED
[08:08:13.543] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8986984869670326976:35:0) after 2m53s
[08:11:06.556] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8986984869670326976:35:0)
[08:11:06.576] Build status: STARTED
[08:11:06.576] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8986984869670326976:36:0) after 3m12s
[08:14:18.597] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8986984869670326976:36:0)
[08:14:18.631] Build status: STARTED
[08:14:18.631] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8986984869670326976:37:0) after 8m16s
[08:22:34.652] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8986984869670326976:37:0)
[08:22:34.674] Build status: STARTED
[08:22:34.674] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8986984869670326976:38:0) after 7m1s
[08:29:35.696] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8986984869670326976:38:0)
[08:29:35.717] Build status: STARTED
[08:29:35.717] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8986984869670326976:39:0) after 3m44s
[08:33:19.745] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8986984869670326976:39:0)
[08:33:19.885] Build status: STARTED
[08:33:19.885] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8986984869670326976:40:0) after 2m10s
[08:35:29.907] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8986984869670326976:40:0)
[08:35:29.929] Build status: STARTED
[08:35:29.929] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8986984869670326976:41:0) after 4m32s
[08:40:01.951] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8986984869670326976:41:0)
[08:40:01.981] Build status: STARTED
[08:40:01.981] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8986984869670326976:42:0) after 6m33s
[08:46:35.083] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8986984869670326976:42:0)
[08:46:35.106] Build status: STARTED
[08:46:35.106] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8986984869670326976:43:0) after 8m19s
[08:54:54.129] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8986984869670326976:43:0)
[08:54:54.152] Build status: STARTED
[08:54:54.152] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8986984869670326976:44:0) after 1m38s
[08:56:32.172] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8986984869670326976:44:0)
[08:56:32.194] Build status: STARTED
[08:56:32.194] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8986984869670326976:45:0) after 6m3s
[09:02:35.220] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8986984869670326976:45:0)
[09:02:35.264] Build status: STARTED
[09:02:35.264] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8986984869670326976:46:0) after 8m39s
[09:11:14.344] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8986984869670326976:46:0)
[09:11:14.364] Build status: STARTED
[09:11:14.364] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8986984869670326976:47:0) after 3m32s
[09:14:46.381] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8986984869670326976:47:0)
[09:14:46.407] Build status: STARTED
[09:14:46.407] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8986984869670326976:48:0) after 5m15s
[09:20:01.549] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8986984869670326976:48:0)
[09:20:01.570] Build status: STARTED
[09:20:01.570] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8986984869670326976:49:0) after 6m48s
[09:26:49.591] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8986984869670326976:49:0)
[09:26:49.616] Build status: STARTED
[09:26:49.616] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8986984869670326976:50:0) after 4m46s
[09:31:35.662] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8986984869670326976:50:0)
[09:31:35.726] Build status: STARTED
[09:31:35.726] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8986984869670326976:51:0) after 6m16s
[09:37:51.749] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8986984869670326976:51:0)
[09:37:51.771] Build status: STARTED
[09:37:51.771] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8986984869670326976:52:0) after 4m2s
[09:41:53.792] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8986984869670326976:52:0)
[09:41:53.820] Build status: STARTED
[09:41:53.820] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8986984869670326976:53:0) after 7m58s
[09:49:51.923] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8986984869670326976:53:0)
[09:49:51.946] Build status: STARTED
[09:49:51.946] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8986984869670326976:54:0) after 3m28s
[09:53:19.975] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8986984869670326976:54:0)
[09:53:19.999] Build status: STARTED
[09:53:20.000] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8986984869670326976:55:0) after 9m0s
[10:02:20.025] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8986984869670326976:55:0)
[10:02:20.049] Build status: STARTED
[10:02:20.049] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8986984869670326976:56:0) after 4m35s
[10:06:55.070] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8986984869670326976:56:0)
[10:06:55.097] Build status: STARTED
[10:06:55.097] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8986984869670326976:57:0) after 8m9s
[10:15:04.285] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8986984869670326976:57:0)
[10:15:04.351] Build status: STARTED
[10:15:04.351] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8986984869670326976:58:0) after 9m25s
[10:24:29.370] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8986984869670326976:58:0)
[10:24:29.400] Build status: STARTED
[10:24:29.400] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8986984869670326976:59:0) after 9m55s
[10:34:24.514] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8986984869670326976:59:0)
[10:34:24.558] Build status: STARTED
[10:34:24.558] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8986984869670326976:60:0) after 2m53s
[10:37:17.804] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8986984869670326976:60:0)
[10:37:17.834] Build status: STARTED
[10:37:17.834] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8986984869670326976:61:0) after 3m42s
[10:40:59.855] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8986984869670326976:61:0)
[10:40:59.878] Build status: STARTED
[10:40:59.878] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8986984869670326976:62:0) after 3m9s
[10:44:08.937] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8986984869670326976:62:0)
[10:44:08.981] Build status: STARTED
[10:44:08.981] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8986984869670326976:63:0) after 4m26s
[10:48:35.068] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8986984869670326976:63:0)
[10:48:35.090] Build status: STARTED
[10:48:35.090] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8986984869670326976:64:0) after 5m16s
[10:53:51.121] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8986984869670326976:64:0)
[10:53:51.144] Build status: STARTED
[10:53:51.144] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8986984869670326976:65:0) after 2m26s
[10:56:17.171] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8986984869670326976:65:0)
[10:56:17.192] Build status: STARTED
[10:56:17.192] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8986984869670326976:66:0) after 5m52s
[11:02:09.315] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8986984869670326976:66:0)
[11:02:09.337] Build status: STARTED
[11:02:09.337] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8986984869670326976:67:0) after 9m35s
[11:11:44.593] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8986984869670326976:67:0)
[11:11:44.610] Build status: STARTED
[11:11:44.610] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8986984869670326976:68:0) after 7m34s
[11:19:18.729] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8986984869670326976:68:0)
[11:19:18.753] Build status: STARTED
[11:19:18.753] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8986984869670326976:69:0) after 4m59s
[11:24:17.840] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8986984869670326976:69:0)
[11:24:17.863] Build status: STARTED
[11:24:17.863] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8986984869670326976:70:0) after 8m55s
[11:33:12.975] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8986984869670326976:70:0)
[11:33:12.994] Build status: STARTED
[11:33:12.994] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8986984869670326976:71:0) after 2m9s
[11:35:22.017] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8986984869670326976:71:0)
[11:35:22.037] Build status: STARTED
[11:35:22.037] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8986984869670326976:72:0) after 4m5s
[11:39:27.311] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8986984869670326976:72:0)
[11:39:27.373] Build status: STARTED
[11:39:27.373] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8986984869670326976:73:0) after 8m44s
[11:48:11.399] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8986984869670326976:73:0)
[11:48:11.434] Build status: STARTED
[11:48:11.434] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8986984869670326976:74:0) after 2m55s
[11:51:06.724] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8986984869670326976:74:0)
[11:51:06.745] Build status: STARTED
[11:51:06.745] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8986984869670326976:75:0) after 6m15s
[11:57:21.772] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8986984869670326976:75:0)
[11:57:21.794] Build status: STARTED
[11:57:21.794] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8986984869670326976:76:0) after 2m12s
[11:59:33.816] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8986984869670326976:76:0)
[11:59:33.838] Build status: STARTED
[11:59:33.838] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8986984869670326976:77:0) after 1m27s
[12:01:00.858] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8986984869670326976:77:0)
[12:01:00.893] Build status: STARTED
[12:01:00.893] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8986984869670326976:78:0) after 7m20s
[12:08:20.916] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8986984869670326976:78:0)
[12:08:20.953] Build status: STARTED
[12:08:20.953] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8986984869670326976:79:0) after 7m24s
[12:15:45.245] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8986984869670326976:79:0)
[12:15:45.407] Build status: STARTED
[12:15:45.407] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8986984869670326976:80:0) after 9m20s
[12:25:05.657] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8986984869670326976:80:0)
[12:25:05.688] Build status: STARTED
[12:25:05.688] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8986984869670326976:81:0) after 1m32s
[12:26:37.853] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8986984869670326976:81:0)
[12:26:37.874] Build status: STARTED
[12:26:37.874] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8986984869670326976:82:0) after 2m35s
[12:29:12.895] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8986984869670326976:82:0)
[12:29:12.924] Build status: STARTED
[12:29:12.924] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8986984869670326976:83:0) after 9m59s
[12:39:12.195] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8986984869670326976:83:0)
[12:39:12.295] Build status: STARTED
[12:39:12.295] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8986984869670326976:84:0) after 2m35s
[12:41:47.351] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8986984869670326976:84:0)
[12:41:47.378] Build status: STARTED
[12:41:47.378] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8986984869670326976:85:0) after 1m46s
[12:43:33.702] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8986984869670326976:85:0)
[12:43:33.763] Build status: STARTED
[12:43:33.763] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8986984869670326976:86:0) after 7m34s
[12:51:07.786] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8986984869670326976:86:0)
[12:51:07.945] Build status: STARTED
[12:51:07.945] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8986984869670326976:87:0) after 2m34s
[12:53:41.986] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8986984869670326976:87:0)
[12:53:42.008] Build status: STARTED
[12:53:42.008] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8986984869670326976:88:0) after 5m17s
[12:58:59.075] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8986984869670326976:88:0)
[12:58:59.121] Build status: STARTED
[12:58:59.121] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8986984869670326976:89:0) after 4m24s
[13:03:23.136] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8986984869670326976:89:0)
[13:03:23.160] Build status: STARTED
[13:03:23.160] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8986984869670326976:90:0) after 8m41s
[13:12:04.187] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8986984869670326976:90:0)
[13:12:04.210] Build status: STARTED
[13:12:04.210] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8986984869670326976:91:0) after 9m15s
[13:21:19.250] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8986984869670326976:91:0)
[13:21:19.371] Build status: STARTED
[13:21:19.371] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8986984869670326976:92:0) after 4m8s
[13:25:27.422] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8986984869670326976:92:0)
[13:25:27.453] Build status: STARTED
[13:25:27.453] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8986984869670326976:93:0) after 8m47s
[13:34:14.665] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8986984869670326976:93:0)
[13:34:14.687] Build status: STARTED
[13:34:14.687] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8986984869670326976:94:0) after 7m14s
[13:41:28.974] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8986984869670326976:94:0)
[13:41:28.998] Build status: STARTED
[13:41:28.998] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8986984869670326976:95:0) after 3m46s
[13:45:15.150] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8986984869670326976:95:0)
[13:45:15.173] Build status: STARTED
[13:45:15.173] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8986984869670326976:96:0) after 7m34s
[13:52:49.498] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8986984869670326976:96:0)
[13:52:49.539] Build status: STARTED
[13:52:49.539] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8986984869670326976:97:0) after 2m51s
[13:55:40.561] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8986984869670326976:97:0)
[13:55:40.589] Build status: STARTED
[13:55:40.589] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8986984869670326976:98:0) after 4m9s
[13:59:49.612] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8986984869670326976:98:0)
[13:59:49.652] Build status: STARTED
[13:59:49.652] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8986984869670326976:99:0) after 7m30s
[14:07:19.677] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8986984869670326976:99:0)
[14:07:19.712] Build status: STARTED
[14:07:19.712] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8986984869670326976:100:0) after 7m22s
[14:11:29.230] Received PubSub notification, asking Buildbucket for the build status
[14:11:29.274] Build:
{
"id": "8821554807817757745",
"builder": {
"project": "chromium",
"bucket": "ci",
"builder": "ToTWin(dbg)"
},
"number": 8762,
"createdBy": "project:chromium",
"createTime": "2022-02-22T05:12:51.222222863Z",
"startTime": "2022-02-22T05:17:23.598946Z",
"endTime": "2022-02-22T14:11:28.197719652Z",
"updateTime": "2022-02-22T14:11:28.197719652Z",
"status": "FAILURE",
"input": {
"gitilesCommit": {
"host": "chromium.googlesource.com",
"project": "chromium/src",
"id": "52a52db9b920decf92247cc1f5c418fd2cb3ee10",
"ref": "refs/heads/main"
}
}
}
[14:11:29.274] Invocation finished in 8h58m39.202791461s with status FAILED