[04:10:22.888] New invocation is queued and will start shortly
[04:10:24.033] Starting the invocation (attempt 1)
[04:10:24.074] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[04:10:24.075] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[04:10:24.075] Buildbucket request:
{
"bucket": "luci.chromium.ci",
"client_operation_id": "9020600273515016768",
"parameters_json": "{\"builder_name\":\"linux-chromeos-dbg\",\"properties\":{\"branch\":\"refs/heads/master\",\"repository\":\"https://chromium.googlesource.com/chromium/src\",\"revision\":\"584bfb4efb6feb1f8e7bf2f0725f461ba0d5107f\"}}",
"pubsub_callback": {
"auth_token": "...",
"topic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
},
"tags": [
"builder:linux-chromeos-dbg",
"scheduler_invocation_id:9020600273515016768",
"scheduler_job_id:chromium/linux-chromeos-dbg",
"user_agent:luci-scheduler",
"buildset:commit/git/584bfb4efb6feb1f8e7bf2f0725f461ba0d5107f",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/584bfb4efb6feb1f8e7bf2f0725f461ba0d5107f",
"gitiles_ref:refs/heads/master"
]
}
[04:10:24.730] Buildbucket response:
{
"build": {
"bucket": "luci.chromium.ci",
"canary": true,
"canary_preference": "CANARY",
"created_by": "project:chromium",
"created_ts": "1613448624151996",
"id": "8855170211440117008",
"parameters_json": "{\"builder_name\": \"linux-chromeos-dbg\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"584bfb4efb6feb1f8e7bf2f0725f461ba0d5107f\"}}",
"project": "chromium",
"result_details_json": "{\"properties\": {}}",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"status": "SCHEDULED",
"status_changed_ts": "1613448624540629",
"tags": [
"build_address:luci.chromium.ci/linux-chromeos-dbg/22642",
"builder:linux-chromeos-dbg",
"buildset:commit/git/584bfb4efb6feb1f8e7bf2f0725f461ba0d5107f",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/584bfb4efb6feb1f8e7bf2f0725f461ba0d5107f",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9020600273515016768",
"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/8855170211440117008/+/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": "1613448624540841",
"url": "https://ci.chromium.org/b/8855170211440117008",
"utcnow_ts": "1613448624717375"
}
}
[04:10:24.730] Task URL: https://ci.chromium.org/b/8855170211440117008
[04:10:24.730] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020600273515016768:2:0) after 1m0s
[04:10:42.464] Received PubSub notification, asking Buildbucket for the build status
[04:10:42.862] Build 8855170211440117008: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:11:24.789] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020600273515016768:2:0)
[04:11:24.789] Timer tick, asking Buildbucket for the build status
[04:11:24.860] Build 8855170211440117008: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:11:24.860] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020600273515016768:4:0) after 1m0s
[04:12:24.878] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020600273515016768:4:0)
[04:12:24.878] Timer tick, asking Buildbucket for the build status
[04:12:24.961] Build 8855170211440117008: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:12:24.961] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020600273515016768:5:0) after 1m0s
[04:13:24.978] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020600273515016768:5:0)
[04:13:24.978] Timer tick, asking Buildbucket for the build status
[04:13:25.159] Build 8855170211440117008: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:13:25.159] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020600273515016768:6:0) after 1m0s
[04:14:25.175] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020600273515016768:6:0)
[04:14:25.175] Timer tick, asking Buildbucket for the build status
[04:14:25.247] Build 8855170211440117008: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:14:25.247] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020600273515016768:7:0) after 1m0s
[04:15:25.280] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020600273515016768:7:0)
[04:15:25.280] Timer tick, asking Buildbucket for the build status
[04:15:25.418] Build 8855170211440117008: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:15:25.418] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020600273515016768:8:0) after 1m0s
[04:16:25.474] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020600273515016768:8:0)
[04:16:25.474] Timer tick, asking Buildbucket for the build status
[04:16:25.568] Build 8855170211440117008: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:16:25.568] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020600273515016768:9:0) after 1m0s
[04:17:25.583] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020600273515016768:9:0)
[04:17:25.583] Timer tick, asking Buildbucket for the build status
[04:17:25.792] Build 8855170211440117008: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:17:25.792] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020600273515016768:10:0) after 1m0s
[04:18:25.809] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020600273515016768:10:0)
[04:18:25.809] Timer tick, asking Buildbucket for the build status
[04:18:25.895] Build 8855170211440117008: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:18:25.895] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020600273515016768:11:0) after 1m0s
[04:19:25.911] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020600273515016768:11:0)
[04:19:25.911] Timer tick, asking Buildbucket for the build status
[04:19:25.983] Build 8855170211440117008: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:19:25.983] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020600273515016768:12:0) after 1m0s
[04:20:25.999] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020600273515016768:12:0)
[04:20:25.999] Timer tick, asking Buildbucket for the build status
[04:20:26.336] Build 8855170211440117008: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:20:26.336] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020600273515016768:13:0) after 1m0s
[04:21:26.368] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020600273515016768:13:0)
[04:21:26.368] Timer tick, asking Buildbucket for the build status
[04:21:26.479] Build 8855170211440117008: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:21:26.479] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020600273515016768:14:0) after 1m0s
[04:22:26.533] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020600273515016768:14:0)
[04:22:26.533] Timer tick, asking Buildbucket for the build status
[04:22:26.912] Build 8855170211440117008: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:22:26.912] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020600273515016768:15:0) after 1m0s
[04:23:26.962] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020600273515016768:15:0)
[04:23:26.962] Timer tick, asking Buildbucket for the build status
[04:23:27.041] Build 8855170211440117008: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:23:27.041] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020600273515016768:16:0) after 1m0s
[04:24:27.058] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020600273515016768:16:0)
[04:24:27.058] Timer tick, asking Buildbucket for the build status
[04:24:27.328] Build 8855170211440117008: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:24:27.328] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020600273515016768:17:0) after 1m0s
[04:25:27.381] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020600273515016768:17:0)
[04:25:27.381] Timer tick, asking Buildbucket for the build status
[04:25:27.511] Build 8855170211440117008: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:25:27.511] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020600273515016768:18:0) after 1m0s
[04:26:27.531] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020600273515016768:18:0)
[04:26:27.531] Timer tick, asking Buildbucket for the build status
[04:26:27.608] Build 8855170211440117008: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:26:27.608] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020600273515016768:19:0) after 1m0s
[04:27:27.623] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020600273515016768:19:0)
[04:27:27.623] Timer tick, asking Buildbucket for the build status
[04:27:27.809] Build 8855170211440117008: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:27:27.809] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020600273515016768:20:0) after 1m0s
[04:28:27.835] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020600273515016768:20:0)
[04:28:27.835] Timer tick, asking Buildbucket for the build status
[04:28:27.906] Build 8855170211440117008: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:28:27.906] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020600273515016768:21:0) after 1m0s
[04:29:27.926] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020600273515016768:21:0)
[04:29:27.926] Timer tick, asking Buildbucket for the build status
[04:29:28.016] Build 8855170211440117008: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:29:28.016] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020600273515016768:22:0) after 1m0s
[04:30:28.031] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020600273515016768:22:0)
[04:30:28.031] Timer tick, asking Buildbucket for the build status
[04:30:28.161] Build 8855170211440117008: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:30:28.161] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020600273515016768:23:0) after 1m0s
[04:31:28.179] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020600273515016768:23:0)
[04:31:28.179] Timer tick, asking Buildbucket for the build status
[04:31:28.260] Build 8855170211440117008: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:31:28.260] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020600273515016768:24:0) after 1m0s
[04:32:28.276] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020600273515016768:24:0)
[04:32:28.276] Timer tick, asking Buildbucket for the build status
[04:32:28.357] Build 8855170211440117008: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:32:28.357] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020600273515016768:25:0) after 1m0s
[04:33:28.378] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020600273515016768:25:0)
[04:33:28.378] Timer tick, asking Buildbucket for the build status
[04:33:28.850] Build 8855170211440117008: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:33:28.850] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020600273515016768:26:0) after 1m0s
[04:34:28.894] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020600273515016768:26:0)
[04:34:28.894] Timer tick, asking Buildbucket for the build status
[04:34:28.960] Build 8855170211440117008: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:34:28.960] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020600273515016768:27:0) after 1m0s
[04:35:29.082] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020600273515016768:27:0)
[04:35:29.082] Timer tick, asking Buildbucket for the build status
[04:35:29.386] Build 8855170211440117008: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:35:29.386] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020600273515016768:28:0) after 1m0s
[04:36:29.420] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020600273515016768:28:0)
[04:36:29.420] Timer tick, asking Buildbucket for the build status
[04:36:29.587] Build 8855170211440117008: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:36:29.587] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020600273515016768:29:0) after 1m0s
[04:37:29.606] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020600273515016768:29:0)
[04:37:29.606] Timer tick, asking Buildbucket for the build status
[04:37:29.682] Build 8855170211440117008: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:37:29.682] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020600273515016768:30:0) after 1m0s
[04:38:29.708] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020600273515016768:30:0)
[04:38:29.708] Timer tick, asking Buildbucket for the build status
[04:38:29.818] Build 8855170211440117008: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:38:29.818] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020600273515016768:31:0) after 1m0s
[04:39:29.903] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020600273515016768:31:0)
[04:39:29.903] Timer tick, asking Buildbucket for the build status
[04:39:30.211] Build 8855170211440117008: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:39:30.211] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020600273515016768:32:0) after 1m0s
[04:40:30.239] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020600273515016768:32:0)
[04:40:30.239] Timer tick, asking Buildbucket for the build status
[04:40:30.333] Build 8855170211440117008: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:40:30.333] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020600273515016768:33:0) after 1m0s
[04:41:30.351] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020600273515016768:33:0)
[04:41:30.351] Timer tick, asking Buildbucket for the build status
[04:41:30.444] Build 8855170211440117008: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:41:30.444] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020600273515016768:34:0) after 1m0s
[04:42:30.486] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020600273515016768:34:0)
[04:42:30.486] Timer tick, asking Buildbucket for the build status
[04:42:30.614] Build 8855170211440117008: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:42:30.614] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020600273515016768:35:0) after 1m0s
[04:43:30.634] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020600273515016768:35:0)
[04:43:30.634] Timer tick, asking Buildbucket for the build status
[04:43:31.503] Build 8855170211440117008: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:43:31.503] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020600273515016768:36:0) after 1m0s
[04:44:31.595] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020600273515016768:36:0)
[04:44:31.595] Timer tick, asking Buildbucket for the build status
[04:44:31.816] Build 8855170211440117008: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:44:31.816] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020600273515016768:37:0) after 1m0s
[04:45:31.835] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020600273515016768:37:0)
[04:45:31.835] Timer tick, asking Buildbucket for the build status
[04:45:31.967] Build 8855170211440117008: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:45:31.967] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020600273515016768:38:0) after 1m0s
[04:46:31.982] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020600273515016768:38:0)
[04:46:31.982] Timer tick, asking Buildbucket for the build status
[04:46:32.211] Build 8855170211440117008: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:46:32.211] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020600273515016768:39:0) after 1m0s
[04:47:32.232] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020600273515016768:39:0)
[04:47:32.232] Timer tick, asking Buildbucket for the build status
[04:47:32.464] Build 8855170211440117008: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:47:32.464] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020600273515016768:40:0) after 1m0s
[04:48:32.486] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020600273515016768:40:0)
[04:48:32.486] Timer tick, asking Buildbucket for the build status
[04:48:32.591] Build 8855170211440117008: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:48:32.591] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020600273515016768:41:0) after 1m0s
[04:49:32.641] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020600273515016768:41:0)
[04:49:32.641] Timer tick, asking Buildbucket for the build status
[04:49:32.769] Build 8855170211440117008: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:49:32.769] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020600273515016768:42:0) after 1m0s
[04:50:32.821] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020600273515016768:42:0)
[04:50:32.821] Timer tick, asking Buildbucket for the build status
[04:50:32.944] Build 8855170211440117008: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:50:32.944] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020600273515016768:43:0) after 1m0s
[04:51:32.964] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020600273515016768:43:0)
[04:51:32.964] Timer tick, asking Buildbucket for the build status
[04:51:33.027] Build 8855170211440117008: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:51:33.027] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020600273515016768:44:0) after 1m0s
[04:52:33.062] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020600273515016768:44:0)
[04:52:33.062] Timer tick, asking Buildbucket for the build status
[04:52:33.424] Build 8855170211440117008: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:52:33.424] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020600273515016768:45:0) after 1m0s
[04:53:33.503] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020600273515016768:45:0)
[04:53:33.503] Timer tick, asking Buildbucket for the build status
[04:53:33.593] Build 8855170211440117008: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:53:33.593] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020600273515016768:46:0) after 1m0s
[04:54:33.614] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020600273515016768:46:0)
[04:54:33.614] Timer tick, asking Buildbucket for the build status
[04:54:33.719] Build 8855170211440117008: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:54:33.719] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020600273515016768:47:0) after 1m0s
[04:55:33.745] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020600273515016768:47:0)
[04:55:33.745] Timer tick, asking Buildbucket for the build status
[04:55:34.347] Build 8855170211440117008: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:55:34.347] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020600273515016768:48:0) after 1m0s
[04:56:34.386] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020600273515016768:48:0)
[04:56:34.386] Timer tick, asking Buildbucket for the build status
[04:56:34.487] Build 8855170211440117008: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:56:34.487] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020600273515016768:49:0) after 1m0s
[04:57:34.545] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020600273515016768:49:0)
[04:57:34.545] Timer tick, asking Buildbucket for the build status
[04:57:34.651] Build 8855170211440117008: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:57:34.651] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020600273515016768:50:0) after 1m0s
[04:58:34.664] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020600273515016768:50:0)
[04:58:34.664] Timer tick, asking Buildbucket for the build status
[04:58:34.750] Build 8855170211440117008: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:58:34.750] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020600273515016768:51:0) after 1m0s
[04:59:34.767] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020600273515016768:51:0)
[04:59:34.767] Timer tick, asking Buildbucket for the build status
[04:59:34.851] Build 8855170211440117008: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:59:34.851] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020600273515016768:52:0) after 1m0s
[05:00:34.926] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020600273515016768:52:0)
[05:00:34.926] Timer tick, asking Buildbucket for the build status
[05:00:36.111] Build 8855170211440117008: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:00:36.111] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020600273515016768:53:0) after 1m0s
[05:01:36.131] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020600273515016768:53:0)
[05:01:36.131] Timer tick, asking Buildbucket for the build status
[05:01:36.270] Build 8855170211440117008: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:01:36.270] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020600273515016768:54:0) after 1m0s
[05:02:36.318] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020600273515016768:54:0)
[05:02:36.318] Timer tick, asking Buildbucket for the build status
[05:02:36.403] Build 8855170211440117008: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:02:36.403] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020600273515016768:55:0) after 1m0s
[05:03:36.430] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020600273515016768:55:0)
[05:03:36.430] Timer tick, asking Buildbucket for the build status
[05:03:36.505] Build 8855170211440117008: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:03:36.505] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020600273515016768:56:0) after 1m0s
[05:04:36.588] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020600273515016768:56:0)
[05:04:36.588] Timer tick, asking Buildbucket for the build status
[05:04:36.889] Build 8855170211440117008: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:04:36.889] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020600273515016768:57:0) after 1m0s
[05:05:36.942] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020600273515016768:57:0)
[05:05:36.942] Timer tick, asking Buildbucket for the build status
[05:05:37.058] Build 8855170211440117008: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:05:37.058] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020600273515016768:58:0) after 1m0s
[05:06:37.115] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020600273515016768:58:0)
[05:06:37.115] Timer tick, asking Buildbucket for the build status
[05:06:37.204] Build 8855170211440117008: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:06:37.204] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020600273515016768:59:0) after 1m0s
[05:07:37.234] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020600273515016768:59:0)
[05:07:37.234] Timer tick, asking Buildbucket for the build status
[05:07:37.325] Build 8855170211440117008: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:07:37.325] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020600273515016768:60:0) after 1m0s
[05:08:37.344] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020600273515016768:60:0)
[05:08:37.344] Timer tick, asking Buildbucket for the build status
[05:08:37.441] Build 8855170211440117008: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:08:37.441] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020600273515016768:61:0) after 1m0s
[05:09:37.498] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020600273515016768:61:0)
[05:09:37.498] Timer tick, asking Buildbucket for the build status
[05:09:37.586] Build 8855170211440117008: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:09:37.586] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020600273515016768:62:0) after 1m0s
[05:10:37.611] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020600273515016768:62:0)
[05:10:37.611] Timer tick, asking Buildbucket for the build status
[05:10:37.713] Build 8855170211440117008: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:10:37.713] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020600273515016768:63:0) after 1m0s
[05:11:37.848] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020600273515016768:63:0)
[05:11:37.848] Timer tick, asking Buildbucket for the build status
[05:11:37.959] Build 8855170211440117008: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:11:37.959] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020600273515016768:64:0) after 1m0s
[05:12:37.979] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020600273515016768:64:0)
[05:12:37.979] Timer tick, asking Buildbucket for the build status
[05:12:38.157] Build 8855170211440117008: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:12:38.158] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020600273515016768:65:0) after 1m0s
[05:13:38.159] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020600273515016768:65:0)
[05:13:38.159] Timer tick, asking Buildbucket for the build status
[05:13:38.318] Build 8855170211440117008: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:13:38.318] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020600273515016768:66:0) after 1m0s
[05:14:38.412] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020600273515016768:66:0)
[05:14:38.412] Timer tick, asking Buildbucket for the build status
[05:14:38.617] Build 8855170211440117008: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:14:38.617] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020600273515016768:67:0) after 1m0s
[05:15:38.718] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020600273515016768:67:0)
[05:15:38.718] Timer tick, asking Buildbucket for the build status
[05:15:39.149] Build 8855170211440117008: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:15:39.149] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020600273515016768:68:0) after 1m0s
[05:16:39.172] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020600273515016768:68:0)
[05:16:39.172] Timer tick, asking Buildbucket for the build status
[05:16:39.264] Build 8855170211440117008: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:16:39.264] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020600273515016768:69:0) after 1m0s
[05:17:39.317] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020600273515016768:69:0)
[05:17:39.317] Timer tick, asking Buildbucket for the build status
[05:17:39.426] Build 8855170211440117008: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:17:39.426] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020600273515016768:70:0) after 1m0s
[05:18:39.449] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020600273515016768:70:0)
[05:18:39.449] Timer tick, asking Buildbucket for the build status
[05:18:39.763] Build 8855170211440117008: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:18:39.763] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020600273515016768:71:0) after 1m0s
[05:19:39.751] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020600273515016768:71:0)
[05:19:39.751] Timer tick, asking Buildbucket for the build status
[05:19:39.940] Build 8855170211440117008: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:19:39.940] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020600273515016768:72:0) after 1m0s
[05:20:40.001] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020600273515016768:72:0)
[05:20:40.001] Timer tick, asking Buildbucket for the build status
[05:20:40.113] Build 8855170211440117008: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:20:40.113] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020600273515016768:73:0) after 1m0s
[05:21:40.147] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020600273515016768:73:0)
[05:21:40.147] Timer tick, asking Buildbucket for the build status
[05:21:40.283] Build 8855170211440117008: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:21:40.283] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020600273515016768:74:0) after 1m0s
[05:22:40.298] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020600273515016768:74:0)
[05:22:40.298] Timer tick, asking Buildbucket for the build status
[05:22:40.433] Build 8855170211440117008: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:22:40.433] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020600273515016768:75:0) after 1m0s
[05:23:40.455] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020600273515016768:75:0)
[05:23:40.455] Timer tick, asking Buildbucket for the build status
[05:23:40.945] Build 8855170211440117008: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:23:40.945] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020600273515016768:76:0) after 1m0s
[05:24:40.974] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020600273515016768:76:0)
[05:24:40.974] Timer tick, asking Buildbucket for the build status
[05:24:41.206] Build 8855170211440117008: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:24:41.206] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020600273515016768:77:0) after 1m0s
[05:25:41.229] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020600273515016768:77:0)
[05:25:41.229] Timer tick, asking Buildbucket for the build status
[05:25:41.428] Build 8855170211440117008: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:25:41.428] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020600273515016768:78:0) after 1m0s
[05:26:41.462] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020600273515016768:78:0)
[05:26:41.462] Timer tick, asking Buildbucket for the build status
[05:26:41.553] Build 8855170211440117008: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:26:41.553] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020600273515016768:79:0) after 1m0s
[05:27:41.576] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020600273515016768:79:0)
[05:27:41.576] Timer tick, asking Buildbucket for the build status
[05:27:41.819] Build 8855170211440117008: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:27:41.819] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020600273515016768:80:0) after 1m0s
[05:28:41.840] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020600273515016768:80:0)
[05:28:41.840] Timer tick, asking Buildbucket for the build status
[05:28:42.056] Build 8855170211440117008: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:28:42.056] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020600273515016768:81:0) after 1m0s
[05:29:42.110] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020600273515016768:81:0)
[05:29:42.110] Timer tick, asking Buildbucket for the build status
[05:29:42.218] Build 8855170211440117008: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:29:42.218] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020600273515016768:82:0) after 1m0s
[05:30:42.281] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020600273515016768:82:0)
[05:30:42.281] Timer tick, asking Buildbucket for the build status
[05:30:42.803] Build 8855170211440117008: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:30:42.803] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020600273515016768:83:0) after 1m0s
[05:31:42.836] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020600273515016768:83:0)
[05:31:42.836] Timer tick, asking Buildbucket for the build status
[05:31:42.940] Build 8855170211440117008: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:31:42.940] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020600273515016768:84:0) after 1m0s
[05:32:42.992] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020600273515016768:84:0)
[05:32:42.992] Timer tick, asking Buildbucket for the build status
[05:32:43.094] Build 8855170211440117008: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:32:43.094] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020600273515016768:85:0) after 1m0s
[05:33:43.128] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020600273515016768:85:0)
[05:33:43.128] Timer tick, asking Buildbucket for the build status
[05:33:43.209] Build 8855170211440117008: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:33:43.209] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020600273515016768:86:0) after 1m0s
[05:34:43.221] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020600273515016768:86:0)
[05:34:43.221] Timer tick, asking Buildbucket for the build status
[05:34:43.313] Build 8855170211440117008: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:34:43.313] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020600273515016768:87:0) after 1m0s
[05:35:43.333] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020600273515016768:87:0)
[05:35:43.333] Timer tick, asking Buildbucket for the build status
[05:35:43.456] Build 8855170211440117008: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:35:43.456] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020600273515016768:88:0) after 1m0s
[05:36:43.642] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020600273515016768:88:0)
[05:36:43.642] Timer tick, asking Buildbucket for the build status
[05:36:43.725] Build 8855170211440117008: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:36:43.725] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020600273515016768:89:0) after 1m0s
[05:37:43.716] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020600273515016768:89:0)
[05:37:43.716] Timer tick, asking Buildbucket for the build status
[05:37:43.795] Build 8855170211440117008: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:37:43.795] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020600273515016768:90:0) after 1m0s
[05:38:43.820] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020600273515016768:90:0)
[05:38:43.820] Timer tick, asking Buildbucket for the build status
[05:38:43.903] Build 8855170211440117008: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:38:43.903] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020600273515016768:91:0) after 1m0s
[05:39:43.927] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020600273515016768:91:0)
[05:39:43.927] Timer tick, asking Buildbucket for the build status
[05:39:44.136] Build 8855170211440117008: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:39:44.136] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020600273515016768:92:0) after 1m0s
[05:40:44.188] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020600273515016768:92:0)
[05:40:44.188] Timer tick, asking Buildbucket for the build status
[05:40:44.691] Build 8855170211440117008: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:40:44.691] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020600273515016768:93:0) after 1m0s
[05:41:44.738] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020600273515016768:93:0)
[05:41:44.738] Timer tick, asking Buildbucket for the build status
[05:41:44.829] Build 8855170211440117008: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:41:44.829] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020600273515016768:94:0) after 1m0s
[05:42:44.887] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020600273515016768:94:0)
[05:42:44.887] Timer tick, asking Buildbucket for the build status
[05:42:44.977] Build 8855170211440117008: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:42:44.977] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020600273515016768:95:0) after 1m0s
[05:43:45.089] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020600273515016768:95:0)
[05:43:45.089] Timer tick, asking Buildbucket for the build status
[05:43:45.193] Build 8855170211440117008: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:43:45.193] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020600273515016768:96:0) after 1m0s
[05:44:45.225] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020600273515016768:96:0)
[05:44:45.225] Timer tick, asking Buildbucket for the build status
[05:44:45.618] Build 8855170211440117008: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:44:45.618] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020600273515016768:97:0) after 1m0s
[05:45:45.648] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020600273515016768:97:0)
[05:45:45.648] Timer tick, asking Buildbucket for the build status
[05:45:46.111] Build 8855170211440117008: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:45:46.111] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020600273515016768:98:0) after 1m0s
[05:46:46.191] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020600273515016768:98:0)
[05:46:46.191] Timer tick, asking Buildbucket for the build status
[05:46:46.318] Build 8855170211440117008: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:46:46.318] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020600273515016768:99:0) after 1m0s
[05:47:46.342] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020600273515016768:99:0)
[05:47:46.342] Timer tick, asking Buildbucket for the build status
[05:47:46.565] Build 8855170211440117008: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:47:46.565] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020600273515016768:100:0) after 1m0s
[05:48:46.557] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020600273515016768:100:0)
[05:48:46.557] Timer tick, asking Buildbucket for the build status
[05:48:46.634] Build 8855170211440117008: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:48:46.634] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020600273515016768:101:0) after 1m0s
[05:48:53.474] Received PubSub notification, asking Buildbucket for the build status
[05:48:53.566] Build 8855170211440117008: status "COMPLETED", result "SUCCESS", failure_reason "", cancelation_reason ""
[05:48:53.566] Buildbucket build:
{
"build": {
"bucket": "luci.chromium.ci",
"canary": true,
"canary_preference": "CANARY",
"completed_ts": "1613454532030427",
"created_by": "project:chromium",
"created_ts": "1613448624151996",
"id": "8855170211440117008",
"parameters_json": "{\"builder_name\": \"linux-chromeos-dbg\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"584bfb4efb6feb1f8e7bf2f0725f461ba0d5107f\"}}",
"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\": \"584bfb4efb6feb1f8e7bf2f0725f461ba0d5107f\", \"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-184-d4lj\", \"branch\": \"refs/heads/master\", \"builder_group\": \"chromium.chromiumos\", \"buildername\": \"linux-chromeos-dbg\", \"buildnumber\": 22642, \"got_angle_revision\": \"a8a2a71b3ab5e535def6239997f6f24da918556b\", \"got_dawn_revision\": \"e61c9d86884145733d5763ab23c15bf09acf358c\", \"got_nacl_revision\": \"8a92e6ba1b6d62631f8d3ba3f4f8872ae8b6cca1\", \"got_revision\": \"584bfb4efb6feb1f8e7bf2f0725f461ba0d5107f\", \"got_revision_cp\": \"refs/heads/master@{#854140}\", \"got_swarming_client_revision\": \"a32a1607f6093d338f756c7e7c7b4333b0c50c9c\", \"got_swiftshader_revision\": \"539ef8e9426e10d7611d433ee60b94de0737344a\", \"got_v8_revision\": \"ebacb645b20531cd78dc088730fb72269822eeb6\", \"got_v8_revision_cp\": \"refs/heads/9.0.172@{#2}\", \"got_webrtc_revision\": \"8408c9938cb543a7cd5e7127927f3b4d0834ad59\", \"got_webrtc_revision_cp\": \"refs/heads/master@{#33272}\", \"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\": \"584bfb4efb6feb1f8e7bf2f0725f461ba0d5107f\", \"swarm_hashes_refs/heads/master(at){#854140}_without_patch\": {\"absl_hardening_tests\": \"47277ed8aa7caaf9943ea5922c26b28b37d01ccd\", \"accessibility_unittests\": \"d82f56d14c0207f9e6c10968239132f99956373e\", \"angle_unittests\": \"dd25916c46d026a27512a299a6b7bb795ee55294\", \"app_list_unittests\": \"8dbc815de031fcf4d22d9bcbe972c272aac02ee9\", \"app_shell_unittests\": \"4aa33d7be13ffbd459c1ab700fbdf58fb8bc51df\", \"ash_unittests\": \"4abf1be602f82be197ccc8a8a47576f78babfcfe\", \"aura_unittests\": \"4d8e5ddc4e53fd08829791cde96865999af6b765\", \"base_unittests\": \"ab79e0ab7f45a7e2b0002e3ca45171215458d709\", \"base_util_unittests\": \"fbb631c28c3aefe31848f99bd49624d444f900ab\", \"blink_common_unittests\": \"3522dccbb11a0d9a5e9fbc5e9f4c769a0849e1cc\", \"blink_fuzzer_unittests\": \"2c8678e7834b1fc588fe96534cd47b420b996ea5\", \"blink_heap_unittests\": \"a0b64a88525fe41f6fbd8be3e7a598f7f0868086\", \"blink_platform_unittests\": \"78ea2be032d0d3af55469afd43ec5731dfba73f2\", \"blink_unittests\": \"095c226507c9cdb3cfca74dd4690463c78e8d8df\", \"boringssl_crypto_tests\": \"e97a28645b19c6f943acb4754d3478f2328ce59a\", \"boringssl_ssl_tests\": \"0a6b062d529cd317e8bf560631cc4b21916e63ef\", \"browser_tests\": \"ac4c2dffc5a81f8799515e5799861031c48821a6\", \"capture_unittests\": \"baed74e9f2b47c9030568fc3ef8730108187f09a\", \"cast_unittests\": \"cb59c9f563ed1001fe7812c786c6c4972dda196e\", \"cc_unittests\": \"7d17c3bcea4dd6722421d4b725ee69acd98a730e\", \"chrome_app_unittests\": \"874080fa3e567e1653fc37b574ae0f2de0e2a147\", \"chromedriver_unittests\": \"b032998c37d033f5ab8a16e83d797c1cbec8efd5\", \"chromeos_components_unittests\": \"0720e276b10f20769ad4960b3e269518afaae733\", \"chromeos_unittests\": \"35f887ee84e085a4fa0fa9c3fe5ae1aefcfc6c71\", \"components_browsertests\": \"bfdb0530f6edd839592a91c6b0c4762e22e4c13d\", \"components_unittests\": \"a9e4f7e111930f7850ce5bcc04de66d8ac589fe4\", \"compositor_unittests\": \"476ef52c0d248daec64b332f3f19ce038a8ff669\", \"content_browsertests\": \"38c6550053543f523ebbfeb7a431e85255664165\", \"content_unittests\": \"3e8fdd663c1c97ad027c46f9d10af427d945a18c\", \"crashpad_tests\": \"64fe438da493eab44d01495d83dfa3b800490729\", \"crypto_unittests\": \"dd31df58fc4766f13c9d75ea9698561833b1ee97\", \"dbus_unittests\": \"01b579da1e63024eb022c6ec168c503d0ac10e3f\", \"device_unittests\": \"eec735a202c40c299bb4054902504e8139967d99\", \"display_unittests\": \"27eea1ffa9d8e6db4c1f3b99d445d783b205dd16\", \"events_unittests\": \"deb23d2e572040479085ac3229f6635ea095a93f\", \"exo_unittests\": \"c81f22564db265bc451ba1bd399ad8423ba8d0be\", \"extensions_browsertests\": \"27ae6b324c1d84a5fe93360f6f3e49f8c58a3d25\", \"extensions_unittests\": \"61b85b6e75c47840952035c3f9a2a277ca6903c7\", \"filesystem_service_unittests\": \"8fb871ebe96a53fd12173a4ea310b7c3e6215078\", \"gcm_unit_tests\": \"17ea2caf9fa9a2c311ef1b915d034f15ece6a3e8\", \"gfx_unittests\": \"6ed05862ed1c3d51bf40b0b6579ae3e27a5c6cfc\", \"gin_unittests\": \"c6b65e6f8f8f5047de04cbc4d6d40eff61386d22\", \"gl_unittests_ozone\": \"cc01535b88712f37d76cf30cac83fb568012657f\", \"google_apis_unittests\": \"32e8a5adf5a679f09a3d538dd9e30a42e70247ba\", \"gpu_unittests\": \"604601f334e7eafc947dd2f020cbf47345cc5bb9\", \"gwp_asan_unittests\": \"6d380ba4d3d76f505c2f8318c8db9dd45de02ec6\", \"interactive_ui_tests\": \"cf9ff17657e0a229a3bed5281d92aa550b363de8\", \"ipc_tests\": \"78a689a54445b4fb569133f4c79c666ae33c363c\", \"jingle_unittests\": \"f53f89d545871b9ef737ae44f0aae48fd1aef9db\", \"keyboard_unittests\": \"68ec550ff0d73c81790e7c63ddb7cda9ddccdd89\", \"latency_unittests\": \"f8ce9fe3775991a31167bc818689eec4c2cc6e78\", \"libjingle_xmpp_unittests\": \"ccc92017682a9361685018902e1ac79264198dd1\", \"liburlpattern_unittests\": \"e66598353ee7585cc72ec49f4b2418d9221d8ea5\", \"media_blink_unittests\": \"fe159797736e0f9d2d63d920bd642fcfbf6f5823\", \"media_unittests\": \"4cadaf37a5b595475d80505f94b1c9df14bf6dd0\", \"message_center_unittests\": \"e1f4198471bb12d9d01b36e8a70539e6075865dc\", \"midi_unittests\": \"3665af6b4751d37780bba281d2e44f2a9c588efb\", \"mojo_core_unittests\": \"e5dd865503ef5b8d16ee371ef7178a2250a83739\", \"mojo_unittests\": \"a74d893630f5bf566461401f29a42440c19629a4\", \"nacl_helper_nonsfi_unittests\": \"58edd4c73e5a5d7ce0a8ff5dbd839fd3fba65412\", \"nacl_loader_unittests\": \"e493d9ff248011816ad3d0b9e7a16260465b155f\", \"native_theme_unittests\": \"00fa402da0f3c811c5f63016474f95a962e1b712\", \"net_unittests\": \"458742c4eb48903dc54baf12fa9096527a01c344\", \"ozone_gl_unittests\": \"db5910d05a563cf1c0696831a8cdcd9dd9c442fb\", \"ozone_unittests\": \"5faaf0a2399d9eda3ea66a8adc4d54b009899407\", \"ozone_x11_unittests\": \"4e93e29fdbbf0fb7f9690f9d86a1bfaa03e2eee5\", \"pdf_unittests\": \"9308ab6ab90ad5a9f1a34278352b75a983fb037b\", \"perfetto_unittests\": \"40374ed4ec920340ded042567cc78e51a5f01e15\", \"ppapi_unittests\": \"f5542164bb079c58212c8e34a74b96b8ee3dd9a8\", \"printing_unittests\": \"92b304e72903981160b3128e843e4a5d9631c785\", \"remoting_unittests\": \"ab505c7f6625d0f190918db027a1dd187d66d575\", \"sandbox_linux_unittests\": \"4c7bdeb9e4741c139a6703fee23732b4f78174c0\", \"service_manager_unittests\": \"f28bff403f14e7d8d0a894518b9ab468e9b05013\", \"services_unittests\": \"597cc08c0eefc4beab84624085fa474f2002439e\", \"shell_dialogs_unittests\": \"37d17363dbfea427534913885e87d735b9abfe0f\", \"shell_encryption_unittests\": \"adba5ea98d6363961289cdbe3e1b7af1db2620cf\", \"skia_unittests\": \"aa58bc15e0ad12b23864c0a5f52ee3d6b23c42e0\", \"snapshot_unittests\": \"de86b2bff84c418a6cb4b454d4fa4d5e2a558a26\", \"sql_unittests\": \"2fc0091e859988e50771d31368af05fe999db0d8\", \"storage_unittests\": \"57a8286bcaef517d61d7ae52c8e10fbb25123c5b\", \"sync_integration_tests\": \"f7c844c6401df0b521f847789a919c4e1c71faa9\", \"traffic_annotation_auditor_unittests\": \"a26bcc9776f53ea9f6495cf78b3918e8344ec742\", \"ui_base_unittests\": \"34d2eb8d630478c64a63e50de0f8139433dd94c7\", \"ui_chromeos_unittests\": \"b88c58b85c7ef71be5370eab8cbf85b228781cac\", \"ui_touch_selection_unittests\": \"c0bbff14427fc7e05672c9d918e1ff1794789e02\", \"unit_tests\": \"f4eb0906e95a61b19db70b3a630d0dfecd52a0cd\", \"url_unittests\": \"1618b588af4887457b8a1baf1b1ce5fac756ee60\", \"usage_time_limit_unittests\": \"1b12f70c8f33a0838a95094d9448ce5ff672de51\", \"views_unittests\": \"86f680d736ac24e82ae7b8031e376bf3d37fb7a7\", \"viz_unittests\": \"b37897e669e8e306b15132f48d539d20d7d9b9e5\", \"wm_unittests\": \"eed2c5d49cb7ea47472c082aa8824688fe00f1bf\", \"wtf_unittests\": \"dd93cac5643d43185b776e735458c77011f4c23e\", \"zlib_unittests\": \"73f891a1050e5e6f668729fa5a486bedc6b6cc44\"}}, \"swarming\": {\"bot_dimensions\": {\"builderless\": [\"1\"], \"caches\": [\"builder_4973d939604d11dcbaec68575e69c80c756ff63e355ab013b29b8bca26434b7c_v2\", \"builder_61626c7085ee1f9730db9e25e8ceef3d7b395de70268d432aed853b8a16eb295_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-184-d4lj\"], \"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\": [\"5700-b36f18b\"], \"ssd\": [\"0\"], \"zone\": [\"us\", \"us-central\", \"us-central1\", \"us-central1-b\"]}}}",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"started_ts": "1613448640835909",
"status": "COMPLETED",
"status_changed_ts": "1613454532368029",
"tags": [
"build_address:luci.chromium.ci/linux-chromeos-dbg/22642",
"builder:linux-chromeos-dbg",
"buildset:commit/git/584bfb4efb6feb1f8e7bf2f0725f461ba0d5107f",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/584bfb4efb6feb1f8e7bf2f0725f461ba0d5107f",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9020600273515016768",
"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/8855170211440117008/+/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:51c1d9c368ad0010",
"user_agent:luci-scheduler"
],
"updated_ts": "1613454532381288",
"url": "https://ci.chromium.org/b/8855170211440117008",
"utcnow_ts": "1613454533558510"
}
}
[05:48:53.566] Invocation finished in 1h38m30.777173215s with status SUCCEEDED