[17:39:41.014] New invocation is queued and will start shortly
[17:39:42.379] Starting the invocation (attempt 1)
[17:39:42.448] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[17:39:42.448] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[17:39:42.448] Buildbucket request:
{
"bucket": "luci.chromium.ci",
"client_operation_id": "9020368162613578128",
"parameters_json": "{\"builder_name\":\"linux-chromeos-dbg\",\"properties\":{\"branch\":\"refs/heads/master\",\"repository\":\"https://chromium.googlesource.com/chromium/src\",\"revision\":\"8065b6de170411cd8766147febdfd9213f156d8d\"}}",
"pubsub_callback": {
"auth_token": "...",
"topic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
},
"tags": [
"builder:linux-chromeos-dbg",
"scheduler_invocation_id:9020368162613578128",
"scheduler_job_id:chromium/linux-chromeos-dbg",
"user_agent:luci-scheduler",
"buildset:commit/git/8065b6de170411cd8766147febdfd9213f156d8d",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/8065b6de170411cd8766147febdfd9213f156d8d",
"gitiles_ref:refs/heads/master"
]
}
[17:39:43.027] Buildbucket response:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "PROD",
"created_by": "project:chromium",
"created_ts": "1613669982524419",
"id": "8854938100362922672",
"parameters_json": "{\"builder_name\": \"linux-chromeos-dbg\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"8065b6de170411cd8766147febdfd9213f156d8d\"}}",
"project": "chromium",
"result_details_json": "{\"properties\": {}}",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"status": "SCHEDULED",
"status_changed_ts": "1613669982874485",
"tags": [
"build_address:luci.chromium.ci/linux-chromeos-dbg/22682",
"builder:linux-chromeos-dbg",
"buildset:commit/git/8065b6de170411cd8766147febdfd9213f156d8d",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/8065b6de170411cd8766147febdfd9213f156d8d",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9020368162613578128",
"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/8854938100362922672/+/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": "1613669982874587",
"url": "https://ci.chromium.org/b/8854938100362922672",
"utcnow_ts": "1613669983021033"
}
}
[17:39:43.027] Task URL: https://ci.chromium.org/b/8854938100362922672
[17:39:43.027] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020368162613578128:2:0) after 1m0s
[17:39:55.573] Received PubSub notification, asking Buildbucket for the build status
[17:39:55.815] Build 8854938100362922672: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:40:43.099] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020368162613578128:2:0)
[17:40:43.099] Timer tick, asking Buildbucket for the build status
[17:40:43.244] Build 8854938100362922672: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:40:43.244] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020368162613578128:4:0) after 1m0s
[17:41:43.328] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020368162613578128:4:0)
[17:41:43.328] Timer tick, asking Buildbucket for the build status
[17:41:43.471] Build 8854938100362922672: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:41:43.472] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020368162613578128:5:0) after 1m0s
[17:42:43.572] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020368162613578128:5:0)
[17:42:43.572] Timer tick, asking Buildbucket for the build status
[17:42:43.777] Build 8854938100362922672: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:42:43.777] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020368162613578128:6:0) after 1m0s
[17:43:43.901] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020368162613578128:6:0)
[17:43:43.901] Timer tick, asking Buildbucket for the build status
[17:43:43.995] Build 8854938100362922672: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:43:43.995] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020368162613578128:7:0) after 1m0s
[17:44:44.070] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020368162613578128:7:0)
[17:44:44.070] Timer tick, asking Buildbucket for the build status
[17:44:44.139] Build 8854938100362922672: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:44:44.139] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020368162613578128:8:0) after 1m0s
[17:45:44.204] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020368162613578128:8:0)
[17:45:44.204] Timer tick, asking Buildbucket for the build status
[17:45:44.296] Build 8854938100362922672: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:45:44.296] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020368162613578128:9:0) after 1m0s
[17:46:44.381] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020368162613578128:9:0)
[17:46:44.381] Timer tick, asking Buildbucket for the build status
[17:46:44.526] Build 8854938100362922672: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:46:44.526] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020368162613578128:10:0) after 1m0s
[17:47:44.544] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020368162613578128:10:0)
[17:47:44.544] Timer tick, asking Buildbucket for the build status
[17:47:44.827] Build 8854938100362922672: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:47:44.827] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020368162613578128:11:0) after 1m0s
[17:48:44.973] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020368162613578128:11:0)
[17:48:44.973] Timer tick, asking Buildbucket for the build status
[17:48:45.527] Build 8854938100362922672: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:48:45.527] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020368162613578128:12:0) after 1m0s
[17:49:45.591] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020368162613578128:12:0)
[17:49:45.591] Timer tick, asking Buildbucket for the build status
[17:49:45.688] Build 8854938100362922672: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:49:45.688] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020368162613578128:13:0) after 1m0s
[17:50:45.710] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020368162613578128:13:0)
[17:50:45.710] Timer tick, asking Buildbucket for the build status
[17:50:46.034] Build 8854938100362922672: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:50:46.034] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020368162613578128:14:0) after 1m0s
[17:51:46.112] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020368162613578128:14:0)
[17:51:46.112] Timer tick, asking Buildbucket for the build status
[17:51:46.185] Build 8854938100362922672: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:51:46.185] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020368162613578128:15:0) after 1m0s
[17:52:46.213] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020368162613578128:15:0)
[17:52:46.213] Timer tick, asking Buildbucket for the build status
[17:52:46.279] Build 8854938100362922672: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:52:46.279] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020368162613578128:16:0) after 1m0s
[17:53:46.332] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020368162613578128:16:0)
[17:53:46.332] Timer tick, asking Buildbucket for the build status
[17:53:46.410] Build 8854938100362922672: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:53:46.410] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020368162613578128:17:0) after 1m0s
[17:54:46.438] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020368162613578128:17:0)
[17:54:46.438] Timer tick, asking Buildbucket for the build status
[17:54:46.570] Build 8854938100362922672: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:54:46.570] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020368162613578128:18:0) after 1m0s
[17:55:46.621] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020368162613578128:18:0)
[17:55:46.621] Timer tick, asking Buildbucket for the build status
[17:55:46.712] Build 8854938100362922672: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:55:46.712] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020368162613578128:19:0) after 1m0s
[17:56:46.769] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020368162613578128:19:0)
[17:56:46.769] Timer tick, asking Buildbucket for the build status
[17:56:46.855] Build 8854938100362922672: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:56:46.855] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020368162613578128:20:0) after 1m0s
[17:57:46.902] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020368162613578128:20:0)
[17:57:46.902] Timer tick, asking Buildbucket for the build status
[17:57:47.004] Build 8854938100362922672: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:57:47.004] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020368162613578128:21:0) after 1m0s
[17:58:47.023] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020368162613578128:21:0)
[17:58:47.023] Timer tick, asking Buildbucket for the build status
[17:58:47.106] Build 8854938100362922672: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:58:47.106] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020368162613578128:22:0) after 1m0s
[17:59:47.151] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020368162613578128:22:0)
[17:59:47.151] Timer tick, asking Buildbucket for the build status
[17:59:47.218] Build 8854938100362922672: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:59:47.218] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020368162613578128:23:0) after 1m0s
[18:00:47.199] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020368162613578128:23:0)
[18:00:47.199] Timer tick, asking Buildbucket for the build status
[18:00:47.411] Build 8854938100362922672: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:00:47.411] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020368162613578128:24:0) after 1m0s
[18:01:47.414] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020368162613578128:24:0)
[18:01:47.414] Timer tick, asking Buildbucket for the build status
[18:01:47.519] Build 8854938100362922672: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:01:47.519] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020368162613578128:25:0) after 1m0s
[18:02:47.566] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020368162613578128:25:0)
[18:02:47.566] Timer tick, asking Buildbucket for the build status
[18:02:47.903] Build 8854938100362922672: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:02:47.903] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020368162613578128:26:0) after 1m0s
[18:03:47.932] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020368162613578128:26:0)
[18:03:47.932] Timer tick, asking Buildbucket for the build status
[18:03:48.014] Build 8854938100362922672: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:03:48.014] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020368162613578128:27:0) after 1m0s
[18:04:48.036] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020368162613578128:27:0)
[18:04:48.036] Timer tick, asking Buildbucket for the build status
[18:04:48.414] Build 8854938100362922672: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:04:48.414] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020368162613578128:28:0) after 1m0s
[18:05:48.477] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020368162613578128:28:0)
[18:05:48.477] Timer tick, asking Buildbucket for the build status
[18:05:48.582] Build 8854938100362922672: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:05:48.582] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020368162613578128:29:0) after 1m0s
[18:06:48.603] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020368162613578128:29:0)
[18:06:48.603] Timer tick, asking Buildbucket for the build status
[18:06:48.989] Build 8854938100362922672: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:06:48.989] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020368162613578128:30:0) after 1m0s
[18:07:48.998] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020368162613578128:30:0)
[18:07:48.998] Timer tick, asking Buildbucket for the build status
[18:07:49.076] Build 8854938100362922672: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:07:49.076] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020368162613578128:31:0) after 1m0s
[18:08:49.102] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020368162613578128:31:0)
[18:08:49.102] Timer tick, asking Buildbucket for the build status
[18:08:49.180] Build 8854938100362922672: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:08:49.180] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020368162613578128:32:0) after 1m0s
[18:09:49.233] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020368162613578128:32:0)
[18:09:49.233] Timer tick, asking Buildbucket for the build status
[18:09:49.325] Build 8854938100362922672: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:09:49.325] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020368162613578128:33:0) after 1m0s
[18:10:49.396] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020368162613578128:33:0)
[18:10:49.396] Timer tick, asking Buildbucket for the build status
[18:10:49.601] Build 8854938100362922672: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:10:49.601] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020368162613578128:34:0) after 1m0s
[18:11:49.639] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020368162613578128:34:0)
[18:11:49.639] Timer tick, asking Buildbucket for the build status
[18:11:49.726] Build 8854938100362922672: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:11:49.726] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020368162613578128:35:0) after 1m0s
[18:12:49.800] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020368162613578128:35:0)
[18:12:49.800] Timer tick, asking Buildbucket for the build status
[18:12:49.901] Build 8854938100362922672: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:12:49.901] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020368162613578128:36:0) after 1m0s
[18:13:49.952] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020368162613578128:36:0)
[18:13:49.952] Timer tick, asking Buildbucket for the build status
[18:13:50.182] Build 8854938100362922672: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:13:50.182] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020368162613578128:37:0) after 1m0s
[18:14:50.193] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020368162613578128:37:0)
[18:14:50.193] Timer tick, asking Buildbucket for the build status
[18:14:50.542] Build 8854938100362922672: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:14:50.542] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020368162613578128:38:0) after 1m0s
[18:15:50.615] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020368162613578128:38:0)
[18:15:50.615] Timer tick, asking Buildbucket for the build status
[18:15:50.736] Build 8854938100362922672: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:15:50.736] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020368162613578128:39:0) after 1m0s
[18:16:50.847] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020368162613578128:39:0)
[18:16:50.847] Timer tick, asking Buildbucket for the build status
[18:16:50.990] Build 8854938100362922672: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:16:50.990] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020368162613578128:40:0) after 1m0s
[18:17:51.141] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020368162613578128:40:0)
[18:17:51.141] Timer tick, asking Buildbucket for the build status
[18:17:51.326] Build 8854938100362922672: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:17:51.326] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020368162613578128:41:0) after 1m0s
[18:18:51.410] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020368162613578128:41:0)
[18:18:51.410] Timer tick, asking Buildbucket for the build status
[18:18:51.617] Build 8854938100362922672: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:18:51.617] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020368162613578128:42:0) after 1m0s
[18:19:51.644] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020368162613578128:42:0)
[18:19:51.644] Timer tick, asking Buildbucket for the build status
[18:19:51.760] Build 8854938100362922672: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:19:51.760] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020368162613578128:43:0) after 1m0s
[18:20:51.879] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020368162613578128:43:0)
[18:20:51.879] Timer tick, asking Buildbucket for the build status
[18:20:51.977] Build 8854938100362922672: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:20:51.977] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020368162613578128:44:0) after 1m0s
[18:21:52.061] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020368162613578128:44:0)
[18:21:52.061] Timer tick, asking Buildbucket for the build status
[18:21:52.282] Build 8854938100362922672: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:21:52.282] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020368162613578128:45:0) after 1m0s
[18:22:52.359] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020368162613578128:45:0)
[18:22:52.359] Timer tick, asking Buildbucket for the build status
[18:22:52.740] Build 8854938100362922672: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:22:52.740] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020368162613578128:46:0) after 1m0s
[18:23:52.793] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020368162613578128:46:0)
[18:23:52.793] Timer tick, asking Buildbucket for the build status
[18:23:52.895] Build 8854938100362922672: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:23:52.895] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020368162613578128:47:0) after 1m0s
[18:24:52.922] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020368162613578128:47:0)
[18:24:52.922] Timer tick, asking Buildbucket for the build status
[18:24:53.310] Build 8854938100362922672: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:24:53.310] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020368162613578128:48:0) after 1m0s
[18:25:53.335] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020368162613578128:48:0)
[18:25:53.335] Timer tick, asking Buildbucket for the build status
[18:25:53.433] Build 8854938100362922672: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:25:53.433] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020368162613578128:49:0) after 1m0s
[18:26:53.456] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020368162613578128:49:0)
[18:26:53.456] Timer tick, asking Buildbucket for the build status
[18:26:53.688] Build 8854938100362922672: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:26:53.688] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020368162613578128:50:0) after 1m0s
[18:27:53.686] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020368162613578128:50:0)
[18:27:53.686] Timer tick, asking Buildbucket for the build status
[18:27:53.786] Build 8854938100362922672: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:27:53.786] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020368162613578128:51:0) after 1m0s
[18:28:53.837] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020368162613578128:51:0)
[18:28:53.837] Timer tick, asking Buildbucket for the build status
[18:28:54.062] Build 8854938100362922672: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:28:54.062] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020368162613578128:52:0) after 1m0s
[18:29:54.141] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020368162613578128:52:0)
[18:29:54.141] Timer tick, asking Buildbucket for the build status
[18:29:54.452] Build 8854938100362922672: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:29:54.453] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020368162613578128:53:0) after 1m0s
[18:30:54.475] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020368162613578128:53:0)
[18:30:54.475] Timer tick, asking Buildbucket for the build status
[18:30:54.562] Build 8854938100362922672: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:30:54.562] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020368162613578128:54:0) after 1m0s
[18:31:54.605] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020368162613578128:54:0)
[18:31:54.605] Timer tick, asking Buildbucket for the build status
[18:31:54.723] Build 8854938100362922672: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:31:54.723] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020368162613578128:55:0) after 1m0s
[18:32:54.716] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020368162613578128:55:0)
[18:32:54.716] Timer tick, asking Buildbucket for the build status
[18:32:55.136] Build 8854938100362922672: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:32:55.136] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020368162613578128:56:0) after 1m0s
[18:33:55.170] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020368162613578128:56:0)
[18:33:55.170] Timer tick, asking Buildbucket for the build status
[18:33:55.246] Build 8854938100362922672: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:33:55.246] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020368162613578128:57:0) after 1m0s
[18:34:55.296] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020368162613578128:57:0)
[18:34:55.296] Timer tick, asking Buildbucket for the build status
[18:34:55.403] Build 8854938100362922672: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:34:55.403] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020368162613578128:58:0) after 1m0s
[18:35:55.413] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020368162613578128:58:0)
[18:35:55.413] Timer tick, asking Buildbucket for the build status
[18:35:55.490] Build 8854938100362922672: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:35:55.490] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020368162613578128:59:0) after 1m0s
[18:36:55.510] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020368162613578128:59:0)
[18:36:55.510] Timer tick, asking Buildbucket for the build status
[18:36:55.802] Build 8854938100362922672: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:36:55.802] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020368162613578128:60:0) after 1m0s
[18:37:55.816] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020368162613578128:60:0)
[18:37:55.816] Timer tick, asking Buildbucket for the build status
[18:37:55.894] Build 8854938100362922672: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:37:55.894] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020368162613578128:61:0) after 1m0s
[18:38:55.953] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020368162613578128:61:0)
[18:38:55.953] Timer tick, asking Buildbucket for the build status
[18:38:56.048] Build 8854938100362922672: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:38:56.048] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020368162613578128:62:0) after 1m0s
[18:39:56.177] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020368162613578128:62:0)
[18:39:56.177] Timer tick, asking Buildbucket for the build status
[18:39:56.281] Build 8854938100362922672: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:39:56.281] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020368162613578128:63:0) after 1m0s
[18:40:56.325] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020368162613578128:63:0)
[18:40:56.325] Timer tick, asking Buildbucket for the build status
[18:40:56.404] Build 8854938100362922672: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:40:56.404] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020368162613578128:64:0) after 1m0s
[18:41:56.453] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020368162613578128:64:0)
[18:41:56.453] Timer tick, asking Buildbucket for the build status
[18:41:56.530] Build 8854938100362922672: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:41:56.530] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020368162613578128:65:0) after 1m0s
[18:42:56.604] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020368162613578128:65:0)
[18:42:56.604] Timer tick, asking Buildbucket for the build status
[18:42:56.927] Build 8854938100362922672: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:42:56.927] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020368162613578128:66:0) after 1m0s
[18:43:56.962] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020368162613578128:66:0)
[18:43:56.962] Timer tick, asking Buildbucket for the build status
[18:43:57.121] Build 8854938100362922672: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:43:57.121] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020368162613578128:67:0) after 1m0s
[18:44:57.101] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020368162613578128:67:0)
[18:44:57.101] Timer tick, asking Buildbucket for the build status
[18:44:57.190] Build 8854938100362922672: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:44:57.190] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020368162613578128:68:0) after 1m0s
[18:45:57.266] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020368162613578128:68:0)
[18:45:57.266] Timer tick, asking Buildbucket for the build status
[18:45:57.727] Build 8854938100362922672: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:45:57.727] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020368162613578128:69:0) after 1m0s
[18:46:57.785] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020368162613578128:69:0)
[18:46:57.785] Timer tick, asking Buildbucket for the build status
[18:46:57.871] Build 8854938100362922672: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:46:57.871] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020368162613578128:70:0) after 1m0s
[18:47:57.895] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020368162613578128:70:0)
[18:47:57.895] Timer tick, asking Buildbucket for the build status
[18:47:58.004] Build 8854938100362922672: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:47:58.004] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020368162613578128:71:0) after 1m0s
[18:48:58.076] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020368162613578128:71:0)
[18:48:58.076] Timer tick, asking Buildbucket for the build status
[18:48:58.397] Build 8854938100362922672: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:48:58.397] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020368162613578128:72:0) after 1m0s
[18:49:58.421] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020368162613578128:72:0)
[18:49:58.421] Timer tick, asking Buildbucket for the build status
[18:49:58.511] Build 8854938100362922672: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:49:58.511] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020368162613578128:73:0) after 1m0s
[18:50:58.568] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020368162613578128:73:0)
[18:50:58.568] Timer tick, asking Buildbucket for the build status
[18:50:58.658] Build 8854938100362922672: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:50:58.658] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020368162613578128:74:0) after 1m0s
[18:51:58.709] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020368162613578128:74:0)
[18:51:58.709] Timer tick, asking Buildbucket for the build status
[18:51:59.026] Build 8854938100362922672: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:51:59.026] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020368162613578128:75:0) after 1m0s
[18:52:59.061] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020368162613578128:75:0)
[18:52:59.061] Timer tick, asking Buildbucket for the build status
[18:52:59.160] Build 8854938100362922672: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:52:59.160] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020368162613578128:76:0) after 1m0s
[18:53:59.197] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020368162613578128:76:0)
[18:53:59.197] Timer tick, asking Buildbucket for the build status
[18:53:59.283] Build 8854938100362922672: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:53:59.283] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020368162613578128:77:0) after 1m0s
[18:54:59.330] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020368162613578128:77:0)
[18:54:59.330] Timer tick, asking Buildbucket for the build status
[18:54:59.448] Build 8854938100362922672: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:54:59.448] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020368162613578128:78:0) after 1m0s
[18:55:59.502] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020368162613578128:78:0)
[18:55:59.502] Timer tick, asking Buildbucket for the build status
[18:55:59.589] Build 8854938100362922672: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:55:59.589] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020368162613578128:79:0) after 1m0s
[18:56:59.602] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020368162613578128:79:0)
[18:56:59.602] Timer tick, asking Buildbucket for the build status
[18:56:59.687] Build 8854938100362922672: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:56:59.687] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020368162613578128:80:0) after 1m0s
[18:57:59.741] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020368162613578128:80:0)
[18:57:59.741] Timer tick, asking Buildbucket for the build status
[18:57:59.945] Build 8854938100362922672: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:57:59.945] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020368162613578128:81:0) after 1m0s
[18:59:00.030] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020368162613578128:81:0)
[18:59:00.030] Timer tick, asking Buildbucket for the build status
[18:59:00.170] Build 8854938100362922672: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:59:00.170] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020368162613578128:82:0) after 1m0s
[19:00:00.220] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020368162613578128:82:0)
[19:00:00.220] Timer tick, asking Buildbucket for the build status
[19:00:00.929] Build 8854938100362922672: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:00:00.929] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020368162613578128:83:0) after 1m0s
[19:01:01.188] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020368162613578128:83:0)
[19:01:01.188] Timer tick, asking Buildbucket for the build status
[19:01:01.274] Build 8854938100362922672: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:01:01.274] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020368162613578128:84:0) after 1m0s
[19:02:01.382] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020368162613578128:84:0)
[19:02:01.382] Timer tick, asking Buildbucket for the build status
[19:02:01.803] Build 8854938100362922672: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:02:01.803] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020368162613578128:85:0) after 1m0s
[19:03:02.104] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020368162613578128:85:0)
[19:03:02.104] Timer tick, asking Buildbucket for the build status
[19:03:02.462] Build 8854938100362922672: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:03:02.462] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020368162613578128:86:0) after 1m0s
[19:04:02.616] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020368162613578128:86:0)
[19:04:02.616] Timer tick, asking Buildbucket for the build status
[19:04:02.709] Build 8854938100362922672: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:04:02.709] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020368162613578128:87:0) after 1m0s
[19:05:02.965] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020368162613578128:87:0)
[19:05:02.965] Timer tick, asking Buildbucket for the build status
[19:05:03.068] Build 8854938100362922672: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:05:03.068] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020368162613578128:88:0) after 1m0s
[19:06:03.140] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020368162613578128:88:0)
[19:06:03.141] Timer tick, asking Buildbucket for the build status
[19:06:03.218] Build 8854938100362922672: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:06:03.218] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020368162613578128:89:0) after 1m0s
[19:07:03.286] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020368162613578128:89:0)
[19:07:03.286] Timer tick, asking Buildbucket for the build status
[19:07:03.626] Build 8854938100362922672: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:07:03.626] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020368162613578128:90:0) after 1m0s
[19:08:03.711] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020368162613578128:90:0)
[19:08:03.711] Timer tick, asking Buildbucket for the build status
[19:08:03.812] Build 8854938100362922672: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:08:03.812] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020368162613578128:91:0) after 1m0s
[19:09:04.034] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020368162613578128:91:0)
[19:09:04.034] Timer tick, asking Buildbucket for the build status
[19:09:04.128] Build 8854938100362922672: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:09:04.128] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020368162613578128:92:0) after 1m0s
[19:10:04.159] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020368162613578128:92:0)
[19:10:04.159] Timer tick, asking Buildbucket for the build status
[19:10:04.517] Build 8854938100362922672: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:10:04.518] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020368162613578128:93:0) after 1m0s
[19:11:04.878] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020368162613578128:93:0)
[19:11:04.878] Timer tick, asking Buildbucket for the build status
[19:11:05.142] Build 8854938100362922672: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:11:05.142] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020368162613578128:94:0) after 1m0s
[19:12:05.258] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020368162613578128:94:0)
[19:12:05.258] Timer tick, asking Buildbucket for the build status
[19:12:05.580] Build 8854938100362922672: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:12:05.580] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020368162613578128:95:0) after 1m0s
[19:13:05.646] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020368162613578128:95:0)
[19:13:05.646] Timer tick, asking Buildbucket for the build status
[19:13:05.960] Build 8854938100362922672: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:13:05.960] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020368162613578128:96:0) after 1m0s
[19:14:06.059] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020368162613578128:96:0)
[19:14:06.059] Timer tick, asking Buildbucket for the build status
[19:14:06.151] Build 8854938100362922672: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:14:06.151] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020368162613578128:97:0) after 1m0s
[19:15:06.210] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020368162613578128:97:0)
[19:15:06.210] Timer tick, asking Buildbucket for the build status
[19:15:06.312] Build 8854938100362922672: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:15:06.312] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020368162613578128:98:0) after 1m0s
[19:16:06.351] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020368162613578128:98:0)
[19:16:06.351] Timer tick, asking Buildbucket for the build status
[19:16:06.452] Build 8854938100362922672: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:16:06.452] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020368162613578128:99:0) after 1m0s
[19:17:06.505] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020368162613578128:99:0)
[19:17:06.505] Timer tick, asking Buildbucket for the build status
[19:17:06.699] Build 8854938100362922672: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:17:06.699] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020368162613578128:100:0) after 1m0s
[19:18:06.768] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020368162613578128:100:0)
[19:18:06.768] Timer tick, asking Buildbucket for the build status
[19:18:07.161] Build 8854938100362922672: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:18:07.161] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020368162613578128:101:0) after 1m0s
[19:19:07.199] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020368162613578128:101:0)
[19:19:07.199] Timer tick, asking Buildbucket for the build status
[19:19:07.727] Build 8854938100362922672: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:19:07.727] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020368162613578128:102:0) after 1m0s
[19:20:07.729] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020368162613578128:102:0)
[19:20:07.729] Timer tick, asking Buildbucket for the build status
[19:20:07.833] Build 8854938100362922672: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:20:07.834] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020368162613578128:103:0) after 1m0s
[19:21:08.115] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020368162613578128:103:0)
[19:21:08.115] Timer tick, asking Buildbucket for the build status
[19:21:08.315] Build 8854938100362922672: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:21:08.315] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020368162613578128:104:0) after 1m0s
[19:22:08.390] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020368162613578128:104:0)
[19:22:08.390] Timer tick, asking Buildbucket for the build status
[19:22:08.478] Build 8854938100362922672: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:22:08.478] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020368162613578128:105:0) after 1m0s
[19:23:08.527] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020368162613578128:105:0)
[19:23:08.527] Timer tick, asking Buildbucket for the build status
[19:23:08.771] Build 8854938100362922672: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:23:08.771] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020368162613578128:106:0) after 1m0s
[19:24:09.625] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020368162613578128:106:0)
[19:24:09.625] Timer tick, asking Buildbucket for the build status
[19:24:09.729] Build 8854938100362922672: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:24:09.729] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020368162613578128:107:0) after 1m0s
[19:25:09.834] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020368162613578128:107:0)
[19:25:09.834] Timer tick, asking Buildbucket for the build status
[19:25:09.918] Build 8854938100362922672: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:25:09.918] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020368162613578128:108:0) after 1m0s
[19:26:10.024] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020368162613578128:108:0)
[19:26:10.024] Timer tick, asking Buildbucket for the build status
[19:26:10.297] Build 8854938100362922672: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:26:10.297] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020368162613578128:109:0) after 1m0s
[19:27:10.400] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020368162613578128:109:0)
[19:27:10.400] Timer tick, asking Buildbucket for the build status
[19:27:10.483] Build 8854938100362922672: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:27:10.483] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020368162613578128:110:0) after 1m0s
[19:28:10.517] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020368162613578128:110:0)
[19:28:10.517] Timer tick, asking Buildbucket for the build status
[19:28:10.594] Build 8854938100362922672: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:28:10.594] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020368162613578128:111:0) after 1m0s
[19:29:10.690] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020368162613578128:111:0)
[19:29:10.690] Timer tick, asking Buildbucket for the build status
[19:29:11.502] Build 8854938100362922672: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:29:11.502] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020368162613578128:112:0) after 1m0s
[19:30:11.642] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020368162613578128:112:0)
[19:30:11.642] Timer tick, asking Buildbucket for the build status
[19:30:11.777] Build 8854938100362922672: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:30:11.777] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9020368162613578128:113:0) after 1m0s
[19:30:34.622] Received PubSub notification, asking Buildbucket for the build status
[19:30:34.721] Build 8854938100362922672: status "COMPLETED", result "SUCCESS", failure_reason "", cancelation_reason ""
[19:30:34.721] Buildbucket build:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "PROD",
"completed_ts": "1613676632133553",
"created_by": "project:chromium",
"created_ts": "1613669982524419",
"id": "8854938100362922672",
"parameters_json": "{\"builder_name\": \"linux-chromeos-dbg\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"8065b6de170411cd8766147febdfd9213f156d8d\"}}",
"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\": \"8065b6de170411cd8766147febdfd9213f156d8d\", \"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\": 22682, \"got_angle_revision\": \"2d3402eba7a8c8115619256aa83bace2749f7870\", \"got_dawn_revision\": \"0b17eb8e19c886680b12b73ba28de8d30adccda9\", \"got_nacl_revision\": \"8a92e6ba1b6d62631f8d3ba3f4f8872ae8b6cca1\", \"got_revision\": \"8065b6de170411cd8766147febdfd9213f156d8d\", \"got_revision_cp\": \"refs/heads/master@{#855328}\", \"got_swarming_client_revision\": \"a32a1607f6093d338f756c7e7c7b4333b0c50c9c\", \"got_swiftshader_revision\": \"aa46953c1309f380cfb23ca027c5c2a8dfd20914\", \"got_v8_revision\": \"dcc59d30e72ef03dda9cbf5ac0ceeb40f0d58cfb\", \"got_v8_revision_cp\": \"refs/heads/9.0.213@{#1}\", \"got_webrtc_revision\": \"e11b4aef3fce51b0fd6bff7c64ee8a6dc00dd02e\", \"got_webrtc_revision_cp\": \"refs/heads/master@{#33293}\", \"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\": \"8065b6de170411cd8766147febdfd9213f156d8d\", \"swarm_hashes_refs/heads/master(at){#855328}_without_patch\": {\"absl_hardening_tests\": \"bbf86be09adcc432d3ce84314aa661b0b65d0988\", \"accessibility_unittests\": \"6ad95174debcc65f68ff478722e1cf51e52d0362\", \"angle_unittests\": \"5fa9a0892746c12bdae9a10203358d10746f4bbe\", \"app_list_unittests\": \"1e19f9965cb160de3dbd8bb7fd4ecf0a181e6e69\", \"app_shell_unittests\": \"050da01f2e4c1423d0fec41d8a8292b8f343f749\", \"ash_unittests\": \"a366120529f651e244daa0ecfb19ba93c7690286\", \"aura_unittests\": \"c87bd2d64603d537cff0b6f116eaeb1308a8ea69\", \"base_unittests\": \"fb3414179e9ce8ac02f7442351c8d2ab0b47d6b0\", \"base_util_unittests\": \"98a4393372bda4e3284d2dbac8d5538fc5f670a3\", \"blink_common_unittests\": \"4b6a1752fc363675d0671637f17fe98569321884\", \"blink_fuzzer_unittests\": \"e61f6d33453a1f8e005a491da5d8df38c1f5c04c\", \"blink_heap_unittests\": \"366910a5f7a17169df530db52301828b7c93f882\", \"blink_platform_unittests\": \"bc47acacb72fb9ae59bcb740e1ffff0f5ea3ef9a\", \"blink_unittests\": \"0370a6e7c288446199f45aee5297a928af258a9e\", \"boringssl_crypto_tests\": \"095ab9eb80314753843cf428a75354ad04155797\", \"boringssl_ssl_tests\": \"7dc4675fec5fe36f4cb30bdcb867cc55bc219ca7\", \"browser_tests\": \"37fa1b66a76033fa61eb5a99a2ca020e09453b1a\", \"capture_unittests\": \"6fa81d6e63a9d5a90acd7fed8100d473d9513835\", \"cast_unittests\": \"f13f26621b391754bf6c613c7286a37213012fa4\", \"cc_unittests\": \"5a2321865aa6b3978a3e0c28abe282df2c602fe9\", \"chrome_app_unittests\": \"7c0e0a2b152362270e949e105157493858a1df03\", \"chromedriver_unittests\": \"c08adba1bd041cb284ad3992f07b7200897486d0\", \"chromeos_components_unittests\": \"98f91d53f0fe79b58ac639f6f6c33759ddaec23b\", \"chromeos_unittests\": \"0815a1a27247f0207459c8a8810f15bfe6313588\", \"components_browsertests\": \"eae8e00933c8f3f1b195651539efcf89a40eb44f\", \"components_unittests\": \"b40904be698b7e9107866ed9a355041beae4edd4\", \"compositor_unittests\": \"dfe8202edff20f8aae23cadaf10a5f22eb9ba952\", \"content_browsertests\": \"c758951ee5bfdf0c8fdbc14a79e0bc739fc771bb\", \"content_unittests\": \"a2a99698118e0174e842dedc66ad1ba5e6974a7f\", \"crashpad_tests\": \"99c1910f34a003bcf0a3481b760f93921f1eb1e0\", \"crypto_unittests\": \"16a3acb37ed888d16eddeeceb28e663172764889\", \"dbus_unittests\": \"b047e3340cd63f8258bcaf318a916de975f125c7\", \"device_unittests\": \"7409baaacd5cebe29013c46587adb90e49704c71\", \"display_unittests\": \"01ed01cf0ccfafcdec19a380118ef3b2277a0741\", \"events_unittests\": \"1e0bb67fd8bc9c731e02df25c029d5143b19df40\", \"exo_unittests\": \"37045ccd3be36869556b06fe7cad97f8f9a10d9c\", \"extensions_browsertests\": \"47ec4d151df0220681e5383dc70da62d196f545e\", \"extensions_unittests\": \"539d9d0f3d6b978f95eb7e902b8b75772eaa04b6\", \"filesystem_service_unittests\": \"dff3247cf56bdd64094976069389d3eb4bf41416\", \"gcm_unit_tests\": \"07127e7b6477ba2d02bd184bafeaf778d975cd4f\", \"gfx_unittests\": \"e14b6000924ba74f1a1aa1db19b03a74d7dbfa5f\", \"gin_unittests\": \"32db9141765222169723b9d6f27b4459eb9f01c7\", \"gl_unittests_ozone\": \"3d6e0d63043d58d917d7e3a757cc8791609e678c\", \"google_apis_unittests\": \"628463b316cd5aba85ac0255119fa32fbc4909aa\", \"gpu_unittests\": \"5935354588d13d7fef90d2d37acf7d44e0aa4aff\", \"gwp_asan_unittests\": \"d85a5d4856ea00b17c5a2debf6a1147db430579f\", \"interactive_ui_tests\": \"178e76fdb240ef5ba5c98d45954ceda510f9ec7d\", \"ipc_tests\": \"67a2659c618b1fae1672806636a5e43b09e4089a\", \"jingle_unittests\": \"9228664ed83ad3f93b2d01d00db7e24e0ce08f6c\", \"keyboard_unittests\": \"e3e9a2457db3066734eb0e54fa965b832b8f8bd4\", \"latency_unittests\": \"5b2f828115d03c3e22df1fd74289f4bfdac66d16\", \"libjingle_xmpp_unittests\": \"6d69b00cd1db09a2f95d937e5e9bdb96b62262cd\", \"liburlpattern_unittests\": \"85e2cb76a016adc699323672d39e4b37ae4daebe\", \"media_blink_unittests\": \"543fe9e7a15938cdd433fd75919e7e1273657ece\", \"media_unittests\": \"966385ff5ba6484195128a9ba5d1c8bb8735d694\", \"message_center_unittests\": \"8633ea1d617b1a9725907042d035fb63f2ccfc35\", \"midi_unittests\": \"bddba8621472957cc2f5d5ea62daf974f59e92dc\", \"mojo_core_unittests\": \"b7f0855b8c4b21666c1f58622a4f674f21f708e9\", \"mojo_unittests\": \"bb5507f4faeeeb2898611a6a9f7302499963bdef\", \"nacl_helper_nonsfi_unittests\": \"072bf5acc932aa418547318683b99411a636873e\", \"nacl_loader_unittests\": \"7fa910becafade14d22ad921de0d2257c42b90bf\", \"native_theme_unittests\": \"ff34a1f81a06bc8cc246d88d656ea879d924c080\", \"net_unittests\": \"e77aceffcba3e34b382d1e03c8be58296bb991b0\", \"ozone_gl_unittests\": \"0108660ff3f87cbec227858951b3b5bb85cab9d8\", \"ozone_unittests\": \"3a6e0ce99cb30d470a18c6ae7b8e74ddb2fee819\", \"ozone_x11_unittests\": \"45e32571ad1ea77651870b04e6c6259c3fb2e66c\", \"pdf_unittests\": \"7b2517d479bc38d090389e70be0a996986676d91\", \"perfetto_unittests\": \"a88217d62025c00088a42c83190fb98723685237\", \"ppapi_unittests\": \"27f082ef0e4841ee29fb32db0f1bcb439e7fb83d\", \"printing_unittests\": \"b1a02390cae8529299af37a3cbb4884c9d017b71\", \"remoting_unittests\": \"7af1b1ffb065dbb36b4ce17d1baeed82c912ff8d\", \"sandbox_linux_unittests\": \"5fcb769f085a45736bde12c730922cd4be128f7b\", \"service_manager_unittests\": \"9fe43111e89372aeffa4108a80d3f0d6604019ca\", \"services_unittests\": \"caca3371ce11137e3bf0cb16f94d3dcaec6c591c\", \"shell_dialogs_unittests\": \"af50a1c0db6d47f61d078c844a36e8608642c590\", \"shell_encryption_unittests\": \"2b21755683855666a65ec5643b8530d2da74bbc5\", \"skia_unittests\": \"603251160c662eca0ea7c4c5818da5e6a27da0bb\", \"snapshot_unittests\": \"8e9b0b4fa71533ee641e7ef80e8cd9c750692752\", \"sql_unittests\": \"2d58a3309b0301533915d34418c98f8c25b3804a\", \"storage_unittests\": \"b1e2ba66ec40d1e3741d1f24e895fb91740c22d6\", \"sync_integration_tests\": \"992d1c3b7da9222ee78a5403f4267bea8fdf0ba7\", \"traffic_annotation_auditor_unittests\": \"1c48bd7e43f0b14caf8b9fdb3af54dbecc9d6e5e\", \"ui_base_unittests\": \"ecb73a34636c5dfa8782879cd6d3bedace5eeff2\", \"ui_chromeos_unittests\": \"4f12c6c050ca34d5f889aa49a9fe9df084722b67\", \"ui_touch_selection_unittests\": \"635dd83379d44a660aaf7ea1ddd768d9b19bdf0e\", \"unit_tests\": \"894bf833f33c61ad145e8aac9b7306e469276dbd\", \"url_unittests\": \"5e9d6eb476ea0a53f60967520f99589fb7049549\", \"usage_time_limit_unittests\": \"12595cff41f13a384eb84c8e6f1813c427b2be11\", \"views_unittests\": \"48f1264834bd99dbab7d31c6a42956a9fe976b72\", \"viz_unittests\": \"60025eac5c9216ab487a9be43642c270c3eae61c\", \"wm_unittests\": \"2f6c8ea0fb4b5fc64ad276d1c8854886f19ef90d\", \"wtf_unittests\": \"71ce79ea27a044d038fc25644f6ab6fa70df94a2\", \"zlib_unittests\": \"8a1b8dbcdbedd9b81c1e0374bbf1a4dcfa41c8e8\"}}, \"swarming\": {\"bot_dimensions\": {\"builderless\": [\"1\"], \"caches\": [\"builder_4973d939604d11dcbaec68575e69c80c756ff63e355ab013b29b8bca26434b7c_v2\", \"builder_61626c7085ee1f9730db9e25e8ceef3d7b395de70268d432aed853b8a16eb295_v2\", \"builder_c07e1e1c2cdac716be0d96bd7f13cbf51acf1625d4d630d38cc920010d58defe_v2\", \"builder_d7a16d1002a90b006293eb3aaf9b6ed11d06403f3c58091e1c5077b5d2ff0b40_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": "1613669993171387",
"status": "COMPLETED",
"status_changed_ts": "1613676632958297",
"tags": [
"build_address:luci.chromium.ci/linux-chromeos-dbg/22682",
"builder:linux-chromeos-dbg",
"buildset:commit/git/8065b6de170411cd8766147febdfd9213f156d8d",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/8065b6de170411cd8766147febdfd9213f156d8d",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9020368162613578128",
"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/8854938100362922672/+/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:51cf0b7ff8274610",
"user_agent:luci-scheduler"
],
"updated_ts": "1613676632989971",
"url": "https://ci.chromium.org/b/8854938100362922672",
"utcnow_ts": "1613676634707070"
}
}
[19:30:34.721] Invocation finished in 1h50m53.727252303s with status SUCCEEDED