[16:54:57.011] New invocation is queued and will start shortly
[16:54:58.363] Starting the invocation (attempt 1)
[16:54:58.394] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[16:54:58.395] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[16:54:58.395] Buildbucket request:
{
"bucket": "luci.chromium.ci",
"client_operation_id": "9076994080990913392",
"parameters_json": "{\"builder_name\":\"Deterministic Linux (dbg)\",\"properties\":{\"branch\":\"refs/heads/master\",\"repository\":\"https://chromium.googlesource.com/chromium/src.git\",\"revision\":\"3e139c3d515449d8684e9287dd536db4e366723f\"}}",
"pubsub_callback": {
"auth_token": "...",
"topic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
},
"tags": [
"builder:Deterministic Linux (dbg)",
"scheduler_invocation_id:9076994080990913392",
"scheduler_job_id:chromium/Deterministic Linux (dbg)",
"user_agent:luci-scheduler",
"buildset:commit/git/3e139c3d515449d8684e9287dd536db4e366723f",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/3e139c3d515449d8684e9287dd536db4e366723f",
"gitiles_ref:refs/heads/master"
]
}
[16:54:59.379] Buildbucket response:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "PROD",
"created_by": "project:chromium",
"created_ts": "1559667298541275",
"id": "8911564018723681264",
"parameters_json": "{\"builder_name\": \"Deterministic Linux (dbg)\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src.git\", \"revision\": \"3e139c3d515449d8684e9287dd536db4e366723f\"}}",
"project": "chromium",
"result_details_json": "{\"properties\": {}}",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"status": "SCHEDULED",
"status_changed_ts": "1559667299019946",
"tags": [
"build_address:luci.chromium.ci/Deterministic Linux (dbg)/8213",
"builder:Deterministic Linux (dbg)",
"buildset:commit/git/3e139c3d515449d8684e9287dd536db4e366723f",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/3e139c3d515449d8684e9287dd536db4e366723f",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9076994080990913392",
"scheduler_job_id:chromium/Deterministic Linux (dbg)",
"swarming_hostname:chromium-swarm.appspot.com",
"swarming_tag:log_location:logdog://logs.chromium.org/chromium/buildbucket/cr-buildbucket.appspot.com/8911564018723681264/+/annotations",
"swarming_tag:luci_project:chromium",
"swarming_tag:recipe_name:swarming/deterministic_build",
"swarming_tag:recipe_package:infra/recipe_bundles/chromium.googlesource.com/chromium/tools/build",
"swarming_task_id:",
"user_agent:luci-scheduler"
],
"updated_ts": "1559667299020126",
"url": "https://ci.chromium.org/b/8911564018723681264",
"utcnow_ts": "1559667299373289"
}
}
[16:54:59.379] Task URL: https://ci.chromium.org/b/8911564018723681264
[16:54:59.379] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9076994080990913392:2:0) after 1m0s
[16:55:06.070] Received PubSub notification, asking Buildbucket for the build status
[16:55:07.143] Build 8911564018723681264: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:55:59.412] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9076994080990913392:2:0)
[16:55:59.412] Timer tick, asking Buildbucket for the build status
[16:56:01.675] Build 8911564018723681264: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:56:01.675] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9076994080990913392:4:0) after 1m0s
[16:57:01.743] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9076994080990913392:4:0)
[16:57:01.743] Timer tick, asking Buildbucket for the build status
[16:57:02.139] Build 8911564018723681264: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:57:02.139] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9076994080990913392:5:0) after 1m0s
[16:58:02.174] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9076994080990913392:5:0)
[16:58:02.174] Timer tick, asking Buildbucket for the build status
[16:58:03.083] Build 8911564018723681264: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:58:03.084] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9076994080990913392:6:0) after 1m0s
[16:59:03.067] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9076994080990913392:6:0)
[16:59:03.067] Timer tick, asking Buildbucket for the build status
[16:59:03.664] Build 8911564018723681264: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:59:03.664] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9076994080990913392:7:0) after 1m0s
[17:00:03.729] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9076994080990913392:7:0)
[17:00:03.729] Timer tick, asking Buildbucket for the build status
[17:00:04.438] Build 8911564018723681264: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:00:04.438] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9076994080990913392:8:0) after 1m0s
[17:01:04.459] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9076994080990913392:8:0)
[17:01:04.459] Timer tick, asking Buildbucket for the build status
[17:01:05.759] Build 8911564018723681264: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:01:05.759] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9076994080990913392:9:0) after 1m0s
[17:02:05.797] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9076994080990913392:9:0)
[17:02:05.797] Timer tick, asking Buildbucket for the build status
[17:02:07.784] Build 8911564018723681264: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:02:07.784] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9076994080990913392:10:0) after 1m0s
[17:03:07.891] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9076994080990913392:10:0)
[17:03:07.891] Timer tick, asking Buildbucket for the build status
[17:03:09.059] Build 8911564018723681264: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:03:09.059] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9076994080990913392:11:0) after 1m0s
[17:04:09.112] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9076994080990913392:11:0)
[17:04:09.112] Timer tick, asking Buildbucket for the build status
[17:04:10.078] Build 8911564018723681264: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:04:10.078] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9076994080990913392:12:0) after 1m0s
[17:05:10.122] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9076994080990913392:12:0)
[17:05:10.122] Timer tick, asking Buildbucket for the build status
[17:05:11.353] Build 8911564018723681264: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:05:11.353] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9076994080990913392:13:0) after 1m0s
[17:06:11.392] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9076994080990913392:13:0)
[17:06:11.392] Timer tick, asking Buildbucket for the build status
[17:06:11.701] Build 8911564018723681264: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:06:11.701] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9076994080990913392:14:0) after 1m0s
[17:07:11.772] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9076994080990913392:14:0)
[17:07:11.772] Timer tick, asking Buildbucket for the build status
[17:07:13.602] Build 8911564018723681264: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:07:13.602] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9076994080990913392:15:0) after 1m0s
[17:08:13.641] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9076994080990913392:15:0)
[17:08:13.641] Timer tick, asking Buildbucket for the build status
[17:08:14.235] Build 8911564018723681264: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:08:14.235] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9076994080990913392:16:0) after 1m0s
[17:09:14.325] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9076994080990913392:16:0)
[17:09:14.325] Timer tick, asking Buildbucket for the build status
[17:09:16.027] Build 8911564018723681264: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:09:16.027] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9076994080990913392:17:0) after 1m0s
[17:10:16.091] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9076994080990913392:17:0)
[17:10:16.091] Timer tick, asking Buildbucket for the build status
[17:10:16.729] Build 8911564018723681264: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:10:16.729] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9076994080990913392:18:0) after 1m0s
[17:11:16.802] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9076994080990913392:18:0)
[17:11:16.802] Timer tick, asking Buildbucket for the build status
[17:11:16.936] Build 8911564018723681264: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:11:16.936] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9076994080990913392:19:0) after 1m0s
[17:12:16.986] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9076994080990913392:19:0)
[17:12:16.986] Timer tick, asking Buildbucket for the build status
[17:12:17.426] Build 8911564018723681264: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:12:17.426] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9076994080990913392:20:0) after 1m0s
[17:13:17.477] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9076994080990913392:20:0)
[17:13:17.477] Timer tick, asking Buildbucket for the build status
[17:13:17.900] Build 8911564018723681264: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:13:17.900] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9076994080990913392:21:0) after 1m0s
[17:14:18.077] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9076994080990913392:21:0)
[17:14:18.077] Timer tick, asking Buildbucket for the build status
[17:14:18.371] Build 8911564018723681264: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:14:18.371] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9076994080990913392:22:0) after 1m0s
[17:15:18.428] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9076994080990913392:22:0)
[17:15:18.428] Timer tick, asking Buildbucket for the build status
[17:15:18.699] Build 8911564018723681264: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:15:18.699] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9076994080990913392:23:0) after 1m0s
[17:16:18.760] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9076994080990913392:23:0)
[17:16:18.760] Timer tick, asking Buildbucket for the build status
[17:16:19.474] Build 8911564018723681264: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:16:19.474] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9076994080990913392:24:0) after 1m0s
[17:17:19.517] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9076994080990913392:24:0)
[17:17:19.517] Timer tick, asking Buildbucket for the build status
[17:17:20.061] Build 8911564018723681264: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:17:20.062] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9076994080990913392:25:0) after 1m0s
[17:18:20.089] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9076994080990913392:25:0)
[17:18:20.089] Timer tick, asking Buildbucket for the build status
[17:18:20.456] Build 8911564018723681264: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:18:20.456] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9076994080990913392:26:0) after 1m0s
[17:19:20.522] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9076994080990913392:26:0)
[17:19:20.522] Timer tick, asking Buildbucket for the build status
[17:19:21.981] Build 8911564018723681264: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:19:21.981] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9076994080990913392:27:0) after 1m0s
[17:20:22.003] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9076994080990913392:27:0)
[17:20:22.003] Timer tick, asking Buildbucket for the build status
[17:20:22.582] Build 8911564018723681264: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:20:22.582] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9076994080990913392:28:0) after 1m0s
[17:21:28.030] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9076994080990913392:28:0)
[17:21:28.030] Timer tick, asking Buildbucket for the build status
[17:21:28.410] Build 8911564018723681264: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:21:28.410] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9076994080990913392:29:0) after 1m0s
[17:22:28.624] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9076994080990913392:29:0)
[17:22:28.624] Timer tick, asking Buildbucket for the build status
[17:22:28.714] Build 8911564018723681264: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:22:28.714] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9076994080990913392:30:0) after 1m0s
[17:23:28.804] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9076994080990913392:30:0)
[17:23:28.804] Timer tick, asking Buildbucket for the build status
[17:23:29.033] Build 8911564018723681264: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:23:29.033] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9076994080990913392:31:0) after 1m0s
[17:24:29.111] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9076994080990913392:31:0)
[17:24:29.111] Timer tick, asking Buildbucket for the build status
[17:24:29.831] Build 8911564018723681264: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:24:29.831] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9076994080990913392:32:0) after 1m0s
[17:25:29.841] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9076994080990913392:32:0)
[17:25:29.841] Timer tick, asking Buildbucket for the build status
[17:25:30.209] Build 8911564018723681264: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:25:30.209] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9076994080990913392:33:0) after 1m0s
[17:26:30.222] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9076994080990913392:33:0)
[17:26:30.222] Timer tick, asking Buildbucket for the build status
[17:26:32.146] Build 8911564018723681264: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:26:32.146] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9076994080990913392:34:0) after 1m0s
[17:27:32.291] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9076994080990913392:34:0)
[17:27:32.291] Timer tick, asking Buildbucket for the build status
[17:27:33.355] Build 8911564018723681264: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:27:33.355] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9076994080990913392:35:0) after 1m0s
[17:28:58.167] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9076994080990913392:35:0)
[17:28:58.167] Timer tick, asking Buildbucket for the build status
[17:28:59.736] Build 8911564018723681264: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:28:59.736] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9076994080990913392:36:0) after 1m0s
[17:30:00.158] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9076994080990913392:36:0)
[17:30:00.158] Timer tick, asking Buildbucket for the build status
[17:30:02.707] Build 8911564018723681264: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:30:02.707] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9076994080990913392:37:0) after 1m0s
[17:31:02.724] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9076994080990913392:37:0)
[17:31:02.724] Timer tick, asking Buildbucket for the build status
[17:31:04.367] Build 8911564018723681264: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:31:04.367] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9076994080990913392:38:0) after 1m0s
[17:32:04.414] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9076994080990913392:38:0)
[17:32:04.414] Timer tick, asking Buildbucket for the build status
[17:32:04.640] Build 8911564018723681264: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:32:04.640] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9076994080990913392:39:0) after 1m0s
[17:33:04.769] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9076994080990913392:39:0)
[17:33:04.769] Timer tick, asking Buildbucket for the build status
[17:33:04.893] Build 8911564018723681264: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:33:04.893] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9076994080990913392:40:0) after 1m0s
[17:34:05.043] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9076994080990913392:40:0)
[17:34:05.043] Timer tick, asking Buildbucket for the build status
[17:34:05.293] Build 8911564018723681264: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:34:05.293] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9076994080990913392:41:0) after 1m0s
[17:35:09.741] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9076994080990913392:41:0)
[17:35:09.741] Timer tick, asking Buildbucket for the build status
[17:35:09.934] Build 8911564018723681264: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:35:09.934] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9076994080990913392:42:0) after 1m0s
[17:36:10.493] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9076994080990913392:42:0)
[17:36:10.493] Timer tick, asking Buildbucket for the build status
[17:36:11.206] Build 8911564018723681264: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:36:11.206] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9076994080990913392:43:0) after 1m0s
[17:37:11.451] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9076994080990913392:43:0)
[17:37:11.451] Timer tick, asking Buildbucket for the build status
[17:37:11.629] Build 8911564018723681264: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:37:11.629] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9076994080990913392:44:0) after 1m0s
[17:38:12.228] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9076994080990913392:44:0)
[17:38:12.228] Timer tick, asking Buildbucket for the build status
[17:38:13.051] Build 8911564018723681264: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:38:13.051] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9076994080990913392:45:0) after 1m0s
[17:39:13.520] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9076994080990913392:45:0)
[17:39:13.520] Timer tick, asking Buildbucket for the build status
[17:39:14.174] Build 8911564018723681264: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:39:14.174] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9076994080990913392:46:0) after 1m0s
[17:40:14.442] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9076994080990913392:46:0)
[17:40:14.442] Timer tick, asking Buildbucket for the build status
[17:40:14.585] Build 8911564018723681264: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:40:14.585] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9076994080990913392:47:0) after 1m0s
[17:41:14.660] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9076994080990913392:47:0)
[17:41:14.660] Timer tick, asking Buildbucket for the build status
[17:41:15.885] Build 8911564018723681264: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:41:15.885] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9076994080990913392:48:0) after 1m0s
[17:42:15.895] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9076994080990913392:48:0)
[17:42:15.895] Timer tick, asking Buildbucket for the build status
[17:42:16.261] Build 8911564018723681264: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:42:16.261] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9076994080990913392:49:0) after 1m0s
[17:43:22.022] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9076994080990913392:49:0)
[17:43:22.022] Timer tick, asking Buildbucket for the build status
[17:43:22.461] Build 8911564018723681264: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:43:22.461] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9076994080990913392:50:0) after 1m0s
[17:44:22.482] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9076994080990913392:50:0)
[17:44:22.482] Timer tick, asking Buildbucket for the build status
[17:44:23.206] Build 8911564018723681264: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:44:23.206] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9076994080990913392:51:0) after 1m0s
[17:45:23.230] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9076994080990913392:51:0)
[17:45:23.230] Timer tick, asking Buildbucket for the build status
[17:45:23.342] Build 8911564018723681264: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:45:23.342] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9076994080990913392:52:0) after 1m0s
[17:46:23.374] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9076994080990913392:52:0)
[17:46:23.374] Timer tick, asking Buildbucket for the build status
[17:46:23.668] Build 8911564018723681264: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:46:23.668] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9076994080990913392:53:0) after 1m0s
[17:47:23.711] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9076994080990913392:53:0)
[17:47:23.711] Timer tick, asking Buildbucket for the build status
[17:47:23.829] Build 8911564018723681264: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:47:23.829] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9076994080990913392:54:0) after 1m0s
[17:48:23.852] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9076994080990913392:54:0)
[17:48:23.852] Timer tick, asking Buildbucket for the build status
[17:48:24.743] Build 8911564018723681264: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:48:24.743] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9076994080990913392:55:0) after 1m0s
[17:49:24.770] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9076994080990913392:55:0)
[17:49:24.770] Timer tick, asking Buildbucket for the build status
[17:49:25.737] Build 8911564018723681264: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:49:25.737] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9076994080990913392:56:0) after 1m0s
[17:50:33.186] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9076994080990913392:56:0)
[17:50:33.186] Timer tick, asking Buildbucket for the build status
[17:50:33.504] Build 8911564018723681264: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:50:33.504] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9076994080990913392:57:0) after 1m0s
[17:51:37.583] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9076994080990913392:57:0)
[17:51:37.583] Timer tick, asking Buildbucket for the build status
[17:51:38.874] Build 8911564018723681264: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:51:38.874] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9076994080990913392:58:0) after 1m0s
[17:52:39.164] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9076994080990913392:58:0)
[17:52:39.164] Timer tick, asking Buildbucket for the build status
[17:52:39.430] Build 8911564018723681264: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:52:39.430] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9076994080990913392:59:0) after 1m0s
[17:53:39.661] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9076994080990913392:59:0)
[17:53:39.661] Timer tick, asking Buildbucket for the build status
[17:53:39.801] Build 8911564018723681264: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:53:39.801] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9076994080990913392:60:0) after 1m0s
[17:54:39.921] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9076994080990913392:60:0)
[17:54:39.921] Timer tick, asking Buildbucket for the build status
[17:54:41.814] Build 8911564018723681264: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:54:41.814] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9076994080990913392:61:0) after 1m0s
[17:55:42.075] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9076994080990913392:61:0)
[17:55:42.075] Timer tick, asking Buildbucket for the build status
[17:55:44.021] Build 8911564018723681264: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:55:44.021] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9076994080990913392:62:0) after 1m0s
[17:56:44.328] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9076994080990913392:62:0)
[17:56:44.328] Timer tick, asking Buildbucket for the build status
[17:56:44.703] Build 8911564018723681264: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:56:44.703] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9076994080990913392:63:0) after 1m0s
[17:57:44.922] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9076994080990913392:63:0)
[17:57:44.922] Timer tick, asking Buildbucket for the build status
[17:57:46.654] Build 8911564018723681264: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:57:46.654] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9076994080990913392:64:0) after 1m0s
[17:58:46.783] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9076994080990913392:64:0)
[17:58:46.783] Timer tick, asking Buildbucket for the build status
[17:58:46.888] Build 8911564018723681264: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:58:46.888] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9076994080990913392:65:0) after 1m0s
[17:59:47.535] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9076994080990913392:65:0)
[17:59:47.535] Timer tick, asking Buildbucket for the build status
[17:59:47.922] Build 8911564018723681264: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:59:47.922] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9076994080990913392:66:0) after 1m0s
[18:00:48.175] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9076994080990913392:66:0)
[18:00:48.175] Timer tick, asking Buildbucket for the build status
[18:00:54.368] Build 8911564018723681264: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:00:54.368] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9076994080990913392:67:0) after 1m0s
[18:01:54.547] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9076994080990913392:67:0)
[18:01:54.547] Timer tick, asking Buildbucket for the build status
[18:01:54.803] Build 8911564018723681264: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:01:54.803] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9076994080990913392:68:0) after 1m0s
[18:02:55.816] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9076994080990913392:68:0)
[18:02:55.816] Timer tick, asking Buildbucket for the build status
[18:02:56.834] Build 8911564018723681264: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:02:56.834] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9076994080990913392:69:0) after 1m0s
[18:04:05.925] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9076994080990913392:69:0)
[18:04:05.925] Timer tick, asking Buildbucket for the build status
[18:04:06.734] Build 8911564018723681264: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:04:06.734] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9076994080990913392:70:0) after 1m0s
[18:05:06.926] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9076994080990913392:70:0)
[18:05:06.926] Timer tick, asking Buildbucket for the build status
[18:05:08.429] Build 8911564018723681264: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:05:08.429] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9076994080990913392:71:0) after 1m0s
[18:06:08.468] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9076994080990913392:71:0)
[18:06:08.468] Timer tick, asking Buildbucket for the build status
[18:06:10.881] Build 8911564018723681264: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:06:10.881] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9076994080990913392:72:0) after 1m0s
[18:07:11.222] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9076994080990913392:72:0)
[18:07:11.222] Timer tick, asking Buildbucket for the build status
[18:07:11.538] Build 8911564018723681264: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:07:11.538] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Linux (dbg):9076994080990913392:73:0) after 1m0s
[18:07:14.712] Received PubSub notification, asking Buildbucket for the build status
[18:07:14.944] Build 8911564018723681264: status "COMPLETED", result "SUCCESS", failure_reason "", cancelation_reason ""
[18:07:14.944] Buildbucket build:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "PROD",
"completed_ts": "1559671632012999",
"created_by": "project:chromium",
"created_ts": "1559667298541275",
"id": "8911564018723681264",
"parameters_json": "{\"builder_name\": \"Deterministic Linux (dbg)\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src.git\", \"revision\": \"3e139c3d515449d8684e9287dd536db4e366723f\"}}",
"project": "chromium",
"result": "SUCCESS",
"result_details_json": "{\"properties\": {\"$build/goma\": {\"jobs\": 500.0}, \"$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-trusty-32-12-v70t\", \"branch\": \"refs/heads/master\", \"buildername\": \"Deterministic Linux (dbg)\", \"buildnumber\": 8213, \"got_angle_revision\": \"4a75741655d330e257b2f20d7404cce1e51ef72e\", \"got_dawn_revision\": \"b632bc58ed373eb2020af65e0fdeaf07d46d1a9c\", \"got_nacl_revision\": \"0ddc033406886a709b901e0c312872529f9705e8\", \"got_revision\": \"3e139c3d515449d8684e9287dd536db4e366723f\", \"got_revision_cp\": \"refs/heads/master@{#665955}\", \"got_swarming_client_revision\": \"779c4f0f8488c64587b75dbb001d18c3c0c4cda9\", \"got_v8_revision\": \"9672bf6d0b325ae9a9157ca217db965bca7e76f9\", \"got_v8_revision_cp\": \"refs/heads/7.7.15@{#1}\", \"got_webrtc_revision\": \"961407f5e86fa4429086dc0c532ab9ceebc4623d\", \"got_webrtc_revision_cp\": \"refs/heads/master@{#28153}\", \"mastername\": \"chromium.linux\", \"path_config\": \"generic\", \"recipe\": \"swarming/deterministic_build\", \"repository\": \"https://chromium.googlesource.com/chromium/src.git\", \"revision\": \"3e139c3d515449d8684e9287dd536db4e366723f\"}, \"swarming\": {\"bot_dimensions\": {\"builderless\": [\"1\"], \"caches\": [\"builder_61e4d25dfd74628f421fe7d90da475349672e571b4dfd9a5326b66319dc94b9e_v2\", \"builder_940b8dd4638ac05ec7d44839e381a2baf02720b3eac518443ac04ffe6b1809c0_v2\", \"git\", \"goma_v2\", \"vpython\"], \"cores\": [\"32\"], \"cpu\": [\"x86\", \"x86-64\", \"x86-64-Broadwell_GCE\", \"x86-64-avx2\"], \"gce\": [\"1\"], \"gpu\": [\"none\"], \"id\": [\"luci-chromium-ci-trusty-32-12-v70t\"], \"image\": [\"chrome-trusty-19041600-95c8804d634\"], \"inside_docker\": [\"0\"], \"kvm\": [\"1\"], \"machine_type\": [\"n1-standard-32\"], \"os\": [\"Linux\", \"Ubuntu\", \"Ubuntu-14.04\"], \"pool\": [\"luci.chromium.ci\"], \"python\": [\"2.7.6\"], \"server_version\": [\"4316-effbcfc\"], \"zone\": [\"us\", \"us-west\", \"us-west1\", \"us-west1-c\"]}}}",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"started_ts": "1559667304350712",
"status": "COMPLETED",
"status_changed_ts": "1559671633725824",
"tags": [
"build_address:luci.chromium.ci/Deterministic Linux (dbg)/8213",
"builder:Deterministic Linux (dbg)",
"buildset:commit/git/3e139c3d515449d8684e9287dd536db4e366723f",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/3e139c3d515449d8684e9287dd536db4e366723f",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9076994080990913392",
"scheduler_job_id:chromium/Deterministic Linux (dbg)",
"swarming_hostname:chromium-swarm.appspot.com",
"swarming_tag:log_location:logdog://logs.chromium.org/chromium/buildbucket/cr-buildbucket.appspot.com/8911564018723681264/+/annotations",
"swarming_tag:luci_project:chromium",
"swarming_tag:os:Linux",
"swarming_tag:recipe_name:swarming/deterministic_build",
"swarming_tag:recipe_package:infra/recipe_bundles/chromium.googlesource.com/chromium/tools/build",
"swarming_task_id:453c3bdd1596dd10",
"user_agent:luci-scheduler"
],
"updated_ts": "1559671633754311",
"url": "https://ci.chromium.org/b/8911564018723681264",
"utcnow_ts": "1559671634935526"
}
}
[18:07:14.944] Invocation finished in 1h12m17.948693279s with status SUCCEEDED