[10:06:51.291] New invocation is queued and will start shortly
[10:06:52.462] Starting the invocation (attempt 1)
[10:06:52.498] Popped buildset tag "buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/870eb2f2d1841b041bea9c81427d20a1dd1eaf21"
[10:06:52.498] Popped gitiles commit info from properties and tags
[10:06:52.499] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[10:06:52.499] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[10:06:52.499] Buildbucket request:
{
"requestId": "8999559349855892000",
"builder": {
"project": "chromium",
"bucket": "ci",
"builder": "ToTMac (dbg)"
},
"properties": {
},
"gitilesCommit": {
"host": "chromium.googlesource.com",
"project": "chromium/src",
"id": "870eb2f2d1841b041bea9c81427d20a1dd1eaf21",
"ref": "refs/heads/main"
},
"tags": [
{
"key": "scheduler_invocation_id",
"value": "8999559349855892000"
},
{
"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"
}
}
[10:06:53.159] Scheduled build:
{
"id": "8834129287842648113",
"builder": {
"project": "chromium",
"bucket": "ci",
"builder": "ToTMac (dbg)"
},
"number": 27277,
"createdBy": "project:chromium",
"createTime": "2021-10-06T10:06:52.580737290Z",
"updateTime": "2021-10-06T10:06:52.850044681Z",
"status": "SCHEDULED",
"input": {
"gitilesCommit": {
"host": "chromium.googlesource.com",
"project": "chromium/src",
"id": "870eb2f2d1841b041bea9c81427d20a1dd1eaf21",
"ref": "refs/heads/main"
}
}
}
[10:06:53.159] Task URL: https://cr-buildbucket.appspot.com/build/8834129287842648113
[10:06:53.159] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8999559349855892000:2:0) after 6m57s
[10:11:14.705] Received PubSub notification, asking Buildbucket for the build status
[10:11:14.731] Build status: STARTED
[10:13:50.192] Handling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8999559349855892000:2:0)
[10:13:50.217] Build status: STARTED
[10:13:50.217] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8999559349855892000:4:0) after 4m21s
[10:18:11.271] Handling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8999559349855892000:4:0)
[10:18:11.300] Build status: STARTED
[10:18:11.300] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8999559349855892000:5:0) after 9m6s
[10:27:17.517] Handling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8999559349855892000:5:0)
[10:27:17.544] Build status: STARTED
[10:27:17.544] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8999559349855892000:6:0) after 7m43s
[10:35:00.527] Handling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8999559349855892000:6:0)
[10:35:00.598] Build status: STARTED
[10:35:00.598] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8999559349855892000:7:0) after 7m25s
[10:42:25.687] Handling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8999559349855892000:7:0)
[10:42:25.715] Build status: STARTED
[10:42:25.715] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8999559349855892000:8:0) after 4m11s
[10:46:36.743] Handling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8999559349855892000:8:0)
[10:46:36.803] Build status: STARTED
[10:46:36.803] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8999559349855892000:9:0) after 5m45s
[10:52:21.873] Handling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8999559349855892000:9:0)
[10:52:21.901] Build status: STARTED
[10:52:21.901] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8999559349855892000:10:0) after 6m15s
[10:58:36.922] Handling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8999559349855892000:10:0)
[10:58:37.004] Build status: STARTED
[10:58:37.004] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8999559349855892000:11:0) after 7m25s
[11:06:02.005] Handling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8999559349855892000:11:0)
[11:06:02.052] Build status: STARTED
[11:06:02.052] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8999559349855892000:12:0) after 7m26s
[11:13:28.074] Handling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8999559349855892000:12:0)
[11:13:28.114] Build status: STARTED
[11:13:28.114] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8999559349855892000:13:0) after 8m41s
[11:22:09.137] Handling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8999559349855892000:13:0)
[11:22:09.169] Build status: STARTED
[11:22:09.169] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8999559349855892000:14:0) after 9m7s
[11:31:16.197] Handling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8999559349855892000:14:0)
[11:31:16.222] Build status: STARTED
[11:31:16.222] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8999559349855892000:15:0) after 6m55s
[11:38:11.277] Handling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8999559349855892000:15:0)
[11:38:11.306] Build status: STARTED
[11:38:11.306] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8999559349855892000:16:0) after 4m1s
[11:42:12.352] Handling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8999559349855892000:16:0)
[11:42:12.381] Build status: STARTED
[11:42:12.381] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8999559349855892000:17:0) after 4m26s
[11:46:38.435] Handling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8999559349855892000:17:0)
[11:46:38.469] Build status: STARTED
[11:46:38.469] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8999559349855892000:18:0) after 2m10s
[11:48:48.480] Handling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8999559349855892000:18:0)
[11:48:48.503] Build status: STARTED
[11:48:48.503] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8999559349855892000:19:0) after 2m48s
[11:51:36.560] Handling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8999559349855892000:19:0)
[11:51:36.590] Build status: STARTED
[11:51:36.590] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8999559349855892000:20:0) after 9m14s
[12:00:50.750] Handling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8999559349855892000:20:0)
[12:00:50.784] Build status: STARTED
[12:00:50.784] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8999559349855892000:21:0) after 5m33s
[12:06:23.808] Handling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8999559349855892000:21:0)
[12:06:24.942] Build status: STARTED
[12:06:24.942] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8999559349855892000:22:0) after 3m49s
[12:10:13.969] Handling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8999559349855892000:22:0)
[12:10:13.997] Build status: STARTED
[12:10:13.997] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8999559349855892000:23:0) after 9m11s
[12:19:25.020] Handling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8999559349855892000:23:0)
[12:19:25.049] Build status: STARTED
[12:19:25.049] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8999559349855892000:24:0) after 5m43s
[12:25:08.174] Handling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8999559349855892000:24:0)
[12:25:08.215] Build status: STARTED
[12:25:08.215] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8999559349855892000:25:0) after 5m10s
[12:30:18.247] Handling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8999559349855892000:25:0)
[12:30:18.279] Build status: STARTED
[12:30:18.279] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8999559349855892000:26:0) after 9m49s
[12:40:07.310] Handling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8999559349855892000:26:0)
[12:40:07.335] Build status: STARTED
[12:40:07.335] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8999559349855892000:27:0) after 9m16s
[12:49:23.366] Handling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8999559349855892000:27:0)
[12:49:23.412] Build status: STARTED
[12:49:23.412] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8999559349855892000:28:0) after 1m26s
[12:50:49.549] Handling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8999559349855892000:28:0)
[12:50:49.578] Build status: STARTED
[12:50:49.578] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8999559349855892000:29:0) after 8m40s
[12:59:29.656] Handling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8999559349855892000:29:0)
[12:59:29.688] Build status: STARTED
[12:59:29.688] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8999559349855892000:30:0) after 7m57s
[13:07:26.861] Handling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8999559349855892000:30:0)
[13:07:26.891] Build status: STARTED
[13:07:26.891] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8999559349855892000:31:0) after 4m16s
[13:11:42.916] Handling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8999559349855892000:31:0)
[13:11:42.943] Build status: STARTED
[13:11:42.943] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8999559349855892000:32:0) after 5m34s
[13:17:16.966] Handling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8999559349855892000:32:0)
[13:17:16.993] Build status: STARTED
[13:17:16.993] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8999559349855892000:33:0) after 8m50s
[13:26:07.016] Handling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8999559349855892000:33:0)
[13:26:07.048] Build status: STARTED
[13:26:07.048] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8999559349855892000:34:0) after 8m20s
[13:34:27.210] Handling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8999559349855892000:34:0)
[13:34:27.238] Build status: STARTED
[13:34:27.238] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8999559349855892000:35:0) after 1m13s
[13:35:40.291] Handling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8999559349855892000:35:0)
[13:35:40.354] Build status: STARTED
[13:35:40.354] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8999559349855892000:36:0) after 8m50s
[13:44:30.404] Handling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8999559349855892000:36:0)
[13:44:30.432] Build status: STARTED
[13:44:30.432] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8999559349855892000:37:0) after 3m23s
[13:47:53.457] Handling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8999559349855892000:37:0)
[13:47:53.489] Build status: STARTED
[13:47:53.489] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8999559349855892000:38:0) after 7m51s
[13:55:44.708] Handling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8999559349855892000:38:0)
[13:55:44.742] Build status: STARTED
[13:55:44.742] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8999559349855892000:39:0) after 1m28s
[13:57:12.769] Handling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8999559349855892000:39:0)
[13:57:12.815] Build status: STARTED
[13:57:12.815] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8999559349855892000:40:0) after 1m2s
[13:58:14.911] Handling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8999559349855892000:40:0)
[13:58:14.950] Build status: STARTED
[13:58:14.950] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8999559349855892000:41:0) after 3m11s
[14:01:25.981] Handling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8999559349855892000:41:0)
[14:01:26.020] Build status: STARTED
[14:01:26.020] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8999559349855892000:42:0) after 2m54s
[14:04:20.044] Handling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8999559349855892000:42:0)
[14:04:20.108] Build status: STARTED
[14:04:20.108] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8999559349855892000:43:0) after 5m38s
[14:09:58.566] Handling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8999559349855892000:43:0)
[14:09:58.642] Build status: STARTED
[14:09:58.642] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8999559349855892000:44:0) after 4m36s
[14:14:34.666] Handling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8999559349855892000:44:0)
[14:14:34.692] Build status: STARTED
[14:14:34.693] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8999559349855892000:45:0) after 3m45s
[14:18:19.715] Handling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8999559349855892000:45:0)
[14:18:19.749] Build status: STARTED
[14:18:19.749] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8999559349855892000:46:0) after 4m19s
[14:22:38.775] Handling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8999559349855892000:46:0)
[14:22:38.803] Build status: STARTED
[14:22:38.803] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8999559349855892000:47:0) after 7m53s
[14:30:31.827] Handling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8999559349855892000:47:0)
[14:30:31.863] Build status: STARTED
[14:30:31.863] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8999559349855892000:48:0) after 8m30s
[14:39:01.986] Handling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8999559349855892000:48:0)
[14:39:02.027] Build status: STARTED
[14:39:02.027] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8999559349855892000:49:0) after 2m16s
[14:41:18.057] Handling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8999559349855892000:49:0)
[14:41:19.444] Build status: STARTED
[14:41:19.444] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8999559349855892000:50:0) after 3m9s
[14:44:28.584] Handling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8999559349855892000:50:0)
[14:44:28.613] Build status: STARTED
[14:44:28.613] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8999559349855892000:51:0) after 5m45s
[14:50:13.644] Handling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8999559349855892000:51:0)
[14:50:13.691] Build status: STARTED
[14:50:13.691] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8999559349855892000:52:0) after 8m54s
[14:59:07.716] Handling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8999559349855892000:52:0)
[14:59:07.742] Build status: STARTED
[14:59:07.742] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8999559349855892000:53:0) after 4m30s
[15:03:37.766] Handling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8999559349855892000:53:0)
[15:03:37.813] Build status: STARTED
[15:03:37.813] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8999559349855892000:54:0) after 7m45s
[15:11:22.894] Handling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8999559349855892000:54:0)
[15:11:22.926] Build status: STARTED
[15:11:22.926] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8999559349855892000:55:0) after 1m24s
[15:12:47.085] Handling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8999559349855892000:55:0)
[15:12:47.118] Build status: STARTED
[15:12:47.118] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8999559349855892000:56:0) after 7m50s
[15:20:37.146] Handling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8999559349855892000:56:0)
[15:20:37.203] Build status: STARTED
[15:20:37.203] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8999559349855892000:57:0) after 6m34s
[15:27:11.235] Handling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8999559349855892000:57:0)
[15:27:11.267] Build status: STARTED
[15:27:11.267] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8999559349855892000:58:0) after 9m5s
[15:36:16.292] Handling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8999559349855892000:58:0)
[15:36:16.345] Build status: STARTED
[15:36:16.345] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8999559349855892000:59:0) after 8m1s
[15:44:17.369] Handling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8999559349855892000:59:0)
[15:44:17.412] Build status: STARTED
[15:44:17.412] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8999559349855892000:60:0) after 8m42s
[15:52:59.455] Handling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8999559349855892000:60:0)
[15:52:59.600] Build status: STARTED
[15:52:59.600] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8999559349855892000:61:0) after 2m0s
[15:54:59.678] Handling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8999559349855892000:61:0)
[15:54:59.732] Build status: STARTED
[15:54:59.732] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8999559349855892000:62:0) after 3m11s
[15:58:10.865] Handling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8999559349855892000:62:0)
[15:58:10.895] Build status: STARTED
[15:58:10.895] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8999559349855892000:63:0) after 2m55s
[16:01:05.926] Handling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8999559349855892000:63:0)
[16:01:05.972] Build status: STARTED
[16:01:05.972] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8999559349855892000:64:0) after 3m51s
[16:04:56.997] Handling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8999559349855892000:64:0)
[16:04:57.032] Build status: STARTED
[16:04:57.032] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8999559349855892000:65:0) after 1m6s
[16:06:03.181] Handling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8999559349855892000:65:0)
[16:06:03.209] Build status: STARTED
[16:06:03.209] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8999559349855892000:66:0) after 7m31s
[16:13:34.304] Handling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8999559349855892000:66:0)
[16:13:34.385] Build status: STARTED
[16:13:34.385] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8999559349855892000:67:0) after 2m24s
[16:15:58.427] Handling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8999559349855892000:67:0)
[16:15:58.619] Build status: STARTED
[16:15:58.619] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8999559349855892000:68:0) after 4m16s
[16:20:14.685] Handling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8999559349855892000:68:0)
[16:20:14.715] Build status: STARTED
[16:20:14.715] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8999559349855892000:69:0) after 6m4s
[16:26:18.738] Handling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8999559349855892000:69:0)
[16:26:18.802] Build status: STARTED
[16:26:18.802] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8999559349855892000:70:0) after 3m7s
[16:29:25.829] Handling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8999559349855892000:70:0)
[16:29:25.878] Build status: STARTED
[16:29:25.878] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8999559349855892000:71:0) after 4m8s
[16:33:33.946] Handling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8999559349855892000:71:0)
[16:33:33.982] Build status: STARTED
[16:33:33.983] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8999559349855892000:72:0) after 6m59s
[16:40:33.007] Handling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8999559349855892000:72:0)
[16:40:33.037] Build status: STARTED
[16:40:33.037] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8999559349855892000:73:0) after 9m27s
[16:50:01.061] Handling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8999559349855892000:73:0)
[16:50:01.092] Build status: STARTED
[16:50:01.092] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8999559349855892000:74:0) after 6m12s
[16:56:13.187] Handling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8999559349855892000:74:0)
[16:56:13.217] Build status: STARTED
[16:56:13.217] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8999559349855892000:75:0) after 1m7s
[16:57:20.467] Handling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8999559349855892000:75:0)
[16:57:20.493] Build status: STARTED
[16:57:20.493] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8999559349855892000:76:0) after 3m37s
[17:00:57.646] Handling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8999559349855892000:76:0)
[17:00:57.680] Build status: STARTED
[17:00:57.680] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8999559349855892000:77:0) after 2m14s
[17:03:11.714] Handling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8999559349855892000:77:0)
[17:03:11.745] Build status: STARTED
[17:03:11.745] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8999559349855892000:78:0) after 6m23s
[17:09:34.797] Handling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8999559349855892000:78:0)
[17:09:34.828] Build status: STARTED
[17:09:34.828] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8999559349855892000:79:0) after 1m56s
[17:11:31.025] Handling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8999559349855892000:79:0)
[17:11:31.057] Build status: STARTED
[17:11:31.057] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8999559349855892000:80:0) after 3m27s
[17:14:58.083] Handling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8999559349855892000:80:0)
[17:14:58.132] Build status: STARTED
[17:14:58.132] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8999559349855892000:81:0) after 3m7s
[17:18:05.347] Handling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8999559349855892000:81:0)
[17:18:05.381] Build status: STARTED
[17:18:05.381] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8999559349855892000:82:0) after 2m42s
[17:20:47.694] Handling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8999559349855892000:82:0)
[17:20:47.727] Build status: STARTED
[17:20:47.727] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8999559349855892000:83:0) after 8m2s
[17:28:49.913] Handling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8999559349855892000:83:0)
[17:28:49.945] Build status: STARTED
[17:28:49.945] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8999559349855892000:84:0) after 8m15s
[17:37:05.504] Handling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8999559349855892000:84:0)
[17:37:05.565] Build status: STARTED
[17:37:05.565] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8999559349855892000:85:0) after 2m43s
[17:39:48.587] Handling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8999559349855892000:85:0)
[17:39:48.615] Build status: STARTED
[17:39:48.615] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8999559349855892000:86:0) after 2m52s
[17:42:40.652] Handling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8999559349855892000:86:0)
[17:42:40.685] Build status: STARTED
[17:42:40.685] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8999559349855892000:87:0) after 1m44s
[17:44:24.982] Handling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8999559349855892000:87:0)
[17:44:25.032] Build status: STARTED
[17:44:25.032] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8999559349855892000:88:0) after 4m35s
[17:49:00.100] Handling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8999559349855892000:88:0)
[17:49:00.135] Build status: STARTED
[17:49:00.135] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8999559349855892000:89:0) after 6m40s
[17:55:40.179] Handling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8999559349855892000:89:0)
[17:55:40.272] Build status: STARTED
[17:55:40.272] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8999559349855892000:90:0) after 2m38s
[17:58:18.662] Handling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8999559349855892000:90:0)
[17:58:18.690] Build status: STARTED
[17:58:18.690] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8999559349855892000:91:0) after 1m23s
[17:59:41.966] Handling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8999559349855892000:91:0)
[17:59:41.997] Build status: STARTED
[17:59:41.997] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8999559349855892000:92:0) after 2m11s
[18:01:53.115] Handling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8999559349855892000:92:0)
[18:01:53.153] Build status: STARTED
[18:01:53.153] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8999559349855892000:93:0) after 7m27s
[18:09:20.188] Handling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8999559349855892000:93:0)
[18:09:20.225] Build status: STARTED
[18:09:20.225] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8999559349855892000:94:0) after 8m3s
[18:17:23.629] Handling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8999559349855892000:94:0)
[18:17:23.671] Build status: STARTED
[18:17:23.671] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8999559349855892000:95:0) after 3m46s
[18:21:09.857] Handling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8999559349855892000:95:0)
[18:21:09.892] Build status: STARTED
[18:21:09.892] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8999559349855892000:96:0) after 1m44s
[18:22:54.156] Handling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8999559349855892000:96:0)
[18:22:54.207] Build status: STARTED
[18:22:54.207] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8999559349855892000:97:0) after 9m54s
[18:32:48.309] Handling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8999559349855892000:97:0)
[18:32:48.379] Build status: STARTED
[18:32:48.379] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8999559349855892000:98:0) after 2m46s
[18:35:34.399] Handling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8999559349855892000:98:0)
[18:35:34.432] Build status: STARTED
[18:35:34.432] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8999559349855892000:99:0) after 5m27s
[18:41:02.142] Handling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8999559349855892000:99:0)
[18:41:02.176] Build status: STARTED
[18:41:02.176] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8999559349855892000:100:0) after 3m5s
[18:44:07.381] Handling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8999559349855892000:100:0)
[18:44:07.422] Build status: STARTED
[18:44:07.422] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8999559349855892000:101:0) after 3m35s
[18:47:42.735] Handling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8999559349855892000:101:0)
[18:47:42.839] Build status: STARTED
[18:47:42.839] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8999559349855892000:102:0) after 2m40s
[18:50:23.072] Handling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8999559349855892000:102:0)
[18:50:23.108] Build status: STARTED
[18:50:23.108] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8999559349855892000:103:0) after 9m16s
[18:59:39.139] Handling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8999559349855892000:103:0)
[18:59:39.170] Build status: STARTED
[18:59:39.170] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8999559349855892000:104:0) after 4m13s
[19:03:52.188] Handling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8999559349855892000:104:0)
[19:03:52.227] Build status: STARTED
[19:03:52.227] Scheduling timer "check-buildbucket-build-status" (chromium/ToTMac (dbg):8999559349855892000:105:0) after 6m35s
[19:07:58.803] Received PubSub notification, asking Buildbucket for the build status
[19:07:58.834] Build:
{
"id": "8834129287842648113",
"builder": {
"project": "chromium",
"bucket": "ci",
"builder": "ToTMac (dbg)"
},
"number": 27277,
"createdBy": "project:chromium",
"createTime": "2021-10-06T10:06:52.580737290Z",
"startTime": "2021-10-06T10:11:14.081989Z",
"endTime": "2021-10-06T19:07:58.336227006Z",
"updateTime": "2021-10-06T19:07:58.336548909Z",
"status": "SUCCESS",
"input": {
"gitilesCommit": {
"host": "chromium.googlesource.com",
"project": "chromium/src",
"id": "870eb2f2d1841b041bea9c81427d20a1dd1eaf21",
"ref": "refs/heads/main"
}
}
}
[19:07:58.834] Invocation finished in 9h1m7.558082334s with status SUCCEEDED