[23:34:41.145] New invocation is queued and will start shortly
[23:34:42.545] Starting the invocation (attempt 1)
[23:34:42.603] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[23:34:42.644] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[23:34:42.645] Buildbucket request:
{
"bucket": "luci.webrtc.ci",
"client_operation_id": "9095631906882207776",
"parameters_json": "{\"builder_name\":\"Linux32 Debug\",\"properties\":{\"branch\":\"refs/heads/master\",\"repository\":\"https://webrtc.googlesource.com/src/\",\"revision\":\"0b1b5c1b2ab3b03b52460a1dbbb65b6b030d600e\"}}",
"pubsub_callback": {
"auth_token": "...",
"topic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
},
"tags": [
"builder:Linux32 Debug",
"scheduler_invocation_id:9095631906882207776",
"scheduler_job_id:webrtc/Linux32 Debug",
"user_agent:luci-scheduler",
"buildset:commit/git/0b1b5c1b2ab3b03b52460a1dbbb65b6b030d600e",
"buildset:commit/gitiles/webrtc.googlesource.com/src/+/0b1b5c1b2ab3b03b52460a1dbbb65b6b030d600e",
"gitiles_ref:refs/heads/master"
]
}
[23:34:45.354] Buildbucket response:
{
"build": {
"bucket": "luci.webrtc.ci",
"canary_preference": "AUTO",
"created_by": "user:luci-scheduler@appspot.gserviceaccount.com",
"created_ts": "1541892882784980",
"id": "8930201844499741584",
"lease_expiration_ts": "1542008084866957",
"lease_key": "792804391",
"parameters_json": "{\"builder_name\": \"Linux32 Debug\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://webrtc.googlesource.com/src/\", \"revision\": \"0b1b5c1b2ab3b03b52460a1dbbb65b6b030d600e\"}}",
"project": "webrtc",
"result_details_json": "null",
"service_account": "webrtc-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"status": "SCHEDULED",
"status_changed_ts": "1541892885216927",
"tags": [
"build_address:luci.webrtc.ci/Linux32 Debug/19162",
"builder:Linux32 Debug",
"buildset:commit/git/0b1b5c1b2ab3b03b52460a1dbbb65b6b030d600e",
"buildset:commit/gitiles/webrtc.googlesource.com/src/+/0b1b5c1b2ab3b03b52460a1dbbb65b6b030d600e",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9095631906882207776",
"scheduler_job_id:webrtc/Linux32 Debug",
"swarming_dimension:caches:builder_0b9ea9fa64bf0cd9c46059730b1bdd1d12ff6500ce62c56e48fe9cca98bdf248_v2",
"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/Linux32 Debug/19162",
"swarming_tag:buildbucket_bucket:webrtc/ci",
"swarming_tag:buildbucket_build_id:8930201844499741584",
"swarming_tag:buildbucket_hostname:cr-buildbucket.appspot.com",
"swarming_tag:buildbucket_template_canary:0",
"swarming_tag:buildbucket_template_revision:4c8ae520b7ed0f3687d2af0e926104b1bcbf0f37",
"swarming_tag:builder:Linux32 Debug",
"swarming_tag:buildset:commit/git/0b1b5c1b2ab3b03b52460a1dbbb65b6b030d600e",
"swarming_tag:buildset:commit/gitiles/webrtc.googlesource.com/src/+/0b1b5c1b2ab3b03b52460a1dbbb65b6b030d600e",
"swarming_tag:caches:builder_0b9ea9fa64bf0cd9c46059730b1bdd1d12ff6500ce62c56e48fe9cca98bdf248_v2",
"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/8930201844499741584/+/annotations",
"swarming_tag:luci_project:webrtc",
"swarming_tag:os:Linux",
"swarming_tag:pool:luci.webrtc.ci",
"swarming_tag:priority:30",
"swarming_tag:recipe_name:webrtc/standalone",
"swarming_tag:recipe_package:infra/recipe_bundles/chromium.googlesource.com/chromium/tools/build",
"swarming_tag:scheduler_invocation_id:9095631906882207776",
"swarming_tag:scheduler_job_id:webrtc/Linux32 Debug",
"swarming_tag:service_account:webrtc-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"swarming_tag:swarming.pool.template:skip",
"swarming_tag:swarming.pool.version:43eed580a711b6fa3c17ee91a8c14ff22cb7390f",
"swarming_tag:user:None",
"swarming_tag:user_agent:luci-scheduler",
"swarming_tag:vpython:native-python-wrapper",
"swarming_task_id:4118cbce4fb3a810",
"user_agent:luci-scheduler"
],
"updated_ts": "1541892885217034",
"url": "https://ci.chromium.org/b/8930201844499741584",
"utcnow_ts": "1541892885319437"
}
}
[23:34:45.354] Task URL: https://ci.chromium.org/b/8930201844499741584
[23:34:45.354] Scheduling timer "check-buildbucket-build-status" (webrtc/Linux32 Debug:9095631906882207776:2:0) after 1m0s
[23:35:45.380] Handling timer "check-buildbucket-build-status" (webrtc/Linux32 Debug:9095631906882207776:2:0)
[23:35:45.380] Timer tick, asking Buildbucket for the build status
[23:35:45.451] Build 8930201844499741584: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[23:35:45.451] Scheduling timer "check-buildbucket-build-status" (webrtc/Linux32 Debug:9095631906882207776:3:0) after 1m0s
[23:36:45.490] Handling timer "check-buildbucket-build-status" (webrtc/Linux32 Debug:9095631906882207776:3:0)
[23:36:45.490] Timer tick, asking Buildbucket for the build status
[23:36:45.547] Build 8930201844499741584: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[23:36:45.547] Scheduling timer "check-buildbucket-build-status" (webrtc/Linux32 Debug:9095631906882207776:4:0) after 1m0s
[23:37:45.563] Handling timer "check-buildbucket-build-status" (webrtc/Linux32 Debug:9095631906882207776:4:0)
[23:37:45.563] Timer tick, asking Buildbucket for the build status
[23:37:45.620] Build 8930201844499741584: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[23:37:45.620] Scheduling timer "check-buildbucket-build-status" (webrtc/Linux32 Debug:9095631906882207776:5:0) after 1m0s
[23:38:45.637] Handling timer "check-buildbucket-build-status" (webrtc/Linux32 Debug:9095631906882207776:5:0)
[23:38:45.637] Timer tick, asking Buildbucket for the build status
[23:38:45.838] Build 8930201844499741584: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[23:38:45.838] Scheduling timer "check-buildbucket-build-status" (webrtc/Linux32 Debug:9095631906882207776:6:0) after 1m0s
[23:39:45.863] Handling timer "check-buildbucket-build-status" (webrtc/Linux32 Debug:9095631906882207776:6:0)
[23:39:45.863] Timer tick, asking Buildbucket for the build status
[23:39:46.021] Build 8930201844499741584: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[23:39:46.021] Scheduling timer "check-buildbucket-build-status" (webrtc/Linux32 Debug:9095631906882207776:7:0) after 1m0s
[23:40:46.047] Handling timer "check-buildbucket-build-status" (webrtc/Linux32 Debug:9095631906882207776:7:0)
[23:40:46.047] Timer tick, asking Buildbucket for the build status
[23:40:46.116] Build 8930201844499741584: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[23:40:46.116] Scheduling timer "check-buildbucket-build-status" (webrtc/Linux32 Debug:9095631906882207776:8:0) after 1m0s
[23:41:46.198] Handling timer "check-buildbucket-build-status" (webrtc/Linux32 Debug:9095631906882207776:8:0)
[23:41:46.198] Timer tick, asking Buildbucket for the build status
[23:41:46.327] Build 8930201844499741584: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[23:41:46.327] Scheduling timer "check-buildbucket-build-status" (webrtc/Linux32 Debug:9095631906882207776:9:0) after 1m0s
[23:42:46.372] Handling timer "check-buildbucket-build-status" (webrtc/Linux32 Debug:9095631906882207776:9:0)
[23:42:46.372] Timer tick, asking Buildbucket for the build status
[23:42:46.421] Build 8930201844499741584: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[23:42:46.421] Scheduling timer "check-buildbucket-build-status" (webrtc/Linux32 Debug:9095631906882207776:10:0) after 1m0s
[23:43:46.471] Handling timer "check-buildbucket-build-status" (webrtc/Linux32 Debug:9095631906882207776:10:0)
[23:43:46.471] Timer tick, asking Buildbucket for the build status
[23:43:46.646] Build 8930201844499741584: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[23:43:46.646] Scheduling timer "check-buildbucket-build-status" (webrtc/Linux32 Debug:9095631906882207776:11:0) after 1m0s
[23:44:46.662] Handling timer "check-buildbucket-build-status" (webrtc/Linux32 Debug:9095631906882207776:11:0)
[23:44:46.662] Timer tick, asking Buildbucket for the build status
[23:44:46.851] Build 8930201844499741584: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[23:44:46.851] Scheduling timer "check-buildbucket-build-status" (webrtc/Linux32 Debug:9095631906882207776:12:0) after 1m0s
[23:45:46.876] Handling timer "check-buildbucket-build-status" (webrtc/Linux32 Debug:9095631906882207776:12:0)
[23:45:46.876] Timer tick, asking Buildbucket for the build status
[23:45:46.944] Build 8930201844499741584: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[23:45:46.944] Scheduling timer "check-buildbucket-build-status" (webrtc/Linux32 Debug:9095631906882207776:13:0) after 1m0s
[23:46:47.072] Handling timer "check-buildbucket-build-status" (webrtc/Linux32 Debug:9095631906882207776:13:0)
[23:46:47.072] Timer tick, asking Buildbucket for the build status
[23:46:47.149] Build 8930201844499741584: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[23:46:47.149] Scheduling timer "check-buildbucket-build-status" (webrtc/Linux32 Debug:9095631906882207776:14:0) after 1m0s
[23:47:47.267] Handling timer "check-buildbucket-build-status" (webrtc/Linux32 Debug:9095631906882207776:14:0)
[23:47:47.267] Timer tick, asking Buildbucket for the build status
[23:47:47.317] Build 8930201844499741584: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[23:47:47.317] Scheduling timer "check-buildbucket-build-status" (webrtc/Linux32 Debug:9095631906882207776:15:0) after 1m0s
[23:48:47.337] Handling timer "check-buildbucket-build-status" (webrtc/Linux32 Debug:9095631906882207776:15:0)
[23:48:47.337] Timer tick, asking Buildbucket for the build status
[23:48:47.505] Build 8930201844499741584: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[23:48:47.505] Scheduling timer "check-buildbucket-build-status" (webrtc/Linux32 Debug:9095631906882207776:16:0) after 1m0s
[23:49:47.524] Handling timer "check-buildbucket-build-status" (webrtc/Linux32 Debug:9095631906882207776:16:0)
[23:49:47.524] Timer tick, asking Buildbucket for the build status
[23:49:47.643] Build 8930201844499741584: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[23:49:47.643] Scheduling timer "check-buildbucket-build-status" (webrtc/Linux32 Debug:9095631906882207776:17:0) after 1m0s
[23:50:47.662] Handling timer "check-buildbucket-build-status" (webrtc/Linux32 Debug:9095631906882207776:17:0)
[23:50:47.662] Timer tick, asking Buildbucket for the build status
[23:50:47.929] Build 8930201844499741584: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[23:50:47.929] Scheduling timer "check-buildbucket-build-status" (webrtc/Linux32 Debug:9095631906882207776:18:0) after 1m0s
[23:51:47.973] Handling timer "check-buildbucket-build-status" (webrtc/Linux32 Debug:9095631906882207776:18:0)
[23:51:47.973] Timer tick, asking Buildbucket for the build status
[23:51:48.034] Build 8930201844499741584: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[23:51:48.034] Scheduling timer "check-buildbucket-build-status" (webrtc/Linux32 Debug:9095631906882207776:19:0) after 1m0s
[23:52:48.069] Handling timer "check-buildbucket-build-status" (webrtc/Linux32 Debug:9095631906882207776:19:0)
[23:52:48.069] Timer tick, asking Buildbucket for the build status
[23:52:48.126] Build 8930201844499741584: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[23:52:48.126] Scheduling timer "check-buildbucket-build-status" (webrtc/Linux32 Debug:9095631906882207776:20:0) after 1m0s
[23:53:48.189] Handling timer "check-buildbucket-build-status" (webrtc/Linux32 Debug:9095631906882207776:20:0)
[23:53:48.189] Timer tick, asking Buildbucket for the build status
[23:53:48.279] Build 8930201844499741584: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[23:53:48.279] Scheduling timer "check-buildbucket-build-status" (webrtc/Linux32 Debug:9095631906882207776:21:0) after 1m0s
[23:54:48.299] Handling timer "check-buildbucket-build-status" (webrtc/Linux32 Debug:9095631906882207776:21:0)
[23:54:48.299] Timer tick, asking Buildbucket for the build status
[23:54:48.368] Build 8930201844499741584: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[23:54:48.368] Scheduling timer "check-buildbucket-build-status" (webrtc/Linux32 Debug:9095631906882207776:22:0) after 1m0s
[23:55:48.398] Handling timer "check-buildbucket-build-status" (webrtc/Linux32 Debug:9095631906882207776:22:0)
[23:55:48.398] Timer tick, asking Buildbucket for the build status
[23:55:48.738] Build 8930201844499741584: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[23:55:48.738] Scheduling timer "check-buildbucket-build-status" (webrtc/Linux32 Debug:9095631906882207776:23:0) after 1m0s
[23:56:48.759] Handling timer "check-buildbucket-build-status" (webrtc/Linux32 Debug:9095631906882207776:23:0)
[23:56:48.759] Timer tick, asking Buildbucket for the build status
[23:56:48.907] Build 8930201844499741584: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[23:56:48.907] Scheduling timer "check-buildbucket-build-status" (webrtc/Linux32 Debug:9095631906882207776:24:0) after 1m0s
[23:57:48.927] Handling timer "check-buildbucket-build-status" (webrtc/Linux32 Debug:9095631906882207776:24:0)
[23:57:48.928] Timer tick, asking Buildbucket for the build status
[23:57:49.206] Build 8930201844499741584: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[23:57:49.206] Scheduling timer "check-buildbucket-build-status" (webrtc/Linux32 Debug:9095631906882207776:25:0) after 1m0s
[23:58:49.378] Handling timer "check-buildbucket-build-status" (webrtc/Linux32 Debug:9095631906882207776:25:0)
[23:58:49.378] Timer tick, asking Buildbucket for the build status
[23:58:49.478] Build 8930201844499741584: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[23:58:49.478] Scheduling timer "check-buildbucket-build-status" (webrtc/Linux32 Debug:9095631906882207776:26:0) after 1m0s
[23:59:49.598] Handling timer "check-buildbucket-build-status" (webrtc/Linux32 Debug:9095631906882207776:26:0)
[23:59:49.598] Timer tick, asking Buildbucket for the build status
[23:59:49.743] Build 8930201844499741584: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[23:59:49.743] Scheduling timer "check-buildbucket-build-status" (webrtc/Linux32 Debug:9095631906882207776:27:0) after 1m0s
[00:00:49.759] Handling timer "check-buildbucket-build-status" (webrtc/Linux32 Debug:9095631906882207776:27:0)
[00:00:49.759] Timer tick, asking Buildbucket for the build status
[00:00:49.909] Build 8930201844499741584: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[00:00:49.909] Scheduling timer "check-buildbucket-build-status" (webrtc/Linux32 Debug:9095631906882207776:28:0) after 1m0s
[00:01:49.929] Handling timer "check-buildbucket-build-status" (webrtc/Linux32 Debug:9095631906882207776:28:0)
[00:01:49.929] Timer tick, asking Buildbucket for the build status
[00:01:50.000] Build 8930201844499741584: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[00:01:50.000] Scheduling timer "check-buildbucket-build-status" (webrtc/Linux32 Debug:9095631906882207776:29:0) after 1m0s
[00:02:50.019] Handling timer "check-buildbucket-build-status" (webrtc/Linux32 Debug:9095631906882207776:29:0)
[00:02:50.019] Timer tick, asking Buildbucket for the build status
[00:02:50.203] Build 8930201844499741584: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[00:02:50.203] Scheduling timer "check-buildbucket-build-status" (webrtc/Linux32 Debug:9095631906882207776:30:0) after 1m0s
[00:03:50.223] Handling timer "check-buildbucket-build-status" (webrtc/Linux32 Debug:9095631906882207776:30:0)
[00:03:50.223] Timer tick, asking Buildbucket for the build status
[00:03:50.284] Build 8930201844499741584: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[00:03:50.284] Scheduling timer "check-buildbucket-build-status" (webrtc/Linux32 Debug:9095631906882207776:31:0) after 1m0s
[00:04:50.304] Handling timer "check-buildbucket-build-status" (webrtc/Linux32 Debug:9095631906882207776:31:0)
[00:04:50.304] Timer tick, asking Buildbucket for the build status
[00:04:50.416] Build 8930201844499741584: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[00:04:50.416] Scheduling timer "check-buildbucket-build-status" (webrtc/Linux32 Debug:9095631906882207776:32:0) after 1m0s
[00:05:50.488] Handling timer "check-buildbucket-build-status" (webrtc/Linux32 Debug:9095631906882207776:32:0)
[00:05:50.488] Timer tick, asking Buildbucket for the build status
[00:05:50.552] Build 8930201844499741584: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[00:05:50.552] Scheduling timer "check-buildbucket-build-status" (webrtc/Linux32 Debug:9095631906882207776:33:0) after 1m0s
[00:06:10.638] Received PubSub notification, asking Buildbucket for the build status
[00:06:10.736] Build 8930201844499741584: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:06:50.571] Handling timer "check-buildbucket-build-status" (webrtc/Linux32 Debug:9095631906882207776:33:0)
[00:06:50.571] Timer tick, asking Buildbucket for the build status
[00:06:50.640] Build 8930201844499741584: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:06:50.640] Scheduling timer "check-buildbucket-build-status" (webrtc/Linux32 Debug:9095631906882207776:35:0) after 1m0s
[00:07:50.673] Handling timer "check-buildbucket-build-status" (webrtc/Linux32 Debug:9095631906882207776:35:0)
[00:07:50.673] Timer tick, asking Buildbucket for the build status
[00:07:50.746] Build 8930201844499741584: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:07:50.746] Scheduling timer "check-buildbucket-build-status" (webrtc/Linux32 Debug:9095631906882207776:36:0) after 1m0s
[00:08:50.770] Handling timer "check-buildbucket-build-status" (webrtc/Linux32 Debug:9095631906882207776:36:0)
[00:08:50.770] Timer tick, asking Buildbucket for the build status
[00:08:50.882] Build 8930201844499741584: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:08:50.882] Scheduling timer "check-buildbucket-build-status" (webrtc/Linux32 Debug:9095631906882207776:37:0) after 1m0s
[00:09:50.901] Handling timer "check-buildbucket-build-status" (webrtc/Linux32 Debug:9095631906882207776:37:0)
[00:09:50.901] Timer tick, asking Buildbucket for the build status
[00:09:50.961] Build 8930201844499741584: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:09:50.961] Scheduling timer "check-buildbucket-build-status" (webrtc/Linux32 Debug:9095631906882207776:38:0) after 1m0s
[00:10:50.989] Handling timer "check-buildbucket-build-status" (webrtc/Linux32 Debug:9095631906882207776:38:0)
[00:10:50.989] Timer tick, asking Buildbucket for the build status
[00:10:51.113] Build 8930201844499741584: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:10:51.113] Scheduling timer "check-buildbucket-build-status" (webrtc/Linux32 Debug:9095631906882207776:39:0) after 1m0s
[00:11:51.178] Handling timer "check-buildbucket-build-status" (webrtc/Linux32 Debug:9095631906882207776:39:0)
[00:11:51.178] Timer tick, asking Buildbucket for the build status
[00:11:51.243] Build 8930201844499741584: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:11:51.243] Scheduling timer "check-buildbucket-build-status" (webrtc/Linux32 Debug:9095631906882207776:40:0) after 1m0s
[00:12:51.289] Handling timer "check-buildbucket-build-status" (webrtc/Linux32 Debug:9095631906882207776:40:0)
[00:12:51.289] Timer tick, asking Buildbucket for the build status
[00:12:51.600] Build 8930201844499741584: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:12:51.600] Scheduling timer "check-buildbucket-build-status" (webrtc/Linux32 Debug:9095631906882207776:41:0) after 1m0s
[00:13:51.619] Handling timer "check-buildbucket-build-status" (webrtc/Linux32 Debug:9095631906882207776:41:0)
[00:13:51.619] Timer tick, asking Buildbucket for the build status
[00:13:51.718] Build 8930201844499741584: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:13:51.718] Scheduling timer "check-buildbucket-build-status" (webrtc/Linux32 Debug:9095631906882207776:42:0) after 1m0s
[00:14:51.764] Handling timer "check-buildbucket-build-status" (webrtc/Linux32 Debug:9095631906882207776:42:0)
[00:14:51.764] Timer tick, asking Buildbucket for the build status
[00:14:51.862] Build 8930201844499741584: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:14:51.862] Scheduling timer "check-buildbucket-build-status" (webrtc/Linux32 Debug:9095631906882207776:43:0) after 1m0s
[00:15:51.891] Handling timer "check-buildbucket-build-status" (webrtc/Linux32 Debug:9095631906882207776:43:0)
[00:15:51.891] Timer tick, asking Buildbucket for the build status
[00:15:52.033] Build 8930201844499741584: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:15:52.033] Scheduling timer "check-buildbucket-build-status" (webrtc/Linux32 Debug:9095631906882207776:44:0) after 1m0s
[00:16:52.067] Handling timer "check-buildbucket-build-status" (webrtc/Linux32 Debug:9095631906882207776:44:0)
[00:16:52.067] Timer tick, asking Buildbucket for the build status
[00:16:52.201] Build 8930201844499741584: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:16:52.201] Scheduling timer "check-buildbucket-build-status" (webrtc/Linux32 Debug:9095631906882207776:45:0) after 1m0s
[00:17:52.225] Handling timer "check-buildbucket-build-status" (webrtc/Linux32 Debug:9095631906882207776:45:0)
[00:17:52.225] Timer tick, asking Buildbucket for the build status
[00:17:52.834] Build 8930201844499741584: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:17:52.834] Scheduling timer "check-buildbucket-build-status" (webrtc/Linux32 Debug:9095631906882207776:46:0) after 1m0s
[00:18:17.314] Received PubSub notification, asking Buildbucket for the build status
[00:18:17.350] Build 8930201844499741584: status "COMPLETED", result "SUCCESS", failure_reason "", cancelation_reason ""
[00:18:17.350] Buildbucket build:
{
"build": {
"bucket": "luci.webrtc.ci",
"canary_preference": "AUTO",
"completed_ts": "1541895496199276",
"created_by": "user:luci-scheduler@appspot.gserviceaccount.com",
"created_ts": "1541892882784980",
"id": "8930201844499741584",
"parameters_json": "{\"builder_name\": \"Linux32 Debug\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://webrtc.googlesource.com/src/\", \"revision\": \"0b1b5c1b2ab3b03b52460a1dbbb65b6b030d600e\"}}",
"project": "webrtc",
"result": "SUCCESS",
"result_details_json": "{\"ui\": {\"info\": \"\"}, \"swarming\": {\"bot_dimensions\": {\"zone\": [\"us\", \"us-central\", \"us-central1\", \"us-central1-b\"], \"inside_docker\": [\"0\"], \"python\": [\"2.7.6\"], \"image\": [\"chrome-trusty-18091700-38cc06ee3ee\"], \"kvm\": [\"1\"], \"cpu\": [\"x86\", \"x86-64\", \"x86-64-Haswell_GCE\", \"x86-64-avx2\"], \"server_version\": [\"3844-124e68f\"], \"machine_type\": [\"n1-standard-8\"], \"gpu\": [\"none\"], \"cores\": [\"8\"], \"os\": [\"Linux\", \"Ubuntu\", \"Ubuntu-14.04\"], \"id\": [\"trusty-webrtc-d2a17ac3-us-central1-b-5qhs\"], \"pool\": [\"luci.webrtc.ci\"], \"caches\": [\"builder_d5629c2cf2c35ad595411a5dcfd59fde2daf263f5d0c2761858cad08923fcc47_v2\", \"git\", \"goma_v2\", \"vpython\"]}}, \"properties\": {\"$recipe_engine/path\": {\"cache_dir\": \"/b/s/w/ir/cache\", \"temp_dir\": \"/b/s/w/ir/tmp/rt\"}, \"buildnumber\": 19162, \"repository\": \"https://webrtc.googlesource.com/src/\", \"buildername\": \"Linux32 Debug\", \"got_revision\": \"0b1b5c1b2ab3b03b52460a1dbbb65b6b030d600e\", \"recipe\": \"webrtc/standalone\", \"mastername\": \"client.webrtc\", \"$recipe_engine/runtime\": {\"is_experimental\": false, \"is_luci\": true}, \"buildbucket\": {\"hostname\": \"cr-buildbucket.appspot.com\", \"build\": {\"created_ts\": 1541892882784980, \"tags\": [\"builder:Linux32 Debug\", \"buildset:commit/git/0b1b5c1b2ab3b03b52460a1dbbb65b6b030d600e\", \"buildset:commit/gitiles/webrtc.googlesource.com/src/+/0b1b5c1b2ab3b03b52460a1dbbb65b6b030d600e\", \"gitiles_ref:refs/heads/master\", \"scheduler_invocation_id:9095631906882207776\", \"scheduler_job_id:webrtc/Linux32 Debug\", \"user_agent:luci-scheduler\"], \"bucket\": \"luci.webrtc.ci\", \"created_by\": \"user:luci-scheduler@appspot.gserviceaccount.com\", \"project\": \"webrtc\", \"id\": \"8930201844499741584\"}}, \"got_revision_cp\": \"refs/heads/master@{#25590}\", \"swarm_hashes\": {\"common_audio_unittests\": \"ef91db0b4b23834cd1cd177f3266d6d16eb5e6ec\", \"system_wrappers_unittests\": \"15b21201a5cc6219971a6b8503b91e0340910635\", \"rtc_unittests\": \"6b4ebbfd7341ae4ac175a80b51ef4a1fb952adb9\", \"low_bandwidth_audio_test\": \"bd8ecd6d12318af0b95b8dd62430392e64e14933\", \"test_support_unittests\": \"5cb52e582ad8237e0d1235a42ae66de0cc01fbd9\", \"tools_unittests\": \"955e65088586fb2cf1fd78bc8805fbef8584cbb0\", \"rtc_pc_unittests\": \"7fa76cee038a14724341419a802b79a8f87c3ff7\", \"modules_tests\": \"37d6b7f3bd07140aaf2a3cfe6f3135d2747871df\", \"common_video_unittests\": \"e9d4cfcb22e29b2dc63cdce14d9dabf67ee8b98b\", \"video_engine_tests\": \"242f0596bbfac6bfbcea9c11d531b8b13e720fe0\", \"webrtc_nonparallel_tests\": \"bf7d494422b31673beffde6db3cececb83c4acde\", \"peerconnection_unittests\": \"f296a940b3d154224e70a1b7c3a3bff5dcce9ac2\", \"rtc_stats_unittests\": \"79d1d2eafea475e38b04cf3e7719ad9f13683750\", \"audio_decoder_unittests\": \"6ff59a74d94d3fa30a86ad0a9567641ab55d70c9\", \"modules_unittests\": \"ce038385e42ea5068e58359e077228387fc0a675\", \"rtc_media_unittests\": \"fb5b3402693c6665f0ac7524a092362f79cd6d3c\"}, \"branch\": \"refs/heads/master\", \"path_config\": \"generic\", \"revision\": \"0b1b5c1b2ab3b03b52460a1dbbb65b6b030d600e\", \"bot_id\": \"trusty-webrtc-d2a17ac3-us-central1-b-5qhs\"}}",
"service_account": "webrtc-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"started_ts": "1541894769682655",
"status": "COMPLETED",
"status_changed_ts": "1541895496737205",
"tags": [
"build_address:luci.webrtc.ci/Linux32 Debug/19162",
"builder:Linux32 Debug",
"buildset:commit/git/0b1b5c1b2ab3b03b52460a1dbbb65b6b030d600e",
"buildset:commit/gitiles/webrtc.googlesource.com/src/+/0b1b5c1b2ab3b03b52460a1dbbb65b6b030d600e",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9095631906882207776",
"scheduler_job_id:webrtc/Linux32 Debug",
"swarming_dimension:caches:builder_0b9ea9fa64bf0cd9c46059730b1bdd1d12ff6500ce62c56e48fe9cca98bdf248_v2",
"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/Linux32 Debug/19162",
"swarming_tag:buildbucket_bucket:webrtc/ci",
"swarming_tag:buildbucket_build_id:8930201844499741584",
"swarming_tag:buildbucket_hostname:cr-buildbucket.appspot.com",
"swarming_tag:buildbucket_template_canary:0",
"swarming_tag:buildbucket_template_revision:4c8ae520b7ed0f3687d2af0e926104b1bcbf0f37",
"swarming_tag:builder:Linux32 Debug",
"swarming_tag:buildset:commit/git/0b1b5c1b2ab3b03b52460a1dbbb65b6b030d600e",
"swarming_tag:buildset:commit/gitiles/webrtc.googlesource.com/src/+/0b1b5c1b2ab3b03b52460a1dbbb65b6b030d600e",
"swarming_tag:caches:builder_0b9ea9fa64bf0cd9c46059730b1bdd1d12ff6500ce62c56e48fe9cca98bdf248_v2",
"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/8930201844499741584/+/annotations",
"swarming_tag:luci_project:webrtc",
"swarming_tag:os:Linux",
"swarming_tag:pool:luci.webrtc.ci",
"swarming_tag:priority:30",
"swarming_tag:recipe_name:webrtc/standalone",
"swarming_tag:recipe_package:infra/recipe_bundles/chromium.googlesource.com/chromium/tools/build",
"swarming_tag:scheduler_invocation_id:9095631906882207776",
"swarming_tag:scheduler_job_id:webrtc/Linux32 Debug",
"swarming_tag:service_account:webrtc-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"swarming_tag:swarming.pool.template:skip",
"swarming_tag:swarming.pool.version:43eed580a711b6fa3c17ee91a8c14ff22cb7390f",
"swarming_tag:user:None",
"swarming_tag:user_agent:luci-scheduler",
"swarming_tag:vpython:native-python-wrapper",
"swarming_task_id:4118cbce4fb3a810",
"user_agent:luci-scheduler"
],
"updated_ts": "1541895496738614",
"url": "https://ci.chromium.org/b/8930201844499741584",
"utcnow_ts": "1541895497339941"
}
}
[00:18:17.350] Invocation finished in 43m36.221026846s with status SUCCEEDED