[06:53:01.290] New invocation is queued and will start shortly
[06:53:02.467] Starting the invocation (attempt 1)
[06:53:02.503] Popped buildset tag "buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/9143dc2366b11b4f32883741f6d16e11a181f5a2"
[06:53:02.503] Popped gitiles commit info from properties and tags
[06:53:02.503] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[06:53:02.503] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[06:53:02.504] Buildbucket request:
{
"requestId": "8979640212187719728",
"builder": {
"project": "chromium",
"bucket": "ci",
"builder": "ToTMac (dbg)"
},
"properties": {
},
"gitilesCommit": {
"host": "chromium.googlesource.com",
"project": "chromium/src",
"id": "9143dc2366b11b4f32883741f6d16e11a181f5a2",
"ref": "refs/heads/main"
},
"tags": [
{
"key": "scheduler_invocation_id",
"value": "8979640212187719728"
},
{
"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"
}
}
[06:53:03.194] Scheduled build:
{
"id": "8814210150095914609",
"builder": {
"project": "chromium",
"bucket": "ci",
"builder": "ToTMac (dbg)"
},
"number": 28481,
"createdBy": "project:chromium",
"createTime": "2022-05-14T06:53:02.654195422Z",
"updateTime": "2022-05-14T06:53:02.654195422Z",
"status": "SCHEDULED",
"input": {
"gitilesCommit": {
"host": "chromium.googlesource.com",
"project": "chromium/src",
"id": "9143dc2366b11b4f32883741f6d16e11a181f5a2",
"ref": "refs/heads/main"
}
}
}
[06:53:03.194] Task URL: https://cr-buildbucket.appspot.com/build/8814210150095914609
[06:53:03.194] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8979640212187719728:2:0) after 2m32s
[06:55:35.324] Handling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8979640212187719728:2:0)
[06:55:35.406] Build status: SCHEDULED
[06:55:35.406] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8979640212187719728:3:0) after 3m11s
[06:58:46.571] Handling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8979640212187719728:3:0)
[06:58:46.588] Build status: SCHEDULED
[06:58:46.588] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8979640212187719728:4:0) after 5m20s
[07:04:06.918] Handling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8979640212187719728:4:0)
[07:04:06.939] Build status: SCHEDULED
[07:04:06.939] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8979640212187719728:5:0) after 6m12s
[07:10:18.976] Handling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8979640212187719728:5:0)
[07:10:19.065] Build status: SCHEDULED
[07:10:19.065] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8979640212187719728:6:0) after 7m23s
[07:17:42.115] Handling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8979640212187719728:6:0)
[07:17:42.140] Build status: SCHEDULED
[07:17:42.140] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8979640212187719728:7:0) after 9m52s
[07:27:34.330] Handling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8979640212187719728:7:0)
[07:27:34.357] Build status: SCHEDULED
[07:27:34.357] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8979640212187719728:8:0) after 3m17s
[07:30:51.398] Handling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8979640212187719728:8:0)
[07:30:51.418] Build status: SCHEDULED
[07:30:51.418] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8979640212187719728:9:0) after 5m0s
[07:35:51.511] Handling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8979640212187719728:9:0)
[07:35:51.542] Build status: SCHEDULED
[07:35:51.542] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8979640212187719728:10:0) after 4m18s
[07:36:16.862] Received PubSub notification, asking Buildbucket for the build status
[07:36:16.882] Build status: STARTED
[07:40:09.568] Handling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8979640212187719728:10:0)
[07:40:09.588] Build status: STARTED
[07:40:09.588] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8979640212187719728:12:0) after 5m14s
[07:45:23.636] Handling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8979640212187719728:12:0)
[07:45:23.693] Build status: STARTED
[07:45:23.693] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8979640212187719728:13:0) after 8m43s
[07:54:06.818] Handling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8979640212187719728:13:0)
[07:54:06.844] Build status: STARTED
[07:54:06.844] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8979640212187719728:14:0) after 7m38s
[08:01:44.868] Handling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8979640212187719728:14:0)
[08:01:44.888] Build status: STARTED
[08:01:44.888] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8979640212187719728:15:0) after 7m35s
[08:09:19.967] Handling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8979640212187719728:15:0)
[08:09:19.988] Build status: STARTED
[08:09:19.988] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8979640212187719728:16:0) after 5m49s
[08:15:09.019] Handling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8979640212187719728:16:0)
[08:15:09.059] Build status: STARTED
[08:15:09.059] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8979640212187719728:17:0) after 1m53s
[08:17:02.200] Handling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8979640212187719728:17:0)
[08:17:02.260] Build status: STARTED
[08:17:02.260] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8979640212187719728:18:0) after 8m59s
[08:26:01.293] Handling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8979640212187719728:18:0)
[08:26:01.322] Build status: STARTED
[08:26:01.322] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8979640212187719728:19:0) after 6m7s
[08:32:08.378] Handling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8979640212187719728:19:0)
[08:32:08.398] Build status: STARTED
[08:32:08.398] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8979640212187719728:20:0) after 5m19s
[08:37:27.423] Handling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8979640212187719728:20:0)
[08:37:27.446] Build status: STARTED
[08:37:27.446] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8979640212187719728:21:0) after 6m34s
[08:44:01.492] Handling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8979640212187719728:21:0)
[08:44:01.511] Build status: STARTED
[08:44:01.511] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8979640212187719728:22:0) after 4m35s
[08:48:36.537] Handling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8979640212187719728:22:0)
[08:48:36.563] Build status: STARTED
[08:48:36.563] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8979640212187719728:23:0) after 9m50s
[08:58:26.754] Handling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8979640212187719728:23:0)
[08:58:26.788] Build status: STARTED
[08:58:26.788] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8979640212187719728:24:0) after 8m47s
[09:07:13.820] Handling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8979640212187719728:24:0)
[09:07:13.861] Build status: STARTED
[09:07:13.861] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8979640212187719728:25:0) after 5m43s
[09:12:56.921] Handling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8979640212187719728:25:0)
[09:12:56.962] Build status: STARTED
[09:12:56.962] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8979640212187719728:26:0) after 2m51s
[09:15:48.035] Handling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8979640212187719728:26:0)
[09:15:48.070] Build status: STARTED
[09:15:48.070] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8979640212187719728:27:0) after 2m49s
[09:18:37.093] Handling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8979640212187719728:27:0)
[09:18:37.180] Build status: STARTED
[09:18:37.180] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8979640212187719728:28:0) after 7m36s
[09:26:13.204] Handling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8979640212187719728:28:0)
[09:26:13.228] Build status: STARTED
[09:26:13.228] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8979640212187719728:29:0) after 2m55s
[09:29:08.276] Handling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8979640212187719728:29:0)
[09:29:08.310] Build status: STARTED
[09:29:08.310] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8979640212187719728:30:0) after 9m47s
[09:38:55.335] Handling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8979640212187719728:30:0)
[09:38:55.365] Build status: STARTED
[09:38:55.365] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8979640212187719728:31:0) after 1m8s
[09:40:03.390] Handling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8979640212187719728:31:0)
[09:40:03.412] Build status: STARTED
[09:40:03.412] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8979640212187719728:32:0) after 3m52s
[09:43:55.579] Handling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8979640212187719728:32:0)
[09:43:55.600] Build status: STARTED
[09:43:55.600] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8979640212187719728:33:0) after 2m37s
[09:46:32.622] Handling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8979640212187719728:33:0)
[09:46:32.663] Build status: STARTED
[09:46:32.663] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8979640212187719728:34:0) after 9m30s
[09:56:02.706] Handling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8979640212187719728:34:0)
[09:56:02.789] Build status: STARTED
[09:56:02.789] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8979640212187719728:35:0) after 9m47s
[10:05:49.927] Handling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8979640212187719728:35:0)
[10:05:49.954] Build status: STARTED
[10:05:49.954] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8979640212187719728:36:0) after 5m8s
[10:10:57.984] Handling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8979640212187719728:36:0)
[10:10:58.007] Build status: STARTED
[10:10:58.007] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8979640212187719728:37:0) after 3m48s
[10:14:46.192] Handling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8979640212187719728:37:0)
[10:14:46.254] Build status: STARTED
[10:14:46.254] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8979640212187719728:38:0) after 9m41s
[10:24:27.280] Handling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8979640212187719728:38:0)
[10:24:27.319] Build status: STARTED
[10:24:27.319] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8979640212187719728:39:0) after 9m46s
[10:34:13.414] Handling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8979640212187719728:39:0)
[10:34:13.434] Build status: STARTED
[10:34:13.434] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8979640212187719728:40:0) after 6m27s
[10:40:41.038] Handling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8979640212187719728:40:0)
[10:40:41.065] Build status: STARTED
[10:40:41.065] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8979640212187719728:41:0) after 4m21s
[10:45:02.154] Handling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8979640212187719728:41:0)
[10:45:02.202] Build status: STARTED
[10:45:02.202] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8979640212187719728:42:0) after 8m28s
[10:53:30.332] Handling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8979640212187719728:42:0)
[10:53:30.358] Build status: STARTED
[10:53:30.358] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8979640212187719728:43:0) after 1m4s
[10:54:34.392] Handling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8979640212187719728:43:0)
[10:54:34.412] Build status: STARTED
[10:54:34.412] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8979640212187719728:44:0) after 9m39s
[11:04:13.439] Handling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8979640212187719728:44:0)
[11:04:13.460] Build status: STARTED
[11:04:13.460] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8979640212187719728:45:0) after 6m39s
[11:10:52.490] Handling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8979640212187719728:45:0)
[11:10:52.510] Build status: STARTED
[11:10:52.510] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8979640212187719728:46:0) after 3m9s
[11:14:01.694] Handling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8979640212187719728:46:0)
[11:14:01.716] Build status: STARTED
[11:14:01.716] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8979640212187719728:47:0) after 1m59s
[11:16:01.689] Handling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8979640212187719728:47:0)
[11:16:01.715] Build status: STARTED
[11:16:01.715] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8979640212187719728:48:0) after 4m27s
[11:20:28.737] Handling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8979640212187719728:48:0)
[11:20:28.770] Build status: STARTED
[11:20:28.770] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8979640212187719728:49:0) after 5m36s
[11:26:04.792] Handling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8979640212187719728:49:0)
[11:26:04.820] Build status: STARTED
[11:26:04.820] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8979640212187719728:50:0) after 7m5s
[11:33:09.977] Handling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8979640212187719728:50:0)
[11:33:09.997] Build status: STARTED
[11:33:09.997] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8979640212187719728:51:0) after 2m23s
[11:35:33.023] Handling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8979640212187719728:51:0)
[11:35:33.044] Build status: STARTED
[11:35:33.044] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8979640212187719728:52:0) after 9m33s
[11:45:06.140] Handling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8979640212187719728:52:0)
[11:45:06.171] Build status: STARTED
[11:45:06.171] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8979640212187719728:53:0) after 7m8s
[11:52:14.197] Handling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8979640212187719728:53:0)
[11:52:14.218] Build status: STARTED
[11:52:14.218] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8979640212187719728:54:0) after 1m38s
[11:53:52.402] Handling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8979640212187719728:54:0)
[11:53:52.423] Build status: STARTED
[11:53:52.423] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8979640212187719728:55:0) after 4m6s
[11:57:58.447] Handling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8979640212187719728:55:0)
[11:57:58.480] Build status: STARTED
[11:57:58.480] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8979640212187719728:56:0) after 2m9s
[12:00:07.525] Handling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8979640212187719728:56:0)
[12:00:07.563] Build status: STARTED
[12:00:07.563] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8979640212187719728:57:0) after 8m24s
[12:08:31.590] Handling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8979640212187719728:57:0)
[12:08:31.669] Build status: STARTED
[12:08:31.669] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8979640212187719728:58:0) after 6m52s
[12:15:24.163] Handling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8979640212187719728:58:0)
[12:15:24.188] Build status: STARTED
[12:15:24.188] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8979640212187719728:59:0) after 3m24s
[12:18:48.411] Handling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8979640212187719728:59:0)
[12:18:48.447] Build status: STARTED
[12:18:48.447] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8979640212187719728:60:0) after 7m55s
[12:26:43.688] Handling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8979640212187719728:60:0)
[12:26:43.708] Build status: STARTED
[12:26:43.709] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8979640212187719728:61:0) after 4m25s
[12:31:08.931] Handling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8979640212187719728:61:0)
[12:31:08.952] Build status: STARTED
[12:31:08.952] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8979640212187719728:62:0) after 2m7s
[12:33:15.977] Handling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8979640212187719728:62:0)
[12:33:16.004] Build status: STARTED
[12:33:16.004] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8979640212187719728:63:0) after 9m38s
[12:42:54.058] Handling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8979640212187719728:63:0)
[12:42:54.092] Build status: STARTED
[12:42:54.092] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8979640212187719728:64:0) after 4m15s
[12:47:09.117] Handling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8979640212187719728:64:0)
[12:47:09.151] Build status: STARTED
[12:47:09.151] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8979640212187719728:65:0) after 1m40s
[12:48:49.174] Handling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8979640212187719728:65:0)
[12:48:49.205] Build status: STARTED
[12:48:49.205] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8979640212187719728:66:0) after 7m28s
[12:56:17.231] Handling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8979640212187719728:66:0)
[12:56:17.289] Build status: STARTED
[12:56:17.289] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8979640212187719728:67:0) after 2m53s
[12:59:10.312] Handling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8979640212187719728:67:0)
[12:59:10.343] Build status: STARTED
[12:59:10.343] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8979640212187719728:68:0) after 2m8s
[13:01:18.401] Handling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8979640212187719728:68:0)
[13:01:18.431] Build status: STARTED
[13:01:18.431] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8979640212187719728:69:0) after 7m47s
[13:09:05.457] Handling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8979640212187719728:69:0)
[13:09:05.481] Build status: STARTED
[13:09:05.481] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8979640212187719728:70:0) after 8m4s
[13:17:09.509] Handling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8979640212187719728:70:0)
[13:17:09.620] Build status: STARTED
[13:17:09.620] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8979640212187719728:71:0) after 3m36s
[13:20:45.655] Handling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8979640212187719728:71:0)
[13:20:45.677] Build status: STARTED
[13:20:45.677] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8979640212187719728:72:0) after 3m18s
[13:24:03.703] Handling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8979640212187719728:72:0)
[13:24:03.734] Build status: STARTED
[13:24:03.734] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8979640212187719728:73:0) after 9m28s
[13:33:31.767] Handling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8979640212187719728:73:0)
[13:33:31.789] Build status: STARTED
[13:33:31.789] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8979640212187719728:74:0) after 4m22s
[13:37:53.969] Handling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8979640212187719728:74:0)
[13:37:53.992] Build status: STARTED
[13:37:53.992] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8979640212187719728:75:0) after 8m1s
[13:45:55.204] Handling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8979640212187719728:75:0)
[13:45:55.226] Build status: STARTED
[13:45:55.226] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8979640212187719728:76:0) after 8m33s
[13:54:28.737] Handling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8979640212187719728:76:0)
[13:54:28.761] Build status: STARTED
[13:54:28.761] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8979640212187719728:77:0) after 4m44s
[13:59:13.077] Handling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8979640212187719728:77:0)
[13:59:13.114] Build status: STARTED
[13:59:13.114] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8979640212187719728:78:0) after 2m33s
[14:01:46.142] Handling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8979640212187719728:78:0)
[14:01:46.187] Build status: STARTED
[14:01:46.187] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8979640212187719728:79:0) after 6m14s
[14:08:01.031] Handling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8979640212187719728:79:0)
[14:08:01.058] Build status: STARTED
[14:08:01.058] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8979640212187719728:80:0) after 5m54s
[14:13:55.309] Handling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8979640212187719728:80:0)
[14:13:55.337] Build status: STARTED
[14:13:55.337] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8979640212187719728:81:0) after 4m8s
[14:18:03.370] Handling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8979640212187719728:81:0)
[14:18:03.399] Build status: STARTED
[14:18:03.399] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8979640212187719728:82:0) after 7m19s
[14:25:22.535] Handling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8979640212187719728:82:0)
[14:25:22.557] Build status: STARTED
[14:25:22.557] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8979640212187719728:83:0) after 2m18s
[14:27:40.581] Handling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8979640212187719728:83:0)
[14:27:40.615] Build status: STARTED
[14:27:40.615] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8979640212187719728:84:0) after 2m7s
[14:29:48.423] Handling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8979640212187719728:84:0)
[14:29:48.451] Build status: STARTED
[14:29:48.451] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8979640212187719728:85:0) after 3m29s
[14:33:18.195] Handling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8979640212187719728:85:0)
[14:33:18.231] Build status: STARTED
[14:33:18.231] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8979640212187719728:86:0) after 9m52s
[14:43:10.306] Handling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8979640212187719728:86:0)
[14:43:10.361] Build status: STARTED
[14:43:10.361] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8979640212187719728:87:0) after 7m48s
[14:50:58.484] Handling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8979640212187719728:87:0)
[14:50:58.507] Build status: STARTED
[14:50:58.508] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8979640212187719728:88:0) after 3m2s
[14:54:00.533] Handling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8979640212187719728:88:0)
[14:54:00.555] Build status: STARTED
[14:54:00.555] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8979640212187719728:89:0) after 2m35s
[14:56:35.907] Handling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8979640212187719728:89:0)
[14:56:35.954] Build status: STARTED
[14:56:35.954] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8979640212187719728:90:0) after 8m20s
[15:04:55.985] Handling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8979640212187719728:90:0)
[15:04:56.009] Build status: STARTED
[15:04:56.009] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8979640212187719728:91:0) after 2m13s
[15:07:09.476] Handling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8979640212187719728:91:0)
[15:07:09.553] Build status: STARTED
[15:07:09.553] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8979640212187719728:92:0) after 2m13s
[15:09:22.778] Handling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8979640212187719728:92:0)
[15:09:22.802] Build status: STARTED
[15:09:22.802] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8979640212187719728:93:0) after 8m4s
[15:17:26.913] Handling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8979640212187719728:93:0)
[15:17:26.950] Build status: STARTED
[15:17:26.950] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8979640212187719728:94:0) after 2m59s
[15:20:26.001] Handling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8979640212187719728:94:0)
[15:20:26.033] Build status: STARTED
[15:20:26.033] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8979640212187719728:95:0) after 3m40s
[15:24:06.256] Handling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8979640212187719728:95:0)
[15:24:06.293] Build status: STARTED
[15:24:06.293] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8979640212187719728:96:0) after 8m2s
[15:32:08.325] Handling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8979640212187719728:96:0)
[15:32:08.348] Build status: STARTED
[15:32:08.348] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8979640212187719728:97:0) after 8m36s
[15:40:44.505] Handling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8979640212187719728:97:0)
[15:40:44.531] Build status: STARTED
[15:40:44.531] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8979640212187719728:98:0) after 9m45s
[15:50:29.556] Handling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8979640212187719728:98:0)
[15:50:29.609] Build status: STARTED
[15:50:29.609] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8979640212187719728:99:0) after 1m47s
[15:52:16.679] Handling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8979640212187719728:99:0)
[15:52:16.731] Build status: STARTED
[15:52:16.731] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8979640212187719728:100:0) after 1m35s
[15:53:51.858] Handling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8979640212187719728:100:0)
[15:53:51.878] Build status: STARTED
[15:53:51.878] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8979640212187719728:101:0) after 3m31s
[15:57:22.933] Handling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8979640212187719728:101:0)
[15:57:22.963] Build status: STARTED
[15:57:22.963] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8979640212187719728:102:0) after 4m21s
[16:01:44.084] Handling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8979640212187719728:102:0)
[16:01:44.110] Build status: STARTED
[16:01:44.110] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8979640212187719728:103:0) after 3m19s
[16:05:03.136] Handling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8979640212187719728:103:0)
[16:05:03.163] Build status: STARTED
[16:05:03.163] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8979640212187719728:104:0) after 5m45s
[16:10:48.195] Handling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8979640212187719728:104:0)
[16:10:48.275] Build status: STARTED
[16:10:48.275] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8979640212187719728:105:0) after 2m33s
[16:13:21.303] Handling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8979640212187719728:105:0)
[16:13:21.326] Build status: STARTED
[16:13:21.326] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8979640212187719728:106:0) after 4m58s
[16:18:19.476] Handling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8979640212187719728:106:0)
[16:18:19.501] Build status: STARTED
[16:18:19.501] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8979640212187719728:107:0) after 1m36s
[16:19:55.529] Handling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8979640212187719728:107:0)
[16:19:55.555] Build status: STARTED
[16:19:55.555] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8979640212187719728:108:0) after 7m26s
[16:27:21.586] Handling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8979640212187719728:108:0)
[16:27:21.625] Build status: STARTED
[16:27:21.625] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8979640212187719728:109:0) after 6m13s
[16:33:34.660] Handling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8979640212187719728:109:0)
[16:33:34.757] Build status: STARTED
[16:33:34.757] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8979640212187719728:110:0) after 2m30s
[16:36:04.837] Handling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8979640212187719728:110:0)
[16:36:04.862] Build status: STARTED
[16:36:04.862] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8979640212187719728:111:0) after 9m59s
[16:46:03.888] Handling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8979640212187719728:111:0)
[16:46:03.920] Build status: STARTED
[16:46:03.921] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8979640212187719728:112:0) after 3m36s
[16:49:40.129] Handling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8979640212187719728:112:0)
[16:49:40.151] Build status: STARTED
[16:49:40.151] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8979640212187719728:113:0) after 8m6s
[16:57:46.182] Handling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8979640212187719728:113:0)
[16:57:46.205] Build status: STARTED
[16:57:46.205] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8979640212187719728:114:0) after 9m38s
[16:59:36.021] Received PubSub notification, asking Buildbucket for the build status
[16:59:36.047] Build:
{
"id": "8814210150095914609",
"builder": {
"project": "chromium",
"bucket": "ci",
"builder": "ToTMac (dbg)"
},
"number": 28481,
"createdBy": "project:chromium",
"createTime": "2022-05-14T06:53:02.654195422Z",
"startTime": "2022-05-14T07:36:15.674514Z",
"endTime": "2022-05-14T16:59:35.516642104Z",
"updateTime": "2022-05-14T16:59:35.516642104Z",
"status": "SUCCESS",
"input": {
"gitilesCommit": {
"host": "chromium.googlesource.com",
"project": "chromium/src",
"id": "9143dc2366b11b4f32883741f6d16e11a181f5a2",
"ref": "refs/heads/main"
}
}
}
[16:59:36.047] Invocation finished in 10h6m34.772911073s with status SUCCEEDED