[04:34:30.396] New invocation is queued and will start shortly
[04:34:31.514] Starting the invocation (attempt 1)
[04:34:31.559] Popped buildset tag "buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/3e9ba9bd5eb44106f06452aeebaaf2e6a09d9452"
[04:34:31.559] Popped gitiles commit info from properties and tags
[04:34:31.559] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[04:34:31.559] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[04:34:31.559] Buildbucket request:
{
"requestId": "8994235038382317424",
"builder": {
"project": "chromium",
"bucket": "ci",
"builder": "ToTWin(dbg)"
},
"properties": {
},
"gitilesCommit": {
"host": "chromium.googlesource.com",
"project": "chromium/src",
"id": "3e9ba9bd5eb44106f06452aeebaaf2e6a09d9452",
"ref": "refs/heads/main"
},
"tags": [
{
"key": "scheduler_invocation_id",
"value": "8994235038382317424"
},
{
"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"
}
}
[04:34:32.045] Scheduled build:
{
"id": "8828804976429462977",
"builder": {
"project": "chromium",
"bucket": "ci",
"builder": "ToTWin(dbg)"
},
"number": 8377,
"createdBy": "project:chromium",
"createTime": "2021-12-04T04:34:31.627459934Z",
"updateTime": "2021-12-04T04:34:31.627459934Z",
"status": "SCHEDULED",
"input": {
"gitilesCommit": {
"host": "chromium.googlesource.com",
"project": "chromium/src",
"id": "3e9ba9bd5eb44106f06452aeebaaf2e6a09d9452",
"ref": "refs/heads/main"
}
}
}
[04:34:32.045] Task URL: https://cr-buildbucket.appspot.com/build/8828804976429462977
[04:34:32.045] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8994235038382317424:2:0) after 8m44s
[04:41:15.358] Received PubSub notification, asking Buildbucket for the build status
[04:41:15.678] Build status: STARTED
[04:43:16.179] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8994235038382317424:2:0)
[04:43:16.207] Build status: STARTED
[04:43:16.207] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8994235038382317424:4:0) after 5m51s
[04:49:07.232] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8994235038382317424:4:0)
[04:49:07.278] Build status: STARTED
[04:49:07.278] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8994235038382317424:5:0) after 9m33s
[04:58:40.339] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8994235038382317424:5:0)
[04:58:40.390] Build status: STARTED
[04:58:40.390] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8994235038382317424:6:0) after 1m37s
[05:00:17.518] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8994235038382317424:6:0)
[05:00:17.571] Build status: STARTED
[05:00:17.571] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8994235038382317424:7:0) after 7m5s
[05:07:22.696] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8994235038382317424:7:0)
[05:07:22.725] Build status: STARTED
[05:07:22.725] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8994235038382317424:8:0) after 3m27s
[05:10:49.754] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8994235038382317424:8:0)
[05:10:49.787] Build status: STARTED
[05:10:49.787] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8994235038382317424:9:0) after 1m0s
[05:11:49.869] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8994235038382317424:9:0)
[05:11:49.901] Build status: STARTED
[05:11:49.901] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8994235038382317424:10:0) after 4m38s
[05:16:28.042] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8994235038382317424:10:0)
[05:16:28.076] Build status: STARTED
[05:16:28.076] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8994235038382317424:11:0) after 4m14s
[05:20:42.217] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8994235038382317424:11:0)
[05:20:42.252] Build status: STARTED
[05:20:42.252] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8994235038382317424:12:0) after 2m48s
[05:23:30.430] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8994235038382317424:12:0)
[05:23:30.462] Build status: STARTED
[05:23:30.463] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8994235038382317424:13:0) after 9m29s
[05:32:59.490] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8994235038382317424:13:0)
[05:32:59.526] Build status: STARTED
[05:32:59.526] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8994235038382317424:14:0) after 3m54s
[05:36:53.550] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8994235038382317424:14:0)
[05:36:53.676] Build status: STARTED
[05:36:53.676] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8994235038382317424:15:0) after 5m34s
[05:42:27.705] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8994235038382317424:15:0)
[05:42:27.739] Build status: STARTED
[05:42:27.739] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8994235038382317424:16:0) after 8m30s
[05:50:57.778] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8994235038382317424:16:0)
[05:50:57.815] Build status: STARTED
[05:50:57.815] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8994235038382317424:17:0) after 2m36s
[05:53:33.840] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8994235038382317424:17:0)
[05:53:33.878] Build status: STARTED
[05:53:33.878] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8994235038382317424:18:0) after 4m13s
[05:57:46.960] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8994235038382317424:18:0)
[05:57:46.988] Build status: STARTED
[05:57:46.988] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8994235038382317424:19:0) after 8m58s
[06:06:45.115] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8994235038382317424:19:0)
[06:06:45.159] Build status: STARTED
[06:06:45.159] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8994235038382317424:20:0) after 1m56s
[06:08:41.183] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8994235038382317424:20:0)
[06:08:41.211] Build status: STARTED
[06:08:41.211] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8994235038382317424:21:0) after 7m16s
[06:15:57.418] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8994235038382317424:21:0)
[06:15:57.449] Build status: STARTED
[06:15:57.449] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8994235038382317424:22:0) after 8m10s
[06:24:07.472] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8994235038382317424:22:0)
[06:24:07.504] Build status: STARTED
[06:24:07.504] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8994235038382317424:23:0) after 3m18s
[06:27:25.587] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8994235038382317424:23:0)
[06:27:25.616] Build status: STARTED
[06:27:25.616] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8994235038382317424:24:0) after 8m38s
[06:36:03.788] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8994235038382317424:24:0)
[06:36:03.819] Build status: STARTED
[06:36:03.819] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8994235038382317424:25:0) after 9m19s
[06:45:22.855] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8994235038382317424:25:0)
[06:45:22.887] Build status: STARTED
[06:45:22.887] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8994235038382317424:26:0) after 3m30s
[06:48:52.913] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8994235038382317424:26:0)
[06:48:52.963] Build status: STARTED
[06:48:52.963] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8994235038382317424:27:0) after 4m8s
[06:53:00.994] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8994235038382317424:27:0)
[06:53:01.030] Build status: STARTED
[06:53:01.030] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8994235038382317424:28:0) after 9m50s
[07:02:51.057] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8994235038382317424:28:0)
[07:02:51.089] Build status: STARTED
[07:02:51.089] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8994235038382317424:29:0) after 2m2s
[07:04:53.133] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8994235038382317424:29:0)
[07:04:53.164] Build status: STARTED
[07:04:53.164] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8994235038382317424:30:0) after 8m6s
[07:12:59.349] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8994235038382317424:30:0)
[07:12:59.407] Build status: STARTED
[07:12:59.407] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8994235038382317424:31:0) after 1m33s
[07:14:32.438] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8994235038382317424:31:0)
[07:14:32.476] Build status: STARTED
[07:14:32.476] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8994235038382317424:32:0) after 5m41s
[07:20:13.502] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8994235038382317424:32:0)
[07:20:13.528] Build status: STARTED
[07:20:13.528] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8994235038382317424:33:0) after 3m29s
[07:23:42.691] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8994235038382317424:33:0)
[07:23:42.763] Build status: STARTED
[07:23:42.763] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8994235038382317424:34:0) after 8m35s
[07:32:17.790] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8994235038382317424:34:0)
[07:32:17.845] Build status: STARTED
[07:32:17.845] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8994235038382317424:35:0) after 6m19s
[07:38:36.921] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8994235038382317424:35:0)
[07:38:36.954] Build status: STARTED
[07:38:36.954] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8994235038382317424:36:0) after 7m51s
[07:46:27.956] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8994235038382317424:36:0)
[07:46:27.986] Build status: STARTED
[07:46:27.986] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8994235038382317424:37:0) after 1m53s
[07:48:21.025] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8994235038382317424:37:0)
[07:48:21.056] Build status: STARTED
[07:48:21.056] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8994235038382317424:38:0) after 8m54s
[07:57:15.211] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8994235038382317424:38:0)
[07:57:15.363] Build status: STARTED
[07:57:15.363] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8994235038382317424:39:0) after 2m59s
[08:00:14.482] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8994235038382317424:39:0)
[08:00:14.520] Build status: STARTED
[08:00:14.520] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8994235038382317424:40:0) after 2m21s
[08:02:35.548] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8994235038382317424:40:0)
[08:02:35.581] Build status: STARTED
[08:02:35.581] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8994235038382317424:41:0) after 6m33s
[08:09:08.710] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8994235038382317424:41:0)
[08:09:08.739] Build status: STARTED
[08:09:08.739] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8994235038382317424:42:0) after 8m14s
[08:17:22.766] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8994235038382317424:42:0)
[08:17:22.803] Build status: STARTED
[08:17:22.803] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8994235038382317424:43:0) after 3m19s
[08:20:41.838] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8994235038382317424:43:0)
[08:20:41.867] Build status: STARTED
[08:20:41.867] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8994235038382317424:44:0) after 8m40s
[08:29:21.911] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8994235038382317424:44:0)
[08:29:21.941] Build status: STARTED
[08:29:21.941] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8994235038382317424:45:0) after 4m12s
[08:33:33.968] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8994235038382317424:45:0)
[08:33:34.056] Build status: STARTED
[08:33:34.056] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8994235038382317424:46:0) after 9m55s
[08:43:29.116] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8994235038382317424:46:0)
[08:43:29.148] Build status: STARTED
[08:43:29.148] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8994235038382317424:47:0) after 2m38s
[08:46:07.478] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8994235038382317424:47:0)
[08:46:07.508] Build status: STARTED
[08:46:07.508] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8994235038382317424:48:0) after 1m17s
[08:47:24.678] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8994235038382317424:48:0)
[08:47:24.735] Build status: STARTED
[08:47:24.735] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8994235038382317424:49:0) after 1m25s
[08:48:49.861] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8994235038382317424:49:0)
[08:48:49.890] Build status: STARTED
[08:48:49.890] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8994235038382317424:50:0) after 7m39s
[08:56:28.917] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8994235038382317424:50:0)
[08:56:29.007] Build status: STARTED
[08:56:29.007] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8994235038382317424:51:0) after 6m21s
[09:02:50.049] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8994235038382317424:51:0)
[09:02:50.084] Build status: STARTED
[09:02:50.084] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8994235038382317424:52:0) after 1m50s
[09:04:40.110] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8994235038382317424:52:0)
[09:04:40.142] Build status: STARTED
[09:04:40.142] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8994235038382317424:53:0) after 7m7s
[09:11:47.231] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8994235038382317424:53:0)
[09:11:47.264] Build status: STARTED
[09:11:47.264] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8994235038382317424:54:0) after 3m1s
[09:14:48.340] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8994235038382317424:54:0)
[09:14:48.373] Build status: STARTED
[09:14:48.373] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8994235038382317424:55:0) after 8m31s
[09:23:19.417] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8994235038382317424:55:0)
[09:23:19.478] Build status: STARTED
[09:23:19.478] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8994235038382317424:56:0) after 1m2s
[09:24:21.711] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8994235038382317424:56:0)
[09:24:21.745] Build status: STARTED
[09:24:21.745] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8994235038382317424:57:0) after 4m39s
[09:29:00.895] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8994235038382317424:57:0)
[09:29:00.925] Build status: STARTED
[09:29:00.925] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8994235038382317424:58:0) after 7m0s
[09:36:00.957] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8994235038382317424:58:0)
[09:36:00.985] Build status: STARTED
[09:36:00.985] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8994235038382317424:59:0) after 4m53s
[09:40:54.629] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8994235038382317424:59:0)
[09:40:54.668] Build status: STARTED
[09:40:54.668] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8994235038382317424:60:0) after 4m5s
[09:44:59.940] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8994235038382317424:60:0)
[09:44:59.981] Build status: STARTED
[09:44:59.981] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8994235038382317424:61:0) after 5m59s
[09:50:59.121] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8994235038382317424:61:0)
[09:50:59.165] Build status: STARTED
[09:50:59.165] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8994235038382317424:62:0) after 7m55s
[09:58:54.371] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8994235038382317424:62:0)
[09:58:54.404] Build status: STARTED
[09:58:54.404] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8994235038382317424:63:0) after 5m16s
[10:04:10.921] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8994235038382317424:63:0)
[10:04:10.950] Build status: STARTED
[10:04:10.950] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8994235038382317424:64:0) after 1m53s
[10:06:03.986] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8994235038382317424:64:0)
[10:06:04.015] Build status: STARTED
[10:06:04.015] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8994235038382317424:65:0) after 6m7s
[10:12:11.361] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8994235038382317424:65:0)
[10:12:11.397] Build status: STARTED
[10:12:11.397] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8994235038382317424:66:0) after 9m22s
[10:21:33.521] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8994235038382317424:66:0)
[10:21:33.553] Build status: STARTED
[10:21:33.553] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8994235038382317424:67:0) after 1m34s
[10:23:07.681] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8994235038382317424:67:0)
[10:23:07.711] Build status: STARTED
[10:23:07.711] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8994235038382317424:68:0) after 6m59s
[10:30:06.739] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8994235038382317424:68:0)
[10:30:06.788] Build status: STARTED
[10:30:06.788] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8994235038382317424:69:0) after 1m44s
[10:31:50.828] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8994235038382317424:69:0)
[10:31:50.877] Build status: STARTED
[10:31:50.877] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8994235038382317424:70:0) after 5m16s
[10:37:07.438] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8994235038382317424:70:0)
[10:37:07.468] Build status: STARTED
[10:37:07.468] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8994235038382317424:71:0) after 1m45s
[10:38:52.506] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8994235038382317424:71:0)
[10:38:52.543] Build status: STARTED
[10:38:52.543] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8994235038382317424:72:0) after 7m20s
[10:46:12.591] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8994235038382317424:72:0)
[10:46:12.622] Build status: STARTED
[10:46:12.622] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8994235038382317424:73:0) after 2m22s
[10:48:34.650] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8994235038382317424:73:0)
[10:48:34.688] Build status: STARTED
[10:48:34.688] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8994235038382317424:74:0) after 4m15s
[10:52:49.801] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8994235038382317424:74:0)
[10:52:49.831] Build status: STARTED
[10:52:49.831] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8994235038382317424:75:0) after 8m36s
[11:01:26.007] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8994235038382317424:75:0)
[11:01:26.062] Build status: STARTED
[11:01:26.062] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8994235038382317424:76:0) after 6m6s
[11:07:32.088] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8994235038382317424:76:0)
[11:07:32.137] Build status: STARTED
[11:07:32.137] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8994235038382317424:77:0) after 9m22s
[11:16:54.897] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8994235038382317424:77:0)
[11:16:54.930] Build status: STARTED
[11:16:54.930] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8994235038382317424:78:0) after 9m22s
[11:26:16.964] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8994235038382317424:78:0)
[11:26:16.996] Build status: STARTED
[11:26:16.996] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8994235038382317424:79:0) after 7m11s
[11:33:28.290] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8994235038382317424:79:0)
[11:33:28.338] Build status: STARTED
[11:33:28.338] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8994235038382317424:80:0) after 6m20s
[11:39:48.602] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8994235038382317424:80:0)
[11:39:48.653] Build status: STARTED
[11:39:48.653] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8994235038382317424:81:0) after 6m34s
[11:46:22.682] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8994235038382317424:81:0)
[11:46:22.718] Build status: STARTED
[11:46:22.718] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8994235038382317424:82:0) after 7m18s
[11:53:41.072] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8994235038382317424:82:0)
[11:53:41.104] Build status: STARTED
[11:53:41.104] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8994235038382317424:83:0) after 4m43s
[11:58:24.337] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8994235038382317424:83:0)
[11:58:24.376] Build status: STARTED
[11:58:24.376] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8994235038382317424:84:0) after 3m36s
[12:02:00.522] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8994235038382317424:84:0)
[12:02:00.553] Build status: STARTED
[12:02:00.554] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8994235038382317424:85:0) after 7m8s
[12:09:08.704] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8994235038382317424:85:0)
[12:09:08.741] Build status: STARTED
[12:09:08.741] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8994235038382317424:86:0) after 7m30s
[12:16:38.785] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8994235038382317424:86:0)
[12:16:38.817] Build status: STARTED
[12:16:38.817] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8994235038382317424:87:0) after 3m34s
[12:20:13.263] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8994235038382317424:87:0)
[12:20:13.398] Build status: STARTED
[12:20:13.398] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8994235038382317424:88:0) after 9m42s
[12:29:55.430] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8994235038382317424:88:0)
[12:29:55.461] Build status: STARTED
[12:29:55.461] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8994235038382317424:89:0) after 1m5s
[12:31:00.488] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8994235038382317424:89:0)
[12:31:00.530] Build status: STARTED
[12:31:00.530] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8994235038382317424:90:0) after 5m29s
[12:36:29.980] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8994235038382317424:90:0)
[12:36:30.039] Build status: STARTED
[12:36:30.039] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8994235038382317424:91:0) after 6m9s
[12:42:39.397] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8994235038382317424:91:0)
[12:42:39.427] Build status: STARTED
[12:42:39.427] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8994235038382317424:92:0) after 6m29s
[12:49:08.474] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8994235038382317424:92:0)
[12:49:08.505] Build status: STARTED
[12:49:08.505] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8994235038382317424:93:0) after 2m14s
[12:51:23.051] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8994235038382317424:93:0)
[12:51:23.084] Build status: STARTED
[12:51:23.084] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8994235038382317424:94:0) after 9m29s
[13:00:52.830] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8994235038382317424:94:0)
[13:00:52.863] Build status: STARTED
[13:00:52.863] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8994235038382317424:95:0) after 2m54s
[13:03:47.101] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8994235038382317424:95:0)
[13:03:47.132] Build status: STARTED
[13:03:47.132] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8994235038382317424:96:0) after 6m51s
[13:10:38.474] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8994235038382317424:96:0)
[13:10:38.545] Build status: STARTED
[13:10:38.545] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8994235038382317424:97:0) after 7m17s
[13:17:55.767] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8994235038382317424:97:0)
[13:17:55.882] Build status: STARTED
[13:17:55.882] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8994235038382317424:98:0) after 3m57s
[13:21:52.918] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8994235038382317424:98:0)
[13:21:52.947] Build status: STARTED
[13:21:52.947] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8994235038382317424:99:0) after 4m19s
[13:26:12.007] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8994235038382317424:99:0)
[13:26:12.034] Build status: STARTED
[13:26:12.034] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8994235038382317424:100:0) after 1m16s
[13:27:28.282] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8994235038382317424:100:0)
[13:27:28.314] Build status: STARTED
[13:27:28.314] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8994235038382317424:101:0) after 3m57s
[13:31:25.340] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8994235038382317424:101:0)
[13:31:25.377] Build status: STARTED
[13:31:25.377] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8994235038382317424:102:0) after 3m11s
[13:34:36.712] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8994235038382317424:102:0)
[13:34:36.755] Build status: STARTED
[13:34:36.756] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8994235038382317424:103:0) after 3m29s
[13:38:06.017] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8994235038382317424:103:0)
[13:38:06.068] Build status: STARTED
[13:38:06.068] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8994235038382317424:104:0) after 4m24s
[13:42:30.095] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8994235038382317424:104:0)
[13:42:30.123] Build status: STARTED
[13:42:30.123] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8994235038382317424:105:0) after 9m2s
[13:51:32.166] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8994235038382317424:105:0)
[13:51:32.211] Build status: STARTED
[13:51:32.211] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8994235038382317424:106:0) after 9m12s
[14:00:44.252] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8994235038382317424:106:0)
[14:00:44.335] Build status: STARTED
[14:00:44.335] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8994235038382317424:107:0) after 4m47s
[14:05:31.371] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8994235038382317424:107:0)
[14:05:31.402] Build status: STARTED
[14:05:31.402] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):8994235038382317424:108:0) after 9m31s
[14:09:22.887] Received PubSub notification, asking Buildbucket for the build status
[14:09:22.916] Build:
{
"id": "8828804976429462977",
"builder": {
"project": "chromium",
"bucket": "ci",
"builder": "ToTWin(dbg)"
},
"number": 8377,
"createdBy": "project:chromium",
"createTime": "2021-12-04T04:34:31.627459934Z",
"startTime": "2021-12-04T04:41:14.973009Z",
"endTime": "2021-12-04T14:09:22.388335012Z",
"updateTime": "2021-12-04T14:09:22.388335012Z",
"status": "FAILURE",
"input": {
"gitilesCommit": {
"host": "chromium.googlesource.com",
"project": "chromium/src",
"id": "3e9ba9bd5eb44106f06452aeebaaf2e6a09d9452",
"ref": "refs/heads/main"
}
}
}
[14:09:22.916] Invocation finished in 9h34m52.535119935s with status FAILED