[16:56:52.204] New invocation is queued and will start shortly
[16:56:53.280] Starting the invocation (attempt 1)
[16:56:53.317] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[16:56:53.320] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[16:56:53.321] Buildbucket request:
{
"bucket": "luci.chromium.ci",
"client_operation_id": "9031967267905302608",
"parameters_json": "{\"builder_name\":\"Linux Builder (dbg)\",\"properties\":{\"branch\":\"refs/heads/master\",\"repository\":\"https://chromium.googlesource.com/chromium/src\",\"revision\":\"42cede4a815b1fb5e60af8bb63252f0aaa4939dd\"}}",
"pubsub_callback": {
"auth_token": "...",
"topic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
},
"tags": [
"builder:Linux Builder (dbg)",
"scheduler_invocation_id:9031967267905302608",
"scheduler_job_id:chromium/Linux Builder (dbg)",
"user_agent:luci-scheduler",
"buildset:commit/git/42cede4a815b1fb5e60af8bb63252f0aaa4939dd",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/42cede4a815b1fb5e60af8bb63252f0aaa4939dd",
"gitiles_ref:refs/heads/master"
]
}
[16:56:54.787] Buildbucket response:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "PROD",
"created_by": "project:chromium",
"created_ts": "1602608213447276",
"id": "8866537205934376112",
"parameters_json": "{\"builder_name\": \"Linux Builder (dbg)\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"42cede4a815b1fb5e60af8bb63252f0aaa4939dd\"}}",
"project": "chromium",
"result_details_json": "{\"properties\": {}}",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"status": "SCHEDULED",
"status_changed_ts": "1602608214399855",
"tags": [
"build_address:luci.chromium.ci/Linux Builder (dbg)/176625",
"builder:Linux Builder (dbg)",
"buildset:commit/git/42cede4a815b1fb5e60af8bb63252f0aaa4939dd",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/42cede4a815b1fb5e60af8bb63252f0aaa4939dd",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9031967267905302608",
"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/8866537205934376112/+/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": "1602608214400002",
"url": "https://ci.chromium.org/b/8866537205934376112",
"utcnow_ts": "1602608214743354"
}
}
[16:56:54.787] Task URL: https://ci.chromium.org/b/8866537205934376112
[16:56:54.787] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9031967267905302608:2:0) after 1m0s
[16:56:58.918] Received PubSub notification, asking Buildbucket for the build status
[16:56:59.058] Build 8866537205934376112: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:57:54.821] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9031967267905302608:2:0)
[16:57:54.821] Timer tick, asking Buildbucket for the build status
[16:57:54.958] Build 8866537205934376112: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:57:54.958] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9031967267905302608:4:0) after 1m0s
[16:58:54.981] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9031967267905302608:4:0)
[16:58:54.981] Timer tick, asking Buildbucket for the build status
[16:58:55.134] Build 8866537205934376112: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:58:55.134] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9031967267905302608:5:0) after 1m0s
[16:59:55.238] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9031967267905302608:5:0)
[16:59:55.238] Timer tick, asking Buildbucket for the build status
[16:59:55.321] Build 8866537205934376112: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:59:55.321] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9031967267905302608:6:0) after 1m0s
[17:00:55.374] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9031967267905302608:6:0)
[17:00:55.374] Timer tick, asking Buildbucket for the build status
[17:00:55.876] Build 8866537205934376112: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:00:55.876] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9031967267905302608:7:0) after 1m0s
[17:01:55.920] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9031967267905302608:7:0)
[17:01:55.920] Timer tick, asking Buildbucket for the build status
[17:01:56.095] Build 8866537205934376112: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:01:56.095] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9031967267905302608:8:0) after 1m0s
[17:02:56.119] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9031967267905302608:8:0)
[17:02:56.119] Timer tick, asking Buildbucket for the build status
[17:02:56.223] Build 8866537205934376112: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:02:56.223] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9031967267905302608:9:0) after 1m0s
[17:03:56.268] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9031967267905302608:9:0)
[17:03:56.268] Timer tick, asking Buildbucket for the build status
[17:03:56.498] Build 8866537205934376112: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:03:56.498] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9031967267905302608:10:0) after 1m0s
[17:04:56.574] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9031967267905302608:10:0)
[17:04:56.574] Timer tick, asking Buildbucket for the build status
[17:04:56.640] Build 8866537205934376112: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:04:56.640] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9031967267905302608:11:0) after 1m0s
[17:05:56.670] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9031967267905302608:11:0)
[17:05:56.670] Timer tick, asking Buildbucket for the build status
[17:05:57.257] Build 8866537205934376112: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:05:57.257] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9031967267905302608:12:0) after 1m0s
[17:06:57.281] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9031967267905302608:12:0)
[17:06:57.281] Timer tick, asking Buildbucket for the build status
[17:06:57.391] Build 8866537205934376112: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:06:57.391] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9031967267905302608:13:0) after 1m0s
[17:07:57.509] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9031967267905302608:13:0)
[17:07:57.509] Timer tick, asking Buildbucket for the build status
[17:07:57.914] Build 8866537205934376112: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:07:57.914] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9031967267905302608:14:0) after 1m0s
[17:08:57.941] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9031967267905302608:14:0)
[17:08:57.941] Timer tick, asking Buildbucket for the build status
[17:08:58.081] Build 8866537205934376112: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:08:58.081] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9031967267905302608:15:0) after 1m0s
[17:09:58.170] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9031967267905302608:15:0)
[17:09:58.170] Timer tick, asking Buildbucket for the build status
[17:09:58.529] Build 8866537205934376112: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:09:58.529] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9031967267905302608:16:0) after 1m0s
[17:10:58.579] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9031967267905302608:16:0)
[17:10:58.579] Timer tick, asking Buildbucket for the build status
[17:10:58.636] Build 8866537205934376112: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:10:58.636] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9031967267905302608:17:0) after 1m0s
[17:11:58.686] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9031967267905302608:17:0)
[17:11:58.686] Timer tick, asking Buildbucket for the build status
[17:11:58.792] Build 8866537205934376112: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:11:58.792] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9031967267905302608:18:0) after 1m0s
[17:12:58.810] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9031967267905302608:18:0)
[17:12:58.810] Timer tick, asking Buildbucket for the build status
[17:12:58.894] Build 8866537205934376112: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:12:58.894] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9031967267905302608:19:0) after 1m0s
[17:13:58.918] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9031967267905302608:19:0)
[17:13:58.918] Timer tick, asking Buildbucket for the build status
[17:13:59.139] Build 8866537205934376112: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:13:59.139] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9031967267905302608:20:0) after 1m0s
[17:14:59.203] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9031967267905302608:20:0)
[17:14:59.203] Timer tick, asking Buildbucket for the build status
[17:14:59.265] Build 8866537205934376112: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:14:59.265] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9031967267905302608:21:0) after 1m0s
[17:15:59.266] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9031967267905302608:21:0)
[17:15:59.266] Timer tick, asking Buildbucket for the build status
[17:15:59.322] Build 8866537205934376112: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:15:59.322] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9031967267905302608:22:0) after 1m0s
[17:16:59.299] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9031967267905302608:22:0)
[17:16:59.299] Timer tick, asking Buildbucket for the build status
[17:16:59.536] Build 8866537205934376112: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:16:59.536] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9031967267905302608:23:0) after 1m0s
[17:17:59.582] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9031967267905302608:23:0)
[17:17:59.582] Timer tick, asking Buildbucket for the build status
[17:17:59.785] Build 8866537205934376112: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:17:59.786] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9031967267905302608:24:0) after 1m0s
[17:18:59.821] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9031967267905302608:24:0)
[17:18:59.821] Timer tick, asking Buildbucket for the build status
[17:18:59.940] Build 8866537205934376112: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:18:59.940] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9031967267905302608:25:0) after 1m0s
[17:20:00.036] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9031967267905302608:25:0)
[17:20:00.036] Timer tick, asking Buildbucket for the build status
[17:20:00.279] Build 8866537205934376112: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:20:00.279] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9031967267905302608:26:0) after 1m0s
[17:21:00.309] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9031967267905302608:26:0)
[17:21:00.309] Timer tick, asking Buildbucket for the build status
[17:21:00.372] Build 8866537205934376112: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:21:00.372] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9031967267905302608:27:0) after 1m0s
[17:22:00.422] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9031967267905302608:27:0)
[17:22:00.422] Timer tick, asking Buildbucket for the build status
[17:22:00.542] Build 8866537205934376112: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:22:00.542] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9031967267905302608:28:0) after 1m0s
[17:23:01.919] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9031967267905302608:28:0)
[17:23:01.919] Timer tick, asking Buildbucket for the build status
[17:23:02.010] Build 8866537205934376112: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:23:02.010] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9031967267905302608:29:0) after 1m0s
[17:24:02.135] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9031967267905302608:29:0)
[17:24:02.135] Timer tick, asking Buildbucket for the build status
[17:24:02.225] Build 8866537205934376112: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:24:02.225] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9031967267905302608:30:0) after 1m0s
[17:25:02.284] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9031967267905302608:30:0)
[17:25:02.284] Timer tick, asking Buildbucket for the build status
[17:25:02.355] Build 8866537205934376112: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:25:02.355] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9031967267905302608:31:0) after 1m0s
[17:26:02.895] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9031967267905302608:31:0)
[17:26:02.895] Timer tick, asking Buildbucket for the build status
[17:26:03.085] Build 8866537205934376112: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:26:03.085] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9031967267905302608:32:0) after 1m0s
[17:27:03.134] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9031967267905302608:32:0)
[17:27:03.134] Timer tick, asking Buildbucket for the build status
[17:27:06.430] Build 8866537205934376112: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:27:06.430] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9031967267905302608:33:0) after 1m0s
[17:28:06.511] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9031967267905302608:33:0)
[17:28:06.511] Timer tick, asking Buildbucket for the build status
[17:28:06.976] Build 8866537205934376112: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:28:06.976] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9031967267905302608:34:0) after 1m0s
[17:29:06.999] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9031967267905302608:34:0)
[17:29:06.999] Timer tick, asking Buildbucket for the build status
[17:29:07.082] Build 8866537205934376112: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:29:07.083] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9031967267905302608:35:0) after 1m0s
[17:30:07.149] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9031967267905302608:35:0)
[17:30:07.149] Timer tick, asking Buildbucket for the build status
[17:30:07.494] Build 8866537205934376112: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:30:07.494] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9031967267905302608:36:0) after 1m0s
[17:31:07.525] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9031967267905302608:36:0)
[17:31:07.525] Timer tick, asking Buildbucket for the build status
[17:31:07.593] Build 8866537205934376112: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:31:07.593] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9031967267905302608:37:0) after 1m0s
[17:32:07.637] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9031967267905302608:37:0)
[17:32:07.637] Timer tick, asking Buildbucket for the build status
[17:32:07.775] Build 8866537205934376112: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:32:07.775] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9031967267905302608:38:0) after 1m0s
[17:33:07.782] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9031967267905302608:38:0)
[17:33:07.782] Timer tick, asking Buildbucket for the build status
[17:33:07.899] Build 8866537205934376112: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:33:07.899] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9031967267905302608:39:0) after 1m0s
[17:34:07.965] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9031967267905302608:39:0)
[17:34:07.965] Timer tick, asking Buildbucket for the build status
[17:34:08.139] Build 8866537205934376112: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:34:08.139] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9031967267905302608:40:0) after 1m0s
[17:35:08.140] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9031967267905302608:40:0)
[17:35:08.140] Timer tick, asking Buildbucket for the build status
[17:35:08.247] Build 8866537205934376112: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:35:08.247] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9031967267905302608:41:0) after 1m0s
[17:36:08.354] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9031967267905302608:41:0)
[17:36:08.354] Timer tick, asking Buildbucket for the build status
[17:36:08.420] Build 8866537205934376112: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:36:08.420] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9031967267905302608:42:0) after 1m0s
[17:37:08.494] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9031967267905302608:42:0)
[17:37:08.494] Timer tick, asking Buildbucket for the build status
[17:37:08.612] Build 8866537205934376112: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:37:08.612] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9031967267905302608:43:0) after 1m0s
[17:38:08.643] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9031967267905302608:43:0)
[17:38:08.643] Timer tick, asking Buildbucket for the build status
[17:38:08.721] Build 8866537205934376112: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:38:08.721] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9031967267905302608:44:0) after 1m0s
[17:39:08.736] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9031967267905302608:44:0)
[17:39:08.736] Timer tick, asking Buildbucket for the build status
[17:39:08.888] Build 8866537205934376112: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:39:08.888] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9031967267905302608:45:0) after 1m0s
[17:40:08.946] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9031967267905302608:45:0)
[17:40:08.946] Timer tick, asking Buildbucket for the build status
[17:40:09.142] Build 8866537205934376112: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:40:09.142] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9031967267905302608:46:0) after 1m0s
[17:41:09.234] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9031967267905302608:46:0)
[17:41:09.234] Timer tick, asking Buildbucket for the build status
[17:41:09.318] Build 8866537205934376112: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:41:09.318] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9031967267905302608:47:0) after 1m0s
[17:42:09.389] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9031967267905302608:47:0)
[17:42:09.389] Timer tick, asking Buildbucket for the build status
[17:42:09.520] Build 8866537205934376112: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:42:09.520] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9031967267905302608:48:0) after 1m0s
[17:43:09.529] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9031967267905302608:48:0)
[17:43:09.529] Timer tick, asking Buildbucket for the build status
[17:43:11.049] Build 8866537205934376112: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:43:11.049] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9031967267905302608:49:0) after 1m0s
[17:44:11.147] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9031967267905302608:49:0)
[17:44:11.147] Timer tick, asking Buildbucket for the build status
[17:44:11.233] Build 8866537205934376112: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:44:11.233] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9031967267905302608:50:0) after 1m0s
[17:45:11.318] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9031967267905302608:50:0)
[17:45:11.319] Timer tick, asking Buildbucket for the build status
[17:45:11.441] Build 8866537205934376112: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:45:11.441] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9031967267905302608:51:0) after 1m0s
[17:46:11.518] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9031967267905302608:51:0)
[17:46:11.518] Timer tick, asking Buildbucket for the build status
[17:46:11.646] Build 8866537205934376112: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:46:11.646] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9031967267905302608:52:0) after 1m0s
[17:47:11.736] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9031967267905302608:52:0)
[17:47:11.736] Timer tick, asking Buildbucket for the build status
[17:47:12.608] Build 8866537205934376112: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:47:12.608] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9031967267905302608:53:0) after 1m0s
[17:48:12.587] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9031967267905302608:53:0)
[17:48:12.587] Timer tick, asking Buildbucket for the build status
[17:48:12.745] Build 8866537205934376112: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:48:12.745] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9031967267905302608:54:0) after 1m0s
[17:49:12.771] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9031967267905302608:54:0)
[17:49:12.771] Timer tick, asking Buildbucket for the build status
[17:49:12.848] Build 8866537205934376112: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:49:12.848] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9031967267905302608:55:0) after 1m0s
[17:50:12.950] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9031967267905302608:55:0)
[17:50:12.950] Timer tick, asking Buildbucket for the build status
[17:50:13.125] Build 8866537205934376112: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:50:13.125] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9031967267905302608:56:0) after 1m0s
[17:51:13.183] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9031967267905302608:56:0)
[17:51:13.183] Timer tick, asking Buildbucket for the build status
[17:51:13.518] Build 8866537205934376112: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:51:13.518] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9031967267905302608:57:0) after 1m0s
[17:52:13.568] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9031967267905302608:57:0)
[17:52:13.568] Timer tick, asking Buildbucket for the build status
[17:52:13.881] Build 8866537205934376112: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:52:13.881] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9031967267905302608:58:0) after 1m0s
[17:53:13.862] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9031967267905302608:58:0)
[17:53:13.862] Timer tick, asking Buildbucket for the build status
[17:53:14.003] Build 8866537205934376112: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:53:14.003] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9031967267905302608:59:0) after 1m0s
[17:54:14.075] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9031967267905302608:59:0)
[17:54:14.075] Timer tick, asking Buildbucket for the build status
[17:54:14.544] Build 8866537205934376112: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:54:14.544] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9031967267905302608:60:0) after 1m0s
[17:54:52.344] Received PubSub notification, asking Buildbucket for the build status
[17:54:52.464] Build 8866537205934376112: status "COMPLETED", result "SUCCESS", failure_reason "", cancelation_reason ""
[17:54:52.464] Buildbucket build:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "PROD",
"completed_ts": "1602611691162889",
"created_by": "project:chromium",
"created_ts": "1602608213447276",
"id": "8866537205934376112",
"parameters_json": "{\"builder_name\": \"Linux Builder (dbg)\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"42cede4a815b1fb5e60af8bb63252f0aaa4939dd\"}}",
"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\": \"42cede4a815b1fb5e60af8bb63252f0aaa4939dd\", \"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-24-hder\", \"branch\": \"refs/heads/master\", \"builder_group\": \"chromium.linux\", \"buildername\": \"Linux Builder (dbg)\", \"buildnumber\": 176625, \"got_angle_revision\": \"bc2dd313cf94ead827ba01d2e47e10e284047408\", \"got_dawn_revision\": \"d1bca09f4ab36bdc8d413bf2642460b0721267f5\", \"got_nacl_revision\": \"0fabd6dc4222dfae664e55a84326e0c904f5b62c\", \"got_revision\": \"42cede4a815b1fb5e60af8bb63252f0aaa4939dd\", \"got_revision_cp\": \"refs/heads/master@{#816612}\", \"got_swarming_client_revision\": \"d46ea7635f2911208268170512cb611412488fd8\", \"got_swiftshader_revision\": \"e72c6099f9465df73f888a92071b70c924d74b0d\", \"got_v8_revision\": \"7bb48090258056285eefddebf26d55a22121fe5a\", \"got_v8_revision_cp\": \"refs/heads/8.8.74@{#1}\", \"got_webrtc_revision\": \"46129e98d33a4d97c7d24252b1e67e83844112fa\", \"got_webrtc_revision_cp\": \"refs/heads/master@{#32387}\", \"isolate_server\": \"https://isolateserver.appspot.com\", \"path_config\": \"generic\", \"recipe\": \"chromium\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"42cede4a815b1fb5e60af8bb63252f0aaa4939dd\", \"swarm_hashes_refs/heads/master(at){#816612}_without_patch\": {\"absl_hardening_tests\": \"3611f7dd69aaf1bbffc3f8b975f4de01b38f9bde\", \"accessibility_unittests\": \"f6c7c3d8628916282f0b00d1b635e0c3f167fd15\", \"app_shell_unittests\": \"ba5440290bcbf239830924c52ca9f38a94d6652f\", \"aura_unittests\": \"402cbfd7a0f981faafc584d5f674298582bbce4d\", \"base_unittests\": \"5c6726ac0b61692d92156e4ff3c388c68bd2cef0\", \"base_util_unittests\": \"9b35a0f5db948eb7572dc42bc50516c675b7829c\", \"blink_common_unittests\": \"f6f7fb35b6de6e45b232c1f62a1c8122056d4bc8\", \"blink_fuzzer_unittests\": \"6324f73c6ae847005499d1a9a39cecf9b8b63ee5\", \"blink_heap_unittests\": \"3311c0e6a8d21bb921c285b2d52aee7a41e63156\", \"blink_platform_unittests\": \"de59d62881ec712be426fb4f0d71fe76bac07996\", \"blink_python_tests\": \"b8551fcb150741e9e67fe9787235827cedb71666\", \"blink_unittests\": \"67e3a43dcfb12e414dacf09aed233e1be161588f\", \"blink_web_tests\": \"402827175ced2e0cd4bb207a567d722e826e262f\", \"boringssl_crypto_tests\": \"25c50177943476b0b4073da694efccddc6e5344c\", \"boringssl_ssl_tests\": \"d88e0625986b64070dd2a5208e38f6701c69ff37\", \"browser_tests\": \"5762dfff72173e42f37db6fd9a88000b9575cc78\", \"capture_unittests\": \"8d81a9e1ed5978dce3ad59e735e7153863901eb0\", \"cast_unittests\": \"f3da233f46a54b4f40fd20678623dfac1cad0568\", \"cc_unittests\": \"963590bc1e274241ea331840c5905e9bec1a1f16\", \"chrome_app_unittests\": \"1c16e367a9ee15314a7c4c01d094260a2412d046\", \"chromedriver_unittests\": \"cea7f86ad2fa423892b501acf11d7532b999d431\", \"components_browsertests\": \"8c9e56ee548b626b3ef06f3dcf529825969aac2e\", \"components_unittests\": \"89e35b2c4df3df97c9dc9e75eea4c6db66e25f07\", \"compositor_unittests\": \"8f5f2d8bf99a277798982dcf51df588fda87c048\", \"content_browsertests\": \"17c1557fe9e31d3d8fe28d5a6ced8e677d2c24ec\", \"content_shell_crash_test\": \"13496b702e245275555ee6a347d85f21afceb2f8\", \"content_unittests\": \"8221736e71d1805a567157233321717b21dc4c8c\", \"crashpad_tests\": \"8ef989d67587f7ef3f411f5ab7bc5729efa0b08f\", \"cronet_tests\": \"7a50bb010e43e5103bb33b0a90ae5a86d5c18400\", \"cronet_unittests\": \"0a2a6bb606201aac0a13e478cbb73d85f7d295a7\", \"crypto_unittests\": \"8552b036fda40e53b6afa7dfc757f6f78938926d\", \"dbus_unittests\": \"c7f73b94a082af3147bfec0c32f88b2c67ebec34\", \"device_unittests\": \"9456e7b16aa707294f905e86ace64593d7de838a\", \"display_unittests\": \"63154369e9a34ae212259f25425b21b08bf3e6a9\", \"events_unittests\": \"46347068aa7d8c4297b78c2188f40ccf8a9218a2\", \"extension_docserver_python_unittests\": \"d26ef8cb17039c269015aaeee770fff4b68c23ca\", \"extensions_browsertests\": \"092cf52867037714d9089eacb0ef5297ff2f5313\", \"extensions_unittests\": \"503c417bcdf0ac5a9fda0dfac173ce03cfdb23cb\", \"filesystem_service_unittests\": \"4b6817dc6a90a96a8d651c469d4c634cca5479e0\", \"flatbuffers_unittests\": \"7c821f13730963d6e07deae074f4fffab315d766\", \"gcm_unit_tests\": \"3d098f8b92afafd1e4b2c19d06fce0012c73f8ea\", \"gfx_unittests\": \"59fd900c5cc33ff0dd041abe6d5549e315f8ec9d\", \"gin_unittests\": \"78f5feee7149f813e62e27a900ae8f323b2352b1\", \"google_apis_unittests\": \"c038dec59d14c39761b80e9cc95bd16d07644155\", \"gpu_unittests\": \"e00266cc548e72973b8d8f86690f9a471bf8d538\", \"grit_python_unittests\": \"55fa961d85005331568451ce869e032331bd4b90\", \"gwp_asan_unittests\": \"342829382e2aaf62796c5daf0e9a21945ed9eb9c\", \"headless_browsertests\": \"a93d74b5e3d825881c6bba08fded3ffba63c7aea\", \"headless_unittests\": \"27ab9c9d358fe54d9f0655b89c3212fa37b0006b\", \"interactive_ui_tests\": \"6597325c15035d902901e93ebb576af4ea6c9e40\", \"ipc_tests\": \"a1ec57da4ad2da5f42d00e2c6e8cbfb17e4c16c5\", \"jingle_unittests\": \"2668983ccdad877075b4774c821633b810f0149a\", \"latency_unittests\": \"8ff8fbd748ae2e95fbe20669c9ae81af7f4a402f\", \"libjingle_xmpp_unittests\": \"04da557d85790c61e362f9a82ea33cd4c0e97d43\", \"media_blink_unittests\": \"52c72b18429b25ae30ffaac519eaed320b03bd1b\", \"media_unittests\": \"65d5eaf1a77ebd63dd6e8c89b49d023bcee921c8\", \"message_center_unittests\": \"010bc7dc32f7c7698cf2e4ad8ff6077ca4db39b7\", \"metrics_python_tests\": \"5154848542516f04254b52a39a82dcd18bedb690\", \"midi_unittests\": \"66f9c2a413190473f4f15fbc29996b21bdb4097c\", \"mojo_core_unittests\": \"edbe202e6e1d2f8f6a8bd9c31bec563d249a0111\", \"mojo_unittests\": \"30412da099957062496b6c175fc578d2a6fa17b1\", \"nacl_helper_nonsfi_unittests\": \"194de36eac4a17e4a93cf02fbe824efd2ae2eaf8\", \"nacl_loader_unittests\": \"328fee28d093d91d2624b34db8959d4f4507a559\", \"native_theme_unittests\": \"6abd809fb55ca50d769abce88db7535ea1113a9b\", \"net_unittests\": \"77e723fada0a64ee1ef59d1ef205eeaf80641631\", \"openscreen_unittests\": \"2d7a9c8dc77d8a92e523c6ce844cee96f8363f9b\", \"pdf_unittests\": \"12edade52d73cc46a5e901076113658579f32d02\", \"perfetto_unittests\": \"46a4999c8e155109d2414fdc4738ced39c404473\", \"ppapi_unittests\": \"90b16a30d3aefa82ffefbfecd634176a7cd97406\", \"printing_unittests\": \"1a6ae858214d02ed0773f86fc21c7ddfbcf32327\", \"remoting_unittests\": \"a3bff319ea2b92d929dd2985efe683c47913cef9\", \"sandbox_linux_unittests\": \"fd55ff5cb73df49bb3d45ab629ccac24256e197d\", \"service_manager_unittests\": \"23f387191f9c46adc770d1235fe4540937447fcf\", \"services_unittests\": \"ee34e269d9ce562d7630a7089e9624bf41b8d347\", \"shell_dialogs_unittests\": \"8b88a20c3a1c52e1fcea60fbef1f2d9dde790e7e\", \"skia_unittests\": \"cf2cb226cc4a048a4d71abdc0d2019c41ee59ef8\", \"snapshot_unittests\": \"efa43b49cd611afa00aef5511690b042864b89df\", \"sql_unittests\": \"b1a2b586bc3eb057acd33db281efa21f56272a4f\", \"standalone_angle_unittests\": \"ada4db51812fab28df5cd8b1106b2d6294eb2b92\", \"storage_unittests\": \"d685eceba5e23038f71da76fd1eff608d1ad4f44\", \"sync_integration_tests\": \"f79518f78d67509f0551fec74b1ee038908e6ce5\", \"telemetry_gpu_unittests\": \"424a1d25b7027803f012648176e2042963d1e460\", \"telemetry_perf_unittests\": \"ac8632fdddc610b62b864dc55076121503d6dacb\", \"telemetry_unittests\": \"dbe3983e3ed943ad0678521c6da7f3e88f70d6c0\", \"traffic_annotation_auditor_unittests\": \"c70c3eb621f762c98a05f2cd6b75378cac48206f\", \"ui_base_unittests\": \"d0ffc3c0f094807d97a430ecc554f0bca5e26572\", \"ui_touch_selection_unittests\": \"8b4cfaf5fa46acc7875df4842098d60689a5a001\", \"unit_tests\": \"38679747fa9d825fef5039b94bf5ea4bb26f06f3\", \"url_unittests\": \"a05679bb1c3f16372e3106d2c0e0054d42edc898\", \"views_perftests\": \"03c9da9dad79547d73e08ef5581d3817093751cf\", \"views_unittests\": \"b400d64d2a8b751e3ad2a754012eee28ec68f55d\", \"viz_unittests\": \"a9e8cfeddd610e065b252a94aabe0d5096ddaef4\", \"vr_common_unittests\": \"e8cdd78460e997202a6aa72ed21492a15b2465d3\", \"vr_pixeltests\": \"ec1a5c72c33b36e103fba4f53d2d1c6cce23da12\", \"webdriver_wpt_tests\": \"c9d371bad646ce6852c38c83d41b37a85b633250\", \"weblayer_browsertests\": \"1d5910b3b85e21a13f9f95fa88f5064cf88b5035\", \"weblayer_unittests\": \"da4d8918432782879ded59f02842fa675d625fed\", \"wm_unittests\": \"7617d564bedc1758064f735bf8a9885dcc4db0be\", \"wtf_unittests\": \"7189f003df1a631ffa957514df15c1c6fa039f11\", \"x11_unittests\": \"59a90cb43223b67ea4f4bd2f3d11f630b53c0f12\", \"xr_browser_tests\": \"c0d1b467b20b8e30a3c487dc3a74f88a1329e1c6\", \"zlib_unittests\": \"dd080086772b5056873c7cfebb5d14b9edec9b92\"}}, \"swarming\": {\"bot_dimensions\": {\"builderless\": [\"1\"], \"caches\": [\"builder_08506e22a0e0fdc29bd318165699b599f0671cf91287ea7a96642b02d7ff24e4_v2\", \"builder_304607b978b8f4bcd63bac0f543c3a69f6b4c7cf202dcd2d3c5b8d4a70be201e_v2\", \"builder_3e35691df8e10f0f9a2876627ba5bcbf70dc06793975d132d4535f10bccc6635_v2\", \"builder_3f701152d865ce3ec8feb15f973214ad980aeace5cbda24477548a965269fca6_v2\", \"builder_5c906bad1aaeae24a2a7f043536626a3e8df9b2c7401ab4a0dd83c120911bddd_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-east1-d-8-24-hder\"], \"image\": [\"chrome-xenial-20100700-ace2c028da3\"], \"inside_docker\": [\"0\"], \"kvm\": [\"1\"], \"locale\": [\"en_US.UTF-8\"], \"machine_type\": [\"e2-standard-8\"], \"os\": [\"Linux\", \"Ubuntu\", \"Ubuntu-16\", \"Ubuntu-16.04\", \"Ubuntu-16.04.6\"], \"pool\": [\"luci.chromium.ci\"], \"python\": [\"2.7.12\"], \"server_version\": [\"5570-fa4adf0\"], \"ssd\": [\"0\"], \"zone\": [\"us\", \"us-east\", \"us-east1\", \"us-east1-d\"]}}}",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"started_ts": "1602608218178961",
"status": "COMPLETED",
"status_changed_ts": "1602611691654140",
"tags": [
"build_address:luci.chromium.ci/Linux Builder (dbg)/176625",
"builder:Linux Builder (dbg)",
"buildset:commit/git/42cede4a815b1fb5e60af8bb63252f0aaa4939dd",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/42cede4a815b1fb5e60af8bb63252f0aaa4939dd",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9031967267905302608",
"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/8866537205934376112/+/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:4f3bb63adcf0ec10",
"user_agent:luci-scheduler"
],
"updated_ts": "1602611691661023",
"url": "https://ci.chromium.org/b/8866537205934376112",
"utcnow_ts": "1602611692451039"
}
}
[17:54:52.464] Invocation finished in 58m0.280109394s with status SUCCEEDED