[20:59:44.825] New invocation is queued and will start shortly
[20:59:46.034] Starting the invocation (attempt 1)
[20:59:46.075] Popped buildset tag "buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/984a7d0013c3dff5227986b18fd660b938b298c9"
[20:59:46.075] Popped gitiles commit info from properties and tags
[20:59:46.075] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[20:59:46.075] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[20:59:46.075] Buildbucket request:
{
"requestId": "8986925295097633216",
"builder": {
"project": "chromium",
"bucket": "ci",
"builder": "ToTChromeOS"
},
"properties": {
},
"gitilesCommit": {
"host": "chromium.googlesource.com",
"project": "chromium/src",
"id": "984a7d0013c3dff5227986b18fd660b938b298c9",
"ref": "refs/heads/main"
},
"tags": [
{
"key": "scheduler_invocation_id",
"value": "8986925295097633216"
},
{
"key": "scheduler_job_id",
"value": "chromium/ToTChromeOS"
},
{
"key": "user_agent",
"value": "luci-scheduler"
}
],
"notify": {
"pubsubTopic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
}
}
[20:59:46.586] Scheduled build:
{
"id": "8821495233059903409",
"builder": {
"project": "chromium",
"bucket": "ci",
"builder": "ToTChromeOS"
},
"number": 650,
"createdBy": "project:chromium",
"createTime": "2022-02-22T20:59:46.138060085Z",
"updateTime": "2022-02-22T20:59:46.138060085Z",
"status": "SCHEDULED",
"input": {
"gitilesCommit": {
"host": "chromium.googlesource.com",
"project": "chromium/src",
"id": "984a7d0013c3dff5227986b18fd660b938b298c9",
"ref": "refs/heads/main"
}
}
}
[20:59:46.586] Task URL: https://cr-buildbucket.appspot.com/build/8821495233059903409
[20:59:46.586] Scheduling timer "check-buildbucket-build-status" (chromium/ToTChromeOS:8986925295097633216:2:0) after 1m32s
[21:00:11.636] Received PubSub notification, asking Buildbucket for the build status
[21:00:11.695] Build status: STARTED
[21:01:18.684] Handling timer "check-buildbucket-build-status" (chromium/ToTChromeOS:8986925295097633216:2:0)
[21:01:18.761] Build status: STARTED
[21:01:18.761] Scheduling timer "check-buildbucket-build-status" (chromium/ToTChromeOS:8986925295097633216:4:0) after 2m52s
[21:04:10.897] Handling timer "check-buildbucket-build-status" (chromium/ToTChromeOS:8986925295097633216:4:0)
[21:04:10.919] Build status: STARTED
[21:04:10.919] Scheduling timer "check-buildbucket-build-status" (chromium/ToTChromeOS:8986925295097633216:5:0) after 2m28s
[21:06:39.194] Handling timer "check-buildbucket-build-status" (chromium/ToTChromeOS:8986925295097633216:5:0)
[21:06:39.213] Build status: STARTED
[21:06:39.213] Scheduling timer "check-buildbucket-build-status" (chromium/ToTChromeOS:8986925295097633216:6:0) after 1m57s
[21:08:36.384] Handling timer "check-buildbucket-build-status" (chromium/ToTChromeOS:8986925295097633216:6:0)
[21:08:36.404] Build status: STARTED
[21:08:36.404] Scheduling timer "check-buildbucket-build-status" (chromium/ToTChromeOS:8986925295097633216:7:0) after 7m51s
[21:16:27.390] Handling timer "check-buildbucket-build-status" (chromium/ToTChromeOS:8986925295097633216:7:0)
[21:16:27.410] Build status: STARTED
[21:16:27.410] Scheduling timer "check-buildbucket-build-status" (chromium/ToTChromeOS:8986925295097633216:8:0) after 8m8s
[21:24:36.195] Handling timer "check-buildbucket-build-status" (chromium/ToTChromeOS:8986925295097633216:8:0)
[21:24:36.257] Build status: STARTED
[21:24:36.257] Scheduling timer "check-buildbucket-build-status" (chromium/ToTChromeOS:8986925295097633216:9:0) after 3m51s
[21:28:27.292] Handling timer "check-buildbucket-build-status" (chromium/ToTChromeOS:8986925295097633216:9:0)
[21:28:27.351] Build status: STARTED
[21:28:27.351] Scheduling timer "check-buildbucket-build-status" (chromium/ToTChromeOS:8986925295097633216:10:0) after 9m33s
[21:38:00.631] Handling timer "check-buildbucket-build-status" (chromium/ToTChromeOS:8986925295097633216:10:0)
[21:38:00.652] Build status: STARTED
[21:38:00.652] Scheduling timer "check-buildbucket-build-status" (chromium/ToTChromeOS:8986925295097633216:11:0) after 5m55s
[21:43:55.735] Handling timer "check-buildbucket-build-status" (chromium/ToTChromeOS:8986925295097633216:11:0)
[21:43:55.758] Build status: STARTED
[21:43:55.758] Scheduling timer "check-buildbucket-build-status" (chromium/ToTChromeOS:8986925295097633216:12:0) after 8m52s
[21:52:48.040] Handling timer "check-buildbucket-build-status" (chromium/ToTChromeOS:8986925295097633216:12:0)
[21:52:48.059] Build status: STARTED
[21:52:48.059] Scheduling timer "check-buildbucket-build-status" (chromium/ToTChromeOS:8986925295097633216:13:0) after 2m30s
[21:55:18.198] Handling timer "check-buildbucket-build-status" (chromium/ToTChromeOS:8986925295097633216:13:0)
[21:55:18.223] Build status: STARTED
[21:55:18.223] Scheduling timer "check-buildbucket-build-status" (chromium/ToTChromeOS:8986925295097633216:14:0) after 2m26s
[21:57:44.246] Handling timer "check-buildbucket-build-status" (chromium/ToTChromeOS:8986925295097633216:14:0)
[21:57:44.262] Build status: STARTED
[21:57:44.263] Scheduling timer "check-buildbucket-build-status" (chromium/ToTChromeOS:8986925295097633216:15:0) after 6m1s
[22:03:45.475] Handling timer "check-buildbucket-build-status" (chromium/ToTChromeOS:8986925295097633216:15:0)
[22:03:45.497] Build status: STARTED
[22:03:45.497] Scheduling timer "check-buildbucket-build-status" (chromium/ToTChromeOS:8986925295097633216:16:0) after 8m8s
[22:11:53.585] Handling timer "check-buildbucket-build-status" (chromium/ToTChromeOS:8986925295097633216:16:0)
[22:11:53.611] Build status: STARTED
[22:11:53.611] Scheduling timer "check-buildbucket-build-status" (chromium/ToTChromeOS:8986925295097633216:17:0) after 7m32s
[22:19:25.746] Handling timer "check-buildbucket-build-status" (chromium/ToTChromeOS:8986925295097633216:17:0)
[22:19:25.778] Build status: STARTED
[22:19:25.778] Scheduling timer "check-buildbucket-build-status" (chromium/ToTChromeOS:8986925295097633216:18:0) after 8m41s
[22:28:06.800] Handling timer "check-buildbucket-build-status" (chromium/ToTChromeOS:8986925295097633216:18:0)
[22:28:06.822] Build status: STARTED
[22:28:06.822] Scheduling timer "check-buildbucket-build-status" (chromium/ToTChromeOS:8986925295097633216:19:0) after 3m9s
[22:31:15.845] Handling timer "check-buildbucket-build-status" (chromium/ToTChromeOS:8986925295097633216:19:0)
[22:31:15.865] Build status: STARTED
[22:31:15.865] Scheduling timer "check-buildbucket-build-status" (chromium/ToTChromeOS:8986925295097633216:20:0) after 7m31s
[22:38:47.644] Handling timer "check-buildbucket-build-status" (chromium/ToTChromeOS:8986925295097633216:20:0)
[22:38:47.681] Build status: STARTED
[22:38:47.681] Scheduling timer "check-buildbucket-build-status" (chromium/ToTChromeOS:8986925295097633216:21:0) after 6m42s
[22:45:29.721] Handling timer "check-buildbucket-build-status" (chromium/ToTChromeOS:8986925295097633216:21:0)
[22:45:29.742] Build status: STARTED
[22:45:29.742] Scheduling timer "check-buildbucket-build-status" (chromium/ToTChromeOS:8986925295097633216:22:0) after 1m6s
[22:46:35.768] Handling timer "check-buildbucket-build-status" (chromium/ToTChromeOS:8986925295097633216:22:0)
[22:46:35.804] Build status: STARTED
[22:46:35.804] Scheduling timer "check-buildbucket-build-status" (chromium/ToTChromeOS:8986925295097633216:23:0) after 3m52s
[22:50:27.969] Handling timer "check-buildbucket-build-status" (chromium/ToTChromeOS:8986925295097633216:23:0)
[22:50:27.987] Build status: STARTED
[22:50:27.987] Scheduling timer "check-buildbucket-build-status" (chromium/ToTChromeOS:8986925295097633216:24:0) after 4m44s
[22:55:12.045] Handling timer "check-buildbucket-build-status" (chromium/ToTChromeOS:8986925295097633216:24:0)
[22:55:12.064] Build status: STARTED
[22:55:12.064] Scheduling timer "check-buildbucket-build-status" (chromium/ToTChromeOS:8986925295097633216:25:0) after 3m58s
[22:59:10.446] Handling timer "check-buildbucket-build-status" (chromium/ToTChromeOS:8986925295097633216:25:0)
[22:59:10.463] Build status: STARTED
[22:59:10.463] Scheduling timer "check-buildbucket-build-status" (chromium/ToTChromeOS:8986925295097633216:26:0) after 8m58s
[23:08:08.530] Handling timer "check-buildbucket-build-status" (chromium/ToTChromeOS:8986925295097633216:26:0)
[23:08:08.550] Build status: STARTED
[23:08:08.550] Scheduling timer "check-buildbucket-build-status" (chromium/ToTChromeOS:8986925295097633216:27:0) after 9m0s
[23:17:08.696] Handling timer "check-buildbucket-build-status" (chromium/ToTChromeOS:8986925295097633216:27:0)
[23:17:08.769] Build status: STARTED
[23:17:08.769] Scheduling timer "check-buildbucket-build-status" (chromium/ToTChromeOS:8986925295097633216:28:0) after 9m59s
[23:27:07.826] Handling timer "check-buildbucket-build-status" (chromium/ToTChromeOS:8986925295097633216:28:0)
[23:27:07.845] Build status: STARTED
[23:27:07.845] Scheduling timer "check-buildbucket-build-status" (chromium/ToTChromeOS:8986925295097633216:29:0) after 7m56s
[23:35:03.871] Handling timer "check-buildbucket-build-status" (chromium/ToTChromeOS:8986925295097633216:29:0)
[23:35:03.892] Build status: STARTED
[23:35:03.892] Scheduling timer "check-buildbucket-build-status" (chromium/ToTChromeOS:8986925295097633216:30:0) after 2m15s
[23:37:18.924] Handling timer "check-buildbucket-build-status" (chromium/ToTChromeOS:8986925295097633216:30:0)
[23:37:18.948] Build status: STARTED
[23:37:18.948] Scheduling timer "check-buildbucket-build-status" (chromium/ToTChromeOS:8986925295097633216:31:0) after 7m31s
[23:44:50.051] Handling timer "check-buildbucket-build-status" (chromium/ToTChromeOS:8986925295097633216:31:0)
[23:44:50.071] Build status: STARTED
[23:44:50.071] Scheduling timer "check-buildbucket-build-status" (chromium/ToTChromeOS:8986925295097633216:32:0) after 2m39s
[23:47:29.290] Handling timer "check-buildbucket-build-status" (chromium/ToTChromeOS:8986925295097633216:32:0)
[23:47:29.316] Build status: STARTED
[23:47:29.316] Scheduling timer "check-buildbucket-build-status" (chromium/ToTChromeOS:8986925295097633216:33:0) after 5m0s
[23:52:29.364] Handling timer "check-buildbucket-build-status" (chromium/ToTChromeOS:8986925295097633216:33:0)
[23:52:29.385] Build status: STARTED
[23:52:29.385] Scheduling timer "check-buildbucket-build-status" (chromium/ToTChromeOS:8986925295097633216:34:0) after 6m32s
[23:59:01.512] Handling timer "check-buildbucket-build-status" (chromium/ToTChromeOS:8986925295097633216:34:0)
[23:59:01.532] Build status: STARTED
[23:59:01.532] Scheduling timer "check-buildbucket-build-status" (chromium/ToTChromeOS:8986925295097633216:35:0) after 2m28s
[00:01:29.553] Handling timer "check-buildbucket-build-status" (chromium/ToTChromeOS:8986925295097633216:35:0)
[00:01:29.588] Build status: STARTED
[00:01:29.588] Scheduling timer "check-buildbucket-build-status" (chromium/ToTChromeOS:8986925295097633216:36:0) after 9m24s
[00:10:53.762] Handling timer "check-buildbucket-build-status" (chromium/ToTChromeOS:8986925295097633216:36:0)
[00:10:53.794] Build status: STARTED
[00:10:53.794] Scheduling timer "check-buildbucket-build-status" (chromium/ToTChromeOS:8986925295097633216:37:0) after 7m50s
[00:18:43.895] Handling timer "check-buildbucket-build-status" (chromium/ToTChromeOS:8986925295097633216:37:0)
[00:18:43.914] Build status: STARTED
[00:18:43.914] Scheduling timer "check-buildbucket-build-status" (chromium/ToTChromeOS:8986925295097633216:38:0) after 3m56s
[00:22:39.994] Handling timer "check-buildbucket-build-status" (chromium/ToTChromeOS:8986925295097633216:38:0)
[00:22:40.017] Build status: STARTED
[00:22:40.017] Scheduling timer "check-buildbucket-build-status" (chromium/ToTChromeOS:8986925295097633216:39:0) after 8m25s
[00:31:05.186] Handling timer "check-buildbucket-build-status" (chromium/ToTChromeOS:8986925295097633216:39:0)
[00:31:05.231] Build status: STARTED
[00:31:05.231] Scheduling timer "check-buildbucket-build-status" (chromium/ToTChromeOS:8986925295097633216:40:0) after 6m14s
[00:37:19.255] Handling timer "check-buildbucket-build-status" (chromium/ToTChromeOS:8986925295097633216:40:0)
[00:37:19.279] Build status: STARTED
[00:37:19.279] Scheduling timer "check-buildbucket-build-status" (chromium/ToTChromeOS:8986925295097633216:41:0) after 4m48s
[00:42:07.306] Handling timer "check-buildbucket-build-status" (chromium/ToTChromeOS:8986925295097633216:41:0)
[00:42:07.456] Build status: STARTED
[00:42:07.456] Scheduling timer "check-buildbucket-build-status" (chromium/ToTChromeOS:8986925295097633216:42:0) after 5m26s
[00:47:33.571] Handling timer "check-buildbucket-build-status" (chromium/ToTChromeOS:8986925295097633216:42:0)
[00:47:33.593] Build status: STARTED
[00:47:33.593] Scheduling timer "check-buildbucket-build-status" (chromium/ToTChromeOS:8986925295097633216:43:0) after 1m25s
[00:48:58.687] Handling timer "check-buildbucket-build-status" (chromium/ToTChromeOS:8986925295097633216:43:0)
[00:48:58.719] Build status: STARTED
[00:48:58.719] Scheduling timer "check-buildbucket-build-status" (chromium/ToTChromeOS:8986925295097633216:44:0) after 9m26s
[00:58:24.841] Handling timer "check-buildbucket-build-status" (chromium/ToTChromeOS:8986925295097633216:44:0)
[00:58:24.874] Build status: STARTED
[00:58:24.874] Scheduling timer "check-buildbucket-build-status" (chromium/ToTChromeOS:8986925295097633216:45:0) after 1m12s
[00:59:36.963] Handling timer "check-buildbucket-build-status" (chromium/ToTChromeOS:8986925295097633216:45:0)
[00:59:36.986] Build status: STARTED
[00:59:36.986] Scheduling timer "check-buildbucket-build-status" (chromium/ToTChromeOS:8986925295097633216:46:0) after 7m7s
[01:06:44.114] Handling timer "check-buildbucket-build-status" (chromium/ToTChromeOS:8986925295097633216:46:0)
[01:06:44.138] Build status: STARTED
[01:06:44.138] Scheduling timer "check-buildbucket-build-status" (chromium/ToTChromeOS:8986925295097633216:47:0) after 9m14s
[01:15:58.266] Handling timer "check-buildbucket-build-status" (chromium/ToTChromeOS:8986925295097633216:47:0)
[01:15:58.314] Build status: STARTED
[01:15:58.314] Scheduling timer "check-buildbucket-build-status" (chromium/ToTChromeOS:8986925295097633216:48:0) after 9m0s
[01:24:58.336] Handling timer "check-buildbucket-build-status" (chromium/ToTChromeOS:8986925295097633216:48:0)
[01:24:58.357] Build status: STARTED
[01:24:58.357] Scheduling timer "check-buildbucket-build-status" (chromium/ToTChromeOS:8986925295097633216:49:0) after 9m57s
[01:34:55.505] Handling timer "check-buildbucket-build-status" (chromium/ToTChromeOS:8986925295097633216:49:0)
[01:34:55.528] Build status: STARTED
[01:34:55.528] Scheduling timer "check-buildbucket-build-status" (chromium/ToTChromeOS:8986925295097633216:50:0) after 5m22s
[01:40:17.687] Handling timer "check-buildbucket-build-status" (chromium/ToTChromeOS:8986925295097633216:50:0)
[01:40:17.705] Build status: STARTED
[01:40:17.705] Scheduling timer "check-buildbucket-build-status" (chromium/ToTChromeOS:8986925295097633216:51:0) after 3m24s
[01:43:42.066] Handling timer "check-buildbucket-build-status" (chromium/ToTChromeOS:8986925295097633216:51:0)
[01:43:42.164] Build status: STARTED
[01:43:42.164] Scheduling timer "check-buildbucket-build-status" (chromium/ToTChromeOS:8986925295097633216:52:0) after 2m8s
[01:45:50.203] Handling timer "check-buildbucket-build-status" (chromium/ToTChromeOS:8986925295097633216:52:0)
[01:45:50.268] Build status: STARTED
[01:45:50.268] Scheduling timer "check-buildbucket-build-status" (chromium/ToTChromeOS:8986925295097633216:53:0) after 1m54s
[01:47:44.563] Handling timer "check-buildbucket-build-status" (chromium/ToTChromeOS:8986925295097633216:53:0)
[01:47:44.586] Build status: STARTED
[01:47:44.586] Scheduling timer "check-buildbucket-build-status" (chromium/ToTChromeOS:8986925295097633216:54:0) after 5m24s
[01:53:08.611] Handling timer "check-buildbucket-build-status" (chromium/ToTChromeOS:8986925295097633216:54:0)
[01:53:08.629] Build status: STARTED
[01:53:08.629] Scheduling timer "check-buildbucket-build-status" (chromium/ToTChromeOS:8986925295097633216:55:0) after 3m24s
[01:56:32.652] Handling timer "check-buildbucket-build-status" (chromium/ToTChromeOS:8986925295097633216:55:0)
[01:56:32.699] Build status: STARTED
[01:56:32.699] Scheduling timer "check-buildbucket-build-status" (chromium/ToTChromeOS:8986925295097633216:56:0) after 3m4s
[01:59:36.748] Handling timer "check-buildbucket-build-status" (chromium/ToTChromeOS:8986925295097633216:56:0)
[01:59:36.927] Build status: STARTED
[01:59:36.927] Scheduling timer "check-buildbucket-build-status" (chromium/ToTChromeOS:8986925295097633216:57:0) after 7m46s
[02:07:23.060] Handling timer "check-buildbucket-build-status" (chromium/ToTChromeOS:8986925295097633216:57:0)
[02:07:23.174] Build status: STARTED
[02:07:23.174] Scheduling timer "check-buildbucket-build-status" (chromium/ToTChromeOS:8986925295097633216:58:0) after 7m15s
[02:14:38.377] Handling timer "check-buildbucket-build-status" (chromium/ToTChromeOS:8986925295097633216:58:0)
[02:14:38.406] Build status: STARTED
[02:14:38.406] Scheduling timer "check-buildbucket-build-status" (chromium/ToTChromeOS:8986925295097633216:59:0) after 8m24s
[02:23:02.433] Handling timer "check-buildbucket-build-status" (chromium/ToTChromeOS:8986925295097633216:59:0)
[02:23:02.473] Build status: STARTED
[02:23:02.473] Scheduling timer "check-buildbucket-build-status" (chromium/ToTChromeOS:8986925295097633216:60:0) after 1m58s
[02:25:00.642] Handling timer "check-buildbucket-build-status" (chromium/ToTChromeOS:8986925295097633216:60:0)
[02:25:00.662] Build status: STARTED
[02:25:00.662] Scheduling timer "check-buildbucket-build-status" (chromium/ToTChromeOS:8986925295097633216:61:0) after 1m19s
[02:26:19.882] Handling timer "check-buildbucket-build-status" (chromium/ToTChromeOS:8986925295097633216:61:0)
[02:26:19.904] Build status: STARTED
[02:26:19.904] Scheduling timer "check-buildbucket-build-status" (chromium/ToTChromeOS:8986925295097633216:62:0) after 9m17s
[02:35:36.910] Handling timer "check-buildbucket-build-status" (chromium/ToTChromeOS:8986925295097633216:62:0)
[02:35:36.946] Build status: STARTED
[02:35:36.946] Scheduling timer "check-buildbucket-build-status" (chromium/ToTChromeOS:8986925295097633216:63:0) after 7m37s
[02:43:13.976] Handling timer "check-buildbucket-build-status" (chromium/ToTChromeOS:8986925295097633216:63:0)
[02:43:13.999] Build status: STARTED
[02:43:13.999] Scheduling timer "check-buildbucket-build-status" (chromium/ToTChromeOS:8986925295097633216:64:0) after 9m58s
[02:53:12.037] Handling timer "check-buildbucket-build-status" (chromium/ToTChromeOS:8986925295097633216:64:0)
[02:53:12.067] Build status: STARTED
[02:53:12.068] Scheduling timer "check-buildbucket-build-status" (chromium/ToTChromeOS:8986925295097633216:65:0) after 3m26s
[02:56:38.202] Handling timer "check-buildbucket-build-status" (chromium/ToTChromeOS:8986925295097633216:65:0)
[02:56:38.221] Build status: STARTED
[02:56:38.221] Scheduling timer "check-buildbucket-build-status" (chromium/ToTChromeOS:8986925295097633216:66:0) after 5m22s
[03:02:00.259] Handling timer "check-buildbucket-build-status" (chromium/ToTChromeOS:8986925295097633216:66:0)
[03:02:00.281] Build status: STARTED
[03:02:00.281] Scheduling timer "check-buildbucket-build-status" (chromium/ToTChromeOS:8986925295097633216:67:0) after 9m0s
[03:11:00.354] Handling timer "check-buildbucket-build-status" (chromium/ToTChromeOS:8986925295097633216:67:0)
[03:11:00.378] Build status: STARTED
[03:11:00.378] Scheduling timer "check-buildbucket-build-status" (chromium/ToTChromeOS:8986925295097633216:68:0) after 6m47s
[03:17:47.694] Handling timer "check-buildbucket-build-status" (chromium/ToTChromeOS:8986925295097633216:68:0)
[03:17:47.711] Build status: STARTED
[03:17:47.711] Scheduling timer "check-buildbucket-build-status" (chromium/ToTChromeOS:8986925295097633216:69:0) after 7m32s
[03:25:19.838] Handling timer "check-buildbucket-build-status" (chromium/ToTChromeOS:8986925295097633216:69:0)
[03:25:19.863] Build status: STARTED
[03:25:19.863] Scheduling timer "check-buildbucket-build-status" (chromium/ToTChromeOS:8986925295097633216:70:0) after 4m59s
[03:30:19.256] Handling timer "check-buildbucket-build-status" (chromium/ToTChromeOS:8986925295097633216:70:0)
[03:30:19.275] Build status: STARTED
[03:30:19.275] Scheduling timer "check-buildbucket-build-status" (chromium/ToTChromeOS:8986925295097633216:71:0) after 1m42s
[03:32:01.384] Handling timer "check-buildbucket-build-status" (chromium/ToTChromeOS:8986925295097633216:71:0)
[03:32:01.405] Build status: STARTED
[03:32:01.405] Scheduling timer "check-buildbucket-build-status" (chromium/ToTChromeOS:8986925295097633216:72:0) after 7m52s
[03:39:53.465] Handling timer "check-buildbucket-build-status" (chromium/ToTChromeOS:8986925295097633216:72:0)
[03:39:53.486] Build status: STARTED
[03:39:53.486] Scheduling timer "check-buildbucket-build-status" (chromium/ToTChromeOS:8986925295097633216:73:0) after 1m0s
[03:40:53.529] Handling timer "check-buildbucket-build-status" (chromium/ToTChromeOS:8986925295097633216:73:0)
[03:40:53.559] Build status: STARTED
[03:40:53.559] Scheduling timer "check-buildbucket-build-status" (chromium/ToTChromeOS:8986925295097633216:74:0) after 4m4s
[03:44:57.836] Handling timer "check-buildbucket-build-status" (chromium/ToTChromeOS:8986925295097633216:74:0)
[03:44:57.867] Build status: STARTED
[03:44:57.867] Scheduling timer "check-buildbucket-build-status" (chromium/ToTChromeOS:8986925295097633216:75:0) after 8m0s
[03:52:57.892] Handling timer "check-buildbucket-build-status" (chromium/ToTChromeOS:8986925295097633216:75:0)
[03:52:57.913] Build status: STARTED
[03:52:57.913] Scheduling timer "check-buildbucket-build-status" (chromium/ToTChromeOS:8986925295097633216:76:0) after 4m31s
[03:57:28.939] Handling timer "check-buildbucket-build-status" (chromium/ToTChromeOS:8986925295097633216:76:0)
[03:57:28.959] Build status: STARTED
[03:57:28.959] Scheduling timer "check-buildbucket-build-status" (chromium/ToTChromeOS:8986925295097633216:77:0) after 7m10s
[04:04:39.060] Handling timer "check-buildbucket-build-status" (chromium/ToTChromeOS:8986925295097633216:77:0)
[04:04:39.120] Build status: STARTED
[04:04:39.120] Scheduling timer "check-buildbucket-build-status" (chromium/ToTChromeOS:8986925295097633216:78:0) after 8m30s
[04:07:15.856] Received PubSub notification, asking Buildbucket for the build status
[04:07:15.874] Build:
{
"id": "8821495233059903409",
"builder": {
"project": "chromium",
"bucket": "ci",
"builder": "ToTChromeOS"
},
"number": 650,
"createdBy": "project:chromium",
"createTime": "2022-02-22T20:59:46.138060085Z",
"startTime": "2022-02-22T21:00:06.696631Z",
"endTime": "2022-02-23T04:07:15.606711612Z",
"updateTime": "2022-02-23T04:07:15.606711612Z",
"status": "SUCCESS",
"input": {
"gitilesCommit": {
"host": "chromium.googlesource.com",
"project": "chromium/src",
"id": "984a7d0013c3dff5227986b18fd660b938b298c9",
"ref": "refs/heads/main"
}
}
}
[04:07:15.874] Invocation finished in 7h7m31.063954769s with status SUCCEEDED