[12:18:22.857] New invocation is queued and will start shortly
[12:18:24.769] Starting the invocation (attempt 1)
[12:18:24.822] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[12:18:24.822] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[12:18:24.823] Buildbucket request:
{
"bucket": "luci.chromium.ci",
"client_operation_id": "9028542104201649696",
"parameters_json": "{\"builder_name\":\"Linux Builder (dbg)\",\"properties\":{\"branch\":\"refs/heads/master\",\"repository\":\"https://chromium.googlesource.com/chromium/src\",\"revision\":\"11553c1392eaa2037e5bcd00db9d29f4163db57a\"}}",
"pubsub_callback": {
"auth_token": "...",
"topic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
},
"tags": [
"builder:Linux Builder (dbg)",
"scheduler_invocation_id:9028542104201649696",
"scheduler_job_id:chromium/Linux Builder (dbg)",
"user_agent:luci-scheduler",
"buildset:commit/git/11553c1392eaa2037e5bcd00db9d29f4163db57a",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/11553c1392eaa2037e5bcd00db9d29f4163db57a",
"gitiles_ref:refs/heads/master"
]
}
[12:18:25.753] Buildbucket response:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "PROD",
"created_by": "project:chromium",
"created_ts": "1605874704931332",
"id": "8863112041360932976",
"parameters_json": "{\"builder_name\": \"Linux Builder (dbg)\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"11553c1392eaa2037e5bcd00db9d29f4163db57a\"}}",
"project": "chromium",
"result_details_json": "{\"properties\": {}}",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"status": "SCHEDULED",
"status_changed_ts": "1605874705472050",
"tags": [
"build_address:luci.chromium.ci/Linux Builder (dbg)/177871",
"builder:Linux Builder (dbg)",
"buildset:commit/git/11553c1392eaa2037e5bcd00db9d29f4163db57a",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/11553c1392eaa2037e5bcd00db9d29f4163db57a",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9028542104201649696",
"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/8863112041360932976/+/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": "1605874705472393",
"url": "https://ci.chromium.org/b/8863112041360932976",
"utcnow_ts": "1605874705740901"
}
}
[12:18:25.753] Task URL: https://ci.chromium.org/b/8863112041360932976
[12:18:25.753] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9028542104201649696:2:0) after 1m0s
[12:18:47.800] Received PubSub notification, asking Buildbucket for the build status
[12:18:47.874] Build 8863112041360932976: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:19:25.802] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9028542104201649696:2:0)
[12:19:25.802] Timer tick, asking Buildbucket for the build status
[12:19:26.345] Build 8863112041360932976: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:19:26.345] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9028542104201649696:4:0) after 1m0s
[12:20:26.368] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9028542104201649696:4:0)
[12:20:26.368] Timer tick, asking Buildbucket for the build status
[12:20:26.509] Build 8863112041360932976: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:20:26.509] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9028542104201649696:5:0) after 1m0s
[12:21:26.538] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9028542104201649696:5:0)
[12:21:26.538] Timer tick, asking Buildbucket for the build status
[12:21:26.620] Build 8863112041360932976: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:21:26.620] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9028542104201649696:6:0) after 1m0s
[12:22:26.644] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9028542104201649696:6:0)
[12:22:26.644] Timer tick, asking Buildbucket for the build status
[12:22:26.914] Build 8863112041360932976: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:22:26.914] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9028542104201649696:7:0) after 1m0s
[12:23:26.930] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9028542104201649696:7:0)
[12:23:26.930] Timer tick, asking Buildbucket for the build status
[12:23:27.072] Build 8863112041360932976: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:23:27.072] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9028542104201649696:8:0) after 1m0s
[12:24:27.100] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9028542104201649696:8:0)
[12:24:27.100] Timer tick, asking Buildbucket for the build status
[12:24:27.386] Build 8863112041360932976: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:24:27.386] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9028542104201649696:9:0) after 1m0s
[12:25:27.415] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9028542104201649696:9:0)
[12:25:27.415] Timer tick, asking Buildbucket for the build status
[12:25:27.770] Build 8863112041360932976: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:25:27.770] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9028542104201649696:10:0) after 1m0s
[12:26:27.816] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9028542104201649696:10:0)
[12:26:27.816] Timer tick, asking Buildbucket for the build status
[12:26:28.297] Build 8863112041360932976: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:26:28.297] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9028542104201649696:11:0) after 1m0s
[12:27:28.323] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9028542104201649696:11:0)
[12:27:28.323] Timer tick, asking Buildbucket for the build status
[12:27:28.395] Build 8863112041360932976: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:27:28.395] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9028542104201649696:12:0) after 1m0s
[12:28:28.425] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9028542104201649696:12:0)
[12:28:28.425] Timer tick, asking Buildbucket for the build status
[12:28:28.778] Build 8863112041360932976: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:28:28.778] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9028542104201649696:13:0) after 1m0s
[12:29:28.801] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9028542104201649696:13:0)
[12:29:28.801] Timer tick, asking Buildbucket for the build status
[12:29:28.921] Build 8863112041360932976: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:29:28.922] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9028542104201649696:14:0) after 1m0s
[12:30:29.037] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9028542104201649696:14:0)
[12:30:29.037] Timer tick, asking Buildbucket for the build status
[12:30:29.184] Build 8863112041360932976: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:30:29.184] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9028542104201649696:15:0) after 1m0s
[12:31:29.240] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9028542104201649696:15:0)
[12:31:29.240] Timer tick, asking Buildbucket for the build status
[12:31:29.307] Build 8863112041360932976: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:31:29.307] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9028542104201649696:16:0) after 1m0s
[12:32:29.316] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9028542104201649696:16:0)
[12:32:29.316] Timer tick, asking Buildbucket for the build status
[12:32:29.400] Build 8863112041360932976: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:32:29.400] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9028542104201649696:17:0) after 1m0s
[12:33:29.458] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9028542104201649696:17:0)
[12:33:29.458] Timer tick, asking Buildbucket for the build status
[12:33:29.542] Build 8863112041360932976: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:33:29.542] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9028542104201649696:18:0) after 1m0s
[12:34:29.588] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9028542104201649696:18:0)
[12:34:29.588] Timer tick, asking Buildbucket for the build status
[12:34:29.713] Build 8863112041360932976: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:34:29.713] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9028542104201649696:19:0) after 1m0s
[12:35:29.821] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9028542104201649696:19:0)
[12:35:29.821] Timer tick, asking Buildbucket for the build status
[12:35:30.007] Build 8863112041360932976: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:35:30.007] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9028542104201649696:20:0) after 1m0s
[12:36:30.034] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9028542104201649696:20:0)
[12:36:30.034] Timer tick, asking Buildbucket for the build status
[12:36:30.112] Build 8863112041360932976: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:36:30.112] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9028542104201649696:21:0) after 1m0s
[12:37:30.175] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9028542104201649696:21:0)
[12:37:30.175] Timer tick, asking Buildbucket for the build status
[12:37:30.261] Build 8863112041360932976: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:37:30.261] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9028542104201649696:22:0) after 1m0s
[12:38:30.342] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9028542104201649696:22:0)
[12:38:30.342] Timer tick, asking Buildbucket for the build status
[12:38:30.426] Build 8863112041360932976: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:38:30.426] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9028542104201649696:23:0) after 1m0s
[12:39:30.414] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9028542104201649696:23:0)
[12:39:30.414] Timer tick, asking Buildbucket for the build status
[12:39:30.611] Build 8863112041360932976: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:39:30.611] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9028542104201649696:24:0) after 1m0s
[12:40:30.639] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9028542104201649696:24:0)
[12:40:30.639] Timer tick, asking Buildbucket for the build status
[12:40:30.700] Build 8863112041360932976: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:40:30.700] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9028542104201649696:25:0) after 1m0s
[12:41:30.766] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9028542104201649696:25:0)
[12:41:30.767] Timer tick, asking Buildbucket for the build status
[12:41:30.834] Build 8863112041360932976: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:41:30.834] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9028542104201649696:26:0) after 1m0s
[12:42:30.922] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9028542104201649696:26:0)
[12:42:30.922] Timer tick, asking Buildbucket for the build status
[12:42:31.004] Build 8863112041360932976: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:42:31.005] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9028542104201649696:27:0) after 1m0s
[12:43:31.000] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9028542104201649696:27:0)
[12:43:31.000] Timer tick, asking Buildbucket for the build status
[12:43:31.073] Build 8863112041360932976: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:43:31.073] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9028542104201649696:28:0) after 1m0s
[12:44:31.874] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9028542104201649696:28:0)
[12:44:31.874] Timer tick, asking Buildbucket for the build status
[12:44:31.981] Build 8863112041360932976: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:44:31.982] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9028542104201649696:29:0) after 1m0s
[12:45:32.068] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9028542104201649696:29:0)
[12:45:32.068] Timer tick, asking Buildbucket for the build status
[12:45:32.165] Build 8863112041360932976: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:45:32.165] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9028542104201649696:30:0) after 1m0s
[12:46:32.307] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9028542104201649696:30:0)
[12:46:32.308] Timer tick, asking Buildbucket for the build status
[12:46:32.375] Build 8863112041360932976: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:46:32.375] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9028542104201649696:31:0) after 1m0s
[12:47:32.398] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9028542104201649696:31:0)
[12:47:32.398] Timer tick, asking Buildbucket for the build status
[12:47:32.540] Build 8863112041360932976: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:47:32.540] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9028542104201649696:32:0) after 1m0s
[12:48:32.584] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9028542104201649696:32:0)
[12:48:32.584] Timer tick, asking Buildbucket for the build status
[12:48:32.651] Build 8863112041360932976: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:48:32.651] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9028542104201649696:33:0) after 1m0s
[12:49:32.634] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9028542104201649696:33:0)
[12:49:32.634] Timer tick, asking Buildbucket for the build status
[12:49:32.731] Build 8863112041360932976: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:49:32.731] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9028542104201649696:34:0) after 1m0s
[12:50:32.806] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9028542104201649696:34:0)
[12:50:32.806] Timer tick, asking Buildbucket for the build status
[12:50:32.981] Build 8863112041360932976: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:50:32.981] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9028542104201649696:35:0) after 1m0s
[12:51:33.123] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9028542104201649696:35:0)
[12:51:33.123] Timer tick, asking Buildbucket for the build status
[12:51:33.199] Build 8863112041360932976: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:51:33.199] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9028542104201649696:36:0) after 1m0s
[12:52:33.233] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9028542104201649696:36:0)
[12:52:33.233] Timer tick, asking Buildbucket for the build status
[12:52:33.302] Build 8863112041360932976: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:52:33.302] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9028542104201649696:37:0) after 1m0s
[12:53:33.326] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9028542104201649696:37:0)
[12:53:33.326] Timer tick, asking Buildbucket for the build status
[12:53:33.393] Build 8863112041360932976: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:53:33.393] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9028542104201649696:38:0) after 1m0s
[12:54:33.421] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9028542104201649696:38:0)
[12:54:33.421] Timer tick, asking Buildbucket for the build status
[12:54:33.777] Build 8863112041360932976: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:54:33.777] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9028542104201649696:39:0) after 1m0s
[12:55:33.807] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9028542104201649696:39:0)
[12:55:33.807] Timer tick, asking Buildbucket for the build status
[12:55:33.874] Build 8863112041360932976: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:55:33.874] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9028542104201649696:40:0) after 1m0s
[12:56:33.907] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9028542104201649696:40:0)
[12:56:33.907] Timer tick, asking Buildbucket for the build status
[12:56:34.007] Build 8863112041360932976: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:56:34.007] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9028542104201649696:41:0) after 1m0s
[12:57:34.057] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9028542104201649696:41:0)
[12:57:34.057] Timer tick, asking Buildbucket for the build status
[12:57:34.979] Build 8863112041360932976: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:57:34.979] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9028542104201649696:42:0) after 1m0s
[12:58:35.994] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9028542104201649696:42:0)
[12:58:35.994] Timer tick, asking Buildbucket for the build status
[12:58:36.273] Build 8863112041360932976: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:58:36.273] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9028542104201649696:43:0) after 1m0s
[12:59:36.588] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9028542104201649696:43:0)
[12:59:36.588] Timer tick, asking Buildbucket for the build status
[12:59:36.858] Build 8863112041360932976: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:59:36.858] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9028542104201649696:44:0) after 1m0s
[13:00:37.128] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9028542104201649696:44:0)
[13:00:37.128] Timer tick, asking Buildbucket for the build status
[13:00:37.697] Build 8863112041360932976: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:00:37.697] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9028542104201649696:45:0) after 1m0s
[13:01:37.993] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9028542104201649696:45:0)
[13:01:37.993] Timer tick, asking Buildbucket for the build status
[13:01:38.077] Build 8863112041360932976: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:01:38.077] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9028542104201649696:46:0) after 1m0s
[13:02:38.288] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9028542104201649696:46:0)
[13:02:38.288] Timer tick, asking Buildbucket for the build status
[13:02:38.355] Build 8863112041360932976: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:02:38.355] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9028542104201649696:47:0) after 1m0s
[13:03:38.410] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9028542104201649696:47:0)
[13:03:38.410] Timer tick, asking Buildbucket for the build status
[13:03:38.500] Build 8863112041360932976: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:03:38.500] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9028542104201649696:48:0) after 1m0s
[13:04:38.558] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9028542104201649696:48:0)
[13:04:38.558] Timer tick, asking Buildbucket for the build status
[13:04:39.479] Build 8863112041360932976: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:04:39.479] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9028542104201649696:49:0) after 1m0s
[13:05:39.503] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9028542104201649696:49:0)
[13:05:39.503] Timer tick, asking Buildbucket for the build status
[13:05:39.854] Build 8863112041360932976: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:05:39.854] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9028542104201649696:50:0) after 1m0s
[13:06:39.916] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9028542104201649696:50:0)
[13:06:39.916] Timer tick, asking Buildbucket for the build status
[13:06:40.059] Build 8863112041360932976: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:06:40.059] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9028542104201649696:51:0) after 1m0s
[13:07:40.142] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9028542104201649696:51:0)
[13:07:40.142] Timer tick, asking Buildbucket for the build status
[13:07:40.261] Build 8863112041360932976: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:07:40.261] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9028542104201649696:52:0) after 1m0s
[13:08:40.342] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9028542104201649696:52:0)
[13:08:40.342] Timer tick, asking Buildbucket for the build status
[13:08:40.415] Build 8863112041360932976: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:08:40.415] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9028542104201649696:53:0) after 1m0s
[13:09:40.507] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9028542104201649696:53:0)
[13:09:40.507] Timer tick, asking Buildbucket for the build status
[13:09:40.614] Build 8863112041360932976: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:09:40.614] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9028542104201649696:54:0) after 1m0s
[13:10:40.715] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9028542104201649696:54:0)
[13:10:40.716] Timer tick, asking Buildbucket for the build status
[13:10:40.888] Build 8863112041360932976: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:10:40.888] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9028542104201649696:55:0) after 1m0s
[13:11:40.980] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9028542104201649696:55:0)
[13:11:40.980] Timer tick, asking Buildbucket for the build status
[13:11:41.223] Build 8863112041360932976: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:11:41.223] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9028542104201649696:56:0) after 1m0s
[13:12:41.313] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9028542104201649696:56:0)
[13:12:41.313] Timer tick, asking Buildbucket for the build status
[13:12:41.424] Build 8863112041360932976: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:12:41.424] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9028542104201649696:57:0) after 1m0s
[13:13:41.444] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9028542104201649696:57:0)
[13:13:41.444] Timer tick, asking Buildbucket for the build status
[13:13:41.722] Build 8863112041360932976: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:13:41.722] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9028542104201649696:58:0) after 1m0s
[13:14:09.467] Received PubSub notification, asking Buildbucket for the build status
[13:14:09.556] Build 8863112041360932976: status "COMPLETED", result "SUCCESS", failure_reason "", cancelation_reason ""
[13:14:09.556] Buildbucket build:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "PROD",
"completed_ts": "1605878048728255",
"created_by": "project:chromium",
"created_ts": "1605874704931332",
"id": "8863112041360932976",
"parameters_json": "{\"builder_name\": \"Linux Builder (dbg)\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"11553c1392eaa2037e5bcd00db9d29f4163db57a\"}}",
"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\": \"11553c1392eaa2037e5bcd00db9d29f4163db57a\", \"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-99-e3yw\", \"branch\": \"refs/heads/master\", \"builder_group\": \"chromium.linux\", \"buildername\": \"Linux Builder (dbg)\", \"buildnumber\": 177871, \"got_angle_revision\": \"777749aafaac268b3468b551050f5bf4b28cf9b6\", \"got_dawn_revision\": \"75a1f5234e4b544b4d16eddb995d39685da21361\", \"got_nacl_revision\": \"3ac0b060c794b64531b47dfded8ff8d951a5c648\", \"got_revision\": \"11553c1392eaa2037e5bcd00db9d29f4163db57a\", \"got_revision_cp\": \"refs/heads/master@{#829625}\", \"got_swarming_client_revision\": \"d46ea7635f2911208268170512cb611412488fd8\", \"got_swiftshader_revision\": \"de9e649438ed3cc2ecf5c30ebf08f033d01270e6\", \"got_v8_revision\": \"94b2c943f7f37e0450e7c5d029fbd22a9d7f6946\", \"got_v8_revision_cp\": \"refs/heads/8.9.14@{#1}\", \"got_webrtc_revision\": \"afaca889d46b2c493de34a8f0771c89dea17bb1a\", \"got_webrtc_revision_cp\": \"refs/heads/master@{#32614}\", \"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\": \"11553c1392eaa2037e5bcd00db9d29f4163db57a\", \"swarm_hashes_refs/heads/master(at){#829625}_without_patch\": {\"absl_hardening_tests\": \"5127d076d76b0223b021c45dd8c243e989fe3275\", \"accessibility_unittests\": \"2505c1c77b4530fa176cfeb40ac407c95a3bbe80\", \"angle_unittests\": \"72bc4245884af4b375bfc794558015736a425a6d\", \"app_shell_unittests\": \"251955e86728e1ce1dadca417a74fa623c5e3ff3\", \"aura_unittests\": \"beca288bf59b7927c2393f3dda8c5076fa32aff9\", \"base_unittests\": \"4f6954beae558b95bdb56d651d1a2dbd5089797a\", \"base_util_unittests\": \"c059a872a5401d2f13945fbf1013936ba05d4891\", \"blink_common_unittests\": \"a7c6337aa76d43a8048f86e0a225f6a935062576\", \"blink_fuzzer_unittests\": \"4107adae6cdf8159534a10f37fd2c4dd79da0083\", \"blink_heap_unittests\": \"272c56ceb34aeae04e959fc8368e25f64a52d9af\", \"blink_platform_unittests\": \"f76439cc48783b229681c095a445eb93c3fb3718\", \"blink_python_tests\": \"c6ea3431e117c481ad5893fc0b090e104c59b84f\", \"blink_unittests\": \"d2e799533532dc45f6a3e821911e20f609648de2\", \"blink_web_tests\": \"92ec16ad8ee0937de7a07876b57c97b3e88cfe68\", \"boringssl_crypto_tests\": \"6696a852010dd1d95cb203e964b0edff8830aa3a\", \"boringssl_ssl_tests\": \"e381a85c01b1a255e42827d85ad7c46762feaa31\", \"browser_tests\": \"ec6976e25351828e63b758a88b0de00d4d775bb7\", \"capture_unittests\": \"5b3564ad4ceacf5506091f044bac5a6532d35e8d\", \"cast_unittests\": \"a61c0f9d420d0f2735af8fb6fbeac5584e788753\", \"cc_unittests\": \"e4e5b397b87aa210ee278b8c8c364d0009b343ac\", \"chrome_app_unittests\": \"a1794644937fe7cad41db78efe280fe2e9c034e3\", \"chromedriver_unittests\": \"784dd3001476c69a6e29fa4d42f7904fe059bae0\", \"components_browsertests\": \"8233459e31339299ed2376b2bbb2f1c46b66fb89\", \"components_unittests\": \"010b78a966ca66857de6e5ad964aec7451843d14\", \"compositor_unittests\": \"2a1ce8121a77f7cceaa28e1564b170d731ff544c\", \"content_browsertests\": \"5768d84da8865049599a6e27283850423189f282\", \"content_shell_crash_test\": \"bfc24660e30fbdbf7e8749133f15bb79d7921870\", \"content_unittests\": \"e73097152ca12f367801f794ca368c4ccfb053b1\", \"crashpad_tests\": \"ca25621662687cc41108322f5aa268032fb56214\", \"cronet_tests\": \"c94d6203330da94a1d8e1297f48175ccd30333af\", \"cronet_unittests\": \"d243905ce662e8ea2dbda93cbca5732d0c7bd1ec\", \"crypto_unittests\": \"5ba3291f1b67789fcc9d5ec3705e50e01cc48c22\", \"dbus_unittests\": \"476e3dfda7c521b56041c4215efb0b57ffc538e6\", \"device_unittests\": \"cc75a3d6cac120ebc90ad3b22f97cebbfc85b499\", \"display_unittests\": \"9b8ba4673088463cf4fa136a45755fd67e1e9f2d\", \"events_unittests\": \"742fea729d48b7523d245e2135c8f520f5eb9f9f\", \"extension_docserver_python_unittests\": \"00c61488b4787d4454f3ed19858091fd1deb359f\", \"extensions_browsertests\": \"e021b6003eabd74b89d3a9ea9a19a900de739f74\", \"extensions_unittests\": \"77d9b1903e2754a85bd6bac02eff7f0107a8f90f\", \"filesystem_service_unittests\": \"0612f6be6904f0a99004c7bf53446637322a3e9f\", \"flatbuffers_unittests\": \"dd6267ccaa5ef4f5de95507aa468128ed4c0a477\", \"gcm_unit_tests\": \"8c04a7ec908f5439e65ddc9b57402f7af681d7e6\", \"gfx_unittests\": \"113ef82fc47176503c6e157d7d665859409fd53a\", \"gin_unittests\": \"161f2eeff867f7ea1b64e93ecca13419a3b8e90d\", \"google_apis_unittests\": \"eba9ab8af75c8e0e1f00310946d07b0ec3c56e05\", \"gpu_unittests\": \"e04c9a5ba40e9d312b8d99b42cdc90b8e481c751\", \"grit_python_unittests\": \"b20d4d77fd059e1da02f2886f0fe402b433cc81c\", \"gwp_asan_unittests\": \"56b88503c324915332ae98e0c316ecdc13881953\", \"headless_browsertests\": \"6fed31154af5accb11ba257bfa14e642b424b0ac\", \"headless_unittests\": \"c11b512dc34c931f5e6e8641f28716cf514d3460\", \"interactive_ui_tests\": \"57b679e89187cebc195eff0a809b7c829e15bc0f\", \"ipc_tests\": \"e8b05defd5900c7aca1ae1b6eb9dd0cd1d4233f2\", \"jingle_unittests\": \"d70c606a9166525be54597c19fc07cd2ba55501f\", \"latency_unittests\": \"fc1788a60d798311ab0a452e865385a7f949374b\", \"libjingle_xmpp_unittests\": \"06fa70d9b49abb9bf7d586b0bcb584c0a774baaa\", \"liburlpattern_unittests\": \"b8ba3e84f3e02a58026549dadc546728775a9de7\", \"media_blink_unittests\": \"19ed463ef79ef41f09e2c65b96bb960d442794eb\", \"media_unittests\": \"0d91f7f899ad7358ca554d1f75301637877dca62\", \"message_center_unittests\": \"b6c38d29f35fbdebd1dd3ee55d71175d1ecd93c3\", \"metrics_python_tests\": \"64c635901def855db635cdee5275cc8c6dfc62bc\", \"midi_unittests\": \"bf99332ef81db83b7b44d6f0c4dd2cc07f2ac774\", \"mojo_core_unittests\": \"f0dc1b6b89e0191c413313ac63d8d0ea0db17231\", \"mojo_unittests\": \"596bcab5d6fa7428f935f81ff8a9581520f934f7\", \"nacl_helper_nonsfi_unittests\": \"18467e4a55a3d81b0a1d3d659f9ff2fb96662a05\", \"nacl_loader_unittests\": \"95e7c123639d5aae50479d1855ec3ad9a4f47100\", \"native_theme_unittests\": \"41cfd62e3a68a967a183ef4e5dc268f8eb04a77b\", \"net_unittests\": \"4e92d429e545271c30ff7872d73fe2a769addd54\", \"openscreen_unittests\": \"1b7531bf5cf451b29e6f79f724baa94cc2dbe22e\", \"pdf_unittests\": \"011d524ee6e5ba1ecf583057f1333542d750d91e\", \"perfetto_unittests\": \"afc9890af4f2d838ebd0e62313484446505327aa\", \"ppapi_unittests\": \"c67d2f0e0e3c8fbd3754c164ec69fbb3f5887669\", \"printing_unittests\": \"5690d1a3e44d05e707ab5fae1912817147fece8f\", \"remoting_unittests\": \"fda610bb785bbc45d690207698aca0662b167ca0\", \"sandbox_linux_unittests\": \"72abc03aa428afbdba0b0f5c1bd0bc2cd8c2062a\", \"service_manager_unittests\": \"6708dcedcb7f415e68ca1a66bcdc41ccb4272b75\", \"services_unittests\": \"c253c4fbc87dae64b9ec38cfc214e94ad9e23706\", \"shell_dialogs_unittests\": \"9345560fb68c1e7523ebc5c2b3db3ef3ef2dafaa\", \"skia_unittests\": \"01d283484dc9dd416e91a9178df10e34312f2058\", \"snapshot_unittests\": \"713bdf8ad03d75f47dd81a663c896a41390b7a54\", \"sql_unittests\": \"fb2b0ac76a30a827c34ff4a5adbf65e45a4fefc9\", \"storage_unittests\": \"df95b23c9acc59b492b7f7d48b31459bc24b6771\", \"sync_integration_tests\": \"823eebbc840348cce8328e308690cd50e3fcf3cf\", \"telemetry_gpu_unittests\": \"60afcda8a443a617d3e6a33aaed1da2afa858c6f\", \"telemetry_perf_unittests\": \"c683577bf24a104914f83dd06a3d6fed9ac7309e\", \"telemetry_unittests\": \"f1779e3eee481aabb8baa47ff36241214da97e11\", \"traffic_annotation_auditor_unittests\": \"57faa77a1b93049cfbbf83046f80da05c7305f7e\", \"ui_base_unittests\": \"9df46864ed029e07e7ea5a3141d31523547fc831\", \"ui_touch_selection_unittests\": \"0a785e2aa026cca71bacc27aa04e839f45ad1923\", \"unit_tests\": \"cd4afdabd83812564bd4c3681cb8e00e8486c4a9\", \"url_unittests\": \"60fc46614f639e1808f168b3cb66032b89a67eee\", \"views_perftests\": \"6b5b72fe70fa31ea5830b8552c2383930bd8c995\", \"views_unittests\": \"428043a45f5930209aa34e6adfbf3be20940fb9d\", \"viz_unittests\": \"b74012672249b76d5164841b1ade32538c31d9da\", \"vr_common_unittests\": \"6122d84417f66ba27a7b600b3085725dcea89766\", \"vr_pixeltests\": \"5ab47d97207f8cf979ac2db75946e39215928f45\", \"webdriver_wpt_tests\": \"dbc5d4942087094a4fdaa1ab7559983c27ad673f\", \"weblayer_browsertests\": \"580d550d446d4b650ece87b3e6ee11ffd22bd20d\", \"weblayer_unittests\": \"e261f90f39f5f8d22da0688546d93ecfc61cb070\", \"wm_unittests\": \"ada4bc3c0e1bfa0f881b1a7eb5f154b8405cc795\", \"wtf_unittests\": \"57ee5d211bab662765c02638a12d44b4a71a12c0\", \"x11_unittests\": \"443203287ed2529db0b2be5b38b5effccc96b24c\", \"xr_browser_tests\": \"12299e9cc2e0d6ee6fb90518a39093a26b30a310\", \"zlib_unittests\": \"4eb90a7ec9c65794f7735e62f18a7075f1756882\"}}, \"swarming\": {\"bot_dimensions\": {\"builderless\": [\"1\"], \"caches\": [\"builder_245a833083bb6a45448d53af992b4d0ba8c7f0d427973f1905c7dc0ae1058008_v2\", \"builder_387e931c7b633ee2f48b892df14288ffa2061feda74b30444810d565fa474120_v2\", \"builder_3df726b65531685b338b7c2caf48988c15becc2e6a96e549d7512dce09d4fac6_v2\", \"builder_4107b14b7476412be0315d38f8e370eb2ac2c1b388bb8ffb59d7bdd8f08032e9_v2\", \"builder_609b54f795c46f6da98bce3e3c3edeb2c2e2d72c7759cc5040a86edccd734c7c_v2\", \"builder_6440ef9dedd0dc3b34dcb22ab34f3415d4cc49eb5cc8c1aeab1a9757364e9da5_v2\", \"builder_ded6992437bb43fbf38c4db56f613c83c13b8efc5129044b4fc05fb02888bbc4_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-99-e3yw\"], \"image\": [\"chrome-xenial-20110800-08efb743065\"], \"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\": [\"5637-4d8b832\"], \"ssd\": [\"0\"], \"zone\": [\"us\", \"us-east\", \"us-east1\", \"us-east1-d\"]}}}",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"started_ts": "1605874727282997",
"status": "COMPLETED",
"status_changed_ts": "1605878049137936",
"tags": [
"build_address:luci.chromium.ci/Linux Builder (dbg)/177871",
"builder:Linux Builder (dbg)",
"buildset:commit/git/11553c1392eaa2037e5bcd00db9d29f4163db57a",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/11553c1392eaa2037e5bcd00db9d29f4163db57a",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9028542104201649696",
"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/8863112041360932976/+/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:4ffe68f59aa37210",
"user_agent:luci-scheduler"
],
"updated_ts": "1605878049143964",
"url": "https://ci.chromium.org/b/8863112041360932976",
"utcnow_ts": "1605878049546971"
}
}
[13:14:09.556] Invocation finished in 55m46.718139174s with status SUCCEEDED