[08:05:01.506] New invocation is queued and will start shortly
[08:05:03.346] Starting the invocation (attempt 1)
[08:05:03.422] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[08:05:03.422] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[08:05:03.422] Buildbucket request:
{
"bucket": "luci.chromium.ci",
"client_operation_id": "9058183252029996112",
"parameters_json": "{\"builder_name\":\"Linux Builder (dbg)\",\"properties\":{\"branch\":\"refs/heads/master\",\"repository\":\"https://chromium.googlesource.com/chromium/src\",\"revision\":\"f25e31a18ae8484040f09d97892b4681f4841c71\"}}",
"pubsub_callback": {
"auth_token": "...",
"topic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
},
"tags": [
"builder:Linux Builder (dbg)",
"scheduler_invocation_id:9058183252029996112",
"scheduler_job_id:chromium/Linux Builder (dbg)",
"user_agent:luci-scheduler",
"buildset:commit/git/f25e31a18ae8484040f09d97892b4681f4841c71",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/f25e31a18ae8484040f09d97892b4681f4841c71",
"gitiles_ref:refs/heads/master"
]
}
[08:05:05.668] Buildbucket response:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "PROD",
"created_by": "project:chromium",
"created_ts": "1577606704191184",
"id": "8892753188504604720",
"parameters_json": "{\"builder_name\": \"Linux Builder (dbg)\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"f25e31a18ae8484040f09d97892b4681f4841c71\"}}",
"project": "chromium",
"result_details_json": "{\"properties\": {}}",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"status": "SCHEDULED",
"status_changed_ts": "1577606705543203",
"tags": [
"build_address:luci.chromium.ci/Linux Builder (dbg)/166700",
"builder:Linux Builder (dbg)",
"buildset:commit/git/f25e31a18ae8484040f09d97892b4681f4841c71",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/f25e31a18ae8484040f09d97892b4681f4841c71",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9058183252029996112",
"scheduler_job_id:chromium/Linux Builder (dbg)",
"swarming_hostname:chromium-swarm.appspot.com",
"swarming_tag:log_location:logdog://logs.chromium.org/chromium/buildbucket/cr-buildbucket.appspot.com/8892753188504604720/+/annotations",
"swarming_tag:luci_project:chromium",
"swarming_tag:recipe_name:chromium",
"swarming_tag:recipe_package:infra/recipe_bundles/chromium.googlesource.com/chromium/tools/build",
"swarming_task_id:",
"user_agent:luci-scheduler"
],
"updated_ts": "1577606705543362",
"url": "https://ci.chromium.org/b/8892753188504604720",
"utcnow_ts": "1577606705659411"
}
}
[08:05:05.668] Task URL: https://ci.chromium.org/b/8892753188504604720
[08:05:05.668] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9058183252029996112:2:0) after 1m0s
[08:06:05.726] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9058183252029996112:2:0)
[08:06:05.726] Timer tick, asking Buildbucket for the build status
[08:06:05.915] Build 8892753188504604720: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[08:06:05.915] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9058183252029996112:3:0) after 1m0s
[08:07:05.994] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9058183252029996112:3:0)
[08:07:05.994] Timer tick, asking Buildbucket for the build status
[08:07:08.464] Build 8892753188504604720: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[08:07:08.464] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9058183252029996112:4:0) after 1m0s
[08:08:08.522] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9058183252029996112:4:0)
[08:08:08.522] Timer tick, asking Buildbucket for the build status
[08:08:08.838] Build 8892753188504604720: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[08:08:08.838] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9058183252029996112:5:0) after 1m0s
[08:09:08.855] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9058183252029996112:5:0)
[08:09:08.855] Timer tick, asking Buildbucket for the build status
[08:09:09.143] Build 8892753188504604720: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[08:09:09.143] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9058183252029996112:6:0) after 1m0s
[08:10:09.188] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9058183252029996112:6:0)
[08:10:09.188] Timer tick, asking Buildbucket for the build status
[08:10:09.461] Build 8892753188504604720: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[08:10:09.461] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9058183252029996112:7:0) after 1m0s
[08:10:09.602] Received PubSub notification, asking Buildbucket for the build status
[08:10:09.916] Build 8892753188504604720: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:11:09.486] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9058183252029996112:7:0)
[08:11:09.486] Timer tick, asking Buildbucket for the build status
[08:11:09.768] Build 8892753188504604720: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:11:09.768] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9058183252029996112:9:0) after 1m0s
[08:12:09.749] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9058183252029996112:9:0)
[08:12:09.749] Timer tick, asking Buildbucket for the build status
[08:12:10.607] Build 8892753188504604720: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:12:10.607] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9058183252029996112:10:0) after 1m0s
[08:13:10.639] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9058183252029996112:10:0)
[08:13:10.639] Timer tick, asking Buildbucket for the build status
[08:13:12.474] Build 8892753188504604720: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:13:12.474] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9058183252029996112:11:0) after 1m0s
[08:14:12.498] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9058183252029996112:11:0)
[08:14:12.498] Timer tick, asking Buildbucket for the build status
[08:14:13.244] Build 8892753188504604720: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:14:13.244] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9058183252029996112:12:0) after 1m0s
[08:15:13.318] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9058183252029996112:12:0)
[08:15:13.318] Timer tick, asking Buildbucket for the build status
[08:15:13.951] Build 8892753188504604720: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:15:13.951] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9058183252029996112:13:0) after 1m0s
[08:16:13.976] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9058183252029996112:13:0)
[08:16:13.977] Timer tick, asking Buildbucket for the build status
[08:16:14.591] Build 8892753188504604720: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:16:14.591] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9058183252029996112:14:0) after 1m0s
[08:17:14.580] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9058183252029996112:14:0)
[08:17:14.580] Timer tick, asking Buildbucket for the build status
[08:17:15.025] Build 8892753188504604720: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:17:15.025] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9058183252029996112:15:0) after 1m0s
[08:18:15.043] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9058183252029996112:15:0)
[08:18:15.043] Timer tick, asking Buildbucket for the build status
[08:18:15.274] Build 8892753188504604720: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:18:15.274] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9058183252029996112:16:0) after 1m0s
[08:19:15.303] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9058183252029996112:16:0)
[08:19:15.303] Timer tick, asking Buildbucket for the build status
[08:19:15.753] Build 8892753188504604720: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:19:15.753] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9058183252029996112:17:0) after 1m0s
[08:20:15.776] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9058183252029996112:17:0)
[08:20:15.776] Timer tick, asking Buildbucket for the build status
[08:20:15.964] Build 8892753188504604720: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:20:15.964] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9058183252029996112:18:0) after 1m0s
[08:21:16.077] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9058183252029996112:18:0)
[08:21:16.077] Timer tick, asking Buildbucket for the build status
[08:21:16.725] Build 8892753188504604720: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:21:16.725] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9058183252029996112:19:0) after 1m0s
[08:22:16.759] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9058183252029996112:19:0)
[08:22:16.759] Timer tick, asking Buildbucket for the build status
[08:22:17.091] Build 8892753188504604720: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:22:17.091] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9058183252029996112:20:0) after 1m0s
[08:23:17.109] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9058183252029996112:20:0)
[08:23:17.109] Timer tick, asking Buildbucket for the build status
[08:23:17.423] Build 8892753188504604720: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:23:17.423] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9058183252029996112:21:0) after 1m0s
[08:24:17.424] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9058183252029996112:21:0)
[08:24:17.424] Timer tick, asking Buildbucket for the build status
[08:24:18.091] Build 8892753188504604720: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:24:18.091] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9058183252029996112:22:0) after 1m0s
[08:25:18.116] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9058183252029996112:22:0)
[08:25:18.116] Timer tick, asking Buildbucket for the build status
[08:25:19.198] Build 8892753188504604720: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:25:19.198] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9058183252029996112:23:0) after 1m0s
[08:26:19.295] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9058183252029996112:23:0)
[08:26:19.295] Timer tick, asking Buildbucket for the build status
[08:26:19.717] Build 8892753188504604720: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:26:19.717] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9058183252029996112:24:0) after 1m0s
[08:27:19.742] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9058183252029996112:24:0)
[08:27:19.742] Timer tick, asking Buildbucket for the build status
[08:27:20.035] Build 8892753188504604720: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:27:20.035] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9058183252029996112:25:0) after 1m0s
[08:28:20.056] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9058183252029996112:25:0)
[08:28:20.056] Timer tick, asking Buildbucket for the build status
[08:28:22.187] Build 8892753188504604720: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:28:22.187] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9058183252029996112:26:0) after 1m0s
[08:29:22.230] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9058183252029996112:26:0)
[08:29:22.230] Timer tick, asking Buildbucket for the build status
[08:29:22.786] Build 8892753188504604720: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:29:22.786] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9058183252029996112:27:0) after 1m0s
[08:30:22.803] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9058183252029996112:27:0)
[08:30:22.803] Timer tick, asking Buildbucket for the build status
[08:30:23.032] Build 8892753188504604720: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:30:23.032] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9058183252029996112:28:0) after 1m0s
[08:31:23.072] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9058183252029996112:28:0)
[08:31:23.072] Timer tick, asking Buildbucket for the build status
[08:31:23.266] Build 8892753188504604720: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:31:23.266] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9058183252029996112:29:0) after 1m0s
[08:32:23.289] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9058183252029996112:29:0)
[08:32:23.289] Timer tick, asking Buildbucket for the build status
[08:32:23.562] Build 8892753188504604720: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:32:23.562] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9058183252029996112:30:0) after 1m0s
[08:33:23.623] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9058183252029996112:30:0)
[08:33:23.623] Timer tick, asking Buildbucket for the build status
[08:33:23.867] Build 8892753188504604720: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:33:23.867] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9058183252029996112:31:0) after 1m0s
[08:34:23.914] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9058183252029996112:31:0)
[08:34:23.914] Timer tick, asking Buildbucket for the build status
[08:34:24.378] Build 8892753188504604720: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:34:24.378] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9058183252029996112:32:0) after 1m0s
[08:35:24.436] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9058183252029996112:32:0)
[08:35:24.436] Timer tick, asking Buildbucket for the build status
[08:35:24.861] Build 8892753188504604720: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:35:24.861] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9058183252029996112:33:0) after 1m0s
[08:36:24.888] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9058183252029996112:33:0)
[08:36:24.888] Timer tick, asking Buildbucket for the build status
[08:36:25.039] Build 8892753188504604720: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:36:25.039] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9058183252029996112:34:0) after 1m0s
[08:37:25.509] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9058183252029996112:34:0)
[08:37:25.509] Timer tick, asking Buildbucket for the build status
[08:37:25.656] Build 8892753188504604720: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:37:25.656] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9058183252029996112:35:0) after 1m0s
[08:38:26.010] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9058183252029996112:35:0)
[08:38:26.010] Timer tick, asking Buildbucket for the build status
[08:38:26.219] Build 8892753188504604720: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:38:26.219] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9058183252029996112:36:0) after 1m0s
[08:39:26.816] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9058183252029996112:36:0)
[08:39:26.816] Timer tick, asking Buildbucket for the build status
[08:39:27.053] Build 8892753188504604720: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:39:27.053] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9058183252029996112:37:0) after 1m0s
[08:40:27.232] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9058183252029996112:37:0)
[08:40:27.232] Timer tick, asking Buildbucket for the build status
[08:40:27.687] Build 8892753188504604720: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:40:27.687] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9058183252029996112:38:0) after 1m0s
[08:41:27.955] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9058183252029996112:38:0)
[08:41:27.955] Timer tick, asking Buildbucket for the build status
[08:41:28.471] Build 8892753188504604720: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:41:28.471] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9058183252029996112:39:0) after 1m0s
[08:42:28.571] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9058183252029996112:39:0)
[08:42:28.571] Timer tick, asking Buildbucket for the build status
[08:42:28.820] Build 8892753188504604720: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:42:28.820] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9058183252029996112:40:0) after 1m0s
[08:43:31.533] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9058183252029996112:40:0)
[08:43:31.533] Timer tick, asking Buildbucket for the build status
[08:43:31.690] Build 8892753188504604720: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:43:31.690] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9058183252029996112:41:0) after 1m0s
[08:44:31.743] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9058183252029996112:41:0)
[08:44:31.743] Timer tick, asking Buildbucket for the build status
[08:44:32.070] Build 8892753188504604720: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:44:32.071] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9058183252029996112:42:0) after 1m0s
[08:45:32.139] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9058183252029996112:42:0)
[08:45:32.139] Timer tick, asking Buildbucket for the build status
[08:45:32.353] Build 8892753188504604720: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:45:32.353] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9058183252029996112:43:0) after 1m0s
[08:46:32.437] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9058183252029996112:43:0)
[08:46:32.437] Timer tick, asking Buildbucket for the build status
[08:46:32.628] Build 8892753188504604720: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:46:32.628] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9058183252029996112:44:0) after 1m0s
[08:47:32.672] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9058183252029996112:44:0)
[08:47:32.672] Timer tick, asking Buildbucket for the build status
[08:47:33.037] Build 8892753188504604720: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:47:33.037] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9058183252029996112:45:0) after 1m0s
[08:48:33.091] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9058183252029996112:45:0)
[08:48:33.091] Timer tick, asking Buildbucket for the build status
[08:48:33.362] Build 8892753188504604720: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:48:33.362] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9058183252029996112:46:0) after 1m0s
[08:49:33.381] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9058183252029996112:46:0)
[08:49:33.381] Timer tick, asking Buildbucket for the build status
[08:49:33.593] Build 8892753188504604720: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:49:33.593] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9058183252029996112:47:0) after 1m0s
[08:50:33.627] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9058183252029996112:47:0)
[08:50:33.627] Timer tick, asking Buildbucket for the build status
[08:50:33.853] Build 8892753188504604720: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:50:33.853] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9058183252029996112:48:0) after 1m0s
[08:51:33.876] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9058183252029996112:48:0)
[08:51:33.876] Timer tick, asking Buildbucket for the build status
[08:51:34.267] Build 8892753188504604720: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:51:34.267] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9058183252029996112:49:0) after 1m0s
[08:52:02.299] Received PubSub notification, asking Buildbucket for the build status
[08:52:03.202] Build 8892753188504604720: status "COMPLETED", result "SUCCESS", failure_reason "", cancelation_reason ""
[08:52:03.203] Buildbucket build:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "PROD",
"completed_ts": "1577609521559276",
"created_by": "project:chromium",
"created_ts": "1577606704191184",
"id": "8892753188504604720",
"parameters_json": "{\"builder_name\": \"Linux Builder (dbg)\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"f25e31a18ae8484040f09d97892b4681f4841c71\"}}",
"project": "chromium",
"result": "SUCCESS",
"result_details_json": "{\"properties\": {\"$build/goma\": {\"jobs\": 500.0, \"rpc_extra_params\": \"?prod\", \"server_host\": \"goma.chromium.org\"}, \"$recipe_engine/path\": {\"cache_dir\": \"/b/s/w/ir/cache\", \"temp_dir\": \"/b/s/w/ir/tmp/rt\"}, \"$recipe_engine/runtime\": {\"is_experimental\": false, \"is_luci\": true}, \"bot_id\": \"luci-chromium-ci-xenial-us-east1-d-8-68-r4cr\", \"branch\": \"refs/heads/master\", \"buildername\": \"Linux Builder (dbg)\", \"buildnumber\": 166700, \"got_angle_revision\": \"fca5a005aa880a51672c091fcb82f084b620670a\", \"got_dawn_revision\": \"87d31381588b26edb3da1d75dd0588b2df4dd968\", \"got_nacl_revision\": \"3651f6c52037c96e034cc422746768d59182bff3\", \"got_revision\": \"f25e31a18ae8484040f09d97892b4681f4841c71\", \"got_revision_cp\": \"refs/heads/master@{#727702}\", \"got_swarming_client_revision\": \"885b3febcc170a60f25795304e60927b77d1e92d\", \"got_swiftshader_revision\": \"59465799210b3f4962af1a9dc44a4ffecb422c10\", \"got_v8_revision\": \"4c53f9a51444393133ff303952f1296603d44ab7\", \"got_v8_revision_cp\": \"refs/heads/8.1.80@{#1}\", \"got_webrtc_revision\": \"8ac79125c05256f4b6ad29533b99c7733e5ac219\", \"got_webrtc_revision_cp\": \"refs/heads/master@{#30127}\", \"isolate_server\": \"https://isolateserver.appspot.com\", \"mastername\": \"chromium.linux\", \"path_config\": \"generic\", \"recipe\": \"chromium\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"f25e31a18ae8484040f09d97892b4681f4841c71\", \"swarm_hashes_refs/heads/master(at){#727702}_without_patch\": {\"accessibility_unittests\": \"a81861ce1d7108077445a93bd9933d7384014f3c\", \"angle_unittests\": \"f2549e48471835323172e729a24125cd41ae5b1e\", \"app_shell_unittests\": \"546eebfc7f28f781aebbccde90e0a8f5e0c6353d\", \"aura_unittests\": \"7580d2096136c9ac79f44162d8175f1807a8c333\", \"base_unittests\": \"3b36a1981dc74cad29d7df6556a74893cd6de6be\", \"base_util_unittests\": \"d75209d1deb1b5e9894d90fe49baad44f28198db\", \"blink_common_unittests\": \"dc50c6af0016a52b95cee26c30e2f31308bfccd9\", \"blink_fuzzer_unittests\": \"1b07b0d1c4a58c849bfcf0bde06bbfbf0a08addd\", \"blink_heap_unittests\": \"3b3139706a69d2c5b1d1cab828159d4a2f533b0f\", \"blink_platform_unittests\": \"cf511016a64a8f03f108d13c7a6696d273397fc3\", \"blink_python_tests\": \"71fca2a74588e42f9255febaeefdd76af0a46926\", \"blink_unittests\": \"c898248f9b6fe7b314c0e30df3c12cbb91fed71f\", \"blink_web_tests\": \"304e6c3f02d443685c598be43b3417ed02c05c9e\", \"boringssl_crypto_tests\": \"16bf76d0bd43020de0b0a3a27a0d178802347693\", \"boringssl_ssl_tests\": \"40be03876a4dfd4ccc8c18d1521e3ce976bda311\", \"browser_tests\": \"b2916bbfb9c935ed057870519f219ee57b414149\", \"cacheinvalidation_unittests\": \"556c60ab206bb104d474237a914ea13752f44a9a\", \"capture_unittests\": \"02b7617a1202435085531366e713220f1363ef0f\", \"cast_unittests\": \"f3625cc27d79e52c2bed90169db97fac68bf831e\", \"cc_unittests\": \"4fa0d88fac6dddb14e57bc5c02ec468d6e358397\", \"chrome_app_unittests\": \"7d02ede0649a39399b49c144ff8694b18cb93600\", \"chromedriver_unittests\": \"a519fac555703fd8882e7e8014f6cb27ba6ca689\", \"components_browsertests\": \"e19967f73caf9c7dc7f7460e9678852cad6d5fc4\", \"components_unittests\": \"452c47c28a1ac755b604b2ce4a70cce8add94b9d\", \"compositor_unittests\": \"911d863096ee2be110dc8b1696acebb1b70690d5\", \"content_browsertests\": \"73b23c5dd5eeaf09d48c1b604cf20b2c8a7a1a5a\", \"content_shell_crash_test\": \"36333911a01b031ce9942afef50a84bd2cba6dd8\", \"content_unittests\": \"b5a4d03e432886191dfbfcf46383db05efee2d7f\", \"crashpad_tests\": \"6483b36da3f759f43d4eacaca3c8f1037a31c56c\", \"cronet_tests\": \"b56d072cefded872de58b253ccedabcdf0e9eff0\", \"cronet_unittests\": \"bea3ac83269257374af58c9c3b7e80ba82a5d825\", \"crypto_unittests\": \"62b85a206fae8f7fc117bfd87e24e01e6cfadaec\", \"dbus_unittests\": \"b18a20c9059f462936304c0128075027577884b4\", \"device_unittests\": \"a0ddef2c6c400392358372def98bd338a78da154\", \"devtools_lint_check\": \"f5ef4bbd5230ceca8e6b62aa06ad4d93f07aaee9\", \"devtools_type_check\": \"0560d4eae584ad288c2a1900ea29c456fa9b4b3b\", \"display_unittests\": \"2b40a271610b8c194eb7a541438dcc65fff882bb\", \"events_unittests\": \"1356ed39e078320fa1b3b3c63edbc2a0ad7c723b\", \"extensions_browsertests\": \"2143169341771061c0386d2073b6ff3e7519c250\", \"extensions_unittests\": \"e0f7413fcb456b892cdf32bff693f7bed6aae77a\", \"filesystem_service_unittests\": \"5e2c5460624c8e658f20e24c97a2121d26a4a7af\", \"flatbuffers_unittests\": \"034d1c63a8199a680c9bbf29b5866b1c851e28ee\", \"gcm_unit_tests\": \"a79f753d21a2e0b37930a4a8af4a2cc83850e3dc\", \"gfx_unittests\": \"38537d8d282a3dfabd80ed309a62490840559b34\", \"gin_unittests\": \"87d62270ef3a528258fa407330476a7f4a0aac5c\", \"google_apis_unittests\": \"32a61e800bab7969325a4d5fc7f5c452167f8269\", \"gpu_unittests\": \"af68f55145c07db4605f0c1070b1d328429cbf70\", \"grit_python_unittests\": \"c651860184eae0fccc98981c3c79be6f65eaf3fe\", \"gwp_asan_unittests\": \"c5d91102ad9e99913ae55450637a2a25d69b8422\", \"headless_browsertests\": \"967261d48419ae4bd2c76fb18fc7ba67999a3339\", \"headless_unittests\": \"4b898a697ccac3d6feca7f3a84c3da8cc637ee2c\", \"interactive_ui_tests\": \"a42f7ea2c0f5125f4cac4daef3c17a93f6a45d1d\", \"ipc_tests\": \"56adffbc41475de3c80be1796c1554dfe30530ad\", \"jingle_unittests\": \"2cf22a3d4ca314bedfa7c10e5ad8ed247697b113\", \"latency_unittests\": \"0cbdd4a8bd7c08acfacc82f9c1bd058ed7493fdc\", \"libjingle_xmpp_unittests\": \"1a58c4cee0529898babf2eb1c2f96fe37afb658e\", \"media_blink_unittests\": \"3bdaee92fdcd1d381a2496cc28fbbad4bd539530\", \"media_service_unittests\": \"f3a23f0ffc00de93703c7b5a63470e15caede38c\", \"media_unittests\": \"e3651462a914c97d7dfab28070f9f90fcd86dc18\", \"message_center_unittests\": \"98eb38986e9100124b393daa364809a36837e7fb\", \"metrics_python_tests\": \"afa7f0361beb7b3e85270b2c02c71903a17203e2\", \"midi_unittests\": \"96438cf3fe3c5bd95b10dc3d01fd587a4114493c\", \"mojo_core_unittests\": \"74cad2c982308d7d83fd3c560a97045d57e06b78\", \"mojo_unittests\": \"2ff810807d859146ed01bdeae00a4ec7f9eabe1f\", \"nacl_helper_nonsfi_unittests\": \"55a89485b120e7f8bc5ce09509896d05a88460cc\", \"nacl_loader_unittests\": \"ef5d8aa6de68814b6609d948d0749d8c9cdc1204\", \"native_theme_unittests\": \"c3a56167356b82e06a17d3033916f8351a193e5b\", \"net_unittests\": \"be9acb58b941cfe414a7fc82daaf2ef66ce2dab3\", \"pdf_unittests\": \"6980bd95b0d2a3ea0afd9bc4ac1e47a19ed9ad59\", \"perfetto_unittests\": \"345c16c5db78b7f517493db9f4fbbe342d28b908\", \"ppapi_unittests\": \"35fb6ac6ae5bcda13b869d71d3a1f3196a092f9c\", \"printing_unittests\": \"7603c1a3d61e30478fd10288e54b19e553f5d59a\", \"remoting_unittests\": \"e916ea051f3083168ae2451f149842adc8fb5d2c\", \"sandbox_linux_unittests\": \"4086d03e75d59c4b049a5feaa15fbff78aab120f\", \"service_manager_unittests\": \"1ef505f1891201962f1610fcec8d53c3ef7457b3\", \"services_unittests\": \"da8f815efe042573706d14fec744b6ca715603ed\", \"shell_dialogs_unittests\": \"7646fa2320b5b18466acf337a6734ad8f4f66ef9\", \"skia_unittests\": \"3e28370bc4c45b941735c4d4c30a102d6543afee\", \"snapshot_unittests\": \"464f9d57c57c5738dc45a177e0d9a5a0def11495\", \"sql_unittests\": \"ec308b65259310647da2da207a5966f418f05f53\", \"storage_unittests\": \"94da97341ec024d97d13231ee8fd433b2f908792\", \"sync_integration_tests\": \"337429c5dc57e3d041250856156f5c1d6d340833\", \"telemetry_gpu_unittests\": \"59fb62efb901528386195d35767e4cdde879113e\", \"telemetry_perf_unittests\": \"b3087d4b3a3aab0dda6c71ebbd37570c1bd95f20\", \"telemetry_unittests\": \"06931a6483777d055fb373b84e2e241dc6212c15\", \"traffic_annotation_auditor_unittests\": \"5fa370b59d7285eb057f481c4be6bcce97e9bf78\", \"ui_base_unittests\": \"ad66ee9dc9c006fd372ebaa0aec3ce1ae2871aef\", \"ui_touch_selection_unittests\": \"53fe94d3a9574b43e7f9a85cd3b1d78a24a70ae7\", \"unit_tests\": \"b3524e16be5dbc9aaaf9a1910f2fe35233c607e0\", \"url_unittests\": \"a758608e0c342ea4571022299f37422f1b995fa3\", \"views_perftests\": \"d88ea99c461971826166b80e51f42f2fcdacded6\", \"views_unittests\": \"499f91f15b71b35b1fb621ebf7a178cab6f6a4ce\", \"viz_unittests\": \"501fd380a868914134818fe20723e4b0983833a8\", \"vr_common_unittests\": \"f2450deea36dd1228a1fda9fc8f96b2d411edbf9\", \"vr_pixeltests\": \"0041a0becca22d217b3a3150e3e26ac2ddb130ad\", \"webdriver_wpt_tests\": \"d009de92d2ff87e39c365239b4f39274b9c5d75d\", \"weblayer_browsertests\": \"9f29169e5afdebc92bf3227680b4b969ac932193\", \"wm_unittests\": \"dc612dba6b67617e2b6dc77deb8637719e7229d2\", \"wtf_unittests\": \"ea10745fc8b3ae4b3898431d0cfccbe841019105\", \"xr_browser_tests\": \"8c005bcd8e3327eee38492408b4870933b203ccc\"}}, \"swarming\": {\"bot_dimensions\": {\"builderless\": [\"1\"], \"caches\": [\"builder_1d6807bf68beb1f6e53b053acbc5bd9e728357249a14ae6e1a69ace8071ddc84_v2\", \"builder_36472ddafb4960b563fa0dfd4883d4c097bf9805cea97d60ada20c6be0c80514_v2\", \"builder_8851890e994e29b56fba2042f90feba99073c8e56d0ea67af5ee13ebe9f87cf6_v2\", \"builder_980e79f61a9eb10b3ecd5f710f08f0308a5299da9889db3d2b6a7010c019cc1f_v2\", \"builder_f1e9b75398bfd0252c605ce36f207e46561896ce8d2d0d3f277d5138614391a3_v2\", \"git\", \"goma_v2\", \"vpython\"], \"cores\": [\"8\"], \"cpu\": [\"x86\", \"x86-64\", \"x86-64-Broadwell_GCE\", \"x86-64-avx2\"], \"gce\": [\"1\"], \"gpu\": [\"none\"], \"id\": [\"luci-chromium-ci-xenial-us-east1-d-8-68-r4cr\"], \"image\": [\"chrome-xenial-19121500-b03549ec744\"], \"inside_docker\": [\"0\"], \"kvm\": [\"1\"], \"locale\": [\"en_US.UTF-8\"], \"machine_type\": [\"n1-standard-8\"], \"os\": [\"Linux\", \"Ubuntu\", \"Ubuntu-16.04\"], \"pool\": [\"luci.chromium.ci\"], \"python\": [\"2.7.12\"], \"server_version\": [\"4733-6bd8c41\"], \"ssd\": [\"0\"], \"zone\": [\"us\", \"us-east\", \"us-east1\", \"us-east1-d\"]}}}",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"started_ts": "1577607008529284",
"status": "COMPLETED",
"status_changed_ts": "1577609521867290",
"tags": [
"build_address:luci.chromium.ci/Linux Builder (dbg)/166700",
"builder:Linux Builder (dbg)",
"buildset:commit/git/f25e31a18ae8484040f09d97892b4681f4841c71",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/f25e31a18ae8484040f09d97892b4681f4841c71",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9058183252029996112",
"scheduler_job_id:chromium/Linux Builder (dbg)",
"swarming_hostname:chromium-swarm.appspot.com",
"swarming_tag:log_location:logdog://logs.chromium.org/chromium/buildbucket/cr-buildbucket.appspot.com/8892753188504604720/+/annotations",
"swarming_tag:luci_project:chromium",
"swarming_tag:os:Linux",
"swarming_tag:recipe_name:chromium",
"swarming_tag:recipe_package:infra/recipe_bundles/chromium.googlesource.com/chromium/tools/build",
"swarming_task_id:4969817a96e99610",
"user_agent:luci-scheduler"
],
"updated_ts": "1577609521878704",
"url": "https://ci.chromium.org/b/8892753188504604720",
"utcnow_ts": "1577609523177145"
}
}
[08:52:03.203] Invocation finished in 47m1.757953296s with status SUCCEEDED