[01:54:09.024] New invocation is queued and will start shortly
[01:54:10.142] Starting the invocation (attempt 1)
[01:54:10.187] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[01:54:10.187] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[01:54:10.187] Buildbucket request:
{
"bucket": "luci.chromium.ci",
"client_operation_id": "9027222422894627904",
"parameters_json": "{\"builder_name\":\"linux-chromeos-dbg\",\"properties\":{\"branch\":\"refs/heads/master\",\"repository\":\"https://chromium.googlesource.com/chromium/src\",\"revision\":\"aaeae87973cda34fb9b42ca7d435ec68ce382398\"}}",
"pubsub_callback": {
"auth_token": "...",
"topic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
},
"tags": [
"builder:linux-chromeos-dbg",
"scheduler_invocation_id:9027222422894627904",
"scheduler_job_id:chromium/linux-chromeos-dbg",
"user_agent:luci-scheduler",
"buildset:commit/git/aaeae87973cda34fb9b42ca7d435ec68ce382398",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/aaeae87973cda34fb9b42ca7d435ec68ce382398",
"gitiles_ref:refs/heads/master"
]
}
[01:54:14.710] Buildbucket response:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "PROD",
"created_by": "project:chromium",
"created_ts": "1607133254202358",
"id": "8861792356800589280",
"parameters_json": "{\"builder_name\": \"linux-chromeos-dbg\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"aaeae87973cda34fb9b42ca7d435ec68ce382398\"}}",
"project": "chromium",
"result_details_json": "{\"properties\": {}}",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"status": "SCHEDULED",
"status_changed_ts": "1607133254582020",
"tags": [
"build_address:luci.chromium.ci/linux-chromeos-dbg/21612",
"builder:linux-chromeos-dbg",
"buildset:commit/git/aaeae87973cda34fb9b42ca7d435ec68ce382398",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/aaeae87973cda34fb9b42ca7d435ec68ce382398",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9027222422894627904",
"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/8861792356800589280/+/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": "1607133254582188",
"url": "https://ci.chromium.org/b/8861792356800589280",
"utcnow_ts": "1607133254700686"
}
}
[01:54:14.710] Task URL: https://ci.chromium.org/b/8861792356800589280
[01:54:14.710] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9027222422894627904:2:0) after 1m0s
[01:54:19.837] Received PubSub notification, asking Buildbucket for the build status
[01:54:20.289] Build 8861792356800589280: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:55:14.821] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9027222422894627904:2:0)
[01:55:14.821] Timer tick, asking Buildbucket for the build status
[01:55:15.109] Build 8861792356800589280: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:55:15.109] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9027222422894627904:4:0) after 1m0s
[01:56:15.096] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9027222422894627904:4:0)
[01:56:15.096] Timer tick, asking Buildbucket for the build status
[01:56:15.177] Build 8861792356800589280: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:56:15.177] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9027222422894627904:5:0) after 1m0s
[01:57:15.161] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9027222422894627904:5:0)
[01:57:15.161] Timer tick, asking Buildbucket for the build status
[01:57:15.287] Build 8861792356800589280: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:57:15.287] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9027222422894627904:6:0) after 1m0s
[01:58:15.306] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9027222422894627904:6:0)
[01:58:15.306] Timer tick, asking Buildbucket for the build status
[01:58:15.783] Build 8861792356800589280: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:58:15.783] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9027222422894627904:7:0) after 1m0s
[01:59:15.819] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9027222422894627904:7:0)
[01:59:15.819] Timer tick, asking Buildbucket for the build status
[01:59:15.974] Build 8861792356800589280: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:59:15.974] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9027222422894627904:8:0) after 1m0s
[02:00:16.000] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9027222422894627904:8:0)
[02:00:16.001] Timer tick, asking Buildbucket for the build status
[02:00:16.750] Build 8861792356800589280: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:00:16.750] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9027222422894627904:9:0) after 1m0s
[02:01:16.759] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9027222422894627904:9:0)
[02:01:16.759] Timer tick, asking Buildbucket for the build status
[02:01:16.975] Build 8861792356800589280: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:01:16.975] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9027222422894627904:10:0) after 1m0s
[02:02:17.096] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9027222422894627904:10:0)
[02:02:17.096] Timer tick, asking Buildbucket for the build status
[02:02:17.223] Build 8861792356800589280: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:02:17.223] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9027222422894627904:11:0) after 1m0s
[02:03:17.244] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9027222422894627904:11:0)
[02:03:17.244] Timer tick, asking Buildbucket for the build status
[02:03:17.308] Build 8861792356800589280: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:03:17.308] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9027222422894627904:12:0) after 1m0s
[02:04:17.287] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9027222422894627904:12:0)
[02:04:17.287] Timer tick, asking Buildbucket for the build status
[02:04:17.396] Build 8861792356800589280: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:04:17.396] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9027222422894627904:13:0) after 1m0s
[02:05:17.417] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9027222422894627904:13:0)
[02:05:17.417] Timer tick, asking Buildbucket for the build status
[02:05:17.637] Build 8861792356800589280: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:05:17.637] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9027222422894627904:14:0) after 1m0s
[02:06:17.624] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9027222422894627904:14:0)
[02:06:17.624] Timer tick, asking Buildbucket for the build status
[02:06:17.700] Build 8861792356800589280: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:06:17.701] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9027222422894627904:15:0) after 1m0s
[02:07:17.732] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9027222422894627904:15:0)
[02:07:17.732] Timer tick, asking Buildbucket for the build status
[02:07:17.876] Build 8861792356800589280: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:07:17.876] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9027222422894627904:16:0) after 1m0s
[02:08:17.939] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9027222422894627904:16:0)
[02:08:17.939] Timer tick, asking Buildbucket for the build status
[02:08:18.009] Build 8861792356800589280: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:08:18.010] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9027222422894627904:17:0) after 1m0s
[02:09:18.041] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9027222422894627904:17:0)
[02:09:18.042] Timer tick, asking Buildbucket for the build status
[02:09:18.257] Build 8861792356800589280: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:09:18.257] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9027222422894627904:18:0) after 1m0s
[02:10:18.259] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9027222422894627904:18:0)
[02:10:18.259] Timer tick, asking Buildbucket for the build status
[02:10:18.476] Build 8861792356800589280: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:10:18.476] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9027222422894627904:19:0) after 1m0s
[02:11:18.479] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9027222422894627904:19:0)
[02:11:18.479] Timer tick, asking Buildbucket for the build status
[02:11:18.542] Build 8861792356800589280: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:11:18.542] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9027222422894627904:20:0) after 1m0s
[02:12:18.543] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9027222422894627904:20:0)
[02:12:18.543] Timer tick, asking Buildbucket for the build status
[02:12:18.881] Build 8861792356800589280: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:12:18.881] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9027222422894627904:21:0) after 1m0s
[02:13:18.927] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9027222422894627904:21:0)
[02:13:18.927] Timer tick, asking Buildbucket for the build status
[02:13:19.132] Build 8861792356800589280: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:13:19.132] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9027222422894627904:22:0) after 1m0s
[02:14:19.179] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9027222422894627904:22:0)
[02:14:19.179] Timer tick, asking Buildbucket for the build status
[02:14:19.324] Build 8861792356800589280: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:14:19.324] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9027222422894627904:23:0) after 1m0s
[02:15:19.406] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9027222422894627904:23:0)
[02:15:19.406] Timer tick, asking Buildbucket for the build status
[02:15:19.591] Build 8861792356800589280: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:15:19.591] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9027222422894627904:24:0) after 1m0s
[02:16:19.637] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9027222422894627904:24:0)
[02:16:19.637] Timer tick, asking Buildbucket for the build status
[02:16:19.718] Build 8861792356800589280: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:16:19.718] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9027222422894627904:25:0) after 1m0s
[02:17:19.702] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9027222422894627904:25:0)
[02:17:19.702] Timer tick, asking Buildbucket for the build status
[02:17:19.888] Build 8861792356800589280: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:17:19.888] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9027222422894627904:26:0) after 1m0s
[02:18:19.860] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9027222422894627904:26:0)
[02:18:19.860] Timer tick, asking Buildbucket for the build status
[02:18:19.954] Build 8861792356800589280: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:18:19.954] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9027222422894627904:27:0) after 1m0s
[02:19:20.045] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9027222422894627904:27:0)
[02:19:20.045] Timer tick, asking Buildbucket for the build status
[02:19:20.468] Build 8861792356800589280: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:19:20.473] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9027222422894627904:28:0) after 1m0s
[02:20:20.492] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9027222422894627904:28:0)
[02:20:20.492] Timer tick, asking Buildbucket for the build status
[02:20:20.906] Build 8861792356800589280: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:20:20.906] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9027222422894627904:29:0) after 1m0s
[02:21:21.031] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9027222422894627904:29:0)
[02:21:21.031] Timer tick, asking Buildbucket for the build status
[02:21:21.100] Build 8861792356800589280: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:21:21.100] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9027222422894627904:30:0) after 1m0s
[02:22:21.169] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9027222422894627904:30:0)
[02:22:21.169] Timer tick, asking Buildbucket for the build status
[02:22:21.243] Build 8861792356800589280: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:22:21.243] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9027222422894627904:31:0) after 1m0s
[02:23:21.385] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9027222422894627904:31:0)
[02:23:21.385] Timer tick, asking Buildbucket for the build status
[02:23:21.456] Build 8861792356800589280: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:23:21.456] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9027222422894627904:32:0) after 1m0s
[02:24:21.500] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9027222422894627904:32:0)
[02:24:21.500] Timer tick, asking Buildbucket for the build status
[02:24:21.617] Build 8861792356800589280: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:24:21.618] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9027222422894627904:33:0) after 1m0s
[02:25:21.643] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9027222422894627904:33:0)
[02:25:21.643] Timer tick, asking Buildbucket for the build status
[02:25:21.722] Build 8861792356800589280: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:25:21.722] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9027222422894627904:34:0) after 1m0s
[02:26:21.766] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9027222422894627904:34:0)
[02:26:21.766] Timer tick, asking Buildbucket for the build status
[02:26:21.888] Build 8861792356800589280: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:26:21.888] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9027222422894627904:35:0) after 1m0s
[02:27:21.928] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9027222422894627904:35:0)
[02:27:21.928] Timer tick, asking Buildbucket for the build status
[02:27:21.990] Build 8861792356800589280: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:27:21.990] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9027222422894627904:36:0) after 1m0s
[02:28:22.048] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9027222422894627904:36:0)
[02:28:22.048] Timer tick, asking Buildbucket for the build status
[02:28:22.139] Build 8861792356800589280: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:28:22.139] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9027222422894627904:37:0) after 1m0s
[02:29:22.162] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9027222422894627904:37:0)
[02:29:22.162] Timer tick, asking Buildbucket for the build status
[02:29:22.336] Build 8861792356800589280: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:29:22.336] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9027222422894627904:38:0) after 1m0s
[02:30:22.481] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9027222422894627904:38:0)
[02:30:22.481] Timer tick, asking Buildbucket for the build status
[02:30:22.747] Build 8861792356800589280: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:30:22.747] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9027222422894627904:39:0) after 1m0s
[02:31:22.981] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9027222422894627904:39:0)
[02:31:22.981] Timer tick, asking Buildbucket for the build status
[02:31:23.149] Build 8861792356800589280: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:31:23.149] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9027222422894627904:40:0) after 1m0s
[02:32:23.138] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9027222422894627904:40:0)
[02:32:23.138] Timer tick, asking Buildbucket for the build status
[02:32:23.234] Build 8861792356800589280: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:32:23.234] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9027222422894627904:41:0) after 1m0s
[02:33:23.335] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9027222422894627904:41:0)
[02:33:23.335] Timer tick, asking Buildbucket for the build status
[02:33:23.409] Build 8861792356800589280: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:33:23.409] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9027222422894627904:42:0) after 1m0s
[02:34:23.580] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9027222422894627904:42:0)
[02:34:23.580] Timer tick, asking Buildbucket for the build status
[02:34:23.678] Build 8861792356800589280: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:34:23.678] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9027222422894627904:43:0) after 1m0s
[02:35:23.868] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9027222422894627904:43:0)
[02:35:23.868] Timer tick, asking Buildbucket for the build status
[02:35:23.974] Build 8861792356800589280: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:35:23.976] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9027222422894627904:44:0) after 1m0s
[02:36:24.076] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9027222422894627904:44:0)
[02:36:24.076] Timer tick, asking Buildbucket for the build status
[02:36:24.166] Build 8861792356800589280: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:36:24.166] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9027222422894627904:45:0) after 1m0s
[02:37:24.276] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9027222422894627904:45:0)
[02:37:24.276] Timer tick, asking Buildbucket for the build status
[02:37:24.464] Build 8861792356800589280: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:37:24.464] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9027222422894627904:46:0) after 1m0s
[02:38:24.640] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9027222422894627904:46:0)
[02:38:24.640] Timer tick, asking Buildbucket for the build status
[02:38:24.757] Build 8861792356800589280: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:38:24.757] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9027222422894627904:47:0) after 1m0s
[02:39:24.895] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9027222422894627904:47:0)
[02:39:24.895] Timer tick, asking Buildbucket for the build status
[02:39:25.103] Build 8861792356800589280: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:39:25.103] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9027222422894627904:48:0) after 1m0s
[02:40:25.221] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9027222422894627904:48:0)
[02:40:25.221] Timer tick, asking Buildbucket for the build status
[02:40:25.354] Build 8861792356800589280: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:40:25.354] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9027222422894627904:49:0) after 1m0s
[02:41:25.636] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9027222422894627904:49:0)
[02:41:25.636] Timer tick, asking Buildbucket for the build status
[02:41:25.975] Build 8861792356800589280: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:41:25.976] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9027222422894627904:50:0) after 1m0s
[02:42:26.004] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9027222422894627904:50:0)
[02:42:26.004] Timer tick, asking Buildbucket for the build status
[02:42:26.504] Build 8861792356800589280: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:42:26.505] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9027222422894627904:51:0) after 1m0s
[02:43:26.518] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9027222422894627904:51:0)
[02:43:26.518] Timer tick, asking Buildbucket for the build status
[02:43:26.986] Build 8861792356800589280: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:43:26.986] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9027222422894627904:52:0) after 1m0s
[02:44:27.031] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9027222422894627904:52:0)
[02:44:27.031] Timer tick, asking Buildbucket for the build status
[02:44:27.162] Build 8861792356800589280: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:44:27.163] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9027222422894627904:53:0) after 1m0s
[02:45:27.194] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9027222422894627904:53:0)
[02:45:27.194] Timer tick, asking Buildbucket for the build status
[02:45:27.314] Build 8861792356800589280: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:45:27.314] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9027222422894627904:54:0) after 1m0s
[02:46:27.402] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9027222422894627904:54:0)
[02:46:27.402] Timer tick, asking Buildbucket for the build status
[02:46:28.110] Build 8861792356800589280: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:46:28.110] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9027222422894627904:55:0) after 1m0s
[02:47:28.126] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9027222422894627904:55:0)
[02:47:28.126] Timer tick, asking Buildbucket for the build status
[02:47:28.726] Build 8861792356800589280: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:47:28.726] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9027222422894627904:56:0) after 1m0s
[02:48:28.831] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9027222422894627904:56:0)
[02:48:28.832] Timer tick, asking Buildbucket for the build status
[02:48:29.193] Build 8861792356800589280: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:48:29.193] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9027222422894627904:57:0) after 1m0s
[02:49:29.216] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9027222422894627904:57:0)
[02:49:29.216] Timer tick, asking Buildbucket for the build status
[02:49:29.773] Build 8861792356800589280: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:49:29.773] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9027222422894627904:58:0) after 1m0s
[02:50:29.788] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9027222422894627904:58:0)
[02:50:29.788] Timer tick, asking Buildbucket for the build status
[02:50:29.904] Build 8861792356800589280: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:50:29.904] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9027222422894627904:59:0) after 1m0s
[02:51:29.958] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9027222422894627904:59:0)
[02:51:29.958] Timer tick, asking Buildbucket for the build status
[02:51:30.181] Build 8861792356800589280: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:51:30.181] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9027222422894627904:60:0) after 1m0s
[02:52:30.242] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9027222422894627904:60:0)
[02:52:30.242] Timer tick, asking Buildbucket for the build status
[02:52:30.356] Build 8861792356800589280: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:52:30.357] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9027222422894627904:61:0) after 1m0s
[02:53:30.389] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9027222422894627904:61:0)
[02:53:30.389] Timer tick, asking Buildbucket for the build status
[02:53:30.462] Build 8861792356800589280: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:53:30.462] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9027222422894627904:62:0) after 1m0s
[02:54:30.485] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9027222422894627904:62:0)
[02:54:30.485] Timer tick, asking Buildbucket for the build status
[02:54:30.628] Build 8861792356800589280: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:54:30.628] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9027222422894627904:63:0) after 1m0s
[02:55:30.632] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9027222422894627904:63:0)
[02:55:30.632] Timer tick, asking Buildbucket for the build status
[02:55:30.724] Build 8861792356800589280: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:55:30.724] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9027222422894627904:64:0) after 1m0s
[02:56:30.730] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9027222422894627904:64:0)
[02:56:30.730] Timer tick, asking Buildbucket for the build status
[02:56:31.177] Build 8861792356800589280: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:56:31.178] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9027222422894627904:65:0) after 1m0s
[02:57:31.204] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9027222422894627904:65:0)
[02:57:31.204] Timer tick, asking Buildbucket for the build status
[02:57:31.347] Build 8861792356800589280: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:57:31.347] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9027222422894627904:66:0) after 1m0s
[02:58:31.370] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9027222422894627904:66:0)
[02:58:31.370] Timer tick, asking Buildbucket for the build status
[02:58:31.451] Build 8861792356800589280: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:58:31.451] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9027222422894627904:67:0) after 1m0s
[02:59:31.496] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9027222422894627904:67:0)
[02:59:31.496] Timer tick, asking Buildbucket for the build status
[02:59:32.048] Build 8861792356800589280: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:59:32.048] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9027222422894627904:68:0) after 1m0s
[03:00:32.088] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9027222422894627904:68:0)
[03:00:32.088] Timer tick, asking Buildbucket for the build status
[03:00:32.203] Build 8861792356800589280: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:00:32.203] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9027222422894627904:69:0) after 1m0s
[03:01:32.239] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9027222422894627904:69:0)
[03:01:32.239] Timer tick, asking Buildbucket for the build status
[03:01:32.414] Build 8861792356800589280: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:01:32.414] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9027222422894627904:70:0) after 1m0s
[03:02:32.454] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9027222422894627904:70:0)
[03:02:32.454] Timer tick, asking Buildbucket for the build status
[03:02:32.581] Build 8861792356800589280: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:02:32.581] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9027222422894627904:71:0) after 1m0s
[03:03:32.613] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9027222422894627904:71:0)
[03:03:32.613] Timer tick, asking Buildbucket for the build status
[03:03:32.783] Build 8861792356800589280: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:03:32.783] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9027222422894627904:72:0) after 1m0s
[03:04:32.839] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9027222422894627904:72:0)
[03:04:32.839] Timer tick, asking Buildbucket for the build status
[03:04:33.054] Build 8861792356800589280: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:04:33.054] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9027222422894627904:73:0) after 1m0s
[03:05:33.093] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9027222422894627904:73:0)
[03:05:33.093] Timer tick, asking Buildbucket for the build status
[03:05:33.227] Build 8861792356800589280: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:05:33.227] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9027222422894627904:74:0) after 1m0s
[03:06:33.224] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9027222422894627904:74:0)
[03:06:33.224] Timer tick, asking Buildbucket for the build status
[03:06:33.324] Build 8861792356800589280: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:06:33.324] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9027222422894627904:75:0) after 1m0s
[03:07:33.424] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9027222422894627904:75:0)
[03:07:33.424] Timer tick, asking Buildbucket for the build status
[03:07:33.524] Build 8861792356800589280: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:07:33.524] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9027222422894627904:76:0) after 1m0s
[03:08:33.576] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9027222422894627904:76:0)
[03:08:33.576] Timer tick, asking Buildbucket for the build status
[03:08:34.137] Build 8861792356800589280: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:08:34.138] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9027222422894627904:77:0) after 1m0s
[03:09:34.199] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9027222422894627904:77:0)
[03:09:34.199] Timer tick, asking Buildbucket for the build status
[03:09:34.630] Build 8861792356800589280: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:09:34.630] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9027222422894627904:78:0) after 1m0s
[03:10:34.658] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9027222422894627904:78:0)
[03:10:34.659] Timer tick, asking Buildbucket for the build status
[03:10:34.732] Build 8861792356800589280: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:10:34.732] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9027222422894627904:79:0) after 1m0s
[03:11:34.874] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9027222422894627904:79:0)
[03:11:34.874] Timer tick, asking Buildbucket for the build status
[03:11:34.945] Build 8861792356800589280: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:11:34.945] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9027222422894627904:80:0) after 1m0s
[03:12:34.955] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9027222422894627904:80:0)
[03:12:34.955] Timer tick, asking Buildbucket for the build status
[03:12:35.078] Build 8861792356800589280: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:12:35.078] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9027222422894627904:81:0) after 1m0s
[03:13:35.180] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9027222422894627904:81:0)
[03:13:35.180] Timer tick, asking Buildbucket for the build status
[03:13:35.269] Build 8861792356800589280: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:13:35.269] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9027222422894627904:82:0) after 1m0s
[03:14:35.654] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9027222422894627904:82:0)
[03:14:35.654] Timer tick, asking Buildbucket for the build status
[03:14:35.814] Build 8861792356800589280: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:14:35.814] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9027222422894627904:83:0) after 1m0s
[03:15:36.037] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9027222422894627904:83:0)
[03:15:36.037] Timer tick, asking Buildbucket for the build status
[03:15:36.183] Build 8861792356800589280: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:15:36.183] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9027222422894627904:84:0) after 1m0s
[03:16:36.347] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9027222422894627904:84:0)
[03:16:36.347] Timer tick, asking Buildbucket for the build status
[03:16:36.481] Build 8861792356800589280: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:16:36.481] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9027222422894627904:85:0) after 1m0s
[03:17:36.665] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9027222422894627904:85:0)
[03:17:36.665] Timer tick, asking Buildbucket for the build status
[03:17:36.759] Build 8861792356800589280: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:17:36.759] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9027222422894627904:86:0) after 1m0s
[03:18:36.841] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9027222422894627904:86:0)
[03:18:36.841] Timer tick, asking Buildbucket for the build status
[03:18:36.935] Build 8861792356800589280: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:18:36.935] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9027222422894627904:87:0) after 1m0s
[03:19:36.974] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9027222422894627904:87:0)
[03:19:36.974] Timer tick, asking Buildbucket for the build status
[03:19:37.091] Build 8861792356800589280: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:19:37.091] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9027222422894627904:88:0) after 1m0s
[03:20:37.121] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9027222422894627904:88:0)
[03:20:37.121] Timer tick, asking Buildbucket for the build status
[03:20:37.537] Build 8861792356800589280: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:20:37.537] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9027222422894627904:89:0) after 1m0s
[03:21:37.588] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9027222422894627904:89:0)
[03:21:37.588] Timer tick, asking Buildbucket for the build status
[03:21:37.664] Build 8861792356800589280: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:21:37.664] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9027222422894627904:90:0) after 1m0s
[03:22:37.776] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9027222422894627904:90:0)
[03:22:37.776] Timer tick, asking Buildbucket for the build status
[03:22:37.886] Build 8861792356800589280: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:22:37.886] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9027222422894627904:91:0) after 1m0s
[03:23:38.013] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9027222422894627904:91:0)
[03:23:38.014] Timer tick, asking Buildbucket for the build status
[03:23:38.192] Build 8861792356800589280: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:23:38.192] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9027222422894627904:92:0) after 1m0s
[03:24:38.252] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9027222422894627904:92:0)
[03:24:38.253] Timer tick, asking Buildbucket for the build status
[03:24:38.364] Build 8861792356800589280: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:24:38.365] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9027222422894627904:93:0) after 1m0s
[03:25:38.462] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9027222422894627904:93:0)
[03:25:38.462] Timer tick, asking Buildbucket for the build status
[03:25:38.569] Build 8861792356800589280: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:25:38.569] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9027222422894627904:94:0) after 1m0s
[03:26:38.693] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9027222422894627904:94:0)
[03:26:38.693] Timer tick, asking Buildbucket for the build status
[03:26:39.215] Build 8861792356800589280: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:26:39.215] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9027222422894627904:95:0) after 1m0s
[03:27:39.240] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9027222422894627904:95:0)
[03:27:39.240] Timer tick, asking Buildbucket for the build status
[03:27:39.579] Build 8861792356800589280: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:27:39.579] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9027222422894627904:96:0) after 1m0s
[03:28:39.607] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9027222422894627904:96:0)
[03:28:39.607] Timer tick, asking Buildbucket for the build status
[03:28:39.814] Build 8861792356800589280: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:28:39.814] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9027222422894627904:97:0) after 1m0s
[03:29:39.870] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9027222422894627904:97:0)
[03:29:39.870] Timer tick, asking Buildbucket for the build status
[03:29:40.251] Build 8861792356800589280: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:29:40.251] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9027222422894627904:98:0) after 1m0s
[03:30:40.311] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9027222422894627904:98:0)
[03:30:40.311] Timer tick, asking Buildbucket for the build status
[03:30:40.469] Build 8861792356800589280: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:30:40.469] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9027222422894627904:99:0) after 1m0s
[03:31:40.556] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9027222422894627904:99:0)
[03:31:40.556] Timer tick, asking Buildbucket for the build status
[03:31:40.821] Build 8861792356800589280: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:31:40.821] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9027222422894627904:100:0) after 1m0s
[03:32:40.868] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9027222422894627904:100:0)
[03:32:40.868] Timer tick, asking Buildbucket for the build status
[03:32:41.032] Build 8861792356800589280: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:32:41.032] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9027222422894627904:101:0) after 1m0s
[03:33:41.091] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9027222422894627904:101:0)
[03:33:41.091] Timer tick, asking Buildbucket for the build status
[03:33:41.273] Build 8861792356800589280: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:33:41.273] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9027222422894627904:102:0) after 1m0s
[03:33:58.598] Received PubSub notification, asking Buildbucket for the build status
[03:33:58.822] Build 8861792356800589280: status "COMPLETED", result "SUCCESS", failure_reason "", cancelation_reason ""
[03:33:58.822] Buildbucket build:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "PROD",
"completed_ts": "1607139236836299",
"created_by": "project:chromium",
"created_ts": "1607133254202358",
"id": "8861792356800589280",
"parameters_json": "{\"builder_name\": \"linux-chromeos-dbg\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"aaeae87973cda34fb9b42ca7d435ec68ce382398\"}}",
"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\": \"aaeae87973cda34fb9b42ca7d435ec68ce382398\", \"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-east1-d-8-0-b447\", \"branch\": \"refs/heads/master\", \"builder_group\": \"chromium.chromiumos\", \"buildername\": \"linux-chromeos-dbg\", \"buildnumber\": 21612, \"got_angle_revision\": \"f42409e60211e9952d01918834c0eace3aeb27fd\", \"got_dawn_revision\": \"c532048062befdee8bb57d18f01d3a3c403d49de\", \"got_nacl_revision\": \"3ac0b060c794b64531b47dfded8ff8d951a5c648\", \"got_revision\": \"aaeae87973cda34fb9b42ca7d435ec68ce382398\", \"got_revision_cp\": \"refs/heads/master@{#833965}\", \"got_swarming_client_revision\": \"1a072711d4388c62e02480fabc26c68c24494be9\", \"got_swiftshader_revision\": \"bae138de13ac876cbca0e30a40b89dc808e2b29d\", \"got_v8_revision\": \"61f3e61408129afc0d9e1268d3354a283ea3c881\", \"got_v8_revision_cp\": \"refs/heads/8.9.100@{#1}\", \"got_webrtc_revision\": \"6c80aebd00360ee00c84c7b14422c5fe475d8916\", \"got_webrtc_revision_cp\": \"refs/heads/master@{#32774}\", \"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\": \"aaeae87973cda34fb9b42ca7d435ec68ce382398\", \"swarm_hashes_refs/heads/master(at){#833965}_without_patch\": {\"absl_hardening_tests\": \"7c1f2ec3442acc134ed7d3c9ac63f9493026810c\", \"accessibility_unittests\": \"85d5352da5b0cfa14e09d0b21376ff78b381dcfe\", \"angle_unittests\": \"15f449397782698a17841601c8980c5d101676e6\", \"app_list_unittests\": \"8441c5c6c31053bb0836e5f4e8ea9e48c37bcbdc\", \"app_shell_unittests\": \"2d2f1c60de6e5c423e14ca0ed3584b7b98c5fc1f\", \"ash_unittests\": \"c3abb400ed9cb91fbd2564af54f253d055a310bf\", \"aura_unittests\": \"952b1638883ffc6be9e60f7e7a2ba6e588d26ffe\", \"base_unittests\": \"2a4caa541a96b849608623b6b25000c20918076e\", \"base_util_unittests\": \"b08058e4c2d3cffaf2642001881fb036ceadc217\", \"blink_common_unittests\": \"940f8beed418e90cc222d1ee094209d0b294cf11\", \"blink_fuzzer_unittests\": \"ed446d035530bc70351dafc24dae6e726c8d9fbc\", \"blink_heap_unittests\": \"2f938cb745ebbd78d0fd159c26fa3c7365e15eac\", \"blink_platform_unittests\": \"f6e5a6980ad6a05c5413b305fb409c5cb3d0c58c\", \"blink_unittests\": \"f067f8669268e43dfd5c31b3435a607ae27e22e1\", \"boringssl_crypto_tests\": \"cacb8297ec5acdf51e44580715c67734c3b2cbde\", \"boringssl_ssl_tests\": \"bb3b6a677fcc0da46715d3b505ea990215bc3c00\", \"browser_tests\": \"0af67a82baa50bb6936db126753981f04a611703\", \"capture_unittests\": \"6b652f2febfcc547a48f1bf657df1f7811b8a6fe\", \"cast_unittests\": \"30b04c8cca687ff8fa34a1bba5dce4e209f1bcbe\", \"cc_unittests\": \"186ae24706d914e8d0c776ef9697acd24f4b8b6e\", \"chrome_app_unittests\": \"7230865217acd2b6d5cdeefff198c5461aad6bde\", \"chromedriver_unittests\": \"093d2876f8fe53c020ad7600e08b3a08bd1918cd\", \"chromeos_components_unittests\": \"e1ddb613f545c8d127d495a68e6ce916b04e2184\", \"chromeos_unittests\": \"7729642ff1ea128b0a63c702d1e3d4161b328862\", \"components_browsertests\": \"8e3f71b0328f593f2a8c9fcb3afcf49d9bc850ba\", \"components_unittests\": \"c1aa92e992bfe25609d5f8d32559750c47dc4eda\", \"compositor_unittests\": \"75e3bdff5c4fde4b81814c180dd306c5a8d240ea\", \"content_browsertests\": \"2a31fb73f61c5e2fea656dd95ad2136ae540af72\", \"content_unittests\": \"5e78a0edc84aad6ff49a4bb20d2608d1fe753117\", \"crashpad_tests\": \"1c9487aebb9d2628cbcac0a3218305895627d272\", \"crypto_unittests\": \"b7cf7c134b067fcc4f44f4d6673f7d788439697f\", \"dbus_unittests\": \"2d3a45f7fc28cc91d585d07365b4f28a68b22e3e\", \"device_unittests\": \"003ba4df3031921bf6ee7e653f752c1ac017f6d6\", \"display_unittests\": \"dd0bddbe89df7700ef43fd28bfdc345608d2f109\", \"events_unittests\": \"b9254c7c32342d60849709ff013c819bb15dd282\", \"exo_unittests\": \"1ca1a39f3b703b5f8cc46805fc49ca59579a1121\", \"extensions_browsertests\": \"bc3b35b3760e81832c839fa3266f34a17e0aca6c\", \"extensions_unittests\": \"90c5128e08c8c22857aef8a92d094c4f59c55948\", \"filesystem_service_unittests\": \"effa9dd72283afb496e77bc01268284d2d603785\", \"gcm_unit_tests\": \"cb4710868aa646db90871aeac4a416e837c2d2f5\", \"gfx_unittests\": \"17b116624ce83df3e60db092d0964104eae5eda3\", \"gin_unittests\": \"209f882ffdc915bcab961305ee3b8f0c71d86ad7\", \"gl_unittests_ozone\": \"b1388908c78894b9d337f5070ea6907ceb065f19\", \"google_apis_unittests\": \"c98462865b50cc165a1fe02e15dd4ec0c12153bd\", \"gpu_unittests\": \"0d41be4475e430131c093971dd51551f9726d6db\", \"gwp_asan_unittests\": \"2a438d7ab1c854cd7d4d70b3200e4b1272b46761\", \"interactive_ui_tests\": \"1f04d5adea628f2d646ded35421d661d26e66850\", \"ipc_tests\": \"20de2cb4199146f60307d8e095da414dafd4930c\", \"jingle_unittests\": \"f15af1174b1df7e1e3f86e3f22d41c5f083b7291\", \"keyboard_unittests\": \"63a817e8d118600fe272e0e2600adab37e55c869\", \"latency_unittests\": \"64e92716052f58a682e223017f25569276ca8bf9\", \"libjingle_xmpp_unittests\": \"c521a4548c99956524010401676e898acde92d31\", \"liburlpattern_unittests\": \"b8384b50143f28c87edf187e0f3d35d1993d5b39\", \"media_blink_unittests\": \"7f21d77bf3729b741994c7d05dd32c57abdbbeed\", \"media_unittests\": \"19776c4220158a98a65bdefb16dfa6a5ad7c678d\", \"message_center_unittests\": \"7fd767bf8e9d6c171e4e9e0329cab4f3376546ad\", \"midi_unittests\": \"0d4a0f9c2eaee198f7af1b69a5ed3e10e2b60ea7\", \"mojo_core_unittests\": \"bc1d3a889930e4ae5bd472271ff8655d0633ebdd\", \"mojo_unittests\": \"b2b6fee21e0b2b96382b1f75ea1202d4cf031c88\", \"nacl_helper_nonsfi_unittests\": \"0bba8c3ab4b3283b684a147800e17843c2e0b0b7\", \"nacl_loader_unittests\": \"68cee28d4908b602888143854d72710d569f9cd7\", \"native_theme_unittests\": \"1762b2993b76ad991ee4dd2330e5dfc2c740f079\", \"net_unittests\": \"0abfef0431d912c031b7580de8465ec4d5edd971\", \"ozone_gl_unittests\": \"fa8bb50145cbe52714ee063c9d24d942a889de99\", \"ozone_unittests\": \"e8003e98335022b7e717774b04c6490ee3f47ce0\", \"ozone_x11_unittests\": \"a735cf79547682ef23812ab153c38f1be328a191\", \"pdf_unittests\": \"81f6858de06de58813ad79c61941b2d05baaf4bf\", \"perfetto_unittests\": \"da16a320a60719ec1cf1cd513e435d35448dc50b\", \"ppapi_unittests\": \"a915764bbd8b4203dac7c16cdaa7d1c3220c68b2\", \"printing_unittests\": \"66f07313c7fe1097343ec5e85b8bad7cb66fd718\", \"remoting_unittests\": \"b37505e42527792aa78e67a0a00b8718b38c08c7\", \"sandbox_linux_unittests\": \"996d8b7927f5c3c6297fd11dc4ce681f14bddfaf\", \"service_manager_unittests\": \"d221bb5a93b00010beac069c2993b3e1d7f26e0f\", \"services_unittests\": \"27cbea185bf3278a7fa0615d6b50763a89cfa67e\", \"shell_dialogs_unittests\": \"badd3138bf9ba58c927da4e69e68c1cd301088b8\", \"shell_encryption_unittests\": \"9e95261e8df5f18d19388a40c9099bd334c01543\", \"skia_unittests\": \"ade04c948a6118c2820211e6ec8380220a197766\", \"snapshot_unittests\": \"da4d945dd7eae14878164cf0bbb88308c093abc4\", \"sql_unittests\": \"7100866a8cb840fc853b0347c2fd604f3b2b7c48\", \"storage_unittests\": \"30a7f8fcce6b674252a73e40d8296df67dd24b90\", \"sync_integration_tests\": \"7908c0a54a3ccfc15bcb292d9d85df3f0f4a6118\", \"traffic_annotation_auditor_unittests\": \"556486de74bab47f6ffe9722876e28e7aa618154\", \"ui_base_unittests\": \"98f8c56b9eee50f50dd32cc781314a5043c8476c\", \"ui_chromeos_unittests\": \"57e96115d9424bd3a7ad95a5990dceb3ba3160b3\", \"ui_touch_selection_unittests\": \"3941e6582de4e1ae3255fc0eaf489941cbdae573\", \"unit_tests\": \"e66185dd837c08045b5433dacff73611b4830399\", \"url_unittests\": \"05790773405f8542f162874f35aa193a830cafea\", \"usage_time_limit_unittests\": \"50e55fd876c946fdcaa5ec60c20f038649d96b08\", \"views_unittests\": \"10e78e23e02dca52b96bbca03065452db72777d5\", \"viz_unittests\": \"87f583b12beb035f45c6e44f78345ca1478cd20b\", \"wm_unittests\": \"632b63634a836c99a8d059e6d28c1db86f2984b8\", \"wtf_unittests\": \"dbc8d6f49cd9e7aceea8b356fcfecd11c133fb7b\", \"zlib_unittests\": \"09497028ebc4655bf270cccb68eae75f3d4536bb\"}}, \"swarming\": {\"bot_dimensions\": {\"builderless\": [\"1\"], \"caches\": [\"builder_4973d939604d11dcbaec68575e69c80c756ff63e355ab013b29b8bca26434b7c_v2\", \"git\", \"goma_v2\", \"vpython\"], \"cores\": [\"8\"], \"cpu\": [\"x86\", \"x86-64\", \"x86-64-Haswell_GCE\", \"x86-64-avx2\"], \"gce\": [\"1\"], \"gcp\": [\"google.com:chromecompute\"], \"gpu\": [\"none\"], \"id\": [\"luci-chromium-ci-xenial-us-east1-d-8-0-b447\"], \"image\": [\"chrome-xenial-20112900-2f7c54bbcac\"], \"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\": [\"5640-d0eb544\"], \"ssd\": [\"0\"], \"zone\": [\"us\", \"us-east\", \"us-east1\", \"us-east1-d\"]}}}",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"started_ts": "1607133259220475",
"status": "COMPLETED",
"status_changed_ts": "1607139237251641",
"tags": [
"build_address:luci.chromium.ci/linux-chromeos-dbg/21612",
"builder:linux-chromeos-dbg",
"buildset:commit/git/aaeae87973cda34fb9b42ca7d435ec68ce382398",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/aaeae87973cda34fb9b42ca7d435ec68ce382398",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9027222422894627904",
"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/8861792356800589280/+/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:50496cdcb1cf3810",
"user_agent:luci-scheduler"
],
"updated_ts": "1607139237264007",
"url": "https://ci.chromium.org/b/8861792356800589280",
"utcnow_ts": "1607139238801094"
}
}
[03:33:58.822] Invocation finished in 1h39m49.815411668s with status SUCCEEDED