[05:26:36.409] New invocation is queued and will start shortly
[05:26:37.537] Starting the invocation (attempt 1)
[05:26:37.578] Popped buildset tag "buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/6a20d970b515cf330f6f3d42c47b6bf07fc2d200"
[05:26:37.578] Popped gitiles commit info from properties and tags
[05:26:37.578] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[05:26:37.578] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[05:26:37.578] Buildbucket request:
{
"requestId": "9015884435489914128",
"builder": {
"project": "chromium",
"bucket": "ci",
"builder": "ToTMac (dbg)"
},
"properties": {
},
"gitilesCommit": {
"host": "chromium.googlesource.com",
"project": "chromium/src",
"id": "6a20d970b515cf330f6f3d42c47b6bf07fc2d200",
"ref": "refs/heads/master"
},
"tags": [
{
"key": "scheduler_invocation_id",
"value": "9015884435489914128"
},
{
"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"
}
}
[05:26:39.431] Scheduled build:
{
"id": "8850454373380481744",
"builder": {
"project": "chromium",
"bucket": "ci",
"builder": "ToTMac (dbg)"
},
"number": 26391,
"createdBy": "project:chromium",
"createTime": "2021-04-09T05:26:37.789336Z",
"updateTime": "2021-04-09T05:26:38.945902Z",
"status": "SCHEDULED",
"input": {
"gitilesCommit": {
"host": "chromium.googlesource.com",
"project": "chromium/src",
"id": "6a20d970b515cf330f6f3d42c47b6bf07fc2d200",
"ref": "refs/heads/master"
}
}
}
[05:26:39.431] Task URL: https://cr-buildbucket.appspot.com/build/8850454373380481744
[05:26:39.431] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):9015884435489914128:2:0) after 5m44s
[05:27:42.478] Received PubSub notification, asking Buildbucket for the build status
[05:27:42.523] Build status: STARTED
[05:32:23.593] Handling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):9015884435489914128:2:0)
[05:32:23.619] Build status: STARTED
[05:32:23.619] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):9015884435489914128:4:0) after 5m18s
[05:37:41.657] Handling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):9015884435489914128:4:0)
[05:37:41.721] Build status: STARTED
[05:37:41.721] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):9015884435489914128:5:0) after 6m22s
[05:44:03.836] Handling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):9015884435489914128:5:0)
[05:44:03.861] Build status: STARTED
[05:44:03.861] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):9015884435489914128:6:0) after 9m42s
[05:53:45.914] Handling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):9015884435489914128:6:0)
[05:53:45.940] Build status: STARTED
[05:53:45.940] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):9015884435489914128:7:0) after 1m9s
[05:54:55.202] Handling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):9015884435489914128:7:0)
[05:54:55.232] Build status: STARTED
[05:54:55.233] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):9015884435489914128:8:0) after 5m48s
[06:00:43.270] Handling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):9015884435489914128:8:0)
[06:00:43.298] Build status: STARTED
[06:00:43.298] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):9015884435489914128:9:0) after 5m48s
[06:06:31.507] Handling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):9015884435489914128:9:0)
[06:06:31.539] Build status: STARTED
[06:06:31.539] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):9015884435489914128:10:0) after 9m37s
[06:16:09.048] Handling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):9015884435489914128:10:0)
[06:16:09.085] Build status: STARTED
[06:16:09.085] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):9015884435489914128:11:0) after 8m47s
[06:24:56.207] Handling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):9015884435489914128:11:0)
[06:24:56.237] Build status: STARTED
[06:24:56.237] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):9015884435489914128:12:0) after 9m5s
[06:34:01.261] Handling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):9015884435489914128:12:0)
[06:34:01.286] Build status: STARTED
[06:34:01.286] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):9015884435489914128:13:0) after 5m43s
[06:39:44.634] Handling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):9015884435489914128:13:0)
[06:39:44.664] Build status: STARTED
[06:39:44.664] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):9015884435489914128:14:0) after 1m46s
[06:41:30.704] Handling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):9015884435489914128:14:0)
[06:41:30.728] Build status: STARTED
[06:41:30.728] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):9015884435489914128:15:0) after 9m55s
[06:51:25.763] Handling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):9015884435489914128:15:0)
[06:51:25.791] Build status: STARTED
[06:51:25.791] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):9015884435489914128:16:0) after 8m26s
[06:59:51.964] Handling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):9015884435489914128:16:0)
[06:59:51.989] Build status: STARTED
[06:59:51.989] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):9015884435489914128:17:0) after 8m39s
[07:08:31.013] Handling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):9015884435489914128:17:0)
[07:08:31.044] Build status: STARTED
[07:08:31.044] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):9015884435489914128:18:0) after 3m55s
[07:12:26.070] Handling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):9015884435489914128:18:0)
[07:12:26.104] Build status: STARTED
[07:12:26.104] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):9015884435489914128:19:0) after 3m6s
[07:15:32.328] Handling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):9015884435489914128:19:0)
[07:15:32.356] Build status: STARTED
[07:15:32.356] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):9015884435489914128:20:0) after 7m47s
[07:23:19.380] Handling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):9015884435489914128:20:0)
[07:23:19.409] Build status: STARTED
[07:23:19.409] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):9015884435489914128:21:0) after 2m31s
[07:25:50.433] Handling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):9015884435489914128:21:0)
[07:25:50.520] Build status: STARTED
[07:25:50.520] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):9015884435489914128:22:0) after 1m1s
[07:26:51.739] Handling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):9015884435489914128:22:0)
[07:26:51.786] Build status: STARTED
[07:26:51.786] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):9015884435489914128:23:0) after 3m33s
[07:30:24.983] Handling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):9015884435489914128:23:0)
[07:30:25.009] Build status: STARTED
[07:30:25.009] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):9015884435489914128:24:0) after 5m47s
[07:36:12.130] Handling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):9015884435489914128:24:0)
[07:36:12.155] Build status: STARTED
[07:36:12.155] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):9015884435489914128:25:0) after 9m49s
[07:46:01.214] Handling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):9015884435489914128:25:0)
[07:46:01.238] Build status: STARTED
[07:46:01.238] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):9015884435489914128:26:0) after 5m5s
[07:51:06.295] Handling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):9015884435489914128:26:0)
[07:51:06.320] Build status: STARTED
[07:51:06.320] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):9015884435489914128:27:0) after 1m57s
[07:53:03.613] Handling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):9015884435489914128:27:0)
[07:53:03.639] Build status: STARTED
[07:53:03.639] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):9015884435489914128:28:0) after 2m8s
[07:55:11.761] Handling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):9015884435489914128:28:0)
[07:55:11.785] Build status: STARTED
[07:55:11.785] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):9015884435489914128:29:0) after 2m39s
[07:57:50.812] Handling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):9015884435489914128:29:0)
[07:57:50.840] Build status: STARTED
[07:57:50.840] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):9015884435489914128:30:0) after 8m55s
[08:06:45.859] Handling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):9015884435489914128:30:0)
[08:06:45.894] Build status: STARTED
[08:06:45.894] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):9015884435489914128:31:0) after 3m34s
[08:10:19.911] Handling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):9015884435489914128:31:0)
[08:10:19.937] Build status: STARTED
[08:10:19.937] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):9015884435489914128:32:0) after 8m47s
[08:19:07.017] Handling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):9015884435489914128:32:0)
[08:19:07.053] Build status: STARTED
[08:19:07.053] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):9015884435489914128:33:0) after 8m42s
[08:27:49.099] Handling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):9015884435489914128:33:0)
[08:27:49.127] Build status: STARTED
[08:27:49.127] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):9015884435489914128:34:0) after 4m35s
[08:32:24.370] Handling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):9015884435489914128:34:0)
[08:32:24.398] Build status: STARTED
[08:32:24.398] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):9015884435489914128:35:0) after 4m54s
[08:37:18.431] Handling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):9015884435489914128:35:0)
[08:37:18.464] Build status: STARTED
[08:37:18.464] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):9015884435489914128:36:0) after 6m24s
[08:43:42.498] Handling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):9015884435489914128:36:0)
[08:43:42.526] Build status: STARTED
[08:43:42.526] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):9015884435489914128:37:0) after 2m52s
[08:46:35.059] Handling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):9015884435489914128:37:0)
[08:46:35.266] Build status: STARTED
[08:46:35.266] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):9015884435489914128:38:0) after 7m46s
[08:54:21.445] Handling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):9015884435489914128:38:0)
[08:54:21.475] Build status: STARTED
[08:54:21.475] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):9015884435489914128:39:0) after 1m8s
[08:55:29.502] Handling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):9015884435489914128:39:0)
[08:55:29.528] Build status: STARTED
[08:55:29.528] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):9015884435489914128:40:0) after 6m29s
[09:01:58.657] Handling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):9015884435489914128:40:0)
[09:01:58.684] Build status: STARTED
[09:01:58.684] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):9015884435489914128:41:0) after 5m13s
[09:07:11.807] Handling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):9015884435489914128:41:0)
[09:07:11.840] Build status: STARTED
[09:07:11.840] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):9015884435489914128:42:0) after 2m18s
[09:09:29.894] Handling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):9015884435489914128:42:0)
[09:09:29.919] Build status: STARTED
[09:09:29.919] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):9015884435489914128:43:0) after 6m51s
[09:16:20.924] Handling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):9015884435489914128:43:0)
[09:16:20.952] Build status: STARTED
[09:16:20.952] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):9015884435489914128:44:0) after 4m26s
[09:20:46.985] Handling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):9015884435489914128:44:0)
[09:20:47.107] Build status: STARTED
[09:20:47.107] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):9015884435489914128:45:0) after 3m35s
[09:24:22.130] Handling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):9015884435489914128:45:0)
[09:24:22.156] Build status: STARTED
[09:24:22.156] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):9015884435489914128:46:0) after 4m33s
[09:28:55.238] Handling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):9015884435489914128:46:0)
[09:28:55.263] Build status: STARTED
[09:28:55.263] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):9015884435489914128:47:0) after 8m38s
[09:37:33.472] Handling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):9015884435489914128:47:0)
[09:37:33.505] Build status: STARTED
[09:37:33.505] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):9015884435489914128:48:0) after 3m14s
[09:40:47.673] Handling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):9015884435489914128:48:0)
[09:40:47.702] Build status: STARTED
[09:40:47.702] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):9015884435489914128:49:0) after 6m32s
[09:47:19.743] Handling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):9015884435489914128:49:0)
[09:47:19.767] Build status: STARTED
[09:47:19.767] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):9015884435489914128:50:0) after 7m23s
[09:54:42.892] Handling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):9015884435489914128:50:0)
[09:54:42.917] Build status: STARTED
[09:54:42.917] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):9015884435489914128:51:0) after 7m57s
[10:02:39.976] Handling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):9015884435489914128:51:0)
[10:02:40.000] Build status: STARTED
[10:02:40.000] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):9015884435489914128:52:0) after 1m29s
[10:04:09.039] Handling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):9015884435489914128:52:0)
[10:04:09.070] Build status: STARTED
[10:04:09.070] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):9015884435489914128:53:0) after 6m33s
[10:10:42.095] Handling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):9015884435489914128:53:0)
[10:10:42.154] Build status: STARTED
[10:10:42.154] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):9015884435489914128:54:0) after 8m30s
[10:19:12.144] Handling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):9015884435489914128:54:0)
[10:19:12.175] Build status: STARTED
[10:19:12.175] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):9015884435489914128:55:0) after 7m3s
[10:26:15.306] Handling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):9015884435489914128:55:0)
[10:26:15.338] Build status: STARTED
[10:26:15.338] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):9015884435489914128:56:0) after 8m22s
[10:34:37.560] Handling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):9015884435489914128:56:0)
[10:34:37.590] Build status: STARTED
[10:34:37.590] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):9015884435489914128:57:0) after 4m59s
[10:39:36.595] Handling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):9015884435489914128:57:0)
[10:39:36.618] Build status: STARTED
[10:39:36.618] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):9015884435489914128:58:0) after 5m31s
[10:45:07.749] Handling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):9015884435489914128:58:0)
[10:45:07.775] Build status: STARTED
[10:45:07.775] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):9015884435489914128:59:0) after 8m19s
[10:53:26.803] Handling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):9015884435489914128:59:0)
[10:53:26.826] Build status: STARTED
[10:53:26.826] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):9015884435489914128:60:0) after 3m55s
[10:57:21.856] Handling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):9015884435489914128:60:0)
[10:57:21.885] Build status: STARTED
[10:57:21.885] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):9015884435489914128:61:0) after 3m22s
[11:00:43.909] Handling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):9015884435489914128:61:0)
[11:00:43.971] Build status: STARTED
[11:00:43.971] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):9015884435489914128:62:0) after 6m26s
[11:07:09.996] Handling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):9015884435489914128:62:0)
[11:07:10.026] Build status: STARTED
[11:07:10.026] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):9015884435489914128:63:0) after 1m38s
[11:08:48.210] Handling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):9015884435489914128:63:0)
[11:08:48.244] Build status: STARTED
[11:08:48.244] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):9015884435489914128:64:0) after 2m17s
[11:11:05.275] Handling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):9015884435489914128:64:0)
[11:11:05.300] Build status: STARTED
[11:11:05.300] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):9015884435489914128:65:0) after 5m16s
[11:16:21.337] Handling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):9015884435489914128:65:0)
[11:16:21.364] Build status: STARTED
[11:16:21.364] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):9015884435489914128:66:0) after 2m1s
[11:18:22.507] Handling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):9015884435489914128:66:0)
[11:18:22.532] Build status: STARTED
[11:18:22.532] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):9015884435489914128:67:0) after 2m51s
[11:21:13.534] Handling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):9015884435489914128:67:0)
[11:21:13.563] Build status: STARTED
[11:21:13.563] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):9015884435489914128:68:0) after 6m28s
[11:27:41.754] Handling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):9015884435489914128:68:0)
[11:27:41.781] Build status: STARTED
[11:27:41.781] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):9015884435489914128:69:0) after 1m48s
[11:29:29.807] Handling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):9015884435489914128:69:0)
[11:29:29.837] Build status: STARTED
[11:29:29.837] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):9015884435489914128:70:0) after 5m22s
[11:34:51.867] Handling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):9015884435489914128:70:0)
[11:34:51.896] Build status: STARTED
[11:34:51.896] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):9015884435489914128:71:0) after 8m51s
[11:43:42.938] Handling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):9015884435489914128:71:0)
[11:43:42.970] Build status: STARTED
[11:43:42.970] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):9015884435489914128:72:0) after 1m29s
[11:45:12.075] Handling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):9015884435489914128:72:0)
[11:45:12.106] Build status: STARTED
[11:45:12.106] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):9015884435489914128:73:0) after 7m4s
[11:52:16.455] Handling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):9015884435489914128:73:0)
[11:52:16.489] Build status: STARTED
[11:52:16.489] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):9015884435489914128:74:0) after 6m20s
[11:58:36.550] Handling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):9015884435489914128:74:0)
[11:58:36.576] Build status: STARTED
[11:58:36.576] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):9015884435489914128:75:0) after 7m56s
[12:06:32.600] Handling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):9015884435489914128:75:0)
[12:06:32.629] Build status: STARTED
[12:06:32.629] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):9015884435489914128:76:0) after 4m23s
[12:10:55.653] Handling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):9015884435489914128:76:0)
[12:10:55.680] Build status: STARTED
[12:10:55.680] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):9015884435489914128:77:0) after 9m2s
[12:19:57.671] Handling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):9015884435489914128:77:0)
[12:19:57.719] Build status: STARTED
[12:19:57.719] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):9015884435489914128:78:0) after 2m45s
[12:22:42.752] Handling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):9015884435489914128:78:0)
[12:22:42.778] Build status: STARTED
[12:22:42.778] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):9015884435489914128:79:0) after 5m33s
[12:28:15.977] Handling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):9015884435489914128:79:0)
[12:28:16.006] Build status: STARTED
[12:28:16.006] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):9015884435489914128:80:0) after 1m45s
[12:30:01.026] Handling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):9015884435489914128:80:0)
[12:30:01.103] Build status: STARTED
[12:30:01.103] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):9015884435489914128:81:0) after 6m7s
[12:36:08.129] Handling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):9015884435489914128:81:0)
[12:36:08.212] Build status: STARTED
[12:36:08.212] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):9015884435489914128:82:0) after 7m33s
[12:43:41.340] Handling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):9015884435489914128:82:0)
[12:43:41.370] Build status: STARTED
[12:43:41.370] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):9015884435489914128:83:0) after 1m18s
[12:44:59.395] Handling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):9015884435489914128:83:0)
[12:44:59.425] Build status: STARTED
[12:44:59.425] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):9015884435489914128:84:0) after 5m54s
[12:50:53.556] Handling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):9015884435489914128:84:0)
[12:50:53.582] Build status: STARTED
[12:50:53.582] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):9015884435489914128:85:0) after 1m49s
[12:52:42.819] Handling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):9015884435489914128:85:0)
[12:52:42.847] Build status: STARTED
[12:52:42.847] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):9015884435489914128:86:0) after 7m43s
[13:00:25.830] Handling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):9015884435489914128:86:0)
[13:00:25.858] Build status: STARTED
[13:00:25.858] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):9015884435489914128:87:0) after 5m13s
[13:05:38.948] Handling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):9015884435489914128:87:0)
[13:05:38.976] Build status: STARTED
[13:05:38.976] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):9015884435489914128:88:0) after 4m3s
[13:09:42.187] Handling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):9015884435489914128:88:0)
[13:09:42.218] Build status: STARTED
[13:09:42.218] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):9015884435489914128:89:0) after 6m30s
[13:16:12.389] Handling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):9015884435489914128:89:0)
[13:16:12.420] Build status: STARTED
[13:16:12.420] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):9015884435489914128:90:0) after 5m37s
[13:21:49.521] Handling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):9015884435489914128:90:0)
[13:21:49.546] Build status: STARTED
[13:21:49.546] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):9015884435489914128:91:0) after 1m39s
[13:23:29.009] Handling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):9015884435489914128:91:0)
[13:23:29.037] Build status: STARTED
[13:23:29.037] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):9015884435489914128:92:0) after 7m49s
[13:31:18.340] Handling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):9015884435489914128:92:0)
[13:31:18.381] Build status: STARTED
[13:31:18.381] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):9015884435489914128:93:0) after 4m34s
[13:35:52.410] Handling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):9015884435489914128:93:0)
[13:35:52.438] Build status: STARTED
[13:35:52.438] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):9015884435489914128:94:0) after 5m16s
[13:41:08.464] Handling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):9015884435489914128:94:0)
[13:41:08.491] Build status: STARTED
[13:41:08.491] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):9015884435489914128:95:0) after 2m7s
[13:43:15.520] Handling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):9015884435489914128:95:0)
[13:43:15.547] Build status: STARTED
[13:43:15.547] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):9015884435489914128:96:0) after 4m58s
[13:48:13.575] Handling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):9015884435489914128:96:0)
[13:48:13.609] Build status: STARTED
[13:48:13.609] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):9015884435489914128:97:0) after 3m59s
[13:52:12.689] Handling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):9015884435489914128:97:0)
[13:52:12.715] Build status: STARTED
[13:52:12.715] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):9015884435489914128:98:0) after 9m23s
[14:01:35.752] Handling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):9015884435489914128:98:0)
[14:01:35.778] Build status: STARTED
[14:01:35.778] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):9015884435489914128:99:0) after 3m24s
[14:04:59.820] Handling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):9015884435489914128:99:0)
[14:04:59.849] Build status: STARTED
[14:04:59.849] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):9015884435489914128:100:0) after 8m2s
[14:13:02.058] Handling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):9015884435489914128:100:0)
[14:13:02.092] Build status: STARTED
[14:13:02.092] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):9015884435489914128:101:0) after 1m51s
[14:14:53.126] Handling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):9015884435489914128:101:0)
[14:14:53.153] Build status: STARTED
[14:14:53.153] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):9015884435489914128:102:0) after 2m28s
[14:17:21.180] Handling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):9015884435489914128:102:0)
[14:17:21.206] Build status: STARTED
[14:17:21.206] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):9015884435489914128:103:0) after 1m12s
[14:18:33.237] Handling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):9015884435489914128:103:0)
[14:18:33.266] Build status: STARTED
[14:18:33.266] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):9015884435489914128:104:0) after 6m14s
[14:24:47.326] Handling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):9015884435489914128:104:0)
[14:24:47.350] Build status: STARTED
[14:24:47.350] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):9015884435489914128:105:0) after 5m2s
[14:29:49.396] Handling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):9015884435489914128:105:0)
[14:29:49.438] Build status: STARTED
[14:29:49.438] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):9015884435489914128:106:0) after 9m13s
[14:39:02.468] Handling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):9015884435489914128:106:0)
[14:39:02.542] Build status: STARTED
[14:39:02.542] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):9015884435489914128:107:0) after 7m39s
[14:46:41.577] Handling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):9015884435489914128:107:0)
[14:46:41.607] Build status: STARTED
[14:46:41.607] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):9015884435489914128:108:0) after 4m53s
[14:51:34.737] Handling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):9015884435489914128:108:0)
[14:51:34.767] Build status: STARTED
[14:51:34.767] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):9015884435489914128:109:0) after 4m54s
[14:56:28.832] Handling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):9015884435489914128:109:0)
[14:56:28.862] Build status: STARTED
[14:56:28.862] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):9015884435489914128:110:0) after 5m11s
[15:01:39.890] Handling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):9015884435489914128:110:0)
[15:01:40.067] Build status: STARTED
[15:01:40.067] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):9015884435489914128:111:0) after 4m11s
[15:05:51.205] Handling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):9015884435489914128:111:0)
[15:05:51.247] Build status: STARTED
[15:05:51.247] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):9015884435489914128:112:0) after 7m32s
[15:13:23.548] Handling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):9015884435489914128:112:0)
[15:13:23.577] Build status: STARTED
[15:13:23.577] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):9015884435489914128:113:0) after 5m5s
[15:18:28.602] Handling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):9015884435489914128:113:0)
[15:18:28.638] Build status: STARTED
[15:18:28.638] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):9015884435489914128:114:0) after 5m42s
[15:24:10.665] Handling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):9015884435489914128:114:0)
[15:24:10.709] Build status: STARTED
[15:24:10.709] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):9015884435489914128:115:0) after 4m2s
[15:28:12.824] Handling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):9015884435489914128:115:0)
[15:28:12.916] Build status: STARTED
[15:28:12.916] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):9015884435489914128:116:0) after 4m53s
[15:33:05.905] Handling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):9015884435489914128:116:0)
[15:33:05.935] Build status: STARTED
[15:33:05.935] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):9015884435489914128:117:0) after 9m22s
[15:42:27.997] Handling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):9015884435489914128:117:0)
[15:42:28.027] Build status: STARTED
[15:42:28.027] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):9015884435489914128:118:0) after 5m9s
[15:47:37.072] Handling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):9015884435489914128:118:0)
[15:47:37.119] Build status: STARTED
[15:47:37.119] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):9015884435489914128:119:0) after 8m29s
[15:48:16.041] Received PubSub notification, asking Buildbucket for the build status
[15:48:16.076] Build:
{
"id": "8850454373380481744",
"builder": {
"project": "chromium",
"bucket": "ci",
"builder": "ToTMac (dbg)"
},
"number": 26391,
"createdBy": "project:chromium",
"createTime": "2021-04-09T05:26:37.789336Z",
"startTime": "2021-04-09T05:27:41.812470Z",
"endTime": "2021-04-09T15:48:15.735082543Z",
"updateTime": "2021-04-09T15:48:15.735418931Z",
"status": "FAILURE",
"input": {
"gitilesCommit": {
"host": "chromium.googlesource.com",
"project": "chromium/src",
"id": "6a20d970b515cf330f6f3d42c47b6bf07fc2d200",
"ref": "refs/heads/master"
}
}
}
[15:48:16.076] Invocation finished in 10h21m39.681507582s with status FAILED