[18:26:55.656] New invocation is queued and will start shortly
[18:26:56.995] Starting the invocation (attempt 1)
[18:26:57.081] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[18:26:57.081] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[18:26:57.082] Buildbucket request:
{
"bucket": "luci.webrtc.ci",
"client_operation_id": "9056513379869838160",
"parameters_json": "{\"builder_name\":\"Mac64 Release\",\"properties\":{\"$recipe_engine/scheduler\":{\"hostname\":\"luci-scheduler.appspot.com\",\"triggers\":[{\"gitiles\":{\"ref\":\"refs/heads/master\",\"repo\":\"https://webrtc.googlesource.com/src\",\"revision\":\"2a11b2451a4068746fa0c55fa210efd4a15e4423\"},\"id\":\"https://webrtc.googlesource.com/src/+/refs/heads/master@2a11b2451a4068746fa0c55fa210efd4a15e4423\",\"title\":\"2a11b2451a4068746fa0c55fa210efd4a15e4423\",\"url\":\"https://webrtc.googlesource.com/src/+/2a11b2451a4068746fa0c55fa210efd4a15e4423\"}]},\"branch\":\"refs/heads/master\",\"repository\":\"https://webrtc.googlesource.com/src\",\"revision\":\"2a11b2451a4068746fa0c55fa210efd4a15e4423\"}}",
"pubsub_callback": {
"auth_token": "...",
"topic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
},
"tags": [
"builder:Mac64 Release",
"scheduler_invocation_id:9056513379869838160",
"scheduler_job_id:webrtc/Mac64 Release",
"user_agent:luci-scheduler",
"buildset:commit/git/2a11b2451a4068746fa0c55fa210efd4a15e4423",
"buildset:commit/gitiles/webrtc.googlesource.com/src/+/2a11b2451a4068746fa0c55fa210efd4a15e4423",
"gitiles_ref:refs/heads/master"
]
}
[18:26:57.990] Buildbucket response:
{
"build": {
"bucket": "luci.webrtc.ci",
"canary_preference": "PROD",
"created_by": "project:webrtc",
"created_ts": "1579199217258340",
"id": "8891083317522474400",
"parameters_json": "{\"builder_name\": \"Mac64 Release\", \"properties\": {\"$recipe_engine/scheduler\": {\"hostname\": \"luci-scheduler.appspot.com\", \"triggers\": [{\"gitiles\": {\"ref\": \"refs/heads/master\", \"repo\": \"https://webrtc.googlesource.com/src\", \"revision\": \"2a11b2451a4068746fa0c55fa210efd4a15e4423\"}, \"id\": \"https://webrtc.googlesource.com/src/+/refs/heads/master@2a11b2451a4068746fa0c55fa210efd4a15e4423\", \"title\": \"2a11b2451a4068746fa0c55fa210efd4a15e4423\", \"url\": \"https://webrtc.googlesource.com/src/+/2a11b2451a4068746fa0c55fa210efd4a15e4423\"}]}, \"branch\": \"refs/heads/master\", \"repository\": \"https://webrtc.googlesource.com/src\", \"revision\": \"2a11b2451a4068746fa0c55fa210efd4a15e4423\"}}",
"project": "webrtc",
"result_details_json": "{\"properties\": {}}",
"service_account": "webrtc-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"status": "SCHEDULED",
"status_changed_ts": "1579199217809505",
"tags": [
"build_address:luci.webrtc.ci/Mac64 Release/23285",
"builder:Mac64 Release",
"buildset:commit/git/2a11b2451a4068746fa0c55fa210efd4a15e4423",
"buildset:commit/gitiles/webrtc.googlesource.com/src/+/2a11b2451a4068746fa0c55fa210efd4a15e4423",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9056513379869838160",
"scheduler_job_id:webrtc/Mac64 Release",
"swarming_hostname:chromium-swarm.appspot.com",
"swarming_tag:log_location:logdog://logs.chromium.org/webrtc/buildbucket/cr-buildbucket.appspot.com/8891083317522474400/+/annotations",
"swarming_tag:luci_project:webrtc",
"swarming_tag:recipe_name:webrtc/standalone",
"swarming_tag:recipe_package:infra/recipe_bundles/chromium.googlesource.com/chromium/tools/build",
"swarming_task_id:",
"user_agent:luci-scheduler"
],
"updated_ts": "1579199217809622",
"url": "https://ci.chromium.org/b/8891083317522474400",
"utcnow_ts": "1579199217981593"
}
}
[18:26:57.990] Task URL: https://ci.chromium.org/b/8891083317522474400
[18:26:57.990] Scheduling timer "check-buildbucket-build-status" (webrtc/Mac64 Release:9056513379869838160:2:0) after 1m0s
[18:27:58.228] Handling timer "check-buildbucket-build-status" (webrtc/Mac64 Release:9056513379869838160:2:0)
[18:27:58.228] Timer tick, asking Buildbucket for the build status
[18:27:58.345] Build 8891083317522474400: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[18:27:58.346] Scheduling timer "check-buildbucket-build-status" (webrtc/Mac64 Release:9056513379869838160:3:0) after 1m0s
[18:28:58.481] Handling timer "check-buildbucket-build-status" (webrtc/Mac64 Release:9056513379869838160:3:0)
[18:28:58.481] Timer tick, asking Buildbucket for the build status
[18:28:58.640] Build 8891083317522474400: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[18:28:58.640] Scheduling timer "check-buildbucket-build-status" (webrtc/Mac64 Release:9056513379869838160:4:0) after 1m0s
[18:29:58.845] Handling timer "check-buildbucket-build-status" (webrtc/Mac64 Release:9056513379869838160:4:0)
[18:29:58.845] Timer tick, asking Buildbucket for the build status
[18:29:58.998] Build 8891083317522474400: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[18:29:58.998] Scheduling timer "check-buildbucket-build-status" (webrtc/Mac64 Release:9056513379869838160:5:0) after 1m0s
[18:30:59.127] Handling timer "check-buildbucket-build-status" (webrtc/Mac64 Release:9056513379869838160:5:0)
[18:30:59.127] Timer tick, asking Buildbucket for the build status
[18:30:59.214] Build 8891083317522474400: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[18:30:59.214] Scheduling timer "check-buildbucket-build-status" (webrtc/Mac64 Release:9056513379869838160:6:0) after 1m0s
[18:31:59.322] Handling timer "check-buildbucket-build-status" (webrtc/Mac64 Release:9056513379869838160:6:0)
[18:31:59.322] Timer tick, asking Buildbucket for the build status
[18:31:59.515] Build 8891083317522474400: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[18:31:59.515] Scheduling timer "check-buildbucket-build-status" (webrtc/Mac64 Release:9056513379869838160:7:0) after 1m0s
[18:32:59.537] Handling timer "check-buildbucket-build-status" (webrtc/Mac64 Release:9056513379869838160:7:0)
[18:32:59.537] Timer tick, asking Buildbucket for the build status
[18:32:59.669] Build 8891083317522474400: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[18:32:59.669] Scheduling timer "check-buildbucket-build-status" (webrtc/Mac64 Release:9056513379869838160:8:0) after 1m0s
[18:33:59.802] Handling timer "check-buildbucket-build-status" (webrtc/Mac64 Release:9056513379869838160:8:0)
[18:33:59.802] Timer tick, asking Buildbucket for the build status
[18:33:59.988] Build 8891083317522474400: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[18:33:59.988] Scheduling timer "check-buildbucket-build-status" (webrtc/Mac64 Release:9056513379869838160:9:0) after 1m0s
[18:35:00.023] Handling timer "check-buildbucket-build-status" (webrtc/Mac64 Release:9056513379869838160:9:0)
[18:35:00.023] Timer tick, asking Buildbucket for the build status
[18:35:00.264] Build 8891083317522474400: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[18:35:00.264] Scheduling timer "check-buildbucket-build-status" (webrtc/Mac64 Release:9056513379869838160:10:0) after 1m0s
[18:36:00.380] Handling timer "check-buildbucket-build-status" (webrtc/Mac64 Release:9056513379869838160:10:0)
[18:36:00.380] Timer tick, asking Buildbucket for the build status
[18:36:00.506] Build 8891083317522474400: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[18:36:00.506] Scheduling timer "check-buildbucket-build-status" (webrtc/Mac64 Release:9056513379869838160:11:0) after 1m0s
[18:37:00.556] Handling timer "check-buildbucket-build-status" (webrtc/Mac64 Release:9056513379869838160:11:0)
[18:37:00.556] Timer tick, asking Buildbucket for the build status
[18:37:00.739] Build 8891083317522474400: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[18:37:00.739] Scheduling timer "check-buildbucket-build-status" (webrtc/Mac64 Release:9056513379869838160:12:0) after 1m0s
[18:38:00.778] Handling timer "check-buildbucket-build-status" (webrtc/Mac64 Release:9056513379869838160:12:0)
[18:38:00.779] Timer tick, asking Buildbucket for the build status
[18:38:01.115] Build 8891083317522474400: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[18:38:01.115] Scheduling timer "check-buildbucket-build-status" (webrtc/Mac64 Release:9056513379869838160:13:0) after 1m0s
[18:39:01.192] Handling timer "check-buildbucket-build-status" (webrtc/Mac64 Release:9056513379869838160:13:0)
[18:39:01.192] Timer tick, asking Buildbucket for the build status
[18:39:01.795] Build 8891083317522474400: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[18:39:01.795] Scheduling timer "check-buildbucket-build-status" (webrtc/Mac64 Release:9056513379869838160:14:0) after 1m0s
[18:39:16.140] Received PubSub notification, asking Buildbucket for the build status
[18:39:16.230] Build 8891083317522474400: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:40:01.829] Handling timer "check-buildbucket-build-status" (webrtc/Mac64 Release:9056513379869838160:14:0)
[18:40:01.829] Timer tick, asking Buildbucket for the build status
[18:40:01.977] Build 8891083317522474400: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:40:01.977] Scheduling timer "check-buildbucket-build-status" (webrtc/Mac64 Release:9056513379869838160:16:0) after 1m0s
[18:41:02.068] Handling timer "check-buildbucket-build-status" (webrtc/Mac64 Release:9056513379869838160:16:0)
[18:41:02.068] Timer tick, asking Buildbucket for the build status
[18:41:02.214] Build 8891083317522474400: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:41:02.214] Scheduling timer "check-buildbucket-build-status" (webrtc/Mac64 Release:9056513379869838160:17:0) after 1m0s
[18:42:02.347] Handling timer "check-buildbucket-build-status" (webrtc/Mac64 Release:9056513379869838160:17:0)
[18:42:02.347] Timer tick, asking Buildbucket for the build status
[18:42:02.768] Build 8891083317522474400: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:42:02.768] Scheduling timer "check-buildbucket-build-status" (webrtc/Mac64 Release:9056513379869838160:18:0) after 1m0s
[18:43:02.848] Handling timer "check-buildbucket-build-status" (webrtc/Mac64 Release:9056513379869838160:18:0)
[18:43:02.848] Timer tick, asking Buildbucket for the build status
[18:43:03.380] Build 8891083317522474400: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:43:03.380] Scheduling timer "check-buildbucket-build-status" (webrtc/Mac64 Release:9056513379869838160:19:0) after 1m0s
[18:44:03.424] Handling timer "check-buildbucket-build-status" (webrtc/Mac64 Release:9056513379869838160:19:0)
[18:44:03.424] Timer tick, asking Buildbucket for the build status
[18:44:04.887] Build 8891083317522474400: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:44:04.887] Scheduling timer "check-buildbucket-build-status" (webrtc/Mac64 Release:9056513379869838160:20:0) after 1m0s
[18:45:04.909] Handling timer "check-buildbucket-build-status" (webrtc/Mac64 Release:9056513379869838160:20:0)
[18:45:04.909] Timer tick, asking Buildbucket for the build status
[18:45:05.034] Build 8891083317522474400: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:45:05.034] Scheduling timer "check-buildbucket-build-status" (webrtc/Mac64 Release:9056513379869838160:21:0) after 1m0s
[18:46:05.077] Handling timer "check-buildbucket-build-status" (webrtc/Mac64 Release:9056513379869838160:21:0)
[18:46:05.077] Timer tick, asking Buildbucket for the build status
[18:46:05.235] Build 8891083317522474400: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:46:05.235] Scheduling timer "check-buildbucket-build-status" (webrtc/Mac64 Release:9056513379869838160:22:0) after 1m0s
[18:46:25.549] Received PubSub notification, asking Buildbucket for the build status
[18:46:25.657] Build 8891083317522474400: status "COMPLETED", result "SUCCESS", failure_reason "", cancelation_reason ""
[18:46:25.657] Buildbucket build:
{
"build": {
"bucket": "luci.webrtc.ci",
"canary_preference": "PROD",
"completed_ts": "1579200384877139",
"created_by": "project:webrtc",
"created_ts": "1579199217258340",
"id": "8891083317522474400",
"parameters_json": "{\"builder_name\": \"Mac64 Release\", \"properties\": {\"$recipe_engine/scheduler\": {\"hostname\": \"luci-scheduler.appspot.com\", \"triggers\": [{\"gitiles\": {\"ref\": \"refs/heads/master\", \"repo\": \"https://webrtc.googlesource.com/src\", \"revision\": \"2a11b2451a4068746fa0c55fa210efd4a15e4423\"}, \"id\": \"https://webrtc.googlesource.com/src/+/refs/heads/master@2a11b2451a4068746fa0c55fa210efd4a15e4423\", \"title\": \"2a11b2451a4068746fa0c55fa210efd4a15e4423\", \"url\": \"https://webrtc.googlesource.com/src/+/2a11b2451a4068746fa0c55fa210efd4a15e4423\"}]}, \"branch\": \"refs/heads/master\", \"repository\": \"https://webrtc.googlesource.com/src\", \"revision\": \"2a11b2451a4068746fa0c55fa210efd4a15e4423\"}}",
"project": "webrtc",
"result": "SUCCESS",
"result_details_json": "{\"properties\": {\"$build/goma\": {\"rpc_extra_params\": \"?prod\", \"server_host\": \"goma.chromium.org\"}, \"$recipe_engine/path\": {\"cache_dir\": \"/b/s/w/ir/cache\", \"temp_dir\": \"/b/s/w/ir/tmp/rt\"}, \"$recipe_engine/runtime\": {\"is_experimental\": false, \"is_luci\": true}, \"$recipe_engine/scheduler\": {\"hostname\": \"luci-scheduler.appspot.com\", \"triggers\": [{\"gitiles\": {\"ref\": \"refs/heads/master\", \"repo\": \"https://webrtc.googlesource.com/src\", \"revision\": \"2a11b2451a4068746fa0c55fa210efd4a15e4423\"}, \"id\": \"https://webrtc.googlesource.com/src/+/refs/heads/master@2a11b2451a4068746fa0c55fa210efd4a15e4423\", \"title\": \"2a11b2451a4068746fa0c55fa210efd4a15e4423\", \"url\": \"https://webrtc.googlesource.com/src/+/2a11b2451a4068746fa0c55fa210efd4a15e4423\"}]}, \"bot_id\": \"build141-m9\", \"branch\": \"refs/heads/master\", \"buildername\": \"Mac64 Release\", \"buildnumber\": 23285, \"got_clang_revision\": \"n332890-c2443155-1\", \"got_revision\": \"2a11b2451a4068746fa0c55fa210efd4a15e4423\", \"got_revision_cp\": \"refs/heads/master@{#30286}\", \"isolate_server\": \"https://isolateserver.appspot.com\", \"mastername\": \"client.webrtc\", \"path_config\": \"generic\", \"recipe\": \"webrtc/standalone\", \"repository\": \"https://webrtc.googlesource.com/src\", \"revision\": \"2a11b2451a4068746fa0c55fa210efd4a15e4423\", \"swarm_hashes\": {\"audio_decoder_unittests\": \"f22eee4fedceff0ff42948e70f211a9036f7c3cf\", \"common_audio_unittests\": \"beb955e66fb02830c496e634d6e5e1fec768eac8\", \"common_video_unittests\": \"502fda412b757bf77544a6fb5d3d02bbea95d009\", \"low_bandwidth_audio_test\": \"dc3e2fbc0a26ecfbecb2d989fc345fe574c68689\", \"modules_tests\": \"7ac1dfd773983ab6ab19efb2de650fda0c307fb5\", \"modules_unittests\": \"5e456cb129fab5219f78b3a02c97b1e049263f9d\", \"peerconnection_unittests\": \"c5adcca2b63f56d47e4ca3cbcaf0490724f4e74e\", \"rtc_media_unittests\": \"d063db270cf55ee99ed3838b0054bd31af710855\", \"rtc_pc_unittests\": \"2a47c18bb3bcb8897f3d21e348ac2e7bd145b9f9\", \"rtc_stats_unittests\": \"3e82d03b218f9f1f51620aac120ba0c96a7d8d61\", \"rtc_unittests\": \"d3f313c44be5faa45edd623e74588f9590b0196a\", \"slow_tests\": \"b378082281d777647cc2b24ea19673a156b3550f\", \"system_wrappers_unittests\": \"dfe73231e492ce0e8fe4b319f223723c32f93d34\", \"test_support_unittests\": \"80c08c86862c3caeedb4d2baee97968828890533\", \"tools_unittests\": \"e2fee81e1ef42d073f2217f9ea16aeee95872d6e\", \"video_capture_tests\": \"36ccd95ecbc8686ca44f0a7f65e86067aa46454f\", \"video_engine_tests\": \"360f570bd2b30710f0078d99b03c7ac8aa823ec4\", \"webrtc_nonparallel_tests\": \"7fba37dfef52e52b6af66abf7dda8ba178cd4a2a\"}}, \"swarming\": {\"bot_dimensions\": {\"caches\": [\"builder_059806cb76369fad874f65dcf15d9fac8b85f8aaa2bcc21181e3047888c9f722_v2\", \"builder_061ad2c84e63fc0fec4b05c132093ef9b6ab75b59928be3b662c8e2e0a6344fd_v2\", \"builder_08dcb1b73883f7e211b0b3bd789c28dc0ecd4dbbececafe484581157878e0b74_v2\", \"builder_159efc1d4e07f83357b1af150b22b5735146a4a38107e0dc728b750b9a5ddd95_v2\", \"builder_2187023a95b72a4c85b14150e8627786d4d0f124144eef86bf927816a2830941_v2\", \"builder_3d12c2f33c8b539e7425f6bc13584a1590c81aeb2114d2a2ac69b6615cd68c43_v2\", \"builder_43f7e9f5ae24b6ee3ca22209fec6b34c1a00e60d041ce7cae040782e455433aa_v2\", \"builder_5be86841ba1a2fffbf39b2203b40a6ecce8d6cb8ff7379bf32e5204ecbef59b2_v2\", \"builder_8a2278e97eb38544b82301aee383e0f90c5414a7b11d57b8f9ae783a4faf492d_v2\", \"builder_af73c5fcdc7c8d0d83ff5fdfb91effdc54af69c7f411ef9f3eba46b34978fd88_v2\", \"builder_d425412af15739f7858c3ec48c0cf46fd8a190c41fc9a14b966839c948b4f9be_v2\", \"git\", \"goma_v2\", \"osx_sdk\", \"vpython\"], \"cores\": [\"4\"], \"cpu\": [\"x86\", \"x86-64\", \"x86-64-i7-4578U\"], \"gce\": [\"0\"], \"gpu\": [\"8086\", \"8086:0a2e\"], \"hidpi\": [\"0\"], \"id\": [\"build141-m9\"], \"mac_model\": [\"Macmini7,1\"], \"machine_type\": [\"n1-standard-4\"], \"os\": [\"Mac\", \"Mac-10.13\", \"Mac-10.13.6\"], \"pool\": [\"luci.webrtc.ci\"], \"python\": [\"2.7.10\"], \"server_version\": [\"4760-d9a0e6d\"], \"ssd\": [\"1\"], \"zone\": [\"us\", \"us-atl\", \"us-atl-golo\", \"us-atl-golo-m9\"]}}}",
"service_account": "webrtc-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"started_ts": "1579199955036227",
"status": "COMPLETED",
"status_changed_ts": "1579200385245511",
"tags": [
"build_address:luci.webrtc.ci/Mac64 Release/23285",
"builder:Mac64 Release",
"buildset:commit/git/2a11b2451a4068746fa0c55fa210efd4a15e4423",
"buildset:commit/gitiles/webrtc.googlesource.com/src/+/2a11b2451a4068746fa0c55fa210efd4a15e4423",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9056513379869838160",
"scheduler_job_id:webrtc/Mac64 Release",
"swarming_hostname:chromium-swarm.appspot.com",
"swarming_tag:log_location:logdog://logs.chromium.org/webrtc/buildbucket/cr-buildbucket.appspot.com/8891083317522474400/+/annotations",
"swarming_tag:luci_project:webrtc",
"swarming_tag:os:Mac",
"swarming_tag:recipe_name:webrtc/standalone",
"swarming_tag:recipe_package:infra/recipe_bundles/chromium.googlesource.com/chromium/tools/build",
"swarming_task_id:49c86d4a3f15d610",
"user_agent:luci-scheduler"
],
"updated_ts": "1579200385255238",
"url": "https://ci.chromium.org/b/8891083317522474400",
"utcnow_ts": "1579200385643534"
}
}
[18:46:25.657] Invocation finished in 19m30.020598214s with status SUCCEEDED