[22:58:08.376] New invocation is queued and will start shortly
[22:58:09.572] Starting the invocation (attempt 1)
[22:58:09.673] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[22:58:09.673] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[22:58:09.673] Buildbucket request:
{
"bucket": "luci.chromium.ci",
"client_operation_id": "9053506616790938896",
"parameters_json": "{\"builder_name\":\"Linux Builder (dbg)\",\"properties\":{\"branch\":\"refs/heads/master\",\"repository\":\"https://chromium.googlesource.com/chromium/src\",\"revision\":\"6a8b5442f363e879acba17e822ca3b99972fee11\"}}",
"pubsub_callback": {
"auth_token": "...",
"topic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
},
"tags": [
"builder:Linux Builder (dbg)",
"scheduler_invocation_id:9053506616790938896",
"scheduler_job_id:chromium/Linux Builder (dbg)",
"user_agent:luci-scheduler",
"buildset:commit/git/6a8b5442f363e879acba17e822ca3b99972fee11",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/6a8b5442f363e879acba17e822ca3b99972fee11",
"gitiles_ref:refs/heads/master"
]
}
[22:58:10.468] Buildbucket response:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "PROD",
"created_by": "project:chromium",
"created_ts": "1582066689827371",
"id": "8888076554606709856",
"parameters_json": "{\"builder_name\": \"Linux Builder (dbg)\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"6a8b5442f363e879acba17e822ca3b99972fee11\"}}",
"project": "chromium",
"result_details_json": "{\"properties\": {}}",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"status": "SCHEDULED",
"status_changed_ts": "1582066690311267",
"tags": [
"build_address:luci.chromium.ci/Linux Builder (dbg)/168770",
"builder:Linux Builder (dbg)",
"buildset:commit/git/6a8b5442f363e879acba17e822ca3b99972fee11",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/6a8b5442f363e879acba17e822ca3b99972fee11",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9053506616790938896",
"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/8888076554606709856/+/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": "1582066690311414",
"url": "https://ci.chromium.org/b/8888076554606709856",
"utcnow_ts": "1582066690457351"
}
}
[22:58:10.468] Task URL: https://ci.chromium.org/b/8888076554606709856
[22:58:10.468] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9053506616790938896:2:0) after 1m0s
[22:59:10.671] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9053506616790938896:2:0)
[22:59:10.671] Timer tick, asking Buildbucket for the build status
[22:59:10.809] Build 8888076554606709856: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[22:59:10.809] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9053506616790938896:3:0) after 1m0s
[23:00:10.907] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9053506616790938896:3:0)
[23:00:10.907] Timer tick, asking Buildbucket for the build status
[23:00:11.144] Build 8888076554606709856: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[23:00:11.144] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9053506616790938896:4:0) after 1m0s
[23:01:11.235] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9053506616790938896:4:0)
[23:01:11.235] Timer tick, asking Buildbucket for the build status
[23:01:11.326] Build 8888076554606709856: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[23:01:11.326] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9053506616790938896:5:0) after 1m0s
[23:02:11.477] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9053506616790938896:5:0)
[23:02:11.477] Timer tick, asking Buildbucket for the build status
[23:02:11.586] Build 8888076554606709856: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[23:02:11.590] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9053506616790938896:6:0) after 1m0s
[23:03:11.591] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9053506616790938896:6:0)
[23:03:11.591] Timer tick, asking Buildbucket for the build status
[23:03:11.956] Build 8888076554606709856: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[23:03:11.956] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9053506616790938896:7:0) after 1m0s
[23:04:12.085] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9053506616790938896:7:0)
[23:04:12.085] Timer tick, asking Buildbucket for the build status
[23:04:12.273] Build 8888076554606709856: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[23:04:12.273] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9053506616790938896:8:0) after 1m0s
[23:04:25.429] Received PubSub notification, asking Buildbucket for the build status
[23:04:25.533] Build 8888076554606709856: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:05:12.270] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9053506616790938896:8:0)
[23:05:12.270] Timer tick, asking Buildbucket for the build status
[23:05:12.422] Build 8888076554606709856: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:05:12.422] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9053506616790938896:10:0) after 1m0s
[23:06:12.484] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9053506616790938896:10:0)
[23:06:12.484] Timer tick, asking Buildbucket for the build status
[23:06:12.612] Build 8888076554606709856: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:06:12.612] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9053506616790938896:11:0) after 1m0s
[23:07:12.709] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9053506616790938896:11:0)
[23:07:12.709] Timer tick, asking Buildbucket for the build status
[23:07:12.836] Build 8888076554606709856: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:07:12.836] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9053506616790938896:12:0) after 1m0s
[23:08:12.888] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9053506616790938896:12:0)
[23:08:12.888] Timer tick, asking Buildbucket for the build status
[23:08:13.079] Build 8888076554606709856: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:08:13.079] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9053506616790938896:13:0) after 1m0s
[23:09:13.199] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9053506616790938896:13:0)
[23:09:13.199] Timer tick, asking Buildbucket for the build status
[23:09:13.304] Build 8888076554606709856: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:09:13.304] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9053506616790938896:14:0) after 1m0s
[23:10:13.295] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9053506616790938896:14:0)
[23:10:13.295] Timer tick, asking Buildbucket for the build status
[23:10:13.581] Build 8888076554606709856: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:10:13.581] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9053506616790938896:15:0) after 1m0s
[23:11:13.608] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9053506616790938896:15:0)
[23:11:13.608] Timer tick, asking Buildbucket for the build status
[23:11:13.719] Build 8888076554606709856: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:11:13.719] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9053506616790938896:16:0) after 1m0s
[23:12:13.752] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9053506616790938896:16:0)
[23:12:13.752] Timer tick, asking Buildbucket for the build status
[23:12:13.850] Build 8888076554606709856: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:12:13.851] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9053506616790938896:17:0) after 1m0s
[23:13:13.862] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9053506616790938896:17:0)
[23:13:13.862] Timer tick, asking Buildbucket for the build status
[23:13:13.996] Build 8888076554606709856: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:13:13.996] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9053506616790938896:18:0) after 1m0s
[23:14:14.076] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9053506616790938896:18:0)
[23:14:14.076] Timer tick, asking Buildbucket for the build status
[23:14:14.477] Build 8888076554606709856: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:14:14.477] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9053506616790938896:19:0) after 1m0s
[23:15:14.552] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9053506616790938896:19:0)
[23:15:14.552] Timer tick, asking Buildbucket for the build status
[23:15:14.669] Build 8888076554606709856: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:15:14.669] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9053506616790938896:20:0) after 1m0s
[23:16:14.779] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9053506616790938896:20:0)
[23:16:14.779] Timer tick, asking Buildbucket for the build status
[23:16:14.916] Build 8888076554606709856: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:16:14.916] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9053506616790938896:21:0) after 1m0s
[23:17:14.989] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9053506616790938896:21:0)
[23:17:14.989] Timer tick, asking Buildbucket for the build status
[23:17:15.063] Build 8888076554606709856: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:17:15.063] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9053506616790938896:22:0) after 1m0s
[23:18:15.311] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9053506616790938896:22:0)
[23:18:15.311] Timer tick, asking Buildbucket for the build status
[23:18:15.415] Build 8888076554606709856: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:18:15.415] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9053506616790938896:23:0) after 1m0s
[23:19:15.430] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9053506616790938896:23:0)
[23:19:15.430] Timer tick, asking Buildbucket for the build status
[23:19:15.522] Build 8888076554606709856: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:19:15.522] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9053506616790938896:24:0) after 1m0s
[23:20:15.552] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9053506616790938896:24:0)
[23:20:15.552] Timer tick, asking Buildbucket for the build status
[23:20:15.887] Build 8888076554606709856: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:20:15.887] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9053506616790938896:25:0) after 1m0s
[23:21:15.899] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9053506616790938896:25:0)
[23:21:15.899] Timer tick, asking Buildbucket for the build status
[23:21:16.099] Build 8888076554606709856: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:21:16.099] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9053506616790938896:26:0) after 1m0s
[23:22:16.149] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9053506616790938896:26:0)
[23:22:16.149] Timer tick, asking Buildbucket for the build status
[23:22:16.300] Build 8888076554606709856: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:22:16.300] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9053506616790938896:27:0) after 1m0s
[23:23:16.366] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9053506616790938896:27:0)
[23:23:16.366] Timer tick, asking Buildbucket for the build status
[23:23:16.627] Build 8888076554606709856: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:23:16.627] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9053506616790938896:28:0) after 1m0s
[23:24:16.716] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9053506616790938896:28:0)
[23:24:16.716] Timer tick, asking Buildbucket for the build status
[23:24:16.905] Build 8888076554606709856: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:24:16.905] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9053506616790938896:29:0) after 1m0s
[23:25:16.957] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9053506616790938896:29:0)
[23:25:16.957] Timer tick, asking Buildbucket for the build status
[23:25:17.169] Build 8888076554606709856: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:25:17.169] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9053506616790938896:30:0) after 1m0s
[23:26:17.271] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9053506616790938896:30:0)
[23:26:17.271] Timer tick, asking Buildbucket for the build status
[23:26:17.409] Build 8888076554606709856: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:26:17.409] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9053506616790938896:31:0) after 1m0s
[23:27:17.595] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9053506616790938896:31:0)
[23:27:17.595] Timer tick, asking Buildbucket for the build status
[23:27:20.050] Build 8888076554606709856: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:27:20.050] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9053506616790938896:32:0) after 1m0s
[23:28:20.042] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9053506616790938896:32:0)
[23:28:20.042] Timer tick, asking Buildbucket for the build status
[23:28:20.381] Build 8888076554606709856: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:28:20.381] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9053506616790938896:33:0) after 1m0s
[23:29:20.563] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9053506616790938896:33:0)
[23:29:20.563] Timer tick, asking Buildbucket for the build status
[23:29:20.961] Build 8888076554606709856: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:29:20.961] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9053506616790938896:34:0) after 1m0s
[23:30:21.167] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9053506616790938896:34:0)
[23:30:21.167] Timer tick, asking Buildbucket for the build status
[23:30:21.264] Build 8888076554606709856: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:30:21.264] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9053506616790938896:35:0) after 1m0s
[23:31:21.324] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9053506616790938896:35:0)
[23:31:21.324] Timer tick, asking Buildbucket for the build status
[23:31:21.415] Build 8888076554606709856: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:31:21.415] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9053506616790938896:36:0) after 1m0s
[23:32:21.646] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9053506616790938896:36:0)
[23:32:21.646] Timer tick, asking Buildbucket for the build status
[23:32:21.790] Build 8888076554606709856: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:32:21.790] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9053506616790938896:37:0) after 1m0s
[23:33:21.817] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9053506616790938896:37:0)
[23:33:21.817] Timer tick, asking Buildbucket for the build status
[23:33:22.052] Build 8888076554606709856: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:33:22.052] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9053506616790938896:38:0) after 1m0s
[23:34:22.106] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9053506616790938896:38:0)
[23:34:22.106] Timer tick, asking Buildbucket for the build status
[23:34:22.322] Build 8888076554606709856: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:34:22.322] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9053506616790938896:39:0) after 1m0s
[23:35:22.403] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9053506616790938896:39:0)
[23:35:22.403] Timer tick, asking Buildbucket for the build status
[23:35:22.521] Build 8888076554606709856: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:35:22.521] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9053506616790938896:40:0) after 1m0s
[23:36:22.595] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9053506616790938896:40:0)
[23:36:22.595] Timer tick, asking Buildbucket for the build status
[23:36:22.754] Build 8888076554606709856: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:36:22.754] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9053506616790938896:41:0) after 1m0s
[23:37:22.857] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9053506616790938896:41:0)
[23:37:22.857] Timer tick, asking Buildbucket for the build status
[23:37:23.043] Build 8888076554606709856: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:37:23.043] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9053506616790938896:42:0) after 1m0s
[23:38:23.131] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9053506616790938896:42:0)
[23:38:23.131] Timer tick, asking Buildbucket for the build status
[23:38:23.310] Build 8888076554606709856: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:38:23.310] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9053506616790938896:43:0) after 1m0s
[23:39:23.398] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9053506616790938896:43:0)
[23:39:23.398] Timer tick, asking Buildbucket for the build status
[23:39:23.683] Build 8888076554606709856: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:39:23.683] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9053506616790938896:44:0) after 1m0s
[23:40:23.756] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9053506616790938896:44:0)
[23:40:23.756] Timer tick, asking Buildbucket for the build status
[23:40:23.873] Build 8888076554606709856: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:40:23.873] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9053506616790938896:45:0) after 1m0s
[23:41:23.898] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9053506616790938896:45:0)
[23:41:23.898] Timer tick, asking Buildbucket for the build status
[23:41:24.002] Build 8888076554606709856: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:41:24.002] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9053506616790938896:46:0) after 1m0s
[23:42:24.028] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9053506616790938896:46:0)
[23:42:24.028] Timer tick, asking Buildbucket for the build status
[23:42:24.175] Build 8888076554606709856: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:42:24.175] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9053506616790938896:47:0) after 1m0s
[23:43:24.322] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9053506616790938896:47:0)
[23:43:24.322] Timer tick, asking Buildbucket for the build status
[23:43:25.072] Build 8888076554606709856: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:43:25.072] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9053506616790938896:48:0) after 1m0s
[23:44:25.204] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9053506616790938896:48:0)
[23:44:25.204] Timer tick, asking Buildbucket for the build status
[23:44:25.529] Build 8888076554606709856: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:44:25.529] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9053506616790938896:49:0) after 1m0s
[23:45:25.517] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9053506616790938896:49:0)
[23:45:25.517] Timer tick, asking Buildbucket for the build status
[23:45:25.636] Build 8888076554606709856: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:45:25.636] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9053506616790938896:50:0) after 1m0s
[23:46:25.739] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9053506616790938896:50:0)
[23:46:25.739] Timer tick, asking Buildbucket for the build status
[23:46:25.929] Build 8888076554606709856: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:46:25.929] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9053506616790938896:51:0) after 1m0s
[23:47:25.981] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9053506616790938896:51:0)
[23:47:25.981] Timer tick, asking Buildbucket for the build status
[23:47:26.359] Build 8888076554606709856: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:47:26.359] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9053506616790938896:52:0) after 1m0s
[23:48:26.414] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9053506616790938896:52:0)
[23:48:26.414] Timer tick, asking Buildbucket for the build status
[23:48:26.683] Build 8888076554606709856: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:48:26.683] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9053506616790938896:53:0) after 1m0s
[23:49:26.814] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9053506616790938896:53:0)
[23:49:26.814] Timer tick, asking Buildbucket for the build status
[23:49:26.951] Build 8888076554606709856: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:49:26.951] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9053506616790938896:54:0) after 1m0s
[23:50:27.025] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9053506616790938896:54:0)
[23:50:27.025] Timer tick, asking Buildbucket for the build status
[23:50:27.171] Build 8888076554606709856: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:50:27.171] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9053506616790938896:55:0) after 1m0s
[23:51:27.347] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9053506616790938896:55:0)
[23:51:27.347] Timer tick, asking Buildbucket for the build status
[23:51:28.065] Build 8888076554606709856: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:51:28.065] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9053506616790938896:56:0) after 1m0s
[23:52:28.287] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9053506616790938896:56:0)
[23:52:28.287] Timer tick, asking Buildbucket for the build status
[23:52:28.400] Build 8888076554606709856: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:52:28.400] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9053506616790938896:57:0) after 1m0s
[23:53:28.580] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9053506616790938896:57:0)
[23:53:28.580] Timer tick, asking Buildbucket for the build status
[23:53:28.870] Build 8888076554606709856: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:53:28.870] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9053506616790938896:58:0) after 1m0s
[23:54:28.980] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9053506616790938896:58:0)
[23:54:28.980] Timer tick, asking Buildbucket for the build status
[23:54:29.355] Build 8888076554606709856: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:54:29.355] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9053506616790938896:59:0) after 1m0s
[23:55:29.522] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9053506616790938896:59:0)
[23:55:29.522] Timer tick, asking Buildbucket for the build status
[23:55:29.694] Build 8888076554606709856: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:55:29.694] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9053506616790938896:60:0) after 1m0s
[23:56:29.814] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9053506616790938896:60:0)
[23:56:29.814] Timer tick, asking Buildbucket for the build status
[23:56:29.941] Build 8888076554606709856: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:56:29.941] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9053506616790938896:61:0) after 1m0s
[23:57:30.082] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9053506616790938896:61:0)
[23:57:30.082] Timer tick, asking Buildbucket for the build status
[23:57:30.735] Build 8888076554606709856: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:57:30.736] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9053506616790938896:62:0) after 1m0s
[23:58:30.926] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9053506616790938896:62:0)
[23:58:30.926] Timer tick, asking Buildbucket for the build status
[23:58:31.072] Build 8888076554606709856: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:58:31.072] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9053506616790938896:63:0) after 1m0s
[23:59:31.122] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9053506616790938896:63:0)
[23:59:31.122] Timer tick, asking Buildbucket for the build status
[23:59:31.621] Build 8888076554606709856: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:59:31.621] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9053506616790938896:64:0) after 1m0s
[00:00:31.743] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9053506616790938896:64:0)
[00:00:31.743] Timer tick, asking Buildbucket for the build status
[00:00:31.973] Build 8888076554606709856: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:00:31.973] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9053506616790938896:65:0) after 1m0s
[00:01:14.206] Received PubSub notification, asking Buildbucket for the build status
[00:01:14.325] Build 8888076554606709856: status "COMPLETED", result "SUCCESS", failure_reason "", cancelation_reason ""
[00:01:14.331] Buildbucket build:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "PROD",
"completed_ts": "1582070472560338",
"created_by": "project:chromium",
"created_ts": "1582066689827371",
"id": "8888076554606709856",
"parameters_json": "{\"builder_name\": \"Linux Builder (dbg)\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"6a8b5442f363e879acba17e822ca3b99972fee11\"}}",
"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\"}, \"$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-central1-b-8-81-bq7t\", \"branch\": \"refs/heads/master\", \"buildername\": \"Linux Builder (dbg)\", \"buildnumber\": 168770, \"got_angle_revision\": \"4b7bac78a9eab3a6ed4fb2815a2d0e42cb3586e4\", \"got_dawn_revision\": \"0aa86a7ae8315f93f9501323dc082af0ac869efc\", \"got_nacl_revision\": \"3651f6c52037c96e034cc422746768d59182bff3\", \"got_revision\": \"6a8b5442f363e879acba17e822ca3b99972fee11\", \"got_revision_cp\": \"refs/heads/master@{#742359}\", \"got_swarming_client_revision\": \"0ac28472d073a515124c85b128c4378a914e0a4d\", \"got_swiftshader_revision\": \"8def9063c4fdefa8e644198d2254ef279952c88b\", \"got_v8_revision\": \"f3d47a2e98b703d1cef05764686571866f6c0f49\", \"got_v8_revision_cp\": \"refs/heads/8.2.109@{#1}\", \"got_webrtc_revision\": \"18c617989b21206b27b0cf6900ecf66259566518\", \"got_webrtc_revision_cp\": \"refs/heads/master@{#30535}\", \"isolate_server\": \"https://isolateserver.appspot.com\", \"mastername\": \"chromium.linux\", \"path_config\": \"generic\", \"recipe\": \"chromium\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"6a8b5442f363e879acba17e822ca3b99972fee11\", \"swarm_hashes_refs/heads/master(at){#742359}_without_patch\": {\"accessibility_unittests\": \"a54d34f934eec490d9c5e7b12858a25005cafb8e\", \"angle_unittests\": \"cf0c28e99ff234760954db06b956063ace075f76\", \"app_shell_unittests\": \"a9214f5f08b033fcd613dcddece0ab64df3c618b\", \"aura_unittests\": \"8e440f69a711d3a8cbfa9da4fb7813ea9ef7675c\", \"base_unittests\": \"c3a8f9776872839a88bbec40085a948b2244c767\", \"base_util_unittests\": \"468deb0cf39f9fef5e3d18baa5a8609b86f47b57\", \"blink_common_unittests\": \"d24d8c7dc16a82f2986416474c82c00b11a58821\", \"blink_fuzzer_unittests\": \"b5cf8bdf2ca6f8b4e21be64b8a0e99c5fd655fde\", \"blink_heap_unittests\": \"cac166738972cbfcbef34f4d234f8b1856174156\", \"blink_platform_unittests\": \"8063f824f1461a80ef2571bb48b58208a1eed2b0\", \"blink_python_tests\": \"9214b5899a3f5c0deb1d1ea4a095e0ae73a0e087\", \"blink_unittests\": \"5faf6ff0a555bebdef14f22a58ab9c91d79e5047\", \"blink_web_tests\": \"678bb0ba2222344c7227d8522e5eff02f81aa33e\", \"boringssl_crypto_tests\": \"9ca2279dbeb2756495ac34cf237e59358588fb48\", \"boringssl_ssl_tests\": \"53725b9d83fa01fe5ec43a0332dfbd8f52c4fb60\", \"browser_tests\": \"20a0992a9147d37e1ddb7b4bbbba7603ec63251b\", \"cacheinvalidation_unittests\": \"323e1e46995659bd764637a2e9c566a75979b25a\", \"capture_unittests\": \"17d634f815fa89b5d53d7a542d7e323356d100b6\", \"cast_unittests\": \"49cd97ff71ba48fd38342e960627609ebccbca41\", \"cc_unittests\": \"63ba0c6d4eeaeff82180e78d21f17cc6259eb7fa\", \"chrome_app_unittests\": \"892ff2513946b3d214a18cdaa5836943484fa8d5\", \"chromedriver_unittests\": \"d2e3617451360e28846f50a6efc2ef63286bf48d\", \"components_browsertests\": \"ae3b9100a20547f220e81f9e338a371650c154a7\", \"components_unittests\": \"486dde5ca8b6837260bef443ce033f6d47eb044c\", \"compositor_unittests\": \"38ca6c1cef5961b81a662f82c6eea2c932ead06e\", \"content_browsertests\": \"817159a341fd145a7b1260d6e28dd5a480df45b5\", \"content_shell_crash_test\": \"6cf1d796527b68e37ba00f844d19980c309e7426\", \"content_unittests\": \"aea21fff455285fcafdcccb529c1f50fcb94fec0\", \"crashpad_tests\": \"cac984c945cbf6f7dc7781448e6b591e2483edc7\", \"cronet_tests\": \"095b69028024adc7d4c10b4672ade03dea2300d5\", \"cronet_unittests\": \"d352a5252ef0bd5fa00dfd05ba2ceaf77e5dd617\", \"crypto_unittests\": \"fcddc88bb52f3a163e02daf079980ea5326ae57e\", \"dbus_unittests\": \"84c4dff3925f67cd30fa0a97555595f347a67ca8\", \"device_unittests\": \"577a2cd6559e2a34c3fc24c859c4136106072d48\", \"display_unittests\": \"5b013ab0e44dd83f9737a12c9b4e425ea1a76ead\", \"events_unittests\": \"199db55f0e38735017ddaa4bf0b4bf847beaf9db\", \"extensions_browsertests\": \"1420b9f5fc2fba7c3d5c550dd7ac5b39f0560187\", \"extensions_unittests\": \"e315758c729a964692f0fc16d8cd2b63e80f3c53\", \"filesystem_service_unittests\": \"d06ab56b7be3180adfd024504ec1909fbddca242\", \"flatbuffers_unittests\": \"9eab69acab0f6bd1460710d9ac6e8475de73625c\", \"gcm_unit_tests\": \"8fec5f76e1a9f81ea15f8603f3c565187d1eed9f\", \"gfx_unittests\": \"59152822f27fd3bd6b5512d4e25720d5a6ffae88\", \"gin_unittests\": \"c690ab5c04b16e01a6f9712cbbe55abd8cf6125e\", \"google_apis_unittests\": \"31436a8d95c6d954530dd53e5574a85347f69602\", \"gpu_unittests\": \"6889d64d76a72ab1b7956691c7ddb367bbed598e\", \"grit_python_unittests\": \"0a186e54539d3475bae4b9d19cc134d9a92e2108\", \"gwp_asan_unittests\": \"07223e118d9ad92e1d3a8c532b700b0a720fed09\", \"headless_browsertests\": \"4477d696e520a48fc6bb3a0924daf9e45e6d8447\", \"headless_unittests\": \"360ff4b89addb328786bfa0eda53dda09883436b\", \"interactive_ui_tests\": \"b4a3c4b1d12ec28c7b6b714b6d19a249f291b47a\", \"ipc_tests\": \"98607666ad2dc8b6e53ce09a190104edef3e413e\", \"jingle_unittests\": \"c1f07e5c2ea9ff143f6af1796f863ea273d484e1\", \"latency_unittests\": \"46281a3e5c7f4ab19b2542d894117809d3ecf85f\", \"libjingle_xmpp_unittests\": \"7c762d231cad28d9c939273efba9e9e8fd30d0b6\", \"media_blink_unittests\": \"b5dad93ea5e29eefaedec86cb480fc263476dbb1\", \"media_service_unittests\": \"c13c91239f592b54a75ad8da9c10eec9c4514f5b\", \"media_unittests\": \"2584b9945356b92db019b8ac240d938ac9c1fb4e\", \"message_center_unittests\": \"6258056496be6d39c567f5184ee71bea623244ed\", \"metrics_python_tests\": \"28cae615e63c4a271e567e88c482712f94653e2e\", \"midi_unittests\": \"d98e70a2d4514d4ef0646c6c7f8419ea9a43a0dc\", \"mojo_core_unittests\": \"8beb0870975f242a2f4e012e3859e98407d4e143\", \"mojo_unittests\": \"04e4d33cb41519d7fe0c99d031b7c40b633c6baf\", \"nacl_helper_nonsfi_unittests\": \"9dad0cdf1df497baf07ecef7be5eb9bb122cbbc4\", \"nacl_loader_unittests\": \"5144b2b93a11006b44cc78000c7abd2350acc8dd\", \"native_theme_unittests\": \"afcd893af5a93a33e0b9153cfdc076f8700c6f06\", \"net_unittests\": \"2db08106f7812d6fe2238c88d435c53d432de16c\", \"pdf_unittests\": \"a28c05589561fd4f59817b5e3bc12c1d4f279e28\", \"perfetto_unittests\": \"16a1aa16394f7d0420398f8c436b16de89b9bb66\", \"ppapi_unittests\": \"4d064a3e875e305d1947477761c6afbc122c95b4\", \"printing_unittests\": \"c004a42b172cbd053b87230c049e0840981f97fd\", \"remoting_unittests\": \"315e5dbe58995d00150aaace85016b1b24da9e79\", \"sandbox_linux_unittests\": \"49333a7bacfab78ba5f30b5b83a585b4aba61dcc\", \"service_manager_unittests\": \"a0cd22e711210e0f1f731212145e837b49481367\", \"services_unittests\": \"54fc1ef7df93d3c6daa7ed73891b95375ec857ce\", \"shell_dialogs_unittests\": \"fc705f3070d298d29ca7109346951bd80a56c258\", \"skia_unittests\": \"60b4fab8a77133d61d370cf11dbddafce5b56660\", \"snapshot_unittests\": \"a57f8111229676abd4a3869a20af9e7607562d29\", \"sql_unittests\": \"17a985241baacb73b9c0b748806301ff4e7e3f64\", \"storage_unittests\": \"67f360f5e9477f22f5d5dadc7a2edd3c644e7277\", \"sync_integration_tests\": \"5cb1faec194b609ffa2d63537b4edf7463c26618\", \"telemetry_gpu_unittests\": \"033c1d30e016dce1b9df87f513cbc7cb57c0d201\", \"telemetry_perf_unittests\": \"7a3ae80efc4c389b5987e9a3306feb9c5be379a2\", \"telemetry_unittests\": \"ddeceef02282ae805183ef2b012e86ad076d433e\", \"traffic_annotation_auditor_unittests\": \"4af659be5115c836d5e56cf2a1936014f59db766\", \"ui_base_unittests\": \"cea710ff1fcf5230e32f8a02ebe39b65ba842a44\", \"ui_touch_selection_unittests\": \"e4dc21ff99306a3adf3e70057077059f2183280a\", \"unit_tests\": \"3f1e27344cfbd576be8fa54c55c39101608d4dc8\", \"url_unittests\": \"623ecb0eff99f76d7664edd19fb38c011b4c4997\", \"views_perftests\": \"c9f444d3523ce37830dc701ec7949d0e7aec44d0\", \"views_unittests\": \"ac5213958bea039762d414b3ac49ff80a9da88fd\", \"viz_unittests\": \"68a1157869a0eb0a1c2ebe2fae0b451a8df52ba2\", \"vr_common_unittests\": \"2add15b2a12065094a7054c1868f5203e34beb5f\", \"vr_pixeltests\": \"bbc5aee121930c8591551d9e970dda5d1544c7e6\", \"webdriver_wpt_tests\": \"7c05da3b76896a9fa6c67ebf42017d7105324a6e\", \"weblayer_browsertests\": \"3754cce269c761e277629348ffb0d3607a75ac3a\", \"wm_unittests\": \"5c50a04287c6ad1e0652cf79ea18d43728ef4891\", \"wtf_unittests\": \"951e5c551367a72d7c4f2c6d724169aca1bf1678\", \"xr_browser_tests\": \"fa2351f189a648c6c4b63fb46dc46bdf9b0ff810\"}}, \"swarming\": {\"bot_dimensions\": {\"builderless\": [\"1\"], \"caches\": [\"builder_0095fe006eafdabf54002a791fb8c836a288874203ece8347c24b74b8d090ce3_v2\", \"builder_3d74f5cea4cbf91e4b26f92a522c5c74e61b738440ef29ba16f5c9a596a5b201_v2\", \"builder_4146122e9519f0d375bf270f7dbe7aaaad2aebc25c303d6d6f0d3252ec13806e_v2\", \"builder_51603c189459d949c9f9b05c6193f37cd30704e77931c7dc651854102fbe3f3d_v2\", \"builder_562e40d9a0016a631bf2d4b73416a93abb069b959f020aa1a03e04f54d5ec620_v2\", \"builder_e961d9d7e9bca679490a4aaa8599bd975f9b7e0b713a988ed6895a059d04d2ac_v2\", \"git\", \"goma_v2\", \"vpython\"], \"cores\": [\"8\"], \"cpu\": [\"x86\", \"x86-64\", \"x86-64-Broadwell_GCE\", \"x86-64-avx2\"], \"gce\": [\"1\"], \"gcp\": [\"google.com:chromecompute\"], \"gpu\": [\"none\"], \"id\": [\"luci-chromium-ci-xenial-us-central1-b-8-81-bq7t\"], \"image\": [\"chrome-xenial-20012600-8e1a7e485b7\"], \"inside_docker\": [\"0\"], \"kvm\": [\"1\"], \"locale\": [\"en_US.UTF-8\"], \"machine_type\": [\"n1-standard-8\"], \"os\": [\"Linux\", \"Ubuntu\", \"Ubuntu-16.04\"], \"pool\": [\"luci.chromium.ci\"], \"python\": [\"2.7.12\"], \"server_version\": [\"4821-6a867f1\"], \"ssd\": [\"0\"], \"zone\": [\"us\", \"us-central\", \"us-central1\", \"us-central1-b\"]}}}",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"started_ts": "1582067064704802",
"status": "COMPLETED",
"status_changed_ts": "1582070473258096",
"tags": [
"build_address:luci.chromium.ci/Linux Builder (dbg)/168770",
"builder:Linux Builder (dbg)",
"buildset:commit/git/6a8b5442f363e879acba17e822ca3b99972fee11",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/6a8b5442f363e879acba17e822ca3b99972fee11",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9053506616790938896",
"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/8888076554606709856/+/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:4a7357726d662910",
"user_agent:luci-scheduler"
],
"updated_ts": "1582070473269777",
"url": "https://ci.chromium.org/b/8888076554606709856",
"utcnow_ts": "1582070474285833"
}
}
[00:01:14.332] Invocation finished in 1h3m5.972110056s with status SUCCEEDED