[07:03:43.788] New invocation is queued and will start shortly
[07:03:44.894] Starting the invocation (attempt 1)
[07:03:44.938] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[07:03:44.938] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[07:03:44.938] Buildbucket request:
{
"bucket": "luci.chromium.ci",
"client_operation_id": "9050214575307457840",
"parameters_json": "{\"builder_name\":\"Linux Builder (dbg)\",\"properties\":{\"branch\":\"refs/heads/master\",\"repository\":\"https://chromium.googlesource.com/chromium/src\",\"revision\":\"09a84d777ea4277f0e6b1027bf2c0414c85d2031\"}}",
"pubsub_callback": {
"auth_token": "...",
"topic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
},
"tags": [
"builder:Linux Builder (dbg)",
"scheduler_invocation_id:9050214575307457840",
"scheduler_job_id:chromium/Linux Builder (dbg)",
"user_agent:luci-scheduler",
"buildset:commit/git/09a84d777ea4277f0e6b1027bf2c0414c85d2031",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/09a84d777ea4277f0e6b1027bf2c0414c85d2031",
"gitiles_ref:refs/heads/master"
]
}
[07:03:45.794] Buildbucket response:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "PROD",
"created_by": "project:chromium",
"created_ts": "1585206225033147",
"id": "8884784513338259952",
"parameters_json": "{\"builder_name\": \"Linux Builder (dbg)\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"09a84d777ea4277f0e6b1027bf2c0414c85d2031\"}}",
"project": "chromium",
"result_details_json": "{\"properties\": {}}",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"status": "SCHEDULED",
"status_changed_ts": "1585206225484224",
"tags": [
"build_address:luci.chromium.ci/Linux Builder (dbg)/170202",
"builder:Linux Builder (dbg)",
"buildset:commit/git/09a84d777ea4277f0e6b1027bf2c0414c85d2031",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/09a84d777ea4277f0e6b1027bf2c0414c85d2031",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9050214575307457840",
"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/8884784513338259952/+/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": "1585206225484336",
"url": "https://ci.chromium.org/b/8884784513338259952",
"utcnow_ts": "1585206225783035"
}
}
[07:03:45.794] Task URL: https://ci.chromium.org/b/8884784513338259952
[07:03:45.794] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9050214575307457840:2:0) after 1m0s
[07:04:45.951] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9050214575307457840:2:0)
[07:04:45.951] Timer tick, asking Buildbucket for the build status
[07:04:46.042] Build 8884784513338259952: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[07:04:46.042] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9050214575307457840:3:0) after 1m0s
[07:05:46.159] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9050214575307457840:3:0)
[07:05:46.159] Timer tick, asking Buildbucket for the build status
[07:05:46.364] Build 8884784513338259952: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[07:05:46.364] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9050214575307457840:4:0) after 1m0s
[07:06:46.465] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9050214575307457840:4:0)
[07:06:46.465] Timer tick, asking Buildbucket for the build status
[07:06:47.270] Build 8884784513338259952: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[07:06:47.270] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9050214575307457840:5:0) after 1m0s
[07:07:47.726] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9050214575307457840:5:0)
[07:07:47.726] Timer tick, asking Buildbucket for the build status
[07:07:48.000] Build 8884784513338259952: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[07:07:48.000] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9050214575307457840:6:0) after 1m0s
[07:08:05.158] Received PubSub notification, asking Buildbucket for the build status
[07:08:05.304] Build 8884784513338259952: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:08:48.049] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9050214575307457840:6:0)
[07:08:48.049] Timer tick, asking Buildbucket for the build status
[07:08:48.192] Build 8884784513338259952: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:08:48.192] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9050214575307457840:8:0) after 1m0s
[07:09:48.548] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9050214575307457840:8:0)
[07:09:48.548] Timer tick, asking Buildbucket for the build status
[07:09:48.712] Build 8884784513338259952: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:09:48.712] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9050214575307457840:9:0) after 1m0s
[07:10:48.848] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9050214575307457840:9:0)
[07:10:48.848] Timer tick, asking Buildbucket for the build status
[07:10:49.136] Build 8884784513338259952: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:10:49.136] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9050214575307457840:10:0) after 1m0s
[07:11:49.206] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9050214575307457840:10:0)
[07:11:49.206] Timer tick, asking Buildbucket for the build status
[07:11:49.358] Build 8884784513338259952: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:11:49.358] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9050214575307457840:11:0) after 1m0s
[07:12:49.661] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9050214575307457840:11:0)
[07:12:49.661] Timer tick, asking Buildbucket for the build status
[07:12:49.819] Build 8884784513338259952: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:12:49.819] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9050214575307457840:12:0) after 1m0s
[07:13:49.994] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9050214575307457840:12:0)
[07:13:49.994] Timer tick, asking Buildbucket for the build status
[07:13:50.111] Build 8884784513338259952: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:13:50.111] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9050214575307457840:13:0) after 1m0s
[07:14:50.276] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9050214575307457840:13:0)
[07:14:50.276] Timer tick, asking Buildbucket for the build status
[07:14:50.383] Build 8884784513338259952: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:14:50.383] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9050214575307457840:14:0) after 1m0s
[07:15:50.642] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9050214575307457840:14:0)
[07:15:50.642] Timer tick, asking Buildbucket for the build status
[07:15:50.926] Build 8884784513338259952: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:15:50.926] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9050214575307457840:15:0) after 1m0s
[07:16:51.127] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9050214575307457840:15:0)
[07:16:51.127] Timer tick, asking Buildbucket for the build status
[07:16:51.417] Build 8884784513338259952: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:16:51.417] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9050214575307457840:16:0) after 1m0s
[07:17:51.723] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9050214575307457840:16:0)
[07:17:51.723] Timer tick, asking Buildbucket for the build status
[07:17:51.859] Build 8884784513338259952: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:17:51.859] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9050214575307457840:17:0) after 1m0s
[07:18:52.065] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9050214575307457840:17:0)
[07:18:52.065] Timer tick, asking Buildbucket for the build status
[07:18:52.375] Build 8884784513338259952: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:18:52.375] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9050214575307457840:18:0) after 1m0s
[07:19:52.395] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9050214575307457840:18:0)
[07:19:52.395] Timer tick, asking Buildbucket for the build status
[07:19:52.516] Build 8884784513338259952: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:19:52.516] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9050214575307457840:19:0) after 1m0s
[07:20:52.516] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9050214575307457840:19:0)
[07:20:52.516] Timer tick, asking Buildbucket for the build status
[07:20:52.678] Build 8884784513338259952: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:20:52.678] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9050214575307457840:20:0) after 1m0s
[07:21:52.825] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9050214575307457840:20:0)
[07:21:52.825] Timer tick, asking Buildbucket for the build status
[07:21:53.712] Build 8884784513338259952: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:21:53.712] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9050214575307457840:21:0) after 1m0s
[07:22:53.891] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9050214575307457840:21:0)
[07:22:53.891] Timer tick, asking Buildbucket for the build status
[07:22:53.964] Build 8884784513338259952: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:22:53.964] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9050214575307457840:22:0) after 1m0s
[07:23:54.084] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9050214575307457840:22:0)
[07:23:54.084] Timer tick, asking Buildbucket for the build status
[07:23:54.251] Build 8884784513338259952: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:23:54.251] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9050214575307457840:23:0) after 1m0s
[07:24:54.316] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9050214575307457840:23:0)
[07:24:54.316] Timer tick, asking Buildbucket for the build status
[07:24:54.451] Build 8884784513338259952: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:24:54.451] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9050214575307457840:24:0) after 1m0s
[07:25:54.597] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9050214575307457840:24:0)
[07:25:54.597] Timer tick, asking Buildbucket for the build status
[07:25:54.933] Build 8884784513338259952: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:25:54.933] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9050214575307457840:25:0) after 1m0s
[07:26:55.023] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9050214575307457840:25:0)
[07:26:55.023] Timer tick, asking Buildbucket for the build status
[07:26:55.233] Build 8884784513338259952: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:26:55.233] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9050214575307457840:26:0) after 1m0s
[07:27:55.297] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9050214575307457840:26:0)
[07:27:55.297] Timer tick, asking Buildbucket for the build status
[07:27:55.502] Build 8884784513338259952: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:27:55.502] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9050214575307457840:27:0) after 1m0s
[07:28:55.604] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9050214575307457840:27:0)
[07:28:55.604] Timer tick, asking Buildbucket for the build status
[07:28:55.748] Build 8884784513338259952: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:28:55.748] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9050214575307457840:28:0) after 1m0s
[07:29:55.798] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9050214575307457840:28:0)
[07:29:55.798] Timer tick, asking Buildbucket for the build status
[07:29:55.914] Build 8884784513338259952: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:29:55.914] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9050214575307457840:29:0) after 1m0s
[07:30:55.978] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9050214575307457840:29:0)
[07:30:55.978] Timer tick, asking Buildbucket for the build status
[07:30:56.078] Build 8884784513338259952: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:30:56.078] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9050214575307457840:30:0) after 1m0s
[07:31:56.162] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9050214575307457840:30:0)
[07:31:56.162] Timer tick, asking Buildbucket for the build status
[07:31:56.255] Build 8884784513338259952: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:31:56.255] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9050214575307457840:31:0) after 1m0s
[07:32:56.446] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9050214575307457840:31:0)
[07:32:56.446] Timer tick, asking Buildbucket for the build status
[07:32:57.037] Build 8884784513338259952: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:32:57.037] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9050214575307457840:32:0) after 1m0s
[07:33:57.135] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9050214575307457840:32:0)
[07:33:57.135] Timer tick, asking Buildbucket for the build status
[07:33:57.261] Build 8884784513338259952: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:33:57.261] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9050214575307457840:33:0) after 1m0s
[07:34:57.296] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9050214575307457840:33:0)
[07:34:57.296] Timer tick, asking Buildbucket for the build status
[07:34:57.449] Build 8884784513338259952: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:34:57.449] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9050214575307457840:34:0) after 1m0s
[07:35:57.452] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9050214575307457840:34:0)
[07:35:57.452] Timer tick, asking Buildbucket for the build status
[07:35:57.685] Build 8884784513338259952: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:35:57.685] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9050214575307457840:35:0) after 1m0s
[07:36:57.740] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9050214575307457840:35:0)
[07:36:57.740] Timer tick, asking Buildbucket for the build status
[07:36:57.817] Build 8884784513338259952: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:36:57.817] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9050214575307457840:36:0) after 1m0s
[07:37:57.809] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9050214575307457840:36:0)
[07:37:57.809] Timer tick, asking Buildbucket for the build status
[07:37:57.937] Build 8884784513338259952: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:37:57.937] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9050214575307457840:37:0) after 1m0s
[07:38:57.975] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9050214575307457840:37:0)
[07:38:57.975] Timer tick, asking Buildbucket for the build status
[07:38:58.210] Build 8884784513338259952: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:38:58.210] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9050214575307457840:38:0) after 1m0s
[07:39:58.313] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9050214575307457840:38:0)
[07:39:58.313] Timer tick, asking Buildbucket for the build status
[07:39:58.511] Build 8884784513338259952: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:39:58.511] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9050214575307457840:39:0) after 1m0s
[07:40:58.609] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9050214575307457840:39:0)
[07:40:58.609] Timer tick, asking Buildbucket for the build status
[07:40:59.034] Build 8884784513338259952: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:40:59.034] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9050214575307457840:40:0) after 1m0s
[07:41:59.087] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9050214575307457840:40:0)
[07:41:59.087] Timer tick, asking Buildbucket for the build status
[07:41:59.197] Build 8884784513338259952: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:41:59.197] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9050214575307457840:41:0) after 1m0s
[07:42:59.262] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9050214575307457840:41:0)
[07:42:59.262] Timer tick, asking Buildbucket for the build status
[07:42:59.394] Build 8884784513338259952: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:42:59.394] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9050214575307457840:42:0) after 1m0s
[07:43:59.474] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9050214575307457840:42:0)
[07:43:59.474] Timer tick, asking Buildbucket for the build status
[07:43:59.601] Build 8884784513338259952: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:43:59.601] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9050214575307457840:43:0) after 1m0s
[07:44:59.586] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9050214575307457840:43:0)
[07:44:59.586] Timer tick, asking Buildbucket for the build status
[07:45:00.276] Build 8884784513338259952: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:45:00.276] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9050214575307457840:44:0) after 1m0s
[07:46:00.326] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9050214575307457840:44:0)
[07:46:00.326] Timer tick, asking Buildbucket for the build status
[07:46:00.407] Build 8884784513338259952: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:46:00.407] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9050214575307457840:45:0) after 1m0s
[07:47:00.492] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9050214575307457840:45:0)
[07:47:00.492] Timer tick, asking Buildbucket for the build status
[07:47:00.786] Build 8884784513338259952: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:47:00.786] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9050214575307457840:46:0) after 1m0s
[07:48:00.823] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9050214575307457840:46:0)
[07:48:00.823] Timer tick, asking Buildbucket for the build status
[07:48:00.998] Build 8884784513338259952: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:48:00.998] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9050214575307457840:47:0) after 1m0s
[07:49:01.055] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9050214575307457840:47:0)
[07:49:01.055] Timer tick, asking Buildbucket for the build status
[07:49:01.384] Build 8884784513338259952: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:49:01.384] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9050214575307457840:48:0) after 1m0s
[07:50:01.435] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9050214575307457840:48:0)
[07:50:01.435] Timer tick, asking Buildbucket for the build status
[07:50:01.864] Build 8884784513338259952: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:50:01.864] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9050214575307457840:49:0) after 1m0s
[07:51:01.890] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9050214575307457840:49:0)
[07:51:01.891] Timer tick, asking Buildbucket for the build status
[07:51:02.033] Build 8884784513338259952: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:51:02.033] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9050214575307457840:50:0) after 1m0s
[07:52:02.142] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9050214575307457840:50:0)
[07:52:02.142] Timer tick, asking Buildbucket for the build status
[07:52:02.290] Build 8884784513338259952: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:52:02.290] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9050214575307457840:51:0) after 1m0s
[07:53:02.279] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9050214575307457840:51:0)
[07:53:02.279] Timer tick, asking Buildbucket for the build status
[07:53:02.399] Build 8884784513338259952: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:53:02.399] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9050214575307457840:52:0) after 1m0s
[07:54:02.460] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9050214575307457840:52:0)
[07:54:02.460] Timer tick, asking Buildbucket for the build status
[07:54:02.653] Build 8884784513338259952: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:54:02.653] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9050214575307457840:53:0) after 1m0s
[07:55:02.677] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9050214575307457840:53:0)
[07:55:02.677] Timer tick, asking Buildbucket for the build status
[07:55:02.819] Build 8884784513338259952: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:55:02.819] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9050214575307457840:54:0) after 1m0s
[07:55:40.063] Received PubSub notification, asking Buildbucket for the build status
[07:55:40.163] Build 8884784513338259952: status "COMPLETED", result "SUCCESS", failure_reason "", cancelation_reason ""
[07:55:40.163] Buildbucket build:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "PROD",
"completed_ts": "1585209338722109",
"created_by": "project:chromium",
"created_ts": "1585206225033147",
"id": "8884784513338259952",
"parameters_json": "{\"builder_name\": \"Linux Builder (dbg)\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"09a84d777ea4277f0e6b1027bf2c0414c85d2031\"}}",
"project": "chromium",
"result": "SUCCESS",
"result_details_json": "{\"properties\": {\"$build/chromium_tests\": {\"bucketed_triggers\": true}, \"$build/goma\": {\"enable_ats\": true, \"jobs\": 500.0, \"rpc_extra_params\": \"?prod\", \"server_host\": \"goma.chromium.org\"}, \"$recipe_engine/path\": {\"cache_dir\": \"/b/s/w/ir/cache\", \"temp_dir\": \"/b/s/w/ir/tmp/rt\"}, \"$recipe_engine/runtime\": {\"is_experimental\": false, \"is_luci\": true}, \"bot_id\": \"luci-chromium-ci-xenial-us-east1-d-8-94-980z\", \"branch\": \"refs/heads/master\", \"buildername\": \"Linux Builder (dbg)\", \"buildnumber\": 170202, \"got_angle_revision\": \"6719f54ac7ce85d5ea812299352387033a099530\", \"got_dawn_revision\": \"d5db214564bd781d5a6438a5fa48e39c9ba021b5\", \"got_nacl_revision\": \"ffed96d1528df9f114a30b14d4eb06120c8fb022\", \"got_revision\": \"09a84d777ea4277f0e6b1027bf2c0414c85d2031\", \"got_revision_cp\": \"refs/heads/master@{#753537}\", \"got_swarming_client_revision\": \"cc958279ffd6853e0a1b227a7e957ca334fe56af\", \"got_swiftshader_revision\": \"77090261dabcf44c7b5a0f97bdf35e812a13a66a\", \"got_v8_revision\": \"3714932e224a7a48553563a7eb18e2ffc000d796\", \"got_v8_revision_cp\": \"refs/heads/8.3.82@{#1}\", \"got_webrtc_revision\": \"d19513f3ffbb939fd56b5377b678bb31d3154e14\", \"got_webrtc_revision_cp\": \"refs/heads/master@{#30881}\", \"isolate_server\": \"https://isolateserver.appspot.com\", \"mastername\": \"chromium.linux\", \"path_config\": \"generic\", \"recipe\": \"chromium\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"09a84d777ea4277f0e6b1027bf2c0414c85d2031\", \"swarm_hashes_refs/heads/master(at){#753537}_without_patch\": {\"accessibility_unittests\": \"a3d4c172298f8bcce8762e7a57b9094402bc34bd\", \"angle_unittests\": \"5ad49e0d0859b8b0b61910379174ba050588f5e0\", \"app_shell_unittests\": \"6133f319b3a153d380dac4a729ef2f3601773bd3\", \"aura_unittests\": \"b302ebc77cd518578e29e48de09365c297f03ac0\", \"base_unittests\": \"74c58d7fb68f0b01bef7aa9af7cf5504519da8c6\", \"base_util_unittests\": \"8e7bebfff1fb78a046ea1d4a2851801b7a711694\", \"blink_common_unittests\": \"e06d96773aa330bd76a6ac8c3bc6a6f94204aeb1\", \"blink_fuzzer_unittests\": \"cb700bb236e8eea84b30d656d973fefd62ecb6eb\", \"blink_heap_unittests\": \"4bd0cfa3c4f88ba0f23752fd021b102203c9e4b9\", \"blink_platform_unittests\": \"a585a9e195b8c8a683a804d16e08bb8ad7bb73cd\", \"blink_python_tests\": \"06295a93a14d165fb47370f62922d6c3e294171b\", \"blink_unittests\": \"9a00784dd97957394c8c479d2fe4cf4897ed08b4\", \"blink_web_tests\": \"33fd1455cc6cf19426df0b501f7b08820a0270d6\", \"boringssl_crypto_tests\": \"1e82f62558e20f1c89917549bc0a2c1c270fed73\", \"boringssl_ssl_tests\": \"24b0b008a0c46f072490208f6b0f301faccdeeaf\", \"browser_tests\": \"3e5873c03b6d2d90e982c1fdf647d539a1d2a288\", \"cacheinvalidation_unittests\": \"cc21a0248c6674285461a13ac0c6ada6876eb5b7\", \"capture_unittests\": \"6a7ec24f50e374f05148bcf5ec08d656257939d9\", \"cast_unittests\": \"bb6f844a09236f03c4875c51a2e6b379d92e6f37\", \"cc_unittests\": \"ac3a1e85c3faa46e520a68d178974b14b43b2dbf\", \"chrome_app_unittests\": \"b2bbed427c478b5f85daf5dd7c41be9f4c103b8b\", \"chromedriver_unittests\": \"4457d9c347188a885a32096d48047245a4a3b803\", \"components_browsertests\": \"61ddcd82f27f2d4a99d167510efc5968e7a47b09\", \"components_unittests\": \"dcac0810b22921f61337b64233cf32826103968f\", \"compositor_unittests\": \"07567a0d7bc17dbb065c6d8c8a280ba5d0a3a9ab\", \"content_browsertests\": \"2a13c49846984c3e0fd45ed33b3acc07eae78c97\", \"content_shell_crash_test\": \"4df861d3e3a236e80430ca9c3f1288f00d73dc64\", \"content_unittests\": \"8cf4de65065bd42f8d881de7c91c12f9ed03b12e\", \"crashpad_tests\": \"7bc41b9163ea3ccd0725f00624949434bb2bffe6\", \"cronet_tests\": \"a86334c588fdd04fdb7325c0d16c8cbd5bed72ab\", \"cronet_unittests\": \"e7d120d38d176083dc02ef7d37029927248e482f\", \"crypto_unittests\": \"bba52e42210fd75b7089ae78cde8354518c519a9\", \"dbus_unittests\": \"d2097f65d9c119db01b9c28c4d9db646115ee0d5\", \"device_unittests\": \"a768037444075a2f76d954be3543deab1122a2d1\", \"display_unittests\": \"4df9b55eb096a4e79b4b9a56c6166d71e5c96f5d\", \"events_unittests\": \"17ad244590769e0c953436ec18b38392dfe949af\", \"extensions_browsertests\": \"bea3f118a6609b5f37a00d8b55e98f7ecb4f44d5\", \"extensions_unittests\": \"70731dcf67994b29022d7f67bb79e408c435e702\", \"filesystem_service_unittests\": \"2bcde4a71e79350434a399b3e4a29cd186f0f058\", \"flatbuffers_unittests\": \"d5a97f0e268c1e3e0a07477fbb5635ba77b25a21\", \"gcm_unit_tests\": \"59e693e9cb574a7aa38aed124b55933c084a82d9\", \"gfx_unittests\": \"4819a1acdcf3aadfdcf5c727268f3fbe4c8053e3\", \"gin_unittests\": \"52c267b7fe493f8a231a63941e1e0fbcc59141f6\", \"google_apis_unittests\": \"c571a41b161c7f38cc4ec61a7409c7f4abea4396\", \"gpu_unittests\": \"e5b6bea53417769b3b31a99db2390589332c8ce4\", \"grit_python_unittests\": \"920c6b3d7ae5f4f6a7545c1f01eb545d63387104\", \"gwp_asan_unittests\": \"cf22f63810236923c79a97d8ea706e40d38a84d1\", \"headless_browsertests\": \"f558a16f5c00e1e9e097d73fd828419aa4070377\", \"headless_unittests\": \"4b4437ae5ced42be8aa8657b662f8a87885373ae\", \"interactive_ui_tests\": \"f36e7917faaf786920d5b53ad67c1bd83361f6a0\", \"ipc_tests\": \"a79bb00adcf2c9cfc4945a060549d052bc80c097\", \"jingle_unittests\": \"b7e21841f79b7acf6f747cfd78f045cf5305a005\", \"latency_unittests\": \"a0324e62284f4d0d5bd7e0e8cc99ef96250804af\", \"libjingle_xmpp_unittests\": \"70e1ebf19fc605a11e30018a33179d9f24af7bc2\", \"media_blink_unittests\": \"085e4288f1dbe2d7ac47d45f8e5c317e0bf5b032\", \"media_service_unittests\": \"d6bb73d8d43cce8fb30a67b520b3592e7a83bd8d\", \"media_unittests\": \"eff96c858d48857039d2cd767bc897f1a061fc65\", \"message_center_unittests\": \"9f93ae7633f23f0dc0c25058f9b09fe412d3cfa2\", \"metrics_python_tests\": \"23da06f442776bc56d629cfa9e291a03c65ac045\", \"midi_unittests\": \"c84124ccf830f2a9f3e1903fb68a1a97cf31f2bd\", \"mojo_core_unittests\": \"70b9307a2e9815b75c7c029ce2967be392d50a59\", \"mojo_unittests\": \"f9640632d5c52d987578ab1dca74a62baf1ca21e\", \"nacl_helper_nonsfi_unittests\": \"ca5f7c245acc4027ac926bfaf0fbe32d7be1f30a\", \"nacl_loader_unittests\": \"b8f3f401585d1b48e5cf7fe323a80af36ef346d4\", \"native_theme_unittests\": \"49dbc110bd6c4e2aa57263112d51d7d180401099\", \"net_unittests\": \"489ab9d7c9477c991dd65697a89e0a572e65c3c3\", \"pdf_unittests\": \"83b54f2d2f20a6b8d4aad065fc4ef81734e1bf3a\", \"perfetto_unittests\": \"2d5451377cc5164128fa27edf1bd896826aa781c\", \"ppapi_unittests\": \"00b1ca5cdfdc7e0f571b954a3b3079d8574458a4\", \"printing_unittests\": \"292db87841ae5afa8f9c1b4ea3bdadf645258e52\", \"remoting_unittests\": \"17748d5d9b6f242b0fa4829254a0e9f820906f59\", \"sandbox_linux_unittests\": \"0537c4abd220f2d25f241a27f5a7a89a1b279f00\", \"service_manager_unittests\": \"e6962c54e2bb5734bf922dce929ab100bd697b10\", \"services_unittests\": \"36adbf42ab0e2f842e3262b0b12e023f04bdcac3\", \"shell_dialogs_unittests\": \"e6dd889a2314a242569e79ab817204ce1a7d1eb5\", \"skia_unittests\": \"45d6497d3f982b56dfe105abac0ceca12296655b\", \"snapshot_unittests\": \"cd909e1ab3d8f10bc6591391c3ff95ccd5cbf135\", \"sql_unittests\": \"ef70c0e616521e543149b478a42391b8819c2eee\", \"storage_unittests\": \"9f70b36e7feca2ec5cb9d4e633e0fe60fa009b48\", \"sync_integration_tests\": \"31b8599368dea7cccd876bfede2c36af8cd01187\", \"telemetry_gpu_unittests\": \"1054905b7431113b0c565005e5c7197ea4b9f318\", \"telemetry_perf_unittests\": \"de290560cd0a498be93db327aaa77ffbe89f8865\", \"telemetry_unittests\": \"ce89379afe86aad1e69941ab814da90e3b74540e\", \"traffic_annotation_auditor_unittests\": \"098618fe106b7ec0f5964ec549c1a6d506cf7628\", \"ui_base_unittests\": \"6f9d9cf01931bae359e643ea5d47bf3350873088\", \"ui_touch_selection_unittests\": \"3141582e8517274cf74745efb3893cf43a5f176d\", \"unit_tests\": \"3776d275737dee26778e262489cb923680c5c555\", \"url_unittests\": \"79740aaa25f384218e7da769683611d19584bb20\", \"views_perftests\": \"7d8e4331ffcac115e62980af9a0d846e19b247f6\", \"views_unittests\": \"35815fce1147bdec28b075c6c4c1edd2481c2e5c\", \"viz_unittests\": \"9ab0a46658cc9bca2206eaf64308c33e6288e706\", \"vr_common_unittests\": \"2212927c67ac9fbd4fb1c6ee3fffae03bbd27ac2\", \"vr_pixeltests\": \"e6bda7a7689cc9a14a1a08ed0704bcd1e4febef8\", \"webdriver_wpt_tests\": \"7901857de398ea54f38b37f48115c63108a0a990\", \"weblayer_browsertests\": \"18f33a2113b717023f6b70724bd89c419b9b4136\", \"wm_unittests\": \"0c15af1a04a393d044b371716cea2edf0ab320bd\", \"wtf_unittests\": \"6626c37aece1a96b0a834fbc4779f3fcfce6d05d\", \"xr_browser_tests\": \"1a881eeafd412e9998f94b4bfb9a508b03d1b2b6\"}}, \"swarming\": {\"bot_dimensions\": {\"builderless\": [\"1\"], \"caches\": [\"builder_5c21095a1a129131be723eb555273fa4f1dc89f7e6d0ed0ea2c09e97b0cf5fcb_v2\", \"builder_81975214af25fe3c157931ccf4182e1c4ae2635ce20b925a941b30b87e2fcb1d_v2\", \"builder_84395cd86c4615c28c38755187d54d1bbe2dcea268d302d74191d04ce3a055d0_v2\", \"builder_98a60cf4ba341a05f49601a94ea91d205798f47ee731869ed66ec9c0f2c54ce9_v2\", \"git\", \"goma_v2\", \"vpython\"], \"cores\": [\"8\"], \"cpu\": [\"x86\", \"x86-64\", \"x86-64-Broadwell_GCE\", \"x86-64-avx2\"], \"gce\": [\"1\"], \"gcp\": [\"google.com:chromecompute\"], \"gpu\": [\"none\"], \"id\": [\"luci-chromium-ci-xenial-us-east1-d-8-94-980z\"], \"image\": [\"chrome-xenial-20032200-f0f7a76907a\"], \"inside_docker\": [\"0\"], \"kvm\": [\"1\"], \"locale\": [\"en_US.UTF-8\"], \"machine_type\": [\"n1-standard-8\"], \"os\": [\"Linux\", \"Ubuntu\", \"Ubuntu-16.04\"], \"pool\": [\"luci.chromium.ci\"], \"python\": [\"2.7.12\"], \"server_version\": [\"4895-ce889b2\"], \"ssd\": [\"0\"], \"zone\": [\"us\", \"us-east\", \"us-east1\", \"us-east1-d\"]}}}",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"started_ts": "1585206484432031",
"status": "COMPLETED",
"status_changed_ts": "1585209339157085",
"tags": [
"build_address:luci.chromium.ci/Linux Builder (dbg)/170202",
"builder:Linux Builder (dbg)",
"buildset:commit/git/09a84d777ea4277f0e6b1027bf2c0414c85d2031",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/09a84d777ea4277f0e6b1027bf2c0414c85d2031",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9050214575307457840",
"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/8884784513338259952/+/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:4b2e78f8d7ae4210",
"user_agent:luci-scheduler"
],
"updated_ts": "1585209339161219",
"url": "https://ci.chromium.org/b/8884784513338259952",
"utcnow_ts": "1585209340151896"
}
}
[07:55:40.163] Invocation finished in 51m56.392398604s with status SUCCEEDED