[18:02:19.088] New invocation is queued and will start shortly
[18:02:20.372] Starting the invocation (attempt 1)
[18:02:20.420] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[18:02:20.420] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[18:02:20.420] Buildbucket request:
{
"bucket": "luci.chromium.ci",
"client_operation_id": "9022812856658874112",
"parameters_json": "{\"builder_name\":\"linux-chromeos-dbg\",\"properties\":{\"branch\":\"refs/heads/master\",\"repository\":\"https://chromium.googlesource.com/chromium/src\",\"revision\":\"30d67bcef67ee39b4145f607ce5cad38e951d6cb\"}}",
"pubsub_callback": {
"auth_token": "...",
"topic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
},
"tags": [
"builder:linux-chromeos-dbg",
"scheduler_invocation_id:9022812856658874112",
"scheduler_job_id:chromium/linux-chromeos-dbg",
"user_agent:luci-scheduler",
"buildset:commit/git/30d67bcef67ee39b4145f607ce5cad38e951d6cb",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/30d67bcef67ee39b4145f607ce5cad38e951d6cb",
"gitiles_ref:refs/heads/master"
]
}
[18:02:21.119] Buildbucket response:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "PROD",
"created_by": "project:chromium",
"created_ts": "1611338540546510",
"id": "8857382794466310080",
"parameters_json": "{\"builder_name\": \"linux-chromeos-dbg\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"30d67bcef67ee39b4145f607ce5cad38e951d6cb\"}}",
"project": "chromium",
"result_details_json": "{\"properties\": {}}",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"status": "SCHEDULED",
"status_changed_ts": "1611338540977996",
"tags": [
"build_address:luci.chromium.ci/linux-chromeos-dbg/22305",
"builder:linux-chromeos-dbg",
"buildset:commit/git/30d67bcef67ee39b4145f607ce5cad38e951d6cb",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/30d67bcef67ee39b4145f607ce5cad38e951d6cb",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9022812856658874112",
"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/8857382794466310080/+/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": "1611338540978154",
"url": "https://ci.chromium.org/b/8857382794466310080",
"utcnow_ts": "1611338541106971"
}
}
[18:02:21.119] Task URL: https://ci.chromium.org/b/8857382794466310080
[18:02:21.119] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022812856658874112:2:0) after 1m0s
[18:02:25.093] Received PubSub notification, asking Buildbucket for the build status
[18:02:25.241] Build 8857382794466310080: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:03:21.167] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022812856658874112:2:0)
[18:03:21.167] Timer tick, asking Buildbucket for the build status
[18:03:21.456] Build 8857382794466310080: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:03:21.456] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022812856658874112:4:0) after 1m0s
[18:04:21.528] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022812856658874112:4:0)
[18:04:21.528] Timer tick, asking Buildbucket for the build status
[18:04:21.604] Build 8857382794466310080: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:04:21.604] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022812856658874112:5:0) after 1m0s
[18:05:21.633] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022812856658874112:5:0)
[18:05:21.633] Timer tick, asking Buildbucket for the build status
[18:05:22.482] Build 8857382794466310080: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:05:22.482] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022812856658874112:6:0) after 1m0s
[18:06:22.520] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022812856658874112:6:0)
[18:06:22.520] Timer tick, asking Buildbucket for the build status
[18:06:22.883] Build 8857382794466310080: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:06:22.883] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022812856658874112:7:0) after 1m0s
[18:07:22.906] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022812856658874112:7:0)
[18:07:22.906] Timer tick, asking Buildbucket for the build status
[18:07:23.018] Build 8857382794466310080: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:07:23.018] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022812856658874112:8:0) after 1m0s
[18:08:23.028] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022812856658874112:8:0)
[18:08:23.028] Timer tick, asking Buildbucket for the build status
[18:08:23.439] Build 8857382794466310080: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:08:23.439] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022812856658874112:9:0) after 1m0s
[18:09:23.526] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022812856658874112:9:0)
[18:09:23.526] Timer tick, asking Buildbucket for the build status
[18:09:23.826] Build 8857382794466310080: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:09:23.826] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022812856658874112:10:0) after 1m0s
[18:10:23.885] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022812856658874112:10:0)
[18:10:23.885] Timer tick, asking Buildbucket for the build status
[18:10:24.409] Build 8857382794466310080: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:10:24.409] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022812856658874112:11:0) after 1m0s
[18:11:24.426] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022812856658874112:11:0)
[18:11:24.426] Timer tick, asking Buildbucket for the build status
[18:11:24.932] Build 8857382794466310080: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:11:24.932] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022812856658874112:12:0) after 1m0s
[18:12:25.011] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022812856658874112:12:0)
[18:12:25.011] Timer tick, asking Buildbucket for the build status
[18:12:25.163] Build 8857382794466310080: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:12:25.163] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022812856658874112:13:0) after 1m0s
[18:13:25.214] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022812856658874112:13:0)
[18:13:25.214] Timer tick, asking Buildbucket for the build status
[18:13:25.477] Build 8857382794466310080: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:13:25.477] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022812856658874112:14:0) after 1m0s
[18:14:25.555] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022812856658874112:14:0)
[18:14:25.555] Timer tick, asking Buildbucket for the build status
[18:14:25.690] Build 8857382794466310080: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:14:25.690] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022812856658874112:15:0) after 1m0s
[18:15:25.797] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022812856658874112:15:0)
[18:15:25.797] Timer tick, asking Buildbucket for the build status
[18:15:25.874] Build 8857382794466310080: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:15:25.874] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022812856658874112:16:0) after 1m0s
[18:16:26.005] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022812856658874112:16:0)
[18:16:26.005] Timer tick, asking Buildbucket for the build status
[18:16:26.110] Build 8857382794466310080: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:16:26.110] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022812856658874112:17:0) after 1m0s
[18:17:26.243] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022812856658874112:17:0)
[18:17:26.243] Timer tick, asking Buildbucket for the build status
[18:17:26.360] Build 8857382794466310080: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:17:26.360] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022812856658874112:18:0) after 1m0s
[18:18:26.387] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022812856658874112:18:0)
[18:18:26.387] Timer tick, asking Buildbucket for the build status
[18:18:26.566] Build 8857382794466310080: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:18:26.566] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022812856658874112:19:0) after 1m0s
[18:19:26.598] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022812856658874112:19:0)
[18:19:26.598] Timer tick, asking Buildbucket for the build status
[18:19:26.751] Build 8857382794466310080: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:19:26.751] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022812856658874112:20:0) after 1m0s
[18:20:26.856] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022812856658874112:20:0)
[18:20:26.856] Timer tick, asking Buildbucket for the build status
[18:20:26.938] Build 8857382794466310080: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:20:26.938] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022812856658874112:21:0) after 1m0s
[18:21:27.059] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022812856658874112:21:0)
[18:21:27.059] Timer tick, asking Buildbucket for the build status
[18:21:27.285] Build 8857382794466310080: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:21:27.285] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022812856658874112:22:0) after 1m0s
[18:22:27.431] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022812856658874112:22:0)
[18:22:27.431] Timer tick, asking Buildbucket for the build status
[18:22:27.637] Build 8857382794466310080: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:22:27.637] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022812856658874112:23:0) after 1m0s
[18:23:27.778] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022812856658874112:23:0)
[18:23:27.778] Timer tick, asking Buildbucket for the build status
[18:23:27.888] Build 8857382794466310080: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:23:27.888] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022812856658874112:24:0) after 1m0s
[18:24:27.920] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022812856658874112:24:0)
[18:24:27.920] Timer tick, asking Buildbucket for the build status
[18:24:27.991] Build 8857382794466310080: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:24:27.991] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022812856658874112:25:0) after 1m0s
[18:25:28.072] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022812856658874112:25:0)
[18:25:28.072] Timer tick, asking Buildbucket for the build status
[18:25:28.138] Build 8857382794466310080: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:25:28.138] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022812856658874112:26:0) after 1m0s
[18:26:28.160] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022812856658874112:26:0)
[18:26:28.160] Timer tick, asking Buildbucket for the build status
[18:26:28.265] Build 8857382794466310080: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:26:28.265] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022812856658874112:27:0) after 1m0s
[18:27:28.288] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022812856658874112:27:0)
[18:27:28.288] Timer tick, asking Buildbucket for the build status
[18:27:28.705] Build 8857382794466310080: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:27:28.705] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022812856658874112:28:0) after 1m0s
[18:28:28.788] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022812856658874112:28:0)
[18:28:28.788] Timer tick, asking Buildbucket for the build status
[18:28:28.908] Build 8857382794466310080: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:28:28.908] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022812856658874112:29:0) after 1m0s
[18:29:28.932] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022812856658874112:29:0)
[18:29:28.932] Timer tick, asking Buildbucket for the build status
[18:29:29.000] Build 8857382794466310080: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:29:29.000] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022812856658874112:30:0) after 1m0s
[18:30:29.028] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022812856658874112:30:0)
[18:30:29.028] Timer tick, asking Buildbucket for the build status
[18:30:29.729] Build 8857382794466310080: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:30:29.729] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022812856658874112:31:0) after 1m0s
[18:31:29.758] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022812856658874112:31:0)
[18:31:29.758] Timer tick, asking Buildbucket for the build status
[18:31:29.897] Build 8857382794466310080: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:31:29.897] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022812856658874112:32:0) after 1m0s
[18:32:29.977] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022812856658874112:32:0)
[18:32:29.977] Timer tick, asking Buildbucket for the build status
[18:32:30.124] Build 8857382794466310080: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:32:30.124] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022812856658874112:33:0) after 1m0s
[18:33:30.164] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022812856658874112:33:0)
[18:33:30.164] Timer tick, asking Buildbucket for the build status
[18:33:30.227] Build 8857382794466310080: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:33:30.227] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022812856658874112:34:0) after 1m0s
[18:34:30.278] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022812856658874112:34:0)
[18:34:30.278] Timer tick, asking Buildbucket for the build status
[18:34:30.418] Build 8857382794466310080: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:34:30.418] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022812856658874112:35:0) after 1m0s
[18:35:30.448] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022812856658874112:35:0)
[18:35:30.448] Timer tick, asking Buildbucket for the build status
[18:35:30.595] Build 8857382794466310080: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:35:30.595] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022812856658874112:36:0) after 1m0s
[18:36:30.627] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022812856658874112:36:0)
[18:36:30.627] Timer tick, asking Buildbucket for the build status
[18:36:30.719] Build 8857382794466310080: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:36:30.719] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022812856658874112:37:0) after 1m0s
[18:37:30.781] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022812856658874112:37:0)
[18:37:30.781] Timer tick, asking Buildbucket for the build status
[18:37:30.914] Build 8857382794466310080: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:37:30.914] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022812856658874112:38:0) after 1m0s
[18:38:30.948] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022812856658874112:38:0)
[18:38:30.948] Timer tick, asking Buildbucket for the build status
[18:38:31.055] Build 8857382794466310080: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:38:31.055] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022812856658874112:39:0) after 1m0s
[18:39:31.086] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022812856658874112:39:0)
[18:39:31.086] Timer tick, asking Buildbucket for the build status
[18:39:31.392] Build 8857382794466310080: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:39:31.392] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022812856658874112:40:0) after 1m0s
[18:40:31.407] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022812856658874112:40:0)
[18:40:31.407] Timer tick, asking Buildbucket for the build status
[18:40:31.990] Build 8857382794466310080: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:40:31.990] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022812856658874112:41:0) after 1m0s
[18:41:32.029] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022812856658874112:41:0)
[18:41:32.029] Timer tick, asking Buildbucket for the build status
[18:41:32.186] Build 8857382794466310080: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:41:32.186] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022812856658874112:42:0) after 1m0s
[18:42:32.213] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022812856658874112:42:0)
[18:42:32.213] Timer tick, asking Buildbucket for the build status
[18:42:32.329] Build 8857382794466310080: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:42:32.329] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022812856658874112:43:0) after 1m0s
[18:43:32.346] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022812856658874112:43:0)
[18:43:32.346] Timer tick, asking Buildbucket for the build status
[18:43:32.491] Build 8857382794466310080: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:43:32.491] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022812856658874112:44:0) after 1m0s
[18:44:32.597] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022812856658874112:44:0)
[18:44:32.597] Timer tick, asking Buildbucket for the build status
[18:44:32.899] Build 8857382794466310080: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:44:32.899] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022812856658874112:45:0) after 1m0s
[18:45:33.032] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022812856658874112:45:0)
[18:45:33.032] Timer tick, asking Buildbucket for the build status
[18:45:33.253] Build 8857382794466310080: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:45:33.253] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022812856658874112:46:0) after 1m0s
[18:46:33.256] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022812856658874112:46:0)
[18:46:33.256] Timer tick, asking Buildbucket for the build status
[18:46:33.324] Build 8857382794466310080: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:46:33.324] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022812856658874112:47:0) after 1m0s
[18:47:33.363] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022812856658874112:47:0)
[18:47:33.363] Timer tick, asking Buildbucket for the build status
[18:47:33.677] Build 8857382794466310080: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:47:33.677] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022812856658874112:48:0) after 1m0s
[18:48:33.699] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022812856658874112:48:0)
[18:48:33.699] Timer tick, asking Buildbucket for the build status
[18:48:34.092] Build 8857382794466310080: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:48:34.092] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022812856658874112:49:0) after 1m0s
[18:49:34.132] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022812856658874112:49:0)
[18:49:34.132] Timer tick, asking Buildbucket for the build status
[18:49:34.263] Build 8857382794466310080: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:49:34.263] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022812856658874112:50:0) after 1m0s
[18:50:34.291] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022812856658874112:50:0)
[18:50:34.291] Timer tick, asking Buildbucket for the build status
[18:50:34.374] Build 8857382794466310080: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:50:34.374] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022812856658874112:51:0) after 1m0s
[18:51:34.442] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022812856658874112:51:0)
[18:51:34.442] Timer tick, asking Buildbucket for the build status
[18:51:37.728] Build 8857382794466310080: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:51:37.729] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022812856658874112:52:0) after 1m0s
[18:52:37.869] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022812856658874112:52:0)
[18:52:37.869] Timer tick, asking Buildbucket for the build status
[18:52:38.724] Build 8857382794466310080: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:52:38.724] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022812856658874112:53:0) after 1m0s
[18:53:38.784] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022812856658874112:53:0)
[18:53:38.784] Timer tick, asking Buildbucket for the build status
[18:53:38.952] Build 8857382794466310080: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:53:38.952] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022812856658874112:54:0) after 1m0s
[18:54:38.998] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022812856658874112:54:0)
[18:54:38.998] Timer tick, asking Buildbucket for the build status
[18:54:39.334] Build 8857382794466310080: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:54:39.334] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022812856658874112:55:0) after 1m0s
[18:55:39.392] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022812856658874112:55:0)
[18:55:39.392] Timer tick, asking Buildbucket for the build status
[18:55:39.552] Build 8857382794466310080: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:55:39.552] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022812856658874112:56:0) after 1m0s
[18:56:39.624] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022812856658874112:56:0)
[18:56:39.624] Timer tick, asking Buildbucket for the build status
[18:56:39.712] Build 8857382794466310080: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:56:39.712] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022812856658874112:57:0) after 1m0s
[18:57:39.751] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022812856658874112:57:0)
[18:57:39.751] Timer tick, asking Buildbucket for the build status
[18:57:39.954] Build 8857382794466310080: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:57:39.954] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022812856658874112:58:0) after 1m0s
[18:58:40.004] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022812856658874112:58:0)
[18:58:40.004] Timer tick, asking Buildbucket for the build status
[18:58:40.159] Build 8857382794466310080: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:58:40.159] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022812856658874112:59:0) after 1m0s
[18:59:40.176] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022812856658874112:59:0)
[18:59:40.176] Timer tick, asking Buildbucket for the build status
[18:59:40.262] Build 8857382794466310080: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:59:40.262] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022812856658874112:60:0) after 1m0s
[19:00:40.299] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022812856658874112:60:0)
[19:00:40.299] Timer tick, asking Buildbucket for the build status
[19:00:40.386] Build 8857382794466310080: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:00:40.386] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022812856658874112:61:0) after 1m0s
[19:01:40.488] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022812856658874112:61:0)
[19:01:40.488] Timer tick, asking Buildbucket for the build status
[19:01:41.307] Build 8857382794466310080: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:01:41.307] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022812856658874112:62:0) after 1m0s
[19:02:41.390] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022812856658874112:62:0)
[19:02:41.390] Timer tick, asking Buildbucket for the build status
[19:02:41.613] Build 8857382794466310080: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:02:41.613] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022812856658874112:63:0) after 1m0s
[19:03:41.653] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022812856658874112:63:0)
[19:03:41.653] Timer tick, asking Buildbucket for the build status
[19:03:41.733] Build 8857382794466310080: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:03:41.733] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022812856658874112:64:0) after 1m0s
[19:04:41.791] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022812856658874112:64:0)
[19:04:41.791] Timer tick, asking Buildbucket for the build status
[19:04:41.962] Build 8857382794466310080: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:04:41.962] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022812856658874112:65:0) after 1m0s
[19:05:41.990] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022812856658874112:65:0)
[19:05:41.990] Timer tick, asking Buildbucket for the build status
[19:05:42.557] Build 8857382794466310080: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:05:42.557] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022812856658874112:66:0) after 1m0s
[19:06:42.672] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022812856658874112:66:0)
[19:06:42.672] Timer tick, asking Buildbucket for the build status
[19:06:42.870] Build 8857382794466310080: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:06:42.870] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022812856658874112:67:0) after 1m0s
[19:07:42.955] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022812856658874112:67:0)
[19:07:42.955] Timer tick, asking Buildbucket for the build status
[19:07:43.383] Build 8857382794466310080: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:07:43.383] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022812856658874112:68:0) after 1m0s
[19:08:43.399] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022812856658874112:68:0)
[19:08:43.399] Timer tick, asking Buildbucket for the build status
[19:08:43.548] Build 8857382794466310080: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:08:43.548] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022812856658874112:69:0) after 1m0s
[19:09:43.632] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022812856658874112:69:0)
[19:09:43.632] Timer tick, asking Buildbucket for the build status
[19:09:43.712] Build 8857382794466310080: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:09:43.712] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022812856658874112:70:0) after 1m0s
[19:10:43.766] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022812856658874112:70:0)
[19:10:43.766] Timer tick, asking Buildbucket for the build status
[19:10:43.938] Build 8857382794466310080: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:10:43.938] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022812856658874112:71:0) after 1m0s
[19:11:43.966] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022812856658874112:71:0)
[19:11:43.966] Timer tick, asking Buildbucket for the build status
[19:11:44.108] Build 8857382794466310080: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:11:44.108] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022812856658874112:72:0) after 1m0s
[19:12:44.163] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022812856658874112:72:0)
[19:12:44.163] Timer tick, asking Buildbucket for the build status
[19:12:44.271] Build 8857382794466310080: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:12:44.271] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022812856658874112:73:0) after 1m0s
[19:13:44.454] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022812856658874112:73:0)
[19:13:44.454] Timer tick, asking Buildbucket for the build status
[19:13:44.558] Build 8857382794466310080: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:13:44.558] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022812856658874112:74:0) after 1m0s
[19:14:44.598] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022812856658874112:74:0)
[19:14:44.598] Timer tick, asking Buildbucket for the build status
[19:14:44.866] Build 8857382794466310080: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:14:44.866] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022812856658874112:75:0) after 1m0s
[19:15:44.909] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022812856658874112:75:0)
[19:15:44.909] Timer tick, asking Buildbucket for the build status
[19:15:44.979] Build 8857382794466310080: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:15:44.979] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022812856658874112:76:0) after 1m0s
[19:16:45.018] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022812856658874112:76:0)
[19:16:45.018] Timer tick, asking Buildbucket for the build status
[19:16:45.088] Build 8857382794466310080: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:16:45.088] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022812856658874112:77:0) after 1m0s
[19:17:45.214] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022812856658874112:77:0)
[19:17:45.214] Timer tick, asking Buildbucket for the build status
[19:17:45.840] Build 8857382794466310080: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:17:45.840] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022812856658874112:78:0) after 1m0s
[19:18:45.925] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022812856658874112:78:0)
[19:18:45.925] Timer tick, asking Buildbucket for the build status
[19:18:46.222] Build 8857382794466310080: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:18:46.222] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022812856658874112:79:0) after 1m0s
[19:19:46.251] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022812856658874112:79:0)
[19:19:46.251] Timer tick, asking Buildbucket for the build status
[19:19:46.329] Build 8857382794466310080: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:19:46.329] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022812856658874112:80:0) after 1m0s
[19:20:46.459] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022812856658874112:80:0)
[19:20:46.459] Timer tick, asking Buildbucket for the build status
[19:20:46.560] Build 8857382794466310080: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:20:46.560] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022812856658874112:81:0) after 1m0s
[19:21:46.645] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022812856658874112:81:0)
[19:21:46.645] Timer tick, asking Buildbucket for the build status
[19:21:47.223] Build 8857382794466310080: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:21:47.223] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022812856658874112:82:0) after 1m0s
[19:22:47.228] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022812856658874112:82:0)
[19:22:47.228] Timer tick, asking Buildbucket for the build status
[19:22:47.383] Build 8857382794466310080: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:22:47.383] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022812856658874112:83:0) after 1m0s
[19:23:47.397] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022812856658874112:83:0)
[19:23:47.397] Timer tick, asking Buildbucket for the build status
[19:23:47.537] Build 8857382794466310080: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:23:47.537] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022812856658874112:84:0) after 1m0s
[19:24:47.570] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022812856658874112:84:0)
[19:24:47.570] Timer tick, asking Buildbucket for the build status
[19:24:47.670] Build 8857382794466310080: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:24:47.670] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022812856658874112:85:0) after 1m0s
[19:25:47.750] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022812856658874112:85:0)
[19:25:47.750] Timer tick, asking Buildbucket for the build status
[19:25:47.817] Build 8857382794466310080: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:25:47.817] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022812856658874112:86:0) after 1m0s
[19:26:47.970] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022812856658874112:86:0)
[19:26:47.970] Timer tick, asking Buildbucket for the build status
[19:26:48.048] Build 8857382794466310080: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:26:48.048] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022812856658874112:87:0) after 1m0s
[19:27:48.196] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022812856658874112:87:0)
[19:27:48.196] Timer tick, asking Buildbucket for the build status
[19:27:48.309] Build 8857382794466310080: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:27:48.309] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022812856658874112:88:0) after 1m0s
[19:28:48.391] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022812856658874112:88:0)
[19:28:48.391] Timer tick, asking Buildbucket for the build status
[19:28:48.547] Build 8857382794466310080: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:28:48.547] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022812856658874112:89:0) after 1m0s
[19:29:48.613] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022812856658874112:89:0)
[19:29:48.613] Timer tick, asking Buildbucket for the build status
[19:29:49.343] Build 8857382794466310080: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:29:49.343] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022812856658874112:90:0) after 1m0s
[19:30:49.540] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022812856658874112:90:0)
[19:30:49.540] Timer tick, asking Buildbucket for the build status
[19:30:50.222] Build 8857382794466310080: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:30:50.222] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022812856658874112:91:0) after 1m0s
[19:31:50.255] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022812856658874112:91:0)
[19:31:50.255] Timer tick, asking Buildbucket for the build status
[19:31:50.431] Build 8857382794466310080: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:31:50.431] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022812856658874112:92:0) after 1m0s
[19:32:50.467] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022812856658874112:92:0)
[19:32:50.467] Timer tick, asking Buildbucket for the build status
[19:32:50.646] Build 8857382794466310080: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:32:50.646] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022812856658874112:93:0) after 1m0s
[19:33:50.710] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022812856658874112:93:0)
[19:33:50.710] Timer tick, asking Buildbucket for the build status
[19:33:50.790] Build 8857382794466310080: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:33:50.790] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022812856658874112:94:0) after 1m0s
[19:34:50.840] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022812856658874112:94:0)
[19:34:50.840] Timer tick, asking Buildbucket for the build status
[19:34:50.919] Build 8857382794466310080: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:34:50.919] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022812856658874112:95:0) after 1m0s
[19:35:50.985] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022812856658874112:95:0)
[19:35:50.985] Timer tick, asking Buildbucket for the build status
[19:35:51.072] Build 8857382794466310080: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:35:51.072] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022812856658874112:96:0) after 1m0s
[19:36:51.103] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022812856658874112:96:0)
[19:36:51.103] Timer tick, asking Buildbucket for the build status
[19:36:51.208] Build 8857382794466310080: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:36:51.208] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022812856658874112:97:0) after 1m0s
[19:37:51.295] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022812856658874112:97:0)
[19:37:51.295] Timer tick, asking Buildbucket for the build status
[19:37:51.474] Build 8857382794466310080: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:37:51.474] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022812856658874112:98:0) after 1m0s
[19:38:51.576] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022812856658874112:98:0)
[19:38:51.576] Timer tick, asking Buildbucket for the build status
[19:38:51.818] Build 8857382794466310080: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:38:51.818] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022812856658874112:99:0) after 1m0s
[19:39:51.881] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022812856658874112:99:0)
[19:39:51.881] Timer tick, asking Buildbucket for the build status
[19:39:52.131] Build 8857382794466310080: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:39:52.131] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022812856658874112:100:0) after 1m0s
[19:40:52.202] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022812856658874112:100:0)
[19:40:52.202] Timer tick, asking Buildbucket for the build status
[19:40:52.581] Build 8857382794466310080: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:40:52.581] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022812856658874112:101:0) after 1m0s
[19:41:52.643] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022812856658874112:101:0)
[19:41:52.643] Timer tick, asking Buildbucket for the build status
[19:41:52.729] Build 8857382794466310080: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:41:52.729] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022812856658874112:102:0) after 1m0s
[19:42:52.880] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022812856658874112:102:0)
[19:42:52.880] Timer tick, asking Buildbucket for the build status
[19:42:53.124] Build 8857382794466310080: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:42:53.124] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022812856658874112:103:0) after 1m0s
[19:43:53.260] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022812856658874112:103:0)
[19:43:53.260] Timer tick, asking Buildbucket for the build status
[19:43:53.533] Build 8857382794466310080: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:43:53.533] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022812856658874112:104:0) after 1m0s
[19:44:53.617] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022812856658874112:104:0)
[19:44:53.617] Timer tick, asking Buildbucket for the build status
[19:44:53.700] Build 8857382794466310080: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:44:53.700] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022812856658874112:105:0) after 1m0s
[19:45:53.772] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022812856658874112:105:0)
[19:45:53.772] Timer tick, asking Buildbucket for the build status
[19:45:53.993] Build 8857382794466310080: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:45:53.993] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9022812856658874112:106:0) after 1m0s
[19:46:19.659] Received PubSub notification, asking Buildbucket for the build status
[19:46:19.735] Build 8857382794466310080: status "COMPLETED", result "SUCCESS", failure_reason "", cancelation_reason ""
[19:46:19.735] Buildbucket build:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "PROD",
"completed_ts": "1611344777319696",
"created_by": "project:chromium",
"created_ts": "1611338540546510",
"id": "8857382794466310080",
"parameters_json": "{\"builder_name\": \"linux-chromeos-dbg\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"30d67bcef67ee39b4145f607ce5cad38e951d6cb\"}}",
"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\": \"30d67bcef67ee39b4145f607ce5cad38e951d6cb\", \"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-89-mvey\", \"branch\": \"refs/heads/master\", \"builder_group\": \"chromium.chromiumos\", \"buildername\": \"linux-chromeos-dbg\", \"buildnumber\": 22305, \"got_angle_revision\": \"b745f6df8801cbaed290bf9a486f10ba1432e395\", \"got_dawn_revision\": \"72cd1a5e8953292dd97c4006973850c880d39db8\", \"got_nacl_revision\": \"cb31feffa500401c95c6c44d88b7c358236bca36\", \"got_revision\": \"30d67bcef67ee39b4145f607ce5cad38e951d6cb\", \"got_revision_cp\": \"refs/heads/master@{#846201}\", \"got_swarming_client_revision\": \"1a072711d4388c62e02480fabc26c68c24494be9\", \"got_swiftshader_revision\": \"1d5174b9dc3be500d63daf227b163b5e86bbc7b5\", \"got_v8_revision\": \"bef4c3936da3f8d002a18ed1836e80f34bd4e9f0\", \"got_v8_revision_cp\": \"refs/heads/9.0.51@{#1}\", \"got_webrtc_revision\": \"11215febb9500c597c940a40f1b9fe86c939413f\", \"got_webrtc_revision_cp\": \"refs/heads/master@{#33056}\", \"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\": \"30d67bcef67ee39b4145f607ce5cad38e951d6cb\", \"swarm_hashes_refs/heads/master(at){#846201}_without_patch\": {\"absl_hardening_tests\": \"50da0b39cf005bfd98f3592db9b436f3d1899355\", \"accessibility_unittests\": \"55b4d281fc89460062a156a4b0e11f99636a0892\", \"angle_unittests\": \"a085c0f347875c0a6347ea6c5615c0b564f2de39\", \"app_list_unittests\": \"f8340e80cff5a868c64af6f9541d3d18ee4d4cce\", \"app_shell_unittests\": \"9b8c85af9f4c2f7300fda0d3555887521118b791\", \"ash_unittests\": \"49bf4c19bf94255acb5bdeb073a52d6dc04f1b9c\", \"aura_unittests\": \"a707c4dd3d7095dcba81bc02aae2f6b99d4a0eb0\", \"base_unittests\": \"68f2e23b307f78ca6569f0eb44ef3de7a6fe3bff\", \"base_util_unittests\": \"facee854a38769034e0284332b5ba93e87f5507a\", \"blink_common_unittests\": \"8f4eb7e3feb90497e29e0b6baf8b0fe71acd5a81\", \"blink_fuzzer_unittests\": \"76c82706df89785d005a00909d8dc7d1dc4321eb\", \"blink_heap_unittests\": \"ac2e97464dc75d77f825e794beda7c0bdce5492d\", \"blink_platform_unittests\": \"d5e2e4e0b3cef7b2e4d8a5ca6d0d4680ac054a9c\", \"blink_unittests\": \"f10728c894f65d8664f3f2857fb04f42b6bfd8f5\", \"boringssl_crypto_tests\": \"0716e04ff44b8cf4e779a16b1ef42d546c7d0835\", \"boringssl_ssl_tests\": \"f3c151b3fed9aceee1dca667df29be89d7b7dd05\", \"browser_tests\": \"a3aa0a3c54a45eba82fd07766079e7eae6845e23\", \"capture_unittests\": \"7ce824c3da34b61bba0db41aa9cf92df429ae831\", \"cast_unittests\": \"dda8cdf7f30d72249e2fc7dd81e9f525ceaf3dcd\", \"cc_unittests\": \"1e68ab2144c88b9e78c01dcffc6f1b070732479e\", \"chrome_app_unittests\": \"2822625e6e380df060a2b87ceca89d17d9b3fdd2\", \"chromedriver_unittests\": \"374b3fbc109a329b3eea9e60aaa865b860a5ad30\", \"chromeos_components_unittests\": \"2d12aba83a25b49dff982be718e11cdd0bdd703a\", \"chromeos_unittests\": \"11977ca8fc875e981e9c5a30051455954f98b262\", \"components_browsertests\": \"1a4263e6636f753b1118c9f1eb8b37c101acb67f\", \"components_unittests\": \"fb55c4ea0c261536a95953b4d7a3863cf972881a\", \"compositor_unittests\": \"ee0e202db3c43e283e20fa1e8879644421a02896\", \"content_browsertests\": \"6f629bc1f18f3de714305a5f5925baf0fc211444\", \"content_unittests\": \"ce0229ea57bc3dc6ca1de9a50d6992de18b52651\", \"crashpad_tests\": \"b63ca5ca35176578e6b95851198194f3368f599c\", \"crypto_unittests\": \"839c16cf03846cc8d74c6f14cd36f4df8ff8e897\", \"dbus_unittests\": \"cafb7996f2295ebb318922f849f7e2396cc00b08\", \"device_unittests\": \"b19cd9af2906d6ccae98969d4888ea55f4874c09\", \"display_unittests\": \"c0ee9338dfd69764bb2052116e527163840e1b85\", \"events_unittests\": \"38901d57fb1c8a9387ef72ac3e6093301f4e654e\", \"exo_unittests\": \"3ad535c18042f0179a1b83b16ff0a386be45ecc5\", \"extensions_browsertests\": \"fe06d56be3bf6fa3a84fab1a469f95379468127e\", \"extensions_unittests\": \"f617f536cad63e03c8ef63f2752062ec680cad95\", \"filesystem_service_unittests\": \"7aa6918bd9b13f6f6ccb0748bc56680440afd908\", \"gcm_unit_tests\": \"4e3c5b73a2ce60885cfa78cd25459f0e68901dea\", \"gfx_unittests\": \"e454998392bb01298d83b8055fb5bece38d79fdf\", \"gin_unittests\": \"cc846b08f7664f2a53d920eaa102f63abb9255d7\", \"gl_unittests_ozone\": \"0602a60ac3891ffc4c1575ad6aa67b895a536605\", \"google_apis_unittests\": \"695348e483233d51c52112c1fe79160c6b6db4cd\", \"gpu_unittests\": \"b12bedf6719b38c31f2f03ce3543979bef1b304e\", \"gwp_asan_unittests\": \"3275e9e1ab1f8cb9754ea2f3ee6a6950d3399e59\", \"interactive_ui_tests\": \"c6ac3cefdfaba51198bffa76696786a28451cf43\", \"ipc_tests\": \"03bea50b2c447926db0afe07fe6b46864edd04ad\", \"jingle_unittests\": \"5618329e2725a8fdd3de8f88180ac8f19db0e39e\", \"keyboard_unittests\": \"d1891f96fdda09023a10d517003922522ec417b4\", \"latency_unittests\": \"f7374b239b53c5e1620a8e964a708803fe9a2f65\", \"libjingle_xmpp_unittests\": \"e3632b2bb933f408288720672a35325e2988b0ff\", \"liburlpattern_unittests\": \"ba5beb881a16dfb1aafd5f5fcfb7220378fd1512\", \"media_blink_unittests\": \"94a18db966d181fd05a77699fc57bec25b9b8c53\", \"media_unittests\": \"4a5e781b15c31bd9f70e3852461d6a169851eee9\", \"message_center_unittests\": \"68c2923fe128a8458bed7fbc7dc535214c2fe948\", \"midi_unittests\": \"8d1e750195c4cf7f164b195b5fe205a7d4e4173d\", \"mojo_core_unittests\": \"2911427ef5e085fe6b50375a43e4061d9428e64a\", \"mojo_unittests\": \"5d1ab2ea143a568d2b1b6571cdb5a2d6f9e14e5e\", \"nacl_helper_nonsfi_unittests\": \"cd5e7b20faf7698426642ddfd63b25185550d4a9\", \"nacl_loader_unittests\": \"1822b07a6f1db8bbef7803fde8c3e05d9e689c22\", \"native_theme_unittests\": \"9848d6b82eaa35d91c4707dac9284b2845e04005\", \"net_unittests\": \"e9131fbe95fb900cf2513b027948a1d5b3c6e1cd\", \"ozone_gl_unittests\": \"fe1613bb7a647a9ce5910c3a509e193c578a045f\", \"ozone_unittests\": \"9011779dc9f192a4890fe86b6314775b81da3972\", \"ozone_x11_unittests\": \"2be5c3f2f788a3640992f03a5728dd42d0ea8301\", \"pdf_unittests\": \"b46e5fe626da0b1e175b5de966919f5e9d12f72f\", \"perfetto_unittests\": \"8ce9584c8275843224595e606c0ad3808b24f020\", \"ppapi_unittests\": \"83677325c94f7b687786f2ac13fbbaa3a32d0a4d\", \"printing_unittests\": \"8a1f93068bbc7abc2686eaff582d46cf604849d4\", \"remoting_unittests\": \"11a64f670bc3cda3772ecf21ce6601f008ca6494\", \"sandbox_linux_unittests\": \"8a96c3e362b8fb740e57045d7f60cc7bf6f5defb\", \"service_manager_unittests\": \"9d01aeff87dbc9b3b382be3e5b7bee8b6c5f0719\", \"services_unittests\": \"d1828f62f9b11e2cc3e5e346cfbd497ccf1f2f5a\", \"shell_dialogs_unittests\": \"d5c7134176545eec8d90a70470b6986e43f6fb0f\", \"shell_encryption_unittests\": \"b4a3860b18041086d6c3473bfda986ce4e62f58a\", \"skia_unittests\": \"f2c2739c03b66196264360c2522451d41ea17897\", \"snapshot_unittests\": \"f19dc38e4b6411a8734f65688bd707132ee986b6\", \"sql_unittests\": \"e457c535e0010d82056a47bbdd155d248b41ba93\", \"storage_unittests\": \"359b7cefe9ad747a0a484389d0c5fbc8b8dace3c\", \"sync_integration_tests\": \"8e44f2bf6096ac49abd46c89b3b5d4ae329b30fc\", \"traffic_annotation_auditor_unittests\": \"eefceb43f9f6973e6fd4efc4d99f570b04984203\", \"ui_base_unittests\": \"99db27b69d4956c6563309a7d488a609d3c8fe11\", \"ui_chromeos_unittests\": \"713ff27b1ad677b0e90977f54de47da948994b3d\", \"ui_touch_selection_unittests\": \"036d54a7d212f785e13b96c5f71eef24fbd47c43\", \"unit_tests\": \"9cdeeab7b517491b3ce7de781b924c5800e99351\", \"url_unittests\": \"719a7263e27a2b5a0645c787227c28f542d481c8\", \"usage_time_limit_unittests\": \"71d05445ef51933acc0faffb996e6d8410314ff0\", \"views_unittests\": \"d3f23f76d8f0ee0dff0904cfb65896b54eb768fb\", \"viz_unittests\": \"7c84525caed1d044dc84e5e88bacd36ca65a6593\", \"wm_unittests\": \"0fb8a787bfd256b5fc57004eb3b5a45022c9c8f3\", \"wtf_unittests\": \"fe61aef06bc38f072c6cd21b55850e864bdadf53\", \"zlib_unittests\": \"e3b26e84e11f7813c341b686e78f2609be36253a\"}}, \"swarming\": {\"bot_dimensions\": {\"builderless\": [\"1\"], \"caches\": [\"builder_093e8a6336a6e6d4670d6f5128e7c73730afadf3bd7f9284d26d8f79182f8ce5_v2\", \"builder_4973d939604d11dcbaec68575e69c80c756ff63e355ab013b29b8bca26434b7c_v2\", \"builder_61faa0d0c1c079ecf670d8cfa4f78ad3b1687a5534233c7377462c3ee6819708_v2\", \"builder_8e7ad9a10a7772feba5b42dda56992e918fe88f23579c3ddaf696dde66ee4238_v2\", \"builder_db6a6033e460ced730b3940170fe4cf923f58c29fb56731f98470df5edf70e65_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-89-mvey\"], \"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\": [\"5671-1d9dea8\"], \"ssd\": [\"0\"], \"zone\": [\"us\", \"us-central\", \"us-central1\", \"us-central1-b\"]}}}",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"started_ts": "1611338543899704",
"status": "COMPLETED",
"status_changed_ts": "1611344778750044",
"tags": [
"build_address:luci.chromium.ci/linux-chromeos-dbg/22305",
"builder:linux-chromeos-dbg",
"buildset:commit/git/30d67bcef67ee39b4145f607ce5cad38e951d6cb",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/30d67bcef67ee39b4145f607ce5cad38e951d6cb",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9022812856658874112",
"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/8857382794466310080/+/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:514414719802d610",
"user_agent:luci-scheduler"
],
"updated_ts": "1611344778756482",
"url": "https://ci.chromium.org/b/8857382794466310080",
"utcnow_ts": "1611344779723419"
}
}
[19:46:19.735] Invocation finished in 1h44m0.662924547s with status SUCCEEDED