[18:28:46.790] New invocation is queued and will start shortly
[18:28:48.498] Starting the invocation (attempt 1)
[18:28:48.535] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[18:28:48.535] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[18:28:48.535] Buildbucket request:
{
"bucket": "luci.webrtc.ci",
"client_operation_id": "9045369836473240688",
"parameters_json": "{\"builder_name\":\"Mac64 Debug\",\"properties\":{\"$recipe_engine/scheduler\":{\"hostname\":\"luci-scheduler.appspot.com\",\"triggers\":[{\"gitiles\":{\"ref\":\"refs/heads/master\",\"repo\":\"https://webrtc.googlesource.com/src\",\"revision\":\"8de900cdcb7ded8f52d6d35b5040b6880d3dda35\"},\"id\":\"https://webrtc.googlesource.com/src/+/refs/heads/master@8de900cdcb7ded8f52d6d35b5040b6880d3dda35\",\"title\":\"8de900cdcb7ded8f52d6d35b5040b6880d3dda35\",\"url\":\"https://webrtc.googlesource.com/src/+/8de900cdcb7ded8f52d6d35b5040b6880d3dda35\"},{\"gitiles\":{\"ref\":\"refs/heads/master\",\"repo\":\"https://webrtc.googlesource.com/src\",\"revision\":\"2af35ab984e3d62ff7abb215dc293fc082de19f6\"},\"id\":\"https://webrtc.googlesource.com/src/+/refs/heads/master@2af35ab984e3d62ff7abb215dc293fc082de19f6\",\"title\":\"2af35ab984e3d62ff7abb215dc293fc082de19f6\",\"url\":\"https://webrtc.googlesource.com/src/+/2af35ab984e3d62ff7abb215dc293fc082de19f6\"}]},\"branch\":\"refs/heads/master\",\"repository\":\"https://webrtc.googlesource.com/src\",\"revision\":\"2af35ab984e3d62ff7abb215dc293fc082de19f6\"}}",
"pubsub_callback": {
"auth_token": "...",
"topic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
},
"tags": [
"builder:Mac64 Debug",
"scheduler_invocation_id:9045369836473240688",
"scheduler_job_id:webrtc/Mac64 Debug",
"user_agent:luci-scheduler",
"buildset:commit/git/2af35ab984e3d62ff7abb215dc293fc082de19f6",
"buildset:commit/gitiles/webrtc.googlesource.com/src/+/2af35ab984e3d62ff7abb215dc293fc082de19f6",
"gitiles_ref:refs/heads/master"
]
}
[18:28:56.912] Buildbucket response:
{
"build": {
"bucket": "luci.webrtc.ci",
"canary_preference": "PROD",
"created_by": "project:webrtc",
"created_ts": "1589826529380923",
"id": "8879939773086688592",
"parameters_json": "{\"builder_name\": \"Mac64 Debug\", \"properties\": {\"$recipe_engine/scheduler\": {\"hostname\": \"luci-scheduler.appspot.com\", \"triggers\": [{\"gitiles\": {\"ref\": \"refs/heads/master\", \"repo\": \"https://webrtc.googlesource.com/src\", \"revision\": \"8de900cdcb7ded8f52d6d35b5040b6880d3dda35\"}, \"id\": \"https://webrtc.googlesource.com/src/+/refs/heads/master@8de900cdcb7ded8f52d6d35b5040b6880d3dda35\", \"title\": \"8de900cdcb7ded8f52d6d35b5040b6880d3dda35\", \"url\": \"https://webrtc.googlesource.com/src/+/8de900cdcb7ded8f52d6d35b5040b6880d3dda35\"}, {\"gitiles\": {\"ref\": \"refs/heads/master\", \"repo\": \"https://webrtc.googlesource.com/src\", \"revision\": \"2af35ab984e3d62ff7abb215dc293fc082de19f6\"}, \"id\": \"https://webrtc.googlesource.com/src/+/refs/heads/master@2af35ab984e3d62ff7abb215dc293fc082de19f6\", \"title\": \"2af35ab984e3d62ff7abb215dc293fc082de19f6\", \"url\": \"https://webrtc.googlesource.com/src/+/2af35ab984e3d62ff7abb215dc293fc082de19f6\"}]}, \"branch\": \"refs/heads/master\", \"repository\": \"https://webrtc.googlesource.com/src\", \"revision\": \"2af35ab984e3d62ff7abb215dc293fc082de19f6\"}}",
"project": "webrtc",
"result_details_json": "{\"properties\": {}}",
"service_account": "webrtc-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"status": "SCHEDULED",
"status_changed_ts": "1589826535415286",
"tags": [
"build_address:luci.webrtc.ci/Mac64 Debug/22440",
"builder:Mac64 Debug",
"buildset:commit/git/2af35ab984e3d62ff7abb215dc293fc082de19f6",
"buildset:commit/gitiles/webrtc.googlesource.com/src/+/2af35ab984e3d62ff7abb215dc293fc082de19f6",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9045369836473240688",
"scheduler_job_id:webrtc/Mac64 Debug",
"swarming_hostname:chromium-swarm.appspot.com",
"swarming_tag:log_location:logdog://logs.chromium.org/webrtc/buildbucket/cr-buildbucket.appspot.com/8879939773086688592/+/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": "1589826535415504",
"url": "https://ci.chromium.org/b/8879939773086688592",
"utcnow_ts": "1589826536646005"
}
}
[18:28:56.913] Task URL: https://ci.chromium.org/b/8879939773086688592
[18:28:56.913] Scheduling timer "check-buildbucket-build-status" (webrtc/Mac64 Debug:9045369836473240688:2:0) after 1m0s
[18:29:56.936] Handling timer "check-buildbucket-build-status" (webrtc/Mac64 Debug:9045369836473240688:2:0)
[18:29:56.936] Timer tick, asking Buildbucket for the build status
[18:29:57.168] Build 8879939773086688592: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[18:29:57.168] Scheduling timer "check-buildbucket-build-status" (webrtc/Mac64 Debug:9045369836473240688:3:0) after 1m0s
[18:30:57.198] Handling timer "check-buildbucket-build-status" (webrtc/Mac64 Debug:9045369836473240688:3:0)
[18:30:57.198] Timer tick, asking Buildbucket for the build status
[18:30:57.352] Build 8879939773086688592: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[18:30:57.352] Scheduling timer "check-buildbucket-build-status" (webrtc/Mac64 Debug:9045369836473240688:4:0) after 1m0s
[18:31:57.437] Handling timer "check-buildbucket-build-status" (webrtc/Mac64 Debug:9045369836473240688:4:0)
[18:31:57.437] Timer tick, asking Buildbucket for the build status
[18:31:57.614] Build 8879939773086688592: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[18:31:57.614] Scheduling timer "check-buildbucket-build-status" (webrtc/Mac64 Debug:9045369836473240688:5:0) after 1m0s
[18:32:57.666] Handling timer "check-buildbucket-build-status" (webrtc/Mac64 Debug:9045369836473240688:5:0)
[18:32:57.666] Timer tick, asking Buildbucket for the build status
[18:32:57.931] Build 8879939773086688592: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[18:32:57.931] Scheduling timer "check-buildbucket-build-status" (webrtc/Mac64 Debug:9045369836473240688:6:0) after 1m0s
[18:33:58.000] Handling timer "check-buildbucket-build-status" (webrtc/Mac64 Debug:9045369836473240688:6:0)
[18:33:58.000] Timer tick, asking Buildbucket for the build status
[18:33:58.152] Build 8879939773086688592: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[18:33:58.152] Scheduling timer "check-buildbucket-build-status" (webrtc/Mac64 Debug:9045369836473240688:7:0) after 1m0s
[18:34:58.158] Handling timer "check-buildbucket-build-status" (webrtc/Mac64 Debug:9045369836473240688:7:0)
[18:34:58.158] Timer tick, asking Buildbucket for the build status
[18:34:58.701] Build 8879939773086688592: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[18:34:58.701] Scheduling timer "check-buildbucket-build-status" (webrtc/Mac64 Debug:9045369836473240688:8:0) after 1m0s
[18:35:58.733] Handling timer "check-buildbucket-build-status" (webrtc/Mac64 Debug:9045369836473240688:8:0)
[18:35:58.733] Timer tick, asking Buildbucket for the build status
[18:35:58.908] Build 8879939773086688592: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[18:35:58.908] Scheduling timer "check-buildbucket-build-status" (webrtc/Mac64 Debug:9045369836473240688:9:0) after 1m0s
[18:36:58.945] Handling timer "check-buildbucket-build-status" (webrtc/Mac64 Debug:9045369836473240688:9:0)
[18:36:58.945] Timer tick, asking Buildbucket for the build status
[18:36:59.149] Build 8879939773086688592: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[18:36:59.149] Scheduling timer "check-buildbucket-build-status" (webrtc/Mac64 Debug:9045369836473240688:10:0) after 1m0s
[18:37:59.302] Handling timer "check-buildbucket-build-status" (webrtc/Mac64 Debug:9045369836473240688:10:0)
[18:37:59.302] Timer tick, asking Buildbucket for the build status
[18:37:59.532] Build 8879939773086688592: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[18:37:59.532] Scheduling timer "check-buildbucket-build-status" (webrtc/Mac64 Debug:9045369836473240688:11:0) after 1m0s
[18:38:59.666] Handling timer "check-buildbucket-build-status" (webrtc/Mac64 Debug:9045369836473240688:11:0)
[18:38:59.666] Timer tick, asking Buildbucket for the build status
[18:39:01.162] Build 8879939773086688592: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[18:39:01.162] Scheduling timer "check-buildbucket-build-status" (webrtc/Mac64 Debug:9045369836473240688:12:0) after 1m0s
[18:40:01.592] Handling timer "check-buildbucket-build-status" (webrtc/Mac64 Debug:9045369836473240688:12:0)
[18:40:01.592] Timer tick, asking Buildbucket for the build status
[18:40:01.859] Build 8879939773086688592: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[18:40:01.859] Scheduling timer "check-buildbucket-build-status" (webrtc/Mac64 Debug:9045369836473240688:13:0) after 1m0s
[18:41:01.872] Handling timer "check-buildbucket-build-status" (webrtc/Mac64 Debug:9045369836473240688:13:0)
[18:41:01.872] Timer tick, asking Buildbucket for the build status
[18:41:02.062] Build 8879939773086688592: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[18:41:02.062] Scheduling timer "check-buildbucket-build-status" (webrtc/Mac64 Debug:9045369836473240688:14:0) after 1m0s
[18:42:02.109] Handling timer "check-buildbucket-build-status" (webrtc/Mac64 Debug:9045369836473240688:14:0)
[18:42:02.109] Timer tick, asking Buildbucket for the build status
[18:42:02.545] Build 8879939773086688592: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[18:42:02.545] Scheduling timer "check-buildbucket-build-status" (webrtc/Mac64 Debug:9045369836473240688:15:0) after 1m0s
[18:43:02.564] Handling timer "check-buildbucket-build-status" (webrtc/Mac64 Debug:9045369836473240688:15:0)
[18:43:02.564] Timer tick, asking Buildbucket for the build status
[18:43:02.787] Build 8879939773086688592: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[18:43:02.787] Scheduling timer "check-buildbucket-build-status" (webrtc/Mac64 Debug:9045369836473240688:16:0) after 1m0s
[18:44:02.826] Handling timer "check-buildbucket-build-status" (webrtc/Mac64 Debug:9045369836473240688:16:0)
[18:44:02.826] Timer tick, asking Buildbucket for the build status
[18:44:02.987] Build 8879939773086688592: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[18:44:02.987] Scheduling timer "check-buildbucket-build-status" (webrtc/Mac64 Debug:9045369836473240688:17:0) after 1m0s
[18:45:03.272] Handling timer "check-buildbucket-build-status" (webrtc/Mac64 Debug:9045369836473240688:17:0)
[18:45:03.272] Timer tick, asking Buildbucket for the build status
[18:45:03.467] Build 8879939773086688592: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[18:45:03.467] Scheduling timer "check-buildbucket-build-status" (webrtc/Mac64 Debug:9045369836473240688:18:0) after 1m0s
[18:46:03.628] Handling timer "check-buildbucket-build-status" (webrtc/Mac64 Debug:9045369836473240688:18:0)
[18:46:03.628] Timer tick, asking Buildbucket for the build status
[18:46:03.938] Build 8879939773086688592: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[18:46:03.938] Scheduling timer "check-buildbucket-build-status" (webrtc/Mac64 Debug:9045369836473240688:19:0) after 1m0s
[18:47:04.077] Handling timer "check-buildbucket-build-status" (webrtc/Mac64 Debug:9045369836473240688:19:0)
[18:47:04.077] Timer tick, asking Buildbucket for the build status
[18:47:04.377] Build 8879939773086688592: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[18:47:04.377] Scheduling timer "check-buildbucket-build-status" (webrtc/Mac64 Debug:9045369836473240688:20:0) after 1m0s
[18:48:04.519] Handling timer "check-buildbucket-build-status" (webrtc/Mac64 Debug:9045369836473240688:20:0)
[18:48:04.519] Timer tick, asking Buildbucket for the build status
[18:48:04.640] Build 8879939773086688592: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[18:48:04.640] Scheduling timer "check-buildbucket-build-status" (webrtc/Mac64 Debug:9045369836473240688:21:0) after 1m0s
[18:49:04.741] Handling timer "check-buildbucket-build-status" (webrtc/Mac64 Debug:9045369836473240688:21:0)
[18:49:04.741] Timer tick, asking Buildbucket for the build status
[18:49:04.920] Build 8879939773086688592: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[18:49:04.920] Scheduling timer "check-buildbucket-build-status" (webrtc/Mac64 Debug:9045369836473240688:22:0) after 1m0s
[18:50:04.978] Handling timer "check-buildbucket-build-status" (webrtc/Mac64 Debug:9045369836473240688:22:0)
[18:50:04.978] Timer tick, asking Buildbucket for the build status
[18:50:05.184] Build 8879939773086688592: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[18:50:05.184] Scheduling timer "check-buildbucket-build-status" (webrtc/Mac64 Debug:9045369836473240688:23:0) after 1m0s
[18:51:05.457] Handling timer "check-buildbucket-build-status" (webrtc/Mac64 Debug:9045369836473240688:23:0)
[18:51:05.457] Timer tick, asking Buildbucket for the build status
[18:51:05.545] Build 8879939773086688592: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[18:51:05.545] Scheduling timer "check-buildbucket-build-status" (webrtc/Mac64 Debug:9045369836473240688:24:0) after 1m0s
[18:52:05.677] Handling timer "check-buildbucket-build-status" (webrtc/Mac64 Debug:9045369836473240688:24:0)
[18:52:05.677] Timer tick, asking Buildbucket for the build status
[18:52:06.260] Build 8879939773086688592: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[18:52:06.260] Scheduling timer "check-buildbucket-build-status" (webrtc/Mac64 Debug:9045369836473240688:25:0) after 1m0s
[18:53:06.380] Handling timer "check-buildbucket-build-status" (webrtc/Mac64 Debug:9045369836473240688:25:0)
[18:53:06.380] Timer tick, asking Buildbucket for the build status
[18:53:06.535] Build 8879939773086688592: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[18:53:06.535] Scheduling timer "check-buildbucket-build-status" (webrtc/Mac64 Debug:9045369836473240688:26:0) after 1m0s
[18:54:06.603] Handling timer "check-buildbucket-build-status" (webrtc/Mac64 Debug:9045369836473240688:26:0)
[18:54:06.603] Timer tick, asking Buildbucket for the build status
[18:54:06.801] Build 8879939773086688592: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[18:54:06.801] Scheduling timer "check-buildbucket-build-status" (webrtc/Mac64 Debug:9045369836473240688:27:0) after 1m0s
[18:55:07.333] Handling timer "check-buildbucket-build-status" (webrtc/Mac64 Debug:9045369836473240688:27:0)
[18:55:07.333] Timer tick, asking Buildbucket for the build status
[18:55:07.606] Build 8879939773086688592: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[18:55:07.606] Scheduling timer "check-buildbucket-build-status" (webrtc/Mac64 Debug:9045369836473240688:28:0) after 1m0s
[18:56:07.757] Handling timer "check-buildbucket-build-status" (webrtc/Mac64 Debug:9045369836473240688:28:0)
[18:56:07.757] Timer tick, asking Buildbucket for the build status
[18:56:07.911] Build 8879939773086688592: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[18:56:07.911] Scheduling timer "check-buildbucket-build-status" (webrtc/Mac64 Debug:9045369836473240688:29:0) after 1m0s
[18:57:08.008] Handling timer "check-buildbucket-build-status" (webrtc/Mac64 Debug:9045369836473240688:29:0)
[18:57:08.008] Timer tick, asking Buildbucket for the build status
[18:57:08.341] Build 8879939773086688592: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[18:57:08.341] Scheduling timer "check-buildbucket-build-status" (webrtc/Mac64 Debug:9045369836473240688:30:0) after 1m0s
[18:58:08.593] Handling timer "check-buildbucket-build-status" (webrtc/Mac64 Debug:9045369836473240688:30:0)
[18:58:08.593] Timer tick, asking Buildbucket for the build status
[18:58:08.781] Build 8879939773086688592: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[18:58:08.781] Scheduling timer "check-buildbucket-build-status" (webrtc/Mac64 Debug:9045369836473240688:31:0) after 1m0s
[18:59:08.965] Handling timer "check-buildbucket-build-status" (webrtc/Mac64 Debug:9045369836473240688:31:0)
[18:59:08.965] Timer tick, asking Buildbucket for the build status
[18:59:09.134] Build 8879939773086688592: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[18:59:09.134] Scheduling timer "check-buildbucket-build-status" (webrtc/Mac64 Debug:9045369836473240688:32:0) after 1m0s
[19:00:09.283] Handling timer "check-buildbucket-build-status" (webrtc/Mac64 Debug:9045369836473240688:32:0)
[19:00:09.283] Timer tick, asking Buildbucket for the build status
[19:00:09.519] Build 8879939773086688592: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[19:00:09.519] Scheduling timer "check-buildbucket-build-status" (webrtc/Mac64 Debug:9045369836473240688:33:0) after 1m0s
[19:01:09.564] Handling timer "check-buildbucket-build-status" (webrtc/Mac64 Debug:9045369836473240688:33:0)
[19:01:09.564] Timer tick, asking Buildbucket for the build status
[19:01:10.034] Build 8879939773086688592: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[19:01:10.034] Scheduling timer "check-buildbucket-build-status" (webrtc/Mac64 Debug:9045369836473240688:34:0) after 1m0s
[19:02:10.016] Handling timer "check-buildbucket-build-status" (webrtc/Mac64 Debug:9045369836473240688:34:0)
[19:02:10.016] Timer tick, asking Buildbucket for the build status
[19:02:10.407] Build 8879939773086688592: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[19:02:10.407] Scheduling timer "check-buildbucket-build-status" (webrtc/Mac64 Debug:9045369836473240688:35:0) after 1m0s
[19:03:10.483] Handling timer "check-buildbucket-build-status" (webrtc/Mac64 Debug:9045369836473240688:35:0)
[19:03:10.483] Timer tick, asking Buildbucket for the build status
[19:03:10.882] Build 8879939773086688592: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[19:03:10.882] Scheduling timer "check-buildbucket-build-status" (webrtc/Mac64 Debug:9045369836473240688:36:0) after 1m0s
[19:04:10.955] Handling timer "check-buildbucket-build-status" (webrtc/Mac64 Debug:9045369836473240688:36:0)
[19:04:10.955] Timer tick, asking Buildbucket for the build status
[19:04:11.112] Build 8879939773086688592: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[19:04:11.112] Scheduling timer "check-buildbucket-build-status" (webrtc/Mac64 Debug:9045369836473240688:37:0) after 1m0s
[19:05:11.166] Handling timer "check-buildbucket-build-status" (webrtc/Mac64 Debug:9045369836473240688:37:0)
[19:05:11.166] Timer tick, asking Buildbucket for the build status
[19:05:13.766] Build 8879939773086688592: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[19:05:13.766] Scheduling timer "check-buildbucket-build-status" (webrtc/Mac64 Debug:9045369836473240688:38:0) after 1m0s
[19:06:13.784] Handling timer "check-buildbucket-build-status" (webrtc/Mac64 Debug:9045369836473240688:38:0)
[19:06:13.784] Timer tick, asking Buildbucket for the build status
[19:06:13.934] Build 8879939773086688592: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[19:06:13.934] Scheduling timer "check-buildbucket-build-status" (webrtc/Mac64 Debug:9045369836473240688:39:0) after 1m0s
[19:07:13.925] Handling timer "check-buildbucket-build-status" (webrtc/Mac64 Debug:9045369836473240688:39:0)
[19:07:13.925] Timer tick, asking Buildbucket for the build status
[19:07:14.677] Build 8879939773086688592: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[19:07:14.677] Scheduling timer "check-buildbucket-build-status" (webrtc/Mac64 Debug:9045369836473240688:40:0) after 1m0s
[19:07:43.727] Received PubSub notification, asking Buildbucket for the build status
[19:07:43.846] Build 8879939773086688592: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:08:14.734] Handling timer "check-buildbucket-build-status" (webrtc/Mac64 Debug:9045369836473240688:40:0)
[19:08:14.734] Timer tick, asking Buildbucket for the build status
[19:08:15.582] Build 8879939773086688592: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:08:15.582] Scheduling timer "check-buildbucket-build-status" (webrtc/Mac64 Debug:9045369836473240688:42:0) after 1m0s
[19:09:15.601] Handling timer "check-buildbucket-build-status" (webrtc/Mac64 Debug:9045369836473240688:42:0)
[19:09:15.601] Timer tick, asking Buildbucket for the build status
[19:09:16.528] Build 8879939773086688592: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:09:16.528] Scheduling timer "check-buildbucket-build-status" (webrtc/Mac64 Debug:9045369836473240688:43:0) after 1m0s
[19:10:16.622] Handling timer "check-buildbucket-build-status" (webrtc/Mac64 Debug:9045369836473240688:43:0)
[19:10:16.622] Timer tick, asking Buildbucket for the build status
[19:10:17.007] Build 8879939773086688592: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:10:17.007] Scheduling timer "check-buildbucket-build-status" (webrtc/Mac64 Debug:9045369836473240688:44:0) after 1m0s
[19:11:17.024] Handling timer "check-buildbucket-build-status" (webrtc/Mac64 Debug:9045369836473240688:44:0)
[19:11:17.024] Timer tick, asking Buildbucket for the build status
[19:11:17.324] Build 8879939773086688592: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:11:17.325] Scheduling timer "check-buildbucket-build-status" (webrtc/Mac64 Debug:9045369836473240688:45:0) after 1m0s
[19:12:17.344] Handling timer "check-buildbucket-build-status" (webrtc/Mac64 Debug:9045369836473240688:45:0)
[19:12:17.344] Timer tick, asking Buildbucket for the build status
[19:12:19.869] Build 8879939773086688592: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:12:19.869] Scheduling timer "check-buildbucket-build-status" (webrtc/Mac64 Debug:9045369836473240688:46:0) after 1m0s
[19:13:19.895] Handling timer "check-buildbucket-build-status" (webrtc/Mac64 Debug:9045369836473240688:46:0)
[19:13:19.895] Timer tick, asking Buildbucket for the build status
[19:13:20.071] Build 8879939773086688592: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:13:20.071] Scheduling timer "check-buildbucket-build-status" (webrtc/Mac64 Debug:9045369836473240688:47:0) after 1m0s
[19:14:20.307] Handling timer "check-buildbucket-build-status" (webrtc/Mac64 Debug:9045369836473240688:47:0)
[19:14:20.307] Timer tick, asking Buildbucket for the build status
[19:14:20.541] Build 8879939773086688592: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:14:20.541] Scheduling timer "check-buildbucket-build-status" (webrtc/Mac64 Debug:9045369836473240688:48:0) after 1m0s
[19:15:12.397] Received PubSub notification, asking Buildbucket for the build status
[19:15:12.521] Build 8879939773086688592: status "COMPLETED", result "SUCCESS", failure_reason "", cancelation_reason ""
[19:15:12.521] Buildbucket build:
{
"build": {
"bucket": "luci.webrtc.ci",
"canary_preference": "PROD",
"completed_ts": "1589829308596066",
"created_by": "project:webrtc",
"created_ts": "1589826529380923",
"id": "8879939773086688592",
"parameters_json": "{\"builder_name\": \"Mac64 Debug\", \"properties\": {\"$recipe_engine/scheduler\": {\"hostname\": \"luci-scheduler.appspot.com\", \"triggers\": [{\"gitiles\": {\"ref\": \"refs/heads/master\", \"repo\": \"https://webrtc.googlesource.com/src\", \"revision\": \"8de900cdcb7ded8f52d6d35b5040b6880d3dda35\"}, \"id\": \"https://webrtc.googlesource.com/src/+/refs/heads/master@8de900cdcb7ded8f52d6d35b5040b6880d3dda35\", \"title\": \"8de900cdcb7ded8f52d6d35b5040b6880d3dda35\", \"url\": \"https://webrtc.googlesource.com/src/+/8de900cdcb7ded8f52d6d35b5040b6880d3dda35\"}, {\"gitiles\": {\"ref\": \"refs/heads/master\", \"repo\": \"https://webrtc.googlesource.com/src\", \"revision\": \"2af35ab984e3d62ff7abb215dc293fc082de19f6\"}, \"id\": \"https://webrtc.googlesource.com/src/+/refs/heads/master@2af35ab984e3d62ff7abb215dc293fc082de19f6\", \"title\": \"2af35ab984e3d62ff7abb215dc293fc082de19f6\", \"url\": \"https://webrtc.googlesource.com/src/+/2af35ab984e3d62ff7abb215dc293fc082de19f6\"}]}, \"branch\": \"refs/heads/master\", \"repository\": \"https://webrtc.googlesource.com/src\", \"revision\": \"2af35ab984e3d62ff7abb215dc293fc082de19f6\"}}",
"project": "webrtc",
"result": "SUCCESS",
"result_details_json": "{\"properties\": {\"$build/goma\": {\"server_host\": \"goma.chromium.org\", \"use_luci_auth\": true}, \"$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\": \"8de900cdcb7ded8f52d6d35b5040b6880d3dda35\"}, \"id\": \"https://webrtc.googlesource.com/src/+/refs/heads/master@8de900cdcb7ded8f52d6d35b5040b6880d3dda35\", \"title\": \"8de900cdcb7ded8f52d6d35b5040b6880d3dda35\", \"url\": \"https://webrtc.googlesource.com/src/+/8de900cdcb7ded8f52d6d35b5040b6880d3dda35\"}, {\"gitiles\": {\"ref\": \"refs/heads/master\", \"repo\": \"https://webrtc.googlesource.com/src\", \"revision\": \"2af35ab984e3d62ff7abb215dc293fc082de19f6\"}, \"id\": \"https://webrtc.googlesource.com/src/+/refs/heads/master@2af35ab984e3d62ff7abb215dc293fc082de19f6\", \"title\": \"2af35ab984e3d62ff7abb215dc293fc082de19f6\", \"url\": \"https://webrtc.googlesource.com/src/+/2af35ab984e3d62ff7abb215dc293fc082de19f6\"}]}, \"bot_id\": \"build141-m9\", \"branch\": \"refs/heads/master\", \"buildername\": \"Mac64 Debug\", \"buildnumber\": 22440, \"clang_revision\": \"n353803-99ac9ce7-1\", \"got_revision\": \"2af35ab984e3d62ff7abb215dc293fc082de19f6\", \"got_revision_cp\": \"refs/heads/master@{#31313}\", \"isolate_server\": \"https://isolateserver.appspot.com\", \"mastername\": \"client.webrtc\", \"path_config\": \"generic\", \"recipe\": \"webrtc/standalone\", \"repository\": \"https://webrtc.googlesource.com/src\", \"revision\": \"2af35ab984e3d62ff7abb215dc293fc082de19f6\", \"swarm_hashes\": {\"audio_decoder_unittests\": \"6c151bd5501318724e628a9c2e8d706f52cb7cda\", \"common_audio_unittests\": \"7ba11bfdfffc5ba053c58e4b3a05c1df97c958d9\", \"common_video_unittests\": \"cb97496107539974162cd6e07b0edfef22b907e5\", \"low_bandwidth_audio_test\": \"d7049aac558ab0a8795fec263eb708764420e203\", \"modules_tests\": \"8d4ed28e2cde8411758703f8ff87cd05e2bc26ce\", \"modules_unittests\": \"5dc6a783463c228b45c57120507ef1d58f1989d4\", \"peerconnection_unittests\": \"967dc3729efe266a8b8bf052a478d7c0794fefe4\", \"rtc_media_unittests\": \"4706be4682ddb342649238b68bfbbe1a84bc34e9\", \"rtc_pc_unittests\": \"cb9369da447632f1850ed9fd2fd8031b1fb469b9\", \"rtc_stats_unittests\": \"6589a432fefc8a2ec5b89eb48bfeaaf36890993f\", \"rtc_unittests\": \"29761b1e9b58b18a6045ea90a0c61f1e08eda14b\", \"slow_tests\": \"27344962f8648b68e5d923bd22bd4eda88df77e6\", \"system_wrappers_unittests\": \"bb6c18f24034303c82496cb7f95122269575a77f\", \"test_support_unittests\": \"a757ec002baf3e9a95695d94123ef7bc0a6d97b3\", \"tools_unittests\": \"35eb240c4c27fae79b9c3b1362eca9a38d7021a6\", \"video_engine_tests\": \"811fc15d9fb6b6dc87d27aba80bed52478e8b84d\", \"voip_unittests\": \"3eb74fd7496b3dddbfa30e1851f3cd0f41152ed1\", \"webrtc_nonparallel_tests\": \"a5c6e9d53a35f08253d66abefb93eb548f2e388c\"}}, \"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_63601768ebaa6550931251d01f66fd42a511d047ab36f27e7a12ce2bed95fdde_v2\", \"builder_8a2278e97eb38544b82301aee383e0f90c5414a7b11d57b8f9ae783a4faf492d_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.14\", \"Mac-10.14.6\"], \"pool\": [\"luci.webrtc.ci\"], \"python\": [\"2.7.10\"], \"server_version\": [\"5088-a734129\"], \"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": "1589828862243313",
"status": "COMPLETED",
"status_changed_ts": "1589829310589626",
"tags": [
"build_address:luci.webrtc.ci/Mac64 Debug/22440",
"builder:Mac64 Debug",
"buildset:commit/git/2af35ab984e3d62ff7abb215dc293fc082de19f6",
"buildset:commit/gitiles/webrtc.googlesource.com/src/+/2af35ab984e3d62ff7abb215dc293fc082de19f6",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9045369836473240688",
"scheduler_job_id:webrtc/Mac64 Debug",
"swarming_hostname:chromium-swarm.appspot.com",
"swarming_tag:log_location:logdog://logs.chromium.org/webrtc/buildbucket/cr-buildbucket.appspot.com/8879939773086688592/+/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:4c41dd4b4b96a410",
"user_agent:luci-scheduler"
],
"updated_ts": "1589829310942343",
"url": "https://ci.chromium.org/b/8879939773086688592",
"utcnow_ts": "1589829312509164"
}
}
[19:15:12.521] Invocation finished in 46m25.754153199s with status SUCCEEDED