[17:52:42.202] New invocation is queued and will start shortly
[17:52:43.407] Starting the invocation (attempt 1)
[17:52:43.442] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[17:52:43.443] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[17:52:43.443] Buildbucket request:
{
"bucket": "luci.webrtc.ci",
"client_operation_id": "9112595055269103632",
"parameters_json": "{\"builder_name\":\"Linux64 Release\",\"properties\":{\"branch\":\"refs/heads/master\",\"repository\":\"https://webrtc.googlesource.com/src/\",\"revision\":\"1f184f0a15400765a1e6ba5982ac092b1af14b1d\"}}",
"pubsub_callback": {
"auth_token": "...",
"topic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
},
"tags": [
"builder:Linux64 Release",
"scheduler_invocation_id:9112595055269103632",
"scheduler_job_id:webrtc/Linux64 Release",
"user_agent:luci-scheduler",
"buildset:commit/gitiles/webrtc.googlesource.com/src/+/1f184f0a15400765a1e6ba5982ac092b1af14b1d",
"gitiles_ref:refs/heads/master"
]
}
[17:52:44.792] Buildbucket response:
{
"build": {
"bucket": "luci.webrtc.ci",
"canary_preference": "AUTO",
"created_by": "user:luci-scheduler@appspot.gserviceaccount.com",
"created_ts": "1525715563585690",
"experimental": true,
"id": "8947164993156900000",
"lease_expiration_ts": "1525744364241210",
"lease_key": "1286687812",
"parameters_json": "{\"builder_name\": \"Linux64 Release\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://webrtc.googlesource.com/src/\", \"revision\": \"1f184f0a15400765a1e6ba5982ac092b1af14b1d\"}}",
"project": "webrtc",
"result_details_json": "null",
"service_account": "none",
"status": "SCHEDULED",
"status_changed_ts": "1525715564597030",
"tags": [
"build_address:luci.webrtc.ci/Linux64 Release/79",
"builder:Linux64 Release",
"buildset:commit/gitiles/webrtc.googlesource.com/src/+/1f184f0a15400765a1e6ba5982ac092b1af14b1d",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9112595055269103632",
"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/79",
"swarming_tag:buildbucket_bucket:luci.webrtc.ci",
"swarming_tag:buildbucket_build_id:8947164993156900000",
"swarming_tag:buildbucket_hostname:cr-buildbucket.appspot.com",
"swarming_tag:buildbucket_template_canary:0",
"swarming_tag:buildbucket_template_revision:1b75eae6aaea26fcf63cbf60fec2c1bfeb5965ce",
"swarming_tag:builder:Linux64 Release",
"swarming_tag:buildset:commit/gitiles/webrtc.googlesource.com/src/+/1f184f0a15400765a1e6ba5982ac092b1af14b1d",
"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/8947164993156900000/+/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_package:infra/recipe_bundles/chromium.googlesource.com/chromium/tools/build",
"swarming_tag:scheduler_invocation_id:9112595055269103632",
"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:3d548d7dcb2bb110",
"user_agent:luci-scheduler"
],
"updated_ts": "1525715564597050",
"url": "https://ci.chromium.org/p/webrtc/builders/luci.webrtc.ci/Linux64 Release/79",
"utcnow_ts": "1525715564778130"
}
}
[17:52:44.793] Task URL: https://ci.chromium.org/p/webrtc/builders/luci.webrtc.ci/Linux64 Release/79
[17:52:44.793] Scheduling timer "check-buildbucket-build-status" (webrtc/Linux64 Release:9112595055269103632:2:0) after 1m0s
[17:53:20.069] Received PubSub notification, asking Buildbucket for the build status
[17:53:20.134] Build 8947164993156900000: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:53:44.807] Handling timer "check-buildbucket-build-status" (webrtc/Linux64 Release:9112595055269103632:2:0)
[17:53:44.807] Timer tick, asking Buildbucket for the build status
[17:53:44.939] Build 8947164993156900000: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:53:44.939] Scheduling timer "check-buildbucket-build-status" (webrtc/Linux64 Release:9112595055269103632:4:0) after 1m0s
[17:54:44.954] Handling timer "check-buildbucket-build-status" (webrtc/Linux64 Release:9112595055269103632:4:0)
[17:54:44.954] Timer tick, asking Buildbucket for the build status
[17:54:45.010] Build 8947164993156900000: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:54:45.010] Scheduling timer "check-buildbucket-build-status" (webrtc/Linux64 Release:9112595055269103632:5:0) after 1m0s
[17:55:45.065] Handling timer "check-buildbucket-build-status" (webrtc/Linux64 Release:9112595055269103632:5:0)
[17:55:45.065] Timer tick, asking Buildbucket for the build status
[17:55:45.130] Build 8947164993156900000: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:55:45.130] Scheduling timer "check-buildbucket-build-status" (webrtc/Linux64 Release:9112595055269103632:6:0) after 1m0s
[17:56:45.145] Handling timer "check-buildbucket-build-status" (webrtc/Linux64 Release:9112595055269103632:6:0)
[17:56:45.145] Timer tick, asking Buildbucket for the build status
[17:56:45.204] Build 8947164993156900000: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:56:45.204] Scheduling timer "check-buildbucket-build-status" (webrtc/Linux64 Release:9112595055269103632:7:0) after 1m0s
[17:57:45.226] Handling timer "check-buildbucket-build-status" (webrtc/Linux64 Release:9112595055269103632:7:0)
[17:57:45.226] Timer tick, asking Buildbucket for the build status
[17:57:45.298] Build 8947164993156900000: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:57:45.298] Scheduling timer "check-buildbucket-build-status" (webrtc/Linux64 Release:9112595055269103632:8:0) after 1m0s
[17:58:45.315] Handling timer "check-buildbucket-build-status" (webrtc/Linux64 Release:9112595055269103632:8:0)
[17:58:45.315] Timer tick, asking Buildbucket for the build status
[17:58:45.402] Build 8947164993156900000: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:58:45.402] Scheduling timer "check-buildbucket-build-status" (webrtc/Linux64 Release:9112595055269103632:9:0) after 1m0s
[17:59:45.424] Handling timer "check-buildbucket-build-status" (webrtc/Linux64 Release:9112595055269103632:9:0)
[17:59:45.424] Timer tick, asking Buildbucket for the build status
[17:59:45.494] Build 8947164993156900000: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:59:45.494] Scheduling timer "check-buildbucket-build-status" (webrtc/Linux64 Release:9112595055269103632:10:0) after 1m0s
[18:00:45.508] Handling timer "check-buildbucket-build-status" (webrtc/Linux64 Release:9112595055269103632:10:0)
[18:00:45.508] Timer tick, asking Buildbucket for the build status
[18:00:45.585] Build 8947164993156900000: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:00:45.585] Scheduling timer "check-buildbucket-build-status" (webrtc/Linux64 Release:9112595055269103632:11:0) after 1m0s
[18:01:45.602] Handling timer "check-buildbucket-build-status" (webrtc/Linux64 Release:9112595055269103632:11:0)
[18:01:45.602] Timer tick, asking Buildbucket for the build status
[18:01:45.778] Build 8947164993156900000: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:01:45.778] Scheduling timer "check-buildbucket-build-status" (webrtc/Linux64 Release:9112595055269103632:12:0) after 1m0s
[18:02:45.799] Handling timer "check-buildbucket-build-status" (webrtc/Linux64 Release:9112595055269103632:12:0)
[18:02:45.799] Timer tick, asking Buildbucket for the build status
[18:02:45.851] Build 8947164993156900000: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:02:45.851] Scheduling timer "check-buildbucket-build-status" (webrtc/Linux64 Release:9112595055269103632:13:0) after 1m0s
[18:03:45.869] Handling timer "check-buildbucket-build-status" (webrtc/Linux64 Release:9112595055269103632:13:0)
[18:03:45.869] Timer tick, asking Buildbucket for the build status
[18:03:45.925] Build 8947164993156900000: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:03:45.925] Scheduling timer "check-buildbucket-build-status" (webrtc/Linux64 Release:9112595055269103632:14:0) after 1m0s
[18:04:46.003] Handling timer "check-buildbucket-build-status" (webrtc/Linux64 Release:9112595055269103632:14:0)
[18:04:46.003] Timer tick, asking Buildbucket for the build status
[18:04:46.076] Build 8947164993156900000: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:04:46.076] Scheduling timer "check-buildbucket-build-status" (webrtc/Linux64 Release:9112595055269103632:15:0) after 1m0s
[18:05:46.127] Handling timer "check-buildbucket-build-status" (webrtc/Linux64 Release:9112595055269103632:15:0)
[18:05:46.127] Timer tick, asking Buildbucket for the build status
[18:05:46.299] Build 8947164993156900000: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:05:46.299] Scheduling timer "check-buildbucket-build-status" (webrtc/Linux64 Release:9112595055269103632:16:0) after 1m0s
[18:06:46.403] Handling timer "check-buildbucket-build-status" (webrtc/Linux64 Release:9112595055269103632:16:0)
[18:06:46.403] Timer tick, asking Buildbucket for the build status
[18:06:46.859] Build 8947164993156900000: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:06:46.859] Scheduling timer "check-buildbucket-build-status" (webrtc/Linux64 Release:9112595055269103632:17:0) after 1m0s
[18:07:46.877] Handling timer "check-buildbucket-build-status" (webrtc/Linux64 Release:9112595055269103632:17:0)
[18:07:46.877] Timer tick, asking Buildbucket for the build status
[18:07:46.916] Build 8947164993156900000: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:07:46.916] Scheduling timer "check-buildbucket-build-status" (webrtc/Linux64 Release:9112595055269103632:18:0) after 1m0s
[18:08:46.985] Handling timer "check-buildbucket-build-status" (webrtc/Linux64 Release:9112595055269103632:18:0)
[18:08:46.985] Timer tick, asking Buildbucket for the build status
[18:08:47.041] Build 8947164993156900000: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:08:47.041] Scheduling timer "check-buildbucket-build-status" (webrtc/Linux64 Release:9112595055269103632:19:0) after 1m0s
[18:09:47.062] Handling timer "check-buildbucket-build-status" (webrtc/Linux64 Release:9112595055269103632:19:0)
[18:09:47.062] Timer tick, asking Buildbucket for the build status
[18:09:47.127] Build 8947164993156900000: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:09:47.127] Scheduling timer "check-buildbucket-build-status" (webrtc/Linux64 Release:9112595055269103632:20:0) after 1m0s
[18:10:47.148] Handling timer "check-buildbucket-build-status" (webrtc/Linux64 Release:9112595055269103632:20:0)
[18:10:47.149] Timer tick, asking Buildbucket for the build status
[18:10:47.218] Build 8947164993156900000: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:10:47.218] Scheduling timer "check-buildbucket-build-status" (webrtc/Linux64 Release:9112595055269103632:21:0) after 1m0s
[18:11:47.262] Handling timer "check-buildbucket-build-status" (webrtc/Linux64 Release:9112595055269103632:21:0)
[18:11:47.262] Timer tick, asking Buildbucket for the build status
[18:11:47.405] Build 8947164993156900000: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:11:47.405] Scheduling timer "check-buildbucket-build-status" (webrtc/Linux64 Release:9112595055269103632:22:0) after 1m0s
[18:12:47.466] Handling timer "check-buildbucket-build-status" (webrtc/Linux64 Release:9112595055269103632:22:0)
[18:12:47.466] Timer tick, asking Buildbucket for the build status
[18:12:47.562] Build 8947164993156900000: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:12:47.562] Scheduling timer "check-buildbucket-build-status" (webrtc/Linux64 Release:9112595055269103632:23:0) after 1m0s
[18:13:47.606] Handling timer "check-buildbucket-build-status" (webrtc/Linux64 Release:9112595055269103632:23:0)
[18:13:47.606] Timer tick, asking Buildbucket for the build status
[18:13:47.787] Build 8947164993156900000: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:13:47.787] Scheduling timer "check-buildbucket-build-status" (webrtc/Linux64 Release:9112595055269103632:24:0) after 1m0s
[18:14:47.920] Handling timer "check-buildbucket-build-status" (webrtc/Linux64 Release:9112595055269103632:24:0)
[18:14:47.920] Timer tick, asking Buildbucket for the build status
[18:14:47.967] Build 8947164993156900000: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:14:47.967] Scheduling timer "check-buildbucket-build-status" (webrtc/Linux64 Release:9112595055269103632:25:0) after 1m0s
[18:15:48.004] Handling timer "check-buildbucket-build-status" (webrtc/Linux64 Release:9112595055269103632:25:0)
[18:15:48.004] Timer tick, asking Buildbucket for the build status
[18:15:52.030] Build 8947164993156900000: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:15:52.030] Scheduling timer "check-buildbucket-build-status" (webrtc/Linux64 Release:9112595055269103632:26:0) after 1m0s
[18:16:52.052] Handling timer "check-buildbucket-build-status" (webrtc/Linux64 Release:9112595055269103632:26:0)
[18:16:52.052] Timer tick, asking Buildbucket for the build status
[18:16:52.138] Build 8947164993156900000: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:16:52.138] Scheduling timer "check-buildbucket-build-status" (webrtc/Linux64 Release:9112595055269103632:27:0) after 1m0s
[18:17:52.168] Handling timer "check-buildbucket-build-status" (webrtc/Linux64 Release:9112595055269103632:27:0)
[18:17:52.168] Timer tick, asking Buildbucket for the build status
[18:17:52.226] Build 8947164993156900000: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:17:52.226] Scheduling timer "check-buildbucket-build-status" (webrtc/Linux64 Release:9112595055269103632:28:0) after 1m0s
[18:18:52.259] Handling timer "check-buildbucket-build-status" (webrtc/Linux64 Release:9112595055269103632:28:0)
[18:18:52.259] Timer tick, asking Buildbucket for the build status
[18:18:52.483] Build 8947164993156900000: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:18:52.483] Scheduling timer "check-buildbucket-build-status" (webrtc/Linux64 Release:9112595055269103632:29:0) after 1m0s
[18:19:52.502] Handling timer "check-buildbucket-build-status" (webrtc/Linux64 Release:9112595055269103632:29:0)
[18:19:52.502] Timer tick, asking Buildbucket for the build status
[18:19:52.578] Build 8947164993156900000: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:19:52.578] Scheduling timer "check-buildbucket-build-status" (webrtc/Linux64 Release:9112595055269103632:30:0) after 1m0s
[18:20:52.597] Handling timer "check-buildbucket-build-status" (webrtc/Linux64 Release:9112595055269103632:30:0)
[18:20:52.597] Timer tick, asking Buildbucket for the build status
[18:20:52.768] Build 8947164993156900000: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:20:52.768] Scheduling timer "check-buildbucket-build-status" (webrtc/Linux64 Release:9112595055269103632:31:0) after 1m0s
[18:21:52.798] Handling timer "check-buildbucket-build-status" (webrtc/Linux64 Release:9112595055269103632:31:0)
[18:21:52.798] Timer tick, asking Buildbucket for the build status
[18:21:52.879] Build 8947164993156900000: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:21:52.879] Scheduling timer "check-buildbucket-build-status" (webrtc/Linux64 Release:9112595055269103632:32:0) after 1m0s
[18:22:53.056] Handling timer "check-buildbucket-build-status" (webrtc/Linux64 Release:9112595055269103632:32:0)
[18:22:53.056] Timer tick, asking Buildbucket for the build status
[18:22:53.148] Build 8947164993156900000: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:22:53.148] Scheduling timer "check-buildbucket-build-status" (webrtc/Linux64 Release:9112595055269103632:33:0) after 1m0s
[18:23:53.222] Handling timer "check-buildbucket-build-status" (webrtc/Linux64 Release:9112595055269103632:33:0)
[18:23:53.222] Timer tick, asking Buildbucket for the build status
[18:23:53.568] Build 8947164993156900000: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:23:53.568] Scheduling timer "check-buildbucket-build-status" (webrtc/Linux64 Release:9112595055269103632:34:0) after 1m0s
[18:24:53.588] Handling timer "check-buildbucket-build-status" (webrtc/Linux64 Release:9112595055269103632:34:0)
[18:24:53.588] Timer tick, asking Buildbucket for the build status
[18:24:53.728] Build 8947164993156900000: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:24:53.729] Scheduling timer "check-buildbucket-build-status" (webrtc/Linux64 Release:9112595055269103632:35:0) after 1m0s
[18:25:53.745] Handling timer "check-buildbucket-build-status" (webrtc/Linux64 Release:9112595055269103632:35:0)
[18:25:53.745] Timer tick, asking Buildbucket for the build status
[18:25:53.865] Build 8947164993156900000: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:25:53.865] Scheduling timer "check-buildbucket-build-status" (webrtc/Linux64 Release:9112595055269103632:36:0) after 1m0s
[18:26:53.903] Handling timer "check-buildbucket-build-status" (webrtc/Linux64 Release:9112595055269103632:36:0)
[18:26:53.903] Timer tick, asking Buildbucket for the build status
[18:26:54.036] Build 8947164993156900000: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:26:54.036] Scheduling timer "check-buildbucket-build-status" (webrtc/Linux64 Release:9112595055269103632:37:0) after 1m0s
[18:27:54.100] Handling timer "check-buildbucket-build-status" (webrtc/Linux64 Release:9112595055269103632:37:0)
[18:27:54.100] Timer tick, asking Buildbucket for the build status
[18:27:54.199] Build 8947164993156900000: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:27:54.199] Scheduling timer "check-buildbucket-build-status" (webrtc/Linux64 Release:9112595055269103632:38:0) after 1m0s
[18:28:54.250] Handling timer "check-buildbucket-build-status" (webrtc/Linux64 Release:9112595055269103632:38:0)
[18:28:54.250] Timer tick, asking Buildbucket for the build status
[18:28:54.329] Build 8947164993156900000: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:28:54.329] Scheduling timer "check-buildbucket-build-status" (webrtc/Linux64 Release:9112595055269103632:39:0) after 1m0s
[18:29:54.361] Handling timer "check-buildbucket-build-status" (webrtc/Linux64 Release:9112595055269103632:39:0)
[18:29:54.361] Timer tick, asking Buildbucket for the build status
[18:29:54.782] Build 8947164993156900000: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:29:54.782] Scheduling timer "check-buildbucket-build-status" (webrtc/Linux64 Release:9112595055269103632:40:0) after 1m0s
[18:30:54.801] Handling timer "check-buildbucket-build-status" (webrtc/Linux64 Release:9112595055269103632:40:0)
[18:30:54.801] Timer tick, asking Buildbucket for the build status
[18:30:54.880] Build 8947164993156900000: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:30:54.880] Scheduling timer "check-buildbucket-build-status" (webrtc/Linux64 Release:9112595055269103632:41:0) after 1m0s
[18:31:54.916] Handling timer "check-buildbucket-build-status" (webrtc/Linux64 Release:9112595055269103632:41:0)
[18:31:54.916] Timer tick, asking Buildbucket for the build status
[18:31:55.001] Build 8947164993156900000: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:31:55.001] Scheduling timer "check-buildbucket-build-status" (webrtc/Linux64 Release:9112595055269103632:42:0) after 1m0s
[18:32:55.021] Handling timer "check-buildbucket-build-status" (webrtc/Linux64 Release:9112595055269103632:42:0)
[18:32:55.021] Timer tick, asking Buildbucket for the build status
[18:32:55.083] Build 8947164993156900000: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:32:55.084] Scheduling timer "check-buildbucket-build-status" (webrtc/Linux64 Release:9112595055269103632:43:0) after 1m0s
[18:33:55.128] Handling timer "check-buildbucket-build-status" (webrtc/Linux64 Release:9112595055269103632:43:0)
[18:33:55.128] Timer tick, asking Buildbucket for the build status
[18:33:55.263] Build 8947164993156900000: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:33:55.263] Scheduling timer "check-buildbucket-build-status" (webrtc/Linux64 Release:9112595055269103632:44:0) after 1m0s
[18:34:55.283] Handling timer "check-buildbucket-build-status" (webrtc/Linux64 Release:9112595055269103632:44:0)
[18:34:55.283] Timer tick, asking Buildbucket for the build status
[18:34:55.448] Build 8947164993156900000: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:34:55.448] Scheduling timer "check-buildbucket-build-status" (webrtc/Linux64 Release:9112595055269103632:45:0) after 1m0s
[18:35:55.473] Handling timer "check-buildbucket-build-status" (webrtc/Linux64 Release:9112595055269103632:45:0)
[18:35:55.473] Timer tick, asking Buildbucket for the build status
[18:35:55.548] Build 8947164993156900000: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:35:55.548] Scheduling timer "check-buildbucket-build-status" (webrtc/Linux64 Release:9112595055269103632:46:0) after 1m0s
[18:36:55.579] Handling timer "check-buildbucket-build-status" (webrtc/Linux64 Release:9112595055269103632:46:0)
[18:36:55.579] Timer tick, asking Buildbucket for the build status
[18:36:55.657] Build 8947164993156900000: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:36:55.657] Scheduling timer "check-buildbucket-build-status" (webrtc/Linux64 Release:9112595055269103632:47:0) after 1m0s
[18:37:55.679] Handling timer "check-buildbucket-build-status" (webrtc/Linux64 Release:9112595055269103632:47:0)
[18:37:55.679] Timer tick, asking Buildbucket for the build status
[18:37:55.918] Build 8947164993156900000: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:37:55.918] Scheduling timer "check-buildbucket-build-status" (webrtc/Linux64 Release:9112595055269103632:48:0) after 1m0s
[18:38:55.947] Handling timer "check-buildbucket-build-status" (webrtc/Linux64 Release:9112595055269103632:48:0)
[18:38:55.947] Timer tick, asking Buildbucket for the build status
[18:38:57.197] Build 8947164993156900000: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:38:57.197] Scheduling timer "check-buildbucket-build-status" (webrtc/Linux64 Release:9112595055269103632:49:0) after 1m0s
[18:39:57.213] Handling timer "check-buildbucket-build-status" (webrtc/Linux64 Release:9112595055269103632:49:0)
[18:39:57.213] Timer tick, asking Buildbucket for the build status
[18:39:57.251] Build 8947164993156900000: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:39:57.251] Scheduling timer "check-buildbucket-build-status" (webrtc/Linux64 Release:9112595055269103632:50:0) after 1m0s
[18:40:57.275] Handling timer "check-buildbucket-build-status" (webrtc/Linux64 Release:9112595055269103632:50:0)
[18:40:57.275] Timer tick, asking Buildbucket for the build status
[18:40:57.379] Build 8947164993156900000: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:40:57.379] Scheduling timer "check-buildbucket-build-status" (webrtc/Linux64 Release:9112595055269103632:51:0) after 1m0s
[18:41:57.408] Handling timer "check-buildbucket-build-status" (webrtc/Linux64 Release:9112595055269103632:51:0)
[18:41:57.408] Timer tick, asking Buildbucket for the build status
[18:41:57.569] Build 8947164993156900000: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:41:57.569] Scheduling timer "check-buildbucket-build-status" (webrtc/Linux64 Release:9112595055269103632:52:0) after 1m0s
[18:42:57.614] Handling timer "check-buildbucket-build-status" (webrtc/Linux64 Release:9112595055269103632:52:0)
[18:42:57.614] Timer tick, asking Buildbucket for the build status
[18:42:57.702] Build 8947164993156900000: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:42:57.702] Scheduling timer "check-buildbucket-build-status" (webrtc/Linux64 Release:9112595055269103632:53:0) after 1m0s
[18:43:57.722] Handling timer "check-buildbucket-build-status" (webrtc/Linux64 Release:9112595055269103632:53:0)
[18:43:57.722] Timer tick, asking Buildbucket for the build status
[18:43:57.821] Build 8947164993156900000: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:43:57.821] Scheduling timer "check-buildbucket-build-status" (webrtc/Linux64 Release:9112595055269103632:54:0) after 1m0s
[18:44:57.840] Handling timer "check-buildbucket-build-status" (webrtc/Linux64 Release:9112595055269103632:54:0)
[18:44:57.840] Timer tick, asking Buildbucket for the build status
[18:44:58.344] Build 8947164993156900000: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:44:58.344] Scheduling timer "check-buildbucket-build-status" (webrtc/Linux64 Release:9112595055269103632:55:0) after 1m0s
[18:45:58.435] Handling timer "check-buildbucket-build-status" (webrtc/Linux64 Release:9112595055269103632:55:0)
[18:45:58.435] Timer tick, asking Buildbucket for the build status
[18:45:58.636] Build 8947164993156900000: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:45:58.636] Scheduling timer "check-buildbucket-build-status" (webrtc/Linux64 Release:9112595055269103632:56:0) after 1m0s
[18:46:58.681] Handling timer "check-buildbucket-build-status" (webrtc/Linux64 Release:9112595055269103632:56:0)
[18:46:58.681] Timer tick, asking Buildbucket for the build status
[18:46:58.852] Build 8947164993156900000: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:46:58.852] Scheduling timer "check-buildbucket-build-status" (webrtc/Linux64 Release:9112595055269103632:57:0) after 1m0s
[18:47:58.869] Handling timer "check-buildbucket-build-status" (webrtc/Linux64 Release:9112595055269103632:57:0)
[18:47:58.869] Timer tick, asking Buildbucket for the build status
[18:47:59.018] Build 8947164993156900000: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:47:59.018] Scheduling timer "check-buildbucket-build-status" (webrtc/Linux64 Release:9112595055269103632:58:0) after 1m0s
[18:48:59.057] Handling timer "check-buildbucket-build-status" (webrtc/Linux64 Release:9112595055269103632:58:0)
[18:48:59.057] Timer tick, asking Buildbucket for the build status
[18:48:59.350] Build 8947164993156900000: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:48:59.350] Scheduling timer "check-buildbucket-build-status" (webrtc/Linux64 Release:9112595055269103632:59:0) after 1m0s
[18:49:59.375] Handling timer "check-buildbucket-build-status" (webrtc/Linux64 Release:9112595055269103632:59:0)
[18:49:59.375] Timer tick, asking Buildbucket for the build status
[18:49:59.444] Build 8947164993156900000: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:49:59.444] Scheduling timer "check-buildbucket-build-status" (webrtc/Linux64 Release:9112595055269103632:60:0) after 1m0s
[18:50:59.463] Handling timer "check-buildbucket-build-status" (webrtc/Linux64 Release:9112595055269103632:60:0)
[18:50:59.463] Timer tick, asking Buildbucket for the build status
[18:50:59.576] Build 8947164993156900000: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:50:59.576] Scheduling timer "check-buildbucket-build-status" (webrtc/Linux64 Release:9112595055269103632:61:0) after 1m0s
[18:51:59.615] Handling timer "check-buildbucket-build-status" (webrtc/Linux64 Release:9112595055269103632:61:0)
[18:51:59.615] Timer tick, asking Buildbucket for the build status
[18:51:59.864] Build 8947164993156900000: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:51:59.864] Scheduling timer "check-buildbucket-build-status" (webrtc/Linux64 Release:9112595055269103632:62:0) after 1m0s
[18:52:59.889] Handling timer "check-buildbucket-build-status" (webrtc/Linux64 Release:9112595055269103632:62:0)
[18:52:59.889] Timer tick, asking Buildbucket for the build status
[18:52:59.986] Build 8947164993156900000: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:52:59.986] Scheduling timer "check-buildbucket-build-status" (webrtc/Linux64 Release:9112595055269103632:63:0) after 1m0s
[18:54:00.005] Handling timer "check-buildbucket-build-status" (webrtc/Linux64 Release:9112595055269103632:63:0)
[18:54:00.005] Timer tick, asking Buildbucket for the build status
[18:54:00.284] Build 8947164993156900000: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:54:00.284] Scheduling timer "check-buildbucket-build-status" (webrtc/Linux64 Release:9112595055269103632:64:0) after 1m0s
[18:54:46.788] Received PubSub notification, asking Buildbucket for the build status
[18:54:46.865] Build 8947164993156900000: status "COMPLETED", result "FAILURE", failure_reason "INFRA_FAILURE", cancelation_reason ""
[18:54:46.866] Buildbucket build:
{
"build": {
"bucket": "luci.webrtc.ci",
"canary_preference": "AUTO",
"completed_ts": "1525719182754910",
"created_by": "user:luci-scheduler@appspot.gserviceaccount.com",
"created_ts": "1525715563585690",
"experimental": true,
"failure_reason": "INFRA_FAILURE",
"id": "8947164993156900000",
"parameters_json": "{\"builder_name\": \"Linux64 Release\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://webrtc.googlesource.com/src/\", \"revision\": \"1f184f0a15400765a1e6ba5982ac092b1af14b1d\"}}",
"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\"}, {\"path\": \"kitchen-checkout\", \"version\": \"0354a27c3fa8f9b2f850f4b2856a7539b888809b\", \"package_name\": \"infra/recipe_bundles/chromium.googlesource.com/chromium/tools/build\"}], \"client_package\": {\"version\": \"e891a48eebcd04fee5b054173539b558cbcc027c\", \"package_name\": \"infra/tools/cipd/linux-amd64\"}}, \"run_id\": \"3d548d7dcb2bb111\", \"outputs_ref\": {\"isolatedserver\": \"https://isolateserver.appspot.com\", \"namespace\": \"default-gzip\", \"isolated\": \"a64c5389acf1ee296968c34318e5ca10c976761b\"}, \"server_versions\": [\"3506-774054c\"], \"duration\": 3600.012246131897, \"completed_ts\": \"2018-05-07T18:53:02.754910\", \"started_ts\": \"2018-05-07T17:52:55.155310\", \"internal_failure\": false, \"exit_code\": \"-15\", \"state\": \"TIMED_OUT\", \"bot_version\": \"b63a0e9ba4b68fffd6b80bc8ede5fa7d748cc3fc517974634cd234b4b0c18da3\", \"tags\": [\"build_address:luci.webrtc.ci/Linux64 Release/79\", \"buildbucket_bucket:luci.webrtc.ci\", \"buildbucket_build_id:8947164993156900000\", \"buildbucket_hostname:cr-buildbucket.appspot.com\", \"buildbucket_template_canary:0\", \"buildbucket_template_revision:1b75eae6aaea26fcf63cbf60fec2c1bfeb5965ce\", \"builder:Linux64 Release\", \"buildset:commit/gitiles/webrtc.googlesource.com/src/+/1f184f0a15400765a1e6ba5982ac092b1af14b1d\", \"cpu:x86-64\", \"gitiles_ref:refs/heads/master\", \"log_location:logdog://logs.chromium.org/webrtc/buildbucket/cr-buildbucket.appspot.com/8947164993156900000/+/annotations\", \"luci_project:webrtc\", \"os:Linux\", \"pool:luci.webrtc.ci\", \"priority:60\", \"recipe_name:webrtc/standalone\", \"recipe_package:infra/recipe_bundles/chromium.googlesource.com/chromium/tools/build\", \"scheduler_invocation_id:9112595055269103632\", \"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-07T18:53:02.754910\", \"user\": \"\", \"children_task_ids\": [\"3d54947a38437510\", \"3d54947fda469610\", \"3d549485f2779410\", \"3d54948a7fef3d10\", \"3d54948deffc0e10\", \"3d54948f77d12c10\", \"3d549493e99c9b10\", \"3d5494952d50fe10\", \"3d549496523b5110\", \"3d549497ac5fef10\", \"3d549498b846df10\", \"3d549499d0ecba10\", \"3d54949d7c30ee10\", \"3d5494a1accf9d10\", \"3d5494a2d79e8410\", \"3d5494a433fc3b10\", \"3d5494a5cbf30010\", \"3d5494a97d734e10\", \"3d5494ad8a34b210\", \"3d5494b17566a410\", \"3d5494b5fb411a10\", \"3d5494b7413f6210\", \"3d5494b8a79ab510\", \"3d5494ba95ce8210\", \"3d5494bb7a5a1610\", \"3d5494bd1f19bb10\", \"3d5494c312c3d010\", \"3d5494c7ed4d7b10\", \"3d5494cc18324a10\", \"3d5494d01eedd310\", \"3d5494d14e909710\", \"3d5494d383527510\", \"3d5494d529dc3510\", \"3d5494d89a8ce810\"], \"created_ts\": \"2018-05-07T17:52:43.969290\", \"name\": \"bb-8947164993156900000-webrtc-Linux64 Release\", \"task_id\": \"3d548d7dcb2bb110\", \"bot_dimensions\": [{\"value\": [\"git\", \"goma\", \"vpython\", \"webrtc_arm_android\"], \"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-hl1j\"], \"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\": [\"3506-774054c\"], \"key\": \"server_version\"}, {\"value\": [\"us\", \"us-central\", \"us-central1\", \"us-central1-b\"], \"key\": \"zone\"}], \"try_number\": \"1\", \"current_task_slice\": \"0\", \"costs_usd\": [0.41710789165935164], \"bot_id\": \"trusty-webrtc-fe7e3dcb-us-central1-b-hl1j\"}}, \"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": "1525715575155310",
"status": "COMPLETED",
"status_changed_ts": "1525719283455670",
"tags": [
"build_address:luci.webrtc.ci/Linux64 Release/79",
"builder:Linux64 Release",
"buildset:commit/gitiles/webrtc.googlesource.com/src/+/1f184f0a15400765a1e6ba5982ac092b1af14b1d",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9112595055269103632",
"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/79",
"swarming_tag:buildbucket_bucket:luci.webrtc.ci",
"swarming_tag:buildbucket_build_id:8947164993156900000",
"swarming_tag:buildbucket_hostname:cr-buildbucket.appspot.com",
"swarming_tag:buildbucket_template_canary:0",
"swarming_tag:buildbucket_template_revision:1b75eae6aaea26fcf63cbf60fec2c1bfeb5965ce",
"swarming_tag:builder:Linux64 Release",
"swarming_tag:buildset:commit/gitiles/webrtc.googlesource.com/src/+/1f184f0a15400765a1e6ba5982ac092b1af14b1d",
"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/8947164993156900000/+/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_package:infra/recipe_bundles/chromium.googlesource.com/chromium/tools/build",
"swarming_tag:scheduler_invocation_id:9112595055269103632",
"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:3d548d7dcb2bb110",
"user_agent:luci-scheduler"
],
"updated_ts": "1525719283456700",
"url": "https://ci.chromium.org/p/webrtc/builders/luci.webrtc.ci/Linux64 Release/79",
"utcnow_ts": "1525719286844450"
}
}
[18:54:46.866] Invocation finished in 1h2m4.678584553s with status FAILED