[14:12:58.919] New invocation is queued and will start shortly
[14:13:00.308] Starting the invocation (attempt 1)
[14:13:00.347] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[14:13:00.348] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[14:13:00.348] Buildbucket request:
{
"bucket": "luci.webrtc.ci",
"client_operation_id": "9017753855121639904",
"parameters_json": "{\"builder_name\":\"Linux32 Debug\",\"properties\":{\"$recipe_engine/scheduler\":{\"hostname\":\"luci-scheduler.appspot.com\",\"triggers\":[{\"gitiles\":{\"ref\":\"refs/heads/master\",\"repo\":\"https://webrtc.googlesource.com/src\",\"revision\":\"490c1503d92696894e9c88c2a40a24ed78abe0a8\"},\"id\":\"https://webrtc.googlesource.com/src/+/refs/heads/master@490c1503d92696894e9c88c2a40a24ed78abe0a8\",\"title\":\"490c1503d92696894e9c88c2a40a24ed78abe0a8\",\"url\":\"https://webrtc.googlesource.com/src/+/490c1503d92696894e9c88c2a40a24ed78abe0a8\"}]},\"branch\":\"refs/heads/master\",\"repository\":\"https://webrtc.googlesource.com/src\",\"revision\":\"490c1503d92696894e9c88c2a40a24ed78abe0a8\"}}",
"pubsub_callback": {
"auth_token": "...",
"topic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
},
"tags": [
"builder:Linux32 Debug",
"scheduler_invocation_id:9017753855121639904",
"scheduler_job_id:webrtc/Linux32 Debug",
"user_agent:luci-scheduler",
"buildset:commit/git/490c1503d92696894e9c88c2a40a24ed78abe0a8",
"buildset:commit/gitiles/webrtc.googlesource.com/src/+/490c1503d92696894e9c88c2a40a24ed78abe0a8",
"gitiles_ref:refs/heads/master"
]
}
[14:13:01.514] Buildbucket response:
{
"build": {
"bucket": "luci.webrtc.ci",
"canary_preference": "PROD",
"created_by": "project:webrtc",
"created_ts": "1616163180513405",
"id": "8852323792788342896",
"parameters_json": "{\"builder_name\": \"Linux32 Debug\", \"properties\": {\"$recipe_engine/scheduler\": {\"hostname\": \"luci-scheduler.appspot.com\", \"triggers\": [{\"gitiles\": {\"ref\": \"refs/heads/master\", \"repo\": \"https://webrtc.googlesource.com/src\", \"revision\": \"490c1503d92696894e9c88c2a40a24ed78abe0a8\"}, \"id\": \"https://webrtc.googlesource.com/src/+/refs/heads/master@490c1503d92696894e9c88c2a40a24ed78abe0a8\", \"title\": \"490c1503d92696894e9c88c2a40a24ed78abe0a8\", \"url\": \"https://webrtc.googlesource.com/src/+/490c1503d92696894e9c88c2a40a24ed78abe0a8\"}]}, \"branch\": \"refs/heads/master\", \"repository\": \"https://webrtc.googlesource.com/src\", \"revision\": \"490c1503d92696894e9c88c2a40a24ed78abe0a8\"}}",
"project": "webrtc",
"result_details_json": "{\"properties\": {}}",
"service_account": "webrtc-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"status": "SCHEDULED",
"status_changed_ts": "1616163180851007",
"tags": [
"build_address:luci.webrtc.ci/Linux32 Debug/26676",
"builder:Linux32 Debug",
"buildset:commit/git/490c1503d92696894e9c88c2a40a24ed78abe0a8",
"buildset:commit/gitiles/webrtc.googlesource.com/src/+/490c1503d92696894e9c88c2a40a24ed78abe0a8",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9017753855121639904",
"scheduler_job_id:webrtc/Linux32 Debug",
"swarming_hostname:chromium-swarm.appspot.com",
"swarming_tag:log_location:logdog://logs.chromium.org/webrtc/buildbucket/cr-buildbucket.appspot.com/8852323792788342896/+/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": "1616163180851125",
"url": "https://ci.chromium.org/b/8852323792788342896",
"utcnow_ts": "1616163181503097"
}
}
[14:13:01.514] Task URL: https://ci.chromium.org/b/8852323792788342896
[14:13:01.514] Scheduling timer "check-buildbucket-build-status" (webrtc/Linux32 Debug:9017753855121639904:2:0) after 1m0s
[14:13:51.964] Received PubSub notification, asking Buildbucket for the build status
[14:13:52.318] Build 8852323792788342896: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:14:01.846] Handling timer "check-buildbucket-build-status" (webrtc/Linux32 Debug:9017753855121639904:2:0)
[14:14:01.846] Timer tick, asking Buildbucket for the build status
[14:14:01.928] Build 8852323792788342896: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:14:01.928] Scheduling timer "check-buildbucket-build-status" (webrtc/Linux32 Debug:9017753855121639904:4:0) after 1m0s
[14:15:02.135] Handling timer "check-buildbucket-build-status" (webrtc/Linux32 Debug:9017753855121639904:4:0)
[14:15:02.135] Timer tick, asking Buildbucket for the build status
[14:15:02.207] Build 8852323792788342896: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:15:02.207] Scheduling timer "check-buildbucket-build-status" (webrtc/Linux32 Debug:9017753855121639904:5:0) after 1m0s
[14:16:02.404] Handling timer "check-buildbucket-build-status" (webrtc/Linux32 Debug:9017753855121639904:5:0)
[14:16:02.404] Timer tick, asking Buildbucket for the build status
[14:16:02.482] Build 8852323792788342896: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:16:02.482] Scheduling timer "check-buildbucket-build-status" (webrtc/Linux32 Debug:9017753855121639904:6:0) after 1m0s
[14:17:02.671] Handling timer "check-buildbucket-build-status" (webrtc/Linux32 Debug:9017753855121639904:6:0)
[14:17:02.671] Timer tick, asking Buildbucket for the build status
[14:17:03.088] Build 8852323792788342896: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:17:03.088] Scheduling timer "check-buildbucket-build-status" (webrtc/Linux32 Debug:9017753855121639904:7:0) after 1m0s
[14:18:03.114] Handling timer "check-buildbucket-build-status" (webrtc/Linux32 Debug:9017753855121639904:7:0)
[14:18:03.114] Timer tick, asking Buildbucket for the build status
[14:18:03.247] Build 8852323792788342896: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:18:03.247] Scheduling timer "check-buildbucket-build-status" (webrtc/Linux32 Debug:9017753855121639904:8:0) after 1m0s
[14:19:03.271] Handling timer "check-buildbucket-build-status" (webrtc/Linux32 Debug:9017753855121639904:8:0)
[14:19:03.271] Timer tick, asking Buildbucket for the build status
[14:19:03.587] Build 8852323792788342896: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:19:03.587] Scheduling timer "check-buildbucket-build-status" (webrtc/Linux32 Debug:9017753855121639904:9:0) after 1m0s
[14:20:03.631] Handling timer "check-buildbucket-build-status" (webrtc/Linux32 Debug:9017753855121639904:9:0)
[14:20:03.631] Timer tick, asking Buildbucket for the build status
[14:20:03.896] Build 8852323792788342896: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:20:03.896] Scheduling timer "check-buildbucket-build-status" (webrtc/Linux32 Debug:9017753855121639904:10:0) after 1m0s
[14:21:03.946] Handling timer "check-buildbucket-build-status" (webrtc/Linux32 Debug:9017753855121639904:10:0)
[14:21:03.946] Timer tick, asking Buildbucket for the build status
[14:21:04.300] Build 8852323792788342896: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:21:04.300] Scheduling timer "check-buildbucket-build-status" (webrtc/Linux32 Debug:9017753855121639904:11:0) after 1m0s
[14:22:04.415] Handling timer "check-buildbucket-build-status" (webrtc/Linux32 Debug:9017753855121639904:11:0)
[14:22:04.415] Timer tick, asking Buildbucket for the build status
[14:22:04.626] Build 8852323792788342896: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:22:04.626] Scheduling timer "check-buildbucket-build-status" (webrtc/Linux32 Debug:9017753855121639904:12:0) after 1m0s
[14:23:04.679] Handling timer "check-buildbucket-build-status" (webrtc/Linux32 Debug:9017753855121639904:12:0)
[14:23:04.679] Timer tick, asking Buildbucket for the build status
[14:23:04.750] Build 8852323792788342896: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:23:04.750] Scheduling timer "check-buildbucket-build-status" (webrtc/Linux32 Debug:9017753855121639904:13:0) after 1m0s
[14:24:04.926] Handling timer "check-buildbucket-build-status" (webrtc/Linux32 Debug:9017753855121639904:13:0)
[14:24:04.926] Timer tick, asking Buildbucket for the build status
[14:24:05.057] Build 8852323792788342896: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:24:05.057] Scheduling timer "check-buildbucket-build-status" (webrtc/Linux32 Debug:9017753855121639904:14:0) after 1m0s
[14:25:05.102] Handling timer "check-buildbucket-build-status" (webrtc/Linux32 Debug:9017753855121639904:14:0)
[14:25:05.102] Timer tick, asking Buildbucket for the build status
[14:25:05.311] Build 8852323792788342896: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:25:05.311] Scheduling timer "check-buildbucket-build-status" (webrtc/Linux32 Debug:9017753855121639904:15:0) after 1m0s
[14:26:05.402] Handling timer "check-buildbucket-build-status" (webrtc/Linux32 Debug:9017753855121639904:15:0)
[14:26:05.402] Timer tick, asking Buildbucket for the build status
[14:26:05.471] Build 8852323792788342896: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:26:05.471] Scheduling timer "check-buildbucket-build-status" (webrtc/Linux32 Debug:9017753855121639904:16:0) after 1m0s
[14:27:05.671] Handling timer "check-buildbucket-build-status" (webrtc/Linux32 Debug:9017753855121639904:16:0)
[14:27:05.671] Timer tick, asking Buildbucket for the build status
[14:27:05.986] Build 8852323792788342896: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:27:05.986] Scheduling timer "check-buildbucket-build-status" (webrtc/Linux32 Debug:9017753855121639904:17:0) after 1m0s
[14:27:30.422] Received PubSub notification, asking Buildbucket for the build status
[14:27:30.505] Build 8852323792788342896: status "COMPLETED", result "SUCCESS", failure_reason "", cancelation_reason ""
[14:27:30.505] Buildbucket build:
{
"build": {
"bucket": "luci.webrtc.ci",
"canary_preference": "PROD",
"completed_ts": "1616164049424203",
"created_by": "project:webrtc",
"created_ts": "1616163180513405",
"id": "8852323792788342896",
"parameters_json": "{\"builder_name\": \"Linux32 Debug\", \"properties\": {\"$recipe_engine/scheduler\": {\"hostname\": \"luci-scheduler.appspot.com\", \"triggers\": [{\"gitiles\": {\"ref\": \"refs/heads/master\", \"repo\": \"https://webrtc.googlesource.com/src\", \"revision\": \"490c1503d92696894e9c88c2a40a24ed78abe0a8\"}, \"id\": \"https://webrtc.googlesource.com/src/+/refs/heads/master@490c1503d92696894e9c88c2a40a24ed78abe0a8\", \"title\": \"490c1503d92696894e9c88c2a40a24ed78abe0a8\", \"url\": \"https://webrtc.googlesource.com/src/+/490c1503d92696894e9c88c2a40a24ed78abe0a8\"}]}, \"branch\": \"refs/heads/master\", \"repository\": \"https://webrtc.googlesource.com/src\", \"revision\": \"490c1503d92696894e9c88c2a40a24ed78abe0a8\"}}",
"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\": \"490c1503d92696894e9c88c2a40a24ed78abe0a8\"}, \"id\": \"https://webrtc.googlesource.com/src/+/refs/heads/master@490c1503d92696894e9c88c2a40a24ed78abe0a8\", \"title\": \"490c1503d92696894e9c88c2a40a24ed78abe0a8\", \"url\": \"https://webrtc.googlesource.com/src/+/490c1503d92696894e9c88c2a40a24ed78abe0a8\"}]}, \"bot_id\": \"luci-webrtc-ci-xenial-7-mgg9\", \"branch\": \"refs/heads/master\", \"builder_group\": \"client.webrtc\", \"buildername\": \"Linux32 Debug\", \"buildnumber\": 26676, \"got_revision\": \"490c1503d92696894e9c88c2a40a24ed78abe0a8\", \"got_revision_cp\": \"refs/heads/master@{#33510}\", \"isolate_server\": \"https://isolateserver.appspot.com\", \"path_config\": \"generic\", \"recipe\": \"webrtc/standalone\", \"repository\": \"https://webrtc.googlesource.com/src\", \"revision\": \"490c1503d92696894e9c88c2a40a24ed78abe0a8\", \"swarm_hashes\": {\"audio_decoder_unittests\": \"1fbd50897686cfdf26825f69f20dd77dd50eef7786e70a3a1b1a48e7c280d3eb/495\", \"common_audio_unittests\": \"9e6a96deff1e26d6ef71c4f064a85d67f6be79b6cf39743f1f7eb4e0dfae45cb/412\", \"common_video_unittests\": \"c6c137e89161dbd32a066838d110d65d955ec79abd9edcb81f27a976e4b94f4d/495\", \"low_bandwidth_audio_test\": \"90e1d89522d05301972b4162e91860be3152f316e4699ad4ea6bd30b6e75f70f/495\", \"modules_tests\": \"34492a35876839acf0de320f28d5d8db53d18e71f15afc0532f7b9d28c7c4733/496\", \"modules_unittests\": \"41c68e449434ccdd95766764634990eeb7865b190c8e8eb5fc789b3e98b499c8/497\", \"peerconnection_unittests\": \"0ee17e179bf1c8d3e53911ed0814f20319117075a262b6322909e863bc166fd8/496\", \"rtc_media_unittests\": \"73d2822bf19e76b2f7a48ff90aec09452f917cdc5d250fe448a8baecbd7a7d2f/495\", \"rtc_pc_unittests\": \"c760751ba87d0371b1337dc7fc023eab3a24564768df270fdab07a03b024feb3/412\", \"rtc_stats_unittests\": \"a2b9084e001f1758a5974be229b89053d197ef5d53f74781e58b6a5ee66de02e/412\", \"rtc_unittests\": \"41b52db7c95a436eb1658df2783b90b47042ecfc5a237c61da4ade36a0fe6369/412\", \"slow_tests\": \"87104e8154f6322808ce5e86a08cdf7c0b8ebcc3f1f2100582090ade34473ea5/412\", \"system_wrappers_unittests\": \"e47feaf6e9a0fa9d9749f1dccc2c1d7395fd0b15f3e0a600e8ec245511bae5b1/412\", \"test_support_unittests\": \"fa0e32185e60b96a844253b265fe8dfe7b3e89d5401facf3cb4ab4ad598b090a/496\", \"tools_unittests\": \"856c41e400d495f7dd5b0a46cfdd4bc19678fc196090286df61a28853a1ca7ff/496\", \"video_engine_tests\": \"6d6ae6ac3d0785995236ca0a3535f4bb2655b6d96a480eec3c882556fd6f1553/496\", \"voip_unittests\": \"705c836f0520f67710e9d05f5136788fdccb8002e0b66dcab74c95f93d598c4a/412\", \"webrtc_nonparallel_tests\": \"c2b85d78981fde4de2b91a8c4e7122b28b13f3265726220f5c5ddd44af87454f/412\"}}, \"swarming\": {\"bot_dimensions\": {\"caches\": [\"builder_0b9ea9fa64bf0cd9c46059730b1bdd1d12ff6500ce62c56e48fe9cca98bdf248_v2\", \"builder_455888f2f945b3280d12644ca1ffba1d78ccc60e6253093e09b5ed6f38897bd7_v2\", \"builder_a9e857c6f45aeca8cc1388c7c30c9ddfcf1f8acd0c8e85588eec9b6e05b9c136_v2\", \"builder_b6e955e353d7ad729db4d58448beff3ae66bc2502b03a8d5aa67f12ea70e7a83_v2\", \"builder_cdf9911d0fb982b144366a069b820bab2cbe2663c4d5f6cc5be539135cc71a3a_v2\", \"builder_ee30cfe615ad79242c90cf868fc3e32771e3342e63241239745f710a5c60d840_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-7-mgg9\"], \"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\", \"2.7\", \"2.7.12\"], \"server_version\": [\"5776-cb9e157\"], \"ssd\": [\"0\"], \"zone\": [\"us\", \"us-central\", \"us-central1\", \"us-central1-b\"]}}}",
"service_account": "webrtc-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"started_ts": "1616163231140250",
"status": "COMPLETED",
"status_changed_ts": "1616164049940014",
"tags": [
"build_address:luci.webrtc.ci/Linux32 Debug/26676",
"builder:Linux32 Debug",
"buildset:commit/git/490c1503d92696894e9c88c2a40a24ed78abe0a8",
"buildset:commit/gitiles/webrtc.googlesource.com/src/+/490c1503d92696894e9c88c2a40a24ed78abe0a8",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9017753855121639904",
"scheduler_job_id:webrtc/Linux32 Debug",
"swarming_hostname:chromium-swarm.appspot.com",
"swarming_tag:log_location:logdog://logs.chromium.org/webrtc/buildbucket/cr-buildbucket.appspot.com/8852323792788342896/+/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:5263a69c37976210",
"user_agent:luci-scheduler"
],
"updated_ts": "1616164049968044",
"url": "https://ci.chromium.org/b/8852323792788342896",
"utcnow_ts": "1616164050498975"
}
}
[14:27:30.505] Invocation finished in 14m31.600600701s with status SUCCEEDED