[08:14:48.927] New invocation is queued and will start shortly
[08:14:50.052] Starting the invocation (attempt 1)
[08:14:50.139] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[08:14:50.139] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[08:14:50.139] Buildbucket request:
{
"bucket": "luci.chromium.ci",
"client_operation_id": "9059813381424970944",
"parameters_json": "{\"builder_name\":\"Linux Builder (dbg)\",\"properties\":{\"branch\":\"refs/heads/master\",\"repository\":\"https://chromium.googlesource.com/chromium/src\",\"revision\":\"d9ed50d4762324ad72d7f94f127aa082b6051ab1\"}}",
"pubsub_callback": {
"auth_token": "...",
"topic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
},
"tags": [
"builder:Linux Builder (dbg)",
"scheduler_invocation_id:9059813381424970944",
"scheduler_job_id:chromium/Linux Builder (dbg)",
"user_agent:luci-scheduler",
"buildset:commit/git/d9ed50d4762324ad72d7f94f127aa082b6051ab1",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/d9ed50d4762324ad72d7f94f127aa082b6051ab1",
"gitiles_ref:refs/heads/master"
]
}
[08:14:51.079] Buildbucket response:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "PROD",
"created_by": "project:chromium",
"created_ts": "1576052090343278",
"id": "8894383319274533200",
"parameters_json": "{\"builder_name\": \"Linux Builder (dbg)\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"d9ed50d4762324ad72d7f94f127aa082b6051ab1\"}}",
"project": "chromium",
"result_details_json": "{\"properties\": {}}",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"status": "SCHEDULED",
"status_changed_ts": "1576052090793809",
"tags": [
"build_address:luci.chromium.ci/Linux Builder (dbg)/165940",
"builder:Linux Builder (dbg)",
"buildset:commit/git/d9ed50d4762324ad72d7f94f127aa082b6051ab1",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/d9ed50d4762324ad72d7f94f127aa082b6051ab1",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9059813381424970944",
"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/8894383319274533200/+/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": "1576052090793920",
"url": "https://ci.chromium.org/b/8894383319274533200",
"utcnow_ts": "1576052091050610"
}
}
[08:14:51.079] Task URL: https://ci.chromium.org/b/8894383319274533200
[08:14:51.079] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9059813381424970944:2:0) after 1m0s
[08:15:51.169] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9059813381424970944:2:0)
[08:15:51.169] Timer tick, asking Buildbucket for the build status
[08:15:51.709] Build 8894383319274533200: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[08:15:51.709] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9059813381424970944:3:0) after 1m0s
[08:16:51.764] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9059813381424970944:3:0)
[08:16:51.764] Timer tick, asking Buildbucket for the build status
[08:16:52.025] Build 8894383319274533200: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[08:16:52.025] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9059813381424970944:4:0) after 1m0s
[08:17:52.463] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9059813381424970944:4:0)
[08:17:52.463] Timer tick, asking Buildbucket for the build status
[08:17:52.682] Build 8894383319274533200: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[08:17:52.682] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9059813381424970944:5:0) after 1m0s
[08:18:52.938] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9059813381424970944:5:0)
[08:18:52.938] Timer tick, asking Buildbucket for the build status
[08:18:55.772] Build 8894383319274533200: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[08:18:55.772] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9059813381424970944:6:0) after 1m0s
[08:19:07.783] Received PubSub notification, asking Buildbucket for the build status
[08:19:07.963] Build 8894383319274533200: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:19:55.918] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9059813381424970944:6:0)
[08:19:55.918] Timer tick, asking Buildbucket for the build status
[08:19:56.425] Build 8894383319274533200: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:19:56.425] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9059813381424970944:8:0) after 1m0s
[08:20:56.502] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9059813381424970944:8:0)
[08:20:56.502] Timer tick, asking Buildbucket for the build status
[08:20:57.184] Build 8894383319274533200: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:20:57.184] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9059813381424970944:9:0) after 1m0s
[08:21:57.237] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9059813381424970944:9:0)
[08:21:57.237] Timer tick, asking Buildbucket for the build status
[08:21:57.510] Build 8894383319274533200: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:21:57.510] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9059813381424970944:10:0) after 1m0s
[08:22:57.492] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9059813381424970944:10:0)
[08:22:57.492] Timer tick, asking Buildbucket for the build status
[08:22:57.810] Build 8894383319274533200: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:22:57.810] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9059813381424970944:11:0) after 1m0s
[08:23:58.673] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9059813381424970944:11:0)
[08:23:58.673] Timer tick, asking Buildbucket for the build status
[08:23:59.114] Build 8894383319274533200: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:23:59.114] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9059813381424970944:12:0) after 1m0s
[08:24:59.270] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9059813381424970944:12:0)
[08:24:59.271] Timer tick, asking Buildbucket for the build status
[08:24:59.933] Build 8894383319274533200: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:24:59.933] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9059813381424970944:13:0) after 1m0s
[08:26:00.017] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9059813381424970944:13:0)
[08:26:00.017] Timer tick, asking Buildbucket for the build status
[08:26:01.897] Build 8894383319274533200: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:26:01.897] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9059813381424970944:14:0) after 1m0s
[08:27:02.007] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9059813381424970944:14:0)
[08:27:02.007] Timer tick, asking Buildbucket for the build status
[08:27:02.434] Build 8894383319274533200: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:27:02.434] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9059813381424970944:15:0) after 1m0s
[08:28:02.523] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9059813381424970944:15:0)
[08:28:02.523] Timer tick, asking Buildbucket for the build status
[08:28:02.925] Build 8894383319274533200: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:28:02.925] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9059813381424970944:16:0) after 1m0s
[08:29:03.224] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9059813381424970944:16:0)
[08:29:03.224] Timer tick, asking Buildbucket for the build status
[08:29:03.686] Build 8894383319274533200: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:29:03.686] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9059813381424970944:17:0) after 1m0s
[08:30:03.885] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9059813381424970944:17:0)
[08:30:03.885] Timer tick, asking Buildbucket for the build status
[08:30:04.646] Build 8894383319274533200: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:30:04.646] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9059813381424970944:18:0) after 1m0s
[08:31:04.686] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9059813381424970944:18:0)
[08:31:04.686] Timer tick, asking Buildbucket for the build status
[08:31:05.165] Build 8894383319274533200: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:31:05.165] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9059813381424970944:19:0) after 1m0s
[08:32:05.189] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9059813381424970944:19:0)
[08:32:05.189] Timer tick, asking Buildbucket for the build status
[08:32:06.182] Build 8894383319274533200: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:32:06.182] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9059813381424970944:20:0) after 1m0s
[08:33:06.211] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9059813381424970944:20:0)
[08:33:06.211] Timer tick, asking Buildbucket for the build status
[08:33:06.420] Build 8894383319274533200: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:33:06.420] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9059813381424970944:21:0) after 1m0s
[08:34:06.465] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9059813381424970944:21:0)
[08:34:06.465] Timer tick, asking Buildbucket for the build status
[08:34:06.727] Build 8894383319274533200: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:34:06.727] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9059813381424970944:22:0) after 1m0s
[08:35:06.796] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9059813381424970944:22:0)
[08:35:06.796] Timer tick, asking Buildbucket for the build status
[08:35:07.324] Build 8894383319274533200: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:35:07.325] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9059813381424970944:23:0) after 1m0s
[08:36:07.339] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9059813381424970944:23:0)
[08:36:07.339] Timer tick, asking Buildbucket for the build status
[08:36:08.190] Build 8894383319274533200: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:36:08.191] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9059813381424970944:24:0) after 1m0s
[08:37:08.468] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9059813381424970944:24:0)
[08:37:08.468] Timer tick, asking Buildbucket for the build status
[08:37:09.075] Build 8894383319274533200: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:37:09.075] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9059813381424970944:25:0) after 1m0s
[08:38:09.329] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9059813381424970944:25:0)
[08:38:09.330] Timer tick, asking Buildbucket for the build status
[08:38:09.866] Build 8894383319274533200: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:38:09.866] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9059813381424970944:26:0) after 1m0s
[08:39:09.938] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9059813381424970944:26:0)
[08:39:09.938] Timer tick, asking Buildbucket for the build status
[08:39:10.145] Build 8894383319274533200: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:39:10.145] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9059813381424970944:27:0) after 1m0s
[08:40:10.176] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9059813381424970944:27:0)
[08:40:10.176] Timer tick, asking Buildbucket for the build status
[08:40:10.699] Build 8894383319274533200: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:40:10.699] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9059813381424970944:28:0) after 1m0s
[08:41:10.716] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9059813381424970944:28:0)
[08:41:10.716] Timer tick, asking Buildbucket for the build status
[08:41:11.358] Build 8894383319274533200: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:41:11.358] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9059813381424970944:29:0) after 1m0s
[08:42:11.404] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9059813381424970944:29:0)
[08:42:11.404] Timer tick, asking Buildbucket for the build status
[08:42:11.782] Build 8894383319274533200: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:42:11.782] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9059813381424970944:30:0) after 1m0s
[08:43:12.039] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9059813381424970944:30:0)
[08:43:12.039] Timer tick, asking Buildbucket for the build status
[08:43:13.380] Build 8894383319274533200: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:43:13.380] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9059813381424970944:31:0) after 1m0s
[08:44:13.682] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9059813381424970944:31:0)
[08:44:13.682] Timer tick, asking Buildbucket for the build status
[08:44:14.336] Build 8894383319274533200: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:44:14.336] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9059813381424970944:32:0) after 1m0s
[08:45:14.563] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9059813381424970944:32:0)
[08:45:14.563] Timer tick, asking Buildbucket for the build status
[08:45:15.112] Build 8894383319274533200: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:45:15.112] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9059813381424970944:33:0) after 1m0s
[08:46:15.213] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9059813381424970944:33:0)
[08:46:15.213] Timer tick, asking Buildbucket for the build status
[08:46:16.185] Build 8894383319274533200: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:46:16.185] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9059813381424970944:34:0) after 1m0s
[08:47:16.289] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9059813381424970944:34:0)
[08:47:16.289] Timer tick, asking Buildbucket for the build status
[08:47:17.069] Build 8894383319274533200: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:47:17.069] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9059813381424970944:35:0) after 1m0s
[08:48:17.125] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9059813381424970944:35:0)
[08:48:17.125] Timer tick, asking Buildbucket for the build status
[08:48:17.608] Build 8894383319274533200: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:48:17.608] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9059813381424970944:36:0) after 1m0s
[08:49:17.658] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9059813381424970944:36:0)
[08:49:17.658] Timer tick, asking Buildbucket for the build status
[08:49:18.150] Build 8894383319274533200: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:49:18.150] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9059813381424970944:37:0) after 1m0s
[08:50:18.213] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9059813381424970944:37:0)
[08:50:18.213] Timer tick, asking Buildbucket for the build status
[08:50:18.634] Build 8894383319274533200: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:50:18.634] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9059813381424970944:38:0) after 1m0s
[08:51:18.744] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9059813381424970944:38:0)
[08:51:18.745] Timer tick, asking Buildbucket for the build status
[08:51:20.785] Build 8894383319274533200: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:51:20.785] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9059813381424970944:39:0) after 1m0s
[08:52:20.892] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9059813381424970944:39:0)
[08:52:20.892] Timer tick, asking Buildbucket for the build status
[08:52:21.440] Build 8894383319274533200: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:52:21.440] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9059813381424970944:40:0) after 1m0s
[08:53:21.464] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9059813381424970944:40:0)
[08:53:21.464] Timer tick, asking Buildbucket for the build status
[08:53:21.962] Build 8894383319274533200: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:53:21.962] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9059813381424970944:41:0) after 1m0s
[08:54:22.050] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9059813381424970944:41:0)
[08:54:22.050] Timer tick, asking Buildbucket for the build status
[08:54:23.874] Build 8894383319274533200: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:54:23.874] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9059813381424970944:42:0) after 1m0s
[08:55:24.265] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9059813381424970944:42:0)
[08:55:24.265] Timer tick, asking Buildbucket for the build status
[08:55:24.468] Build 8894383319274533200: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:55:24.468] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9059813381424970944:43:0) after 1m0s
[08:56:24.545] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9059813381424970944:43:0)
[08:56:24.545] Timer tick, asking Buildbucket for the build status
[08:56:25.274] Build 8894383319274533200: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:56:25.274] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9059813381424970944:44:0) after 1m0s
[08:57:25.425] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9059813381424970944:44:0)
[08:57:25.425] Timer tick, asking Buildbucket for the build status
[08:57:26.142] Build 8894383319274533200: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:57:26.142] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9059813381424970944:45:0) after 1m0s
[08:58:26.306] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9059813381424970944:45:0)
[08:58:26.306] Timer tick, asking Buildbucket for the build status
[08:58:26.540] Build 8894383319274533200: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:58:26.540] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9059813381424970944:46:0) after 1m0s
[08:59:26.826] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9059813381424970944:46:0)
[08:59:26.826] Timer tick, asking Buildbucket for the build status
[08:59:27.020] Build 8894383319274533200: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:59:27.020] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9059813381424970944:47:0) after 1m0s
[09:00:27.055] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9059813381424970944:47:0)
[09:00:27.055] Timer tick, asking Buildbucket for the build status
[09:00:27.496] Build 8894383319274533200: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:00:27.496] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9059813381424970944:48:0) after 1m0s
[09:01:27.758] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9059813381424970944:48:0)
[09:01:27.758] Timer tick, asking Buildbucket for the build status
[09:01:28.565] Build 8894383319274533200: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:01:28.565] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9059813381424970944:49:0) after 1m0s
[09:02:28.645] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9059813381424970944:49:0)
[09:02:28.645] Timer tick, asking Buildbucket for the build status
[09:02:29.233] Build 8894383319274533200: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:02:29.233] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9059813381424970944:50:0) after 1m0s
[09:03:29.465] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9059813381424970944:50:0)
[09:03:29.466] Timer tick, asking Buildbucket for the build status
[09:03:29.847] Build 8894383319274533200: status "STARTED", result "", failure_reason "", cancelation_reason ""
[09:03:29.847] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9059813381424970944:51:0) after 1m0s
[09:03:33.426] Received PubSub notification, asking Buildbucket for the build status
[09:03:34.055] Build 8894383319274533200: status "COMPLETED", result "SUCCESS", failure_reason "", cancelation_reason ""
[09:03:34.055] Buildbucket build:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "PROD",
"completed_ts": "1576055012219160",
"created_by": "project:chromium",
"created_ts": "1576052090343278",
"id": "8894383319274533200",
"parameters_json": "{\"builder_name\": \"Linux Builder (dbg)\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"d9ed50d4762324ad72d7f94f127aa082b6051ab1\"}}",
"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-81-fpev\", \"branch\": \"refs/heads/master\", \"buildername\": \"Linux Builder (dbg)\", \"buildnumber\": 165940, \"got_angle_revision\": \"caa6eccde3ee90fcec9254c86060404c29b7d51a\", \"got_dawn_revision\": \"ea89189d336d691cd5661f81e1a35357fd346a5e\", \"got_nacl_revision\": \"3651f6c52037c96e034cc422746768d59182bff3\", \"got_revision\": \"d9ed50d4762324ad72d7f94f127aa082b6051ab1\", \"got_revision_cp\": \"refs/heads/master@{#723733}\", \"got_swarming_client_revision\": \"885b3febcc170a60f25795304e60927b77d1e92d\", \"got_swiftshader_revision\": \"353f3314bf40e3c7d0d5c2e65e931f65e73e7126\", \"got_v8_revision\": \"a7b3b5faf0c910eb2421d9386bcce32de672ba97\", \"got_v8_revision_cp\": \"refs/heads/8.1.12@{#1}\", \"got_webrtc_revision\": \"947a380b81ecd3eb40af30f317e3ccef521d5574\", \"got_webrtc_revision_cp\": \"refs/heads/master@{#30056}\", \"isolate_server\": \"https://isolateserver.appspot.com\", \"mastername\": \"chromium.linux\", \"path_config\": \"generic\", \"recipe\": \"chromium\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"d9ed50d4762324ad72d7f94f127aa082b6051ab1\", \"swarm_hashes_refs/heads/master(at){#723733}_without_patch\": {\"accessibility_unittests\": \"78cb0dedee1c7f01a2d7ce2970455a3a490356c3\", \"angle_unittests\": \"54953b22cf1c81f5c2c894a881924aaa1d868aef\", \"app_shell_unittests\": \"7384f05133f94d6deaa71ea05c28781b7a18cb74\", \"aura_unittests\": \"639beaac5cb985c0161affdb5afa47d1c6402d7c\", \"base_unittests\": \"409bf1f7623d361eac4b1a44f09aa00793d9029c\", \"base_util_unittests\": \"485c91b0a97c1d80af2d66165bb2223657b077f3\", \"blink_common_unittests\": \"464b2e8629a2f8da4424689d6a6f10f0628b8c53\", \"blink_fuzzer_unittests\": \"7a5edd7b2838505908fa50a257a0f8def48c55d3\", \"blink_heap_unittests\": \"64d5234ef70383943e4e8de8b3ff95ed68c5dd5c\", \"blink_platform_unittests\": \"7fe73f9b13db59ede4ace7f4b5cf41360875ca4f\", \"blink_python_tests\": \"55a594269800260fcc991b00462ee7a642bada12\", \"blink_unittests\": \"01866a3eac7d46566c8c1500b89b05a0bd010591\", \"blink_web_tests\": \"58a5b4a8148b659a59e1bf5f99b6107e0fb1ae04\", \"boringssl_crypto_tests\": \"11f1a077fa0155406b0c8d3bef04b839391a6e2d\", \"boringssl_ssl_tests\": \"3da0a7fbee1468544df83d41017ded0ac30bc959\", \"browser_tests\": \"a82ce195ac0a4dacfd8efd2f871ff762c6bb221b\", \"cacheinvalidation_unittests\": \"c6155d973b1ded198a26e03827ebb7c8c38128d9\", \"capture_unittests\": \"9b822dacbea1cc05da68d30ff40919c07ed48b2d\", \"cast_unittests\": \"5b6c36c300d58e0998ae72d0e0c7fe6903360a01\", \"cc_unittests\": \"a72c70dda5f4b1577b449507106c8626e50945e0\", \"chrome_app_unittests\": \"c13e7a0f44417e4382ec4b890a05053956034d6b\", \"chromedriver_unittests\": \"5ba9494b57ecb92e46b87fa97cc6bad4df0979d2\", \"components_browsertests\": \"1ea16d9fefe6391ecfa9e36777ae09240bf1bb0b\", \"components_unittests\": \"538c42929fc06b12303f6e94f06709255c87d68a\", \"compositor_unittests\": \"5f4023a31f0d8b39d31faeb5006d32b6520a82cf\", \"content_browsertests\": \"cd50257a2d91aa6cc8b109cce46123f261f767c5\", \"content_shell_crash_test\": \"4549405e5f9490014b4e7e41bc3988f186f7d5ba\", \"content_unittests\": \"b5332b3886221e7c36a0a5442ad9d6d20bb34493\", \"crashpad_tests\": \"a0bd57225e265c9c255f49c6a9577d071b8397ed\", \"cronet_tests\": \"31ece7d3c50c67a650a1f17eca3318339aaaa339\", \"cronet_unittests\": \"0e4327e626e185242ba219951a04333abd6ef7f1\", \"crypto_unittests\": \"d80790968ca92932e10de78677ade7089acad773\", \"dbus_unittests\": \"6a2855af41cd183e5d170fcd65e88bae8a26dede\", \"device_unittests\": \"0a31eb7fa740b2dfb1aadd2561e5ef18e3674ec4\", \"devtools_lint_check\": \"a32914318dd62ca0f0849f2ccfcc239beee43692\", \"devtools_type_check\": \"f98a0724cb931b8cc755bc5be71b748084101c90\", \"display_unittests\": \"696d53256e478c65f51ed495928894b1da7427ec\", \"events_unittests\": \"b4a410b975b22d8d7cc1484a22e16cb13d028758\", \"extensions_browsertests\": \"5a0cb99cd3c44943731aa7ec61b1170ef13a4b8b\", \"extensions_unittests\": \"53229459b8555f6a40e859f29097d0de23494ccf\", \"filesystem_service_unittests\": \"08abc8f3a5ab91412d49d490d51b53d4bee71c4d\", \"flatbuffers_unittests\": \"034d1c63a8199a680c9bbf29b5866b1c851e28ee\", \"gcm_unit_tests\": \"bd6eaf1882c3ba238adc60fe6d899b35937f3599\", \"gfx_unittests\": \"292444e7149cc47e1fd170ebeae08fea59401aa8\", \"gin_unittests\": \"e33ca9898db64a5c553bd179d2fd487295958d51\", \"google_apis_unittests\": \"5eec68b0789c0e1fd26ce6975764bbec1fd1a046\", \"gpu_unittests\": \"67a0c78d81f6e4486da1bbd4bc0002061d5b86ce\", \"grit_python_unittests\": \"c949091fb2717b913781a9a7cb15efe1537c4608\", \"gwp_asan_unittests\": \"b2939cd5fd508c3da068939b0cdf718613826a50\", \"headless_browsertests\": \"c8fb0fb81a2e519963b07d6989aa096d08b1757f\", \"headless_unittests\": \"f03f166fa7d8780b42fa1d1b0ce8b0acf3b2e867\", \"interactive_ui_tests\": \"2166adbd342fa62fc1e7a2a3d85eb62e72685e5d\", \"ipc_tests\": \"7dfbc62764178e3a7846ee7a0de24d3b06b3a4e1\", \"jingle_unittests\": \"6b9c8f81570f61ef92741311186defd6a11359b2\", \"latency_unittests\": \"1e6ac5b5fc5bd7d818f4d44c3a824871ea4017a2\", \"libjingle_xmpp_unittests\": \"311a1cb436b96c3551f3243ee7c4ef8884830fa4\", \"media_blink_unittests\": \"d676fc5d2df1085ed1d1bc618d3fa05a742ed76e\", \"media_service_unittests\": \"c46e651a51d1b324906560a5d9f22871fce687d2\", \"media_unittests\": \"e0cbb118be1d17caad636ce5a85a8fd7fd266abf\", \"message_center_unittests\": \"566861e174b33d97578fa6bab4bc6dc4749ce6c4\", \"metrics_python_tests\": \"48f26b6206416ceab219f1954fa76901b5bbfa79\", \"midi_unittests\": \"656d8b45a0c954ffecc112a792f1078692cfa50b\", \"mojo_core_unittests\": \"7b73240ca727f3e980fb9795ce869c16fac4099d\", \"mojo_unittests\": \"17ff33efd42a2273fbf792963ca6fe26990aaf7c\", \"nacl_helper_nonsfi_unittests\": \"c2d453b20530d77066a37ad40698718617fb458f\", \"nacl_loader_unittests\": \"4354b62c24a2ecdaa8f9b0637fbfb832545d9478\", \"native_theme_unittests\": \"af3a95c57d6b8312ca754ee867f031a0f59bf3ed\", \"net_unittests\": \"7e0ffd0046e04a5fd7c79013efba7c86b1bdb02a\", \"pdf_unittests\": \"2c2543b3f76e2a079cae44f83b4c89412d10c0a9\", \"perfetto_unittests\": \"2469bcaf7a1e1bb170dcf2b30f3e4465f00a0a54\", \"ppapi_unittests\": \"68f126752fb6409689cab1467486a34b4d3a5d7d\", \"printing_unittests\": \"2658b048bc83cbe336c74177de7b25b3c31b47f5\", \"remoting_unittests\": \"5b0122081d028cc32fe4827395b5a066fc16e34b\", \"sandbox_linux_unittests\": \"0caa77dd588ea291810a44b1ca72eb99fc894e81\", \"service_manager_unittests\": \"f125da82536a10f22b05baaee700d37ee294e158\", \"services_unittests\": \"5e5323ac928f3da94c76f618a1700d4b3aa79b09\", \"shell_dialogs_unittests\": \"2f6c9233b2d4b8eed51337f7015b15ea92a61827\", \"skia_unittests\": \"0d9b8e29cbe6245b6f80f4206852764f12391630\", \"snapshot_unittests\": \"a4221eaf2cb96d19a4b1d3444335cd44596b301f\", \"sql_unittests\": \"d52ef03a4d997eb7f9bbf468b9c2325083842dfc\", \"storage_unittests\": \"e2da356ef6657af64f6752d046e9c34e035aa1c1\", \"sync_integration_tests\": \"41a9d4487a57a6a8a546043777858c81991abed7\", \"telemetry_gpu_unittests\": \"d857918efb28a1fc3a15ddfa8c9f10209d6d9cd9\", \"telemetry_perf_unittests\": \"f78b1b4f19862e95f4860d7b81a06156329ce58f\", \"telemetry_unittests\": \"099d2c43bcfa33504c515c90f98d9e23aa469093\", \"traffic_annotation_auditor_unittests\": \"e0dce1b71abe60390f2feca00f525dfbb8958370\", \"ui_base_unittests\": \"5d88d4700c8ade4b516422b082670bb24c51f4c9\", \"ui_touch_selection_unittests\": \"da5c483d8db9dece933c485bc0b6da2e00779859\", \"unit_tests\": \"e472323aa9407dc41e6242ab42b35ae68c7d29ab\", \"url_unittests\": \"a94d03792bc2852ff36cb1ac1f884dfa1540f907\", \"views_perftests\": \"e6261a89d79d9c40ae78045baa1e083ff01385ed\", \"views_unittests\": \"836ee4bf17b1cff627ba6dc2dd1d2f12e68872a5\", \"viz_unittests\": \"1726b789a3e1f8cf0e036518cbe27633870366b3\", \"vr_common_unittests\": \"b34f14b433f2893fa7d0f35946ec365d98c4b7a0\", \"vr_pixeltests\": \"6425410d7a124fd6c91eebc29af8bd4845e31996\", \"webdriver_wpt_tests\": \"d239462fa5bce037fc02d3ca6e74f3b80c995d0a\", \"weblayer_browsertests\": \"b2abe2a3e1621e802008cbf57bb0662ad2d5b010\", \"wm_unittests\": \"5a97dc42e39bfb9973ed6dc638c096919e8ed8ed\", \"wtf_unittests\": \"43019f5a04b08fe499e79b7a3810716593d054ba\", \"xr_browser_tests\": \"da77a25d6857cf5d3fefc5bfbe3d370bf78c05b1\"}}, \"swarming\": {\"bot_dimensions\": {\"builderless\": [\"1\"], \"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-81-fpev\"], \"image\": [\"chrome-xenial-19120800-09d8782d9a1\"], \"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\": [\"4709-f2c88b6\"], \"ssd\": [\"0\"], \"zone\": [\"us\", \"us-east\", \"us-east1\", \"us-east1-d\"]}}}",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"started_ts": "1576052346888436",
"status": "COMPLETED",
"status_changed_ts": "1576055012682153",
"tags": [
"build_address:luci.chromium.ci/Linux Builder (dbg)/165940",
"builder:Linux Builder (dbg)",
"buildset:commit/git/d9ed50d4762324ad72d7f94f127aa082b6051ab1",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/d9ed50d4762324ad72d7f94f127aa082b6051ab1",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9059813381424970944",
"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/8894383319274533200/+/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:490cd7f3f495dd10",
"user_agent:luci-scheduler"
],
"updated_ts": "1576055012691466",
"url": "https://ci.chromium.org/b/8894383319274533200",
"utcnow_ts": "1576055014037185"
}
}
[09:03:34.055] Invocation finished in 48m45.146376586s with status SUCCEEDED