[06:57:41.496] New invocation is queued and will start shortly
[06:57:42.572] Starting the invocation (attempt 1)
[06:57:42.606] Popped buildset tag "buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/9f1626e1265d67d21d98ae3ae872f71ea13e095a"
[06:57:42.606] Popped gitiles commit info from properties and tags
[06:57:42.606] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[06:57:42.607] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[06:57:42.607] Buildbucket request:
{
"requestId": "9015516317108801760",
"builder": {
"project": "chromium",
"bucket": "ci",
"builder": "ToTWin(dbg)"
},
"properties": {
},
"gitilesCommit": {
"host": "chromium.googlesource.com",
"project": "chromium/src",
"id": "9f1626e1265d67d21d98ae3ae872f71ea13e095a",
"ref": "refs/heads/master"
},
"tags": [
{
"key": "scheduler_invocation_id",
"value": "9015516317108801760"
},
{
"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"
}
}
[06:57:43.284] Scheduled build:
{
"id": "8850086255140229616",
"builder": {
"project": "chromium",
"bucket": "ci",
"builder": "ToTWin(dbg)"
},
"number": 6976,
"createdBy": "project:chromium",
"createTime": "2021-04-13T06:57:42.700530Z",
"updateTime": "2021-04-13T06:57:43.208006Z",
"status": "SCHEDULED",
"input": {
"gitilesCommit": {
"host": "chromium.googlesource.com",
"project": "chromium/src",
"id": "9f1626e1265d67d21d98ae3ae872f71ea13e095a",
"ref": "refs/heads/master"
}
}
}
[06:57:43.284] Task URL: https://cr-buildbucket.appspot.com/build/8850086255140229616
[06:57:43.284] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):9015516317108801760:2:0) after 4m41s
[06:58:30.775] Received PubSub notification, asking Buildbucket for the build status
[06:58:30.820] Build status: STARTED
[07:02:24.308] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):9015516317108801760:2:0)
[07:02:24.332] Build status: STARTED
[07:02:24.332] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):9015516317108801760:4:0) after 5m14s
[07:07:38.384] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):9015516317108801760:4:0)
[07:07:38.412] Build status: STARTED
[07:07:38.412] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):9015516317108801760:5:0) after 7m57s
[07:15:35.554] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):9015516317108801760:5:0)
[07:15:35.605] Build status: STARTED
[07:15:35.605] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):9015516317108801760:6:0) after 9m30s
[07:25:05.695] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):9015516317108801760:6:0)
[07:25:05.730] Build status: STARTED
[07:25:05.730] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):9015516317108801760:7:0) after 7m48s
[07:32:53.842] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):9015516317108801760:7:0)
[07:32:53.871] Build status: STARTED
[07:32:53.871] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):9015516317108801760:8:0) after 3m56s
[07:36:49.917] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):9015516317108801760:8:0)
[07:36:49.942] Build status: STARTED
[07:36:49.942] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):9015516317108801760:9:0) after 5m44s
[07:42:34.039] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):9015516317108801760:9:0)
[07:42:34.071] Build status: STARTED
[07:42:34.071] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):9015516317108801760:10:0) after 9m43s
[07:52:17.112] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):9015516317108801760:10:0)
[07:52:17.141] Build status: STARTED
[07:52:17.141] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):9015516317108801760:11:0) after 5m54s
[07:58:11.235] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):9015516317108801760:11:0)
[07:58:11.272] Build status: STARTED
[07:58:11.272] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):9015516317108801760:12:0) after 4m20s
[08:02:31.327] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):9015516317108801760:12:0)
[08:02:31.354] Build status: STARTED
[08:02:31.354] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):9015516317108801760:13:0) after 3m17s
[08:05:48.490] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):9015516317108801760:13:0)
[08:05:48.517] Build status: STARTED
[08:05:48.517] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):9015516317108801760:14:0) after 8m23s
[08:14:11.961] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):9015516317108801760:14:0)
[08:14:11.987] Build status: STARTED
[08:14:11.987] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):9015516317108801760:15:0) after 6m45s
[08:20:57.072] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):9015516317108801760:15:0)
[08:20:57.099] Build status: STARTED
[08:20:57.099] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):9015516317108801760:16:0) after 2m57s
[08:23:54.150] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):9015516317108801760:16:0)
[08:23:54.174] Build status: STARTED
[08:23:54.174] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):9015516317108801760:17:0) after 2m6s
[08:26:00.201] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):9015516317108801760:17:0)
[08:26:00.356] Build status: STARTED
[08:26:00.357] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):9015516317108801760:18:0) after 8m26s
[08:34:26.409] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):9015516317108801760:18:0)
[08:34:26.438] Build status: STARTED
[08:34:26.438] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):9015516317108801760:19:0) after 5m5s
[08:39:31.463] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):9015516317108801760:19:0)
[08:39:31.491] Build status: STARTED
[08:39:31.491] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):9015516317108801760:20:0) after 1m20s
[08:40:51.525] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):9015516317108801760:20:0)
[08:40:51.555] Build status: STARTED
[08:40:51.555] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):9015516317108801760:21:0) after 6m23s
[08:47:14.663] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):9015516317108801760:21:0)
[08:47:14.692] Build status: STARTED
[08:47:14.692] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):9015516317108801760:22:0) after 8m5s
[08:55:19.772] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):9015516317108801760:22:0)
[08:55:19.807] Build status: STARTED
[08:55:19.807] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):9015516317108801760:23:0) after 7m30s
[09:02:49.835] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):9015516317108801760:23:0)
[09:02:49.866] Build status: STARTED
[09:02:49.866] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):9015516317108801760:24:0) after 8m4s
[09:10:53.950] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):9015516317108801760:24:0)
[09:10:53.982] Build status: STARTED
[09:10:53.982] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):9015516317108801760:25:0) after 7m7s
[09:18:01.016] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):9015516317108801760:25:0)
[09:18:01.080] Build status: STARTED
[09:18:01.080] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):9015516317108801760:26:0) after 8m35s
[09:26:36.314] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):9015516317108801760:26:0)
[09:26:36.350] Build status: STARTED
[09:26:36.350] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):9015516317108801760:27:0) after 5m30s
[09:32:06.454] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):9015516317108801760:27:0)
[09:32:06.486] Build status: STARTED
[09:32:06.486] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):9015516317108801760:28:0) after 9m2s
[09:41:08.556] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):9015516317108801760:28:0)
[09:41:08.582] Build status: STARTED
[09:41:08.582] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):9015516317108801760:29:0) after 2m26s
[09:43:34.624] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):9015516317108801760:29:0)
[09:43:34.649] Build status: STARTED
[09:43:34.650] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):9015516317108801760:30:0) after 6m0s
[09:49:34.779] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):9015516317108801760:30:0)
[09:49:34.809] Build status: STARTED
[09:49:34.809] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):9015516317108801760:31:0) after 4m53s
[09:54:28.187] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):9015516317108801760:31:0)
[09:54:28.217] Build status: STARTED
[09:54:28.217] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):9015516317108801760:32:0) after 4m37s
[09:59:05.423] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):9015516317108801760:32:0)
[09:59:05.468] Build status: STARTED
[09:59:05.468] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):9015516317108801760:33:0) after 9m8s
[10:08:13.468] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):9015516317108801760:33:0)
[10:08:13.499] Build status: STARTED
[10:08:13.499] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):9015516317108801760:34:0) after 2m37s
[10:10:50.871] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):9015516317108801760:34:0)
[10:10:50.899] Build status: STARTED
[10:10:50.899] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):9015516317108801760:35:0) after 2m15s
[10:13:05.935] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):9015516317108801760:35:0)
[10:13:05.962] Build status: STARTED
[10:13:05.962] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):9015516317108801760:36:0) after 4m14s
[10:17:20.097] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):9015516317108801760:36:0)
[10:17:20.137] Build status: STARTED
[10:17:20.137] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):9015516317108801760:37:0) after 4m6s
[10:21:26.230] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):9015516317108801760:37:0)
[10:21:26.296] Build status: STARTED
[10:21:26.296] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):9015516317108801760:38:0) after 2m12s
[10:23:38.330] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):9015516317108801760:38:0)
[10:23:38.374] Build status: STARTED
[10:23:38.374] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):9015516317108801760:39:0) after 2m31s
[10:26:09.510] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):9015516317108801760:39:0)
[10:26:09.537] Build status: STARTED
[10:26:09.537] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):9015516317108801760:40:0) after 4m47s
[10:30:56.587] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):9015516317108801760:40:0)
[10:30:56.625] Build status: STARTED
[10:30:56.625] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):9015516317108801760:41:0) after 2m31s
[10:33:27.812] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):9015516317108801760:41:0)
[10:33:27.839] Build status: STARTED
[10:33:27.839] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):9015516317108801760:42:0) after 3m3s
[10:36:30.873] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):9015516317108801760:42:0)
[10:36:30.907] Build status: STARTED
[10:36:30.907] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):9015516317108801760:43:0) after 1m4s
[10:37:34.950] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):9015516317108801760:43:0)
[10:37:34.983] Build status: STARTED
[10:37:34.983] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):9015516317108801760:44:0) after 1m34s
[10:39:08.978] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):9015516317108801760:44:0)
[10:39:09.006] Build status: STARTED
[10:39:09.006] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):9015516317108801760:45:0) after 7m11s
[10:46:20.035] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):9015516317108801760:45:0)
[10:46:20.061] Build status: STARTED
[10:46:20.061] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):9015516317108801760:46:0) after 4m26s
[10:50:46.126] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):9015516317108801760:46:0)
[10:50:46.157] Build status: STARTED
[10:50:46.157] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):9015516317108801760:47:0) after 8m33s
[10:59:19.182] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):9015516317108801760:47:0)
[10:59:19.213] Build status: STARTED
[10:59:19.213] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):9015516317108801760:48:0) after 3m29s
[11:02:48.402] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):9015516317108801760:48:0)
[11:02:48.434] Build status: STARTED
[11:02:48.434] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):9015516317108801760:49:0) after 1m9s
[11:03:57.518] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):9015516317108801760:49:0)
[11:03:57.552] Build status: STARTED
[11:03:57.552] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):9015516317108801760:50:0) after 7m18s
[11:11:15.585] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):9015516317108801760:50:0)
[11:11:15.619] Build status: STARTED
[11:11:15.619] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):9015516317108801760:51:0) after 3m10s
[11:14:25.763] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):9015516317108801760:51:0)
[11:14:25.794] Build status: STARTED
[11:14:25.794] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):9015516317108801760:52:0) after 8m15s
[11:22:40.855] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):9015516317108801760:52:0)
[11:22:40.879] Build status: STARTED
[11:22:40.879] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):9015516317108801760:53:0) after 6m50s
[11:29:30.974] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):9015516317108801760:53:0)
[11:29:31.003] Build status: STARTED
[11:29:31.003] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):9015516317108801760:54:0) after 2m2s
[11:31:33.059] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):9015516317108801760:54:0)
[11:31:33.099] Build status: STARTED
[11:31:33.099] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):9015516317108801760:55:0) after 2m48s
[11:34:21.250] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):9015516317108801760:55:0)
[11:34:21.311] Build status: STARTED
[11:34:21.311] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):9015516317108801760:56:0) after 7m19s
[11:41:40.500] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):9015516317108801760:56:0)
[11:41:40.527] Build status: STARTED
[11:41:40.527] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):9015516317108801760:57:0) after 9m38s
[11:51:18.660] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):9015516317108801760:57:0)
[11:51:18.686] Build status: STARTED
[11:51:18.686] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):9015516317108801760:58:0) after 4m44s
[11:56:02.774] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):9015516317108801760:58:0)
[11:56:02.809] Build status: STARTED
[11:56:02.809] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):9015516317108801760:59:0) after 4m54s
[12:00:56.863] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):9015516317108801760:59:0)
[12:00:56.896] Build status: STARTED
[12:00:56.896] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):9015516317108801760:60:0) after 2m47s
[12:03:43.910] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):9015516317108801760:60:0)
[12:03:43.938] Build status: STARTED
[12:03:43.938] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):9015516317108801760:61:0) after 7m35s
[12:11:19.014] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):9015516317108801760:61:0)
[12:11:19.045] Build status: STARTED
[12:11:19.045] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):9015516317108801760:62:0) after 4m33s
[12:15:52.074] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):9015516317108801760:62:0)
[12:15:52.106] Build status: STARTED
[12:15:52.106] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):9015516317108801760:63:0) after 1m30s
[12:17:22.304] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):9015516317108801760:63:0)
[12:17:22.332] Build status: STARTED
[12:17:22.332] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):9015516317108801760:64:0) after 9m5s
[12:26:27.360] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):9015516317108801760:64:0)
[12:26:27.386] Build status: STARTED
[12:26:27.386] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):9015516317108801760:65:0) after 6m53s
[12:33:20.542] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):9015516317108801760:65:0)
[12:33:20.568] Build status: STARTED
[12:33:20.568] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):9015516317108801760:66:0) after 1m22s
[12:34:42.587] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):9015516317108801760:66:0)
[12:34:42.613] Build status: STARTED
[12:34:42.613] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):9015516317108801760:67:0) after 7m14s
[12:41:56.672] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):9015516317108801760:67:0)
[12:41:56.708] Build status: STARTED
[12:41:56.708] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):9015516317108801760:68:0) after 6m46s
[12:48:42.940] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):9015516317108801760:68:0)
[12:48:42.992] Build status: STARTED
[12:48:42.992] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):9015516317108801760:69:0) after 9m12s
[12:57:55.045] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):9015516317108801760:69:0)
[12:57:55.073] Build status: STARTED
[12:57:55.073] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):9015516317108801760:70:0) after 5m13s
[13:03:08.098] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):9015516317108801760:70:0)
[13:03:08.122] Build status: STARTED
[13:03:08.122] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):9015516317108801760:71:0) after 4m46s
[13:07:54.149] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):9015516317108801760:71:0)
[13:07:54.196] Build status: STARTED
[13:07:54.196] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):9015516317108801760:72:0) after 7m12s
[13:15:06.257] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):9015516317108801760:72:0)
[13:15:06.367] Build status: STARTED
[13:15:06.367] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):9015516317108801760:73:0) after 4m27s
[13:19:34.245] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):9015516317108801760:73:0)
[13:19:34.272] Build status: STARTED
[13:19:34.272] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):9015516317108801760:74:0) after 4m53s
[13:24:27.304] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):9015516317108801760:74:0)
[13:24:27.331] Build status: STARTED
[13:24:27.331] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):9015516317108801760:75:0) after 5m5s
[13:29:32.544] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):9015516317108801760:75:0)
[13:29:32.600] Build status: STARTED
[13:29:32.600] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):9015516317108801760:76:0) after 8m33s
[13:38:05.726] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):9015516317108801760:76:0)
[13:38:05.764] Build status: STARTED
[13:38:05.764] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):9015516317108801760:77:0) after 1m53s
[13:39:58.903] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):9015516317108801760:77:0)
[13:39:58.945] Build status: STARTED
[13:39:58.945] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):9015516317108801760:78:0) after 1m14s
[13:41:12.990] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):9015516317108801760:78:0)
[13:41:13.049] Build status: STARTED
[13:41:13.049] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):9015516317108801760:79:0) after 7m2s
[13:48:15.072] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):9015516317108801760:79:0)
[13:48:15.099] Build status: STARTED
[13:48:15.099] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):9015516317108801760:80:0) after 9m41s
[13:57:56.192] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):9015516317108801760:80:0)
[13:57:56.234] Build status: STARTED
[13:57:56.234] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):9015516317108801760:81:0) after 6m31s
[14:04:27.273] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):9015516317108801760:81:0)
[14:04:27.324] Build status: STARTED
[14:04:27.324] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):9015516317108801760:82:0) after 8m43s
[14:13:10.353] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):9015516317108801760:82:0)
[14:13:10.380] Build status: STARTED
[14:13:10.380] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):9015516317108801760:83:0) after 1m32s
[14:14:42.479] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):9015516317108801760:83:0)
[14:14:42.539] Build status: STARTED
[14:14:42.539] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):9015516317108801760:84:0) after 2m11s
[14:16:53.660] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):9015516317108801760:84:0)
[14:16:53.750] Build status: STARTED
[14:16:53.750] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):9015516317108801760:85:0) after 5m50s
[14:22:43.798] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):9015516317108801760:85:0)
[14:22:43.856] Build status: STARTED
[14:22:43.856] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):9015516317108801760:86:0) after 2m24s
[14:25:07.893] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):9015516317108801760:86:0)
[14:25:07.928] Build status: STARTED
[14:25:07.928] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):9015516317108801760:87:0) after 5m19s
[14:30:27.006] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):9015516317108801760:87:0)
[14:30:27.037] Build status: STARTED
[14:30:27.037] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):9015516317108801760:88:0) after 2m47s
[14:33:14.082] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):9015516317108801760:88:0)
[14:33:14.115] Build status: STARTED
[14:33:14.115] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):9015516317108801760:89:0) after 2m42s
[14:35:56.165] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):9015516317108801760:89:0)
[14:35:56.191] Build status: STARTED
[14:35:56.191] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):9015516317108801760:90:0) after 2m44s
[14:38:40.295] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):9015516317108801760:90:0)
[14:38:40.326] Build status: STARTED
[14:38:40.326] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):9015516317108801760:91:0) after 5m2s
[14:43:42.350] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):9015516317108801760:91:0)
[14:43:42.398] Build status: STARTED
[14:43:42.398] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):9015516317108801760:92:0) after 8m30s
[14:52:12.424] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):9015516317108801760:92:0)
[14:52:12.463] Build status: STARTED
[14:52:12.463] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):9015516317108801760:93:0) after 5m12s
[14:57:24.491] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):9015516317108801760:93:0)
[14:57:24.523] Build status: STARTED
[14:57:24.523] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):9015516317108801760:94:0) after 6m9s
[15:03:33.554] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):9015516317108801760:94:0)
[15:03:33.580] Build status: STARTED
[15:03:33.580] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):9015516317108801760:95:0) after 5m46s
[15:09:19.635] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):9015516317108801760:95:0)
[15:09:19.702] Build status: STARTED
[15:09:19.703] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):9015516317108801760:96:0) after 8m14s
[15:17:33.862] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):9015516317108801760:96:0)
[15:17:33.912] Build status: STARTED
[15:17:33.912] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):9015516317108801760:97:0) after 2m3s
[15:19:37.143] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):9015516317108801760:97:0)
[15:19:37.171] Build status: STARTED
[15:19:37.171] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):9015516317108801760:98:0) after 7m53s
[15:27:30.222] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):9015516317108801760:98:0)
[15:27:30.248] Build status: STARTED
[15:27:30.248] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):9015516317108801760:99:0) after 3m8s
[15:30:38.310] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):9015516317108801760:99:0)
[15:30:38.337] Build status: STARTED
[15:30:38.337] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):9015516317108801760:100:0) after 5m21s
[15:35:59.372] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):9015516317108801760:100:0)
[15:35:59.437] Build status: STARTED
[15:35:59.437] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):9015516317108801760:101:0) after 2m38s
[15:38:37.675] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):9015516317108801760:101:0)
[15:38:37.708] Build status: STARTED
[15:38:37.708] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):9015516317108801760:102:0) after 9m30s
[15:48:07.733] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):9015516317108801760:102:0)
[15:48:07.758] Build status: STARTED
[15:48:07.758] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):9015516317108801760:103:0) after 3m29s
[15:51:36.919] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):9015516317108801760:103:0)
[15:51:36.947] Build status: STARTED
[15:51:36.947] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):9015516317108801760:104:0) after 7m14s
[15:58:50.974] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):9015516317108801760:104:0)
[15:58:51.005] Build status: STARTED
[15:58:51.005] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):9015516317108801760:105:0) after 1m59s
[16:00:50.036] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):9015516317108801760:105:0)
[16:00:50.068] Build status: STARTED
[16:00:50.068] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):9015516317108801760:106:0) after 2m24s
[16:03:14.428] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):9015516317108801760:106:0)
[16:03:14.458] Build status: STARTED
[16:03:14.458] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):9015516317108801760:107:0) after 1m46s
[16:05:00.489] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):9015516317108801760:107:0)
[16:05:00.516] Build status: STARTED
[16:05:00.517] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):9015516317108801760:108:0) after 9m13s
[16:13:32.033] Received PubSub notification, asking Buildbucket for the build status
[16:13:32.058] Build:
{
"id": "8850086255140229616",
"builder": {
"project": "chromium",
"bucket": "ci",
"builder": "ToTWin(dbg)"
},
"number": 6976,
"createdBy": "project:chromium",
"createTime": "2021-04-13T06:57:42.700530Z",
"startTime": "2021-04-13T06:58:30.331408Z",
"endTime": "2021-04-13T16:13:31.454095804Z",
"updateTime": "2021-04-13T16:13:31.454726142Z",
"status": "FAILURE",
"input": {
"gitilesCommit": {
"host": "chromium.googlesource.com",
"project": "chromium/src",
"id": "9f1626e1265d67d21d98ae3ae872f71ea13e095a",
"ref": "refs/heads/master"
}
}
}
[16:13:32.059] Invocation finished in 9h15m50.619182589s with status FAILED