[01:54:29.579] New invocation is queued and will start shortly
[01:54:30.738] Starting the invocation (attempt 1)
[01:54:30.778] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[01:54:30.778] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[01:54:30.778] Buildbucket request:
{
"bucket": "luci.chromium.ci",
"client_operation_id": "9021424195489626032",
"parameters_json": "{\"builder_name\":\"Linux Builder (dbg)\",\"properties\":{\"branch\":\"refs/heads/master\",\"repository\":\"https://chromium.googlesource.com/chromium/src\",\"revision\":\"09af0a3aec46082ead9d78c81b2ce0f423e4c772\"}}",
"pubsub_callback": {
"auth_token": "...",
"topic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
},
"tags": [
"builder:Linux Builder (dbg)",
"scheduler_invocation_id:9021424195489626032",
"scheduler_job_id:chromium/Linux Builder (dbg)",
"user_agent:luci-scheduler",
"buildset:commit/git/09af0a3aec46082ead9d78c81b2ce0f423e4c772",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/09af0a3aec46082ead9d78c81b2ce0f423e4c772",
"gitiles_ref:refs/heads/master"
]
}
[01:54:31.445] Buildbucket response:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "PROD",
"created_by": "project:chromium",
"created_ts": "1612662870853132",
"id": "8855994133490180928",
"parameters_json": "{\"builder_name\": \"Linux Builder (dbg)\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"09af0a3aec46082ead9d78c81b2ce0f423e4c772\"}}",
"project": "chromium",
"result_details_json": "{\"properties\": {}}",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"status": "SCHEDULED",
"status_changed_ts": "1612662871337224",
"tags": [
"build_address:luci.chromium.ci/Linux Builder (dbg)/180343",
"builder:Linux Builder (dbg)",
"buildset:commit/git/09af0a3aec46082ead9d78c81b2ce0f423e4c772",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/09af0a3aec46082ead9d78c81b2ce0f423e4c772",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9021424195489626032",
"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/8855994133490180928/+/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": "1612662871337351",
"url": "https://ci.chromium.org/b/8855994133490180928",
"utcnow_ts": "1612662871436355"
}
}
[01:54:31.445] Task URL: https://ci.chromium.org/b/8855994133490180928
[01:54:31.445] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021424195489626032:2:0) after 1m0s
[01:55:31.497] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021424195489626032:2:0)
[01:55:31.497] Timer tick, asking Buildbucket for the build status
[01:55:31.597] Build 8855994133490180928: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[01:55:31.597] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021424195489626032:3:0) after 1m0s
[01:56:31.621] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021424195489626032:3:0)
[01:56:31.621] Timer tick, asking Buildbucket for the build status
[01:56:31.703] Build 8855994133490180928: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[01:56:31.703] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021424195489626032:4:0) after 1m0s
[01:57:31.675] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021424195489626032:4:0)
[01:57:31.675] Timer tick, asking Buildbucket for the build status
[01:57:31.760] Build 8855994133490180928: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[01:57:31.760] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021424195489626032:5:0) after 1m0s
[01:58:31.784] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021424195489626032:5:0)
[01:58:31.784] Timer tick, asking Buildbucket for the build status
[01:58:31.860] Build 8855994133490180928: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[01:58:31.860] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021424195489626032:6:0) after 1m0s
[01:59:31.885] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021424195489626032:6:0)
[01:59:31.885] Timer tick, asking Buildbucket for the build status
[01:59:32.017] Build 8855994133490180928: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[01:59:32.017] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021424195489626032:7:0) after 1m0s
[02:00:32.027] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021424195489626032:7:0)
[02:00:32.027] Timer tick, asking Buildbucket for the build status
[02:00:32.168] Build 8855994133490180928: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[02:00:32.168] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021424195489626032:8:0) after 1m0s
[02:01:32.224] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021424195489626032:8:0)
[02:01:32.224] Timer tick, asking Buildbucket for the build status
[02:01:32.325] Build 8855994133490180928: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[02:01:32.325] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021424195489626032:9:0) after 1m0s
[02:02:32.392] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021424195489626032:9:0)
[02:02:32.392] Timer tick, asking Buildbucket for the build status
[02:02:32.605] Build 8855994133490180928: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[02:02:32.605] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021424195489626032:10:0) after 1m0s
[02:03:32.654] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021424195489626032:10:0)
[02:03:32.654] Timer tick, asking Buildbucket for the build status
[02:03:32.753] Build 8855994133490180928: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[02:03:32.753] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021424195489626032:11:0) after 1m0s
[02:04:32.782] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021424195489626032:11:0)
[02:04:32.782] Timer tick, asking Buildbucket for the build status
[02:04:32.916] Build 8855994133490180928: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[02:04:32.916] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021424195489626032:12:0) after 1m0s
[02:05:32.934] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021424195489626032:12:0)
[02:05:32.934] Timer tick, asking Buildbucket for the build status
[02:05:33.020] Build 8855994133490180928: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[02:05:33.020] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021424195489626032:13:0) after 1m0s
[02:06:33.036] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021424195489626032:13:0)
[02:06:33.036] Timer tick, asking Buildbucket for the build status
[02:06:33.293] Build 8855994133490180928: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[02:06:33.293] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021424195489626032:14:0) after 1m0s
[02:07:33.329] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021424195489626032:14:0)
[02:07:33.329] Timer tick, asking Buildbucket for the build status
[02:07:33.415] Build 8855994133490180928: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[02:07:33.415] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021424195489626032:15:0) after 1m0s
[02:08:33.390] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021424195489626032:15:0)
[02:08:33.390] Timer tick, asking Buildbucket for the build status
[02:08:33.477] Build 8855994133490180928: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[02:08:33.477] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021424195489626032:16:0) after 1m0s
[02:09:33.503] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021424195489626032:16:0)
[02:09:33.503] Timer tick, asking Buildbucket for the build status
[02:09:33.688] Build 8855994133490180928: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[02:09:33.688] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021424195489626032:17:0) after 1m0s
[02:10:33.775] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021424195489626032:17:0)
[02:10:33.775] Timer tick, asking Buildbucket for the build status
[02:10:34.054] Build 8855994133490180928: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[02:10:34.054] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021424195489626032:18:0) after 1m0s
[02:11:34.039] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021424195489626032:18:0)
[02:11:34.039] Timer tick, asking Buildbucket for the build status
[02:11:34.103] Build 8855994133490180928: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[02:11:34.103] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021424195489626032:19:0) after 1m0s
[02:12:34.178] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021424195489626032:19:0)
[02:12:34.178] Timer tick, asking Buildbucket for the build status
[02:12:34.245] Build 8855994133490180928: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[02:12:34.245] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021424195489626032:20:0) after 1m0s
[02:13:34.270] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021424195489626032:20:0)
[02:13:34.270] Timer tick, asking Buildbucket for the build status
[02:13:34.510] Build 8855994133490180928: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[02:13:34.510] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021424195489626032:21:0) after 1m0s
[02:14:34.520] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021424195489626032:21:0)
[02:14:34.520] Timer tick, asking Buildbucket for the build status
[02:14:34.638] Build 8855994133490180928: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[02:14:34.638] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021424195489626032:22:0) after 1m0s
[02:15:34.650] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021424195489626032:22:0)
[02:15:34.650] Timer tick, asking Buildbucket for the build status
[02:15:35.016] Build 8855994133490180928: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[02:15:35.016] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021424195489626032:23:0) after 1m0s
[02:16:35.068] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021424195489626032:23:0)
[02:16:35.068] Timer tick, asking Buildbucket for the build status
[02:16:35.247] Build 8855994133490180928: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[02:16:35.247] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021424195489626032:24:0) after 1m0s
[02:17:35.253] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021424195489626032:24:0)
[02:17:35.253] Timer tick, asking Buildbucket for the build status
[02:17:35.330] Build 8855994133490180928: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[02:17:35.330] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021424195489626032:25:0) after 1m0s
[02:18:35.487] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021424195489626032:25:0)
[02:18:35.487] Timer tick, asking Buildbucket for the build status
[02:18:35.566] Build 8855994133490180928: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[02:18:35.566] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021424195489626032:26:0) after 1m0s
[02:19:35.619] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021424195489626032:26:0)
[02:19:35.619] Timer tick, asking Buildbucket for the build status
[02:19:35.715] Build 8855994133490180928: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[02:19:35.715] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021424195489626032:27:0) after 1m0s
[02:20:35.778] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021424195489626032:27:0)
[02:20:35.778] Timer tick, asking Buildbucket for the build status
[02:20:35.856] Build 8855994133490180928: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[02:20:35.856] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021424195489626032:28:0) after 1m0s
[02:21:35.921] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021424195489626032:28:0)
[02:21:35.921] Timer tick, asking Buildbucket for the build status
[02:21:36.189] Build 8855994133490180928: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[02:21:36.189] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021424195489626032:29:0) after 1m0s
[02:22:36.216] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021424195489626032:29:0)
[02:22:36.216] Timer tick, asking Buildbucket for the build status
[02:22:36.510] Build 8855994133490180928: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[02:22:36.510] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021424195489626032:30:0) after 1m0s
[02:23:36.535] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021424195489626032:30:0)
[02:23:36.536] Timer tick, asking Buildbucket for the build status
[02:23:36.615] Build 8855994133490180928: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[02:23:36.615] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021424195489626032:31:0) after 1m0s
[02:24:36.633] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021424195489626032:31:0)
[02:24:36.633] Timer tick, asking Buildbucket for the build status
[02:24:37.010] Build 8855994133490180928: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[02:24:37.010] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021424195489626032:32:0) after 1m0s
[02:25:37.263] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021424195489626032:32:0)
[02:25:37.263] Timer tick, asking Buildbucket for the build status
[02:25:37.547] Build 8855994133490180928: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[02:25:37.547] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021424195489626032:33:0) after 1m0s
[02:26:37.759] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021424195489626032:33:0)
[02:26:37.759] Timer tick, asking Buildbucket for the build status
[02:26:37.831] Build 8855994133490180928: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[02:26:37.831] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021424195489626032:34:0) after 1m0s
[02:27:37.860] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021424195489626032:34:0)
[02:27:37.860] Timer tick, asking Buildbucket for the build status
[02:27:37.954] Build 8855994133490180928: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[02:27:37.954] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021424195489626032:35:0) after 1m0s
[02:28:38.073] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021424195489626032:35:0)
[02:28:38.073] Timer tick, asking Buildbucket for the build status
[02:28:38.164] Build 8855994133490180928: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[02:28:38.164] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021424195489626032:36:0) after 1m0s
[02:29:38.257] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021424195489626032:36:0)
[02:29:38.257] Timer tick, asking Buildbucket for the build status
[02:29:38.672] Build 8855994133490180928: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[02:29:38.672] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021424195489626032:37:0) after 1m0s
[02:30:35.171] Received PubSub notification, asking Buildbucket for the build status
[02:30:35.418] Build 8855994133490180928: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:30:38.695] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021424195489626032:37:0)
[02:30:38.695] Timer tick, asking Buildbucket for the build status
[02:30:38.791] Build 8855994133490180928: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:30:38.791] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021424195489626032:39:0) after 1m0s
[02:31:38.836] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021424195489626032:39:0)
[02:31:38.836] Timer tick, asking Buildbucket for the build status
[02:31:38.918] Build 8855994133490180928: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:31:38.918] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021424195489626032:40:0) after 1m0s
[02:32:38.937] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021424195489626032:40:0)
[02:32:38.937] Timer tick, asking Buildbucket for the build status
[02:32:39.050] Build 8855994133490180928: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:32:39.050] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021424195489626032:41:0) after 1m0s
[02:33:39.078] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021424195489626032:41:0)
[02:33:39.078] Timer tick, asking Buildbucket for the build status
[02:33:39.151] Build 8855994133490180928: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:33:39.151] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021424195489626032:42:0) after 1m0s
[02:34:39.184] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021424195489626032:42:0)
[02:34:39.184] Timer tick, asking Buildbucket for the build status
[02:34:39.441] Build 8855994133490180928: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:34:39.441] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021424195489626032:43:0) after 1m0s
[02:35:39.471] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021424195489626032:43:0)
[02:35:39.471] Timer tick, asking Buildbucket for the build status
[02:35:39.956] Build 8855994133490180928: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:35:39.957] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021424195489626032:44:0) after 1m0s
[02:36:40.023] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021424195489626032:44:0)
[02:36:40.023] Timer tick, asking Buildbucket for the build status
[02:36:40.081] Build 8855994133490180928: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:36:40.081] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021424195489626032:45:0) after 1m0s
[02:37:40.101] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021424195489626032:45:0)
[02:37:40.101] Timer tick, asking Buildbucket for the build status
[02:37:40.243] Build 8855994133490180928: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:37:40.243] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021424195489626032:46:0) after 1m0s
[02:38:40.345] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021424195489626032:46:0)
[02:38:40.345] Timer tick, asking Buildbucket for the build status
[02:38:40.466] Build 8855994133490180928: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:38:40.466] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021424195489626032:47:0) after 1m0s
[02:39:40.593] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021424195489626032:47:0)
[02:39:40.593] Timer tick, asking Buildbucket for the build status
[02:39:41.093] Build 8855994133490180928: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:39:41.093] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021424195489626032:48:0) after 1m0s
[02:40:41.104] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021424195489626032:48:0)
[02:40:41.104] Timer tick, asking Buildbucket for the build status
[02:40:41.174] Build 8855994133490180928: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:40:41.174] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021424195489626032:49:0) after 1m0s
[02:41:41.385] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021424195489626032:49:0)
[02:41:41.385] Timer tick, asking Buildbucket for the build status
[02:41:41.710] Build 8855994133490180928: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:41:41.710] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021424195489626032:50:0) after 1m0s
[02:42:41.770] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021424195489626032:50:0)
[02:42:41.770] Timer tick, asking Buildbucket for the build status
[02:42:41.830] Build 8855994133490180928: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:42:41.830] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021424195489626032:51:0) after 1m0s
[02:43:41.927] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021424195489626032:51:0)
[02:43:41.927] Timer tick, asking Buildbucket for the build status
[02:43:42.383] Build 8855994133490180928: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:43:42.383] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021424195489626032:52:0) after 1m0s
[02:44:42.507] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021424195489626032:52:0)
[02:44:42.507] Timer tick, asking Buildbucket for the build status
[02:44:42.742] Build 8855994133490180928: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:44:42.742] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021424195489626032:53:0) after 1m0s
[02:45:42.764] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021424195489626032:53:0)
[02:45:42.764] Timer tick, asking Buildbucket for the build status
[02:45:43.033] Build 8855994133490180928: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:45:43.033] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021424195489626032:54:0) after 1m0s
[02:46:43.056] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021424195489626032:54:0)
[02:46:43.056] Timer tick, asking Buildbucket for the build status
[02:46:43.128] Build 8855994133490180928: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:46:43.128] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021424195489626032:55:0) after 1m0s
[02:47:43.189] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021424195489626032:55:0)
[02:47:43.189] Timer tick, asking Buildbucket for the build status
[02:47:43.412] Build 8855994133490180928: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:47:43.412] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021424195489626032:56:0) after 1m0s
[02:48:43.431] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021424195489626032:56:0)
[02:48:43.431] Timer tick, asking Buildbucket for the build status
[02:48:43.696] Build 8855994133490180928: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:48:43.696] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021424195489626032:57:0) after 1m0s
[02:49:43.749] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021424195489626032:57:0)
[02:49:43.749] Timer tick, asking Buildbucket for the build status
[02:49:43.915] Build 8855994133490180928: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:49:43.915] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021424195489626032:58:0) after 1m0s
[02:50:44.008] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021424195489626032:58:0)
[02:50:44.008] Timer tick, asking Buildbucket for the build status
[02:50:44.068] Build 8855994133490180928: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:50:44.068] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021424195489626032:59:0) after 1m0s
[02:51:44.148] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021424195489626032:59:0)
[02:51:44.148] Timer tick, asking Buildbucket for the build status
[02:51:44.311] Build 8855994133490180928: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:51:44.311] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021424195489626032:60:0) after 1m0s
[02:52:44.297] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021424195489626032:60:0)
[02:52:44.297] Timer tick, asking Buildbucket for the build status
[02:52:44.449] Build 8855994133490180928: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:52:44.449] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021424195489626032:61:0) after 1m0s
[02:53:44.504] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021424195489626032:61:0)
[02:53:44.504] Timer tick, asking Buildbucket for the build status
[02:53:44.606] Build 8855994133490180928: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:53:44.606] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021424195489626032:62:0) after 1m0s
[02:54:44.674] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021424195489626032:62:0)
[02:54:44.674] Timer tick, asking Buildbucket for the build status
[02:54:45.083] Build 8855994133490180928: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:54:45.083] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021424195489626032:63:0) after 1m0s
[02:55:45.106] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021424195489626032:63:0)
[02:55:45.106] Timer tick, asking Buildbucket for the build status
[02:55:45.164] Build 8855994133490180928: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:55:45.165] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021424195489626032:64:0) after 1m0s
[02:56:45.194] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021424195489626032:64:0)
[02:56:45.194] Timer tick, asking Buildbucket for the build status
[02:56:45.434] Build 8855994133490180928: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:56:45.434] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021424195489626032:65:0) after 1m0s
[02:57:45.433] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021424195489626032:65:0)
[02:57:45.433] Timer tick, asking Buildbucket for the build status
[02:57:45.488] Build 8855994133490180928: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:57:45.488] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021424195489626032:66:0) after 1m0s
[02:58:45.459] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021424195489626032:66:0)
[02:58:45.459] Timer tick, asking Buildbucket for the build status
[02:58:45.530] Build 8855994133490180928: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:58:45.530] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021424195489626032:67:0) after 1m0s
[02:59:45.644] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021424195489626032:67:0)
[02:59:45.644] Timer tick, asking Buildbucket for the build status
[02:59:45.734] Build 8855994133490180928: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:59:45.734] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021424195489626032:68:0) after 1m0s
[03:00:45.792] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021424195489626032:68:0)
[03:00:45.792] Timer tick, asking Buildbucket for the build status
[03:00:45.945] Build 8855994133490180928: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:00:45.945] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021424195489626032:69:0) after 1m0s
[03:01:45.977] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021424195489626032:69:0)
[03:01:45.977] Timer tick, asking Buildbucket for the build status
[03:01:46.035] Build 8855994133490180928: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:01:46.035] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021424195489626032:70:0) after 1m0s
[03:02:46.057] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021424195489626032:70:0)
[03:02:46.057] Timer tick, asking Buildbucket for the build status
[03:02:46.307] Build 8855994133490180928: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:02:46.307] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021424195489626032:71:0) after 1m0s
[03:03:46.326] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021424195489626032:71:0)
[03:03:46.326] Timer tick, asking Buildbucket for the build status
[03:03:46.385] Build 8855994133490180928: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:03:46.385] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021424195489626032:72:0) after 1m0s
[03:04:46.395] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021424195489626032:72:0)
[03:04:46.395] Timer tick, asking Buildbucket for the build status
[03:04:46.506] Build 8855994133490180928: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:04:46.506] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021424195489626032:73:0) after 1m0s
[03:05:46.533] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021424195489626032:73:0)
[03:05:46.533] Timer tick, asking Buildbucket for the build status
[03:05:46.832] Build 8855994133490180928: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:05:46.832] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021424195489626032:74:0) after 1m0s
[03:06:46.851] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021424195489626032:74:0)
[03:06:46.851] Timer tick, asking Buildbucket for the build status
[03:06:46.912] Build 8855994133490180928: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:06:46.912] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021424195489626032:75:0) after 1m0s
[03:07:46.936] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021424195489626032:75:0)
[03:07:46.936] Timer tick, asking Buildbucket for the build status
[03:07:47.128] Build 8855994133490180928: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:07:47.128] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021424195489626032:76:0) after 1m0s
[03:08:47.155] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021424195489626032:76:0)
[03:08:47.155] Timer tick, asking Buildbucket for the build status
[03:08:47.228] Build 8855994133490180928: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:08:47.228] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021424195489626032:77:0) after 1m0s
[03:09:47.244] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021424195489626032:77:0)
[03:09:47.244] Timer tick, asking Buildbucket for the build status
[03:09:47.350] Build 8855994133490180928: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:09:47.350] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021424195489626032:78:0) after 1m0s
[03:10:47.372] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021424195489626032:78:0)
[03:10:47.372] Timer tick, asking Buildbucket for the build status
[03:10:47.428] Build 8855994133490180928: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:10:47.428] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021424195489626032:79:0) after 1m0s
[03:11:47.502] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021424195489626032:79:0)
[03:11:47.502] Timer tick, asking Buildbucket for the build status
[03:11:47.552] Build 8855994133490180928: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:11:47.552] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021424195489626032:80:0) after 1m0s
[03:12:47.596] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021424195489626032:80:0)
[03:12:47.596] Timer tick, asking Buildbucket for the build status
[03:12:47.772] Build 8855994133490180928: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:12:47.772] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021424195489626032:81:0) after 1m0s
[03:13:47.795] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021424195489626032:81:0)
[03:13:47.795] Timer tick, asking Buildbucket for the build status
[03:13:48.028] Build 8855994133490180928: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:13:48.028] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021424195489626032:82:0) after 1m0s
[03:14:48.047] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021424195489626032:82:0)
[03:14:48.047] Timer tick, asking Buildbucket for the build status
[03:14:48.155] Build 8855994133490180928: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:14:48.155] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021424195489626032:83:0) after 1m0s
[03:15:48.231] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021424195489626032:83:0)
[03:15:48.231] Timer tick, asking Buildbucket for the build status
[03:15:48.278] Build 8855994133490180928: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:15:48.278] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021424195489626032:84:0) after 1m0s
[03:16:48.349] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021424195489626032:84:0)
[03:16:48.349] Timer tick, asking Buildbucket for the build status
[03:16:48.635] Build 8855994133490180928: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:16:48.635] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021424195489626032:85:0) after 1m0s
[03:17:48.711] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021424195489626032:85:0)
[03:17:48.711] Timer tick, asking Buildbucket for the build status
[03:17:48.870] Build 8855994133490180928: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:17:48.870] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021424195489626032:86:0) after 1m0s
[03:18:49.094] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021424195489626032:86:0)
[03:18:49.094] Timer tick, asking Buildbucket for the build status
[03:18:49.400] Build 8855994133490180928: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:18:49.400] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021424195489626032:87:0) after 1m0s
[03:19:49.396] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021424195489626032:87:0)
[03:19:49.396] Timer tick, asking Buildbucket for the build status
[03:19:49.494] Build 8855994133490180928: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:19:49.494] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021424195489626032:88:0) after 1m0s
[03:20:49.566] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021424195489626032:88:0)
[03:20:49.566] Timer tick, asking Buildbucket for the build status
[03:20:49.640] Build 8855994133490180928: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:20:49.640] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021424195489626032:89:0) after 1m0s
[03:21:49.783] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021424195489626032:89:0)
[03:21:49.783] Timer tick, asking Buildbucket for the build status
[03:21:49.908] Build 8855994133490180928: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:21:49.908] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021424195489626032:90:0) after 1m0s
[03:22:49.903] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021424195489626032:90:0)
[03:22:49.903] Timer tick, asking Buildbucket for the build status
[03:22:49.977] Build 8855994133490180928: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:22:49.977] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021424195489626032:91:0) after 1m0s
[03:23:50.084] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021424195489626032:91:0)
[03:23:50.084] Timer tick, asking Buildbucket for the build status
[03:23:50.136] Build 8855994133490180928: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:23:50.137] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021424195489626032:92:0) after 1m0s
[03:24:50.161] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021424195489626032:92:0)
[03:24:50.161] Timer tick, asking Buildbucket for the build status
[03:24:50.503] Build 8855994133490180928: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:24:50.503] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021424195489626032:93:0) after 1m0s
[03:25:50.524] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021424195489626032:93:0)
[03:25:50.524] Timer tick, asking Buildbucket for the build status
[03:25:50.585] Build 8855994133490180928: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:25:50.585] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021424195489626032:94:0) after 1m0s
[03:26:50.605] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021424195489626032:94:0)
[03:26:50.605] Timer tick, asking Buildbucket for the build status
[03:26:50.688] Build 8855994133490180928: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:26:50.688] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021424195489626032:95:0) after 1m0s
[03:27:50.710] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021424195489626032:95:0)
[03:27:50.710] Timer tick, asking Buildbucket for the build status
[03:27:50.860] Build 8855994133490180928: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:27:50.860] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021424195489626032:96:0) after 1m0s
[03:28:50.884] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021424195489626032:96:0)
[03:28:50.884] Timer tick, asking Buildbucket for the build status
[03:28:51.226] Build 8855994133490180928: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:28:51.226] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021424195489626032:97:0) after 1m0s
[03:29:51.249] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021424195489626032:97:0)
[03:29:51.249] Timer tick, asking Buildbucket for the build status
[03:29:51.414] Build 8855994133490180928: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:29:51.414] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021424195489626032:98:0) after 1m0s
[03:30:51.436] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021424195489626032:98:0)
[03:30:51.436] Timer tick, asking Buildbucket for the build status
[03:30:51.669] Build 8855994133490180928: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:30:51.669] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021424195489626032:99:0) after 1m0s
[03:31:51.692] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021424195489626032:99:0)
[03:31:51.692] Timer tick, asking Buildbucket for the build status
[03:31:51.744] Build 8855994133490180928: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:31:51.744] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021424195489626032:100:0) after 1m0s
[03:32:51.765] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021424195489626032:100:0)
[03:32:51.765] Timer tick, asking Buildbucket for the build status
[03:32:51.821] Build 8855994133490180928: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:32:51.821] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021424195489626032:101:0) after 1m0s
[03:33:55.576] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021424195489626032:101:0)
[03:33:55.576] Timer tick, asking Buildbucket for the build status
[03:33:55.631] Build 8855994133490180928: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:33:55.631] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021424195489626032:102:0) after 1m0s
[03:34:55.668] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021424195489626032:102:0)
[03:34:55.669] Timer tick, asking Buildbucket for the build status
[03:34:55.765] Build 8855994133490180928: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:34:55.765] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021424195489626032:103:0) after 1m0s
[03:35:55.833] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021424195489626032:103:0)
[03:35:55.833] Timer tick, asking Buildbucket for the build status
[03:35:56.020] Build 8855994133490180928: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:35:56.020] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021424195489626032:104:0) after 1m0s
[03:36:56.066] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021424195489626032:104:0)
[03:36:56.066] Timer tick, asking Buildbucket for the build status
[03:36:56.318] Build 8855994133490180928: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:36:56.319] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021424195489626032:105:0) after 1m0s
[03:37:56.420] Handling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021424195489626032:105:0)
[03:37:56.420] Timer tick, asking Buildbucket for the build status
[03:37:56.515] Build 8855994133490180928: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:37:56.515] Scheduling timer "check-buildbucket-build-status" (chromium/Linux Builder (dbg):9021424195489626032:106:0) after 1m0s
[03:38:21.367] Received PubSub notification, asking Buildbucket for the build status
[03:38:21.528] Build 8855994133490180928: status "COMPLETED", result "SUCCESS", failure_reason "", cancelation_reason ""
[03:38:21.528] Buildbucket build:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "PROD",
"completed_ts": "1612669100524625",
"created_by": "project:chromium",
"created_ts": "1612662870853132",
"id": "8855994133490180928",
"parameters_json": "{\"builder_name\": \"Linux Builder (dbg)\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"09af0a3aec46082ead9d78c81b2ce0f423e4c772\"}}",
"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\": \"09af0a3aec46082ead9d78c81b2ce0f423e4c772\", \"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-13-dhxs\", \"branch\": \"refs/heads/master\", \"builder_group\": \"chromium.linux\", \"buildername\": \"Linux Builder (dbg)\", \"buildnumber\": 180343, \"got_angle_revision\": \"d820ec7b3e5f9412d1ceb55d31b3f7dc09e3d16d\", \"got_dawn_revision\": \"2831f0584028114a8896059ce00e7bddaf3bba1f\", \"got_nacl_revision\": \"8db20f20316f13d8886a2732099f5bb880568663\", \"got_revision\": \"09af0a3aec46082ead9d78c81b2ce0f423e4c772\", \"got_revision_cp\": \"refs/heads/master@{#851511}\", \"got_swarming_client_revision\": \"a32a1607f6093d338f756c7e7c7b4333b0c50c9c\", \"got_swiftshader_revision\": \"266614a36dbd5328a9079ea6bbef9026c7bbe3d7\", \"got_v8_revision\": \"711403215714087a74f05b1382b18e4c318be936\", \"got_v8_revision_cp\": \"refs/heads/9.0.137@{#1}\", \"got_webrtc_revision\": \"d42413a4b4636422ba5ea66ba40e7d24fb64f9b1\", \"got_webrtc_revision_cp\": \"refs/heads/master@{#33183}\", \"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\": \"09af0a3aec46082ead9d78c81b2ce0f423e4c772\", \"swarm_hashes_refs/heads/master(at){#851511}_without_patch\": {\"absl_hardening_tests\": \"64778e6cf144fe3d48d21b54d50d816037546329\", \"accessibility_unittests\": \"c7f8b90e9634705099236ed1505348c09e5b7817\", \"angle_unittests\": \"7bf1e437c5e082b4df2b40607246e295d994ae78\", \"app_shell_unittests\": \"cad66d8440e053070d8c5f353df42a5d2b3791c4\", \"aura_unittests\": \"1af7420be707751e24e39df3e6db9cb3212118a8\", \"base_unittests\": \"3ddbc1a95da50aeea326e2c67dab45bbebe560d4\", \"base_util_unittests\": \"6cbe72d9fc9c0cb5c67ad8032fcfe4ce98aae651\", \"blink_common_unittests\": \"f8e9cc4f24fc9cafbc1e7d673747b8b725f59e5a\", \"blink_fuzzer_unittests\": \"026932eb66a6cb2207a7fc526220b4d842470ae9\", \"blink_heap_unittests\": \"31eb78c45ecf7592397222f970785a9d9e2946bf\", \"blink_platform_unittests\": \"fdd1e3e4080e487f1eab1f4c96cc6390d98368ea\", \"blink_python_tests\": \"3fee940019a74843b7b678382a7a94dcff347e7b\", \"blink_unittests\": \"49d09859dc2211890a7185544ecb38c8124d2c6d\", \"blink_web_tests\": \"665b751baa4adee182bbbdff22311563bcb2c475\", \"boringssl_crypto_tests\": \"a424bd46f5e0cb93bfe4b0086d92335aab64a2be\", \"boringssl_ssl_tests\": \"6de8a3da857594aae666b0a9bc8df0b0c90319dd\", \"browser_tests\": \"8886b8f8a2f0456152db21783adc3010ae162396\", \"capture_unittests\": \"d0be6c7498070be48cbea476191e61be3934b5e8\", \"cast_unittests\": \"dc231939c5e5113333ffed46634941cdc4f72222\", \"cc_unittests\": \"e9306f6a2a2f67a11a0c0bfe511b45acdf33ea80\", \"chrome_app_unittests\": \"ac2dcbd7f37c9105b64c2dea62336986ffc24454\", \"chromedriver_unittests\": \"f82cf653ca2c9d5da2fa4b85254615b729e0e02c\", \"components_browsertests\": \"21bdebaca9c47b22a33e331ed83f1317e69ed9c1\", \"components_unittests\": \"564c82c3c5f08e8edbfe8b2697fec6dd41b66071\", \"compositor_unittests\": \"00315f4f7debb3f18afeb4b947a3716ae0612d1f\", \"content_browsertests\": \"16c3401a647aa71385832d089abbb0b44b642001\", \"content_shell_crash_test\": \"2da299dac50ef24efb169e5340b8d7c85cbde056\", \"content_unittests\": \"2ae4ee5fc14e11f350c4dadd5356c86fbb7545d6\", \"crashpad_tests\": \"7138511a3168abe7e77e2abb84c7daa2789a2bd8\", \"cronet_tests\": \"66956a24fa581863b7d5eab02c5ffbdb57c9b12a\", \"cronet_unittests\": \"be3cce6290684cc52ec22752cc2c3eb4932a95bc\", \"crypto_unittests\": \"f935dc19a1bcf6c82098e4c41ec4a4b92029c9ae\", \"dbus_unittests\": \"4737b77a777c13e925ee08f9ac34290c3ce9b4ec\", \"device_unittests\": \"1db69a4b8de16a079d27d6cabd6b07bce1e64361\", \"display_unittests\": \"2759599edd82db72467fe9577e3dcd750e609760\", \"events_unittests\": \"9655d16bc3909b51afd35828fd28444b2ed2d4bf\", \"extensions_browsertests\": \"10bcda75ef5a212f59cdfe8b06989f31753488e0\", \"extensions_unittests\": \"b4068c9ee29f3e5fd209f87dd57ec68d5c5642fe\", \"filesystem_service_unittests\": \"9e411975211d7c8c2356b23de7192e8438a2d804\", \"flatbuffers_unittests\": \"adcf587971a832b1be93c24a83cd1ec975e593d8\", \"gcm_unit_tests\": \"56640b358837872308625b9af72d1235b5b822ae\", \"gfx_unittests\": \"85e24e103d6a3067503efe0bf816b4024e207c08\", \"gin_unittests\": \"b90cec6ed2e56e0b49b855bf90b902668713c901\", \"google_apis_unittests\": \"698446604d7480c9229ea285ffe74054ab061196\", \"gpu_unittests\": \"38631ea18b897d8327ebf108d87df055d0f8c30a\", \"grit_python_unittests\": \"09d11eaebf65aefde13fcafc2a12fe42d6476e6b\", \"gwp_asan_unittests\": \"7dfe728c41fd835db8f14a894babf49ef30649ec\", \"headless_browsertests\": \"2f5ab9b81156f5937a91cab9e62eced5a42cea6c\", \"headless_unittests\": \"89e13f615da80519f6038609251967ccf557bd17\", \"interactive_ui_tests\": \"16b2c4ce85ec2b4e8e18d2b4af1dfc5f5519bcf0\", \"ipc_tests\": \"54f9f9f5407bbdaa60c714e3744cb90e2b24dc9c\", \"jingle_unittests\": \"d8dff5004289f503e77e99dc96b8ad3473098ccf\", \"latency_unittests\": \"fc27d457c0967967541012cb995cb7218a9ac8db\", \"libjingle_xmpp_unittests\": \"988c29af95ad53ccb3cd5644e176c17a0aa55f18\", \"liburlpattern_unittests\": \"215aac7876731a2562355499b348b66c74218d1c\", \"media_blink_unittests\": \"57c33d64bf8b8878b398d355a18a854a5409bf21\", \"media_unittests\": \"7e5c3d3462bc4c50b5ddcc9bfc7323a646077757\", \"message_center_unittests\": \"f3fdfdae0554bcbe62fccdd0b05c6fff7c23c4df\", \"metrics_python_tests\": \"3af7da07ea324fe9bd3ce36ef6f07fe4928b4065\", \"midi_unittests\": \"3fbf0d629d30f805814534b523db6fc2b61aa843\", \"mojo_core_unittests\": \"995c0cfd53ecd51b939834ec986ab81873b81ef7\", \"mojo_unittests\": \"a10b34747be4b54b79e21bd6e130eb7c402fc424\", \"nacl_helper_nonsfi_unittests\": \"db7d2023af78ab9674c4ae353a274a4f09d04d85\", \"nacl_loader_unittests\": \"71db82221e30b995fee9e7e6280af3e920d3f261\", \"native_theme_unittests\": \"5d5b7dbd56ecf43f492f2e6a47097f8660a45d7f\", \"net_unittests\": \"e2f49c147c84fa8b423c3a2df9a03f1db71e8899\", \"openscreen_unittests\": \"30d5e2dcead3c01ecfedbc277ba56aa999c5a051\", \"pdf_unittests\": \"9e22f001f0a35bc80c83f15dc743fd84f6ec3ae6\", \"perfetto_unittests\": \"547c1e815a8f72a98dfeb5de2e2a5990239743c7\", \"ppapi_unittests\": \"4a3ebd8b2237f2d8b9ce9da6689353335ff23bc2\", \"printing_unittests\": \"a2b924a6dbd60a0fa6fa56df56ec843da70897f1\", \"remoting_unittests\": \"d75693c24758477d1713de32387395321c6b4088\", \"sandbox_linux_unittests\": \"121534da5e51fffc06146b5bdf6761784f1c1d6c\", \"service_manager_unittests\": \"a4b19acc743c64bec0d0b0da1864bdaee9925169\", \"services_unittests\": \"8d90e0f3c44f230bbe2874ec641ab2cd7ee66046\", \"shell_dialogs_unittests\": \"7b358b7fa7a4d1c39fd54dbd69f61230d7f101b7\", \"skia_unittests\": \"27547f259aa7fb5450261ada5f99297bc4ad0407\", \"snapshot_unittests\": \"9e5ed59a0cbdfeb4dbda75b8d95282a65188368d\", \"sql_unittests\": \"b2616fcf279dfd08b95b40eed60a673f555e2ae6\", \"storage_unittests\": \"5479104d7ba4378fc2ad00725c3fda6efb2d9984\", \"sync_integration_tests\": \"f3acc70d573c9dcac4463548bba91b4ee5d29b2b\", \"telemetry_gpu_unittests\": \"133ddc69a828378569256cf1ff10f9e2f452770f\", \"telemetry_perf_unittests\": \"c64985834d9a31a7de462a80d7d68479283534cc\", \"telemetry_unittests\": \"287cacdf9ba1360d8ab9d58c07c4b2b625731ada\", \"traffic_annotation_auditor_unittests\": \"d6aa416cd83f5edd5924ed0c8b5ac9c972dc4eec\", \"ui_base_unittests\": \"ecec8f97eb93f358dc78ec89db9a10793dc8ceeb\", \"ui_touch_selection_unittests\": \"4aa4d2969e5ce0faa3c936ca6dab0f022c1833f8\", \"unit_tests\": \"a136825861e31717244440b26600de2d69a9a0e6\", \"url_unittests\": \"e6e87f2bc320fb2872f90c7178d4c9407e46e3d1\", \"views_perftests\": \"a6b322c65103a5a181643133fd0a767c3ce18ceb\", \"views_unittests\": \"dad4a0faa497b7c3d26c36eeec8e8782cf1e8b58\", \"viz_unittests\": \"cf228477fd9244de2a5dfc723de58313f111a775\", \"vr_common_unittests\": \"c4c637785da484641c31e3ebcfe5cb27c872fd0e\", \"vr_pixeltests\": \"da39f0a59664569645a65d8f1b37ae9bcbf07703\", \"webdriver_wpt_tests\": \"db03ffd40d5d25128ad52bfcbcd89902fec8b537\", \"weblayer_browsertests\": \"1a6210965442bcc0d18388ff62bf3029cb866ac4\", \"weblayer_unittests\": \"b3be128f6e8cdef1b0198947e12cb643d5057c99\", \"wm_unittests\": \"0af054fbf1c73dc1c96ee718936ea651bc81a571\", \"wtf_unittests\": \"181765d7295b4ece108a42c96e22c04394504a8a\", \"x11_unittests\": \"66e6d6fe99df5dd9c1e667be469ceefe4f08881a\", \"xr_browser_tests\": \"73a88cb2d6e1e18f87351cb1f83560e0f5f5fb4b\", \"zlib_unittests\": \"b879485fda9fb74f3b79ef46caca44a329fe61c0\"}}, \"swarming\": {\"bot_dimensions\": {\"builderless\": [\"1\"], \"caches\": [\"builder_1565bd2e801a59db86c3cb29ff80b2e229b1f19a08963dbe4c2b49186438622b_v2\", \"builder_8851890e994e29b56fba2042f90feba99073c8e56d0ea67af5ee13ebe9f87cf6_v2\", \"builder_97b15bccca8d35086c1bc50eecf0b53d98289cdc65be75a287efcc384d1f34ed_v2\", \"builder_a1b9c6892397d61c3624774723419f5ae48fcf776e7d2304bd4682bf5cd4c049_v2\", \"builder_c18d585c17603559d8d68e3de2c6e12032537b56b99cb619aa84174b37006d15_v2\", \"builder_eb75bb97ad9a82e6e51bc242be3605b13562b7c1ffaba99d94159b9b70e03009_v2\", \"builder_f2d41554cc5e5ccdd409a1e3331deca1f73b654eb50c3540ea4abf5478e808d4_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-13-dhxs\"], \"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\": [\"5676-c76598c\"], \"ssd\": [\"0\"], \"zone\": [\"us\", \"us-central\", \"us-central1\", \"us-central1-b\"]}}}",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"started_ts": "1612665034333176",
"status": "COMPLETED",
"status_changed_ts": "1612669100806336",
"tags": [
"build_address:luci.chromium.ci/Linux Builder (dbg)/180343",
"builder:Linux Builder (dbg)",
"buildset:commit/git/09af0a3aec46082ead9d78c81b2ce0f423e4c772",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/09af0a3aec46082ead9d78c81b2ce0f423e4c772",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9021424195489626032",
"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/8855994133490180928/+/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:5193041ddd706b10",
"user_agent:luci-scheduler"
],
"updated_ts": "1612669100819567",
"url": "https://ci.chromium.org/b/8855994133490180928",
"utcnow_ts": "1612669101516077"
}
}
[03:38:21.528] Invocation finished in 1h43m51.964753112s with status SUCCEEDED