[06:16:16.122] New invocation is queued and will start shortly
[06:16:17.209] Starting the invocation (attempt 1)
[06:16:17.247] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[06:16:17.247] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[06:16:17.247] Buildbucket request:
{
"bucket": "luci.chromium.ci",
"client_operation_id": "9057284124684463520",
"parameters_json": "{\"builder_name\":\"Linux Builder (dbg)\",\"properties\":{\"branch\":\"refs/heads/master\",\"repository\":\"https://chromium.googlesource.com/chromium/src\",\"revision\":\"ed1f5386339460b628430d343beb30a886548c52\"}}",
"pubsub_callback": {
"auth_token": "...",
"topic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
},
"tags": [
"builder:Linux Builder (dbg)",
"scheduler_invocation_id:9057284124684463520",
"scheduler_job_id:chromium/Linux Builder (dbg)",
"user_agent:luci-scheduler",
"buildset:commit/git/ed1f5386339460b628430d343beb30a886548c52",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/ed1f5386339460b628430d343beb30a886548c52",
"gitiles_ref:refs/heads/master"
]
}
[06:16:18.068] Buildbucket response:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "PROD",
"created_by": "project:chromium",
"created_ts": "1578464177399007",
"id": "8891854062678137104",
"parameters_json": "{\"builder_name\": \"Linux Builder (dbg)\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"ed1f5386339460b628430d343beb30a886548c52\"}}",
"project": "chromium",
"result_details_json": "{\"properties\": {}}",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"status": "SCHEDULED",
"status_changed_ts": "1578464177923294",
"tags": [
"build_address:luci.chromium.ci/Linux Builder (dbg)/167110",
"builder:Linux Builder (dbg)",
"buildset:commit/git/ed1f5386339460b628430d343beb30a886548c52",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/ed1f5386339460b628430d343beb30a886548c52",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9057284124684463520",
"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/8891854062678137104/+/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": "1578464177923430",
"url": "https://ci.chromium.org/b/8891854062678137104",
"utcnow_ts": "1578464178056946"
}
}
[06:16:18.068] Task URL: https://ci.chromium.org/b/8891854062678137104
[06:16:18.068] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9057284124684463520:2:0) after 1m0s
[06:17:18.193] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9057284124684463520:2:0)
[06:17:18.193] Timer tick, asking Buildbucket for the build status
[06:17:18.873] Build 8891854062678137104: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[06:17:18.873] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9057284124684463520:3:0) after 1m0s
[06:18:18.932] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9057284124684463520:3:0)
[06:18:18.932] Timer tick, asking Buildbucket for the build status
[06:18:19.192] Build 8891854062678137104: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[06:18:19.192] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9057284124684463520:4:0) after 1m0s
[06:19:19.263] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9057284124684463520:4:0)
[06:19:19.263] Timer tick, asking Buildbucket for the build status
[06:19:19.495] Build 8891854062678137104: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[06:19:19.495] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9057284124684463520:5:0) after 1m0s
[06:20:19.707] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9057284124684463520:5:0)
[06:20:19.707] Timer tick, asking Buildbucket for the build status
[06:20:20.701] Build 8891854062678137104: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[06:20:20.701] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9057284124684463520:6:0) after 1m0s
[06:21:03.161] Received PubSub notification, asking Buildbucket for the build status
[06:21:03.304] Build 8891854062678137104: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:21:20.823] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9057284124684463520:6:0)
[06:21:20.823] Timer tick, asking Buildbucket for the build status
[06:21:20.980] Build 8891854062678137104: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:21:20.980] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9057284124684463520:8:0) after 1m0s
[06:22:21.077] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9057284124684463520:8:0)
[06:22:21.077] Timer tick, asking Buildbucket for the build status
[06:22:21.263] Build 8891854062678137104: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:22:21.263] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9057284124684463520:9:0) after 1m0s
[06:23:21.362] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9057284124684463520:9:0)
[06:23:21.362] Timer tick, asking Buildbucket for the build status
[06:23:22.794] Build 8891854062678137104: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:23:22.794] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9057284124684463520:10:0) after 1m0s
[06:24:22.817] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9057284124684463520:10:0)
[06:24:22.817] Timer tick, asking Buildbucket for the build status
[06:24:23.288] Build 8891854062678137104: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:24:23.288] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9057284124684463520:11:0) after 1m0s
[06:25:23.436] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9057284124684463520:11:0)
[06:25:23.436] Timer tick, asking Buildbucket for the build status
[06:25:23.611] Build 8891854062678137104: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:25:23.611] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9057284124684463520:12:0) after 1m0s
[06:26:23.628] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9057284124684463520:12:0)
[06:26:23.628] Timer tick, asking Buildbucket for the build status
[06:26:24.191] Build 8891854062678137104: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:26:24.191] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9057284124684463520:13:0) after 1m0s
[06:27:24.208] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9057284124684463520:13:0)
[06:27:24.208] Timer tick, asking Buildbucket for the build status
[06:27:24.793] Build 8891854062678137104: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:27:24.793] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9057284124684463520:14:0) after 1m0s
[06:28:24.880] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9057284124684463520:14:0)
[06:28:24.880] Timer tick, asking Buildbucket for the build status
[06:28:25.208] Build 8891854062678137104: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:28:25.208] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9057284124684463520:15:0) after 1m0s
[06:29:25.266] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9057284124684463520:15:0)
[06:29:25.266] Timer tick, asking Buildbucket for the build status
[06:29:25.431] Build 8891854062678137104: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:29:25.431] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9057284124684463520:16:0) after 1m0s
[06:30:25.486] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9057284124684463520:16:0)
[06:30:25.486] Timer tick, asking Buildbucket for the build status
[06:30:25.993] Build 8891854062678137104: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:30:25.993] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9057284124684463520:17:0) after 1m0s
[06:31:25.992] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9057284124684463520:17:0)
[06:31:25.992] Timer tick, asking Buildbucket for the build status
[06:31:26.276] Build 8891854062678137104: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:31:26.276] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9057284124684463520:18:0) after 1m0s
[06:32:26.296] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9057284124684463520:18:0)
[06:32:26.296] Timer tick, asking Buildbucket for the build status
[06:32:26.482] Build 8891854062678137104: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:32:26.482] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9057284124684463520:19:0) after 1m0s
[06:33:26.512] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9057284124684463520:19:0)
[06:33:26.512] Timer tick, asking Buildbucket for the build status
[06:33:27.451] Build 8891854062678137104: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:33:27.451] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9057284124684463520:20:0) after 1m0s
[06:34:27.511] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9057284124684463520:20:0)
[06:34:27.511] Timer tick, asking Buildbucket for the build status
[06:34:28.495] Build 8891854062678137104: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:34:28.495] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9057284124684463520:21:0) after 1m0s
[06:35:28.526] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9057284124684463520:21:0)
[06:35:28.526] Timer tick, asking Buildbucket for the build status
[06:35:28.776] Build 8891854062678137104: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:35:28.776] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9057284124684463520:22:0) after 1m0s
[06:36:28.883] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9057284124684463520:22:0)
[06:36:28.883] Timer tick, asking Buildbucket for the build status
[06:36:29.262] Build 8891854062678137104: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:36:29.262] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9057284124684463520:23:0) after 1m0s
[06:37:29.313] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9057284124684463520:23:0)
[06:37:29.313] Timer tick, asking Buildbucket for the build status
[06:37:29.490] Build 8891854062678137104: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:37:29.490] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9057284124684463520:24:0) after 1m0s
[06:38:29.518] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9057284124684463520:24:0)
[06:38:29.518] Timer tick, asking Buildbucket for the build status
[06:38:30.078] Build 8891854062678137104: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:38:30.078] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9057284124684463520:25:0) after 1m0s
[06:39:30.136] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9057284124684463520:25:0)
[06:39:30.136] Timer tick, asking Buildbucket for the build status
[06:39:30.357] Build 8891854062678137104: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:39:30.357] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9057284124684463520:26:0) after 1m0s
[06:40:30.386] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9057284124684463520:26:0)
[06:40:30.386] Timer tick, asking Buildbucket for the build status
[06:40:30.625] Build 8891854062678137104: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:40:30.625] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9057284124684463520:27:0) after 1m0s
[06:41:30.652] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9057284124684463520:27:0)
[06:41:30.652] Timer tick, asking Buildbucket for the build status
[06:41:30.911] Build 8891854062678137104: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:41:30.911] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9057284124684463520:28:0) after 1m0s
[06:42:30.968] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9057284124684463520:28:0)
[06:42:30.968] Timer tick, asking Buildbucket for the build status
[06:42:31.341] Build 8891854062678137104: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:42:31.341] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9057284124684463520:29:0) after 1m0s
[06:43:31.418] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9057284124684463520:29:0)
[06:43:31.418] Timer tick, asking Buildbucket for the build status
[06:43:31.626] Build 8891854062678137104: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:43:31.626] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9057284124684463520:30:0) after 1m0s
[06:44:31.749] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9057284124684463520:30:0)
[06:44:31.749] Timer tick, asking Buildbucket for the build status
[06:44:33.273] Build 8891854062678137104: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:44:33.273] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9057284124684463520:31:0) after 1m0s
[06:45:33.325] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9057284124684463520:31:0)
[06:45:33.325] Timer tick, asking Buildbucket for the build status
[06:45:33.611] Build 8891854062678137104: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:45:33.611] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9057284124684463520:32:0) after 1m0s
[06:46:33.695] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9057284124684463520:32:0)
[06:46:33.695] Timer tick, asking Buildbucket for the build status
[06:46:34.045] Build 8891854062678137104: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:46:34.045] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9057284124684463520:33:0) after 1m0s
[06:47:34.117] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9057284124684463520:33:0)
[06:47:34.117] Timer tick, asking Buildbucket for the build status
[06:47:34.391] Build 8891854062678137104: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:47:34.391] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9057284124684463520:34:0) after 1m0s
[06:48:34.436] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9057284124684463520:34:0)
[06:48:34.436] Timer tick, asking Buildbucket for the build status
[06:48:34.957] Build 8891854062678137104: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:48:34.957] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9057284124684463520:35:0) after 1m0s
[06:49:35.161] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9057284124684463520:35:0)
[06:49:35.161] Timer tick, asking Buildbucket for the build status
[06:49:35.472] Build 8891854062678137104: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:49:35.472] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9057284124684463520:36:0) after 1m0s
[06:50:35.493] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9057284124684463520:36:0)
[06:50:35.493] Timer tick, asking Buildbucket for the build status
[06:50:35.674] Build 8891854062678137104: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:50:35.674] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9057284124684463520:37:0) after 1m0s
[06:51:35.706] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9057284124684463520:37:0)
[06:51:35.706] Timer tick, asking Buildbucket for the build status
[06:51:36.346] Build 8891854062678137104: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:51:36.346] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9057284124684463520:38:0) after 1m0s
[06:52:36.375] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9057284124684463520:38:0)
[06:52:36.375] Timer tick, asking Buildbucket for the build status
[06:52:37.427] Build 8891854062678137104: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:52:37.427] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9057284124684463520:39:0) after 1m0s
[06:53:37.456] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9057284124684463520:39:0)
[06:53:37.456] Timer tick, asking Buildbucket for the build status
[06:53:37.642] Build 8891854062678137104: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:53:37.642] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9057284124684463520:40:0) after 1m0s
[06:54:37.630] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9057284124684463520:40:0)
[06:54:37.630] Timer tick, asking Buildbucket for the build status
[06:54:37.820] Build 8891854062678137104: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:54:37.820] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9057284124684463520:41:0) after 1m0s
[06:55:37.848] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9057284124684463520:41:0)
[06:55:37.848] Timer tick, asking Buildbucket for the build status
[06:55:38.382] Build 8891854062678137104: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:55:38.382] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9057284124684463520:42:0) after 1m0s
[06:56:38.444] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9057284124684463520:42:0)
[06:56:38.444] Timer tick, asking Buildbucket for the build status
[06:56:38.627] Build 8891854062678137104: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:56:38.627] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9057284124684463520:43:0) after 1m0s
[06:57:38.656] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9057284124684463520:43:0)
[06:57:38.656] Timer tick, asking Buildbucket for the build status
[06:57:38.843] Build 8891854062678137104: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:57:38.843] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9057284124684463520:44:0) after 1m0s
[06:58:38.838] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9057284124684463520:44:0)
[06:58:38.838] Timer tick, asking Buildbucket for the build status
[06:58:39.191] Build 8891854062678137104: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:58:39.191] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9057284124684463520:45:0) after 1m0s
[06:59:39.213] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9057284124684463520:45:0)
[06:59:39.214] Timer tick, asking Buildbucket for the build status
[06:59:39.505] Build 8891854062678137104: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:59:39.505] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9057284124684463520:46:0) after 1m0s
[07:00:39.607] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9057284124684463520:46:0)
[07:00:39.607] Timer tick, asking Buildbucket for the build status
[07:00:39.904] Build 8891854062678137104: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:00:39.904] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9057284124684463520:47:0) after 1m0s
[07:01:40.006] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9057284124684463520:47:0)
[07:01:40.006] Timer tick, asking Buildbucket for the build status
[07:01:40.479] Build 8891854062678137104: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:01:40.479] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9057284124684463520:48:0) after 1m0s
[07:02:40.595] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9057284124684463520:48:0)
[07:02:40.595] Timer tick, asking Buildbucket for the build status
[07:02:40.814] Build 8891854062678137104: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:02:40.814] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9057284124684463520:49:0) after 1m0s
[07:03:41.005] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9057284124684463520:49:0)
[07:03:41.005] Timer tick, asking Buildbucket for the build status
[07:03:42.558] Build 8891854062678137104: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:03:42.558] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9057284124684463520:50:0) after 1m0s
[07:04:42.597] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9057284124684463520:50:0)
[07:04:42.597] Timer tick, asking Buildbucket for the build status
[07:04:43.538] Build 8891854062678137104: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:04:43.538] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9057284124684463520:51:0) after 1m0s
[07:05:43.576] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9057284124684463520:51:0)
[07:05:43.576] Timer tick, asking Buildbucket for the build status
[07:05:44.092] Build 8891854062678137104: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:05:44.092] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9057284124684463520:52:0) after 1m0s
[07:06:44.146] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9057284124684463520:52:0)
[07:06:44.146] Timer tick, asking Buildbucket for the build status
[07:06:44.367] Build 8891854062678137104: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:06:44.367] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9057284124684463520:53:0) after 1m0s
[07:07:44.397] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9057284124684463520:53:0)
[07:07:44.397] Timer tick, asking Buildbucket for the build status
[07:07:44.592] Build 8891854062678137104: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:07:44.592] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9057284124684463520:54:0) after 1m0s
[07:08:44.677] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9057284124684463520:54:0)
[07:08:44.677] Timer tick, asking Buildbucket for the build status
[07:08:45.023] Build 8891854062678137104: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:08:45.023] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9057284124684463520:55:0) after 1m0s
[07:09:45.098] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9057284124684463520:55:0)
[07:09:45.098] Timer tick, asking Buildbucket for the build status
[07:09:45.799] Build 8891854062678137104: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:09:45.799] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9057284124684463520:56:0) after 1m0s
[07:10:18.560] Received PubSub notification, asking Buildbucket for the build status
[07:10:18.760] Build 8891854062678137104: status "COMPLETED", result "SUCCESS", failure_reason "", cancelation_reason ""
[07:10:18.760] Buildbucket build:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "PROD",
"completed_ts": "1578467417571851",
"created_by": "project:chromium",
"created_ts": "1578464177399007",
"id": "8891854062678137104",
"parameters_json": "{\"builder_name\": \"Linux Builder (dbg)\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"ed1f5386339460b628430d343beb30a886548c52\"}}",
"project": "chromium",
"result": "SUCCESS",
"result_details_json": "{\"properties\": {\"$build/goma\": {\"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-41-m00s\", \"branch\": \"refs/heads/master\", \"buildername\": \"Linux Builder (dbg)\", \"buildnumber\": 167110, \"got_angle_revision\": \"db49bc7dd0759fac8cb4065aa2afc3172aed7948\", \"got_dawn_revision\": \"96f79f6db56b87150be2a12755fed10f91f574dc\", \"got_nacl_revision\": \"3651f6c52037c96e034cc422746768d59182bff3\", \"got_revision\": \"ed1f5386339460b628430d343beb30a886548c52\", \"got_revision_cp\": \"refs/heads/master@{#729247}\", \"got_swarming_client_revision\": \"885b3febcc170a60f25795304e60927b77d1e92d\", \"got_swiftshader_revision\": \"45a4d0f36bd602f5b202a2961ef64984778d0681\", \"got_v8_revision\": \"898f9ebe1614cc9e5260afb32438282d91f0dbc8\", \"got_v8_revision_cp\": \"refs/heads/8.1.108@{#1}\", \"got_webrtc_revision\": \"75b58972cbb788300b23a93bcb92012343d5606b\", \"got_webrtc_revision_cp\": \"refs/heads/master@{#30169}\", \"isolate_server\": \"https://isolateserver.appspot.com\", \"mastername\": \"chromium.linux\", \"path_config\": \"generic\", \"recipe\": \"chromium\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"ed1f5386339460b628430d343beb30a886548c52\", \"swarm_hashes_refs/heads/master(at){#729247}_without_patch\": {\"accessibility_unittests\": \"5647f12059357936ef17433da2047b1e8d9d765f\", \"angle_unittests\": \"e8fec559be991d271b1e9dbe11ff7e4f64dacee7\", \"app_shell_unittests\": \"2f0c029b00eb01041a4ffe2583b31a6c455d9c02\", \"aura_unittests\": \"00a4e6217ec3ef5e14602112627a2ce0f42faaf3\", \"base_unittests\": \"fa9a8990f2b631435b735bf9b51d2904554ef60a\", \"base_util_unittests\": \"f90de5aa9a8e5c49353bbc568cb9bb93dde289cc\", \"blink_common_unittests\": \"f5ca9d5b840f739750060024bb68eb43943e895c\", \"blink_fuzzer_unittests\": \"8706147b6bc78e40499f41da14803b7960dbd12b\", \"blink_heap_unittests\": \"e0ffd0290c12cf6eccdc53e06c1965feb34f069d\", \"blink_platform_unittests\": \"035c6f60cbc14849baa1914a9fa41edbf82d0f13\", \"blink_python_tests\": \"59eabf640d15aa1a1cbff84a2cd1856508596002\", \"blink_unittests\": \"97c0cb5e264f04e0b6f3ce7140915a215035cd62\", \"blink_web_tests\": \"9ac55ec64244255af4e5d971ca1f2cdc6a180457\", \"boringssl_crypto_tests\": \"dd96a4d56f67e9e3a6b3de7a42ac564161034493\", \"boringssl_ssl_tests\": \"d44a59c6dfd71650fd7cff0bfe5b815e857136f7\", \"browser_tests\": \"132c4c95c2b2879b5691489f4ab555721f97db06\", \"cacheinvalidation_unittests\": \"7a23ebcb67d3b55c3d5f4a2461267bf283e17a18\", \"capture_unittests\": \"fd050f12b5f3fa170240546c35d0ab284bb0a21d\", \"cast_unittests\": \"fec90493c9cef1bd9d6746486e5570425824a559\", \"cc_unittests\": \"1da5b9218dd94218da9b46f252aec3399d4e9ece\", \"chrome_app_unittests\": \"e843c92f965c5b6d55ab2e6795bf80f49a46f1c2\", \"chromedriver_unittests\": \"4939e2bacb5d872fa448c1318ee1b9970089919c\", \"components_browsertests\": \"587b50672f3dbd77ef44e37b8f8d84d4d3f8b11c\", \"components_unittests\": \"21b61c8676611a1e1389507f59fed9c473a271bf\", \"compositor_unittests\": \"bcf539ba4a6395210ed0467f28226d3a84f29e07\", \"content_browsertests\": \"fe25b13c9495182ee014e17592c313d17b7e1da1\", \"content_shell_crash_test\": \"4782c0ac65e1cac9e9613049e396d69116d39edd\", \"content_unittests\": \"8d4bb5afdd46ecf218b910d01153233408e10729\", \"crashpad_tests\": \"a827b1604f018c78b24bbb5ac267d6fa2ab16f9a\", \"cronet_tests\": \"ea3461eff64af0a5c6676ad00ab7871c47441c7c\", \"cronet_unittests\": \"be07fe9c401d4567fba73c7cad8f7ce80cb3544a\", \"crypto_unittests\": \"fd5e19c6485259d8babce884584923ae2b1d631e\", \"dbus_unittests\": \"e609369d2b5f73f38c93cbf615fa438c68af6bb2\", \"device_unittests\": \"cefeefc5071f06a5732d049e6fa7efeea96229d8\", \"devtools_lint_check\": \"d00c512fb68f12a95c3246635e8d61f5f667ccf2\", \"devtools_type_check\": \"d08015c18a198d6d90420417c533b0c79749f712\", \"display_unittests\": \"916bab5f7927dfe533b84350a93e61422c683813\", \"events_unittests\": \"1d1cc36ccc219b6ccfeabf9a44bf7a705c9a18e0\", \"extensions_browsertests\": \"34e050c333e7b05dfde0f6b955910e6781a41c15\", \"extensions_unittests\": \"3a5922e35c1fe23964850de7ba6895371b7bd4f4\", \"filesystem_service_unittests\": \"498e62ca86b9a7c4592394c1197991425a03a903\", \"flatbuffers_unittests\": \"034d1c63a8199a680c9bbf29b5866b1c851e28ee\", \"gcm_unit_tests\": \"35d3f32a24e14e9023bc53dec6f3328ac2f9dbed\", \"gfx_unittests\": \"2df7b9aa2b79d980a2f27df2bc12b8e45f6b23c6\", \"gin_unittests\": \"4f692f74a023b6fe2d875ff769cbc2ce7f5506b8\", \"google_apis_unittests\": \"218e6ef4369a278afea1ddfe559c8708a77ee467\", \"gpu_unittests\": \"bd9cb2aa0fb42ed1591d1730431448b2a25b0450\", \"grit_python_unittests\": \"5d2561226d0db6aa6e2a7322c9c06178bd9c6346\", \"gwp_asan_unittests\": \"43eec98bca1e5f5f731f7a5f5b625cf0032c0f8d\", \"headless_browsertests\": \"a13e5db0d13a19b0ea77d79b325361b70d787a44\", \"headless_unittests\": \"f33090b5471618b258641420a86a954dbca60e61\", \"interactive_ui_tests\": \"7710156ff8e7dbec3841f5cdc0ec3f8dcb6c9d52\", \"ipc_tests\": \"d7a9b6e7bd956d1d90af578c665e701e0b24874b\", \"jingle_unittests\": \"3bff7541e9e8667301405d13a3eaa8e7bbd6132d\", \"latency_unittests\": \"77e40a9826c5647805a0923c084f98f89c937eea\", \"libjingle_xmpp_unittests\": \"122f0919ed350b53ac4d615c74afa5275b4105f8\", \"media_blink_unittests\": \"27c59335f0f38593e49f2aa9a9ae288f91c56d3a\", \"media_service_unittests\": \"fd1d7bac30d4d3f7d726b999000bf30cb91bfa7e\", \"media_unittests\": \"8f4b06f4e0cd6314a9137582fe30cb19875a3313\", \"message_center_unittests\": \"c804a9be05c087f8bac033fd35244d8f8c2c171f\", \"metrics_python_tests\": \"4927b4da5f942db335be18871c27aa416a1755c6\", \"midi_unittests\": \"aa15ba049b04a82258e853491182bd672ff697a4\", \"mojo_core_unittests\": \"b727db8f82b600d31192dae41001746a5b64744a\", \"mojo_unittests\": \"e7bee824c7dae1df27de1fab8046a3ffacd9ad6a\", \"nacl_helper_nonsfi_unittests\": \"e084eed6bfce5c31f98b4a63f1fcdc2c37e2feb8\", \"nacl_loader_unittests\": \"19e43e6c5d27eb8550a652c3de34b9b90ec0a6d6\", \"native_theme_unittests\": \"7aba8b7e7c52b3a44be43b3a60d610bb3bc1e610\", \"net_unittests\": \"9b3298abe441c9bae6bdd30e5290640476c6dcff\", \"pdf_unittests\": \"2d6e908a9b1319989d475ead7b6342194ade4c3b\", \"perfetto_unittests\": \"0984069a80364fc32fe50d349aa0a9fd663c1b3a\", \"ppapi_unittests\": \"c5e32787b7ea47fa3ecda3adf6f4d58599f6b8d2\", \"printing_unittests\": \"9320a88b6476131605da3fc2345d6018af7a3e80\", \"remoting_unittests\": \"4f4662281bcab1ec78465d001ebac2dc89771722\", \"sandbox_linux_unittests\": \"bd0ce247ad1fe32bd47bbec59a5df0a3ece4cd62\", \"service_manager_unittests\": \"b37c85a4eaf99ea1e46a7bb86f0a1eb35225493c\", \"services_unittests\": \"f338ea23c6fe12884f9fee6e823946ea1339198e\", \"shell_dialogs_unittests\": \"76493e0de0fec98b382ebf8ecac8c20c4648854b\", \"skia_unittests\": \"ac0fbd3e1d726dd388e9fb1434145a347646aa41\", \"snapshot_unittests\": \"10653d4c6e21b9d9a8fcebf3d94c2bfb0a37ba2a\", \"sql_unittests\": \"26a1e83fac8d847e64f3ef09a0988e34c4c68177\", \"storage_unittests\": \"d2419303ae877e03f09942d95e8391a7a399adb0\", \"sync_integration_tests\": \"613e14f95674a0d4a6649da931a74a7893c8ff32\", \"telemetry_gpu_unittests\": \"acdaa465bceba10d82c13d4de47d964d6df975d3\", \"telemetry_perf_unittests\": \"3e54aaf649e10037275f20ea55812747da7d08b8\", \"telemetry_unittests\": \"2b759c4ae12552a2ca40c2715b4b7aa68b90ca6e\", \"traffic_annotation_auditor_unittests\": \"8c3c9858de4df05371b4b5128a37286ff5978d49\", \"ui_base_unittests\": \"faf4da63653e5006883b7880a2b3809c07435c98\", \"ui_touch_selection_unittests\": \"d9aca0c209f3096efb576387a1deb956c0e54d64\", \"unit_tests\": \"87d875c6fd9fdd5abe22a24cfa81e29ca941b8df\", \"url_unittests\": \"ed852d327dfba876ffe6e9d82be7b9490a08cc29\", \"views_perftests\": \"17a1e81cccb1a258747443b6aa5c233248eae8c2\", \"views_unittests\": \"2d4922f9898f3daa525759ce9305c1109d47c4b9\", \"viz_unittests\": \"ca0bf572175c2670f8dbce7f577359a441af3875\", \"vr_common_unittests\": \"398003cfc5d6422ec765ba0d7fc7ed5999efed13\", \"vr_pixeltests\": \"369e0ecdb853d2aae720e3affdd5782cae4bedbe\", \"webdriver_wpt_tests\": \"280ea73479adb670dd0d0514e1498b706cb41188\", \"weblayer_browsertests\": \"3ac034a6b2343e656b8b4ca99b7bd1d1c5bc5cac\", \"wm_unittests\": \"046befe3d3b44588a3e37f49bc92aeb3db88c795\", \"wtf_unittests\": \"b03322434e4cbda3f8a3a28d6f9cdcecab8dc3dd\", \"xr_browser_tests\": \"9064afd65a7cf3d84fb92b1ed2abce54f8e1ae48\"}}, \"swarming\": {\"bot_dimensions\": {\"builderless\": [\"1\"], \"caches\": [\"builder_2dd6a1af21400b3785138e4c8a94108d5525f829439b094d94efcf967177507f_v2\", \"builder_5c21095a1a129131be723eb555273fa4f1dc89f7e6d0ed0ea2c09e97b0cf5fcb_v2\", \"git\", \"goma_v2\", \"vpython\"], \"cores\": [\"8\"], \"cpu\": [\"x86\", \"x86-64\", \"x86-64-Broadwell_GCE\", \"x86-64-avx2\"], \"gce\": [\"1\"], \"gpu\": [\"none\"], \"id\": [\"luci-chromium-ci-xenial-us-central1-b-8-41-m00s\"], \"image\": [\"chrome-xenial-19121500-b03549ec744\"], \"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\": [\"4745-ef32e44\"], \"ssd\": [\"0\"], \"zone\": [\"us\", \"us-central\", \"us-central1\", \"us-central1-b\"]}}}",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"started_ts": "1578464462044097",
"status": "COMPLETED",
"status_changed_ts": "1578467418034637",
"tags": [
"build_address:luci.chromium.ci/Linux Builder (dbg)/167110",
"builder:Linux Builder (dbg)",
"buildset:commit/git/ed1f5386339460b628430d343beb30a886548c52",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/ed1f5386339460b628430d343beb30a886548c52",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9057284124684463520",
"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/8891854062678137104/+/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:499c9d7850457810",
"user_agent:luci-scheduler"
],
"updated_ts": "1578467418039109",
"url": "https://ci.chromium.org/b/8891854062678137104",
"utcnow_ts": "1578467418743169"
}
}
[07:10:18.761] Invocation finished in 54m2.658950803s with status SUCCEEDED