[14:55:46.230] New invocation is queued and will start shortly
[14:55:47.316] Starting the invocation (attempt 1)
[14:55:47.358] Popped buildset tag "buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/171828781311b7e0a92a6dbef3f0c4867fd801bb"
[14:55:47.358] Popped gitiles commit info from properties and tags
[14:55:47.358] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[14:55:47.358] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[14:55:47.358] Buildbucket request:
{
"requestId": "8977979094851712400",
"builder": {
"project": "chromium",
"bucket": "ci",
"builder": "ToTMac (dbg)"
},
"properties": {
},
"gitilesCommit": {
"host": "chromium.googlesource.com",
"project": "chromium/src",
"id": "171828781311b7e0a92a6dbef3f0c4867fd801bb",
"ref": "refs/heads/main"
},
"tags": [
{
"key": "scheduler_invocation_id",
"value": "8977979094851712400"
},
{
"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"
}
}
[14:55:47.913] Scheduled build:
{
"id": "8812549032886006657",
"builder": {
"project": "chromium",
"bucket": "ci",
"builder": "ToTMac (dbg)"
},
"number": 28520,
"createdBy": "project:chromium",
"createTime": "2022-06-01T14:55:47.473281799Z",
"updateTime": "2022-06-01T14:55:47.473281799Z",
"status": "SCHEDULED",
"input": {
"gitilesCommit": {
"host": "chromium.googlesource.com",
"project": "chromium/src",
"id": "171828781311b7e0a92a6dbef3f0c4867fd801bb",
"ref": "refs/heads/main"
}
}
}
[14:55:47.913] Task URL: https://cr-buildbucket.appspot.com/build/8812549032886006657
[14:55:47.913] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8977979094851712400:2:0) after 9m30s
[15:05:17.958] Handling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8977979094851712400:2:0)
[15:05:17.979] Build status: SCHEDULED
[15:05:17.979] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8977979094851712400:3:0) after 2m20s
[15:07:38.284] Handling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8977979094851712400:3:0)
[15:07:38.322] Build status: SCHEDULED
[15:07:38.322] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8977979094851712400:4:0) after 4m43s
[15:12:21.422] Handling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8977979094851712400:4:0)
[15:12:21.453] Build status: SCHEDULED
[15:12:21.453] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8977979094851712400:5:0) after 3m41s
[15:16:02.487] Handling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8977979094851712400:5:0)
[15:16:02.524] Build status: SCHEDULED
[15:16:02.524] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8977979094851712400:6:0) after 9m30s
[15:25:32.586] Handling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8977979094851712400:6:0)
[15:25:32.634] Build status: SCHEDULED
[15:25:32.634] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8977979094851712400:7:0) after 1m16s
[15:26:48.660] Handling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8977979094851712400:7:0)
[15:26:48.688] Build status: SCHEDULED
[15:26:48.688] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8977979094851712400:8:0) after 1m31s
[15:28:19.717] Handling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8977979094851712400:8:0)
[15:28:19.747] Build status: SCHEDULED
[15:28:19.747] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8977979094851712400:9:0) after 8m15s
[15:36:34.773] Handling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8977979094851712400:9:0)
[15:36:34.822] Build status: SCHEDULED
[15:36:34.822] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8977979094851712400:10:0) after 3m51s
[15:40:25.955] Handling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8977979094851712400:10:0)
[15:40:26.002] Build status: SCHEDULED
[15:40:26.002] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8977979094851712400:11:0) after 4m16s
[15:44:42.142] Handling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8977979094851712400:11:0)
[15:44:42.184] Build status: SCHEDULED
[15:44:42.184] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8977979094851712400:12:0) after 2m19s
[15:47:01.232] Handling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8977979094851712400:12:0)
[15:47:01.256] Build status: SCHEDULED
[15:47:01.256] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8977979094851712400:13:0) after 8m37s
[15:51:01.401] Received PubSub notification, asking Buildbucket for the build status
[15:51:01.439] Build status: STARTED
[15:55:38.281] Handling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8977979094851712400:13:0)
[15:55:38.301] Build status: STARTED
[15:55:38.301] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8977979094851712400:15:0) after 1m58s
[15:57:36.440] Handling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8977979094851712400:15:0)
[15:57:36.464] Build status: STARTED
[15:57:36.464] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8977979094851712400:16:0) after 3m31s
[16:01:07.669] Handling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8977979094851712400:16:0)
[16:01:07.714] Build status: STARTED
[16:01:07.714] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8977979094851712400:17:0) after 6m42s
[16:07:49.741] Handling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8977979094851712400:17:0)
[16:07:49.791] Build status: STARTED
[16:07:49.791] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8977979094851712400:18:0) after 2m20s
[16:10:09.817] Handling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8977979094851712400:18:0)
[16:10:09.839] Build status: STARTED
[16:10:09.839] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8977979094851712400:19:0) after 2m37s
[16:12:46.971] Handling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8977979094851712400:19:0)
[16:12:46.991] Build status: STARTED
[16:12:46.991] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8977979094851712400:20:0) after 4m31s
[16:17:18.018] Handling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8977979094851712400:20:0)
[16:17:18.042] Build status: STARTED
[16:17:18.042] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8977979094851712400:21:0) after 4m46s
[16:22:04.068] Handling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8977979094851712400:21:0)
[16:22:04.108] Build status: STARTED
[16:22:04.108] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8977979094851712400:22:0) after 5m23s
[16:27:27.141] Handling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8977979094851712400:22:0)
[16:27:27.191] Build status: STARTED
[16:27:27.191] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8977979094851712400:23:0) after 6m2s
[16:33:29.204] Handling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8977979094851712400:23:0)
[16:33:29.230] Build status: STARTED
[16:33:29.230] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8977979094851712400:24:0) after 2m11s
[16:35:40.276] Handling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8977979094851712400:24:0)
[16:35:40.301] Build status: STARTED
[16:35:40.301] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8977979094851712400:25:0) after 8m36s
[16:44:16.333] Handling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8977979094851712400:25:0)
[16:44:16.359] Build status: STARTED
[16:44:16.359] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8977979094851712400:26:0) after 8m25s
[16:52:41.492] Handling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8977979094851712400:26:0)
[16:52:41.515] Build status: STARTED
[16:52:41.515] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8977979094851712400:27:0) after 4m32s
[16:57:13.633] Handling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8977979094851712400:27:0)
[16:57:13.682] Build status: STARTED
[16:57:13.682] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8977979094851712400:28:0) after 7m48s
[17:05:01.836] Handling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8977979094851712400:28:0)
[17:05:01.864] Build status: STARTED
[17:05:01.864] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8977979094851712400:29:0) after 6m39s
[17:11:40.953] Handling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8977979094851712400:29:0)
[17:11:40.991] Build status: STARTED
[17:11:40.991] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8977979094851712400:30:0) after 6m10s
[17:17:51.145] Handling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8977979094851712400:30:0)
[17:17:51.171] Build status: STARTED
[17:17:51.171] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8977979094851712400:31:0) after 7m13s
[17:25:04.218] Handling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8977979094851712400:31:0)
[17:25:04.239] Build status: STARTED
[17:25:04.239] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8977979094851712400:32:0) after 1m42s
[17:26:46.322] Handling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8977979094851712400:32:0)
[17:26:46.343] Build status: STARTED
[17:26:46.343] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8977979094851712400:33:0) after 1m31s
[17:28:17.645] Handling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8977979094851712400:33:0)
[17:28:17.668] Build status: STARTED
[17:28:17.668] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8977979094851712400:34:0) after 4m1s
[17:32:18.786] Handling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8977979094851712400:34:0)
[17:32:18.832] Build status: STARTED
[17:32:18.832] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8977979094851712400:35:0) after 9m29s
[17:41:47.867] Handling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8977979094851712400:35:0)
[17:41:47.888] Build status: STARTED
[17:41:47.888] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8977979094851712400:36:0) after 6m6s
[17:47:54.008] Handling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8977979094851712400:36:0)
[17:47:54.029] Build status: STARTED
[17:47:54.029] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8977979094851712400:37:0) after 4m14s
[17:52:08.057] Handling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8977979094851712400:37:0)
[17:52:08.089] Build status: STARTED
[17:52:08.089] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8977979094851712400:38:0) after 7m38s
[17:59:46.116] Handling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8977979094851712400:38:0)
[17:59:46.135] Build status: STARTED
[17:59:46.136] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8977979094851712400:39:0) after 6m1s
[18:05:47.230] Handling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8977979094851712400:39:0)
[18:05:47.311] Build status: STARTED
[18:05:47.311] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8977979094851712400:40:0) after 3m17s
[18:09:04.337] Handling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8977979094851712400:40:0)
[18:09:04.365] Build status: STARTED
[18:09:04.365] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8977979094851712400:41:0) after 2m27s
[18:11:31.392] Handling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8977979094851712400:41:0)
[18:11:31.412] Build status: STARTED
[18:11:31.412] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8977979094851712400:42:0) after 1m29s
[18:13:00.447] Handling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8977979094851712400:42:0)
[18:13:00.480] Build status: STARTED
[18:13:00.480] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8977979094851712400:43:0) after 5m3s
[18:18:03.509] Handling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8977979094851712400:43:0)
[18:18:03.567] Build status: STARTED
[18:18:03.567] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8977979094851712400:44:0) after 4m7s
[18:22:10.663] Handling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8977979094851712400:44:0)
[18:22:10.703] Build status: STARTED
[18:22:10.703] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8977979094851712400:45:0) after 7m50s
[18:30:00.900] Handling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8977979094851712400:45:0)
[18:30:00.937] Build status: STARTED
[18:30:00.937] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8977979094851712400:46:0) after 9m1s
[18:39:02.031] Handling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8977979094851712400:46:0)
[18:39:02.052] Build status: STARTED
[18:39:02.052] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8977979094851712400:47:0) after 7m40s
[18:46:42.082] Handling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8977979094851712400:47:0)
[18:46:42.111] Build status: STARTED
[18:46:42.111] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8977979094851712400:48:0) after 3m29s
[18:50:11.298] Handling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8977979094851712400:48:0)
[18:50:11.335] Build status: STARTED
[18:50:11.336] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8977979094851712400:49:0) after 7m48s
[18:57:59.565] Handling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8977979094851712400:49:0)
[18:57:59.601] Build status: STARTED
[18:57:59.601] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8977979094851712400:50:0) after 5m36s
[19:03:36.127] Handling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8977979094851712400:50:0)
[19:03:36.164] Build status: STARTED
[19:03:36.164] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8977979094851712400:51:0) after 6m45s
[19:10:21.198] Handling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8977979094851712400:51:0)
[19:10:21.220] Build status: STARTED
[19:10:21.220] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8977979094851712400:52:0) after 7m7s
[19:17:28.273] Handling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8977979094851712400:52:0)
[19:17:28.295] Build status: STARTED
[19:17:28.295] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8977979094851712400:53:0) after 3m18s
[19:20:46.492] Handling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8977979094851712400:53:0)
[19:20:46.531] Build status: STARTED
[19:20:46.531] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8977979094851712400:54:0) after 8m35s
[19:29:21.579] Handling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8977979094851712400:54:0)
[19:29:21.617] Build status: STARTED
[19:29:21.617] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8977979094851712400:55:0) after 5m37s
[19:34:58.647] Handling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8977979094851712400:55:0)
[19:34:58.683] Build status: STARTED
[19:34:58.683] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8977979094851712400:56:0) after 9m22s
[19:44:20.751] Handling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8977979094851712400:56:0)
[19:44:20.928] Build status: STARTED
[19:44:20.928] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8977979094851712400:57:0) after 5m25s
[19:49:45.958] Handling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8977979094851712400:57:0)
[19:49:45.997] Build status: STARTED
[19:49:45.997] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8977979094851712400:58:0) after 1m14s
[19:51:00.067] Handling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8977979094851712400:58:0)
[19:51:00.093] Build status: STARTED
[19:51:00.093] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8977979094851712400:59:0) after 2m24s
[19:53:24.218] Handling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8977979094851712400:59:0)
[19:53:24.239] Build status: STARTED
[19:53:24.239] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8977979094851712400:60:0) after 2m20s
[19:55:44.317] Handling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8977979094851712400:60:0)
[19:55:44.344] Build status: STARTED
[19:55:44.344] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8977979094851712400:61:0) after 2m20s
[19:58:04.419] Handling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8977979094851712400:61:0)
[19:58:04.458] Build status: STARTED
[19:58:04.458] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8977979094851712400:62:0) after 2m2s
[20:00:06.698] Handling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8977979094851712400:62:0)
[20:00:06.726] Build status: STARTED
[20:00:06.726] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8977979094851712400:63:0) after 2m26s
[20:02:32.839] Handling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8977979094851712400:63:0)
[20:02:33.096] Build status: STARTED
[20:02:33.096] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8977979094851712400:64:0) after 2m51s
[20:05:24.175] Handling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8977979094851712400:64:0)
[20:05:24.200] Build status: STARTED
[20:05:24.200] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8977979094851712400:65:0) after 7m4s
[20:12:28.213] Handling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8977979094851712400:65:0)
[20:12:28.240] Build status: STARTED
[20:12:28.240] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8977979094851712400:66:0) after 1m50s
[20:14:18.458] Handling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8977979094851712400:66:0)
[20:14:18.494] Build status: STARTED
[20:14:18.494] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8977979094851712400:67:0) after 3m11s
[20:17:29.645] Handling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8977979094851712400:67:0)
[20:17:29.696] Build status: STARTED
[20:17:29.696] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8977979094851712400:68:0) after 6m3s
[20:23:32.745] Handling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8977979094851712400:68:0)
[20:23:32.772] Build status: STARTED
[20:23:32.772] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8977979094851712400:69:0) after 7m39s
[20:31:11.803] Handling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8977979094851712400:69:0)
[20:31:11.828] Build status: STARTED
[20:31:11.828] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8977979094851712400:70:0) after 7m57s
[20:39:08.984] Handling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8977979094851712400:70:0)
[20:39:09.036] Build status: STARTED
[20:39:09.036] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8977979094851712400:71:0) after 2m31s
[20:41:40.433] Handling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8977979094851712400:71:0)
[20:41:40.468] Build status: STARTED
[20:41:40.468] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8977979094851712400:72:0) after 3m19s
[20:44:59.515] Handling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8977979094851712400:72:0)
[20:44:59.550] Build status: STARTED
[20:44:59.550] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8977979094851712400:73:0) after 6m15s
[20:51:14.662] Handling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8977979094851712400:73:0)
[20:51:14.727] Build status: STARTED
[20:51:14.727] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8977979094851712400:74:0) after 9m36s
[21:00:50.820] Handling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8977979094851712400:74:0)
[21:00:50.859] Build status: STARTED
[21:00:50.859] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8977979094851712400:75:0) after 4m31s
[21:05:22.042] Handling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8977979094851712400:75:0)
[21:05:22.075] Build status: STARTED
[21:05:22.075] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8977979094851712400:76:0) after 6m26s
[21:11:48.597] Handling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8977979094851712400:76:0)
[21:11:48.620] Build status: STARTED
[21:11:48.620] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8977979094851712400:77:0) after 4m51s
[21:16:39.920] Handling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8977979094851712400:77:0)
[21:16:39.943] Build status: STARTED
[21:16:39.944] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8977979094851712400:78:0) after 8m42s
[21:25:22.211] Handling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8977979094851712400:78:0)
[21:25:22.237] Build status: STARTED
[21:25:22.237] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8977979094851712400:79:0) after 4m51s
[21:30:13.483] Handling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8977979094851712400:79:0)
[21:30:13.505] Build status: STARTED
[21:30:13.505] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8977979094851712400:80:0) after 4m25s
[21:34:38.611] Handling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8977979094851712400:80:0)
[21:34:38.664] Build status: STARTED
[21:34:38.664] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8977979094851712400:81:0) after 9m50s
[21:44:28.774] Handling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8977979094851712400:81:0)
[21:44:28.795] Build status: STARTED
[21:44:28.795] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8977979094851712400:82:0) after 9m52s
[21:54:20.938] Handling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8977979094851712400:82:0)
[21:54:20.961] Build status: STARTED
[21:54:20.961] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8977979094851712400:83:0) after 2m29s
[21:56:50.023] Handling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8977979094851712400:83:0)
[21:56:50.057] Build status: STARTED
[21:56:50.057] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8977979094851712400:84:0) after 2m27s
[21:59:17.083] Handling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8977979094851712400:84:0)
[21:59:17.137] Build status: STARTED
[21:59:17.137] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8977979094851712400:85:0) after 8m11s
[22:07:28.168] Handling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8977979094851712400:85:0)
[22:07:28.331] Build status: STARTED
[22:07:28.331] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8977979094851712400:86:0) after 4m47s
[22:12:15.408] Handling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8977979094851712400:86:0)
[22:12:15.432] Build status: STARTED
[22:12:15.432] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8977979094851712400:87:0) after 8m6s
[22:20:21.773] Handling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8977979094851712400:87:0)
[22:20:21.793] Build status: STARTED
[22:20:21.793] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8977979094851712400:88:0) after 1m28s
[22:21:50.040] Handling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8977979094851712400:88:0)
[22:21:50.071] Build status: STARTED
[22:21:50.071] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8977979094851712400:89:0) after 9m56s
[22:31:46.112] Handling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8977979094851712400:89:0)
[22:31:46.164] Build status: STARTED
[22:31:46.164] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8977979094851712400:90:0) after 1m25s
[22:33:11.148] Handling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8977979094851712400:90:0)
[22:33:11.175] Build status: STARTED
[22:33:11.175] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8977979094851712400:91:0) after 9m24s
[22:42:35.237] Handling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8977979094851712400:91:0)
[22:42:35.261] Build status: STARTED
[22:42:35.261] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8977979094851712400:92:0) after 3m38s
[22:46:13.343] Handling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8977979094851712400:92:0)
[22:46:13.368] Build status: STARTED
[22:46:13.368] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8977979094851712400:93:0) after 3m38s
[22:49:51.414] Handling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8977979094851712400:93:0)
[22:49:51.437] Build status: STARTED
[22:49:51.437] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8977979094851712400:94:0) after 4m51s
[22:54:42.465] Handling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8977979094851712400:94:0)
[22:54:42.496] Build status: STARTED
[22:54:42.496] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8977979094851712400:95:0) after 2m43s
[22:57:25.525] Handling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8977979094851712400:95:0)
[22:57:25.554] Build status: STARTED
[22:57:25.554] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8977979094851712400:96:0) after 9m2s
[23:06:27.581] Handling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8977979094851712400:96:0)
[23:06:27.607] Build status: STARTED
[23:06:27.607] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8977979094851712400:97:0) after 9m13s
[23:15:40.656] Handling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8977979094851712400:97:0)
[23:15:40.737] Build status: STARTED
[23:15:40.737] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8977979094851712400:98:0) after 5m24s
[23:21:04.776] Handling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8977979094851712400:98:0)
[23:21:04.832] Build status: STARTED
[23:21:04.832] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8977979094851712400:99:0) after 8m44s
[23:29:49.131] Handling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8977979094851712400:99:0)
[23:29:49.189] Build status: STARTED
[23:29:49.189] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8977979094851712400:100:0) after 4m33s
[23:34:22.303] Handling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8977979094851712400:100:0)
[23:34:22.325] Build status: STARTED
[23:34:22.325] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8977979094851712400:101:0) after 5m41s
[23:40:03.526] Handling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8977979094851712400:101:0)
[23:40:03.571] Build status: STARTED
[23:40:03.571] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8977979094851712400:102:0) after 3m21s
[23:43:24.603] Handling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8977979094851712400:102:0)
[23:43:24.624] Build status: STARTED
[23:43:24.624] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8977979094851712400:103:0) after 7m25s
[23:50:49.858] Handling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8977979094851712400:103:0)
[23:50:49.878] Build status: STARTED
[23:50:49.878] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8977979094851712400:104:0) after 2m34s
[23:53:23.940] Handling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8977979094851712400:104:0)
[23:53:23.976] Build status: STARTED
[23:53:23.976] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8977979094851712400:105:0) after 8m30s
[00:01:54.156] Handling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8977979094851712400:105:0)
[00:01:54.219] Build status: STARTED
[00:01:54.219] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8977979094851712400:106:0) after 6m11s
[00:08:05.684] Handling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8977979094851712400:106:0)
[00:08:05.736] Build status: STARTED
[00:08:05.736] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8977979094851712400:107:0) after 6m53s
[00:14:58.814] Handling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8977979094851712400:107:0)
[00:14:58.858] Build status: STARTED
[00:14:58.858] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8977979094851712400:108:0) after 2m43s
[00:17:42.122] Handling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8977979094851712400:108:0)
[00:17:42.174] Build status: STARTED
[00:17:42.174] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8977979094851712400:109:0) after 1m43s
[00:19:25.347] Handling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8977979094851712400:109:0)
[00:19:25.384] Build status: STARTED
[00:19:25.384] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8977979094851712400:110:0) after 2m0s
[00:21:25.850] Handling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8977979094851712400:110:0)
[00:21:25.873] Build status: STARTED
[00:21:25.873] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8977979094851712400:111:0) after 5m22s
[00:26:48.002] Handling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8977979094851712400:111:0)
[00:26:48.027] Build status: STARTED
[00:26:48.027] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8977979094851712400:112:0) after 1m2s
[00:27:50.009] Handling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8977979094851712400:112:0)
[00:27:50.030] Build status: STARTED
[00:27:50.031] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8977979094851712400:113:0) after 3m5s
[00:30:55.205] Handling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8977979094851712400:113:0)
[00:30:55.225] Build status: STARTED
[00:30:55.271] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8977979094851712400:114:0) after 1m34s
[00:32:29.416] Handling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8977979094851712400:114:0)
[00:32:29.439] Build status: STARTED
[00:32:29.439] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8977979094851712400:115:0) after 6m44s
[00:39:13.531] Handling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8977979094851712400:115:0)
[00:39:13.564] Build status: STARTED
[00:39:13.564] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8977979094851712400:116:0) after 2m2s
[00:41:15.865] Handling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8977979094851712400:116:0)
[00:41:15.887] Build status: STARTED
[00:41:15.887] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8977979094851712400:117:0) after 6m47s
[00:48:03.286] Handling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8977979094851712400:117:0)
[00:48:03.309] Build status: STARTED
[00:48:03.309] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8977979094851712400:118:0) after 4m46s
[00:52:49.362] Handling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8977979094851712400:118:0)
[00:52:49.382] Build status: STARTED
[00:52:49.382] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8977979094851712400:119:0) after 3m11s
[00:56:00.569] Handling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8977979094851712400:119:0)
[00:56:00.596] Build status: STARTED
[00:56:00.596] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8977979094851712400:120:0) after 6m3s
[01:02:03.630] Handling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8977979094851712400:120:0)
[01:02:03.655] Build status: STARTED
[01:02:03.656] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8977979094851712400:121:0) after 9m33s
[01:11:36.692] Handling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8977979094851712400:121:0)
[01:11:36.722] Build status: STARTED
[01:11:36.722] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8977979094851712400:122:0) after 3m32s
[01:15:08.763] Handling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8977979094851712400:122:0)
[01:15:08.827] Build status: STARTED
[01:15:08.827] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8977979094851712400:123:0) after 8m32s
[01:23:40.871] Handling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8977979094851712400:123:0)
[01:23:40.902] Build status: STARTED
[01:23:40.902] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8977979094851712400:124:0) after 2m39s
[01:24:23.006] Received PubSub notification, asking Buildbucket for the build status
[01:24:23.027] Build:
{
"id": "8812549032886006657",
"builder": {
"project": "chromium",
"bucket": "ci",
"builder": "ToTMac (dbg)"
},
"number": 28520,
"createdBy": "project:chromium",
"createTime": "2022-06-01T14:55:47.473281799Z",
"startTime": "2022-06-01T15:51:00.675451Z",
"endTime": "2022-06-02T01:24:19.218049387Z",
"updateTime": "2022-06-02T01:24:19.218049387Z",
"status": "SUCCESS",
"input": {
"gitilesCommit": {
"host": "chromium.googlesource.com",
"project": "chromium/src",
"id": "171828781311b7e0a92a6dbef3f0c4867fd801bb",
"ref": "refs/heads/main"
}
}
}
[01:24:23.027] Invocation finished in 10h28m36.812761008s with status SUCCEEDED