[06:42:26.636] New invocation is queued and will start shortly
[06:42:28.386] Starting the invocation (attempt 1)
[06:42:28.423] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[06:42:28.423] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[06:42:28.423] Buildbucket request:
{
"bucket": "luci.chromium.ci",
"client_operation_id": "9052299644724514864",
"parameters_json": "{\"builder_name\":\"Linux Builder (dbg)\",\"properties\":{\"branch\":\"refs/heads/master\",\"repository\":\"https://chromium.googlesource.com/chromium/src\",\"revision\":\"39db88fd0f28518ea3854d78bd173c02906200ec\"}}",
"pubsub_callback": {
"auth_token": "...",
"topic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
},
"tags": [
"builder:Linux Builder (dbg)",
"scheduler_invocation_id:9052299644724514864",
"scheduler_job_id:chromium/Linux Builder (dbg)",
"user_agent:luci-scheduler",
"buildset:commit/git/39db88fd0f28518ea3854d78bd173c02906200ec",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/39db88fd0f28518ea3854d78bd173c02906200ec",
"gitiles_ref:refs/heads/master"
]
}
[06:42:29.352] Buildbucket response:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "PROD",
"created_by": "project:chromium",
"created_ts": "1583217748552293",
"id": "8886869582052499840",
"parameters_json": "{\"builder_name\": \"Linux Builder (dbg)\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"39db88fd0f28518ea3854d78bd173c02906200ec\"}}",
"project": "chromium",
"result_details_json": "{\"properties\": {}}",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"status": "SCHEDULED",
"status_changed_ts": "1583217749195783",
"tags": [
"build_address:luci.chromium.ci/Linux Builder (dbg)/169270",
"builder:Linux Builder (dbg)",
"buildset:commit/git/39db88fd0f28518ea3854d78bd173c02906200ec",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/39db88fd0f28518ea3854d78bd173c02906200ec",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9052299644724514864",
"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/8886869582052499840/+/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": "1583217749195889",
"url": "https://ci.chromium.org/b/8886869582052499840",
"utcnow_ts": "1583217749336829"
}
}
[06:42:29.352] Task URL: https://ci.chromium.org/b/8886869582052499840
[06:42:29.352] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052299644724514864:2:0) after 1m0s
[06:43:29.487] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052299644724514864:2:0)
[06:43:29.487] Timer tick, asking Buildbucket for the build status
[06:43:29.642] Build 8886869582052499840: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[06:43:29.642] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052299644724514864:3:0) after 1m0s
[06:44:29.709] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052299644724514864:3:0)
[06:44:29.709] Timer tick, asking Buildbucket for the build status
[06:44:30.124] Build 8886869582052499840: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[06:44:30.124] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052299644724514864:4:0) after 1m0s
[06:45:30.229] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052299644724514864:4:0)
[06:45:30.229] Timer tick, asking Buildbucket for the build status
[06:45:30.378] Build 8886869582052499840: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[06:45:30.378] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052299644724514864:5:0) after 1m0s
[06:46:30.470] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052299644724514864:5:0)
[06:46:30.470] Timer tick, asking Buildbucket for the build status
[06:46:30.662] Build 8886869582052499840: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[06:46:30.662] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052299644724514864:6:0) after 1m0s
[06:47:08.842] Received PubSub notification, asking Buildbucket for the build status
[06:47:08.914] Build 8886869582052499840: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:47:30.722] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052299644724514864:6:0)
[06:47:30.722] Timer tick, asking Buildbucket for the build status
[06:47:30.798] Build 8886869582052499840: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:47:30.798] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052299644724514864:8:0) after 1m0s
[06:48:30.897] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052299644724514864:8:0)
[06:48:30.897] Timer tick, asking Buildbucket for the build status
[06:48:31.010] Build 8886869582052499840: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:48:31.010] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052299644724514864:9:0) after 1m0s
[06:49:31.142] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052299644724514864:9:0)
[06:49:31.142] Timer tick, asking Buildbucket for the build status
[06:49:31.472] Build 8886869582052499840: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:49:31.473] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052299644724514864:10:0) after 1m0s
[06:50:31.543] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052299644724514864:10:0)
[06:50:31.543] Timer tick, asking Buildbucket for the build status
[06:50:31.694] Build 8886869582052499840: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:50:31.694] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052299644724514864:11:0) after 1m0s
[06:51:31.769] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052299644724514864:11:0)
[06:51:31.769] Timer tick, asking Buildbucket for the build status
[06:51:31.862] Build 8886869582052499840: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:51:31.862] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052299644724514864:12:0) after 1m0s
[06:52:32.021] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052299644724514864:12:0)
[06:52:32.021] Timer tick, asking Buildbucket for the build status
[06:52:32.113] Build 8886869582052499840: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:52:32.113] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052299644724514864:13:0) after 1m0s
[06:53:32.165] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052299644724514864:13:0)
[06:53:32.165] Timer tick, asking Buildbucket for the build status
[06:53:33.362] Build 8886869582052499840: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:53:33.362] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052299644724514864:14:0) after 1m0s
[06:54:33.616] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052299644724514864:14:0)
[06:54:33.616] Timer tick, asking Buildbucket for the build status
[06:54:34.035] Build 8886869582052499840: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:54:34.035] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052299644724514864:15:0) after 1m0s
[06:55:34.573] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052299644724514864:15:0)
[06:55:34.573] Timer tick, asking Buildbucket for the build status
[06:55:34.728] Build 8886869582052499840: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:55:34.728] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052299644724514864:16:0) after 1m0s
[06:56:34.754] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052299644724514864:16:0)
[06:56:34.754] Timer tick, asking Buildbucket for the build status
[06:56:35.071] Build 8886869582052499840: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:56:35.071] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052299644724514864:17:0) after 1m0s
[06:57:35.105] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052299644724514864:17:0)
[06:57:35.105] Timer tick, asking Buildbucket for the build status
[06:57:35.407] Build 8886869582052499840: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:57:35.407] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052299644724514864:18:0) after 1m0s
[06:58:35.402] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052299644724514864:18:0)
[06:58:35.402] Timer tick, asking Buildbucket for the build status
[06:58:37.155] Build 8886869582052499840: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:58:37.155] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052299644724514864:19:0) after 1m0s
[06:59:37.144] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052299644724514864:19:0)
[06:59:37.144] Timer tick, asking Buildbucket for the build status
[06:59:37.266] Build 8886869582052499840: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:59:37.266] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052299644724514864:20:0) after 1m0s
[07:00:37.291] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052299644724514864:20:0)
[07:00:37.291] Timer tick, asking Buildbucket for the build status
[07:00:37.476] Build 8886869582052499840: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:00:37.476] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052299644724514864:21:0) after 1m0s
[07:01:37.499] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052299644724514864:21:0)
[07:01:37.499] Timer tick, asking Buildbucket for the build status
[07:01:37.638] Build 8886869582052499840: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:01:37.639] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052299644724514864:22:0) after 1m0s
[07:02:37.693] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052299644724514864:22:0)
[07:02:37.693] Timer tick, asking Buildbucket for the build status
[07:02:37.940] Build 8886869582052499840: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:02:37.940] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052299644724514864:23:0) after 1m0s
[07:03:37.976] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052299644724514864:23:0)
[07:03:37.976] Timer tick, asking Buildbucket for the build status
[07:03:38.915] Build 8886869582052499840: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:03:38.915] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052299644724514864:24:0) after 1m0s
[07:04:38.930] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052299644724514864:24:0)
[07:04:38.930] Timer tick, asking Buildbucket for the build status
[07:04:39.098] Build 8886869582052499840: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:04:39.098] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052299644724514864:25:0) after 1m0s
[07:05:39.286] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052299644724514864:25:0)
[07:05:39.286] Timer tick, asking Buildbucket for the build status
[07:05:39.405] Build 8886869582052499840: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:05:39.405] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052299644724514864:26:0) after 1m0s
[07:06:39.432] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052299644724514864:26:0)
[07:06:39.432] Timer tick, asking Buildbucket for the build status
[07:06:39.719] Build 8886869582052499840: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:06:39.719] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052299644724514864:27:0) after 1m0s
[07:07:39.827] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052299644724514864:27:0)
[07:07:39.827] Timer tick, asking Buildbucket for the build status
[07:07:40.189] Build 8886869582052499840: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:07:40.189] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052299644724514864:28:0) after 1m0s
[07:08:40.272] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052299644724514864:28:0)
[07:08:40.272] Timer tick, asking Buildbucket for the build status
[07:08:40.589] Build 8886869582052499840: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:08:40.589] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052299644724514864:29:0) after 1m0s
[07:09:40.665] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052299644724514864:29:0)
[07:09:40.665] Timer tick, asking Buildbucket for the build status
[07:09:40.820] Build 8886869582052499840: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:09:40.820] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052299644724514864:30:0) after 1m0s
[07:10:40.841] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052299644724514864:30:0)
[07:10:40.841] Timer tick, asking Buildbucket for the build status
[07:10:41.014] Build 8886869582052499840: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:10:41.014] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052299644724514864:31:0) after 1m0s
[07:11:41.046] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052299644724514864:31:0)
[07:11:41.046] Timer tick, asking Buildbucket for the build status
[07:11:41.169] Build 8886869582052499840: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:11:41.169] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052299644724514864:32:0) after 1m0s
[07:12:41.162] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052299644724514864:32:0)
[07:12:41.162] Timer tick, asking Buildbucket for the build status
[07:12:41.387] Build 8886869582052499840: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:12:41.387] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052299644724514864:33:0) after 1m0s
[07:13:41.415] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052299644724514864:33:0)
[07:13:41.415] Timer tick, asking Buildbucket for the build status
[07:13:42.197] Build 8886869582052499840: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:13:42.197] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052299644724514864:34:0) after 1m0s
[07:14:42.272] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052299644724514864:34:0)
[07:14:42.272] Timer tick, asking Buildbucket for the build status
[07:14:42.387] Build 8886869582052499840: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:14:42.387] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052299644724514864:35:0) after 1m0s
[07:15:42.415] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052299644724514864:35:0)
[07:15:42.415] Timer tick, asking Buildbucket for the build status
[07:15:42.522] Build 8886869582052499840: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:15:42.522] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052299644724514864:36:0) after 1m0s
[07:16:42.575] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052299644724514864:36:0)
[07:16:42.575] Timer tick, asking Buildbucket for the build status
[07:16:42.680] Build 8886869582052499840: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:16:42.680] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052299644724514864:37:0) after 1m0s
[07:17:42.708] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052299644724514864:37:0)
[07:17:42.708] Timer tick, asking Buildbucket for the build status
[07:17:42.990] Build 8886869582052499840: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:17:42.990] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052299644724514864:38:0) after 1m0s
[07:18:43.069] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052299644724514864:38:0)
[07:18:43.069] Timer tick, asking Buildbucket for the build status
[07:18:43.488] Build 8886869582052499840: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:18:43.488] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052299644724514864:39:0) after 1m0s
[07:19:43.532] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052299644724514864:39:0)
[07:19:43.532] Timer tick, asking Buildbucket for the build status
[07:19:43.742] Build 8886869582052499840: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:19:43.742] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052299644724514864:40:0) after 1m0s
[07:20:43.775] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052299644724514864:40:0)
[07:20:43.775] Timer tick, asking Buildbucket for the build status
[07:20:44.119] Build 8886869582052499840: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:20:44.119] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052299644724514864:41:0) after 1m0s
[07:21:44.147] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052299644724514864:41:0)
[07:21:44.147] Timer tick, asking Buildbucket for the build status
[07:21:44.256] Build 8886869582052499840: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:21:44.256] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052299644724514864:42:0) after 1m0s
[07:22:44.279] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052299644724514864:42:0)
[07:22:44.279] Timer tick, asking Buildbucket for the build status
[07:22:44.432] Build 8886869582052499840: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:22:44.432] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052299644724514864:43:0) after 1m0s
[07:23:44.465] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052299644724514864:43:0)
[07:23:44.465] Timer tick, asking Buildbucket for the build status
[07:23:45.298] Build 8886869582052499840: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:23:45.298] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052299644724514864:44:0) after 1m0s
[07:24:45.331] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052299644724514864:44:0)
[07:24:45.331] Timer tick, asking Buildbucket for the build status
[07:24:45.689] Build 8886869582052499840: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:24:45.689] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052299644724514864:45:0) after 1m0s
[07:25:45.729] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052299644724514864:45:0)
[07:25:45.729] Timer tick, asking Buildbucket for the build status
[07:25:45.860] Build 8886869582052499840: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:25:45.860] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052299644724514864:46:0) after 1m0s
[07:26:45.933] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052299644724514864:46:0)
[07:26:45.933] Timer tick, asking Buildbucket for the build status
[07:26:46.114] Build 8886869582052499840: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:26:46.114] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052299644724514864:47:0) after 1m0s
[07:27:46.193] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052299644724514864:47:0)
[07:27:46.193] Timer tick, asking Buildbucket for the build status
[07:27:46.352] Build 8886869582052499840: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:27:46.352] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052299644724514864:48:0) after 1m0s
[07:28:46.387] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052299644724514864:48:0)
[07:28:46.387] Timer tick, asking Buildbucket for the build status
[07:28:46.764] Build 8886869582052499840: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:28:46.764] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052299644724514864:49:0) after 1m0s
[07:29:46.872] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052299644724514864:49:0)
[07:29:46.872] Timer tick, asking Buildbucket for the build status
[07:29:46.985] Build 8886869582052499840: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:29:46.985] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052299644724514864:50:0) after 1m0s
[07:30:47.082] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052299644724514864:50:0)
[07:30:47.082] Timer tick, asking Buildbucket for the build status
[07:30:47.362] Build 8886869582052499840: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:30:47.362] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052299644724514864:51:0) after 1m0s
[07:31:47.440] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052299644724514864:51:0)
[07:31:47.440] Timer tick, asking Buildbucket for the build status
[07:31:47.630] Build 8886869582052499840: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:31:47.630] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052299644724514864:52:0) after 1m0s
[07:32:47.633] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052299644724514864:52:0)
[07:32:47.633] Timer tick, asking Buildbucket for the build status
[07:32:47.759] Build 8886869582052499840: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:32:47.759] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052299644724514864:53:0) after 1m0s
[07:33:47.822] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052299644724514864:53:0)
[07:33:47.823] Timer tick, asking Buildbucket for the build status
[07:33:48.127] Build 8886869582052499840: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:33:48.127] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052299644724514864:54:0) after 1m0s
[07:34:48.192] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052299644724514864:54:0)
[07:34:48.192] Timer tick, asking Buildbucket for the build status
[07:34:48.331] Build 8886869582052499840: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:34:48.331] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052299644724514864:55:0) after 1m0s
[07:35:48.459] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052299644724514864:55:0)
[07:35:48.459] Timer tick, asking Buildbucket for the build status
[07:35:48.607] Build 8886869582052499840: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:35:48.607] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052299644724514864:56:0) after 1m0s
[07:36:48.722] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052299644724514864:56:0)
[07:36:48.722] Timer tick, asking Buildbucket for the build status
[07:36:48.848] Build 8886869582052499840: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:36:48.848] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052299644724514864:57:0) after 1m0s
[07:37:49.034] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052299644724514864:57:0)
[07:37:49.034] Timer tick, asking Buildbucket for the build status
[07:37:49.270] Build 8886869582052499840: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:37:49.270] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052299644724514864:58:0) after 1m0s
[07:38:49.396] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052299644724514864:58:0)
[07:38:49.396] Timer tick, asking Buildbucket for the build status
[07:38:49.518] Build 8886869582052499840: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:38:49.518] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052299644724514864:59:0) after 1m0s
[07:39:49.610] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052299644724514864:59:0)
[07:39:49.610] Timer tick, asking Buildbucket for the build status
[07:39:49.731] Build 8886869582052499840: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:39:49.731] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052299644724514864:60:0) after 1m0s
[07:40:49.745] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052299644724514864:60:0)
[07:40:49.746] Timer tick, asking Buildbucket for the build status
[07:40:49.889] Build 8886869582052499840: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:40:49.889] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9052299644724514864:61:0) after 1m0s
[07:41:42.605] Received PubSub notification, asking Buildbucket for the build status
[07:41:42.723] Build 8886869582052499840: status "COMPLETED", result "SUCCESS", failure_reason "", cancelation_reason ""
[07:41:42.723] Buildbucket build:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "PROD",
"completed_ts": "1583221301552931",
"created_by": "project:chromium",
"created_ts": "1583217748552293",
"id": "8886869582052499840",
"parameters_json": "{\"builder_name\": \"Linux Builder (dbg)\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"39db88fd0f28518ea3854d78bd173c02906200ec\"}}",
"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\"}, \"$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-98-04mr\", \"branch\": \"refs/heads/master\", \"buildername\": \"Linux Builder (dbg)\", \"buildnumber\": 169270, \"got_angle_revision\": \"80f55e97420423d4b52aa7cf810d25e8ae125dce\", \"got_dawn_revision\": \"6f92b9160b197ba49b084faa7764f865b0c9ea92\", \"got_nacl_revision\": \"35bcc9f6d5e81c3c39ad57de97ef9cd22301ee9e\", \"got_revision\": \"39db88fd0f28518ea3854d78bd173c02906200ec\", \"got_revision_cp\": \"refs/heads/master@{#746263}\", \"got_swarming_client_revision\": \"0ac28472d073a515124c85b128c4378a914e0a4d\", \"got_swiftshader_revision\": \"176f3a3dbbc90d7b2dd9822db709505b4ad41b67\", \"got_v8_revision\": \"aa1b2c63e3149095e253e292986096c438f66e98\", \"got_v8_revision_cp\": \"refs/heads/8.2.231@{#1}\", \"got_webrtc_revision\": \"83762b21dbd2efbcbed81fefbd0218a99c03c18a\", \"got_webrtc_revision_cp\": \"refs/heads/master@{#30665}\", \"isolate_server\": \"https://isolateserver.appspot.com\", \"mastername\": \"chromium.linux\", \"path_config\": \"generic\", \"recipe\": \"chromium\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"39db88fd0f28518ea3854d78bd173c02906200ec\", \"swarm_hashes_refs/heads/master(at){#746263}_without_patch\": {\"accessibility_unittests\": \"7e7dd40b6b56f32d8a08b07c12541cf50eded233\", \"angle_unittests\": \"f4c7125e7e79712e83172a346191670535f561e8\", \"app_shell_unittests\": \"74fe529394d2c7d0af18733fbd62fcb80e706eae\", \"aura_unittests\": \"c64b28b367154b5c2cf0b9016bbe835cd4688121\", \"base_unittests\": \"e1dc4d80a9437cc5b195d6ea2a173357d4f10862\", \"base_util_unittests\": \"92182848f4dc3e04baf001b2a39c24e0e4dcdfe3\", \"blink_common_unittests\": \"65f7e5bebeb82597e548593736274345dc1e0677\", \"blink_fuzzer_unittests\": \"0ce64968e9b1db4deba26519a2f2d498ad20d740\", \"blink_heap_unittests\": \"dc3e27dd6bdec0c84f150885b0509397fe83f3e8\", \"blink_platform_unittests\": \"bf1b24110a5598ba481932247c19ea0701ceacee\", \"blink_python_tests\": \"ac4c90a706fc0047d76e69d5269ea972b708036a\", \"blink_unittests\": \"8d556edea77bc43decab4af7bac2af11a4531846\", \"blink_web_tests\": \"1ad869a705b144c0bee7bd02e7fdc1ed46c79d70\", \"boringssl_crypto_tests\": \"347e163d6d7875e7b0fb03c20bd67f307a82e599\", \"boringssl_ssl_tests\": \"2a96fcb5473933e81b7d52e58e4f6dec5248f29b\", \"browser_tests\": \"7a5887e14c303010abefbb96538f17b86c164121\", \"cacheinvalidation_unittests\": \"5f450377ea68e46b2962efa8a77199728bf77526\", \"capture_unittests\": \"2160abeb44ba296488a5c8ff0f7558c2e54941ef\", \"cast_unittests\": \"7dfce97825d68f60d164c6a189f948a753ef6c11\", \"cc_unittests\": \"df20003dbdbbcf485751ff97a340e0bc068e7484\", \"chrome_app_unittests\": \"6f84d89022f90e88a80daca4d5cf3cf0ad7e1608\", \"chromedriver_unittests\": \"2ab9c11b3a800717598adcffaae854e6243e2b12\", \"components_browsertests\": \"46bed02275da00d833f9893c525793656dd5c33b\", \"components_unittests\": \"748e9b765074f3f66c4a910717c4a507e7cbd237\", \"compositor_unittests\": \"989053d18d4da58a712b20c8ad8dd3ae7935325f\", \"content_browsertests\": \"fb430e15826505ae43275fd8b850f40c99216f6c\", \"content_shell_crash_test\": \"2fef8993ae98f9ecf74354a0da0cf390a02839e9\", \"content_unittests\": \"a6f7f79458856830406c19d0061ec0b71a43c219\", \"crashpad_tests\": \"18aed9303106fb20b5aeba4e0a2fef12e7e24193\", \"cronet_tests\": \"99609c8bf408fbd52a77a773944fc1d8c286dccd\", \"cronet_unittests\": \"04bd0dad1606b24f1e85ee8bc20cf5d28ae2822e\", \"crypto_unittests\": \"71c537e26d6586cc5d3b0ac9cb6a00ac21fd3d14\", \"dbus_unittests\": \"b49b55bf28ce2722460e5debd0bbf38435ffabfc\", \"device_unittests\": \"7d83e3989c8f1454c67099e71ccb49972df95206\", \"display_unittests\": \"240bdfa733153dd0f53aea459a639dda74a665bd\", \"events_unittests\": \"24c9b18600b1d217ef12359c1d210e7e3217d822\", \"extensions_browsertests\": \"6462e9c3a60a16fc927be033001a3209898da832\", \"extensions_unittests\": \"86208665ce94258d974f473d904cba1a3884eb07\", \"filesystem_service_unittests\": \"7b7dd1be89dd83de2314941d1f812a60e8330f98\", \"flatbuffers_unittests\": \"9b972b84314b0e944fad99f4c5be3f50c351ec0c\", \"gcm_unit_tests\": \"2fb8a16edf3051bbf33ef364fa18676576aac328\", \"gfx_unittests\": \"6e1167de58ae58590dbd1154a64737de5e0e88c7\", \"gin_unittests\": \"19dab49df35a19289c203040c7fda07e4e93188d\", \"google_apis_unittests\": \"8e6e552c28b49755da7cd5e325cf77dd3e12b535\", \"gpu_unittests\": \"41b9c4953cc39b25acb096da2f375f846c0c2f5f\", \"grit_python_unittests\": \"8d3af1ca6ce7611b3ef6d2516a78cd61f915c28b\", \"gwp_asan_unittests\": \"0855d57e6c94aab982a5b3ed1fa0905b85065e11\", \"headless_browsertests\": \"1c0ee377a1cff494a9b3d3f88dbab51f98b0d729\", \"headless_unittests\": \"98a29cf411570c7535ca75477445c20aaba2da77\", \"interactive_ui_tests\": \"7c72901b97f63b69991e124549fa0209432b78f0\", \"ipc_tests\": \"d6a20b6063355ff057fe6fa2f4335035fabe0fcc\", \"jingle_unittests\": \"f17097e8a39af8f230544c6ed98ada0d8930af11\", \"latency_unittests\": \"cabdaa3c75b03be08ff251ab7711fa3e07a4614c\", \"libjingle_xmpp_unittests\": \"f525c90f7273fd00960efecedfe1270308f02ad6\", \"media_blink_unittests\": \"8cde5690d48317fbe3faff3ebbaab80c2a007e19\", \"media_service_unittests\": \"86b900d9af3c2c38d57a9e701eee88cb604bc77d\", \"media_unittests\": \"35cb9baf1454a8d61abda3b4591f292d304094c7\", \"message_center_unittests\": \"a53deed2459d90d7f65cb983ef5f50aef689b33c\", \"metrics_python_tests\": \"4f0e6f6ff96cf6476537808e5ddd75a23b4072cf\", \"midi_unittests\": \"0bbc0614523f1a0c4e9a0fa9ab47e1ab1ec37b46\", \"mojo_core_unittests\": \"ba467814a0ce146d41e6657d6d5e31e97d622893\", \"mojo_unittests\": \"6f6ad75d9aed21f4e6622698e9614dafba086c64\", \"nacl_helper_nonsfi_unittests\": \"2b6bc8ab9e7a91366204cde5acd98dfb753368db\", \"nacl_loader_unittests\": \"6a6cfd9eca4ac57452ddb34a01a273c228cadad8\", \"native_theme_unittests\": \"3d64bf2d27d065e4baf3490c94777b0c72c85a23\", \"net_unittests\": \"fc1adee9bf55dacd3252bd338004ec8657fd8ff3\", \"pdf_unittests\": \"925efde8b75de8cf2935b96b8ceb06a2aa440e03\", \"perfetto_unittests\": \"664324f40892923afc6c5f5617085eeb446d13cf\", \"ppapi_unittests\": \"b3ffdc61e254dc63bb5050000d7b6e37451c047e\", \"printing_unittests\": \"96b74923023704e96cbac856602d72b6b444160a\", \"remoting_unittests\": \"602e839f0dda0f37f10150ed11a473d2ea846cab\", \"sandbox_linux_unittests\": \"ac2bbad4245b6865e9a24b7492daad69ac3eefc2\", \"service_manager_unittests\": \"4beab5bfbc43f6b65f4a08d7ffd60f48c53b06b0\", \"services_unittests\": \"1081074dcb171c3d9aef9d57fc55664bff5c22d8\", \"shell_dialogs_unittests\": \"c26ab4742501e2c9ba11222e277dc6b5d150fedc\", \"skia_unittests\": \"ccc010c5a42fb3bc4e3b1022354b7105e7ea7c2e\", \"snapshot_unittests\": \"47a061b74a9d0beedfb7ae5b4981ea4a21b18ced\", \"sql_unittests\": \"4d6c59a58b4fd8766b42e9c7c8142538353933a2\", \"storage_unittests\": \"33c5aee53d6f3d81e4b71d638e3d49dff90718ad\", \"sync_integration_tests\": \"b1133fe85a6c79f3bcd80496a56f2db61ffbc79f\", \"telemetry_gpu_unittests\": \"ab73039b0adbf3730c890791c90656bd5059106a\", \"telemetry_perf_unittests\": \"bbc76bbb68b0acfaa28ff12e0135fba49bea11fb\", \"telemetry_unittests\": \"fc21a081a1b43e508e18a73305b19655436199e1\", \"traffic_annotation_auditor_unittests\": \"90c9bedbdeb05d665b31b74e39010c271448f004\", \"ui_base_unittests\": \"d5ae191243ac58eee136d72b182c904576ae02e9\", \"ui_touch_selection_unittests\": \"bff6d4d5f88f147127e9326ad0cba36448640471\", \"unit_tests\": \"1d3b99513db1710180804e2f859b1ae766091035\", \"url_unittests\": \"68845201e82ef72da83b0afd76710a9148373728\", \"views_perftests\": \"f03b5f17072bcf87b527c07a0c50880e0d17faf0\", \"views_unittests\": \"40459fcd98cf5fc57fec3ecbd320da794038ac60\", \"viz_unittests\": \"303a680f17e2566debc65fb4698b57d309404c4f\", \"vr_common_unittests\": \"ca327647a86e8d401228f0eb6840b74cf944129d\", \"vr_pixeltests\": \"00d16e4100614a05278072abdc31d3a631a78ade\", \"webdriver_wpt_tests\": \"c55a35b6d264f18a4adf1a0626526896c2f8712a\", \"weblayer_browsertests\": \"4a605a58f349604b04e94c5c06f816f309aa83c7\", \"wm_unittests\": \"1fb3e17c866c5e81b5c259137b6632dde2229dbf\", \"wtf_unittests\": \"2bc39a8293397b8baaf72f63b4b14a0fc6a3999e\", \"xr_browser_tests\": \"e28311160d43a073f1ab8b91075e18f92bf8b75d\"}}, \"swarming\": {\"bot_dimensions\": {\"builderless\": [\"1\"], \"caches\": [\"builder_3e75b41c9bcf12a22209c03b338cce1fafa12941d3074ed1e1ed2450e6b71594_v2\", \"builder_43913798ffe4aacc9db317de63924a4a199b83672551513d069405cf6f3bc584_v2\", \"builder_5315cf154f9c1ae6b2621094599bc107171a849e1c0f232ec66a504ee800a364_v2\", \"builder_7d75f6999c07e42a7f7fde2313383264fbd8ed871e2008bde33b278973c1f4c8_v2\", \"builder_bee64b857be6df8b7c1ab34ae7b2c6eab296c35495667b8b8424b2083d103b1e_v2\", \"builder_c4692ee50382bcd35d592bcc0950e009bfc7efa8bba012f560f58cf3ab714e75_v2\", \"builder_d2010e0a6a440fb89731b061caf7d596c92723d209ffefd62489cc037db4f7a7_v2\", \"builder_fa0031875b7f2f11c46443055ab400bfaeb07a1d2a142b58c631314016c04e0a_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-98-04mr\"], \"image\": [\"chrome-xenial-20012600-8e1a7e485b7\"], \"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\": [\"4840-d3c86f9\"], \"ssd\": [\"0\"], \"zone\": [\"us\", \"us-east\", \"us-east1\", \"us-east1-d\"]}}}",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"started_ts": "1583218027770339",
"status": "COMPLETED",
"status_changed_ts": "1583221301873006",
"tags": [
"build_address:luci.chromium.ci/Linux Builder (dbg)/169270",
"builder:Linux Builder (dbg)",
"buildset:commit/git/39db88fd0f28518ea3854d78bd173c02906200ec",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/39db88fd0f28518ea3854d78bd173c02906200ec",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9052299644724514864",
"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/8886869582052499840/+/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:4ab7f335d669ad10",
"user_agent:luci-scheduler"
],
"updated_ts": "1583221301876783",
"url": "https://ci.chromium.org/b/8886869582052499840",
"utcnow_ts": "1583221302713123"
}
}
[07:41:42.723] Invocation finished in 59m16.102847585s with status SUCCEEDED