[03:04:45.433] New invocation is queued and will start shortly
[03:04:46.497] Starting the invocation (attempt 1)
[03:04:46.559] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[03:04:46.559] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[03:04:46.559] Buildbucket request:
{
"bucket": "luci.chromium.ci",
"client_operation_id": "9020332611248850048",
"parameters_json": "{\"builder_name\":\"Linux Builder (dbg)\",\"properties\":{\"branch\":\"refs/heads/master\",\"repository\":\"https://chromium.googlesource.com/chromium/src\",\"revision\":\"ca136f237b4e4cb2bece2bc83f14dbbd7f16415e\"}}",
"pubsub_callback": {
"auth_token": "...",
"topic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
},
"tags": [
"builder:Linux Builder (dbg)",
"scheduler_invocation_id:9020332611248850048",
"scheduler_job_id:chromium/Linux Builder (dbg)",
"user_agent:luci-scheduler",
"buildset:commit/git/ca136f237b4e4cb2bece2bc83f14dbbd7f16415e",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/ca136f237b4e4cb2bece2bc83f14dbbd7f16415e",
"gitiles_ref:refs/heads/master"
]
}
[03:04:47.347] Buildbucket response:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "PROD",
"created_by": "project:chromium",
"created_ts": "1613703886692224",
"id": "8854902549266807664",
"parameters_json": "{\"builder_name\": \"Linux Builder (dbg)\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"ca136f237b4e4cb2bece2bc83f14dbbd7f16415e\"}}",
"project": "chromium",
"result_details_json": "{\"properties\": {}}",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"status": "SCHEDULED",
"status_changed_ts": "1613703887166017",
"tags": [
"build_address:luci.chromium.ci/Linux Builder (dbg)/180731",
"builder:Linux Builder (dbg)",
"buildset:commit/git/ca136f237b4e4cb2bece2bc83f14dbbd7f16415e",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/ca136f237b4e4cb2bece2bc83f14dbbd7f16415e",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9020332611248850048",
"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/8854902549266807664/+/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": "1613703887166129",
"url": "https://ci.chromium.org/b/8854902549266807664",
"utcnow_ts": "1613703887321603"
}
}
[03:04:47.347] Task URL: https://ci.chromium.org/b/8854902549266807664
[03:04:47.347] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9020332611248850048:2:0) after 1m0s
[03:04:49.332] Received PubSub notification, asking Buildbucket for the build status
[03:04:49.403] Build 8854902549266807664: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:05:47.465] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9020332611248850048:2:0)
[03:05:47.465] Timer tick, asking Buildbucket for the build status
[03:05:47.693] Build 8854902549266807664: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:05:47.693] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9020332611248850048:4:0) after 1m0s
[03:06:47.740] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9020332611248850048:4:0)
[03:06:47.740] Timer tick, asking Buildbucket for the build status
[03:06:47.847] Build 8854902549266807664: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:06:47.847] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9020332611248850048:5:0) after 1m0s
[03:07:47.939] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9020332611248850048:5:0)
[03:07:47.939] Timer tick, asking Buildbucket for the build status
[03:07:48.022] Build 8854902549266807664: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:07:48.022] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9020332611248850048:6:0) after 1m0s
[03:08:48.168] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9020332611248850048:6:0)
[03:08:48.168] Timer tick, asking Buildbucket for the build status
[03:08:48.240] Build 8854902549266807664: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:08:48.240] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9020332611248850048:7:0) after 1m0s
[03:09:48.314] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9020332611248850048:7:0)
[03:09:48.314] Timer tick, asking Buildbucket for the build status
[03:09:48.548] Build 8854902549266807664: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:09:48.548] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9020332611248850048:8:0) after 1m0s
[03:10:48.600] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9020332611248850048:8:0)
[03:10:48.600] Timer tick, asking Buildbucket for the build status
[03:10:48.686] Build 8854902549266807664: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:10:48.686] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9020332611248850048:9:0) after 1m0s
[03:11:48.707] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9020332611248850048:9:0)
[03:11:48.707] Timer tick, asking Buildbucket for the build status
[03:11:48.915] Build 8854902549266807664: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:11:48.915] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9020332611248850048:10:0) after 1m0s
[03:12:48.889] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9020332611248850048:10:0)
[03:12:48.889] Timer tick, asking Buildbucket for the build status
[03:12:49.028] Build 8854902549266807664: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:12:49.028] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9020332611248850048:11:0) after 1m0s
[03:13:49.060] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9020332611248850048:11:0)
[03:13:49.060] Timer tick, asking Buildbucket for the build status
[03:13:49.132] Build 8854902549266807664: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:13:49.132] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9020332611248850048:12:0) after 1m0s
[03:14:49.150] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9020332611248850048:12:0)
[03:14:49.150] Timer tick, asking Buildbucket for the build status
[03:14:49.261] Build 8854902549266807664: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:14:49.261] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9020332611248850048:13:0) after 1m0s
[03:15:49.300] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9020332611248850048:13:0)
[03:15:49.300] Timer tick, asking Buildbucket for the build status
[03:15:49.385] Build 8854902549266807664: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:15:49.385] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9020332611248850048:14:0) after 1m0s
[03:16:49.474] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9020332611248850048:14:0)
[03:16:49.474] Timer tick, asking Buildbucket for the build status
[03:16:49.701] Build 8854902549266807664: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:16:49.701] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9020332611248850048:15:0) after 1m0s
[03:17:49.768] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9020332611248850048:15:0)
[03:17:49.768] Timer tick, asking Buildbucket for the build status
[03:17:50.271] Build 8854902549266807664: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:17:50.271] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9020332611248850048:16:0) after 1m0s
[03:18:50.348] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9020332611248850048:16:0)
[03:18:50.348] Timer tick, asking Buildbucket for the build status
[03:18:50.436] Build 8854902549266807664: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:18:50.436] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9020332611248850048:17:0) after 1m0s
[03:19:50.443] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9020332611248850048:17:0)
[03:19:50.443] Timer tick, asking Buildbucket for the build status
[03:19:50.533] Build 8854902549266807664: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:19:50.533] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9020332611248850048:18:0) after 1m0s
[03:20:50.563] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9020332611248850048:18:0)
[03:20:50.563] Timer tick, asking Buildbucket for the build status
[03:20:50.885] Build 8854902549266807664: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:20:50.885] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9020332611248850048:19:0) after 1m0s
[03:21:50.933] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9020332611248850048:19:0)
[03:21:50.933] Timer tick, asking Buildbucket for the build status
[03:21:51.037] Build 8854902549266807664: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:21:51.037] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9020332611248850048:20:0) after 1m0s
[03:22:51.081] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9020332611248850048:20:0)
[03:22:51.081] Timer tick, asking Buildbucket for the build status
[03:22:51.166] Build 8854902549266807664: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:22:51.166] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9020332611248850048:21:0) after 1m0s
[03:23:51.255] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9020332611248850048:21:0)
[03:23:51.255] Timer tick, asking Buildbucket for the build status
[03:23:51.335] Build 8854902549266807664: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:23:51.335] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9020332611248850048:22:0) after 1m0s
[03:24:51.350] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9020332611248850048:22:0)
[03:24:51.350] Timer tick, asking Buildbucket for the build status
[03:24:51.605] Build 8854902549266807664: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:24:51.605] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9020332611248850048:23:0) after 1m0s
[03:25:51.603] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9020332611248850048:23:0)
[03:25:51.603] Timer tick, asking Buildbucket for the build status
[03:25:52.027] Build 8854902549266807664: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:25:52.027] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9020332611248850048:24:0) after 1m0s
[03:26:52.028] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9020332611248850048:24:0)
[03:26:52.028] Timer tick, asking Buildbucket for the build status
[03:26:52.111] Build 8854902549266807664: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:26:52.111] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9020332611248850048:25:0) after 1m0s
[03:27:52.162] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9020332611248850048:25:0)
[03:27:52.162] Timer tick, asking Buildbucket for the build status
[03:27:52.402] Build 8854902549266807664: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:27:52.402] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9020332611248850048:26:0) after 1m0s
[03:28:52.453] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9020332611248850048:26:0)
[03:28:52.453] Timer tick, asking Buildbucket for the build status
[03:28:52.561] Build 8854902549266807664: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:28:52.561] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9020332611248850048:27:0) after 1m0s
[03:29:52.620] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9020332611248850048:27:0)
[03:29:52.620] Timer tick, asking Buildbucket for the build status
[03:29:52.729] Build 8854902549266807664: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:29:52.729] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9020332611248850048:28:0) after 1m0s
[03:30:52.802] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9020332611248850048:28:0)
[03:30:52.802] Timer tick, asking Buildbucket for the build status
[03:30:53.122] Build 8854902549266807664: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:30:53.122] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9020332611248850048:29:0) after 1m0s
[03:31:53.165] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9020332611248850048:29:0)
[03:31:53.165] Timer tick, asking Buildbucket for the build status
[03:31:53.238] Build 8854902549266807664: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:31:53.238] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9020332611248850048:30:0) after 1m0s
[03:32:53.265] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9020332611248850048:30:0)
[03:32:53.265] Timer tick, asking Buildbucket for the build status
[03:32:53.344] Build 8854902549266807664: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:32:53.344] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9020332611248850048:31:0) after 1m0s
[03:33:53.386] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9020332611248850048:31:0)
[03:33:53.386] Timer tick, asking Buildbucket for the build status
[03:33:53.541] Build 8854902549266807664: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:33:53.541] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9020332611248850048:32:0) after 1m0s
[03:34:53.641] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9020332611248850048:32:0)
[03:34:53.641] Timer tick, asking Buildbucket for the build status
[03:34:53.738] Build 8854902549266807664: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:34:53.738] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9020332611248850048:33:0) after 1m0s
[03:35:53.786] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9020332611248850048:33:0)
[03:35:53.786] Timer tick, asking Buildbucket for the build status
[03:35:53.867] Build 8854902549266807664: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:35:53.867] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9020332611248850048:34:0) after 1m0s
[03:36:53.963] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9020332611248850048:34:0)
[03:36:53.963] Timer tick, asking Buildbucket for the build status
[03:36:54.075] Build 8854902549266807664: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:36:54.075] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9020332611248850048:35:0) after 1m0s
[03:37:54.183] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9020332611248850048:35:0)
[03:37:54.183] Timer tick, asking Buildbucket for the build status
[03:37:54.266] Build 8854902549266807664: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:37:54.266] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9020332611248850048:36:0) after 1m0s
[03:38:54.319] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9020332611248850048:36:0)
[03:38:54.319] Timer tick, asking Buildbucket for the build status
[03:38:54.409] Build 8854902549266807664: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:38:54.409] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9020332611248850048:37:0) after 1m0s
[03:39:54.432] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9020332611248850048:37:0)
[03:39:54.432] Timer tick, asking Buildbucket for the build status
[03:39:54.702] Build 8854902549266807664: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:39:54.702] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9020332611248850048:38:0) after 1m0s
[03:40:54.714] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9020332611248850048:38:0)
[03:40:54.714] Timer tick, asking Buildbucket for the build status
[03:40:54.998] Build 8854902549266807664: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:40:54.998] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9020332611248850048:39:0) after 1m0s
[03:41:55.001] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9020332611248850048:39:0)
[03:41:55.001] Timer tick, asking Buildbucket for the build status
[03:41:55.092] Build 8854902549266807664: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:41:55.092] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9020332611248850048:40:0) after 1m0s
[03:42:55.137] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9020332611248850048:40:0)
[03:42:55.137] Timer tick, asking Buildbucket for the build status
[03:42:55.215] Build 8854902549266807664: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:42:55.215] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9020332611248850048:41:0) after 1m0s
[03:43:55.236] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9020332611248850048:41:0)
[03:43:55.236] Timer tick, asking Buildbucket for the build status
[03:43:55.329] Build 8854902549266807664: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:43:55.329] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9020332611248850048:42:0) after 1m0s
[03:44:55.372] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9020332611248850048:42:0)
[03:44:55.372] Timer tick, asking Buildbucket for the build status
[03:44:55.464] Build 8854902549266807664: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:44:55.464] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9020332611248850048:43:0) after 1m0s
[03:45:55.503] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9020332611248850048:43:0)
[03:45:55.503] Timer tick, asking Buildbucket for the build status
[03:45:55.589] Build 8854902549266807664: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:45:55.589] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9020332611248850048:44:0) after 1m0s
[03:46:55.610] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9020332611248850048:44:0)
[03:46:55.610] Timer tick, asking Buildbucket for the build status
[03:46:55.717] Build 8854902549266807664: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:46:55.717] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9020332611248850048:45:0) after 1m0s
[03:47:55.785] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9020332611248850048:45:0)
[03:47:55.785] Timer tick, asking Buildbucket for the build status
[03:47:55.868] Build 8854902549266807664: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:47:55.868] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9020332611248850048:46:0) after 1m0s
[03:48:55.862] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9020332611248850048:46:0)
[03:48:55.862] Timer tick, asking Buildbucket for the build status
[03:48:55.928] Build 8854902549266807664: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:48:55.928] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9020332611248850048:47:0) after 1m0s
[03:49:55.967] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9020332611248850048:47:0)
[03:49:55.967] Timer tick, asking Buildbucket for the build status
[03:49:56.105] Build 8854902549266807664: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:49:56.105] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9020332611248850048:48:0) after 1m0s
[03:50:56.201] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9020332611248850048:48:0)
[03:50:56.201] Timer tick, asking Buildbucket for the build status
[03:50:56.272] Build 8854902549266807664: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:50:56.272] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9020332611248850048:49:0) after 1m0s
[03:51:56.315] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9020332611248850048:49:0)
[03:51:56.315] Timer tick, asking Buildbucket for the build status
[03:51:56.599] Build 8854902549266807664: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:51:56.599] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9020332611248850048:50:0) after 1m0s
[03:52:56.618] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9020332611248850048:50:0)
[03:52:56.618] Timer tick, asking Buildbucket for the build status
[03:52:56.713] Build 8854902549266807664: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:52:56.713] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9020332611248850048:51:0) after 1m0s
[03:53:56.766] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9020332611248850048:51:0)
[03:53:56.766] Timer tick, asking Buildbucket for the build status
[03:53:56.852] Build 8854902549266807664: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:53:56.852] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9020332611248850048:52:0) after 1m0s
[03:54:56.856] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9020332611248850048:52:0)
[03:54:56.856] Timer tick, asking Buildbucket for the build status
[03:54:56.951] Build 8854902549266807664: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:54:56.951] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9020332611248850048:53:0) after 1m0s
[03:55:56.955] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9020332611248850048:53:0)
[03:55:56.955] Timer tick, asking Buildbucket for the build status
[03:55:57.024] Build 8854902549266807664: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:55:57.024] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9020332611248850048:54:0) after 1m0s
[03:56:57.087] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9020332611248850048:54:0)
[03:56:57.087] Timer tick, asking Buildbucket for the build status
[03:56:57.196] Build 8854902549266807664: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:56:57.196] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9020332611248850048:55:0) after 1m0s
[03:57:57.289] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9020332611248850048:55:0)
[03:57:57.289] Timer tick, asking Buildbucket for the build status
[03:57:57.364] Build 8854902549266807664: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:57:57.365] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9020332611248850048:56:0) after 1m0s
[03:58:57.394] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9020332611248850048:56:0)
[03:58:57.394] Timer tick, asking Buildbucket for the build status
[03:58:57.468] Build 8854902549266807664: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:58:57.468] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9020332611248850048:57:0) after 1m0s
[03:59:57.483] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9020332611248850048:57:0)
[03:59:57.483] Timer tick, asking Buildbucket for the build status
[03:59:57.596] Build 8854902549266807664: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:59:57.596] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9020332611248850048:58:0) after 1m0s
[04:00:57.649] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9020332611248850048:58:0)
[04:00:57.649] Timer tick, asking Buildbucket for the build status
[04:00:57.723] Build 8854902549266807664: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:00:57.723] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9020332611248850048:59:0) after 1m0s
[04:01:57.787] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9020332611248850048:59:0)
[04:01:57.787] Timer tick, asking Buildbucket for the build status
[04:01:57.905] Build 8854902549266807664: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:01:57.905] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9020332611248850048:60:0) after 1m0s
[04:02:58.017] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9020332611248850048:60:0)
[04:02:58.017] Timer tick, asking Buildbucket for the build status
[04:02:58.121] Build 8854902549266807664: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:02:58.121] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9020332611248850048:61:0) after 1m0s
[04:03:36.953] Received PubSub notification, asking Buildbucket for the build status
[04:03:37.055] Build 8854902549266807664: status "COMPLETED", result "SUCCESS", failure_reason "", cancelation_reason ""
[04:03:37.055] Buildbucket build:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "PROD",
"completed_ts": "1613707416369488",
"created_by": "project:chromium",
"created_ts": "1613703886692224",
"id": "8854902549266807664",
"parameters_json": "{\"builder_name\": \"Linux Builder (dbg)\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"ca136f237b4e4cb2bece2bc83f14dbbd7f16415e\"}}",
"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\": \"ca136f237b4e4cb2bece2bc83f14dbbd7f16415e\", \"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-central1-b-8-26-2i8d\", \"branch\": \"refs/heads/master\", \"builder_group\": \"chromium.linux\", \"buildername\": \"Linux Builder (dbg)\", \"buildnumber\": 180731, \"got_angle_revision\": \"fd132e4e7a9c84333b4fb4730f79367fe75f53e7\", \"got_dawn_revision\": \"1024d6e1873cd12280b6d43a78f779a108d57320\", \"got_nacl_revision\": \"8a92e6ba1b6d62631f8d3ba3f4f8872ae8b6cca1\", \"got_revision\": \"ca136f237b4e4cb2bece2bc83f14dbbd7f16415e\", \"got_revision_cp\": \"refs/heads/master@{#855603}\", \"got_swarming_client_revision\": \"a32a1607f6093d338f756c7e7c7b4333b0c50c9c\", \"got_swiftshader_revision\": \"8603b126b3d599f0ab8781163729fd226a93cf17\", \"got_v8_revision\": \"aaf128851c4dd86978eaf9d41ce297c5af31597f\", \"got_v8_revision_cp\": \"refs/heads/9.0.217@{#1}\", \"got_webrtc_revision\": \"735e33fae0a06ae05a9c0be6f5d8b06a6ad820a4\", \"got_webrtc_revision_cp\": \"refs/heads/master@{#33297}\", \"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\": \"ca136f237b4e4cb2bece2bc83f14dbbd7f16415e\", \"swarm_hashes_refs/heads/master(at){#855603}_without_patch\": {\"absl_hardening_tests\": \"ea13295ce48a93ea1c111243e9692b5569aba70f\", \"accessibility_unittests\": \"bc972ee3fb2f84590cf92da71a1450d4a5902108\", \"angle_unittests\": \"3ce70cfaccda6c9b10ec719817a2cf34b25d789a\", \"app_shell_unittests\": \"7746b6f6721038d3bb6fa980605ca50816c0958e\", \"aura_unittests\": \"620ad3824402d134d3810f9dfa252b18eb83fcec\", \"base_unittests\": \"b8373905f4a17c33da9a25a409fd2c6a935c4f29\", \"base_util_unittests\": \"51488229683c06ec6ac556939365a313c7626d48\", \"blink_common_unittests\": \"83d099cf16dca1a12e728b3f9dcf8fe1c2438305\", \"blink_fuzzer_unittests\": \"829384b83c252c7ebac10c94716f67340c9059be\", \"blink_heap_unittests\": \"b7457c82787385c04c7c95d45ea3cba6f170bf2b\", \"blink_platform_unittests\": \"47b23fe6f69eb878f21448fe4b1028cc57617e35\", \"blink_python_tests\": \"5d0030becac3d7416c20af6b7455af0d98f8b8a5\", \"blink_unittests\": \"9aa8ddfded638b2e6dca2342db290dd75ad5efe8\", \"blink_web_tests\": \"fd89d1d94950780db1781e98f3894e0ed7577239\", \"boringssl_crypto_tests\": \"48f3af5a36abaf8bc39864eb22548554b9c093a6\", \"boringssl_ssl_tests\": \"5f4a509e6291b6648d6cd0a86bd903c219e3efb9\", \"browser_tests\": \"db93840a1129a0bb4454c75743069855b24622d9\", \"capture_unittests\": \"c5fdebc8b9e43941d39d6a8b83b6cb8ac1b6a247\", \"cast_unittests\": \"e8f2676c8533fa722c962462ee1b58f380789443\", \"cc_unittests\": \"4c163035bf987400727fb81f9365c7ce180013ac\", \"chrome_app_unittests\": \"2cfee2a66d7877bb9e127f4ef22cd06d543f089a\", \"chromedriver_unittests\": \"13812d8043135b48e2278be9b029a98a884b99be\", \"components_browsertests\": \"d937a903d4494f5a2cbb77abdbef573d8cc1f2f6\", \"components_unittests\": \"86ddf062d0e73c7348c6b2c9a8717f9e232cc244\", \"compositor_unittests\": \"2a80edd0f2f3ce5fb0fccf2c7085b24266cdb247\", \"content_browsertests\": \"a9ea8b135acb752aa83784a1be9f73df12b27363\", \"content_shell_crash_test\": \"d48eea37786448ea3c090c134c7383395f09cd44\", \"content_unittests\": \"0dc25d89549cb431312225e33026fb74a7b53382\", \"crashpad_tests\": \"21f2b2918597c5d56aeb1e66e61315adac81f37c\", \"cronet_tests\": \"e02a4fb4d48043e6149ec795aafa4c2c10e9fa6a\", \"cronet_unittests\": \"5f840fd89fe3eced7d51d0d479f829b4b1ebd3f3\", \"crypto_unittests\": \"f5adf5b112f36dca3b9c087d579edff17afac845\", \"dbus_unittests\": \"965ecc73ee8668dd795446a6677dc9d1cefd36de\", \"device_unittests\": \"7a810efebd4129a5ede9d75b7cc19d36733eae95\", \"display_unittests\": \"dcda0aeeda60ba8771bf4d8185761409ebdf7a7f\", \"events_unittests\": \"4c424a1b2d64a573b0b2a52cdf41706161b82078\", \"extensions_browsertests\": \"4180e70bc8a08953d7460cb894fe8b02b99f8125\", \"extensions_unittests\": \"1a8a3184ad7f221ac8b62e4700ec25f0a7d7094d\", \"filesystem_service_unittests\": \"ff3b05e71a18f5e0914a76124d9ab9406b9ab3c1\", \"flatbuffers_unittests\": \"698230cd2ee29799b3293b30c69cdc80b3ff243d\", \"gcm_unit_tests\": \"e85dba5599f9411cf6ce898811daf7019448f727\", \"gfx_unittests\": \"c468410292395d46493b715dad9c8f7df626aa0c\", \"gin_unittests\": \"2691090a9bf6345f44c829c027df53ee0421c6b4\", \"google_apis_unittests\": \"6ea318d7e86c565e92b341b87a9882e1f5f2001b\", \"gpu_unittests\": \"6cc75e411f96f8053b1f32cffabb07e45cfd2711\", \"grit_python_unittests\": \"e9472d6ec31317123f3dfff9be51bd5eb8f9349b\", \"gwp_asan_unittests\": \"23dd335574b760b00237dce18ed34b19965c670d\", \"headless_browsertests\": \"f30bd1f73eabbd70eb2a2f5dd84b3dcbe1cc2a25\", \"headless_unittests\": \"938d71ce7096a3d180f2b99f0a64bb8442ccdfd1\", \"interactive_ui_tests\": \"75cbf0c2b34f8c4e1d1c7439517a9c5ac3fad2b0\", \"ipc_tests\": \"dee671adf3324ee8e2254fd61121868598f14704\", \"jingle_unittests\": \"8b2b0e2999956399f075ec93d632f126592a4ef2\", \"latency_unittests\": \"d5654bdcafd6bd67377948c5578827c50df43c7e\", \"libjingle_xmpp_unittests\": \"383976382e5bbd0e8150bbf50826e6609f28cb10\", \"liburlpattern_unittests\": \"b13f5fb2c7b2e3201e87f24053eb24d4bbd3c1ea\", \"media_blink_unittests\": \"297dbe80b0eeee096a54d54d48103074ac83f7d5\", \"media_unittests\": \"c7c9a76e978b4bb0280bb9c43cc68aa6883d1e9a\", \"message_center_unittests\": \"079772ea10b034948875c643df0bee699ab5c53e\", \"metrics_python_tests\": \"785c38e9c93a774566fe4b163ffc9c9d68a113f8\", \"midi_unittests\": \"84a48020360cc6539eaeeab9ab8389a8895a7a4b\", \"mojo_core_unittests\": \"7a9df45427df3c4455f7b65a4d4b1f0fcd9194c2\", \"mojo_unittests\": \"e0cdc82999b7e49d76f99ed98ca7964a49fde757\", \"nacl_helper_nonsfi_unittests\": \"e976280b6ad2d44029ba238553022313058d556e\", \"nacl_loader_unittests\": \"1199f93271e9b262918789ec8007d0e3cc0b3bdc\", \"native_theme_unittests\": \"fcc7c588f65803a3fa651aeeeb0b0f6b9608ee7f\", \"net_unittests\": \"13784405dde8a360ad8c3a12584bec09ebc9f0a8\", \"openscreen_unittests\": \"2610064b825c8fe148e67b6187a6421b4cff12ad\", \"pdf_unittests\": \"0d00cc7ad50b58983db2c1bce22039fc8eacbab5\", \"perfetto_unittests\": \"d05aa4886b2b406ddc1f4035433e3d2704a7b3f4\", \"ppapi_unittests\": \"b0c3b2448c89769b6804bbb4b863a330c4c0cee8\", \"printing_unittests\": \"f56971211783c4d5b119d26f538caa473da46d30\", \"remoting_unittests\": \"eaa32c9d5ed869d3415e1823dff2b8c8c02e0a4b\", \"sandbox_linux_unittests\": \"90535369d9ad87d19983b6118faab9e60f3f59fc\", \"service_manager_unittests\": \"805545dfa501ff4025fc82936d0d391c385e90b9\", \"services_unittests\": \"9053774872d3b11dd0a174e354d89e88d87883a7\", \"shell_dialogs_unittests\": \"57924d3245f20c959614430a586aace2c83617e2\", \"skia_unittests\": \"02e07fda9810dfbbd4897df6bc76f73e5a7dc3d8\", \"snapshot_unittests\": \"e28384e1e192d75e2fba637e4c82b0b77f0bc67c\", \"sql_unittests\": \"e45e8c3b940a88fb630bbaf6bdd0f6e35681dc07\", \"storage_unittests\": \"a481e1e0dd8cee83977d5b72764351cf1018b3d2\", \"sync_integration_tests\": \"b28e2dab5101cf0281fc41cb5032b76f50cdc375\", \"telemetry_gpu_unittests\": \"3714a761d530de8f59dddba8dcb076f75d16ab0a\", \"telemetry_perf_unittests\": \"ab9c78d9c98f1fef100356e2b1627eb5c7ce39d3\", \"telemetry_unittests\": \"540b301e491d7f4a897e12bbf65dc0d1a6a3c217\", \"traffic_annotation_auditor_unittests\": \"57c7a80b5b14487139fd0f78166c56ff98118666\", \"ui_base_unittests\": \"9f53eab67c4d1fe3f19b2aa837897f14d1ec1866\", \"ui_touch_selection_unittests\": \"b6d879771c6b0962ea720d7a57f9c8cb0b37f954\", \"unit_tests\": \"0ec3a2735bb740c1f741c47abd85a60e212474c9\", \"url_unittests\": \"50c7c7b24b3caa514e9b809237cc42e8e4e78a87\", \"views_perftests\": \"42220e6a663f737de7814d706d32838ad3431346\", \"views_unittests\": \"6ae1cfeaf2dc21a634536bcb3b9dd12b118589ac\", \"viz_unittests\": \"c48622068cc85bea49df8c13a39a1c063bd04ad4\", \"vr_common_unittests\": \"e4efcf4e4bbb64fd5921623380d507be87bb2615\", \"vr_pixeltests\": \"7d57b2034f42644340661be11d6cfcc96b4613f3\", \"webdriver_wpt_tests\": \"e40431a005225c6c8881b2b5b54ef17e0b8ba7ce\", \"weblayer_browsertests\": \"f56005d2c957e1906c8fa89cadfcb159fe0f5abd\", \"weblayer_unittests\": \"f1e0e4fc70f48fda31f9758838a577f24bb607cb\", \"wm_unittests\": \"9f6c6c4c4930e4529f58d0b386c5efc8e1d8648a\", \"wtf_unittests\": \"9e37f0e4b4d85fb5be8320357b6955a337d5d604\", \"x11_unittests\": \"2a22d9f53589049daf92e2d571ab9321156ada7c\", \"xr_browser_tests\": \"fef749122b751715f9c28504bc49af40a49f051b\", \"zlib_unittests\": \"c4eeec5b7cf7e1ca342abdbaac8de37bbda04546\"}}, \"swarming\": {\"bot_dimensions\": {\"builderless\": [\"1\"], \"caches\": [\"builder_a8228d45a2e4046ab48e21b574ab916f6d3c7e4ad955b91040a9e9374d3dd18a_v2\", \"builder_e21c17032b725bcf1c922976a36352546baf3f39ec148d1e6730a93c0400d8cc_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-central1-b-8-26-2i8d\"], \"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.7.12\"], \"server_version\": [\"5706-397711c\"], \"ssd\": [\"0\"], \"zone\": [\"us\", \"us-central\", \"us-central1\", \"us-central1-b\"]}}}",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"started_ts": "1613703888515947",
"status": "COMPLETED",
"status_changed_ts": "1613707416708147",
"tags": [
"build_address:luci.chromium.ci/Linux Builder (dbg)/180731",
"builder:Linux Builder (dbg)",
"buildset:commit/git/ca136f237b4e4cb2bece2bc83f14dbbd7f16415e",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/ca136f237b4e4cb2bece2bc83f14dbbd7f16415e",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9020332611248850048",
"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/8854902549266807664/+/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:51d110c2f0d92a10",
"user_agent:luci-scheduler"
],
"updated_ts": "1613707416712858",
"url": "https://ci.chromium.org/b/8854902549266807664",
"utcnow_ts": "1613707417048148"
}
}
[04:03:37.055] Invocation finished in 58m51.637709358s with status SUCCEEDED