[22:46:04.498] New invocation is queued and will start shortly
[22:46:05.569] Starting the invocation (attempt 1)
[22:46:05.616] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[22:46:05.616] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[22:46:05.616] Buildbucket request:
{
"bucket": "luci.webrtc.ci",
"client_operation_id": "9017993365002555152",
"parameters_json": "{\"builder_name\":\"Linux64 Debug\",\"properties\":{\"$recipe_engine/scheduler\":{\"hostname\":\"luci-scheduler.appspot.com\",\"triggers\":[{\"gitiles\":{\"ref\":\"refs/heads/master\",\"repo\":\"https://webrtc.googlesource.com/src\",\"revision\":\"861a0d1244678db1d5c269f15c36570865101e09\"},\"id\":\"https://webrtc.googlesource.com/src/+/refs/heads/master@861a0d1244678db1d5c269f15c36570865101e09\",\"title\":\"861a0d1244678db1d5c269f15c36570865101e09\",\"url\":\"https://webrtc.googlesource.com/src/+/861a0d1244678db1d5c269f15c36570865101e09\"}]},\"branch\":\"refs/heads/master\",\"repository\":\"https://webrtc.googlesource.com/src\",\"revision\":\"861a0d1244678db1d5c269f15c36570865101e09\"}}",
"pubsub_callback": {
"auth_token": "...",
"topic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
},
"tags": [
"builder:Linux64 Debug",
"scheduler_invocation_id:9017993365002555152",
"scheduler_job_id:webrtc/Linux64 Debug",
"user_agent:luci-scheduler",
"buildset:commit/git/861a0d1244678db1d5c269f15c36570865101e09",
"buildset:commit/gitiles/webrtc.googlesource.com/src/+/861a0d1244678db1d5c269f15c36570865101e09",
"gitiles_ref:refs/heads/master"
]
}
[22:46:07.020] Buildbucket response:
{
"build": {
"bucket": "luci.webrtc.ci",
"canary_preference": "PROD",
"created_by": "project:webrtc",
"created_ts": "1615934765866481",
"id": "8852563302905575808",
"parameters_json": "{\"builder_name\": \"Linux64 Debug\", \"properties\": {\"$recipe_engine/scheduler\": {\"hostname\": \"luci-scheduler.appspot.com\", \"triggers\": [{\"gitiles\": {\"ref\": \"refs/heads/master\", \"repo\": \"https://webrtc.googlesource.com/src\", \"revision\": \"861a0d1244678db1d5c269f15c36570865101e09\"}, \"id\": \"https://webrtc.googlesource.com/src/+/refs/heads/master@861a0d1244678db1d5c269f15c36570865101e09\", \"title\": \"861a0d1244678db1d5c269f15c36570865101e09\", \"url\": \"https://webrtc.googlesource.com/src/+/861a0d1244678db1d5c269f15c36570865101e09\"}]}, \"branch\": \"refs/heads/master\", \"repository\": \"https://webrtc.googlesource.com/src\", \"revision\": \"861a0d1244678db1d5c269f15c36570865101e09\"}}",
"project": "webrtc",
"result_details_json": "{\"properties\": {}}",
"service_account": "webrtc-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"status": "SCHEDULED",
"status_changed_ts": "1615934766815839",
"tags": [
"build_address:luci.webrtc.ci/Linux64 Debug/27670",
"builder:Linux64 Debug",
"buildset:commit/git/861a0d1244678db1d5c269f15c36570865101e09",
"buildset:commit/gitiles/webrtc.googlesource.com/src/+/861a0d1244678db1d5c269f15c36570865101e09",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9017993365002555152",
"scheduler_job_id:webrtc/Linux64 Debug",
"swarming_hostname:chromium-swarm.appspot.com",
"swarming_tag:log_location:logdog://logs.chromium.org/webrtc/buildbucket/cr-buildbucket.appspot.com/8852563302905575808/+/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": "1615934766816028",
"url": "https://ci.chromium.org/b/8852563302905575808",
"utcnow_ts": "1615934767008841"
}
}
[22:46:07.020] Task URL: https://ci.chromium.org/b/8852563302905575808
[22:46:07.020] Scheduling timer "check-buildbucket-build-status" (webrtc/Linux64 Debug:9017993365002555152:2:0) after 1m0s
[22:46:50.350] Received PubSub notification, asking Buildbucket for the build status
[22:46:50.789] Build 8852563302905575808: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:47:07.357] Handling timer "check-buildbucket-build-status" (webrtc/Linux64 Debug:9017993365002555152:2:0)
[22:47:07.357] Timer tick, asking Buildbucket for the build status
[22:47:07.416] Build 8852563302905575808: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:47:07.416] Scheduling timer "check-buildbucket-build-status" (webrtc/Linux64 Debug:9017993365002555152:4:0) after 1m0s
[22:48:07.480] Handling timer "check-buildbucket-build-status" (webrtc/Linux64 Debug:9017993365002555152:4:0)
[22:48:07.480] Timer tick, asking Buildbucket for the build status
[22:48:07.813] Build 8852563302905575808: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:48:07.813] Scheduling timer "check-buildbucket-build-status" (webrtc/Linux64 Debug:9017993365002555152:5:0) after 1m0s
[22:49:08.121] Handling timer "check-buildbucket-build-status" (webrtc/Linux64 Debug:9017993365002555152:5:0)
[22:49:08.121] Timer tick, asking Buildbucket for the build status
[22:49:08.331] Build 8852563302905575808: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:49:08.331] Scheduling timer "check-buildbucket-build-status" (webrtc/Linux64 Debug:9017993365002555152:6:0) after 1m0s
[22:50:08.447] Handling timer "check-buildbucket-build-status" (webrtc/Linux64 Debug:9017993365002555152:6:0)
[22:50:08.447] Timer tick, asking Buildbucket for the build status
[22:50:08.529] Build 8852563302905575808: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:50:08.529] Scheduling timer "check-buildbucket-build-status" (webrtc/Linux64 Debug:9017993365002555152:7:0) after 1m0s
[22:51:08.593] Handling timer "check-buildbucket-build-status" (webrtc/Linux64 Debug:9017993365002555152:7:0)
[22:51:08.593] Timer tick, asking Buildbucket for the build status
[22:51:08.923] Build 8852563302905575808: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:51:08.923] Scheduling timer "check-buildbucket-build-status" (webrtc/Linux64 Debug:9017993365002555152:8:0) after 1m0s
[22:52:09.001] Handling timer "check-buildbucket-build-status" (webrtc/Linux64 Debug:9017993365002555152:8:0)
[22:52:09.001] Timer tick, asking Buildbucket for the build status
[22:52:09.346] Build 8852563302905575808: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:52:09.346] Scheduling timer "check-buildbucket-build-status" (webrtc/Linux64 Debug:9017993365002555152:9:0) after 1m0s
[22:53:09.361] Handling timer "check-buildbucket-build-status" (webrtc/Linux64 Debug:9017993365002555152:9:0)
[22:53:09.361] Timer tick, asking Buildbucket for the build status
[22:53:09.490] Build 8852563302905575808: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:53:09.490] Scheduling timer "check-buildbucket-build-status" (webrtc/Linux64 Debug:9017993365002555152:10:0) after 1m0s
[22:54:09.566] Handling timer "check-buildbucket-build-status" (webrtc/Linux64 Debug:9017993365002555152:10:0)
[22:54:09.566] Timer tick, asking Buildbucket for the build status
[22:54:09.642] Build 8852563302905575808: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:54:09.642] Scheduling timer "check-buildbucket-build-status" (webrtc/Linux64 Debug:9017993365002555152:11:0) after 1m0s
[22:55:09.689] Handling timer "check-buildbucket-build-status" (webrtc/Linux64 Debug:9017993365002555152:11:0)
[22:55:09.689] Timer tick, asking Buildbucket for the build status
[22:55:09.779] Build 8852563302905575808: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:55:09.779] Scheduling timer "check-buildbucket-build-status" (webrtc/Linux64 Debug:9017993365002555152:12:0) after 1m0s
[22:56:09.774] Handling timer "check-buildbucket-build-status" (webrtc/Linux64 Debug:9017993365002555152:12:0)
[22:56:09.774] Timer tick, asking Buildbucket for the build status
[22:56:09.902] Build 8852563302905575808: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:56:09.902] Scheduling timer "check-buildbucket-build-status" (webrtc/Linux64 Debug:9017993365002555152:13:0) after 1m0s
[22:57:09.935] Handling timer "check-buildbucket-build-status" (webrtc/Linux64 Debug:9017993365002555152:13:0)
[22:57:09.935] Timer tick, asking Buildbucket for the build status
[22:57:10.154] Build 8852563302905575808: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:57:10.154] Scheduling timer "check-buildbucket-build-status" (webrtc/Linux64 Debug:9017993365002555152:14:0) after 1m0s
[22:58:10.193] Handling timer "check-buildbucket-build-status" (webrtc/Linux64 Debug:9017993365002555152:14:0)
[22:58:10.193] Timer tick, asking Buildbucket for the build status
[22:58:10.258] Build 8852563302905575808: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:58:10.258] Scheduling timer "check-buildbucket-build-status" (webrtc/Linux64 Debug:9017993365002555152:15:0) after 1m0s
[22:59:10.276] Handling timer "check-buildbucket-build-status" (webrtc/Linux64 Debug:9017993365002555152:15:0)
[22:59:10.276] Timer tick, asking Buildbucket for the build status
[22:59:10.348] Build 8852563302905575808: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:59:10.348] Scheduling timer "check-buildbucket-build-status" (webrtc/Linux64 Debug:9017993365002555152:16:0) after 1m0s
[23:00:10.379] Handling timer "check-buildbucket-build-status" (webrtc/Linux64 Debug:9017993365002555152:16:0)
[23:00:10.379] Timer tick, asking Buildbucket for the build status
[23:00:10.490] Build 8852563302905575808: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:00:10.490] Scheduling timer "check-buildbucket-build-status" (webrtc/Linux64 Debug:9017993365002555152:17:0) after 1m0s
[23:01:05.750] Received PubSub notification, asking Buildbucket for the build status
[23:01:05.821] Build 8852563302905575808: status "COMPLETED", result "SUCCESS", failure_reason "", cancelation_reason ""
[23:01:05.821] Buildbucket build:
{
"build": {
"bucket": "luci.webrtc.ci",
"canary_preference": "PROD",
"completed_ts": "1615935664693126",
"created_by": "project:webrtc",
"created_ts": "1615934765866481",
"id": "8852563302905575808",
"parameters_json": "{\"builder_name\": \"Linux64 Debug\", \"properties\": {\"$recipe_engine/scheduler\": {\"hostname\": \"luci-scheduler.appspot.com\", \"triggers\": [{\"gitiles\": {\"ref\": \"refs/heads/master\", \"repo\": \"https://webrtc.googlesource.com/src\", \"revision\": \"861a0d1244678db1d5c269f15c36570865101e09\"}, \"id\": \"https://webrtc.googlesource.com/src/+/refs/heads/master@861a0d1244678db1d5c269f15c36570865101e09\", \"title\": \"861a0d1244678db1d5c269f15c36570865101e09\", \"url\": \"https://webrtc.googlesource.com/src/+/861a0d1244678db1d5c269f15c36570865101e09\"}]}, \"branch\": \"refs/heads/master\", \"repository\": \"https://webrtc.googlesource.com/src\", \"revision\": \"861a0d1244678db1d5c269f15c36570865101e09\"}}",
"project": "webrtc",
"result": "SUCCESS",
"result_details_json": "{\"properties\": {\"$build/goma\": {\"server_host\": \"goma.chromium.org\", \"use_luci_auth\": true}, \"$recipe_engine/isolated\": {\"server\": \"https://isolateserver.appspot.com\"}, \"$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\": \"861a0d1244678db1d5c269f15c36570865101e09\"}, \"id\": \"https://webrtc.googlesource.com/src/+/refs/heads/master@861a0d1244678db1d5c269f15c36570865101e09\", \"title\": \"861a0d1244678db1d5c269f15c36570865101e09\", \"url\": \"https://webrtc.googlesource.com/src/+/861a0d1244678db1d5c269f15c36570865101e09\"}]}, \"bot_id\": \"luci-webrtc-ci-xenial-1-krc0\", \"branch\": \"refs/heads/master\", \"builder_group\": \"client.webrtc\", \"buildername\": \"Linux64 Debug\", \"buildnumber\": 27670, \"got_revision\": \"861a0d1244678db1d5c269f15c36570865101e09\", \"got_revision_cp\": \"refs/heads/master@{#33484}\", \"isolate_server\": \"https://isolateserver.appspot.com\", \"path_config\": \"generic\", \"recipe\": \"webrtc/standalone\", \"repository\": \"https://webrtc.googlesource.com/src\", \"revision\": \"861a0d1244678db1d5c269f15c36570865101e09\", \"swarm_hashes\": {\"audio_decoder_unittests\": \"00d3f27e1553512388f912f16f8c21863650672fcb53fc5f88ad15ec698cd111/495\", \"common_audio_unittests\": \"4e46d8468bcd683b2d78aa6a2323ea757962b91a492676a92073ee172e8be8bc/412\", \"common_video_unittests\": \"a926d7c0ddd4c6b5c3f34127f9e42f8790cc48eb141c96c95172ae95a931edda/495\", \"low_bandwidth_audio_test\": \"5501e4c5cd80b216082c61c0cd47a29fb5a90a56b33dff614a4de96489f6ffc6/495\", \"modules_tests\": \"c69ab5f797cf5dd3e793e5a1cf3d752b394c6b70523c030901b2f3cdebd1688e/496\", \"modules_unittests\": \"1ff34a69a66bb298120f37d22ca07ab5478f5e634000df7a3f39138891f2ca78/497\", \"peerconnection_unittests\": \"f3377ea1d9fff8009a65e66880d6a29ec59a9a7f60e775f177e8ad5e1bff1288/496\", \"rtc_media_unittests\": \"6e9e9e65933f7f37a7cc1e08a6700f4cb497da5b9661fead4d34611ca8c729e1/495\", \"rtc_pc_unittests\": \"72c1f75c6407ba71a8aae87454ac66b5fb3ed75d4cf2e7887b45d0f7e2cc56a1/412\", \"rtc_stats_unittests\": \"e838fcb40e07fb4af5da5d0b86c8b0a8205664930c2fd7afad2ba52d2eef1466/412\", \"rtc_unittests\": \"4a73a40f3ea41353386fa70b0cdc2d18f74936ca1c72b50e26508b92be1ffe28/412\", \"slow_tests\": \"5376d2cf3e633e1ee28dfaea6593279146f89044da4e85f804e94629e69315c9/412\", \"system_wrappers_unittests\": \"e7b6977870eba79dffc3c54b35f182a801487553601724e7e56b3722630bdae9/412\", \"test_support_unittests\": \"19d6d4583845e8098aedd869307b6e763e2ee52716bdde2519f2cd34ebbd1fde/496\", \"tools_unittests\": \"b21318814d2ff7d30af1277f1fd74dd3c6d274154dd26c64d76242ad2b1e6fd0/496\", \"video_engine_tests\": \"a7c25be6abf42ae59125b8de5a1a32f892c3a406120a1931dc251182df688894/496\", \"voip_unittests\": \"83d3e3c9fb1a5318cc7ed3dfd1259386976a0eb3a85fd8855c31862c1cc476c8/412\", \"webrtc_nonparallel_tests\": \"a879a8ce71b3516bea5280554478466c33f4670fc15ec604027a063076db7c36/412\"}}, \"swarming\": {\"bot_dimensions\": {\"caches\": [\"builder_d8087e4e6918034fd84666cddd7a396a0a7b057decc19643f05e08f84b97a27e_v2\", \"git\", \"goma_v2\", \"vpython\"], \"cores\": [\"8\"], \"cpu\": [\"x86\", \"x86-64\", \"x86-64-Haswell_GCE\", \"x86-64-avx2\"], \"gce\": [\"1\"], \"gcp\": [\"webrtc-ci\"], \"gpu\": [\"none\"], \"id\": [\"luci-webrtc-ci-xenial-1-krc0\"], \"image\": [\"chrome-xenial-21011100-9488e34e558\"], \"inside_docker\": [\"0\"], \"kvm\": [\"1\"], \"locale\": [\"en_US.UTF-8\"], \"machine_type\": [\"e2-standard-8\"], \"os\": [\"Linux\", \"Ubuntu\", \"Ubuntu-16\", \"Ubuntu-16.04\", \"Ubuntu-16.04.6\"], \"pool\": [\"luci.webrtc.ci\"], \"python\": [\"2.7.12\"], \"server_version\": [\"5754-8c4f760\"], \"ssd\": [\"0\"], \"zone\": [\"us\", \"us-central\", \"us-central1\", \"us-central1-b\"]}}}",
"service_account": "webrtc-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"started_ts": "1615934809323171",
"status": "COMPLETED",
"status_changed_ts": "1615935665096201",
"tags": [
"build_address:luci.webrtc.ci/Linux64 Debug/27670",
"builder:Linux64 Debug",
"buildset:commit/git/861a0d1244678db1d5c269f15c36570865101e09",
"buildset:commit/gitiles/webrtc.googlesource.com/src/+/861a0d1244678db1d5c269f15c36570865101e09",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9017993365002555152",
"scheduler_job_id:webrtc/Linux64 Debug",
"swarming_hostname:chromium-swarm.appspot.com",
"swarming_tag:log_location:logdog://logs.chromium.org/webrtc/buildbucket/cr-buildbucket.appspot.com/8852563302905575808/+/annotations",
"swarming_tag:luci_project:webrtc",
"swarming_tag:os:Linux",
"swarming_tag:recipe_name:webrtc/standalone",
"swarming_tag:recipe_package:infra/recipe_bundles/chromium.googlesource.com/chromium/tools/build",
"swarming_task_id:5256094f2c9e1210",
"user_agent:luci-scheduler"
],
"updated_ts": "1615935665108132",
"url": "https://ci.chromium.org/b/8852563302905575808",
"utcnow_ts": "1615935665814391"
}
}
[23:01:05.821] Invocation finished in 15m1.33815653s with status SUCCEEDED