[19:13:02.576] New invocation is queued and will start shortly
[19:13:03.744] Starting the invocation (attempt 1)
[19:13:03.780] Popped buildset tag "buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/381aa1fc2981055ea13a5f84334906c4d2d7ac05"
[19:13:03.780] Popped gitiles commit info from properties and tags
[19:13:03.780] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[19:13:03.780] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[19:13:03.780] Buildbucket request:
{
"requestId": "9015923037596198416",
"builder": {
"project": "chromium",
"bucket": "ci",
"builder": "ToTMac (dbg)"
},
"properties": {
},
"gitilesCommit": {
"host": "chromium.googlesource.com",
"project": "chromium/src",
"id": "381aa1fc2981055ea13a5f84334906c4d2d7ac05",
"ref": "refs/heads/master"
},
"tags": [
{
"key": "scheduler_invocation_id",
"value": "9015923037596198416"
},
{
"key": "scheduler_job_id",
"value": "chromium/ToTMac (dbg)"
},
{
"key": "user_agent",
"value": "luci-scheduler"
}
],
"notify": {
"pubsubTopic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
}
}
[19:13:06.002] Scheduled build:
{
"id": "8850492974032554416",
"builder": {
"project": "chromium",
"bucket": "ci",
"builder": "ToTMac (dbg)"
},
"number": 26390,
"createdBy": "project:chromium",
"createTime": "2021-04-08T19:13:05.339198Z",
"updateTime": "2021-04-08T19:13:05.909889Z",
"status": "SCHEDULED",
"input": {
"gitilesCommit": {
"host": "chromium.googlesource.com",
"project": "chromium/src",
"id": "381aa1fc2981055ea13a5f84334906c4d2d7ac05",
"ref": "refs/heads/master"
}
}
}
[19:13:06.002] Task URL: https://cr-buildbucket.appspot.com/build/8850492974032554416
[19:13:06.002] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):9015923037596198416:2:0) after 4m52s
[19:13:32.331] Received PubSub notification, asking Buildbucket for the build status
[19:13:32.368] Build status: STARTED
[19:17:58.024] Handling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):9015923037596198416:2:0)
[19:17:58.058] Build status: STARTED
[19:17:58.058] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):9015923037596198416:4:0) after 5m23s
[19:23:21.194] Handling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):9015923037596198416:4:0)
[19:23:21.290] Build status: STARTED
[19:23:21.291] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):9015923037596198416:5:0) after 2m48s
[19:26:09.383] Handling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):9015923037596198416:5:0)
[19:26:09.423] Build status: STARTED
[19:26:09.423] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):9015923037596198416:6:0) after 8m33s
[19:34:42.540] Handling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):9015923037596198416:6:0)
[19:34:42.569] Build status: STARTED
[19:34:42.569] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):9015923037596198416:7:0) after 3m15s
[19:37:57.635] Handling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):9015923037596198416:7:0)
[19:37:57.663] Build status: STARTED
[19:37:57.663] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):9015923037596198416:8:0) after 9m36s
[19:47:33.864] Handling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):9015923037596198416:8:0)
[19:47:33.995] Build status: STARTED
[19:47:33.995] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):9015923037596198416:9:0) after 8m13s
[19:55:47.109] Handling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):9015923037596198416:9:0)
[19:55:47.146] Build status: STARTED
[19:55:47.146] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):9015923037596198416:10:0) after 1m34s
[19:57:21.337] Handling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):9015923037596198416:10:0)
[19:57:21.397] Build status: STARTED
[19:57:21.397] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):9015923037596198416:11:0) after 3m35s
[20:00:56.421] Handling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):9015923037596198416:11:0)
[20:00:56.481] Build status: STARTED
[20:00:56.481] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):9015923037596198416:12:0) after 6m21s
[20:07:17.550] Handling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):9015923037596198416:12:0)
[20:07:17.613] Build status: STARTED
[20:07:17.613] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):9015923037596198416:13:0) after 6m12s
[20:13:29.656] Handling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):9015923037596198416:13:0)
[20:13:29.688] Build status: STARTED
[20:13:29.688] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):9015923037596198416:14:0) after 9m10s
[20:22:39.771] Handling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):9015923037596198416:14:0)
[20:22:39.813] Build status: STARTED
[20:22:39.813] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):9015923037596198416:15:0) after 3m46s
[20:26:25.894] Handling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):9015923037596198416:15:0)
[20:26:25.924] Build status: STARTED
[20:26:25.924] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):9015923037596198416:16:0) after 3m13s
[20:29:39.255] Handling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):9015923037596198416:16:0)
[20:29:39.336] Build status: STARTED
[20:29:39.336] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):9015923037596198416:17:0) after 2m36s
[20:32:15.501] Handling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):9015923037596198416:17:0)
[20:32:15.537] Build status: STARTED
[20:32:15.537] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):9015923037596198416:18:0) after 8m46s
[20:41:01.566] Handling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):9015923037596198416:18:0)
[20:41:01.592] Build status: STARTED
[20:41:01.592] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):9015923037596198416:19:0) after 4m23s
[20:45:24.656] Handling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):9015923037596198416:19:0)
[20:45:24.684] Build status: STARTED
[20:45:24.684] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):9015923037596198416:20:0) after 2m30s
[20:47:54.807] Handling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):9015923037596198416:20:0)
[20:47:54.855] Build status: STARTED
[20:47:54.855] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):9015923037596198416:21:0) after 3m58s
[20:51:53.027] Handling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):9015923037596198416:21:0)
[20:51:53.093] Build status: STARTED
[20:51:53.093] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):9015923037596198416:22:0) after 2m59s
[20:54:52.170] Handling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):9015923037596198416:22:0)
[20:54:52.200] Build status: STARTED
[20:54:52.200] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):9015923037596198416:23:0) after 3m15s
[20:58:07.525] Handling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):9015923037596198416:23:0)
[20:58:07.593] Build status: STARTED
[20:58:07.593] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):9015923037596198416:24:0) after 5m49s
[21:03:56.578] Handling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):9015923037596198416:24:0)
[21:03:56.610] Build status: STARTED
[21:03:56.610] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):9015923037596198416:25:0) after 9m12s
[21:13:08.689] Handling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):9015923037596198416:25:0)
[21:13:08.732] Build status: STARTED
[21:13:08.732] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):9015923037596198416:26:0) after 3m51s
[21:16:59.840] Handling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):9015923037596198416:26:0)
[21:16:59.866] Build status: STARTED
[21:16:59.866] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):9015923037596198416:27:0) after 1m30s
[21:18:30.261] Handling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):9015923037596198416:27:0)
[21:18:30.285] Build status: STARTED
[21:18:30.285] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):9015923037596198416:28:0) after 6m10s
[21:24:40.312] Handling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):9015923037596198416:28:0)
[21:24:40.344] Build status: STARTED
[21:24:40.344] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):9015923037596198416:29:0) after 8m14s
[21:32:54.422] Handling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):9015923037596198416:29:0)
[21:32:54.454] Build status: STARTED
[21:32:54.454] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):9015923037596198416:30:0) after 9m50s
[21:42:44.596] Handling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):9015923037596198416:30:0)
[21:42:44.626] Build status: STARTED
[21:42:44.626] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):9015923037596198416:31:0) after 6m14s
[21:48:58.711] Handling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):9015923037596198416:31:0)
[21:48:58.736] Build status: STARTED
[21:48:58.736] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):9015923037596198416:32:0) after 8m7s
[21:57:05.886] Handling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):9015923037596198416:32:0)
[21:57:05.916] Build status: STARTED
[21:57:05.916] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):9015923037596198416:33:0) after 5m31s
[22:02:36.962] Handling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):9015923037596198416:33:0)
[22:02:36.990] Build status: STARTED
[22:02:36.990] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):9015923037596198416:34:0) after 2m35s
[22:05:12.088] Handling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):9015923037596198416:34:0)
[22:05:12.119] Build status: STARTED
[22:05:12.119] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):9015923037596198416:35:0) after 2m18s
[22:07:30.221] Handling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):9015923037596198416:35:0)
[22:07:30.310] Build status: STARTED
[22:07:30.310] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):9015923037596198416:36:0) after 4m50s
[22:12:20.536] Handling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):9015923037596198416:36:0)
[22:12:20.564] Build status: STARTED
[22:12:20.564] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):9015923037596198416:37:0) after 6m29s
[22:18:49.766] Handling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):9015923037596198416:37:0)
[22:18:49.794] Build status: STARTED
[22:18:49.794] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):9015923037596198416:38:0) after 2m55s
[22:21:44.835] Handling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):9015923037596198416:38:0)
[22:21:44.860] Build status: STARTED
[22:21:44.860] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):9015923037596198416:39:0) after 8m53s
[22:30:37.891] Handling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):9015923037596198416:39:0)
[22:30:37.918] Build status: STARTED
[22:30:37.918] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):9015923037596198416:40:0) after 2m25s
[22:33:03.198] Handling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):9015923037596198416:40:0)
[22:33:03.225] Build status: STARTED
[22:33:03.225] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):9015923037596198416:41:0) after 6m28s
[22:39:31.252] Handling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):9015923037596198416:41:0)
[22:39:31.276] Build status: STARTED
[22:39:31.276] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):9015923037596198416:42:0) after 1m15s
[22:40:46.301] Handling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):9015923037596198416:42:0)
[22:40:46.326] Build status: STARTED
[22:40:46.326] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):9015923037596198416:43:0) after 3m56s
[22:44:42.640] Handling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):9015923037596198416:43:0)
[22:44:42.666] Build status: STARTED
[22:44:42.666] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):9015923037596198416:44:0) after 9m39s
[22:54:21.708] Handling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):9015923037596198416:44:0)
[22:54:21.740] Build status: STARTED
[22:54:21.740] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):9015923037596198416:45:0) after 4m55s
[22:59:16.818] Handling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):9015923037596198416:45:0)
[22:59:16.848] Build status: STARTED
[22:59:16.848] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):9015923037596198416:46:0) after 7m40s
[23:06:57.234] Handling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):9015923037596198416:46:0)
[23:06:57.258] Build status: STARTED
[23:06:57.258] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):9015923037596198416:47:0) after 3m52s
[23:10:49.365] Handling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):9015923037596198416:47:0)
[23:10:49.392] Build status: STARTED
[23:10:49.392] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):9015923037596198416:48:0) after 2m54s
[23:13:43.621] Handling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):9015923037596198416:48:0)
[23:13:43.681] Build status: STARTED
[23:13:43.681] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):9015923037596198416:49:0) after 1m24s
[23:15:07.733] Handling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):9015923037596198416:49:0)
[23:15:07.795] Build status: STARTED
[23:15:07.795] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):9015923037596198416:50:0) after 8m16s
[23:23:23.822] Handling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):9015923037596198416:50:0)
[23:23:23.847] Build status: STARTED
[23:23:23.847] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):9015923037596198416:51:0) after 9m57s
[23:33:21.075] Handling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):9015923037596198416:51:0)
[23:33:21.102] Build status: STARTED
[23:33:21.102] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):9015923037596198416:52:0) after 1m18s
[23:34:39.227] Handling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):9015923037596198416:52:0)
[23:34:39.255] Build status: STARTED
[23:34:39.255] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):9015923037596198416:53:0) after 7m38s
[23:42:17.325] Handling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):9015923037596198416:53:0)
[23:42:17.358] Build status: STARTED
[23:42:17.358] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):9015923037596198416:54:0) after 4m50s
[23:47:07.359] Handling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):9015923037596198416:54:0)
[23:47:07.387] Build status: STARTED
[23:47:07.387] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):9015923037596198416:55:0) after 7m37s
[23:54:44.423] Handling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):9015923037596198416:55:0)
[23:54:44.449] Build status: STARTED
[23:54:44.449] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):9015923037596198416:56:0) after 5m14s
[23:59:58.475] Handling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):9015923037596198416:56:0)
[23:59:58.502] Build status: STARTED
[23:59:58.502] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):9015923037596198416:57:0) after 8m41s
[00:08:39.878] Handling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):9015923037596198416:57:0)
[00:08:39.911] Build status: STARTED
[00:08:39.911] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):9015923037596198416:58:0) after 5m8s
[00:13:47.938] Handling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):9015923037596198416:58:0)
[00:13:47.964] Build status: STARTED
[00:13:47.964] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):9015923037596198416:59:0) after 4m8s
[00:17:56.114] Handling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):9015923037596198416:59:0)
[00:17:56.143] Build status: STARTED
[00:17:56.143] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):9015923037596198416:60:0) after 3m14s
[00:21:10.146] Handling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):9015923037596198416:60:0)
[00:21:10.176] Build status: STARTED
[00:21:10.176] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):9015923037596198416:61:0) after 6m14s
[00:27:24.206] Handling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):9015923037596198416:61:0)
[00:27:24.231] Build status: STARTED
[00:27:24.231] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):9015923037596198416:62:0) after 7m57s
[00:35:21.357] Handling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):9015923037596198416:62:0)
[00:35:21.388] Build status: STARTED
[00:35:21.388] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):9015923037596198416:63:0) after 4m49s
[00:40:10.525] Handling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):9015923037596198416:63:0)
[00:40:10.609] Build status: STARTED
[00:40:10.609] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):9015923037596198416:64:0) after 1m4s
[00:41:14.637] Handling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):9015923037596198416:64:0)
[00:41:14.665] Build status: STARTED
[00:41:14.665] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):9015923037596198416:65:0) after 4m33s
[00:45:47.740] Handling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):9015923037596198416:65:0)
[00:45:47.773] Build status: STARTED
[00:45:47.773] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):9015923037596198416:66:0) after 8m42s
[00:54:29.815] Handling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):9015923037596198416:66:0)
[00:54:29.842] Build status: STARTED
[00:54:29.842] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):9015923037596198416:67:0) after 3m48s
[00:58:17.861] Handling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):9015923037596198416:67:0)
[00:58:17.890] Build status: STARTED
[00:58:17.890] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):9015923037596198416:68:0) after 5m39s
[01:03:56.927] Handling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):9015923037596198416:68:0)
[01:03:56.962] Build status: STARTED
[01:03:56.962] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):9015923037596198416:69:0) after 2m10s
[01:06:06.987] Handling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):9015923037596198416:69:0)
[01:06:07.028] Build status: STARTED
[01:06:07.028] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):9015923037596198416:70:0) after 7m50s
[01:13:57.101] Handling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):9015923037596198416:70:0)
[01:13:57.135] Build status: STARTED
[01:13:57.135] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):9015923037596198416:71:0) after 4m34s
[01:18:31.161] Handling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):9015923037596198416:71:0)
[01:18:31.192] Build status: STARTED
[01:18:31.192] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):9015923037596198416:72:0) after 4m25s
[01:22:56.222] Handling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):9015923037596198416:72:0)
[01:22:56.274] Build status: STARTED
[01:22:56.274] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):9015923037596198416:73:0) after 5m2s
[01:27:58.447] Handling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):9015923037596198416:73:0)
[01:27:58.474] Build status: STARTED
[01:27:58.474] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):9015923037596198416:74:0) after 6m1s
[01:33:59.768] Handling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):9015923037596198416:74:0)
[01:33:59.802] Build status: STARTED
[01:33:59.802] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):9015923037596198416:75:0) after 3m55s
[01:37:54.905] Handling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):9015923037596198416:75:0)
[01:37:54.932] Build status: STARTED
[01:37:54.932] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):9015923037596198416:76:0) after 9m47s
[01:47:41.956] Handling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):9015923037596198416:76:0)
[01:47:41.982] Build status: STARTED
[01:47:41.982] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):9015923037596198416:77:0) after 9m33s
[01:57:15.023] Handling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):9015923037596198416:77:0)
[01:57:15.055] Build status: STARTED
[01:57:15.055] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):9015923037596198416:78:0) after 9m15s
[02:06:30.247] Handling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):9015923037596198416:78:0)
[02:06:30.275] Build status: STARTED
[02:06:30.275] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):9015923037596198416:79:0) after 1m21s
[02:07:51.455] Handling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):9015923037596198416:79:0)
[02:07:51.483] Build status: STARTED
[02:07:51.483] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):9015923037596198416:80:0) after 6m43s
[02:14:34.610] Handling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):9015923037596198416:80:0)
[02:14:34.643] Build status: STARTED
[02:14:34.643] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):9015923037596198416:81:0) after 6m43s
[02:21:17.681] Handling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):9015923037596198416:81:0)
[02:21:17.713] Build status: STARTED
[02:21:17.713] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):9015923037596198416:82:0) after 2m22s
[02:23:39.742] Handling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):9015923037596198416:82:0)
[02:23:39.769] Build status: STARTED
[02:23:39.769] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):9015923037596198416:83:0) after 8m7s
[02:31:47.042] Handling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):9015923037596198416:83:0)
[02:31:47.073] Build status: STARTED
[02:31:47.073] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):9015923037596198416:84:0) after 8m13s
[02:40:00.108] Handling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):9015923037596198416:84:0)
[02:40:00.140] Build status: STARTED
[02:40:00.140] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):9015923037596198416:85:0) after 1m10s
[02:41:10.159] Handling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):9015923037596198416:85:0)
[02:41:10.203] Build status: STARTED
[02:41:10.203] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):9015923037596198416:86:0) after 9m28s
[02:50:38.242] Handling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):9015923037596198416:86:0)
[02:50:38.278] Build status: STARTED
[02:50:38.278] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):9015923037596198416:87:0) after 5m12s
[02:55:50.413] Handling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):9015923037596198416:87:0)
[02:55:50.439] Build status: STARTED
[02:55:50.439] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):9015923037596198416:88:0) after 6m32s
[03:02:22.541] Handling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):9015923037596198416:88:0)
[03:02:22.598] Build status: STARTED
[03:02:22.598] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):9015923037596198416:89:0) after 7m54s
[03:10:16.717] Handling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):9015923037596198416:89:0)
[03:10:16.744] Build status: STARTED
[03:10:16.744] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):9015923037596198416:90:0) after 5m2s
[03:15:18.830] Handling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):9015923037596198416:90:0)
[03:15:18.933] Build status: STARTED
[03:15:18.933] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):9015923037596198416:91:0) after 4m38s
[03:19:56.960] Handling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):9015923037596198416:91:0)
[03:19:56.988] Build status: STARTED
[03:19:56.988] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):9015923037596198416:92:0) after 1m8s
[03:21:05.119] Handling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):9015923037596198416:92:0)
[03:21:05.151] Build status: STARTED
[03:21:05.151] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):9015923037596198416:93:0) after 9m14s
[03:30:19.192] Handling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):9015923037596198416:93:0)
[03:30:19.227] Build status: STARTED
[03:30:19.227] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):9015923037596198416:94:0) after 4m31s
[03:34:50.357] Handling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):9015923037596198416:94:0)
[03:34:50.386] Build status: STARTED
[03:34:50.386] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):9015923037596198416:95:0) after 2m17s
[03:37:07.381] Handling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):9015923037596198416:95:0)
[03:37:07.407] Build status: STARTED
[03:37:07.407] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):9015923037596198416:96:0) after 5m17s
[03:42:24.498] Handling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):9015923037596198416:96:0)
[03:42:24.523] Build status: STARTED
[03:42:24.523] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):9015923037596198416:97:0) after 8m8s
[03:50:32.683] Handling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):9015923037596198416:97:0)
[03:50:32.708] Build status: STARTED
[03:50:32.708] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):9015923037596198416:98:0) after 2m41s
[03:53:13.812] Handling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):9015923037596198416:98:0)
[03:53:13.847] Build status: STARTED
[03:53:13.847] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):9015923037596198416:99:0) after 2m28s
[03:55:41.878] Handling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):9015923037596198416:99:0)
[03:55:41.904] Build status: STARTED
[03:55:41.904] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):9015923037596198416:100:0) after 7m23s
[04:03:05.074] Handling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):9015923037596198416:100:0)
[04:03:05.108] Build status: STARTED
[04:03:05.108] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):9015923037596198416:101:0) after 3m10s
[04:06:15.331] Handling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):9015923037596198416:101:0)
[04:06:15.356] Build status: STARTED
[04:06:15.356] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):9015923037596198416:102:0) after 1m12s
[04:07:27.589] Handling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):9015923037596198416:102:0)
[04:07:27.619] Build status: STARTED
[04:07:27.619] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):9015923037596198416:103:0) after 7m36s
[04:15:03.644] Handling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):9015923037596198416:103:0)
[04:15:03.671] Build status: STARTED
[04:15:03.671] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):9015923037596198416:104:0) after 5m51s
[04:20:54.773] Handling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):9015923037596198416:104:0)
[04:20:54.802] Build status: STARTED
[04:20:54.802] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):9015923037596198416:105:0) after 4m33s
[04:25:27.853] Handling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):9015923037596198416:105:0)
[04:25:27.881] Build status: STARTED
[04:25:27.881] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):9015923037596198416:106:0) after 6m48s
[04:32:15.944] Handling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):9015923037596198416:106:0)
[04:32:15.988] Build status: STARTED
[04:32:15.988] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):9015923037596198416:107:0) after 4m3s
[04:36:19.223] Handling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):9015923037596198416:107:0)
[04:36:19.252] Build status: STARTED
[04:36:19.252] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):9015923037596198416:108:0) after 3m51s
[04:40:10.517] Handling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):9015923037596198416:108:0)
[04:40:10.556] Build status: STARTED
[04:40:10.556] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):9015923037596198416:109:0) after 2m29s
[04:42:39.584] Handling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):9015923037596198416:109:0)
[04:42:39.616] Build status: STARTED
[04:42:39.616] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):9015923037596198416:110:0) after 5m15s
[04:47:54.686] Handling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):9015923037596198416:110:0)
[04:47:54.718] Build status: STARTED
[04:47:54.718] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):9015923037596198416:111:0) after 1m41s
[04:49:35.752] Handling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):9015923037596198416:111:0)
[04:49:35.779] Build status: STARTED
[04:49:35.779] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):9015923037596198416:112:0) after 3m13s
[04:52:48.888] Handling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):9015923037596198416:112:0)
[04:52:48.912] Build status: STARTED
[04:52:48.912] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):9015923037596198416:113:0) after 5m6s
[04:57:55.112] Handling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):9015923037596198416:113:0)
[04:57:55.135] Build status: STARTED
[04:57:55.135] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):9015923037596198416:114:0) after 2m6s
[05:00:01.235] Handling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):9015923037596198416:114:0)
[05:00:01.273] Build status: STARTED
[05:00:01.274] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):9015923037596198416:115:0) after 8m0s
[05:08:01.518] Handling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):9015923037596198416:115:0)
[05:08:01.547] Build status: STARTED
[05:08:01.547] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):9015923037596198416:116:0) after 4m4s
[05:12:05.667] Handling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):9015923037596198416:116:0)
[05:12:05.697] Build status: STARTED
[05:12:05.697] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):9015923037596198416:117:0) after 1m2s
[05:13:07.730] Handling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):9015923037596198416:117:0)
[05:13:07.756] Build status: STARTED
[05:13:07.756] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):9015923037596198416:118:0) after 6m54s
[05:20:01.970] Handling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):9015923037596198416:118:0)
[05:20:01.999] Build status: STARTED
[05:20:01.999] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):9015923037596198416:119:0) after 3m16s
[05:23:18.045] Handling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):9015923037596198416:119:0)
[05:23:18.096] Build status: STARTED
[05:23:18.096] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):9015923037596198416:120:0) after 7m6s
[05:26:34.115] Received PubSub notification, asking Buildbucket for the build status
[05:26:34.149] Build:
{
"id": "8850492974032554416",
"builder": {
"project": "chromium",
"bucket": "ci",
"builder": "ToTMac (dbg)"
},
"number": 26390,
"createdBy": "project:chromium",
"createTime": "2021-04-08T19:13:05.339198Z",
"startTime": "2021-04-08T19:13:31.600967Z",
"endTime": "2021-04-09T05:26:33.849738879Z",
"updateTime": "2021-04-09T05:26:33.850091388Z",
"status": "FAILURE",
"input": {
"gitilesCommit": {
"host": "chromium.googlesource.com",
"project": "chromium/src",
"id": "381aa1fc2981055ea13a5f84334906c4d2d7ac05",
"ref": "refs/heads/master"
}
}
}
[05:26:34.149] Invocation finished in 10h13m31.592036126s with status FAILED