[22:36:22.925] New invocation is queued and will start shortly
[22:36:24.093] Starting the invocation (attempt 1)
[22:36:24.133] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[22:36:24.133] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[22:36:24.133] Buildbucket request:
{
"bucket": "luci.chromium.ci",
"client_operation_id": "9021799047430844128",
"parameters_json": "{\"builder_name\":\"Linux Builder (dbg)\",\"properties\":{\"branch\":\"refs/heads/master\",\"repository\":\"https://chromium.googlesource.com/chromium/src\",\"revision\":\"8d90fa162a8f62f96a66eedb75852636a6571f3b\"}}",
"pubsub_callback": {
"auth_token": "...",
"topic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
},
"tags": [
"builder:Linux Builder (dbg)",
"scheduler_invocation_id:9021799047430844128",
"scheduler_job_id:chromium/Linux Builder (dbg)",
"user_agent:luci-scheduler",
"buildset:commit/git/8d90fa162a8f62f96a66eedb75852636a6571f3b",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/8d90fa162a8f62f96a66eedb75852636a6571f3b",
"gitiles_ref:refs/heads/master"
]
}
[22:36:25.603] Buildbucket response:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "PROD",
"created_by": "project:chromium",
"created_ts": "1612305384412472",
"id": "8856368985193178688",
"parameters_json": "{\"builder_name\": \"Linux Builder (dbg)\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"8d90fa162a8f62f96a66eedb75852636a6571f3b\"}}",
"project": "chromium",
"result_details_json": "{\"properties\": {}}",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"status": "SCHEDULED",
"status_changed_ts": "1612305385226604",
"tags": [
"build_address:luci.chromium.ci/Linux Builder (dbg)/180211",
"builder:Linux Builder (dbg)",
"buildset:commit/git/8d90fa162a8f62f96a66eedb75852636a6571f3b",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/8d90fa162a8f62f96a66eedb75852636a6571f3b",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9021799047430844128",
"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/8856368985193178688/+/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": "1612305385227059",
"url": "https://ci.chromium.org/b/8856368985193178688",
"utcnow_ts": "1612305385544168"
}
}
[22:36:25.604] Task URL: https://ci.chromium.org/b/8856368985193178688
[22:36:25.604] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021799047430844128:2:0) after 1m0s
[22:36:34.389] Received PubSub notification, asking Buildbucket for the build status
[22:36:34.946] Build 8856368985193178688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:37:25.630] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021799047430844128:2:0)
[22:37:25.630] Timer tick, asking Buildbucket for the build status
[22:37:25.834] Build 8856368985193178688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:37:25.834] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021799047430844128:4:0) after 1m0s
[22:38:25.846] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021799047430844128:4:0)
[22:38:25.846] Timer tick, asking Buildbucket for the build status
[22:38:25.923] Build 8856368985193178688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:38:25.923] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021799047430844128:5:0) after 1m0s
[22:39:25.958] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021799047430844128:5:0)
[22:39:25.958] Timer tick, asking Buildbucket for the build status
[22:39:26.032] Build 8856368985193178688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:39:26.032] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021799047430844128:6:0) after 1m0s
[22:40:26.085] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021799047430844128:6:0)
[22:40:26.085] Timer tick, asking Buildbucket for the build status
[22:40:26.281] Build 8856368985193178688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:40:26.281] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021799047430844128:7:0) after 1m0s
[22:41:26.313] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021799047430844128:7:0)
[22:41:26.313] Timer tick, asking Buildbucket for the build status
[22:41:26.470] Build 8856368985193178688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:41:26.470] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021799047430844128:8:0) after 1m0s
[22:42:26.511] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021799047430844128:8:0)
[22:42:26.511] Timer tick, asking Buildbucket for the build status
[22:42:26.891] Build 8856368985193178688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:42:26.891] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021799047430844128:9:0) after 1m0s
[22:43:26.942] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021799047430844128:9:0)
[22:43:26.942] Timer tick, asking Buildbucket for the build status
[22:43:27.018] Build 8856368985193178688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:43:27.018] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021799047430844128:10:0) after 1m0s
[22:44:27.122] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021799047430844128:10:0)
[22:44:27.122] Timer tick, asking Buildbucket for the build status
[22:44:27.222] Build 8856368985193178688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:44:27.222] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021799047430844128:11:0) after 1m0s
[22:45:27.247] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021799047430844128:11:0)
[22:45:27.247] Timer tick, asking Buildbucket for the build status
[22:45:27.311] Build 8856368985193178688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:45:27.311] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021799047430844128:12:0) after 1m0s
[22:46:27.327] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021799047430844128:12:0)
[22:46:27.327] Timer tick, asking Buildbucket for the build status
[22:46:27.477] Build 8856368985193178688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:46:27.477] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021799047430844128:13:0) after 1m0s
[22:47:27.504] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021799047430844128:13:0)
[22:47:27.504] Timer tick, asking Buildbucket for the build status
[22:47:27.579] Build 8856368985193178688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:47:27.579] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021799047430844128:14:0) after 1m0s
[22:48:27.624] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021799047430844128:14:0)
[22:48:27.624] Timer tick, asking Buildbucket for the build status
[22:48:27.688] Build 8856368985193178688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:48:27.688] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021799047430844128:15:0) after 1m0s
[22:49:27.796] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021799047430844128:15:0)
[22:49:27.796] Timer tick, asking Buildbucket for the build status
[22:49:27.855] Build 8856368985193178688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:49:27.855] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021799047430844128:16:0) after 1m0s
[22:50:27.871] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021799047430844128:16:0)
[22:50:27.871] Timer tick, asking Buildbucket for the build status
[22:50:28.007] Build 8856368985193178688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:50:28.007] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021799047430844128:17:0) after 1m0s
[22:51:28.162] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021799047430844128:17:0)
[22:51:28.162] Timer tick, asking Buildbucket for the build status
[22:51:28.290] Build 8856368985193178688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:51:28.290] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021799047430844128:18:0) after 1m0s
[22:52:28.357] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021799047430844128:18:0)
[22:52:28.357] Timer tick, asking Buildbucket for the build status
[22:52:28.427] Build 8856368985193178688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:52:28.427] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021799047430844128:19:0) after 1m0s
[22:53:28.454] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021799047430844128:19:0)
[22:53:28.454] Timer tick, asking Buildbucket for the build status
[22:53:28.525] Build 8856368985193178688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:53:28.525] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021799047430844128:20:0) after 1m0s
[22:54:28.546] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021799047430844128:20:0)
[22:54:28.546] Timer tick, asking Buildbucket for the build status
[22:54:28.625] Build 8856368985193178688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:54:28.625] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021799047430844128:21:0) after 1m0s
[22:55:28.697] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021799047430844128:21:0)
[22:55:28.697] Timer tick, asking Buildbucket for the build status
[22:55:28.782] Build 8856368985193178688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:55:28.782] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021799047430844128:22:0) after 1m0s
[22:56:28.791] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021799047430844128:22:0)
[22:56:28.791] Timer tick, asking Buildbucket for the build status
[22:56:30.400] Build 8856368985193178688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:56:30.400] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021799047430844128:23:0) after 1m0s
[22:57:30.623] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021799047430844128:23:0)
[22:57:30.623] Timer tick, asking Buildbucket for the build status
[22:57:30.702] Build 8856368985193178688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:57:30.702] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021799047430844128:24:0) after 1m0s
[22:58:30.747] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021799047430844128:24:0)
[22:58:30.747] Timer tick, asking Buildbucket for the build status
[22:58:30.851] Build 8856368985193178688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:58:30.851] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021799047430844128:25:0) after 1m0s
[22:59:30.927] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021799047430844128:25:0)
[22:59:30.927] Timer tick, asking Buildbucket for the build status
[22:59:30.989] Build 8856368985193178688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:59:30.989] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021799047430844128:26:0) after 1m0s
[23:00:31.074] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021799047430844128:26:0)
[23:00:31.074] Timer tick, asking Buildbucket for the build status
[23:00:31.151] Build 8856368985193178688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:00:31.151] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021799047430844128:27:0) after 1m0s
[23:01:31.257] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021799047430844128:27:0)
[23:01:31.257] Timer tick, asking Buildbucket for the build status
[23:01:31.364] Build 8856368985193178688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:01:31.364] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021799047430844128:28:0) after 1m0s
[23:02:31.437] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021799047430844128:28:0)
[23:02:31.437] Timer tick, asking Buildbucket for the build status
[23:02:31.639] Build 8856368985193178688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:02:31.639] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021799047430844128:29:0) after 1m0s
[23:03:31.652] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021799047430844128:29:0)
[23:03:31.652] Timer tick, asking Buildbucket for the build status
[23:03:31.717] Build 8856368985193178688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:03:31.717] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021799047430844128:30:0) after 1m0s
[23:04:31.766] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021799047430844128:30:0)
[23:04:31.766] Timer tick, asking Buildbucket for the build status
[23:04:31.915] Build 8856368985193178688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:04:31.915] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021799047430844128:31:0) after 1m0s
[23:05:32.148] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021799047430844128:31:0)
[23:05:32.148] Timer tick, asking Buildbucket for the build status
[23:05:32.214] Build 8856368985193178688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:05:32.214] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021799047430844128:32:0) after 1m0s
[23:06:32.629] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021799047430844128:32:0)
[23:06:32.629] Timer tick, asking Buildbucket for the build status
[23:06:32.732] Build 8856368985193178688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:06:32.732] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021799047430844128:33:0) after 1m0s
[23:07:32.786] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021799047430844128:33:0)
[23:07:32.786] Timer tick, asking Buildbucket for the build status
[23:07:32.877] Build 8856368985193178688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:07:32.877] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021799047430844128:34:0) after 1m0s
[23:08:32.990] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021799047430844128:34:0)
[23:08:32.990] Timer tick, asking Buildbucket for the build status
[23:08:33.138] Build 8856368985193178688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:08:33.138] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021799047430844128:35:0) after 1m0s
[23:09:33.637] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021799047430844128:35:0)
[23:09:33.637] Timer tick, asking Buildbucket for the build status
[23:09:33.730] Build 8856368985193178688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:09:33.730] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021799047430844128:36:0) after 1m0s
[23:10:33.964] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021799047430844128:36:0)
[23:10:33.964] Timer tick, asking Buildbucket for the build status
[23:10:34.041] Build 8856368985193178688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:10:34.041] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021799047430844128:37:0) after 1m0s
[23:11:34.132] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021799047430844128:37:0)
[23:11:34.132] Timer tick, asking Buildbucket for the build status
[23:11:34.308] Build 8856368985193178688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:11:34.308] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021799047430844128:38:0) after 1m0s
[23:12:34.457] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021799047430844128:38:0)
[23:12:34.457] Timer tick, asking Buildbucket for the build status
[23:12:34.512] Build 8856368985193178688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:12:34.512] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021799047430844128:39:0) after 1m0s
[23:13:34.551] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021799047430844128:39:0)
[23:13:34.551] Timer tick, asking Buildbucket for the build status
[23:13:34.834] Build 8856368985193178688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:13:34.834] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021799047430844128:40:0) after 1m0s
[23:14:34.874] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021799047430844128:40:0)
[23:14:34.874] Timer tick, asking Buildbucket for the build status
[23:14:35.040] Build 8856368985193178688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:14:35.040] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021799047430844128:41:0) after 1m0s
[23:15:35.087] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021799047430844128:41:0)
[23:15:35.087] Timer tick, asking Buildbucket for the build status
[23:15:35.769] Build 8856368985193178688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:15:35.769] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021799047430844128:42:0) after 1m0s
[23:16:35.835] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021799047430844128:42:0)
[23:16:35.835] Timer tick, asking Buildbucket for the build status
[23:16:35.973] Build 8856368985193178688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:16:35.973] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021799047430844128:43:0) after 1m0s
[23:17:36.027] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021799047430844128:43:0)
[23:17:36.027] Timer tick, asking Buildbucket for the build status
[23:17:36.113] Build 8856368985193178688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:17:36.113] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021799047430844128:44:0) after 1m0s
[23:18:36.186] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021799047430844128:44:0)
[23:18:36.186] Timer tick, asking Buildbucket for the build status
[23:18:36.265] Build 8856368985193178688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:18:36.265] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021799047430844128:45:0) after 1m0s
[23:19:36.321] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021799047430844128:45:0)
[23:19:36.321] Timer tick, asking Buildbucket for the build status
[23:19:36.410] Build 8856368985193178688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:19:36.410] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021799047430844128:46:0) after 1m0s
[23:20:36.482] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021799047430844128:46:0)
[23:20:36.482] Timer tick, asking Buildbucket for the build status
[23:20:36.553] Build 8856368985193178688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:20:36.553] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021799047430844128:47:0) after 1m0s
[23:21:36.573] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021799047430844128:47:0)
[23:21:36.573] Timer tick, asking Buildbucket for the build status
[23:21:36.684] Build 8856368985193178688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:21:36.684] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021799047430844128:48:0) after 1m0s
[23:22:36.704] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021799047430844128:48:0)
[23:22:36.704] Timer tick, asking Buildbucket for the build status
[23:22:37.012] Build 8856368985193178688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:22:37.012] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021799047430844128:49:0) after 1m0s
[23:23:37.059] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021799047430844128:49:0)
[23:23:37.059] Timer tick, asking Buildbucket for the build status
[23:23:37.428] Build 8856368985193178688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:23:37.428] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021799047430844128:50:0) after 1m0s
[23:24:37.508] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021799047430844128:50:0)
[23:24:37.508] Timer tick, asking Buildbucket for the build status
[23:24:37.589] Build 8856368985193178688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:24:37.589] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021799047430844128:51:0) after 1m0s
[23:25:37.794] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021799047430844128:51:0)
[23:25:37.794] Timer tick, asking Buildbucket for the build status
[23:25:38.004] Build 8856368985193178688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:25:38.004] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021799047430844128:52:0) after 1m0s
[23:26:38.078] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021799047430844128:52:0)
[23:26:38.078] Timer tick, asking Buildbucket for the build status
[23:26:38.190] Build 8856368985193178688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:26:38.190] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021799047430844128:53:0) after 1m0s
[23:27:38.268] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021799047430844128:53:0)
[23:27:38.268] Timer tick, asking Buildbucket for the build status
[23:27:38.346] Build 8856368985193178688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:27:38.346] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021799047430844128:54:0) after 1m0s
[23:28:38.421] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021799047430844128:54:0)
[23:28:38.421] Timer tick, asking Buildbucket for the build status
[23:28:38.628] Build 8856368985193178688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:28:38.628] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021799047430844128:55:0) after 1m0s
[23:29:38.676] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021799047430844128:55:0)
[23:29:38.676] Timer tick, asking Buildbucket for the build status
[23:29:38.809] Build 8856368985193178688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:29:38.809] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021799047430844128:56:0) after 1m0s
[23:30:38.835] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021799047430844128:56:0)
[23:30:38.835] Timer tick, asking Buildbucket for the build status
[23:30:39.096] Build 8856368985193178688: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:30:39.096] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021799047430844128:57:0) after 1m0s
[23:30:48.295] Received PubSub notification, asking Buildbucket for the build status
[23:30:48.444] Build 8856368985193178688: status "COMPLETED", result "SUCCESS", failure_reason "", cancelation_reason ""
[23:30:48.444] Buildbucket build:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "PROD",
"completed_ts": "1612308647280715",
"created_by": "project:chromium",
"created_ts": "1612305384412472",
"id": "8856368985193178688",
"parameters_json": "{\"builder_name\": \"Linux Builder (dbg)\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"8d90fa162a8f62f96a66eedb75852636a6571f3b\"}}",
"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\": \"8d90fa162a8f62f96a66eedb75852636a6571f3b\", \"project\": \"chromium/src\"}], \"$recipe_engine/path\": {\"cache_dir\": \"/b/s/w/ir/cache\", \"temp_dir\": \"/b/s/w/ir/tmp/rt\"}, \"$recipe_engine/runtime\": {\"is_experimental\": false, \"is_luci\": true}, \"bot_id\": \"luci-chromium-ci-xenial-us-central1-b-8-60-0fyf\", \"branch\": \"refs/heads/master\", \"builder_group\": \"chromium.linux\", \"buildername\": \"Linux Builder (dbg)\", \"buildnumber\": 180211, \"got_angle_revision\": \"7476121298462f0e15b3ed85acc54188c4d31859\", \"got_dawn_revision\": \"dd988bca844a6003a7249221680fc3e4f2d8b445\", \"got_nacl_revision\": \"952e81813a66902714b68f34b51073c5d1ba6c94\", \"got_revision\": \"8d90fa162a8f62f96a66eedb75852636a6571f3b\", \"got_revision_cp\": \"refs/heads/master@{#849801}\", \"got_swarming_client_revision\": \"a32a1607f6093d338f756c7e7c7b4333b0c50c9c\", \"got_swiftshader_revision\": \"51045556acd0fe0a1b687ef00725a57f0f19a91b\", \"got_v8_revision\": \"90801c815c96dd55224b008d11b63d51400b049d\", \"got_v8_revision_cp\": \"refs/heads/9.0.115@{#1}\", \"got_webrtc_revision\": \"e7c79fd3d66e0f6c54c027f880a8b1682ebae58a\", \"got_webrtc_revision_cp\": \"refs/heads/master@{#33124}\", \"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\": \"8d90fa162a8f62f96a66eedb75852636a6571f3b\", \"swarm_hashes_refs/heads/master(at){#849801}_without_patch\": {\"absl_hardening_tests\": \"9e7a0c02e96ae4bd267954e671f2917389c76aa4\", \"accessibility_unittests\": \"b61dabd87a74817cf70a67931ccaa3bc91ccfa55\", \"angle_unittests\": \"81e64395370051cc70f74b6c5776f3563d72916c\", \"app_shell_unittests\": \"bccd478c81c4202761e2c1f2433f3d64aa20c734\", \"aura_unittests\": \"00b80db91aba5748c6873c866c092e792b8f67eb\", \"base_unittests\": \"a43e69f1566db7d379b7ba99d68e2ad7c0d43009\", \"base_util_unittests\": \"c3d82ef65871b87b60a141788977935df4e665df\", \"blink_common_unittests\": \"9bbc6af6f305bf8e4fdbdeb6a2a9f95930681d42\", \"blink_fuzzer_unittests\": \"d5c89f5044d7fba04139d5130ba65f91d9370e4a\", \"blink_heap_unittests\": \"dae93160b127bf6db27fc417b61314fa2ac12a76\", \"blink_platform_unittests\": \"556f92f0de16ccfde80469ffb99c74e33fac9ba7\", \"blink_python_tests\": \"a4e066a789e1755a6a5ffe5f43876075035024f3\", \"blink_unittests\": \"2594b01f22e881f9022cf03da1d5c4a00a2b288c\", \"blink_web_tests\": \"5f3436e443622c4bb6c71f48a21066e75649fc33\", \"boringssl_crypto_tests\": \"843afe89cf8e4bf573a98497a0a20159c16d4ebd\", \"boringssl_ssl_tests\": \"96f1456e6a1630b8e9396bfb1283dcb3a2dcf55c\", \"browser_tests\": \"07633f8c8042513437ae7a676c1e7ed981907c83\", \"capture_unittests\": \"34ac2c350dbda4ff245f81121883ec5e7d137d9f\", \"cast_unittests\": \"ee64b50620a304f5a84a9b802b10a5bf9a0e6cf1\", \"cc_unittests\": \"a035ce2ef5ff4fdac96b06fa5c7814d13ef1e783\", \"chrome_app_unittests\": \"9efd4795dc33e6116a013c72e77c3ad57b40a0bb\", \"chromedriver_unittests\": \"22d2a4c3db84e44f34957ba60dca9befbad1017e\", \"components_browsertests\": \"26c24c3380456b95c06d2124c97926fc988a16ed\", \"components_unittests\": \"0f34dfa89278d5a84d7fa655ad9a2dfc88d46943\", \"compositor_unittests\": \"1730979818976a0018da229aa38b66db4452c367\", \"content_browsertests\": \"6632beb3dc9b235f6fb528870aa962f47da0f0e7\", \"content_shell_crash_test\": \"f103d8e28214faf57b411228cff501e5396e7816\", \"content_unittests\": \"56b5a803b6c4f214edc8e290dd41c0ef0737efb7\", \"crashpad_tests\": \"df9bc31ca71081d8f1323362b341a6767f2f10a1\", \"cronet_tests\": \"2da616b4d323577d538596ba93cee6018f375796\", \"cronet_unittests\": \"d93992f4f3310f6a49c6bb96fe4eb595f1143880\", \"crypto_unittests\": \"9a0d38657460a758f6dce6eb24b160bacd10a5dc\", \"dbus_unittests\": \"03cdf77f421041fd11d3d2ccc879cc3168af518a\", \"device_unittests\": \"5184be9b3ef8e2c08a951d42daa958b513debd91\", \"display_unittests\": \"842742879b53b0182a915b3fd2466047e1ea7948\", \"events_unittests\": \"974c5fd3539afe2b1a8416d9123de8a0bab14755\", \"extensions_browsertests\": \"817b04259a5fcde7bd3cf9c5f5687d25a4d3d032\", \"extensions_unittests\": \"022bc7ecb1b2e87639f9656054bff2934e00435c\", \"filesystem_service_unittests\": \"9a73310e6bf727032223851b3961faf161044c5e\", \"flatbuffers_unittests\": \"abe7737f42a55ed672142d98ab3b938d8384c781\", \"gcm_unit_tests\": \"850ce6b906e3e22d94b234f76c96c633fdcd945b\", \"gfx_unittests\": \"b5272aae6273c298fc48ee3cc4c970a18bfb8391\", \"gin_unittests\": \"b751fe383fca8cd0c582fcfe9e62d8a150f831dc\", \"google_apis_unittests\": \"1a981b3bc552517d98ee133e1ce1937f3ca3d355\", \"gpu_unittests\": \"8e372c420611dcc3468e5ffb959d126afb3dab83\", \"grit_python_unittests\": \"0532571aa381198443b89c1ec536d42cf612fc22\", \"gwp_asan_unittests\": \"ce0a7acba820a0ae40754b785320266549ec65c8\", \"headless_browsertests\": \"70b8d22e7ceb054dc23b7285f67927f80b7fe5ed\", \"headless_unittests\": \"24b85454c4897a7cacd5fece579f5ea22998b2da\", \"interactive_ui_tests\": \"396758cae3401e5025f9d123925b20318eccacf9\", \"ipc_tests\": \"8c0b66235e4fc272689adf90fc3c91f265e95cad\", \"jingle_unittests\": \"9b45c59b5077e6dfb0c8574bd5bf70ca9ca1a033\", \"latency_unittests\": \"4b6342ee07ef5aac4369205165e45f84d0bf12eb\", \"libjingle_xmpp_unittests\": \"105af0a13fbd4f61abfc13f6c41c5718ac138428\", \"liburlpattern_unittests\": \"03c0fe8d65aecf986d4b02e0fec8368533bca4e9\", \"media_blink_unittests\": \"4c10c997868dc8693234cf31dbe04e94f0dbd4c8\", \"media_unittests\": \"0678406df5d423983003b975ec09ee7e77656677\", \"message_center_unittests\": \"962892641adbaceb65805074e0f7e8bf5690770f\", \"metrics_python_tests\": \"cc2ab1a62218ae26113e3cc26781d821aff346c4\", \"midi_unittests\": \"b380f454f78a982a775bea546576cde61f86ff23\", \"mojo_core_unittests\": \"c2112b393f6b07f8249e95c6539d7d4716758e02\", \"mojo_unittests\": \"4eaa2770148ccf589b69e9ac01054f3b5068ada3\", \"nacl_helper_nonsfi_unittests\": \"bafa9df896bfae54a550a9cc3f9372275608506e\", \"nacl_loader_unittests\": \"3f82509da591fa99b64f0a42d5c579149cd0dbbd\", \"native_theme_unittests\": \"e8c1508a1bf11e625f1f5f4e6aaf249cba51af00\", \"net_unittests\": \"5f1ff239309850ca4b6be64505dd72caaf1dfbed\", \"openscreen_unittests\": \"d5806469bc1f9504b0bb950e7c6c9e6082fd7a65\", \"pdf_unittests\": \"cfbcac07ed3bad7bdcb5562c120f0b7f9b02a414\", \"perfetto_unittests\": \"f3828ed3fda7768f35de47d83fd4b64995706d9f\", \"ppapi_unittests\": \"6e32c292d1bec5ddc45882316c284ca6ce3e8e12\", \"printing_unittests\": \"c607bcd732c75cf49c205f5ab6418fb8fb128ccc\", \"remoting_unittests\": \"eb194243cd34f87cf3790cbf3ec395624824ff0f\", \"sandbox_linux_unittests\": \"391f1bda018417af6bd79eed511602dac0ff0a29\", \"service_manager_unittests\": \"3fdd7856019c12bd4a53888f6bb75b845fc8197d\", \"services_unittests\": \"36ea425703d1e6b488fe6416a7c198275499c5cc\", \"shell_dialogs_unittests\": \"ee31f6b7818601a32e18dfcd87a00af2938f0b93\", \"skia_unittests\": \"f0e6de0d08d1b2bf2f929ecab168e79384e18265\", \"snapshot_unittests\": \"19bbbae90c5d089bb9050206c2b47b4c3df7fc95\", \"sql_unittests\": \"243f3d2a150de4f8f28ffc4735c07c9b9ebe6aa6\", \"storage_unittests\": \"f2718068d90e016d5f1302e201e166a4baebba61\", \"sync_integration_tests\": \"fd0fa4b73a65f19ca7fcc7364bc597a6b929bf7e\", \"telemetry_gpu_unittests\": \"131dfeba70eda9c21f0627fca028078c8398b1f5\", \"telemetry_perf_unittests\": \"092b26517b12f1b9fc426d3fa71b9cf0cd6f7c53\", \"telemetry_unittests\": \"9aa15511e6f1bbb8a01d84ed80e0692b8c79536e\", \"traffic_annotation_auditor_unittests\": \"bf82e66020731b9fd216a157401d3a510a764320\", \"ui_base_unittests\": \"07c5f2f90fa76fea918ee155870261e856027399\", \"ui_touch_selection_unittests\": \"6aa340b7f3bf11246b9c69535b44598c562b2147\", \"unit_tests\": \"ef9077de65a452b14e59653049c8156d130d17cf\", \"url_unittests\": \"0d46cb568a0ec311e6da0488af47a9fb2fa35c6a\", \"views_perftests\": \"db189fddccebbdd435cc35186d9871dbdcd290a1\", \"views_unittests\": \"81e301d45c64fabf37ac1627c51cff41df22ac90\", \"viz_unittests\": \"b6ce69b498c09cb4d1fe7716c358a41cf304a9d8\", \"vr_common_unittests\": \"8ea825b4ca08ec285e7df99df0a58a4159f49bb4\", \"vr_pixeltests\": \"b7d80f898c6df6e56bdd91f989e6aad5d03b1208\", \"webdriver_wpt_tests\": \"94cf04350eeb17f5e14e0fba9c1a116b69881a1c\", \"weblayer_browsertests\": \"e1e5209b5612c3fba2852e3d0d9e0b834b940e25\", \"weblayer_unittests\": \"a277c6530901fb75657774d07ff94dea945aa9c0\", \"wm_unittests\": \"55577f9a126b9b8483ceb6d5a6890ed459f600dd\", \"wtf_unittests\": \"a4bd7420a28f40026a2955bd67482345d42ecfd8\", \"x11_unittests\": \"a4193c7413a013ded7b17f87d09eefcdc5c4ce16\", \"xr_browser_tests\": \"6e7dabfbe5761fc1208b96d26f6e284e187364d9\", \"zlib_unittests\": \"31d1e83b01afa4a5c1a6c5d017d280294e819859\"}}, \"swarming\": {\"bot_dimensions\": {\"builderless\": [\"1\"], \"caches\": [\"builder_21b7b67cc5140fc86b3165a24b457b619be37de8070af45371e28279dc829f76_v2\", \"builder_45c5b54513fd8d251ddf48af87bd70552077e6f51953669d04eaa4296b96a344_v2\", \"builder_97b15bccca8d35086c1bc50eecf0b53d98289cdc65be75a287efcc384d1f34ed_v2\", \"builder_e21c17032b725bcf1c922976a36352546baf3f39ec148d1e6730a93c0400d8cc_v2\", \"git\", \"goma_v2\", \"vpython\"], \"cores\": [\"8\"], \"cpu\": [\"x86\", \"x86-64\", \"x86-64-Haswell_GCE\", \"x86-64-avx2\"], \"gce\": [\"1\"], \"gcp\": [\"google.com:chromecompute\"], \"gpu\": [\"none\"], \"id\": [\"luci-chromium-ci-xenial-us-central1-b-8-60-0fyf\"], \"image\": [\"chrome-xenial-21011100-9488e34e558\"], \"inside_docker\": [\"0\"], \"kvm\": [\"1\"], \"locale\": [\"en_US.UTF-8\"], \"machine_type\": [\"e2-standard-8\"], \"os\": [\"Linux\", \"Ubuntu\", \"Ubuntu-16\", \"Ubuntu-16.04\", \"Ubuntu-16.04.6\"], \"pool\": [\"luci.chromium.ci\"], \"python\": [\"2.7.12\"], \"server_version\": [\"5673-2413400\"], \"ssd\": [\"0\"], \"zone\": [\"us\", \"us-central\", \"us-central1\", \"us-central1-b\"]}}}",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"started_ts": "1612305387024088",
"status": "COMPLETED",
"status_changed_ts": "1612308647861685",
"tags": [
"build_address:luci.chromium.ci/Linux Builder (dbg)/180211",
"builder:Linux Builder (dbg)",
"buildset:commit/git/8d90fa162a8f62f96a66eedb75852636a6571f3b",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/8d90fa162a8f62f96a66eedb75852636a6571f3b",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9021799047430844128",
"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/8856368985193178688/+/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:517db5505c5d3110",
"user_agent:luci-scheduler"
],
"updated_ts": "1612308647903047",
"url": "https://ci.chromium.org/b/8856368985193178688",
"utcnow_ts": "1612308648434657"
}
}
[23:30:48.444] Invocation finished in 54m25.550336521s with status SUCCEEDED