[17:42:38.340] New invocation is queued and will start shortly
[17:42:39.563] Starting the invocation (attempt 1)
[17:42:39.592] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[17:42:39.592] PubSub topic is "projects/luci-scheduler/topics/scheduler+buildbucket+cr-buildbucket~appspot.gserviceaccount.com"
[17:42:39.592] Buildbucket request:
{
"bucket": "luci.webrtc.ci",
"client_operation_id": "9113048673297263152",
"parameters_json": "{\"builder_name\":\"Linux64 Release\",\"properties\":{\"branch\":\"refs/heads/master\",\"repository\":\"https://webrtc.googlesource.com/src/\",\"revision\":\"26e084906140af8dd7b75d381a6476161bba5bb2\"}}",
"pubsub_callback": {
"auth_token": "...",
"topic": "projects/luci-scheduler/topics/scheduler+buildbucket+cr-buildbucket~appspot.gserviceaccount.com"
},
"tags": [
"builder:Linux64 Release",
"scheduler_invocation_id:9113048673297263152",
"scheduler_job_id:webrtc/Linux64 Release",
"user_agent:luci-scheduler",
"buildset:commit/gitiles/webrtc.googlesource.com/src/+/26e084906140af8dd7b75d381a6476161bba5bb2",
"gitiles_ref:refs/heads/master"
]
}
[17:42:40.529] Buildbucket response:
{
"build": {
"bucket": "luci.webrtc.ci",
"canary_preference": "AUTO",
"created_by": "user:luci-scheduler@appspot.gserviceaccount.com",
"created_ts": "1525282959665440",
"experimental": true,
"id": "8947618611244549296",
"lease_expiration_ts": "1525311760206500",
"lease_key": "1661807574",
"parameters_json": "{\"builder_name\": \"Linux64 Release\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://webrtc.googlesource.com/src/\", \"revision\": \"26e084906140af8dd7b75d381a6476161bba5bb2\"}}",
"project": "webrtc",
"result_details_json": "null",
"service_account": "none",
"status": "SCHEDULED",
"status_changed_ts": "1525282960367330",
"tags": [
"build_address:luci.webrtc.ci/Linux64 Release/11",
"builder:Linux64 Release",
"buildset:commit/gitiles/webrtc.googlesource.com/src/+/26e084906140af8dd7b75d381a6476161bba5bb2",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9113048673297263152",
"scheduler_job_id:webrtc/Linux64 Release",
"swarming_dimension:cpu:x86-64",
"swarming_dimension:os:Linux",
"swarming_dimension:pool:luci.webrtc.ci",
"swarming_hostname:chromium-swarm.appspot.com",
"swarming_tag:build_address:luci.webrtc.ci/Linux64 Release/11",
"swarming_tag:buildbucket_bucket:luci.webrtc.ci",
"swarming_tag:buildbucket_build_id:8947618611244549296",
"swarming_tag:buildbucket_hostname:cr-buildbucket.appspot.com",
"swarming_tag:buildbucket_template_canary:0",
"swarming_tag:buildbucket_template_revision:48a002e4c84497febc829e8ccfd23eb8084470dc",
"swarming_tag:builder:Linux64 Release",
"swarming_tag:buildset:commit/gitiles/webrtc.googlesource.com/src/+/26e084906140af8dd7b75d381a6476161bba5bb2",
"swarming_tag:cpu:x86-64",
"swarming_tag:gitiles_ref:refs/heads/master",
"swarming_tag:log_location:logdog://logs.chromium.org/webrtc/buildbucket/cr-buildbucket.appspot.com/8947618611244549296/+/annotations",
"swarming_tag:luci_project:webrtc",
"swarming_tag:os:Linux",
"swarming_tag:pool:luci.webrtc.ci",
"swarming_tag:priority:60",
"swarming_tag:recipe_name:webrtc/standalone",
"swarming_tag:recipe_repository:https://chromium.googlesource.com/chromium/tools/build.git",
"swarming_tag:scheduler_invocation_id:9113048673297263152",
"swarming_tag:scheduler_job_id:webrtc/Linux64 Release",
"swarming_tag:service_account:none",
"swarming_tag:user:None",
"swarming_tag:user_agent:luci-scheduler",
"swarming_tag:vpython:native-python-wrapper",
"swarming_task_id:3d3ac47a2eee2610",
"user_agent:luci-scheduler"
],
"updated_ts": "1525282960367350",
"url": "https://ci.chromium.org/p/webrtc/builders/luci.webrtc.ci/Linux64 Release/11",
"utcnow_ts": "1525282960516960"
}
}
[17:42:40.529] Task URL: https://ci.chromium.org/p/webrtc/builders/luci.webrtc.ci/Linux64 Release/11
[17:42:40.529] Scheduling timer "check-buildbucket-build-status" (webrtc/Linux64 Release:9113048673297263152:2:0) after 1m0s
[17:42:48.502] Received PubSub notification, asking Buildbucket for the build status
[17:42:48.625] Build 8947618611244549296: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:43:40.546] Handling timer "check-buildbucket-build-status" (webrtc/Linux64 Release:9113048673297263152:2:0)
[17:43:40.546] Timer tick, asking Buildbucket for the build status
[17:43:40.610] Build 8947618611244549296: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:43:40.610] Scheduling timer "check-buildbucket-build-status" (webrtc/Linux64 Release:9113048673297263152:4:0) after 1m0s
[17:44:40.634] Handling timer "check-buildbucket-build-status" (webrtc/Linux64 Release:9113048673297263152:4:0)
[17:44:40.634] Timer tick, asking Buildbucket for the build status
[17:44:40.711] Build 8947618611244549296: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:44:40.711] Scheduling timer "check-buildbucket-build-status" (webrtc/Linux64 Release:9113048673297263152:5:0) after 1m0s
[17:45:40.742] Handling timer "check-buildbucket-build-status" (webrtc/Linux64 Release:9113048673297263152:5:0)
[17:45:40.742] Timer tick, asking Buildbucket for the build status
[17:45:41.012] Build 8947618611244549296: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:45:41.012] Scheduling timer "check-buildbucket-build-status" (webrtc/Linux64 Release:9113048673297263152:6:0) after 1m0s
[17:46:41.128] Handling timer "check-buildbucket-build-status" (webrtc/Linux64 Release:9113048673297263152:6:0)
[17:46:41.128] Timer tick, asking Buildbucket for the build status
[17:46:41.353] Build 8947618611244549296: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:46:41.353] Scheduling timer "check-buildbucket-build-status" (webrtc/Linux64 Release:9113048673297263152:7:0) after 1m0s
[17:47:41.407] Handling timer "check-buildbucket-build-status" (webrtc/Linux64 Release:9113048673297263152:7:0)
[17:47:41.407] Timer tick, asking Buildbucket for the build status
[17:47:42.045] Build 8947618611244549296: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:47:42.045] Scheduling timer "check-buildbucket-build-status" (webrtc/Linux64 Release:9113048673297263152:8:0) after 1m0s
[17:48:42.066] Handling timer "check-buildbucket-build-status" (webrtc/Linux64 Release:9113048673297263152:8:0)
[17:48:42.066] Timer tick, asking Buildbucket for the build status
[17:48:42.152] Build 8947618611244549296: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:48:42.152] Scheduling timer "check-buildbucket-build-status" (webrtc/Linux64 Release:9113048673297263152:9:0) after 1m0s
[17:49:42.187] Handling timer "check-buildbucket-build-status" (webrtc/Linux64 Release:9113048673297263152:9:0)
[17:49:42.187] Timer tick, asking Buildbucket for the build status
[17:49:42.250] Build 8947618611244549296: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:49:42.250] Scheduling timer "check-buildbucket-build-status" (webrtc/Linux64 Release:9113048673297263152:10:0) after 1m0s
[17:50:42.291] Handling timer "check-buildbucket-build-status" (webrtc/Linux64 Release:9113048673297263152:10:0)
[17:50:42.291] Timer tick, asking Buildbucket for the build status
[17:50:42.356] Build 8947618611244549296: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:50:42.356] Scheduling timer "check-buildbucket-build-status" (webrtc/Linux64 Release:9113048673297263152:11:0) after 1m0s
[17:51:42.374] Handling timer "check-buildbucket-build-status" (webrtc/Linux64 Release:9113048673297263152:11:0)
[17:51:42.374] Timer tick, asking Buildbucket for the build status
[17:51:42.526] Build 8947618611244549296: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:51:42.526] Scheduling timer "check-buildbucket-build-status" (webrtc/Linux64 Release:9113048673297263152:12:0) after 1m0s
[17:52:42.682] Handling timer "check-buildbucket-build-status" (webrtc/Linux64 Release:9113048673297263152:12:0)
[17:52:42.682] Timer tick, asking Buildbucket for the build status
[17:52:42.754] Build 8947618611244549296: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:52:42.754] Scheduling timer "check-buildbucket-build-status" (webrtc/Linux64 Release:9113048673297263152:13:0) after 1m0s
[17:53:42.947] Handling timer "check-buildbucket-build-status" (webrtc/Linux64 Release:9113048673297263152:13:0)
[17:53:42.947] Timer tick, asking Buildbucket for the build status
[17:53:42.995] Build 8947618611244549296: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:53:42.995] Scheduling timer "check-buildbucket-build-status" (webrtc/Linux64 Release:9113048673297263152:14:0) after 1m0s
[17:54:43.103] Handling timer "check-buildbucket-build-status" (webrtc/Linux64 Release:9113048673297263152:14:0)
[17:54:43.103] Timer tick, asking Buildbucket for the build status
[17:54:43.169] Build 8947618611244549296: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:54:43.169] Scheduling timer "check-buildbucket-build-status" (webrtc/Linux64 Release:9113048673297263152:15:0) after 1m0s
[17:55:43.351] Handling timer "check-buildbucket-build-status" (webrtc/Linux64 Release:9113048673297263152:15:0)
[17:55:43.351] Timer tick, asking Buildbucket for the build status
[17:55:43.496] Build 8947618611244549296: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:55:43.496] Scheduling timer "check-buildbucket-build-status" (webrtc/Linux64 Release:9113048673297263152:16:0) after 1m0s
[17:56:43.606] Handling timer "check-buildbucket-build-status" (webrtc/Linux64 Release:9113048673297263152:16:0)
[17:56:43.606] Timer tick, asking Buildbucket for the build status
[17:56:43.764] Build 8947618611244549296: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:56:43.764] Scheduling timer "check-buildbucket-build-status" (webrtc/Linux64 Release:9113048673297263152:17:0) after 1m0s
[17:57:43.841] Handling timer "check-buildbucket-build-status" (webrtc/Linux64 Release:9113048673297263152:17:0)
[17:57:43.841] Timer tick, asking Buildbucket for the build status
[17:57:43.911] Build 8947618611244549296: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:57:43.911] Scheduling timer "check-buildbucket-build-status" (webrtc/Linux64 Release:9113048673297263152:18:0) after 1m0s
[17:58:43.931] Handling timer "check-buildbucket-build-status" (webrtc/Linux64 Release:9113048673297263152:18:0)
[17:58:43.931] Timer tick, asking Buildbucket for the build status
[17:58:44.180] Build 8947618611244549296: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:58:44.180] Scheduling timer "check-buildbucket-build-status" (webrtc/Linux64 Release:9113048673297263152:19:0) after 1m0s
[17:59:44.246] Handling timer "check-buildbucket-build-status" (webrtc/Linux64 Release:9113048673297263152:19:0)
[17:59:44.246] Timer tick, asking Buildbucket for the build status
[17:59:44.335] Build 8947618611244549296: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:59:44.335] Scheduling timer "check-buildbucket-build-status" (webrtc/Linux64 Release:9113048673297263152:20:0) after 1m0s
[18:00:44.434] Handling timer "check-buildbucket-build-status" (webrtc/Linux64 Release:9113048673297263152:20:0)
[18:00:44.434] Timer tick, asking Buildbucket for the build status
[18:00:44.504] Build 8947618611244549296: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:00:44.504] Scheduling timer "check-buildbucket-build-status" (webrtc/Linux64 Release:9113048673297263152:21:0) after 1m0s
[18:01:44.611] Handling timer "check-buildbucket-build-status" (webrtc/Linux64 Release:9113048673297263152:21:0)
[18:01:44.612] Timer tick, asking Buildbucket for the build status
[18:01:44.909] Build 8947618611244549296: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:01:44.909] Scheduling timer "check-buildbucket-build-status" (webrtc/Linux64 Release:9113048673297263152:22:0) after 1m0s
[18:02:44.928] Handling timer "check-buildbucket-build-status" (webrtc/Linux64 Release:9113048673297263152:22:0)
[18:02:44.928] Timer tick, asking Buildbucket for the build status
[18:02:45.083] Build 8947618611244549296: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:02:45.083] Scheduling timer "check-buildbucket-build-status" (webrtc/Linux64 Release:9113048673297263152:23:0) after 1m0s
[18:03:45.113] Handling timer "check-buildbucket-build-status" (webrtc/Linux64 Release:9113048673297263152:23:0)
[18:03:45.113] Timer tick, asking Buildbucket for the build status
[18:03:45.280] Build 8947618611244549296: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:03:45.280] Scheduling timer "check-buildbucket-build-status" (webrtc/Linux64 Release:9113048673297263152:24:0) after 1m0s
[18:04:45.340] Handling timer "check-buildbucket-build-status" (webrtc/Linux64 Release:9113048673297263152:24:0)
[18:04:45.340] Timer tick, asking Buildbucket for the build status
[18:04:45.441] Build 8947618611244549296: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:04:45.441] Scheduling timer "check-buildbucket-build-status" (webrtc/Linux64 Release:9113048673297263152:25:0) after 1m0s
[18:05:45.589] Handling timer "check-buildbucket-build-status" (webrtc/Linux64 Release:9113048673297263152:25:0)
[18:05:45.589] Timer tick, asking Buildbucket for the build status
[18:05:45.894] Build 8947618611244549296: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:05:45.894] Scheduling timer "check-buildbucket-build-status" (webrtc/Linux64 Release:9113048673297263152:26:0) after 1m0s
[18:06:45.913] Handling timer "check-buildbucket-build-status" (webrtc/Linux64 Release:9113048673297263152:26:0)
[18:06:45.913] Timer tick, asking Buildbucket for the build status
[18:06:46.036] Build 8947618611244549296: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:06:46.037] Scheduling timer "check-buildbucket-build-status" (webrtc/Linux64 Release:9113048673297263152:27:0) after 1m0s
[18:07:46.055] Handling timer "check-buildbucket-build-status" (webrtc/Linux64 Release:9113048673297263152:27:0)
[18:07:46.055] Timer tick, asking Buildbucket for the build status
[18:07:46.267] Build 8947618611244549296: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:07:46.267] Scheduling timer "check-buildbucket-build-status" (webrtc/Linux64 Release:9113048673297263152:28:0) after 1m0s
[18:08:46.304] Handling timer "check-buildbucket-build-status" (webrtc/Linux64 Release:9113048673297263152:28:0)
[18:08:46.304] Timer tick, asking Buildbucket for the build status
[18:08:46.375] Build 8947618611244549296: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:08:46.375] Scheduling timer "check-buildbucket-build-status" (webrtc/Linux64 Release:9113048673297263152:29:0) after 1m0s
[18:09:46.393] Handling timer "check-buildbucket-build-status" (webrtc/Linux64 Release:9113048673297263152:29:0)
[18:09:46.393] Timer tick, asking Buildbucket for the build status
[18:09:46.534] Build 8947618611244549296: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:09:46.534] Scheduling timer "check-buildbucket-build-status" (webrtc/Linux64 Release:9113048673297263152:30:0) after 1m0s
[18:10:46.585] Handling timer "check-buildbucket-build-status" (webrtc/Linux64 Release:9113048673297263152:30:0)
[18:10:46.585] Timer tick, asking Buildbucket for the build status
[18:10:46.658] Build 8947618611244549296: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:10:46.659] Scheduling timer "check-buildbucket-build-status" (webrtc/Linux64 Release:9113048673297263152:31:0) after 1m0s
[18:11:46.680] Handling timer "check-buildbucket-build-status" (webrtc/Linux64 Release:9113048673297263152:31:0)
[18:11:46.680] Timer tick, asking Buildbucket for the build status
[18:11:46.769] Build 8947618611244549296: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:11:46.769] Scheduling timer "check-buildbucket-build-status" (webrtc/Linux64 Release:9113048673297263152:32:0) after 1m0s
[18:12:46.790] Handling timer "check-buildbucket-build-status" (webrtc/Linux64 Release:9113048673297263152:32:0)
[18:12:46.790] Timer tick, asking Buildbucket for the build status
[18:12:46.866] Build 8947618611244549296: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:12:46.866] Scheduling timer "check-buildbucket-build-status" (webrtc/Linux64 Release:9113048673297263152:33:0) after 1m0s
[18:13:46.896] Handling timer "check-buildbucket-build-status" (webrtc/Linux64 Release:9113048673297263152:33:0)
[18:13:46.896] Timer tick, asking Buildbucket for the build status
[18:13:47.003] Build 8947618611244549296: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:13:47.003] Scheduling timer "check-buildbucket-build-status" (webrtc/Linux64 Release:9113048673297263152:34:0) after 1m0s
[18:14:47.031] Handling timer "check-buildbucket-build-status" (webrtc/Linux64 Release:9113048673297263152:34:0)
[18:14:47.031] Timer tick, asking Buildbucket for the build status
[18:14:47.119] Build 8947618611244549296: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:14:47.119] Scheduling timer "check-buildbucket-build-status" (webrtc/Linux64 Release:9113048673297263152:35:0) after 1m0s
[18:15:47.139] Handling timer "check-buildbucket-build-status" (webrtc/Linux64 Release:9113048673297263152:35:0)
[18:15:47.139] Timer tick, asking Buildbucket for the build status
[18:15:47.219] Build 8947618611244549296: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:15:47.219] Scheduling timer "check-buildbucket-build-status" (webrtc/Linux64 Release:9113048673297263152:36:0) after 1m0s
[18:16:47.240] Handling timer "check-buildbucket-build-status" (webrtc/Linux64 Release:9113048673297263152:36:0)
[18:16:47.240] Timer tick, asking Buildbucket for the build status
[18:16:47.314] Build 8947618611244549296: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:16:47.314] Scheduling timer "check-buildbucket-build-status" (webrtc/Linux64 Release:9113048673297263152:37:0) after 1m0s
[18:17:47.346] Handling timer "check-buildbucket-build-status" (webrtc/Linux64 Release:9113048673297263152:37:0)
[18:17:47.346] Timer tick, asking Buildbucket for the build status
[18:17:47.712] Build 8947618611244549296: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:17:47.712] Scheduling timer "check-buildbucket-build-status" (webrtc/Linux64 Release:9113048673297263152:38:0) after 1m0s
[18:18:47.739] Handling timer "check-buildbucket-build-status" (webrtc/Linux64 Release:9113048673297263152:38:0)
[18:18:47.739] Timer tick, asking Buildbucket for the build status
[18:18:47.829] Build 8947618611244549296: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:18:47.829] Scheduling timer "check-buildbucket-build-status" (webrtc/Linux64 Release:9113048673297263152:39:0) after 1m0s
[18:19:47.852] Handling timer "check-buildbucket-build-status" (webrtc/Linux64 Release:9113048673297263152:39:0)
[18:19:47.852] Timer tick, asking Buildbucket for the build status
[18:19:49.649] Build 8947618611244549296: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:19:49.649] Scheduling timer "check-buildbucket-build-status" (webrtc/Linux64 Release:9113048673297263152:40:0) after 1m0s
[18:20:49.732] Handling timer "check-buildbucket-build-status" (webrtc/Linux64 Release:9113048673297263152:40:0)
[18:20:49.732] Timer tick, asking Buildbucket for the build status
[18:20:49.783] Build 8947618611244549296: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:20:49.783] Scheduling timer "check-buildbucket-build-status" (webrtc/Linux64 Release:9113048673297263152:41:0) after 1m0s
[18:21:49.930] Handling timer "check-buildbucket-build-status" (webrtc/Linux64 Release:9113048673297263152:41:0)
[18:21:49.930] Timer tick, asking Buildbucket for the build status
[18:21:50.077] Build 8947618611244549296: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:21:50.077] Scheduling timer "check-buildbucket-build-status" (webrtc/Linux64 Release:9113048673297263152:42:0) after 1m0s
[18:22:50.220] Handling timer "check-buildbucket-build-status" (webrtc/Linux64 Release:9113048673297263152:42:0)
[18:22:50.220] Timer tick, asking Buildbucket for the build status
[18:22:50.450] Build 8947618611244549296: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:22:50.450] Scheduling timer "check-buildbucket-build-status" (webrtc/Linux64 Release:9113048673297263152:43:0) after 1m0s
[18:23:50.496] Handling timer "check-buildbucket-build-status" (webrtc/Linux64 Release:9113048673297263152:43:0)
[18:23:50.496] Timer tick, asking Buildbucket for the build status
[18:23:50.642] Build 8947618611244549296: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:23:50.642] Scheduling timer "check-buildbucket-build-status" (webrtc/Linux64 Release:9113048673297263152:44:0) after 1m0s
[18:24:50.668] Handling timer "check-buildbucket-build-status" (webrtc/Linux64 Release:9113048673297263152:44:0)
[18:24:50.668] Timer tick, asking Buildbucket for the build status
[18:24:50.723] Build 8947618611244549296: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:24:50.723] Scheduling timer "check-buildbucket-build-status" (webrtc/Linux64 Release:9113048673297263152:45:0) after 1m0s
[18:25:50.750] Handling timer "check-buildbucket-build-status" (webrtc/Linux64 Release:9113048673297263152:45:0)
[18:25:50.750] Timer tick, asking Buildbucket for the build status
[18:25:53.189] Build 8947618611244549296: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:25:53.189] Scheduling timer "check-buildbucket-build-status" (webrtc/Linux64 Release:9113048673297263152:46:0) after 1m0s
[18:26:53.227] Handling timer "check-buildbucket-build-status" (webrtc/Linux64 Release:9113048673297263152:46:0)
[18:26:53.227] Timer tick, asking Buildbucket for the build status
[18:26:53.366] Build 8947618611244549296: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:26:53.366] Scheduling timer "check-buildbucket-build-status" (webrtc/Linux64 Release:9113048673297263152:47:0) after 1m0s
[18:27:53.386] Handling timer "check-buildbucket-build-status" (webrtc/Linux64 Release:9113048673297263152:47:0)
[18:27:53.386] Timer tick, asking Buildbucket for the build status
[18:27:53.458] Build 8947618611244549296: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:27:53.458] Scheduling timer "check-buildbucket-build-status" (webrtc/Linux64 Release:9113048673297263152:48:0) after 1m0s
[18:28:53.486] Handling timer "check-buildbucket-build-status" (webrtc/Linux64 Release:9113048673297263152:48:0)
[18:28:53.486] Timer tick, asking Buildbucket for the build status
[18:28:53.740] Build 8947618611244549296: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:28:53.740] Scheduling timer "check-buildbucket-build-status" (webrtc/Linux64 Release:9113048673297263152:49:0) after 1m0s
[18:29:53.772] Handling timer "check-buildbucket-build-status" (webrtc/Linux64 Release:9113048673297263152:49:0)
[18:29:53.772] Timer tick, asking Buildbucket for the build status
[18:29:53.991] Build 8947618611244549296: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:29:53.991] Scheduling timer "check-buildbucket-build-status" (webrtc/Linux64 Release:9113048673297263152:50:0) after 1m0s
[18:30:54.012] Handling timer "check-buildbucket-build-status" (webrtc/Linux64 Release:9113048673297263152:50:0)
[18:30:54.012] Timer tick, asking Buildbucket for the build status
[18:30:54.159] Build 8947618611244549296: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:30:54.159] Scheduling timer "check-buildbucket-build-status" (webrtc/Linux64 Release:9113048673297263152:51:0) after 1m0s
[18:31:54.177] Handling timer "check-buildbucket-build-status" (webrtc/Linux64 Release:9113048673297263152:51:0)
[18:31:54.177] Timer tick, asking Buildbucket for the build status
[18:31:54.233] Build 8947618611244549296: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:31:54.233] Scheduling timer "check-buildbucket-build-status" (webrtc/Linux64 Release:9113048673297263152:52:0) after 1m0s
[18:32:54.336] Handling timer "check-buildbucket-build-status" (webrtc/Linux64 Release:9113048673297263152:52:0)
[18:32:54.336] Timer tick, asking Buildbucket for the build status
[18:32:54.553] Build 8947618611244549296: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:32:54.553] Scheduling timer "check-buildbucket-build-status" (webrtc/Linux64 Release:9113048673297263152:53:0) after 1m0s
[18:33:54.571] Handling timer "check-buildbucket-build-status" (webrtc/Linux64 Release:9113048673297263152:53:0)
[18:33:54.571] Timer tick, asking Buildbucket for the build status
[18:33:54.776] Build 8947618611244549296: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:33:54.776] Scheduling timer "check-buildbucket-build-status" (webrtc/Linux64 Release:9113048673297263152:54:0) after 1m0s
[18:34:54.795] Handling timer "check-buildbucket-build-status" (webrtc/Linux64 Release:9113048673297263152:54:0)
[18:34:54.795] Timer tick, asking Buildbucket for the build status
[18:34:55.237] Build 8947618611244549296: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:34:55.237] Scheduling timer "check-buildbucket-build-status" (webrtc/Linux64 Release:9113048673297263152:55:0) after 1m0s
[18:35:55.255] Handling timer "check-buildbucket-build-status" (webrtc/Linux64 Release:9113048673297263152:55:0)
[18:35:55.255] Timer tick, asking Buildbucket for the build status
[18:35:55.309] Build 8947618611244549296: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:35:55.309] Scheduling timer "check-buildbucket-build-status" (webrtc/Linux64 Release:9113048673297263152:56:0) after 1m0s
[18:36:55.328] Handling timer "check-buildbucket-build-status" (webrtc/Linux64 Release:9113048673297263152:56:0)
[18:36:55.328] Timer tick, asking Buildbucket for the build status
[18:36:55.417] Build 8947618611244549296: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:36:55.417] Scheduling timer "check-buildbucket-build-status" (webrtc/Linux64 Release:9113048673297263152:57:0) after 1m0s
[18:37:55.479] Handling timer "check-buildbucket-build-status" (webrtc/Linux64 Release:9113048673297263152:57:0)
[18:37:55.479] Timer tick, asking Buildbucket for the build status
[18:37:55.641] Build 8947618611244549296: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:37:55.641] Scheduling timer "check-buildbucket-build-status" (webrtc/Linux64 Release:9113048673297263152:58:0) after 1m0s
[18:38:55.663] Handling timer "check-buildbucket-build-status" (webrtc/Linux64 Release:9113048673297263152:58:0)
[18:38:55.663] Timer tick, asking Buildbucket for the build status
[18:38:55.705] Build 8947618611244549296: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:38:55.705] Scheduling timer "check-buildbucket-build-status" (webrtc/Linux64 Release:9113048673297263152:59:0) after 1m0s
[18:39:55.728] Handling timer "check-buildbucket-build-status" (webrtc/Linux64 Release:9113048673297263152:59:0)
[18:39:55.728] Timer tick, asking Buildbucket for the build status
[18:39:55.805] Build 8947618611244549296: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:39:55.805] Scheduling timer "check-buildbucket-build-status" (webrtc/Linux64 Release:9113048673297263152:60:0) after 1m0s
[18:40:55.829] Handling timer "check-buildbucket-build-status" (webrtc/Linux64 Release:9113048673297263152:60:0)
[18:40:55.830] Timer tick, asking Buildbucket for the build status
[18:40:55.915] Build 8947618611244549296: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:40:55.915] Scheduling timer "check-buildbucket-build-status" (webrtc/Linux64 Release:9113048673297263152:61:0) after 1m0s
[18:41:55.937] Handling timer "check-buildbucket-build-status" (webrtc/Linux64 Release:9113048673297263152:61:0)
[18:41:55.937] Timer tick, asking Buildbucket for the build status
[18:41:55.980] Build 8947618611244549296: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:41:55.980] Scheduling timer "check-buildbucket-build-status" (webrtc/Linux64 Release:9113048673297263152:62:0) after 1m0s
[18:42:54.178] Received PubSub notification, asking Buildbucket for the build status
[18:42:54.232] Build 8947618611244549296: status "COMPLETED", result "FAILURE", failure_reason "INFRA_FAILURE", cancelation_reason ""
[18:42:54.232] Buildbucket build:
{
"build": {
"bucket": "luci.webrtc.ci",
"canary_preference": "AUTO",
"completed_ts": "1525286573016230",
"created_by": "user:luci-scheduler@appspot.gserviceaccount.com",
"created_ts": "1525282959665440",
"experimental": true,
"failure_reason": "INFRA_FAILURE",
"id": "8947618611244549296",
"parameters_json": "{\"builder_name\": \"Linux64 Release\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://webrtc.googlesource.com/src/\", \"revision\": \"26e084906140af8dd7b75d381a6476161bba5bb2\"}}",
"project": "webrtc",
"result": "FAILURE",
"result_details_json": "{\"swarming\": {\"task_result\": {\"cipd_pins\": {\"packages\": [{\"path\": \".\", \"version\": \"e4b90cad477c47ea00ff4dbd6183667bb0f1a82c\", \"package_name\": \"infra/tools/luci/kitchen/linux-amd64\"}, {\"path\": \"cipd_bin_packages\", \"version\": \"fe5dbec4f5e027fe8c5b35fbac9f8ad9f64c47c1\", \"package_name\": \"infra/git/linux-amd64\"}, {\"path\": \"cipd_bin_packages\", \"version\": \"46c0c897ca0f053799ee41fd148bb7a47232df47\", \"package_name\": \"infra/python/cpython/linux-amd64\"}, {\"path\": \"cipd_bin_packages\", \"version\": \"6e5ff69bbe48c38117c44fd735cb7adb32417549\", \"package_name\": \"infra/tools/buildbucket/linux-amd64\"}, {\"path\": \"cipd_bin_packages\", \"version\": \"4672ed11a416bb60e9ec6738dab9cc41386971f5\", \"package_name\": \"infra/tools/cloudtail/linux-amd64\"}, {\"path\": \"cipd_bin_packages\", \"version\": \"139d6a6663b2cdd9420516c9335d0731dd2c5c58\", \"package_name\": \"infra/tools/git/linux-amd64\"}, {\"path\": \"cipd_bin_packages\", \"version\": \"df53a719b65668e3b16ecdb600f29f8c901cd67e\", \"package_name\": \"infra/tools/luci-auth/linux-amd64\"}, {\"path\": \"cipd_bin_packages\", \"version\": \"72f5c9ec60e557643b06eac503836fb78359ca06\", \"package_name\": \"infra/tools/luci/git-credential-luci/linux-amd64\"}, {\"path\": \"cipd_bin_packages\", \"version\": \"defef80b8231a429bb8b4931798307272a536717\", \"package_name\": \"infra/tools/luci/vpython-native/linux-amd64\"}, {\"path\": \"cipd_bin_packages\", \"version\": \"8bf6a502584cb13fdb2bb5dcbc7bbb59a6d983a5\", \"package_name\": \"infra/tools/luci/vpython/linux-amd64\"}, {\"path\": \"cipd_bin_packages\", \"version\": \"7ac9ea00b7d1d664e9015d2bbd537bc8cb3bfda4\", \"package_name\": \"infra/tools/prpc/linux-amd64\"}], \"client_package\": {\"version\": \"e891a48eebcd04fee5b054173539b558cbcc027c\", \"package_name\": \"infra/tools/cipd/linux-amd64\"}}, \"run_id\": \"3d3ac47a2eee2611\", \"outputs_ref\": {\"isolatedserver\": \"https://isolateserver.appspot.com\", \"namespace\": \"default-gzip\", \"isolated\": \"a64c5389acf1ee296968c34318e5ca10c976761b\"}, \"server_versions\": [\"3484-a41f00b\"], \"duration\": 3600.0225009918213, \"completed_ts\": \"2018-05-02T18:42:53.016230\", \"started_ts\": \"2018-05-02T17:42:47.294300\", \"internal_failure\": false, \"exit_code\": \"-15\", \"state\": \"TIMED_OUT\", \"bot_version\": \"cec545eacfdaae85f5c1afce2740b095a0b9348ba17280498d1e1867db6bf08a\", \"tags\": [\"build_address:luci.webrtc.ci/Linux64 Release/11\", \"buildbucket_bucket:luci.webrtc.ci\", \"buildbucket_build_id:8947618611244549296\", \"buildbucket_hostname:cr-buildbucket.appspot.com\", \"buildbucket_template_canary:0\", \"buildbucket_template_revision:48a002e4c84497febc829e8ccfd23eb8084470dc\", \"builder:Linux64 Release\", \"buildset:commit/gitiles/webrtc.googlesource.com/src/+/26e084906140af8dd7b75d381a6476161bba5bb2\", \"cpu:x86-64\", \"gitiles_ref:refs/heads/master\", \"log_location:logdog://logs.chromium.org/webrtc/buildbucket/cr-buildbucket.appspot.com/8947618611244549296/+/annotations\", \"luci_project:webrtc\", \"os:Linux\", \"pool:luci.webrtc.ci\", \"priority:60\", \"recipe_name:webrtc/standalone\", \"recipe_repository:https://chromium.googlesource.com/chromium/tools/build.git\", \"scheduler_invocation_id:9113048673297263152\", \"scheduler_job_id:webrtc/Linux64 Release\", \"service_account:none\", \"user:None\", \"user_agent:luci-scheduler\", \"vpython:native-python-wrapper\"], \"failure\": true, \"modified_ts\": \"2018-05-02T18:42:53.016230\", \"user\": \"\", \"children_task_ids\": [\"3d3ac63dd4273b10\", \"3d3ac643bf3f2d10\", \"3d3ac64ae7b3e610\", \"3d3ac64efc077310\", \"3d3ac652a6cced10\", \"3d3ac65477f82c10\", \"3d3ac6583d105410\", \"3d3ac65ad7d88710\", \"3d3ac6603ccba010\", \"3d3ac6633a419910\", \"3d3ac665f0bec010\", \"3d3ac666f5db2110\", \"3d3ac66a5bbf8f10\", \"3d3ac66de19a4a10\", \"3d3ac66f63b51810\", \"3d3ac6722e0df610\", \"3d3ac6731cfb1b10\", \"3d3ac677394ddf10\", \"3d3ac67b5726e010\", \"3d3ac67f321b9110\", \"3d3ac682bc4b6610\", \"3d3ac6839e82d610\", \"3d3ac6852dfe0d10\", \"3d3ac686de8b4710\", \"3d3ac68967e9fc10\", \"3d3ac68e0c056510\", \"3d3ac6941a0bc810\", \"3d3ac6981c2fb410\", \"3d3ac69d93bcc810\", \"3d3ac6a0eacf0b10\", \"3d3ac6a200534910\", \"3d3ac6a36ba5d710\", \"3d3ac6a4d7176e10\", \"3d3ac6a8f4acd510\"], \"created_ts\": \"2018-05-02T17:42:39.889260\", \"name\": \"bb-8947618611244549296-webrtc-Linux64 Release\", \"task_id\": \"3d3ac47a2eee2610\", \"bot_dimensions\": [{\"value\": [\"git\", \"goma\", \"vpython\", \"webrtc_linux\"], \"key\": \"caches\"}, {\"value\": [\"8\"], \"key\": \"cores\"}, {\"value\": [\"x86\", \"x86-64\", \"x86-64-Haswell_GCE\", \"x86-64-avx2\"], \"key\": \"cpu\"}, {\"value\": [\"none\"], \"key\": \"gpu\"}, {\"value\": [\"trusty-webrtc-fe7e3dcb-us-central1-b-hnh8\"], \"key\": \"id\"}, {\"value\": [\"chrome-trusty-18042300-b7223b463e3\"], \"key\": \"image\"}, {\"value\": [\"0\"], \"key\": \"inside_docker\"}, {\"value\": [\"1\"], \"key\": \"kvm\"}, {\"value\": [\"n1-standard-8\"], \"key\": \"machine_type\"}, {\"value\": [\"Linux\", \"Ubuntu\", \"Ubuntu-14.04\"], \"key\": \"os\"}, {\"value\": [\"luci.webrtc.ci\"], \"key\": \"pool\"}, {\"value\": [\"2.7.6\"], \"key\": \"python\"}, {\"value\": [\"3484-a41f00b\"], \"key\": \"server_version\"}, {\"value\": [\"us\", \"us-central\", \"us-central1\", \"us-central1-b\"], \"key\": \"zone\"}], \"try_number\": \"1\", \"current_task_slice\": \"0\", \"costs_usd\": [0.41685961068157179], \"bot_id\": \"trusty-webrtc-fe7e3dcb-us-central1-b-hnh8\"}}, \"build_run_result\": {\"infraFailure\": {\"text\": \"kitchen crashed or got killed\", \"bootstrapperCallStack\": [], \"type\": \"BOOTSTRAPPER_ERROR\"}, \"recipeResult\": null, \"recipeExitCode\": null, \"recipe\": null, \"annotationUrl\": \"\"}, \"ui\": {\"info\": \"\"}, \"properties\": {}}",
"service_account": "none",
"started_ts": "1525282967294300",
"status": "COMPLETED",
"status_changed_ts": "1525286573708790",
"tags": [
"build_address:luci.webrtc.ci/Linux64 Release/11",
"builder:Linux64 Release",
"buildset:commit/gitiles/webrtc.googlesource.com/src/+/26e084906140af8dd7b75d381a6476161bba5bb2",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9113048673297263152",
"scheduler_job_id:webrtc/Linux64 Release",
"swarming_dimension:cpu:x86-64",
"swarming_dimension:os:Linux",
"swarming_dimension:pool:luci.webrtc.ci",
"swarming_hostname:chromium-swarm.appspot.com",
"swarming_tag:build_address:luci.webrtc.ci/Linux64 Release/11",
"swarming_tag:buildbucket_bucket:luci.webrtc.ci",
"swarming_tag:buildbucket_build_id:8947618611244549296",
"swarming_tag:buildbucket_hostname:cr-buildbucket.appspot.com",
"swarming_tag:buildbucket_template_canary:0",
"swarming_tag:buildbucket_template_revision:48a002e4c84497febc829e8ccfd23eb8084470dc",
"swarming_tag:builder:Linux64 Release",
"swarming_tag:buildset:commit/gitiles/webrtc.googlesource.com/src/+/26e084906140af8dd7b75d381a6476161bba5bb2",
"swarming_tag:cpu:x86-64",
"swarming_tag:gitiles_ref:refs/heads/master",
"swarming_tag:log_location:logdog://logs.chromium.org/webrtc/buildbucket/cr-buildbucket.appspot.com/8947618611244549296/+/annotations",
"swarming_tag:luci_project:webrtc",
"swarming_tag:os:Linux",
"swarming_tag:pool:luci.webrtc.ci",
"swarming_tag:priority:60",
"swarming_tag:recipe_name:webrtc/standalone",
"swarming_tag:recipe_repository:https://chromium.googlesource.com/chromium/tools/build.git",
"swarming_tag:scheduler_invocation_id:9113048673297263152",
"swarming_tag:scheduler_job_id:webrtc/Linux64 Release",
"swarming_tag:service_account:none",
"swarming_tag:user:None",
"swarming_tag:user_agent:luci-scheduler",
"swarming_tag:vpython:native-python-wrapper",
"swarming_task_id:3d3ac47a2eee2610",
"user_agent:luci-scheduler"
],
"updated_ts": "1525286573709940",
"url": "https://ci.chromium.org/p/webrtc/builders/luci.webrtc.ci/Linux64 Release/11",
"utcnow_ts": "1525286574215720"
}
}
[18:42:54.232] Invocation finished in 1h0m15.907666351s with status FAILED