[12:35:53.441] New invocation is queued and will start shortly
[12:35:54.536] Starting the invocation (attempt 1)
[12:35:54.595] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[12:35:54.595] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[12:35:54.595] Buildbucket request:
{
"bucket": "luci.chromium.ci",
"client_operation_id": "9017850560543873872",
"parameters_json": "{\"builder_name\":\"Linux Builder (dbg)\",\"properties\":{\"branch\":\"refs/heads/master\",\"repository\":\"https://chromium.googlesource.com/chromium/src\",\"revision\":\"db2c5f0096a37acb3407d8436dd97ca011ba1e14\"}}",
"pubsub_callback": {
"auth_token": "...",
"topic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
},
"tags": [
"builder:Linux Builder (dbg)",
"scheduler_invocation_id:9017850560543873872",
"scheduler_job_id:chromium/Linux Builder (dbg)",
"user_agent:luci-scheduler",
"buildset:commit/git/db2c5f0096a37acb3407d8436dd97ca011ba1e14",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/db2c5f0096a37acb3407d8436dd97ca011ba1e14",
"gitiles_ref:refs/heads/master"
]
}
[12:35:55.556] Buildbucket response:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "PROD",
"created_by": "project:chromium",
"created_ts": "1616070954737682",
"id": "8852420498523886064",
"parameters_json": "{\"builder_name\": \"Linux Builder (dbg)\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"db2c5f0096a37acb3407d8436dd97ca011ba1e14\"}}",
"project": "chromium",
"result_details_json": "{\"properties\": {}}",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"status": "SCHEDULED",
"status_changed_ts": "1616070955295719",
"tags": [
"build_address:luci.chromium.ci/Linux Builder (dbg)/181485",
"builder:Linux Builder (dbg)",
"buildset:commit/git/db2c5f0096a37acb3407d8436dd97ca011ba1e14",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/db2c5f0096a37acb3407d8436dd97ca011ba1e14",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9017850560543873872",
"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/8852420498523886064/+/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": "1616070955295839",
"url": "https://ci.chromium.org/b/8852420498523886064",
"utcnow_ts": "1616070955534818"
}
}
[12:35:55.556] Task URL: https://ci.chromium.org/b/8852420498523886064
[12:35:55.556] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9017850560543873872:2:0) after 1m0s
[12:35:57.997] Received PubSub notification, asking Buildbucket for the build status
[12:35:58.214] Build 8852420498523886064: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:36:55.551] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9017850560543873872:2:0)
[12:36:55.551] Timer tick, asking Buildbucket for the build status
[12:36:55.809] Build 8852420498523886064: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:36:55.809] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9017850560543873872:4:0) after 1m0s
[12:37:55.880] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9017850560543873872:4:0)
[12:37:55.880] Timer tick, asking Buildbucket for the build status
[12:37:56.067] Build 8852420498523886064: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:37:56.068] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9017850560543873872:5:0) after 1m0s
[12:38:56.112] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9017850560543873872:5:0)
[12:38:56.112] Timer tick, asking Buildbucket for the build status
[12:38:56.197] Build 8852420498523886064: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:38:56.197] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9017850560543873872:6:0) after 1m0s
[12:39:56.245] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9017850560543873872:6:0)
[12:39:56.245] Timer tick, asking Buildbucket for the build status
[12:39:56.334] Build 8852420498523886064: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:39:56.335] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9017850560543873872:7:0) after 1m0s
[12:40:56.347] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9017850560543873872:7:0)
[12:40:56.347] Timer tick, asking Buildbucket for the build status
[12:40:56.415] Build 8852420498523886064: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:40:56.415] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9017850560543873872:8:0) after 1m0s
[12:41:56.406] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9017850560543873872:8:0)
[12:41:56.406] Timer tick, asking Buildbucket for the build status
[12:42:01.352] Build 8852420498523886064: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:42:01.352] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9017850560543873872:9:0) after 1m0s
[12:43:01.348] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9017850560543873872:9:0)
[12:43:01.348] Timer tick, asking Buildbucket for the build status
[12:43:01.416] Build 8852420498523886064: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:43:01.416] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9017850560543873872:10:0) after 1m0s
[12:44:01.441] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9017850560543873872:10:0)
[12:44:01.441] Timer tick, asking Buildbucket for the build status
[12:44:01.731] Build 8852420498523886064: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:44:01.731] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9017850560543873872:11:0) after 1m0s
[12:45:01.741] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9017850560543873872:11:0)
[12:45:01.741] Timer tick, asking Buildbucket for the build status
[12:45:01.825] Build 8852420498523886064: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:45:01.825] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9017850560543873872:12:0) after 1m0s
[12:46:01.885] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9017850560543873872:12:0)
[12:46:01.885] Timer tick, asking Buildbucket for the build status
[12:46:02.295] Build 8852420498523886064: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:46:02.295] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9017850560543873872:13:0) after 1m0s
[12:47:02.337] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9017850560543873872:13:0)
[12:47:02.337] Timer tick, asking Buildbucket for the build status
[12:47:03.059] Build 8852420498523886064: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:47:03.059] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9017850560543873872:14:0) after 1m0s
[12:48:03.110] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9017850560543873872:14:0)
[12:48:03.110] Timer tick, asking Buildbucket for the build status
[12:48:03.339] Build 8852420498523886064: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:48:03.339] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9017850560543873872:15:0) after 1m0s
[12:49:03.352] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9017850560543873872:15:0)
[12:49:03.352] Timer tick, asking Buildbucket for the build status
[12:49:03.966] Build 8852420498523886064: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:49:03.966] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9017850560543873872:16:0) after 1m0s
[12:50:04.013] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9017850560543873872:16:0)
[12:50:04.013] Timer tick, asking Buildbucket for the build status
[12:50:04.122] Build 8852420498523886064: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:50:04.122] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9017850560543873872:17:0) after 1m0s
[12:51:04.130] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9017850560543873872:17:0)
[12:51:04.130] Timer tick, asking Buildbucket for the build status
[12:51:04.227] Build 8852420498523886064: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:51:04.227] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9017850560543873872:18:0) after 1m0s
[12:52:04.305] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9017850560543873872:18:0)
[12:52:04.305] Timer tick, asking Buildbucket for the build status
[12:52:04.590] Build 8852420498523886064: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:52:04.590] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9017850560543873872:19:0) after 1m0s
[12:53:04.609] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9017850560543873872:19:0)
[12:53:04.609] Timer tick, asking Buildbucket for the build status
[12:53:04.722] Build 8852420498523886064: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:53:04.722] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9017850560543873872:20:0) after 1m0s
[12:54:04.783] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9017850560543873872:20:0)
[12:54:04.783] Timer tick, asking Buildbucket for the build status
[12:54:04.881] Build 8852420498523886064: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:54:04.881] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9017850560543873872:21:0) after 1m0s
[12:55:04.958] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9017850560543873872:21:0)
[12:55:04.958] Timer tick, asking Buildbucket for the build status
[12:55:05.164] Build 8852420498523886064: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:55:05.164] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9017850560543873872:22:0) after 1m0s
[12:56:05.194] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9017850560543873872:22:0)
[12:56:05.194] Timer tick, asking Buildbucket for the build status
[12:56:05.300] Build 8852420498523886064: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:56:05.300] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9017850560543873872:23:0) after 1m0s
[12:57:05.298] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9017850560543873872:23:0)
[12:57:05.298] Timer tick, asking Buildbucket for the build status
[12:57:05.462] Build 8852420498523886064: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:57:05.462] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9017850560543873872:24:0) after 1m0s
[12:58:05.553] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9017850560543873872:24:0)
[12:58:05.553] Timer tick, asking Buildbucket for the build status
[12:58:05.630] Build 8852420498523886064: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:58:05.630] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9017850560543873872:25:0) after 1m0s
[12:59:05.650] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9017850560543873872:25:0)
[12:59:05.650] Timer tick, asking Buildbucket for the build status
[12:59:05.736] Build 8852420498523886064: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:59:05.736] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9017850560543873872:26:0) after 1m0s
[13:00:05.815] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9017850560543873872:26:0)
[13:00:05.815] Timer tick, asking Buildbucket for the build status
[13:00:05.890] Build 8852420498523886064: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:00:05.890] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9017850560543873872:27:0) after 1m0s
[13:01:06.266] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9017850560543873872:27:0)
[13:01:06.266] Timer tick, asking Buildbucket for the build status
[13:01:06.403] Build 8852420498523886064: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:01:06.403] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9017850560543873872:28:0) after 1m0s
[13:02:06.503] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9017850560543873872:28:0)
[13:02:06.503] Timer tick, asking Buildbucket for the build status
[13:02:06.706] Build 8852420498523886064: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:02:06.706] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9017850560543873872:29:0) after 1m0s
[13:03:06.825] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9017850560543873872:29:0)
[13:03:06.825] Timer tick, asking Buildbucket for the build status
[13:03:06.917] Build 8852420498523886064: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:03:06.917] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9017850560543873872:30:0) after 1m0s
[13:04:06.973] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9017850560543873872:30:0)
[13:04:06.973] Timer tick, asking Buildbucket for the build status
[13:04:07.120] Build 8852420498523886064: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:04:07.120] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9017850560543873872:31:0) after 1m0s
[13:05:07.180] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9017850560543873872:31:0)
[13:05:07.180] Timer tick, asking Buildbucket for the build status
[13:05:07.292] Build 8852420498523886064: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:05:07.292] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9017850560543873872:32:0) after 1m0s
[13:06:07.301] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9017850560543873872:32:0)
[13:06:07.301] Timer tick, asking Buildbucket for the build status
[13:06:07.542] Build 8852420498523886064: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:06:07.542] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9017850560543873872:33:0) after 1m0s
[13:07:07.593] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9017850560543873872:33:0)
[13:07:07.593] Timer tick, asking Buildbucket for the build status
[13:07:07.666] Build 8852420498523886064: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:07:07.666] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9017850560543873872:34:0) after 1m0s
[13:08:07.716] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9017850560543873872:34:0)
[13:08:07.716] Timer tick, asking Buildbucket for the build status
[13:08:07.782] Build 8852420498523886064: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:08:07.782] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9017850560543873872:35:0) after 1m0s
[13:09:07.850] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9017850560543873872:35:0)
[13:09:07.850] Timer tick, asking Buildbucket for the build status
[13:09:08.007] Build 8852420498523886064: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:09:08.007] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9017850560543873872:36:0) after 1m0s
[13:10:07.981] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9017850560543873872:36:0)
[13:10:07.981] Timer tick, asking Buildbucket for the build status
[13:10:08.122] Build 8852420498523886064: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:10:08.122] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9017850560543873872:37:0) after 1m0s
[13:11:08.165] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9017850560543873872:37:0)
[13:11:08.165] Timer tick, asking Buildbucket for the build status
[13:11:08.355] Build 8852420498523886064: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:11:08.355] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9017850560543873872:38:0) after 1m0s
[13:12:08.426] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9017850560543873872:38:0)
[13:12:08.426] Timer tick, asking Buildbucket for the build status
[13:12:08.496] Build 8852420498523886064: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:12:08.496] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9017850560543873872:39:0) after 1m0s
[13:13:08.583] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9017850560543873872:39:0)
[13:13:08.583] Timer tick, asking Buildbucket for the build status
[13:13:08.735] Build 8852420498523886064: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:13:08.735] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9017850560543873872:40:0) after 1m0s
[13:14:08.787] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9017850560543873872:40:0)
[13:14:08.787] Timer tick, asking Buildbucket for the build status
[13:14:08.865] Build 8852420498523886064: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:14:08.865] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9017850560543873872:41:0) after 1m0s
[13:15:09.017] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9017850560543873872:41:0)
[13:15:09.017] Timer tick, asking Buildbucket for the build status
[13:15:09.094] Build 8852420498523886064: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:15:09.094] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9017850560543873872:42:0) after 1m0s
[13:16:09.147] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9017850560543873872:42:0)
[13:16:09.147] Timer tick, asking Buildbucket for the build status
[13:16:09.323] Build 8852420498523886064: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:16:09.323] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9017850560543873872:43:0) after 1m0s
[13:17:09.386] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9017850560543873872:43:0)
[13:17:09.386] Timer tick, asking Buildbucket for the build status
[13:17:09.448] Build 8852420498523886064: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:17:09.448] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9017850560543873872:44:0) after 1m0s
[13:18:09.506] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9017850560543873872:44:0)
[13:18:09.506] Timer tick, asking Buildbucket for the build status
[13:18:09.575] Build 8852420498523886064: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:18:09.575] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9017850560543873872:45:0) after 1m0s
[13:19:09.804] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9017850560543873872:45:0)
[13:19:09.804] Timer tick, asking Buildbucket for the build status
[13:19:09.874] Build 8852420498523886064: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:19:09.874] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9017850560543873872:46:0) after 1m0s
[13:20:09.996] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9017850560543873872:46:0)
[13:20:09.996] Timer tick, asking Buildbucket for the build status
[13:20:10.070] Build 8852420498523886064: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:20:10.070] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9017850560543873872:47:0) after 1m0s
[13:21:10.221] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9017850560543873872:47:0)
[13:21:10.221] Timer tick, asking Buildbucket for the build status
[13:21:10.300] Build 8852420498523886064: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:21:10.300] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9017850560543873872:48:0) after 1m0s
[13:22:10.381] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9017850560543873872:48:0)
[13:22:10.381] Timer tick, asking Buildbucket for the build status
[13:22:10.506] Build 8852420498523886064: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:22:10.506] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9017850560543873872:49:0) after 1m0s
[13:23:10.573] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9017850560543873872:49:0)
[13:23:10.573] Timer tick, asking Buildbucket for the build status
[13:23:10.650] Build 8852420498523886064: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:23:10.650] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9017850560543873872:50:0) after 1m0s
[13:24:10.753] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9017850560543873872:50:0)
[13:24:10.753] Timer tick, asking Buildbucket for the build status
[13:24:10.828] Build 8852420498523886064: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:24:10.828] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9017850560543873872:51:0) after 1m0s
[13:25:10.945] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9017850560543873872:51:0)
[13:25:10.945] Timer tick, asking Buildbucket for the build status
[13:25:11.012] Build 8852420498523886064: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:25:11.012] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9017850560543873872:52:0) after 1m0s
[13:26:11.377] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9017850560543873872:52:0)
[13:26:11.377] Timer tick, asking Buildbucket for the build status
[13:26:11.464] Build 8852420498523886064: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:26:11.464] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9017850560543873872:53:0) after 1m0s
[13:27:11.630] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9017850560543873872:53:0)
[13:27:11.630] Timer tick, asking Buildbucket for the build status
[13:27:11.698] Build 8852420498523886064: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:27:11.698] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9017850560543873872:54:0) after 1m0s
[13:28:11.854] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9017850560543873872:54:0)
[13:28:11.854] Timer tick, asking Buildbucket for the build status
[13:28:12.122] Build 8852420498523886064: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:28:12.122] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9017850560543873872:55:0) after 1m0s
[13:29:12.186] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9017850560543873872:55:0)
[13:29:12.186] Timer tick, asking Buildbucket for the build status
[13:29:12.552] Build 8852420498523886064: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:29:12.552] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9017850560543873872:56:0) after 1m0s
[13:30:12.639] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9017850560543873872:56:0)
[13:30:12.639] Timer tick, asking Buildbucket for the build status
[13:30:12.730] Build 8852420498523886064: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:30:12.730] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9017850560543873872:57:0) after 1m0s
[13:30:47.163] Received PubSub notification, asking Buildbucket for the build status
[13:30:47.260] Build 8852420498523886064: status "COMPLETED", result "SUCCESS", failure_reason "", cancelation_reason ""
[13:30:47.261] Buildbucket build:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "PROD",
"completed_ts": "1616074234235355",
"created_by": "project:chromium",
"created_ts": "1616070954737682",
"id": "8852420498523886064",
"parameters_json": "{\"builder_name\": \"Linux Builder (dbg)\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"db2c5f0096a37acb3407d8436dd97ca011ba1e14\"}}",
"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\": \"db2c5f0096a37acb3407d8436dd97ca011ba1e14\", \"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-117-8x3x\", \"branch\": \"refs/heads/master\", \"builder_group\": \"chromium.linux\", \"buildername\": \"Linux Builder (dbg)\", \"buildnumber\": 181485, \"got_angle_revision\": \"39296f396f5bf9abb8c8d80b147be7029c633964\", \"got_dawn_revision\": \"3209df5a9cc2de5415688653d1142b1adda554db\", \"got_nacl_revision\": \"abf3277f295c6c87f0b103f291ed5e3e73933b76\", \"got_revision\": \"db2c5f0096a37acb3407d8436dd97ca011ba1e14\", \"got_revision_cp\": \"refs/heads/master@{#864198}\", \"got_swarming_client_revision\": \"a32a1607f6093d338f756c7e7c7b4333b0c50c9c\", \"got_swiftshader_revision\": \"a98fb3f8380a3a5c9ae3e0175634ba88c85a434f\", \"got_v8_revision\": \"4f0f4e2a3c5ad9dc7312774da5197e0179c30863\", \"got_v8_revision_cp\": \"refs/heads/9.1.146@{#1}\", \"got_webrtc_revision\": \"92a768ad66f54ca57002f6f2e87c7a732e3fec39\", \"got_webrtc_revision_cp\": \"refs/heads/master@{#33488}\", \"is_cached\": true, \"isolate_server\": \"https://isolateserver.appspot.com\", \"mirrored_builders\": [\"tryserver.chromium.linux:linux-clang-tidy-dbg\", \"tryserver.chromium.linux:linux_chromium_dbg_ng\", \"tryserver.chromium.linux:linux_chromium_compile_dbg_ng\"], \"path_config\": \"generic\", \"recipe\": \"chromium\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"db2c5f0096a37acb3407d8436dd97ca011ba1e14\", \"swarm_hashes_refs/heads/master(at){#864198}_without_patch\": {\"absl_hardening_tests\": \"498e58468d5560c8c191717aacec51dedeed4fbb\", \"accessibility_unittests\": \"6332be996f78be125956fb9695031e049497e765\", \"angle_unittests\": \"9cd79732422babde9165833b1d7cd6aa795ea9ea\", \"app_shell_unittests\": \"a9893971347048d437962fad835fd84543a60660\", \"aura_unittests\": \"b858d0200012350ad3f5eaafffe7dab9299f3e29\", \"base_unittests\": \"4490f11f551a4fe59e67c25f316cee1c0e2ddb31\", \"base_util_unittests\": \"1030422ddb03fbce360a2ab1cad438a9bb1b4ae5\", \"blink_common_unittests\": \"cab18dc30012f3203178c1532fff97df9654db7a\", \"blink_fuzzer_unittests\": \"6efc5f7f722ad55a097e4105055d79c98416b509\", \"blink_heap_unittests\": \"1515ab18f3e2e282f00ad2fd6acdd4d2debc813c\", \"blink_platform_unittests\": \"c1c730e062dd43c33359f73f4703feca224b50a6\", \"blink_python_tests\": \"6bda19141297b629ea547427d9648b468b824705\", \"blink_unittests\": \"7f8a6762209952438397b0507fa0a44625c51e68\", \"blink_web_tests\": \"7572f179c7904adb7745f5d2acfc8119b4755f51\", \"boringssl_crypto_tests\": \"4dd65b22b82684b981e05d8cd4bca37ace88a423\", \"boringssl_ssl_tests\": \"513bc963db9198dc050699224da013b2dbc1aa55\", \"browser_tests\": \"c1a4672b9a137f76586cb0f629994e8fba439c1c\", \"capture_unittests\": \"be67ef76c38802f8580a596113e325d05810a281\", \"cast_unittests\": \"6aec6782831f286e23e125a13861586a9aa1edb1\", \"cc_unittests\": \"bb1672dc550b313ac4c25ae6f2d5c4e41a4d49ed\", \"chrome_app_unittests\": \"7e51c73669d4c513ee2ebe16c05cfee7535d04cc\", \"chromedriver_unittests\": \"64328fcf0b1fd6040339f4b095213c067c3f840a\", \"color_unittests\": \"ea2704b40736b3554bb7abc6962bbc0ff1e692a9\", \"components_browsertests\": \"3c1b69dd056f52784b613fb15b4c093c2f00a62f\", \"components_unittests\": \"06bc815750bf93ee252149dee58f0547d240f96d\", \"compositor_unittests\": \"c8b4894073d308c15fd9af7ead665bc9bd015739\", \"content_browsertests\": \"8f9d2b4cda82d8e786f5d8878b8f86e5ac2d82b7\", \"content_shell_crash_test\": \"4d65fc88f3f724728d69f3a4b13b581ec4bd12ac\", \"content_unittests\": \"ebc354b876c3055dd791b05ff322d01ed3101f53\", \"crashpad_tests\": \"39952376fd98bcd364c965b6a43a7499d5cd2fde\", \"cronet_tests\": \"033258a4664263894387309d47f4c9afa92be1dd\", \"cronet_unittests\": \"28d5c51aee6625277a369ff94981fc04685d209d\", \"crypto_unittests\": \"48d0b6431752aa0cfda2fec4f61b937fee779c20\", \"dbus_unittests\": \"ea3e31ba1bdffd29c903a1f9ff886741fca0827a\", \"device_unittests\": \"b67f359a135a591ea6b0d6d299f914762423ccd7\", \"display_unittests\": \"86d3828c835af72f4132f7d17129cdda57c1b32d\", \"events_unittests\": \"c3144ef616b379cad7185a419ae526555c65d635\", \"extensions_browsertests\": \"a9cf160be630cd274e0b774429d240654eca1768\", \"extensions_unittests\": \"ad7e609663dbc7cae38a09845fe46a05717663fa\", \"filesystem_service_unittests\": \"492b6e8f36d824e19ccf35f098fbd957a71a948e\", \"flatbuffers_unittests\": \"053e6ac98b117f7c5980e972268db1930536e1f7\", \"gcm_unit_tests\": \"ebbe7aca6ea3dc177156b96bba7f321393e810dd\", \"gfx_unittests\": \"24aa173db32aa54083575ab672db07725b01cbe5\", \"gin_unittests\": \"162059b5d0320578c014fce9052b39f42d71d76a\", \"google_apis_unittests\": \"114739715fe1c87dc1c9c4410ecbcc30e0342a8c\", \"gpu_unittests\": \"033afddf10acfdb219fd0994a7c769d4ee403961\", \"grit_python_unittests\": \"7ad08adeec1e5c63b898e2e191a9ad3e35ab39f9\", \"gwp_asan_unittests\": \"b76afa748a13a6074b6c61f3090be4fa4b0ac76a\", \"headless_browsertests\": \"d10684b12686bc7e28e398676e33d88ee0a53133\", \"headless_unittests\": \"b5bd21b617593cf3c0f6b03c4a63e42f2496991b\", \"interactive_ui_tests\": \"efddf02f44d175c2b1089455c43bdc47d0d70958\", \"ipc_tests\": \"5e27b412a9c7693d62eafb16be593b155a5990ad\", \"jingle_unittests\": \"9a3247750ba1ceb36e2addb047f5bf87f8392cf7\", \"latency_unittests\": \"b586dff185c5179399c45e3b71fb9688755b2822\", \"libjingle_xmpp_unittests\": \"e893d432a309c6b7a52f9b564f068b2089a91a55\", \"liburlpattern_unittests\": \"091aa76f774cee07c20a50a5ae7b288425bd8d39\", \"media_blink_unittests\": \"51c12ddd00831db9fe79150b04f4d676a1e99f6e\", \"media_unittests\": \"296b0f0989d2564d62b3d2175906cab5b29ca6f8\", \"message_center_unittests\": \"1a27241ff161d89269ebf2d599d3b6d517c2d371\", \"metrics_python_tests\": \"775c08a1a596a635a56335b7cee37576970d2c18\", \"midi_unittests\": \"10f345d0e58fc6e0bfe85b502b778a25756e23d9\", \"mojo_core_unittests\": \"750191412bade303a1f9fb39372235855a8a611f\", \"mojo_unittests\": \"eca6b74e911192cdbb739d509a5cab971f58e27a\", \"nacl_helper_nonsfi_unittests\": \"b3d3af4a47b06539180e36f55dd9532d17baee94\", \"nacl_loader_unittests\": \"a0716373e199200fc8a0acda54b0ede1942fe121\", \"native_theme_unittests\": \"9fdee98161d45815d040decbf8c4f1b3496b4d4e\", \"net_unittests\": \"64dfad5725107e88c238002996e5230f2a53e513\", \"openscreen_unittests\": \"36fa7df792e913539645c38f549a8267aa0ae403\", \"pdf_unittests\": \"fcc7df7572762498bfe3f0d14ad26f6a9c1885bd\", \"perfetto_unittests\": \"e04ab934e40027f739654ea40f3995d29b0216b3\", \"ppapi_unittests\": \"212d7eb014833d2d1474c1902c9a4c3f6329a431\", \"printing_unittests\": \"888698105ffcddf7c0089caa9d8ce4a87a4aa9f7\", \"remoting_unittests\": \"81a773b7e1a04268043a733b67131ca7dd300e91\", \"sandbox_linux_unittests\": \"3f899211bddf6a53ecb60c093cb60cb13bf62186\", \"service_manager_unittests\": \"227b2fc4bc6eae9f9b4c4aa096b60bfa5050fca3\", \"services_unittests\": \"24ea6d55020273cee5274a6fc7de697f1cfa510e\", \"shell_dialogs_unittests\": \"cf31a1c0dda2fbf93fc129d88c0eefa82b75a9a1\", \"skia_unittests\": \"d20ca32f901c6fc663a7b129067d80e002b58535\", \"snapshot_unittests\": \"679d32cf32e342c743935270175a5f87debdf2fe\", \"sql_unittests\": \"259100dd644691a12f4f6b97fd0c4ac95b3205b7\", \"storage_unittests\": \"819bb2eb5b8cf47e58526fe466b927741679770d\", \"sync_integration_tests\": \"b8b933fce834dd2b8b3457ddffa7fc900202fa56\", \"telemetry_gpu_unittests\": \"06b3fb23eee26d1ea3f02f7950dae75209bf41c5\", \"telemetry_perf_unittests\": \"704917121ca1c55b4b7372e086068a338c72f118\", \"telemetry_unittests\": \"26c1a1a44acfe4d70737bf11e0a901dec0ae1373\", \"traffic_annotation_auditor_unittests\": \"ba8a01c0b5e159a466e2424c5593a7e4084149c9\", \"ui_base_unittests\": \"a8a08245dc7537ab24d7fe0c26f6fb01a0c0328b\", \"ui_touch_selection_unittests\": \"f02db8b48959ae76c5e3c793dfddee60093c069c\", \"unit_tests\": \"8322dad0659b22f3ca8cadc52b568e4aed2216b3\", \"url_unittests\": \"8a4667c6ecb089c3ac21c9590e5e2eac4197da5f\", \"views_perftests\": \"2cce2ef965479b23f81e5b277ce1680138aea711\", \"views_unittests\": \"975b5acf301c4dff76fc11980ee64c3a847fe49b\", \"viz_unittests\": \"60184f4278075ffe058bd53ee498baf25ac19a45\", \"vr_common_unittests\": \"b09429b1b3306db17a2e2b838944793b8cb1c6c5\", \"vr_pixeltests\": \"fc40dc00d0300ffe0ad37392e0524050a46ca92b\", \"webdriver_wpt_tests\": \"72f52793203194774fa88e15c9c348d081ae23fd\", \"weblayer_browsertests\": \"96572f91f2f96b31a848bcb3860325f3ef75db4d\", \"weblayer_unittests\": \"8e8d224ca5693769205fc2a18a931963129ef884\", \"wm_unittests\": \"1325efff276dd57d7ad3c1a62ab6a4eda6483779\", \"wtf_unittests\": \"583daa0c428dc398857887d7563421a03c0ff6e5\", \"x11_unittests\": \"cb61a39aabc49aae5b047bbe461e569133f843f5\", \"xr_browser_tests\": \"a46f9d06a2cb3a21adfe50438ee52e865a91f55f\", \"zlib_unittests\": \"571ba7528dd6515e3c20362a4b708705c4d09b54\"}}, \"swarming\": {\"bot_dimensions\": {\"builderless\": [\"1\"], \"caches\": [\"builder_2bbcd421f4eb1113f3a23522b280d70ced47ef846cc2e40eada60721dff8d17e_v2\", \"builder_47c3ec4238d3b3d0448e41826f5b2c1435e77a4255b8c93aa27077a59a7a5a67_v2\", \"builder_db6a6033e460ced730b3940170fe4cf923f58c29fb56731f98470df5edf70e65_v2\", \"builder_de67dcb387b95c18ea83e54ea320474d260d319089536d63e3279fdbb975ff72_v2\", \"builder_e21c17032b725bcf1c922976a36352546baf3f39ec148d1e6730a93c0400d8cc_v2\", \"builder_fac2959e29eeee13eb43de2791ff2fcb7aa7ab15952f0beca21f4615b55fa2a2_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-117-8x3x\"], \"image\": [\"chrome-xenial-21011100-9488e34e558\"], \"inside_docker\": [\"0\"], \"kvm\": [\"1\"], \"locale\": [\"en_US.UTF-8\"], \"machine_type\": [\"e2-standard-8\"], \"os\": [\"Linux\", \"Ubuntu\", \"Ubuntu-16\", \"Ubuntu-16.04\", \"Ubuntu-16.04.6\"], \"pool\": [\"luci.chromium.ci\"], \"python\": [\"2\", \"2.7\", \"2.7.12\"], \"server_version\": [\"5776-cb9e157\"], \"ssd\": [\"0\"], \"zone\": [\"us\", \"us-east\", \"us-east1\", \"us-east1-d\"]}}}",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"started_ts": "1616070957313601",
"status": "COMPLETED",
"status_changed_ts": "1616074234855541",
"tags": [
"build_address:luci.chromium.ci/Linux Builder (dbg)/181485",
"builder:Linux Builder (dbg)",
"buildset:commit/git/db2c5f0096a37acb3407d8436dd97ca011ba1e14",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/db2c5f0096a37acb3407d8436dd97ca011ba1e14",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9017850560543873872",
"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/8852420498523886064/+/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:525e275acd814310",
"user_agent:luci-scheduler"
],
"updated_ts": "1616074234872154",
"url": "https://ci.chromium.org/b/8852420498523886064",
"utcnow_ts": "1616074247241537"
}
}
[13:30:47.264] Invocation finished in 54m53.837344823s with status SUCCEEDED