[22:30:52.189] New invocation is queued and will start shortly
[22:30:54.189] Starting the invocation (attempt 1)
[22:30:54.227] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[22:30:54.227] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[22:30:54.227] Buildbucket request:
{
"bucket": "luci.chromium.ci",
"client_operation_id": "9032308642321604896",
"parameters_json": "{\"builder_name\":\"Linux Builder (dbg)\",\"properties\":{\"branch\":\"refs/heads/master\",\"repository\":\"https://chromium.googlesource.com/chromium/src\",\"revision\":\"dd8308e5aa18ccd54b534cdc1db956847123a12f\"}}",
"pubsub_callback": {
"auth_token": "...",
"topic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
},
"tags": [
"builder:Linux Builder (dbg)",
"scheduler_invocation_id:9032308642321604896",
"scheduler_job_id:chromium/Linux Builder (dbg)",
"user_agent:luci-scheduler",
"buildset:commit/git/dd8308e5aa18ccd54b534cdc1db956847123a12f",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/dd8308e5aa18ccd54b534cdc1db956847123a12f",
"gitiles_ref:refs/heads/master"
]
}
[22:30:55.084] Buildbucket response:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "PROD",
"created_by": "project:chromium",
"created_ts": "1602282654367333",
"id": "8866878579373233344",
"parameters_json": "{\"builder_name\": \"Linux Builder (dbg)\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"dd8308e5aa18ccd54b534cdc1db956847123a12f\"}}",
"project": "chromium",
"result_details_json": "{\"properties\": {}}",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"status": "SCHEDULED",
"status_changed_ts": "1602282654880667",
"tags": [
"build_address:luci.chromium.ci/Linux Builder (dbg)/176508",
"builder:Linux Builder (dbg)",
"buildset:commit/git/dd8308e5aa18ccd54b534cdc1db956847123a12f",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/dd8308e5aa18ccd54b534cdc1db956847123a12f",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9032308642321604896",
"scheduler_job_id:chromium/Linux Builder (dbg)",
"swarming_hostname:chromium-swarm.appspot.com",
"swarming_tag:log_location:logdog://logs.chromium.org/chromium/buildbucket/cr-buildbucket.appspot.com/8866878579373233344/+/annotations",
"swarming_tag:luci_project:chromium",
"swarming_tag:recipe_name:chromium",
"swarming_tag:recipe_package:infra/recipe_bundles/chromium.googlesource.com/chromium/tools/build",
"swarming_task_id:",
"user_agent:luci-scheduler"
],
"updated_ts": "1602282654880819",
"url": "https://ci.chromium.org/b/8866878579373233344",
"utcnow_ts": "1602282655073448"
}
}
[22:30:55.084] Task URL: https://ci.chromium.org/b/8866878579373233344
[22:30:55.084] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9032308642321604896:2:0) after 1m0s
[22:31:18.981] Received PubSub notification, asking Buildbucket for the build status
[22:31:19.282] Build 8866878579373233344: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:31:55.264] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9032308642321604896:2:0)
[22:31:55.264] Timer tick, asking Buildbucket for the build status
[22:31:55.391] Build 8866878579373233344: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:31:55.391] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9032308642321604896:4:0) after 1m0s
[22:32:55.434] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9032308642321604896:4:0)
[22:32:55.434] Timer tick, asking Buildbucket for the build status
[22:32:55.626] Build 8866878579373233344: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:32:55.626] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9032308642321604896:5:0) after 1m0s
[22:33:55.607] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9032308642321604896:5:0)
[22:33:55.607] Timer tick, asking Buildbucket for the build status
[22:33:55.663] Build 8866878579373233344: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:33:55.663] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9032308642321604896:6:0) after 1m0s
[22:34:55.694] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9032308642321604896:6:0)
[22:34:55.694] Timer tick, asking Buildbucket for the build status
[22:34:55.762] Build 8866878579373233344: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:34:55.762] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9032308642321604896:7:0) after 1m0s
[22:35:55.846] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9032308642321604896:7:0)
[22:35:55.846] Timer tick, asking Buildbucket for the build status
[22:35:56.028] Build 8866878579373233344: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:35:56.028] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9032308642321604896:8:0) after 1m0s
[22:36:56.053] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9032308642321604896:8:0)
[22:36:56.053] Timer tick, asking Buildbucket for the build status
[22:36:56.158] Build 8866878579373233344: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:36:56.158] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9032308642321604896:9:0) after 1m0s
[22:37:56.212] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9032308642321604896:9:0)
[22:37:56.212] Timer tick, asking Buildbucket for the build status
[22:37:56.318] Build 8866878579373233344: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:37:56.319] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9032308642321604896:10:0) after 1m0s
[22:38:56.365] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9032308642321604896:10:0)
[22:38:56.365] Timer tick, asking Buildbucket for the build status
[22:38:56.904] Build 8866878579373233344: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:38:56.904] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9032308642321604896:11:0) after 1m0s
[22:39:56.998] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9032308642321604896:11:0)
[22:39:56.998] Timer tick, asking Buildbucket for the build status
[22:39:57.066] Build 8866878579373233344: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:39:57.066] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9032308642321604896:12:0) after 1m0s
[22:40:57.091] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9032308642321604896:12:0)
[22:40:57.091] Timer tick, asking Buildbucket for the build status
[22:40:57.193] Build 8866878579373233344: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:40:57.193] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9032308642321604896:13:0) after 1m0s
[22:41:57.250] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9032308642321604896:13:0)
[22:41:57.250] Timer tick, asking Buildbucket for the build status
[22:41:57.325] Build 8866878579373233344: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:41:57.325] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9032308642321604896:14:0) after 1m0s
[22:42:57.372] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9032308642321604896:14:0)
[22:42:57.372] Timer tick, asking Buildbucket for the build status
[22:42:57.517] Build 8866878579373233344: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:42:57.517] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9032308642321604896:15:0) after 1m0s
[22:43:57.538] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9032308642321604896:15:0)
[22:43:57.538] Timer tick, asking Buildbucket for the build status
[22:43:57.608] Build 8866878579373233344: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:43:57.608] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9032308642321604896:16:0) after 1m0s
[22:44:57.700] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9032308642321604896:16:0)
[22:44:57.700] Timer tick, asking Buildbucket for the build status
[22:44:57.761] Build 8866878579373233344: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:44:57.761] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9032308642321604896:17:0) after 1m0s
[22:45:57.843] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9032308642321604896:17:0)
[22:45:57.843] Timer tick, asking Buildbucket for the build status
[22:45:57.971] Build 8866878579373233344: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:45:57.971] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9032308642321604896:18:0) after 1m0s
[22:46:58.042] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9032308642321604896:18:0)
[22:46:58.042] Timer tick, asking Buildbucket for the build status
[22:46:58.186] Build 8866878579373233344: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:46:58.186] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9032308642321604896:19:0) after 1m0s
[22:47:58.179] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9032308642321604896:19:0)
[22:47:58.179] Timer tick, asking Buildbucket for the build status
[22:48:12.251] Build 8866878579373233344: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:48:12.251] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9032308642321604896:20:0) after 1m0s
[22:49:12.323] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9032308642321604896:20:0)
[22:49:12.323] Timer tick, asking Buildbucket for the build status
[22:49:12.501] Build 8866878579373233344: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:49:12.501] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9032308642321604896:21:0) after 1m0s
[22:50:12.562] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9032308642321604896:21:0)
[22:50:12.562] Timer tick, asking Buildbucket for the build status
[22:50:12.644] Build 8866878579373233344: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:50:12.644] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9032308642321604896:22:0) after 1m0s
[22:51:12.775] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9032308642321604896:22:0)
[22:51:12.775] Timer tick, asking Buildbucket for the build status
[22:51:12.878] Build 8866878579373233344: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:51:12.878] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9032308642321604896:23:0) after 1m0s
[22:52:12.899] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9032308642321604896:23:0)
[22:52:12.899] Timer tick, asking Buildbucket for the build status
[22:52:12.969] Build 8866878579373233344: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:52:12.969] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9032308642321604896:24:0) after 1m0s
[22:53:13.083] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9032308642321604896:24:0)
[22:53:13.083] Timer tick, asking Buildbucket for the build status
[22:53:13.294] Build 8866878579373233344: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:53:13.294] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9032308642321604896:25:0) after 1m0s
[22:54:13.323] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9032308642321604896:25:0)
[22:54:13.323] Timer tick, asking Buildbucket for the build status
[22:54:13.510] Build 8866878579373233344: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:54:13.510] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9032308642321604896:26:0) after 1m0s
[22:55:13.590] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9032308642321604896:26:0)
[22:55:13.590] Timer tick, asking Buildbucket for the build status
[22:55:13.959] Build 8866878579373233344: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:55:13.959] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9032308642321604896:27:0) after 1m0s
[22:56:14.048] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9032308642321604896:27:0)
[22:56:14.048] Timer tick, asking Buildbucket for the build status
[22:56:14.139] Build 8866878579373233344: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:56:14.139] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9032308642321604896:28:0) after 1m0s
[22:57:14.198] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9032308642321604896:28:0)
[22:57:14.198] Timer tick, asking Buildbucket for the build status
[22:57:14.253] Build 8866878579373233344: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:57:14.253] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9032308642321604896:29:0) after 1m0s
[22:58:14.299] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9032308642321604896:29:0)
[22:58:14.299] Timer tick, asking Buildbucket for the build status
[22:58:14.546] Build 8866878579373233344: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:58:14.546] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9032308642321604896:30:0) after 1m0s
[22:59:14.601] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9032308642321604896:30:0)
[22:59:14.601] Timer tick, asking Buildbucket for the build status
[22:59:14.661] Build 8866878579373233344: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:59:14.661] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9032308642321604896:31:0) after 1m0s
[23:00:14.697] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9032308642321604896:31:0)
[23:00:14.697] Timer tick, asking Buildbucket for the build status
[23:00:14.853] Build 8866878579373233344: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:00:14.853] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9032308642321604896:32:0) after 1m0s
[23:01:15.477] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9032308642321604896:32:0)
[23:01:15.477] Timer tick, asking Buildbucket for the build status
[23:01:15.607] Build 8866878579373233344: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:01:15.607] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9032308642321604896:33:0) after 1m0s
[23:02:15.685] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9032308642321604896:33:0)
[23:02:15.685] Timer tick, asking Buildbucket for the build status
[23:02:15.753] Build 8866878579373233344: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:02:15.753] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9032308642321604896:34:0) after 1m0s
[23:03:15.848] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9032308642321604896:34:0)
[23:03:15.848] Timer tick, asking Buildbucket for the build status
[23:03:16.018] Build 8866878579373233344: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:03:16.018] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9032308642321604896:35:0) after 1m0s
[23:04:16.043] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9032308642321604896:35:0)
[23:04:16.043] Timer tick, asking Buildbucket for the build status
[23:04:16.113] Build 8866878579373233344: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:04:16.113] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9032308642321604896:36:0) after 1m0s
[23:05:16.167] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9032308642321604896:36:0)
[23:05:16.167] Timer tick, asking Buildbucket for the build status
[23:05:16.242] Build 8866878579373233344: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:05:16.242] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9032308642321604896:37:0) after 1m0s
[23:06:16.228] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9032308642321604896:37:0)
[23:06:16.228] Timer tick, asking Buildbucket for the build status
[23:06:16.470] Build 8866878579373233344: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:06:16.470] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9032308642321604896:38:0) after 1m0s
[23:07:16.551] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9032308642321604896:38:0)
[23:07:16.551] Timer tick, asking Buildbucket for the build status
[23:07:16.659] Build 8866878579373233344: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:07:16.659] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9032308642321604896:39:0) after 1m0s
[23:08:16.727] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9032308642321604896:39:0)
[23:08:16.727] Timer tick, asking Buildbucket for the build status
[23:08:16.801] Build 8866878579373233344: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:08:16.801] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9032308642321604896:40:0) after 1m0s
[23:09:16.856] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9032308642321604896:40:0)
[23:09:16.856] Timer tick, asking Buildbucket for the build status
[23:09:17.049] Build 8866878579373233344: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:09:17.049] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9032308642321604896:41:0) after 1m0s
[23:10:17.074] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9032308642321604896:41:0)
[23:10:17.074] Timer tick, asking Buildbucket for the build status
[23:10:17.290] Build 8866878579373233344: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:10:17.290] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9032308642321604896:42:0) after 1m0s
[23:11:17.279] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9032308642321604896:42:0)
[23:11:17.279] Timer tick, asking Buildbucket for the build status
[23:11:17.421] Build 8866878579373233344: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:11:17.421] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9032308642321604896:43:0) after 1m0s
[23:12:17.436] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9032308642321604896:43:0)
[23:12:17.436] Timer tick, asking Buildbucket for the build status
[23:12:17.507] Build 8866878579373233344: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:12:17.507] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9032308642321604896:44:0) after 1m0s
[23:13:17.642] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9032308642321604896:44:0)
[23:13:17.642] Timer tick, asking Buildbucket for the build status
[23:13:17.696] Build 8866878579373233344: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:13:17.696] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9032308642321604896:45:0) after 1m0s
[23:14:17.724] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9032308642321604896:45:0)
[23:14:17.724] Timer tick, asking Buildbucket for the build status
[23:14:18.003] Build 8866878579373233344: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:14:18.003] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9032308642321604896:46:0) after 1m0s
[23:15:18.023] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9032308642321604896:46:0)
[23:15:18.023] Timer tick, asking Buildbucket for the build status
[23:15:18.137] Build 8866878579373233344: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:15:18.137] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9032308642321604896:47:0) after 1m0s
[23:16:18.179] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9032308642321604896:47:0)
[23:16:18.179] Timer tick, asking Buildbucket for the build status
[23:16:18.285] Build 8866878579373233344: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:16:18.285] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9032308642321604896:48:0) after 1m0s
[23:17:17.087] Received PubSub notification, asking Buildbucket for the build status
[23:17:17.365] Build 8866878579373233344: status "COMPLETED", result "SUCCESS", failure_reason "", cancelation_reason ""
[23:17:17.365] Buildbucket build:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "PROD",
"completed_ts": "1602285436312115",
"created_by": "project:chromium",
"created_ts": "1602282654367333",
"id": "8866878579373233344",
"parameters_json": "{\"builder_name\": \"Linux Builder (dbg)\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"dd8308e5aa18ccd54b534cdc1db956847123a12f\"}}",
"project": "chromium",
"result": "SUCCESS",
"result_details_json": "{\"properties\": {\"$build/goma\": {\"enable_ats\": true, \"jobs\": 500.0, \"rpc_extra_params\": \"?prod\", \"server_host\": \"goma.chromium.org\", \"use_luci_auth\": true}, \"$recipe_engine/isolated\": {\"server\": \"https://isolateserver.appspot.com\"}, \"$recipe_engine/milo/blamelist_pins\": [{\"host\": \"chromium.googlesource.com\", \"id\": \"dd8308e5aa18ccd54b534cdc1db956847123a12f\", \"project\": \"chromium/src\"}], \"$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}, \"bot_id\": \"luci-chromium-ci-xenial-us-east1-d-8-102-8h21\", \"branch\": \"refs/heads/master\", \"builder_group\": \"chromium.linux\", \"buildername\": \"Linux Builder (dbg)\", \"buildnumber\": 176508, \"got_angle_revision\": \"b2ff69f856d98312bbfe14f80d084b7d8795281f\", \"got_dawn_revision\": \"793a07e366362f2e3cdf07e144c1eff8de18efba\", \"got_nacl_revision\": \"0fabd6dc4222dfae664e55a84326e0c904f5b62c\", \"got_revision\": \"dd8308e5aa18ccd54b534cdc1db956847123a12f\", \"got_revision_cp\": \"refs/heads/master@{#815818}\", \"got_swarming_client_revision\": \"d46ea7635f2911208268170512cb611412488fd8\", \"got_swiftshader_revision\": \"0aca3ca9427d1d2aa8d8e706de62360c61af3598\", \"got_v8_revision\": \"e4ed803f4c09ff72bb1eaadf59ec31facf507368\", \"got_v8_revision_cp\": \"refs/heads/8.8.64@{#1}\", \"got_webrtc_revision\": \"ff7913204ce23f6888d206d16250a1429d0736db\", \"got_webrtc_revision_cp\": \"refs/heads/master@{#32372}\", \"isolate_server\": \"https://isolateserver.appspot.com\", \"path_config\": \"generic\", \"recipe\": \"chromium\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"dd8308e5aa18ccd54b534cdc1db956847123a12f\", \"swarm_hashes_refs/heads/master(at){#815818}_without_patch\": {\"absl_hardening_tests\": \"a173f4dc49dc9e5443221a812ce2683dd46409a9\", \"accessibility_unittests\": \"7c6691c21d276d34c6e29c4e94c679b8a9acc1cc\", \"app_shell_unittests\": \"5cbc57d8882f0109e3050375519cad8e5d9914aa\", \"aura_unittests\": \"8d70e6927c5885a2b72b178b318f688beaa83874\", \"base_unittests\": \"94fd9d86986477e5d80f73da41f9cece99359ad6\", \"base_util_unittests\": \"ec55b2a290aa8a15929601370efde779ba12cded\", \"blink_common_unittests\": \"e7a56b93a6f9a09f8898334fdfbaf46bd8b5ae84\", \"blink_fuzzer_unittests\": \"06b8fb1c6c70cbf953858557a329799e58d3f282\", \"blink_heap_unittests\": \"b1e72fa8a2a8a8230ef6a5d669062fe36604ab4e\", \"blink_platform_unittests\": \"9ce0ad19db4c776027196ccaeb3585ac02f96808\", \"blink_python_tests\": \"5078ad6c91545cebdd167a6ff1fc6123b0c06ff9\", \"blink_unittests\": \"5f7814a980c97ad27e15b3294732e202590326c3\", \"blink_web_tests\": \"09c65213e37699d80fb656d31ab50991146e8a4e\", \"boringssl_crypto_tests\": \"dc9b2f9d71f27db45641db518d53087c1148b5e0\", \"boringssl_ssl_tests\": \"6f640201cc8ab052e7d22ac28010324baf798e14\", \"browser_tests\": \"63d2d53fbbd11d9ad625344ea0c6f3f6ad711030\", \"capture_unittests\": \"a72efe1ccadb5f461d6cecf136c8f2d3b08eb5fc\", \"cast_unittests\": \"a5c1b2af8b3d8c7a146df60c7bab1d6c87378be4\", \"cc_unittests\": \"cbf943fae4f56ea325c2284050bd2683a74af4c2\", \"chrome_app_unittests\": \"05a609de085a85efb70c3c001dfd9d9983276b69\", \"chromedriver_unittests\": \"abef258a5a8500715bee9e22d85b104dd4a07811\", \"components_browsertests\": \"a374d029045674c13b10e7ede8ae2dd53ca56788\", \"components_unittests\": \"d52ea137d328886e29ade8cb734755a703282fbc\", \"compositor_unittests\": \"4d984c210320a6b2d56d19af1369af6339f2db68\", \"content_browsertests\": \"fcdf169e5d9b9c1a834608c9e7bb6e24f4ffa869\", \"content_shell_crash_test\": \"2328cb7d5a067e82ee8695d5d91a442fa552dd86\", \"content_unittests\": \"9c71f3ce990704d713fcc582e70684ac901b2413\", \"crashpad_tests\": \"4dd823f1653abdd57b7d2eab64ec5f6cdb03c15b\", \"cronet_tests\": \"7518ba92ef3a829f13c5738221573707c475cfe2\", \"cronet_unittests\": \"52a1336e58285d265180b2af232af3359b8e1489\", \"crypto_unittests\": \"13c9ee3a22140b45ee1a2c4c8b4019e46ad3479c\", \"dbus_unittests\": \"6ca17005898f746e259c634901ce16c758af135b\", \"device_unittests\": \"f785356668e12e87928630b99f5597e460a0a6f7\", \"display_unittests\": \"a842a8e05578030abd6229da925e9b7db9d767b9\", \"events_unittests\": \"6c84c733a8149533018570e6d1995951d6448895\", \"extension_docserver_python_unittests\": \"9e07c383868e294c399248635a054c66261bdb48\", \"extensions_browsertests\": \"f536f3e679a273822a8b1e14e43ee3f81906122e\", \"extensions_unittests\": \"7537efefdde438043f6eb6e707a211b34f3353a0\", \"filesystem_service_unittests\": \"8e946d46d5c31af28b9d9eb5a6cc434c28294819\", \"flatbuffers_unittests\": \"7c821f13730963d6e07deae074f4fffab315d766\", \"gcm_unit_tests\": \"63285e766cff45592ec2e5f39a6aefd7fcd990e4\", \"gfx_unittests\": \"9db76f9fbf12bda17ced171f9146c55fbd4aee2d\", \"gin_unittests\": \"2f2892d19b618ce45fb1ac0da631b422f2a2657e\", \"google_apis_unittests\": \"d3258c26977f2a912216310463a4ce8204c2ca56\", \"gpu_unittests\": \"dfbf71784278a040813609d4f388d1374455db04\", \"grit_python_unittests\": \"55fa961d85005331568451ce869e032331bd4b90\", \"gwp_asan_unittests\": \"a905ca9b6b9480fc00a0c4106a193f35b469abcb\", \"headless_browsertests\": \"b7726856e2d1b442c0a763befb8a5db0d99fb3d2\", \"headless_unittests\": \"55eecbbc045533a5f6d2b0eb2e9990ac354b5f21\", \"interactive_ui_tests\": \"8420172b29516ee01ac25c5856ab2a2b2fdeaee3\", \"ipc_tests\": \"5d9d1fb78d20bfe6d9ee0a307184e31872fa8ef5\", \"jingle_unittests\": \"1b55ca5476bc4e67f883f7abbaed43c0b2151546\", \"latency_unittests\": \"81c60e091ef2f2dd74a442aa8d842b767348370b\", \"libjingle_xmpp_unittests\": \"9633e03643c58588266d279bde38a024bfdb9b73\", \"media_blink_unittests\": \"a3f308d1c1a0a089b6df0cfbc54ba61732fbb16e\", \"media_unittests\": \"f2ff7eb904251364ae3c4aad9fb295bf2937c299\", \"message_center_unittests\": \"ef0b36fe686a020da7a476fca94f35b6078d99ef\", \"metrics_python_tests\": \"43e87e244101d73a9dff32c86a1c0dfbb88c3873\", \"midi_unittests\": \"7711289fa783951e3923a7a90d1efd4d37246e2e\", \"mojo_core_unittests\": \"4453e15f7c87b0f9df2c25a38603f623ecf2a89f\", \"mojo_unittests\": \"1ec2de557f4024db944d2adf1b56877458d4a61c\", \"nacl_helper_nonsfi_unittests\": \"e7ad4784f0b843f7391f4b353f6026c16b294f7c\", \"nacl_loader_unittests\": \"b6438d6bd554aa3cf9511fb4d4fb68f5ee0b4d41\", \"native_theme_unittests\": \"728d111458f35f689eb08a33382e46ecd752e27d\", \"net_unittests\": \"4440830724b344ed8ba4199c418d4e12bc60092f\", \"openscreen_unittests\": \"891f351d4df806c282fdaecab5c49a3baff9fb71\", \"pdf_unittests\": \"485b70a81b92b6e17cebbab0a66d16bcdca1917e\", \"perfetto_unittests\": \"bab85377c29a313fc8ff603f6b8784d3db201076\", \"ppapi_unittests\": \"4789427bc4970b4647f9dcaba4e1fd25ffce5423\", \"printing_unittests\": \"a8f6db07a9047d3f258cdba0f16dc3a2871ee32e\", \"remoting_unittests\": \"862addbaf712088a79ff1d5c2833378d020977e0\", \"sandbox_linux_unittests\": \"efdd4e571400bc7b50636cb346a4f538f35f09f3\", \"service_manager_unittests\": \"15719d62d164ab516ebc5602e09e619c0a4bf5e4\", \"services_unittests\": \"223c4917924648671bc98523999a32b6b59ef6fc\", \"shell_dialogs_unittests\": \"2539a027cbb3cb6e66fbd93982a64ab83d23a58c\", \"skia_unittests\": \"eeaa861cf292ece7f0ebcc721537cfda343b4874\", \"snapshot_unittests\": \"5b3b48ed95bd3f3741bc6bc090fbde7b42f6ffea\", \"sql_unittests\": \"d0d6d916a1026ac46c17cdc86d352fec5a20402c\", \"standalone_angle_unittests\": \"f16b025e43964c0e347dbdcda13bf3e7e228f5b1\", \"storage_unittests\": \"b317e90160428eb9757943512fe6aa2c6e916426\", \"sync_integration_tests\": \"05bd5951bbddd7c4a1f3272147975e2efee732c0\", \"telemetry_gpu_unittests\": \"d39ebe3cc4ca41b48d35b137451553873747c001\", \"telemetry_perf_unittests\": \"edc70eeb7002ed0235617bfec5018fe892ec9a4b\", \"telemetry_unittests\": \"4a991264505ab76a5495cc2d5943a944110073d3\", \"traffic_annotation_auditor_unittests\": \"3f63cb29a77d3685423056fff8b9da7353a8e4cd\", \"ui_base_unittests\": \"9d57aae71ed808cd3e7f4ad51fe7d19d57fe1890\", \"ui_touch_selection_unittests\": \"7c378275152d78bc897effabafba2a8ac8f3fd64\", \"unit_tests\": \"784ffaa4716650c9166545f98d5396d0075ed98d\", \"url_unittests\": \"50b030812460bcd38b6a5aabfefe3e89fcd3d987\", \"views_perftests\": \"2e836a8051d4346fae2e0c57eb57259e734b03bd\", \"views_unittests\": \"453f9d737f513d0c765fdbc7f4b2860070362974\", \"viz_unittests\": \"b9ed159fc23f95679c4295778fa7ead5536c2f19\", \"vr_common_unittests\": \"a5261a89f80535ea74ab2f34e830478dbf7688ef\", \"vr_pixeltests\": \"c3af458b81e4ce39cae578d11f27c234dcdbcad6\", \"webdriver_wpt_tests\": \"6e23ab7de4d4622f93bfd67f97cca6dfec041ccc\", \"weblayer_browsertests\": \"0ae9aafaddfec468ae00e6fb7cdb7cc9ea2a0a3e\", \"weblayer_unittests\": \"2c3c4e1d559eca549a363d7bdd3efe30617a0135\", \"wm_unittests\": \"2d750c0774842c98ca7c3d823558e90a358667f5\", \"wtf_unittests\": \"fdae154aefa830805546432e3d88bef46873e7a0\", \"x11_unittests\": \"9aaafb5961f3a36fd4f7856ef7ea30a3e75aa243\", \"xr_browser_tests\": \"b2f8a67750ba0e543727fb0ae5182fb205255dbf\", \"zlib_unittests\": \"19c461d0b6bd9b0e7ea388ec5818dfe02aaac29f\"}}, \"swarming\": {\"bot_dimensions\": {\"builderless\": [\"1\"], \"caches\": [\"builder_151f80801b9f29276c11c5f05dab27ce5673f9c9ba442aaf2cf20aab9215f522_v2\", \"builder_2fce50e69d80f7d3cf1b01087d63cb5fa68f8d968b73601af44a2f0cc34bc410_v2\", \"builder_5315cf154f9c1ae6b2621094599bc107171a849e1c0f232ec66a504ee800a364_v2\", \"builder_5ae174071c5d6730648bf4e0d5db68d27bfbde0d9c5b879a557aa1bc8e90c36b_v2\", \"builder_e21c17032b725bcf1c922976a36352546baf3f39ec148d1e6730a93c0400d8cc_v2\", \"builder_e7ad59aa200d68ebcc1a02549d22b636b3b4d989b688240b853e1dce9c0a2c9f_v2\", \"builder_ffe623326ac74578ce917ff55ef6cefa75094e5ad3ad5fe3409a729d79be647a_v2\", \"git\", \"goma_v2\", \"vpython\"], \"cores\": [\"8\"], \"cpu\": [\"x86\", \"x86-64\", \"x86-64-Haswell_GCE\", \"x86-64-avx2\"], \"gce\": [\"1\"], \"gcp\": [\"google.com:chromecompute\"], \"gpu\": [\"none\"], \"id\": [\"luci-chromium-ci-xenial-us-east1-d-8-102-8h21\"], \"image\": [\"chrome-xenial-20091600-9ddf7e422ac\"], \"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.chromium.ci\"], \"python\": [\"2.7.12\"], \"server_version\": [\"5570-fa4adf0\"], \"ssd\": [\"0\"], \"zone\": [\"us\", \"us-east\", \"us-east1\", \"us-east1-d\"]}}}",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"started_ts": "1602282677975125",
"status": "COMPLETED",
"status_changed_ts": "1602285436837659",
"tags": [
"build_address:luci.chromium.ci/Linux Builder (dbg)/176508",
"builder:Linux Builder (dbg)",
"buildset:commit/git/dd8308e5aa18ccd54b534cdc1db956847123a12f",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/dd8308e5aa18ccd54b534cdc1db956847123a12f",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9032308642321604896",
"scheduler_job_id:chromium/Linux Builder (dbg)",
"swarming_hostname:chromium-swarm.appspot.com",
"swarming_tag:log_location:logdog://logs.chromium.org/chromium/buildbucket/cr-buildbucket.appspot.com/8866878579373233344/+/annotations",
"swarming_tag:luci_project:chromium",
"swarming_tag:os:Linux",
"swarming_tag:recipe_name:chromium",
"swarming_tag:recipe_package:infra/recipe_bundles/chromium.googlesource.com/chromium/tools/build",
"swarming_task_id:4f284e9671153410",
"user_agent:luci-scheduler"
],
"updated_ts": "1602285436842709",
"url": "https://ci.chromium.org/b/8866878579373233344",
"utcnow_ts": "1602285437314145"
}
}
[23:17:17.365] Invocation finished in 46m25.193364895s with status SUCCEEDED