[21:59:16.393] New invocation is queued and will start shortly
[21:59:17.516] Starting the invocation (attempt 1)
[21:59:17.553] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[21:59:17.553] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[21:59:17.553] Buildbucket request:
{
"bucket": "luci.chromium.ci",
"client_operation_id": "9024066306266055584",
"parameters_json": "{\"builder_name\":\"linux-chromeos-dbg\",\"properties\":{\"branch\":\"refs/heads/master\",\"repository\":\"https://chromium.googlesource.com/chromium/src\",\"revision\":\"c46fe077f9020d73d0d324430e08fa6ba670bd50\"}}",
"pubsub_callback": {
"auth_token": "...",
"topic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
},
"tags": [
"builder:linux-chromeos-dbg",
"scheduler_invocation_id:9024066306266055584",
"scheduler_job_id:chromium/linux-chromeos-dbg",
"user_agent:luci-scheduler",
"buildset:commit/git/c46fe077f9020d73d0d324430e08fa6ba670bd50",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/c46fe077f9020d73d0d324430e08fa6ba670bd50",
"gitiles_ref:refs/heads/master"
]
}
[21:59:18.867] Buildbucket response:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "PROD",
"created_by": "project:chromium",
"created_ts": "1610143157646878",
"id": "8858636244286460768",
"parameters_json": "{\"builder_name\": \"linux-chromeos-dbg\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"c46fe077f9020d73d0d324430e08fa6ba670bd50\"}}",
"project": "chromium",
"result_details_json": "{\"properties\": {}}",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"status": "SCHEDULED",
"status_changed_ts": "1610143158399400",
"tags": [
"build_address:luci.chromium.ci/linux-chromeos-dbg/22121",
"builder:linux-chromeos-dbg",
"buildset:commit/git/c46fe077f9020d73d0d324430e08fa6ba670bd50",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/c46fe077f9020d73d0d324430e08fa6ba670bd50",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9024066306266055584",
"scheduler_job_id:chromium/linux-chromeos-dbg",
"swarming_hostname:chromium-swarm.appspot.com",
"swarming_tag:log_location:logdog://logs.chromium.org/chromium/buildbucket/cr-buildbucket.appspot.com/8858636244286460768/+/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": "1610143158399580",
"url": "https://ci.chromium.org/b/8858636244286460768",
"utcnow_ts": "1610143158797278"
}
}
[21:59:18.867] Task URL: https://ci.chromium.org/b/8858636244286460768
[21:59:18.867] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9024066306266055584:2:0) after 1m0s
[21:59:19.944] Received PubSub notification, asking Buildbucket for the build status
[21:59:20.026] Build 8858636244286460768: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:00:19.007] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9024066306266055584:2:0)
[22:00:19.007] Timer tick, asking Buildbucket for the build status
[22:00:19.175] Build 8858636244286460768: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:00:19.176] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9024066306266055584:4:0) after 1m0s
[22:01:19.229] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9024066306266055584:4:0)
[22:01:19.229] Timer tick, asking Buildbucket for the build status
[22:01:19.297] Build 8858636244286460768: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:01:19.297] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9024066306266055584:5:0) after 1m0s
[22:02:19.427] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9024066306266055584:5:0)
[22:02:19.427] Timer tick, asking Buildbucket for the build status
[22:02:19.590] Build 8858636244286460768: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:02:19.591] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9024066306266055584:6:0) after 1m0s
[22:03:19.614] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9024066306266055584:6:0)
[22:03:19.614] Timer tick, asking Buildbucket for the build status
[22:03:20.034] Build 8858636244286460768: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:03:20.034] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9024066306266055584:7:0) after 1m0s
[22:04:20.051] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9024066306266055584:7:0)
[22:04:20.051] Timer tick, asking Buildbucket for the build status
[22:04:20.161] Build 8858636244286460768: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:04:20.161] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9024066306266055584:8:0) after 1m0s
[22:05:20.285] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9024066306266055584:8:0)
[22:05:20.285] Timer tick, asking Buildbucket for the build status
[22:05:20.406] Build 8858636244286460768: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:05:20.406] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9024066306266055584:9:0) after 1m0s
[22:06:20.426] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9024066306266055584:9:0)
[22:06:20.426] Timer tick, asking Buildbucket for the build status
[22:06:20.499] Build 8858636244286460768: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:06:20.499] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9024066306266055584:10:0) after 1m0s
[22:07:20.516] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9024066306266055584:10:0)
[22:07:20.516] Timer tick, asking Buildbucket for the build status
[22:07:20.599] Build 8858636244286460768: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:07:20.599] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9024066306266055584:11:0) after 1m0s
[22:08:20.617] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9024066306266055584:11:0)
[22:08:20.617] Timer tick, asking Buildbucket for the build status
[22:08:20.687] Build 8858636244286460768: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:08:20.687] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9024066306266055584:12:0) after 1m0s
[22:09:20.662] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9024066306266055584:12:0)
[22:09:20.662] Timer tick, asking Buildbucket for the build status
[22:09:20.783] Build 8858636244286460768: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:09:20.783] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9024066306266055584:13:0) after 1m0s
[22:10:20.842] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9024066306266055584:13:0)
[22:10:20.842] Timer tick, asking Buildbucket for the build status
[22:10:20.910] Build 8858636244286460768: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:10:20.910] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9024066306266055584:14:0) after 1m0s
[22:11:21.016] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9024066306266055584:14:0)
[22:11:21.016] Timer tick, asking Buildbucket for the build status
[22:11:21.094] Build 8858636244286460768: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:11:21.094] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9024066306266055584:15:0) after 1m0s
[22:12:21.186] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9024066306266055584:15:0)
[22:12:21.186] Timer tick, asking Buildbucket for the build status
[22:12:21.283] Build 8858636244286460768: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:12:21.283] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9024066306266055584:16:0) after 1m0s
[22:13:21.349] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9024066306266055584:16:0)
[22:13:21.349] Timer tick, asking Buildbucket for the build status
[22:13:21.436] Build 8858636244286460768: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:13:21.436] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9024066306266055584:17:0) after 1m0s
[22:14:21.508] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9024066306266055584:17:0)
[22:14:21.508] Timer tick, asking Buildbucket for the build status
[22:14:21.633] Build 8858636244286460768: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:14:21.633] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9024066306266055584:18:0) after 1m0s
[22:15:21.640] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9024066306266055584:18:0)
[22:15:21.640] Timer tick, asking Buildbucket for the build status
[22:15:22.133] Build 8858636244286460768: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:15:22.133] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9024066306266055584:19:0) after 1m0s
[22:16:22.186] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9024066306266055584:19:0)
[22:16:22.186] Timer tick, asking Buildbucket for the build status
[22:16:22.342] Build 8858636244286460768: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:16:22.342] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9024066306266055584:20:0) after 1m0s
[22:17:22.458] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9024066306266055584:20:0)
[22:17:22.458] Timer tick, asking Buildbucket for the build status
[22:17:22.528] Build 8858636244286460768: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:17:22.528] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9024066306266055584:21:0) after 1m0s
[22:18:22.554] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9024066306266055584:21:0)
[22:18:22.554] Timer tick, asking Buildbucket for the build status
[22:18:22.718] Build 8858636244286460768: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:18:22.718] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9024066306266055584:22:0) after 1m0s
[22:19:22.756] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9024066306266055584:22:0)
[22:19:22.757] Timer tick, asking Buildbucket for the build status
[22:19:23.113] Build 8858636244286460768: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:19:23.113] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9024066306266055584:23:0) after 1m0s
[22:20:23.136] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9024066306266055584:23:0)
[22:20:23.136] Timer tick, asking Buildbucket for the build status
[22:20:23.513] Build 8858636244286460768: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:20:23.514] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9024066306266055584:24:0) after 1m0s
[22:21:23.540] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9024066306266055584:24:0)
[22:21:23.540] Timer tick, asking Buildbucket for the build status
[22:21:23.748] Build 8858636244286460768: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:21:23.748] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9024066306266055584:25:0) after 1m0s
[22:22:23.797] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9024066306266055584:25:0)
[22:22:23.797] Timer tick, asking Buildbucket for the build status
[22:22:23.998] Build 8858636244286460768: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:22:23.998] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9024066306266055584:26:0) after 1m0s
[22:23:24.025] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9024066306266055584:26:0)
[22:23:24.025] Timer tick, asking Buildbucket for the build status
[22:23:24.123] Build 8858636244286460768: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:23:24.123] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9024066306266055584:27:0) after 1m0s
[22:24:24.154] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9024066306266055584:27:0)
[22:24:24.154] Timer tick, asking Buildbucket for the build status
[22:24:24.535] Build 8858636244286460768: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:24:24.535] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9024066306266055584:28:0) after 1m0s
[22:25:24.598] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9024066306266055584:28:0)
[22:25:24.598] Timer tick, asking Buildbucket for the build status
[22:25:24.686] Build 8858636244286460768: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:25:24.686] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9024066306266055584:29:0) after 1m0s
[22:26:24.740] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9024066306266055584:29:0)
[22:26:24.740] Timer tick, asking Buildbucket for the build status
[22:26:25.061] Build 8858636244286460768: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:26:25.061] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9024066306266055584:30:0) after 1m0s
[22:27:25.082] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9024066306266055584:30:0)
[22:27:25.082] Timer tick, asking Buildbucket for the build status
[22:27:25.165] Build 8858636244286460768: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:27:25.165] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9024066306266055584:31:0) after 1m0s
[22:28:25.234] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9024066306266055584:31:0)
[22:28:25.234] Timer tick, asking Buildbucket for the build status
[22:28:25.285] Build 8858636244286460768: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:28:25.285] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9024066306266055584:32:0) after 1m0s
[22:29:25.333] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9024066306266055584:32:0)
[22:29:25.333] Timer tick, asking Buildbucket for the build status
[22:29:25.460] Build 8858636244286460768: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:29:25.460] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9024066306266055584:33:0) after 1m0s
[22:30:25.539] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9024066306266055584:33:0)
[22:30:25.539] Timer tick, asking Buildbucket for the build status
[22:30:25.700] Build 8858636244286460768: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:30:25.700] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9024066306266055584:34:0) after 1m0s
[22:31:25.724] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9024066306266055584:34:0)
[22:31:25.724] Timer tick, asking Buildbucket for the build status
[22:31:25.809] Build 8858636244286460768: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:31:25.809] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9024066306266055584:35:0) after 1m0s
[22:32:25.843] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9024066306266055584:35:0)
[22:32:25.843] Timer tick, asking Buildbucket for the build status
[22:32:25.944] Build 8858636244286460768: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:32:25.945] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9024066306266055584:36:0) after 1m0s
[22:33:25.968] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9024066306266055584:36:0)
[22:33:25.968] Timer tick, asking Buildbucket for the build status
[22:33:26.051] Build 8858636244286460768: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:33:26.051] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9024066306266055584:37:0) after 1m0s
[22:34:26.098] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9024066306266055584:37:0)
[22:34:26.098] Timer tick, asking Buildbucket for the build status
[22:34:26.218] Build 8858636244286460768: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:34:26.218] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9024066306266055584:38:0) after 1m0s
[22:35:26.264] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9024066306266055584:38:0)
[22:35:26.264] Timer tick, asking Buildbucket for the build status
[22:35:26.359] Build 8858636244286460768: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:35:26.359] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9024066306266055584:39:0) after 1m0s
[22:36:26.365] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9024066306266055584:39:0)
[22:36:26.366] Timer tick, asking Buildbucket for the build status
[22:36:26.939] Build 8858636244286460768: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:36:26.939] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9024066306266055584:40:0) after 1m0s
[22:37:27.112] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9024066306266055584:40:0)
[22:37:27.112] Timer tick, asking Buildbucket for the build status
[22:37:27.361] Build 8858636244286460768: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:37:27.361] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9024066306266055584:41:0) after 1m0s
[22:38:27.411] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9024066306266055584:41:0)
[22:38:27.411] Timer tick, asking Buildbucket for the build status
[22:38:27.796] Build 8858636244286460768: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:38:27.796] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9024066306266055584:42:0) after 1m0s
[22:39:27.891] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9024066306266055584:42:0)
[22:39:27.891] Timer tick, asking Buildbucket for the build status
[22:39:28.009] Build 8858636244286460768: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:39:28.009] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9024066306266055584:43:0) after 1m0s
[22:40:28.059] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9024066306266055584:43:0)
[22:40:28.059] Timer tick, asking Buildbucket for the build status
[22:40:28.260] Build 8858636244286460768: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:40:28.260] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9024066306266055584:44:0) after 1m0s
[22:41:28.273] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9024066306266055584:44:0)
[22:41:28.273] Timer tick, asking Buildbucket for the build status
[22:41:28.428] Build 8858636244286460768: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:41:28.428] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9024066306266055584:45:0) after 1m0s
[22:42:28.524] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9024066306266055584:45:0)
[22:42:28.524] Timer tick, asking Buildbucket for the build status
[22:42:28.619] Build 8858636244286460768: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:42:28.619] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9024066306266055584:46:0) after 1m0s
[22:43:28.743] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9024066306266055584:46:0)
[22:43:28.743] Timer tick, asking Buildbucket for the build status
[22:43:28.818] Build 8858636244286460768: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:43:28.818] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9024066306266055584:47:0) after 1m0s
[22:44:28.946] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9024066306266055584:47:0)
[22:44:28.946] Timer tick, asking Buildbucket for the build status
[22:44:29.074] Build 8858636244286460768: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:44:29.074] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9024066306266055584:48:0) after 1m0s
[22:45:29.103] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9024066306266055584:48:0)
[22:45:29.103] Timer tick, asking Buildbucket for the build status
[22:45:29.229] Build 8858636244286460768: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:45:29.229] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9024066306266055584:49:0) after 1m0s
[22:46:29.271] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9024066306266055584:49:0)
[22:46:29.271] Timer tick, asking Buildbucket for the build status
[22:46:29.404] Build 8858636244286460768: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:46:29.404] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9024066306266055584:50:0) after 1m0s
[22:47:29.490] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9024066306266055584:50:0)
[22:47:29.490] Timer tick, asking Buildbucket for the build status
[22:47:29.604] Build 8858636244286460768: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:47:29.604] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9024066306266055584:51:0) after 1m0s
[22:48:29.639] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9024066306266055584:51:0)
[22:48:29.639] Timer tick, asking Buildbucket for the build status
[22:48:30.011] Build 8858636244286460768: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:48:30.011] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9024066306266055584:52:0) after 1m0s
[22:49:30.108] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9024066306266055584:52:0)
[22:49:30.108] Timer tick, asking Buildbucket for the build status
[22:49:30.251] Build 8858636244286460768: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:49:30.251] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9024066306266055584:53:0) after 1m0s
[22:50:30.349] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9024066306266055584:53:0)
[22:50:30.349] Timer tick, asking Buildbucket for the build status
[22:50:30.510] Build 8858636244286460768: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:50:30.510] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9024066306266055584:54:0) after 1m0s
[22:51:30.611] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9024066306266055584:54:0)
[22:51:30.611] Timer tick, asking Buildbucket for the build status
[22:51:30.746] Build 8858636244286460768: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:51:30.746] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9024066306266055584:55:0) after 1m0s
[22:52:30.820] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9024066306266055584:55:0)
[22:52:30.820] Timer tick, asking Buildbucket for the build status
[22:52:30.902] Build 8858636244286460768: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:52:30.902] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9024066306266055584:56:0) after 1m0s
[22:53:30.924] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9024066306266055584:56:0)
[22:53:30.924] Timer tick, asking Buildbucket for the build status
[22:53:31.109] Build 8858636244286460768: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:53:31.109] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9024066306266055584:57:0) after 1m0s
[22:54:31.132] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9024066306266055584:57:0)
[22:54:31.132] Timer tick, asking Buildbucket for the build status
[22:54:31.548] Build 8858636244286460768: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:54:31.548] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9024066306266055584:58:0) after 1m0s
[22:55:31.586] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9024066306266055584:58:0)
[22:55:31.586] Timer tick, asking Buildbucket for the build status
[22:55:31.689] Build 8858636244286460768: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:55:31.689] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9024066306266055584:59:0) after 1m0s
[22:56:31.756] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9024066306266055584:59:0)
[22:56:31.756] Timer tick, asking Buildbucket for the build status
[22:56:31.833] Build 8858636244286460768: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:56:31.833] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9024066306266055584:60:0) after 1m0s
[22:57:31.850] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9024066306266055584:60:0)
[22:57:31.850] Timer tick, asking Buildbucket for the build status
[22:57:32.124] Build 8858636244286460768: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:57:32.124] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9024066306266055584:61:0) after 1m0s
[22:58:32.199] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9024066306266055584:61:0)
[22:58:32.199] Timer tick, asking Buildbucket for the build status
[22:58:32.336] Build 8858636244286460768: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:58:32.337] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9024066306266055584:62:0) after 1m0s
[22:59:32.324] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9024066306266055584:62:0)
[22:59:32.324] Timer tick, asking Buildbucket for the build status
[22:59:32.429] Build 8858636244286460768: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:59:32.429] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9024066306266055584:63:0) after 1m0s
[23:00:32.453] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9024066306266055584:63:0)
[23:00:32.453] Timer tick, asking Buildbucket for the build status
[23:00:32.738] Build 8858636244286460768: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:00:32.738] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9024066306266055584:64:0) after 1m0s
[23:01:32.815] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9024066306266055584:64:0)
[23:01:32.815] Timer tick, asking Buildbucket for the build status
[23:01:33.024] Build 8858636244286460768: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:01:33.024] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9024066306266055584:65:0) after 1m0s
[23:02:33.066] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9024066306266055584:65:0)
[23:02:33.066] Timer tick, asking Buildbucket for the build status
[23:02:33.398] Build 8858636244286460768: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:02:33.398] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9024066306266055584:66:0) after 1m0s
[23:03:33.449] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9024066306266055584:66:0)
[23:03:33.449] Timer tick, asking Buildbucket for the build status
[23:03:33.635] Build 8858636244286460768: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:03:33.635] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9024066306266055584:67:0) after 1m0s
[23:04:33.697] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9024066306266055584:67:0)
[23:04:33.697] Timer tick, asking Buildbucket for the build status
[23:04:34.454] Build 8858636244286460768: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:04:34.454] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9024066306266055584:68:0) after 1m0s
[23:05:34.505] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9024066306266055584:68:0)
[23:05:34.505] Timer tick, asking Buildbucket for the build status
[23:05:34.940] Build 8858636244286460768: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:05:34.940] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9024066306266055584:69:0) after 1m0s
[23:06:34.943] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9024066306266055584:69:0)
[23:06:34.943] Timer tick, asking Buildbucket for the build status
[23:06:35.018] Build 8858636244286460768: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:06:35.018] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9024066306266055584:70:0) after 1m0s
[23:07:35.067] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9024066306266055584:70:0)
[23:07:35.067] Timer tick, asking Buildbucket for the build status
[23:07:35.222] Build 8858636244286460768: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:07:35.222] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9024066306266055584:71:0) after 1m0s
[23:08:35.255] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9024066306266055584:71:0)
[23:08:35.255] Timer tick, asking Buildbucket for the build status
[23:08:35.347] Build 8858636244286460768: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:08:35.347] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9024066306266055584:72:0) after 1m0s
[23:09:35.372] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9024066306266055584:72:0)
[23:09:35.372] Timer tick, asking Buildbucket for the build status
[23:09:35.937] Build 8858636244286460768: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:09:35.937] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9024066306266055584:73:0) after 1m0s
[23:10:35.953] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9024066306266055584:73:0)
[23:10:35.953] Timer tick, asking Buildbucket for the build status
[23:10:36.346] Build 8858636244286460768: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:10:36.346] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9024066306266055584:74:0) after 1m0s
[23:11:36.393] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9024066306266055584:74:0)
[23:11:36.393] Timer tick, asking Buildbucket for the build status
[23:11:36.632] Build 8858636244286460768: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:11:36.632] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9024066306266055584:75:0) after 1m0s
[23:12:36.690] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9024066306266055584:75:0)
[23:12:36.690] Timer tick, asking Buildbucket for the build status
[23:12:36.767] Build 8858636244286460768: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:12:36.767] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9024066306266055584:76:0) after 1m0s
[23:13:36.801] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9024066306266055584:76:0)
[23:13:36.801] Timer tick, asking Buildbucket for the build status
[23:13:36.885] Build 8858636244286460768: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:13:36.885] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9024066306266055584:77:0) after 1m0s
[23:14:37.484] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9024066306266055584:77:0)
[23:14:37.484] Timer tick, asking Buildbucket for the build status
[23:14:37.800] Build 8858636244286460768: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:14:37.800] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9024066306266055584:78:0) after 1m0s
[23:15:37.839] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9024066306266055584:78:0)
[23:15:37.839] Timer tick, asking Buildbucket for the build status
[23:15:37.964] Build 8858636244286460768: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:15:37.964] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9024066306266055584:79:0) after 1m0s
[23:16:37.961] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9024066306266055584:79:0)
[23:16:37.961] Timer tick, asking Buildbucket for the build status
[23:16:38.023] Build 8858636244286460768: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:16:38.023] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9024066306266055584:80:0) after 1m0s
[23:17:38.067] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9024066306266055584:80:0)
[23:17:38.067] Timer tick, asking Buildbucket for the build status
[23:17:38.144] Build 8858636244286460768: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:17:38.144] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9024066306266055584:81:0) after 1m0s
[23:18:38.432] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9024066306266055584:81:0)
[23:18:38.432] Timer tick, asking Buildbucket for the build status
[23:18:38.512] Build 8858636244286460768: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:18:38.512] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9024066306266055584:82:0) after 1m0s
[23:19:38.545] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9024066306266055584:82:0)
[23:19:38.545] Timer tick, asking Buildbucket for the build status
[23:19:38.755] Build 8858636244286460768: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:19:38.755] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9024066306266055584:83:0) after 1m0s
[23:20:38.852] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9024066306266055584:83:0)
[23:20:38.852] Timer tick, asking Buildbucket for the build status
[23:20:39.047] Build 8858636244286460768: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:20:39.047] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9024066306266055584:84:0) after 1m0s
[23:21:39.203] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9024066306266055584:84:0)
[23:21:39.203] Timer tick, asking Buildbucket for the build status
[23:21:39.286] Build 8858636244286460768: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:21:39.287] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9024066306266055584:85:0) after 1m0s
[23:22:39.398] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9024066306266055584:85:0)
[23:22:39.398] Timer tick, asking Buildbucket for the build status
[23:22:39.487] Build 8858636244286460768: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:22:39.487] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9024066306266055584:86:0) after 1m0s
[23:23:39.515] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9024066306266055584:86:0)
[23:23:39.515] Timer tick, asking Buildbucket for the build status
[23:23:39.815] Build 8858636244286460768: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:23:39.815] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9024066306266055584:87:0) after 1m0s
[23:24:39.824] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9024066306266055584:87:0)
[23:24:39.824] Timer tick, asking Buildbucket for the build status
[23:24:40.213] Build 8858636244286460768: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:24:40.213] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9024066306266055584:88:0) after 1m0s
[23:25:40.301] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9024066306266055584:88:0)
[23:25:40.301] Timer tick, asking Buildbucket for the build status
[23:25:40.397] Build 8858636244286460768: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:25:40.397] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9024066306266055584:89:0) after 1m0s
[23:26:40.524] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9024066306266055584:89:0)
[23:26:40.524] Timer tick, asking Buildbucket for the build status
[23:26:40.603] Build 8858636244286460768: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:26:40.603] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9024066306266055584:90:0) after 1m0s
[23:27:40.728] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9024066306266055584:90:0)
[23:27:40.728] Timer tick, asking Buildbucket for the build status
[23:27:40.970] Build 8858636244286460768: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:27:40.970] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9024066306266055584:91:0) after 1m0s
[23:28:41.037] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9024066306266055584:91:0)
[23:28:41.037] Timer tick, asking Buildbucket for the build status
[23:28:41.498] Build 8858636244286460768: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:28:41.498] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9024066306266055584:92:0) after 1m0s
[23:29:41.670] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9024066306266055584:92:0)
[23:29:41.670] Timer tick, asking Buildbucket for the build status
[23:29:41.838] Build 8858636244286460768: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:29:41.838] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9024066306266055584:93:0) after 1m0s
[23:30:41.892] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9024066306266055584:93:0)
[23:30:41.892] Timer tick, asking Buildbucket for the build status
[23:30:41.972] Build 8858636244286460768: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:30:41.972] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9024066306266055584:94:0) after 1m0s
[23:31:42.024] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9024066306266055584:94:0)
[23:31:42.024] Timer tick, asking Buildbucket for the build status
[23:31:42.112] Build 8858636244286460768: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:31:42.112] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9024066306266055584:95:0) after 1m0s
[23:32:42.154] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9024066306266055584:95:0)
[23:32:42.154] Timer tick, asking Buildbucket for the build status
[23:32:42.224] Build 8858636244286460768: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:32:42.224] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9024066306266055584:96:0) after 1m0s
[23:33:42.320] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9024066306266055584:96:0)
[23:33:42.320] Timer tick, asking Buildbucket for the build status
[23:33:42.406] Build 8858636244286460768: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:33:42.406] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9024066306266055584:97:0) after 1m0s
[23:34:42.433] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9024066306266055584:97:0)
[23:34:42.433] Timer tick, asking Buildbucket for the build status
[23:34:42.578] Build 8858636244286460768: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:34:42.578] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9024066306266055584:98:0) after 1m0s
[23:35:42.690] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9024066306266055584:98:0)
[23:35:42.690] Timer tick, asking Buildbucket for the build status
[23:35:42.817] Build 8858636244286460768: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:35:42.817] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9024066306266055584:99:0) after 1m0s
[23:36:42.814] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9024066306266055584:99:0)
[23:36:42.814] Timer tick, asking Buildbucket for the build status
[23:36:43.161] Build 8858636244286460768: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:36:43.161] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9024066306266055584:100:0) after 1m0s
[23:37:43.234] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9024066306266055584:100:0)
[23:37:43.234] Timer tick, asking Buildbucket for the build status
[23:37:43.330] Build 8858636244286460768: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:37:43.330] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9024066306266055584:101:0) after 1m0s
[23:38:42.847] Received PubSub notification, asking Buildbucket for the build status
[23:38:42.928] Build 8858636244286460768: status "COMPLETED", result "SUCCESS", failure_reason "", cancelation_reason ""
[23:38:42.928] Buildbucket build:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "PROD",
"completed_ts": "1610149121780596",
"created_by": "project:chromium",
"created_ts": "1610143157646878",
"id": "8858636244286460768",
"parameters_json": "{\"builder_name\": \"linux-chromeos-dbg\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"c46fe077f9020d73d0d324430e08fa6ba670bd50\"}}",
"project": "chromium",
"result": "SUCCESS",
"result_details_json": "{\"properties\": {\"$build/goma\": {\"enable_ats\": true, \"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\": \"c46fe077f9020d73d0d324430e08fa6ba670bd50\", \"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-65-a7fn\", \"branch\": \"refs/heads/master\", \"builder_group\": \"chromium.chromiumos\", \"buildername\": \"linux-chromeos-dbg\", \"buildnumber\": 22121, \"got_angle_revision\": \"fa449cf3b0d00e411a47039408fd31389d79beb0\", \"got_dawn_revision\": \"c4efeef8333435ef770fdf72f3ffdca9d7d19bfc\", \"got_nacl_revision\": \"d28e6c52e05ea2f1b3231de473b6dbfce59bce40\", \"got_revision\": \"c46fe077f9020d73d0d324430e08fa6ba670bd50\", \"got_revision_cp\": \"refs/heads/master@{#841667}\", \"got_swarming_client_revision\": \"1a072711d4388c62e02480fabc26c68c24494be9\", \"got_swiftshader_revision\": \"2e89a70e3561793871480d971f4e958d04faf37a\", \"got_v8_revision\": \"6bb19707a491fda7a4dc04dbbeb188d48f6d641d\", \"got_v8_revision_cp\": \"refs/heads/8.9.225@{#1}\", \"got_webrtc_revision\": \"644164c9c4b368d96bde2b3dcce68c57c2b7f749\", \"got_webrtc_revision_cp\": \"refs/heads/master@{#32926}\", \"isolate_server\": \"https://isolateserver.appspot.com\", \"mirrored_builders\": [\"tryserver.chromium.chromiumos:linux-chromeos-dbg\", \"tryserver.chromium.chromiumos:linux-chromeos-compile-dbg\"], \"path_config\": \"generic\", \"recipe\": \"chromium\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"c46fe077f9020d73d0d324430e08fa6ba670bd50\", \"swarm_hashes_refs/heads/master(at){#841667}_without_patch\": {\"absl_hardening_tests\": \"e11c45dcc8d9566def067069bb1746d83227ad64\", \"accessibility_unittests\": \"9ed26cba33373d004697eb787d06e921851754f2\", \"angle_unittests\": \"126a0745bc588d31cda82259eb9997f4a51fe2ee\", \"app_list_unittests\": \"38882e51262dac4a6cc2980d16851f76a800d64f\", \"app_shell_unittests\": \"f805f3a63d95eae4a7b1be22eff7d08d2db79dc7\", \"ash_unittests\": \"76457eb8590853fe6dabbea444ae30269a01cd5f\", \"aura_unittests\": \"e2bb66059dc27a2d168b8429cb82e561e16db97e\", \"base_unittests\": \"d1351522bc01749c7f394b2877d6737ba13c060e\", \"base_util_unittests\": \"19004d8650136779af0dbe57147b28dec2071de0\", \"blink_common_unittests\": \"49b360bba1008df9d92667e3f8a8ec9ae0acdad0\", \"blink_fuzzer_unittests\": \"48d14eae69d8b3f6e344b197801c617da064db03\", \"blink_heap_unittests\": \"f5931dcd9c653f04efbddce915254f9e0ccd6f06\", \"blink_platform_unittests\": \"fcda6f6f7585a39bc973e949bbb6716d46d36348\", \"blink_unittests\": \"3d45b89ce396fabe979f829d2b8d4b4112400a81\", \"boringssl_crypto_tests\": \"ce4fec9be5bdc0b4226fd7210a91147869c0300b\", \"boringssl_ssl_tests\": \"4a08bbfb79aec42ffb32a4d2f99e94e104f162f4\", \"browser_tests\": \"537e3399ae08d1590d0000bfd8057905679e9a7e\", \"capture_unittests\": \"d1a555d4263dcdee8411730e1ce2a2f094391243\", \"cast_unittests\": \"c3e1deed456450613515667973ee9b0b2f2f0a19\", \"cc_unittests\": \"df977c4859012c66c274016176025c90d212f79b\", \"chrome_app_unittests\": \"953bae50c299929a6a6ae9fe77d0fc75ae6c0e5b\", \"chromedriver_unittests\": \"aa180f7f84ddf8a0b0cf061615c8eeb7fab9b5e1\", \"chromeos_components_unittests\": \"f1676bab4ceca1dcf84ab51cb0ddbe81350c8836\", \"chromeos_unittests\": \"c98b7536b4275d482c99e0757551cdf07ea118aa\", \"components_browsertests\": \"0941857b2691155b8738367ee23d4d16ee1eac40\", \"components_unittests\": \"89e1f5198cdd5481c4578417d20328fa2eabaf84\", \"compositor_unittests\": \"2136cb90682c7cc02cdcbae6b5f7b6a602bd172c\", \"content_browsertests\": \"1dc236d5e615762a0dd63e5980c69fc46e7ecb53\", \"content_unittests\": \"4e40f667330bc01529764c6208105f64c36b0932\", \"crashpad_tests\": \"02ce5fce80dc21a5ef9068940e5662d492c977bb\", \"crypto_unittests\": \"979f4f305df546e93ed509a1eb46946db8bb25b0\", \"dbus_unittests\": \"668ec14815522b1d585b0f9880b1d4408c2f2685\", \"device_unittests\": \"baa83561291bc57aa8fdada8801032db45217a20\", \"display_unittests\": \"b4fb1eec0417ce59ef24d56c4ce7040abb160737\", \"events_unittests\": \"728cb4ea1af80ab591a1abdfb13d28a27bf05402\", \"exo_unittests\": \"147a6b0723da03b40d68a8cb2961f65b910c1e09\", \"extensions_browsertests\": \"9377f28c4d83300ac947420d0a3d4d4516f12257\", \"extensions_unittests\": \"01649c223fde6ddb2418053afda574c2afd2b15a\", \"filesystem_service_unittests\": \"3ebacc0a079f4f9d225921f8fe1afa3b2830fa69\", \"gcm_unit_tests\": \"104ea2ce939052d30b57da6bcf19b9ac6b18879a\", \"gfx_unittests\": \"03e38675e06a8b6474b8ce5b23c21a20c108bfbd\", \"gin_unittests\": \"a7d7710446f3d210957f7e4073a998673acafb7c\", \"gl_unittests_ozone\": \"e45665144d387f55387bd5b74b0c79407ede7edd\", \"google_apis_unittests\": \"3b11fccfac4a16ef3d71e79cf89fd32dd16dae4e\", \"gpu_unittests\": \"6bb70e7ccb982ee4722547cb9d4a7a306740cbe4\", \"gwp_asan_unittests\": \"96bfc32b9dc3c414dfa7c08d6efbde43dfd592c2\", \"interactive_ui_tests\": \"fdc784ecea10c78f6ff9155c649d37bd0964f586\", \"ipc_tests\": \"c5440bca8e4617e89a692e691532e6a4c7fe8c91\", \"jingle_unittests\": \"e637b6dcdcc8dd6898cd494d8464019ee702aab7\", \"keyboard_unittests\": \"51690e7a48ab5ea167144df87006b5df98c68a3a\", \"latency_unittests\": \"8973f7f2766eb71e8530b1cf5e7b1a014e1d9fe5\", \"libjingle_xmpp_unittests\": \"f98a0a63e4d7ccc0301c1b307dd0563f165632fe\", \"liburlpattern_unittests\": \"5dd657429cca47277260bc5a2166753a1ff5ecdb\", \"media_blink_unittests\": \"d44a6292145ea4bed331b8c83499fec2931079f7\", \"media_unittests\": \"528c733e4b58f4cff0f331010463e597ffb30e32\", \"message_center_unittests\": \"7691329334e1e669e7c454c6bc293de1f396e33e\", \"midi_unittests\": \"076415e58654cc7a122ae8fe6199602864e64296\", \"mojo_core_unittests\": \"21ee761ba4ddc248566cf055de702d9ebb11dc45\", \"mojo_unittests\": \"f70df340efefb41baa8618327042947e520432b4\", \"nacl_helper_nonsfi_unittests\": \"b6864c00605671ba6877e416188da93a7e86564b\", \"nacl_loader_unittests\": \"ddd3b2ddbfb0bcb7e11318027de1acfbed00d93f\", \"native_theme_unittests\": \"ab2c20f076d717561ccc51d5b31eece9e6d70b05\", \"net_unittests\": \"f469cd70dec99249d12199ed6a2c4c4da9b5e201\", \"ozone_gl_unittests\": \"4279549cd33c3f4832b098f4bd65fa9d18fa90a0\", \"ozone_unittests\": \"94ec40fefb211487250eb87a01e988ca940dbddb\", \"ozone_x11_unittests\": \"9bcfccc6b4c9b5312ce36550665b75af14030d28\", \"pdf_unittests\": \"023f1e84c36c004b27a79418c29f339ce95270b3\", \"perfetto_unittests\": \"c3242eae739a10a3d74f693f47a6215aa7026a07\", \"ppapi_unittests\": \"1c1983af59f8ae455b9454c35a35ab70e308405f\", \"printing_unittests\": \"439798eb5aeb4c741505ef489d0287781e56f42f\", \"remoting_unittests\": \"93a3eeffbbca2723418d649fa3e15ae74a084cb4\", \"sandbox_linux_unittests\": \"82519b032bd1c6792051b79d1722eac851717489\", \"service_manager_unittests\": \"efa462070d19278ffd259d1c148d7bb69d18a17e\", \"services_unittests\": \"abec6e8e0910dd1e2850430c7d19cee18b896c0d\", \"shell_dialogs_unittests\": \"64e9ba52085af08e9c90e30c189dccbef8e4bad9\", \"shell_encryption_unittests\": \"93ca789b2a3354eabb282b1b88ee351959f1ae54\", \"skia_unittests\": \"3db970f2bcd0cad2c4d1491ca4c93b2cfa0549ef\", \"snapshot_unittests\": \"31d2686dd3938d36ff97cbaafe05e088d62d227c\", \"sql_unittests\": \"fccbb58955d88fd42749eb781583c077f041e34a\", \"storage_unittests\": \"cf7bc70149a6b47ae1f1b2b2112b377224917655\", \"sync_integration_tests\": \"62c94f8a078546c1f7a32458b0cd60568effd3e2\", \"traffic_annotation_auditor_unittests\": \"a4a360d96dbc2c612fc400b40b12342434046956\", \"ui_base_unittests\": \"4c5941c3e24279a95ef13e2f1aef2cd903e45208\", \"ui_chromeos_unittests\": \"ada82c04fa5987717506eaee8eb035ee90996740\", \"ui_touch_selection_unittests\": \"21ff3ced0c620a89d6d701fe3ed6b7d7248726c6\", \"unit_tests\": \"b0da85972cf143b3e95aa176ffa0f8d3f96e1d4f\", \"url_unittests\": \"d452a2aed0954a99000b11c7ef202132d0688461\", \"usage_time_limit_unittests\": \"3b343d92d2e7ae742d59d2280912bb0c461be907\", \"views_unittests\": \"04c47f385c3b66481be6d59f67276ba6db791984\", \"viz_unittests\": \"d50a07a1c66b1cbf3529347a478cb532d0c04bcc\", \"wm_unittests\": \"bf6d13840e47bb2960fe1fd31dc04b9ec4e4695b\", \"wtf_unittests\": \"0fc7b7981fe5f0753a4fbc76619e50eb11e442ec\", \"zlib_unittests\": \"bad17d9eec8f67aca9de7ae6b7c2d5b4990cac8c\"}}, \"swarming\": {\"bot_dimensions\": {\"builderless\": [\"1\"], \"caches\": [\"builder_4973d939604d11dcbaec68575e69c80c756ff63e355ab013b29b8bca26434b7c_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-65-a7fn\"], \"image\": [\"chrome-xenial-21010300-f0aeabbfea7\"], \"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\": [\"5657-0417a3f\"], \"ssd\": [\"0\"], \"zone\": [\"us\", \"us-central\", \"us-central1\", \"us-central1-b\"]}}}",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"started_ts": "1610143159281687",
"status": "COMPLETED",
"status_changed_ts": "1610149122412288",
"tags": [
"build_address:luci.chromium.ci/linux-chromeos-dbg/22121",
"builder:linux-chromeos-dbg",
"buildset:commit/git/c46fe077f9020d73d0d324430e08fa6ba670bd50",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/c46fe077f9020d73d0d324430e08fa6ba670bd50",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9024066306266055584",
"scheduler_job_id:chromium/linux-chromeos-dbg",
"swarming_hostname:chromium-swarm.appspot.com",
"swarming_tag:log_location:logdog://logs.chromium.org/chromium/buildbucket/cr-buildbucket.appspot.com/8858636244286460768/+/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:50fcd459fdf7d210",
"user_agent:luci-scheduler"
],
"updated_ts": "1610149122417938",
"url": "https://ci.chromium.org/b/8858636244286460768",
"utcnow_ts": "1610149122920003"
}
}
[23:38:42.928] Invocation finished in 1h39m26.552929578s with status SUCCEEDED