[20:24:16.823] New invocation is queued and will start shortly
[20:24:18.170] Starting the invocation (attempt 1)
[20:24:18.210] Popped buildset tag "buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/d0181cd84f442e44e0dba1c930f46d5e2b21925a"
[20:24:18.210] Popped gitiles commit info from properties and tags
[20:24:18.211] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[20:24:18.211] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[20:24:18.211] Buildbucket request:
{
"requestId": "8964368881836572560",
"builder": {
"project": "chromium",
"bucket": "ci",
"builder": "ToTMac (dbg)"
},
"properties": {
},
"gitilesCommit": {
"host": "chromium.googlesource.com",
"project": "chromium/src",
"id": "d0181cd84f442e44e0dba1c930f46d5e2b21925a",
"ref": "refs/heads/main"
},
"tags": [
{
"key": "scheduler_invocation_id",
"value": "8964368881836572560"
},
{
"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"
}
}
[20:24:18.688] Scheduled build:
{
"id": "8798938819618926705",
"builder": {
"project": "chromium",
"bucket": "ci",
"builder": "ToTMac (dbg)"
},
"number": 29887,
"createdBy": "project:chromium",
"createTime": "2022-10-29T20:24:18.307177734Z",
"updateTime": "2022-10-29T20:24:18.307177734Z",
"status": "SCHEDULED",
"input": {
"gitilesCommit": {
"host": "chromium.googlesource.com",
"project": "chromium/src",
"id": "d0181cd84f442e44e0dba1c930f46d5e2b21925a",
"ref": "refs/heads/main"
}
}
}
[20:24:18.688] Task URL: https://cr-buildbucket.appspot.com/build/8798938819618926705
[20:24:18.688] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8964368881836572560:2:0) after 4m50s
[20:28:39.262] Received PubSub notification, asking Buildbucket for the build status
[20:28:39.301] Build status: STARTED
[20:29:08.820] Handling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8964368881836572560:2:0)
[20:29:08.857] Build status: STARTED
[20:29:08.857] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8964368881836572560:4:0) after 8m22s
[20:37:30.879] Handling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8964368881836572560:4:0)
[20:37:30.898] Build status: STARTED
[20:37:30.898] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8964368881836572560:5:0) after 4m49s
[20:42:20.265] Handling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8964368881836572560:5:0)
[20:42:20.286] Build status: STARTED
[20:42:20.286] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8964368881836572560:6:0) after 3m48s
[20:46:08.390] Handling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8964368881836572560:6:0)
[20:46:08.416] Build status: STARTED
[20:46:08.416] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8964368881836572560:7:0) after 1m7s
[20:47:15.427] Handling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8964368881836572560:7:0)
[20:47:15.476] Build status: STARTED
[20:47:15.477] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8964368881836572560:8:0) after 1m30s
[20:48:45.454] Handling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8964368881836572560:8:0)
[20:48:45.488] Build status: STARTED
[20:48:45.488] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8964368881836572560:9:0) after 7m20s
[20:56:05.578] Handling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8964368881836572560:9:0)
[20:56:05.609] Build status: STARTED
[20:56:05.610] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8964368881836572560:10:0) after 4m44s
[21:00:49.586] Handling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8964368881836572560:10:0)
[21:00:49.635] Build status: STARTED
[21:00:49.635] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8964368881836572560:11:0) after 5m22s
[21:06:11.727] Handling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8964368881836572560:11:0)
[21:06:11.752] Build status: STARTED
[21:06:11.752] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8964368881836572560:12:0) after 2m15s
[21:08:26.781] Handling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8964368881836572560:12:0)
[21:08:26.806] Build status: STARTED
[21:08:26.806] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8964368881836572560:13:0) after 9m51s
[21:18:17.827] Handling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8964368881836572560:13:0)
[21:18:17.849] Build status: STARTED
[21:18:17.849] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8964368881836572560:14:0) after 7m27s
[21:25:44.871] Handling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8964368881836572560:14:0)
[21:25:44.893] Build status: STARTED
[21:25:44.893] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8964368881836572560:15:0) after 5m7s
[21:30:51.919] Handling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8964368881836572560:15:0)
[21:30:51.944] Build status: STARTED
[21:30:51.944] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8964368881836572560:16:0) after 2m34s
[21:33:25.966] Handling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8964368881836572560:16:0)
[21:33:25.993] Build status: STARTED
[21:33:25.993] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8964368881836572560:17:0) after 6m37s
[21:40:03.018] Handling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8964368881836572560:17:0)
[21:40:03.072] Build status: STARTED
[21:40:03.072] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8964368881836572560:18:0) after 4m28s
[21:44:31.093] Handling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8964368881836572560:18:0)
[21:44:31.132] Build status: STARTED
[21:44:31.132] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8964368881836572560:19:0) after 4m18s
[21:48:49.356] Handling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8964368881836572560:19:0)
[21:48:49.377] Build status: STARTED
[21:48:49.377] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8964368881836572560:20:0) after 4m13s
[21:53:02.418] Handling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8964368881836572560:20:0)
[21:53:02.440] Build status: STARTED
[21:53:02.440] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8964368881836572560:21:0) after 8m16s
[22:01:18.562] Handling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8964368881836572560:21:0)
[22:01:18.589] Build status: STARTED
[22:01:18.589] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8964368881836572560:22:0) after 4m50s
[22:06:08.626] Handling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8964368881836572560:22:0)
[22:06:08.653] Build status: STARTED
[22:06:08.653] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8964368881836572560:23:0) after 1m41s
[22:07:49.674] Handling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8964368881836572560:23:0)
[22:07:49.701] Build status: STARTED
[22:07:49.701] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8964368881836572560:24:0) after 4m5s
[22:11:54.728] Handling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8964368881836572560:24:0)
[22:11:54.752] Build status: STARTED
[22:11:54.752] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8964368881836572560:25:0) after 2m44s
[22:14:38.771] Handling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8964368881836572560:25:0)
[22:14:38.792] Build status: STARTED
[22:14:38.792] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8964368881836572560:26:0) after 1m35s
[22:16:13.814] Handling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8964368881836572560:26:0)
[22:16:13.850] Build status: STARTED
[22:16:13.850] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8964368881836572560:27:0) after 3m28s
[22:19:41.943] Handling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8964368881836572560:27:0)
[22:19:41.965] Build status: STARTED
[22:19:41.965] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8964368881836572560:28:0) after 7m56s
[22:27:37.987] Handling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8964368881836572560:28:0)
[22:27:38.011] Build status: STARTED
[22:27:38.011] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8964368881836572560:29:0) after 2m29s
[22:30:07.038] Handling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8964368881836572560:29:0)
[22:30:07.059] Build status: STARTED
[22:30:07.059] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8964368881836572560:30:0) after 5m8s
[22:35:15.183] Handling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8964368881836572560:30:0)
[22:35:15.204] Build status: STARTED
[22:35:15.204] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8964368881836572560:31:0) after 5m36s
[22:40:51.194] Handling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8964368881836572560:31:0)
[22:40:51.216] Build status: STARTED
[22:40:51.216] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8964368881836572560:32:0) after 9m14s
[22:50:05.238] Handling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8964368881836572560:32:0)
[22:50:05.262] Build status: STARTED
[22:50:05.262] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8964368881836572560:33:0) after 2m11s
[22:52:16.463] Handling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8964368881836572560:33:0)
[22:52:16.495] Build status: STARTED
[22:52:16.495] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8964368881836572560:34:0) after 9m24s
[23:01:40.517] Handling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8964368881836572560:34:0)
[23:01:40.536] Build status: STARTED
[23:01:40.536] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8964368881836572560:35:0) after 7m44s
[23:09:24.636] Handling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8964368881836572560:35:0)
[23:09:24.657] Build status: STARTED
[23:09:24.657] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8964368881836572560:36:0) after 8m16s
[23:17:40.697] Handling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8964368881836572560:36:0)
[23:17:40.725] Build status: STARTED
[23:17:40.725] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8964368881836572560:37:0) after 4m6s
[23:21:47.031] Handling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8964368881836572560:37:0)
[23:21:47.056] Build status: STARTED
[23:21:47.056] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8964368881836572560:38:0) after 7m1s
[23:28:48.150] Handling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8964368881836572560:38:0)
[23:28:48.174] Build status: STARTED
[23:28:48.175] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8964368881836572560:39:0) after 2m55s
[23:31:43.167] Handling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8964368881836572560:39:0)
[23:31:43.188] Build status: STARTED
[23:31:43.188] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8964368881836572560:40:0) after 8m28s
[23:40:11.420] Handling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8964368881836572560:40:0)
[23:40:11.448] Build status: STARTED
[23:40:11.448] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8964368881836572560:41:0) after 7m52s
[23:48:03.529] Handling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8964368881836572560:41:0)
[23:48:03.581] Build status: STARTED
[23:48:03.581] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8964368881836572560:42:0) after 3m21s
[23:51:24.613] Handling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8964368881836572560:42:0)
[23:51:24.638] Build status: STARTED
[23:51:24.638] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8964368881836572560:43:0) after 7m7s
[23:58:31.658] Handling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8964368881836572560:43:0)
[23:58:31.695] Build status: STARTED
[23:58:31.695] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8964368881836572560:44:0) after 4m7s
[00:02:38.721] Handling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8964368881836572560:44:0)
[00:02:38.744] Build status: STARTED
[00:02:38.744] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8964368881836572560:45:0) after 1m12s
[00:03:50.795] Handling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8964368881836572560:45:0)
[00:03:50.823] Build status: STARTED
[00:03:50.823] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8964368881836572560:46:0) after 7m55s
[00:11:45.849] Handling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8964368881836572560:46:0)
[00:11:45.876] Build status: STARTED
[00:11:45.876] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8964368881836572560:47:0) after 7m21s
[00:19:06.876] Handling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8964368881836572560:47:0)
[00:19:06.900] Build status: STARTED
[00:19:06.900] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8964368881836572560:48:0) after 2m29s
[00:21:35.924] Handling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8964368881836572560:48:0)
[00:21:35.949] Build status: STARTED
[00:21:35.949] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8964368881836572560:49:0) after 6m29s
[00:28:04.971] Handling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8964368881836572560:49:0)
[00:28:04.992] Build status: STARTED
[00:28:04.992] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8964368881836572560:50:0) after 3m45s
[00:31:50.063] Handling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8964368881836572560:50:0)
[00:31:50.100] Build status: STARTED
[00:31:50.100] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8964368881836572560:51:0) after 4m29s
[00:36:19.148] Handling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8964368881836572560:51:0)
[00:36:19.174] Build status: STARTED
[00:36:19.174] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8964368881836572560:52:0) after 1m4s
[00:37:23.261] Handling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8964368881836572560:52:0)
[00:37:23.280] Build status: STARTED
[00:37:23.280] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8964368881836572560:53:0) after 9m25s
[00:46:48.299] Handling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8964368881836572560:53:0)
[00:46:48.326] Build status: STARTED
[00:46:48.326] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8964368881836572560:54:0) after 7m33s
[00:54:21.351] Handling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8964368881836572560:54:0)
[00:54:21.379] Build status: STARTED
[00:54:21.379] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8964368881836572560:55:0) after 8m36s
[01:02:57.401] Handling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8964368881836572560:55:0)
[01:02:57.426] Build status: STARTED
[01:02:57.426] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8964368881836572560:56:0) after 9m42s
[01:12:39.453] Handling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8964368881836572560:56:0)
[01:12:39.479] Build status: STARTED
[01:12:39.479] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8964368881836572560:57:0) after 7m47s
[01:20:26.708] Handling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8964368881836572560:57:0)
[01:20:26.743] Build status: STARTED
[01:20:26.743] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8964368881836572560:58:0) after 3m32s
[01:23:58.763] Handling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8964368881836572560:58:0)
[01:23:58.792] Build status: STARTED
[01:23:58.792] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8964368881836572560:59:0) after 6m50s
[01:30:48.813] Handling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8964368881836572560:59:0)
[01:30:48.843] Build status: STARTED
[01:30:48.843] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8964368881836572560:60:0) after 6m17s
[01:37:06.009] Handling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8964368881836572560:60:0)
[01:37:06.037] Build status: STARTED
[01:37:06.037] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8964368881836572560:61:0) after 5m38s
[01:42:44.068] Handling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8964368881836572560:61:0)
[01:42:44.092] Build status: STARTED
[01:42:44.092] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8964368881836572560:62:0) after 6m55s
[01:49:39.182] Handling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8964368881836572560:62:0)
[01:49:39.207] Build status: STARTED
[01:49:39.207] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8964368881836572560:63:0) after 5m16s
[01:54:55.227] Handling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8964368881836572560:63:0)
[01:54:55.247] Build status: STARTED
[01:54:55.247] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8964368881836572560:64:0) after 4m6s
[01:59:01.266] Handling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8964368881836572560:64:0)
[01:59:01.284] Build status: STARTED
[01:59:01.284] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8964368881836572560:65:0) after 1m45s
[02:00:46.516] Handling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8964368881836572560:65:0)
[02:00:46.540] Build status: STARTED
[02:00:46.540] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8964368881836572560:66:0) after 9m11s
[02:09:57.699] Handling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8964368881836572560:66:0)
[02:09:57.721] Build status: STARTED
[02:09:57.721] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8964368881836572560:67:0) after 8m28s
[02:18:25.813] Handling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8964368881836572560:67:0)
[02:18:25.854] Build status: STARTED
[02:18:25.854] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8964368881836572560:68:0) after 8m45s
[02:27:10.877] Handling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8964368881836572560:68:0)
[02:27:10.903] Build status: STARTED
[02:27:10.903] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8964368881836572560:69:0) after 9m37s
[02:36:47.973] Handling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8964368881836572560:69:0)
[02:36:48.003] Build status: STARTED
[02:36:48.003] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8964368881836572560:70:0) after 2m55s
[02:39:42.980] Handling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8964368881836572560:70:0)
[02:39:43.023] Build status: STARTED
[02:39:43.023] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8964368881836572560:71:0) after 7m29s
[02:47:12.088] Handling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8964368881836572560:71:0)
[02:47:12.109] Build status: STARTED
[02:47:12.109] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8964368881836572560:72:0) after 3m41s
[02:50:53.133] Handling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8964368881836572560:72:0)
[02:50:53.157] Build status: STARTED
[02:50:53.157] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8964368881836572560:73:0) after 3m32s
[02:54:25.178] Handling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8964368881836572560:73:0)
[02:54:25.203] Build status: STARTED
[02:54:25.203] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8964368881836572560:74:0) after 7m32s
[03:01:57.226] Handling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8964368881836572560:74:0)
[03:01:57.248] Build status: STARTED
[03:01:57.249] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8964368881836572560:75:0) after 7m51s
[03:09:48.274] Handling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8964368881836572560:75:0)
[03:09:48.305] Build status: STARTED
[03:09:48.305] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8964368881836572560:76:0) after 3m43s
[03:13:31.411] Handling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8964368881836572560:76:0)
[03:13:31.434] Build status: STARTED
[03:13:31.434] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8964368881836572560:77:0) after 8m46s
[03:22:17.527] Handling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8964368881836572560:77:0)
[03:22:17.559] Build status: STARTED
[03:22:17.559] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8964368881836572560:78:0) after 5m32s
[03:27:49.583] Handling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8964368881836572560:78:0)
[03:27:49.605] Build status: STARTED
[03:27:49.605] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8964368881836572560:79:0) after 3m8s
[03:30:57.706] Handling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8964368881836572560:79:0)
[03:30:57.734] Build status: STARTED
[03:30:57.734] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8964368881836572560:80:0) after 4m16s
[03:35:13.755] Handling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8964368881836572560:80:0)
[03:35:13.790] Build status: STARTED
[03:35:13.790] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8964368881836572560:81:0) after 1m4s
[03:36:17.825] Handling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8964368881836572560:81:0)
[03:36:17.913] Build status: STARTED
[03:36:17.913] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8964368881836572560:82:0) after 1m34s
[03:37:51.971] Handling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8964368881836572560:82:0)
[03:37:52.019] Build status: STARTED
[03:37:52.019] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8964368881836572560:83:0) after 7m3s
[03:44:55.816] Handling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8964368881836572560:83:0)
[03:44:55.844] Build status: STARTED
[03:44:55.844] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8964368881836572560:84:0) after 9m59s
[03:54:55.257] Handling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8964368881836572560:84:0)
[03:54:55.280] Build status: STARTED
[03:54:55.280] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8964368881836572560:85:0) after 8m31s
[04:03:26.302] Handling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8964368881836572560:85:0)
[04:03:26.327] Build status: STARTED
[04:03:26.327] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8964368881836572560:86:0) after 4m22s
[04:07:48.465] Handling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8964368881836572560:86:0)
[04:07:48.489] Build status: STARTED
[04:07:48.489] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8964368881836572560:87:0) after 3m58s
[04:11:46.969] Handling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8964368881836572560:87:0)
[04:11:46.990] Build status: STARTED
[04:11:46.990] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8964368881836572560:88:0) after 1m45s
[04:13:32.121] Handling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8964368881836572560:88:0)
[04:13:32.144] Build status: STARTED
[04:13:32.144] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8964368881836572560:89:0) after 8m53s
[04:22:25.222] Handling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8964368881836572560:89:0)
[04:22:25.244] Build status: STARTED
[04:22:25.244] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8964368881836572560:90:0) after 5m14s
[04:27:39.325] Handling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8964368881836572560:90:0)
[04:27:39.350] Build status: STARTED
[04:27:39.350] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8964368881836572560:91:0) after 3m29s
[04:31:08.419] Handling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8964368881836572560:91:0)
[04:31:08.453] Build status: STARTED
[04:31:08.453] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8964368881836572560:92:0) after 7m13s
[04:38:21.549] Handling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8964368881836572560:92:0)
[04:38:21.572] Build status: STARTED
[04:38:21.572] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8964368881836572560:93:0) after 3m55s
[04:42:16.602] Handling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8964368881836572560:93:0)
[04:42:16.625] Build status: STARTED
[04:42:16.625] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8964368881836572560:94:0) after 6m7s
[04:48:23.766] Handling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8964368881836572560:94:0)
[04:48:23.796] Build status: STARTED
[04:48:23.797] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8964368881836572560:95:0) after 5m28s
[04:53:51.931] Handling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8964368881836572560:95:0)
[04:53:51.953] Build status: STARTED
[04:53:51.953] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8964368881836572560:96:0) after 6m48s
[05:00:39.978] Handling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8964368881836572560:96:0)
[05:00:40.001] Build status: STARTED
[05:00:40.001] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8964368881836572560:97:0) after 8m46s
[05:09:26.077] Handling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8964368881836572560:97:0)
[05:09:26.101] Build status: STARTED
[05:09:26.101] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8964368881836572560:98:0) after 8m47s
[05:18:13.124] Handling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8964368881836572560:98:0)
[05:18:13.148] Build status: STARTED
[05:18:13.148] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8964368881836572560:99:0) after 3m59s
[05:22:12.175] Handling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8964368881836572560:99:0)
[05:22:12.206] Build status: STARTED
[05:22:12.206] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8964368881836572560:100:0) after 9m49s
[05:32:01.668] Handling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8964368881836572560:100:0)
[05:32:01.691] Build status: STARTED
[05:32:01.691] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8964368881836572560:101:0) after 2m49s
[05:34:50.714] Handling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8964368881836572560:101:0)
[05:34:50.733] Build status: STARTED
[05:34:50.733] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8964368881836572560:102:0) after 5m7s
[05:39:57.771] Handling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8964368881836572560:102:0)
[05:39:57.795] Build status: STARTED
[05:39:57.795] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8964368881836572560:103:0) after 4m32s
[05:44:29.828] Handling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8964368881836572560:103:0)
[05:44:29.848] Build status: STARTED
[05:44:29.848] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8964368881836572560:104:0) after 2m36s
[05:47:06.154] Handling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8964368881836572560:104:0)
[05:47:06.179] Build status: STARTED
[05:47:06.179] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8964368881836572560:105:0) after 2m34s
[05:49:40.340] Handling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8964368881836572560:105:0)
[05:49:40.366] Build status: STARTED
[05:49:40.367] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8964368881836572560:106:0) after 1m12s
[05:50:52.416] Handling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8964368881836572560:106:0)
[05:50:52.443] Build status: STARTED
[05:50:52.443] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8964368881836572560:107:0) after 1m59s
[05:52:51.475] Handling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8964368881836572560:107:0)
[05:52:51.499] Build status: STARTED
[05:52:51.499] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8964368881836572560:108:0) after 6m46s
[05:59:37.639] Handling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8964368881836572560:108:0)
[05:59:37.676] Build status: STARTED
[05:59:37.676] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8964368881836572560:109:0) after 2m34s
[06:02:11.796] Handling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8964368881836572560:109:0)
[06:02:11.901] Build status: STARTED
[06:02:11.901] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8964368881836572560:110:0) after 9m28s
[06:11:39.923] Handling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8964368881836572560:110:0)
[06:11:39.946] Build status: STARTED
[06:11:39.946] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8964368881836572560:111:0) after 5m16s
[06:16:56.047] Handling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8964368881836572560:111:0)
[06:16:56.069] Build status: STARTED
[06:16:56.069] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8964368881836572560:112:0) after 4m7s
[06:21:03.092] Handling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8964368881836572560:112:0)
[06:21:03.116] Build status: STARTED
[06:21:03.116] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8964368881836572560:113:0) after 2m26s
[06:23:29.155] Handling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8964368881836572560:113:0)
[06:23:29.181] Build status: STARTED
[06:23:29.181] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8964368881836572560:114:0) after 6m4s
[06:29:33.218] Handling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8964368881836572560:114:0)
[06:29:33.241] Build status: STARTED
[06:29:33.241] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8964368881836572560:115:0) after 6m42s
[06:36:15.263] Handling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8964368881836572560:115:0)
[06:36:15.292] Build status: STARTED
[06:36:15.292] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8964368881836572560:116:0) after 4m50s
[06:41:05.319] Handling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8964368881836572560:116:0)
[06:41:05.338] Build status: STARTED
[06:41:05.338] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8964368881836572560:117:0) after 2m17s
[06:43:22.361] Handling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8964368881836572560:117:0)
[06:43:22.388] Build status: STARTED
[06:43:22.388] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8964368881836572560:118:0) after 4m34s
[06:47:56.444] Handling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8964368881836572560:118:0)
[06:47:56.467] Build status: STARTED
[06:47:56.467] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8964368881836572560:119:0) after 9m12s
[06:57:08.705] Handling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8964368881836572560:119:0)
[06:57:08.726] Build status: STARTED
[06:57:08.726] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8964368881836572560:120:0) after 1m52s
[06:59:01.487] Handling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8964368881836572560:120:0)
[06:59:01.510] Build status: STARTED
[06:59:01.510] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8964368881836572560:121:0) after 6m11s
[07:05:12.619] Handling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8964368881836572560:121:0)
[07:05:12.645] Build status: STARTED
[07:05:12.645] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8964368881836572560:122:0) after 5m49s
[07:11:01.855] Handling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8964368881836572560:122:0)
[07:11:01.878] Build status: STARTED
[07:11:01.878] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8964368881836572560:123:0) after 7m11s
[07:18:12.940] Handling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8964368881836572560:123:0)
[07:18:12.964] Build status: STARTED
[07:18:12.964] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8964368881836572560:124:0) after 7m2s
[07:25:15.022] Handling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8964368881836572560:124:0)
[07:25:15.045] Build status: STARTED
[07:25:15.045] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8964368881836572560:125:0) after 5m14s
[07:30:29.072] Handling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8964368881836572560:125:0)
[07:30:29.096] Build status: STARTED
[07:30:29.096] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8964368881836572560:126:0) after 9m46s
[07:40:15.076] Handling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8964368881836572560:126:0)
[07:40:15.104] Build status: STARTED
[07:40:15.104] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8964368881836572560:127:0) after 5m5s
[07:45:20.279] Handling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8964368881836572560:127:0)
[07:45:20.309] Build status: STARTED
[07:45:20.309] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8964368881836572560:128:0) after 5m31s
[07:50:51.425] Handling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8964368881836572560:128:0)
[07:50:51.451] Build status: STARTED
[07:50:51.451] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8964368881836572560:129:0) after 5m32s
[07:56:23.454] Handling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8964368881836572560:129:0)
[07:56:23.498] Build status: STARTED
[07:56:23.498] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8964368881836572560:130:0) after 9m9s
[08:05:32.602] Handling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8964368881836572560:130:0)
[08:05:32.630] Build status: STARTED
[08:05:32.631] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8964368881836572560:131:0) after 6m15s
[08:06:56.672] Received PubSub notification, asking Buildbucket for the build status
[08:06:56.698] Build:
{
"id": "8798938819618926705",
"builder": {
"project": "chromium",
"bucket": "ci",
"builder": "ToTMac (dbg)"
},
"number": 29887,
"createdBy": "project:chromium",
"createTime": "2022-10-29T20:24:18.307177734Z",
"startTime": "2022-10-29T20:28:38.643839Z",
"endTime": "2022-10-30T08:06:56.396599601Z",
"updateTime": "2022-10-30T08:06:56.396599601Z",
"status": "SUCCESS",
"input": {
"gitilesCommit": {
"host": "chromium.googlesource.com",
"project": "chromium/src",
"id": "d0181cd84f442e44e0dba1c930f46d5e2b21925a",
"ref": "refs/heads/main"
}
}
}
[08:06:56.698] Invocation finished in 11h42m39.889473354s with status SUCCEEDED