[11:57:28.117] New invocation is queued and will start shortly
[11:57:29.148] Starting the invocation (attempt 1)
[11:57:29.179] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[11:57:29.180] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[11:57:29.180] Buildbucket request:
{
"bucket": "luci.chromium.ci",
"client_operation_id": "9023198198871131632",
"parameters_json": "{\"builder_name\":\"linux-chromeos-dbg\",\"properties\":{\"branch\":\"refs/heads/master\",\"repository\":\"https://chromium.googlesource.com/chromium/src\",\"revision\":\"21a8ee36d10ae1ea202f95fe4ddb0d8eb9154f7d\"}}",
"pubsub_callback": {
"auth_token": "...",
"topic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
},
"tags": [
"builder:linux-chromeos-dbg",
"scheduler_invocation_id:9023198198871131632",
"scheduler_job_id:chromium/linux-chromeos-dbg",
"user_agent:luci-scheduler",
"buildset:commit/git/21a8ee36d10ae1ea202f95fe4ddb0d8eb9154f7d",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/21a8ee36d10ae1ea202f95fe4ddb0d8eb9154f7d",
"gitiles_ref:refs/heads/master"
]
}
[11:57:30.251] Buildbucket response:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "PROD",
"created_by": "project:chromium",
"created_ts": "1610971049259498",
"id": "8857768137010536736",
"parameters_json": "{\"builder_name\": \"linux-chromeos-dbg\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"21a8ee36d10ae1ea202f95fe4ddb0d8eb9154f7d\"}}",
"project": "chromium",
"result_details_json": "{\"properties\": {}}",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"status": "SCHEDULED",
"status_changed_ts": "1610971049983059",
"tags": [
"build_address:luci.chromium.ci/linux-chromeos-dbg/22240",
"builder:linux-chromeos-dbg",
"buildset:commit/git/21a8ee36d10ae1ea202f95fe4ddb0d8eb9154f7d",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/21a8ee36d10ae1ea202f95fe4ddb0d8eb9154f7d",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9023198198871131632",
"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/8857768137010536736/+/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": "1610971049983253",
"url": "https://ci.chromium.org/b/8857768137010536736",
"utcnow_ts": "1610971050242529"
}
}
[11:57:30.251] Task URL: https://ci.chromium.org/b/8857768137010536736
[11:57:30.251] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023198198871131632:2:0) after 1m0s
[11:57:33.002] Received PubSub notification, asking Buildbucket for the build status
[11:57:33.354] Build 8857768137010536736: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:58:30.404] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023198198871131632:2:0)
[11:58:30.404] Timer tick, asking Buildbucket for the build status
[11:58:30.493] Build 8857768137010536736: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:58:30.493] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023198198871131632:4:0) after 1m0s
[11:59:30.604] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023198198871131632:4:0)
[11:59:30.604] Timer tick, asking Buildbucket for the build status
[11:59:30.666] Build 8857768137010536736: status "STARTED", result "", failure_reason "", cancelation_reason ""
[11:59:30.666] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023198198871131632:5:0) after 1m0s
[12:00:30.975] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023198198871131632:5:0)
[12:00:30.975] Timer tick, asking Buildbucket for the build status
[12:00:31.847] Build 8857768137010536736: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:00:31.847] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023198198871131632:6:0) after 1m0s
[12:01:31.986] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023198198871131632:6:0)
[12:01:31.986] Timer tick, asking Buildbucket for the build status
[12:01:32.091] Build 8857768137010536736: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:01:32.091] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023198198871131632:7:0) after 1m0s
[12:02:32.183] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023198198871131632:7:0)
[12:02:32.184] Timer tick, asking Buildbucket for the build status
[12:02:32.302] Build 8857768137010536736: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:02:32.302] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023198198871131632:8:0) after 1m0s
[12:03:32.422] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023198198871131632:8:0)
[12:03:32.422] Timer tick, asking Buildbucket for the build status
[12:03:32.539] Build 8857768137010536736: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:03:32.539] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023198198871131632:9:0) after 1m0s
[12:04:32.759] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023198198871131632:9:0)
[12:04:32.759] Timer tick, asking Buildbucket for the build status
[12:04:33.249] Build 8857768137010536736: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:04:33.249] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023198198871131632:10:0) after 1m0s
[12:05:33.336] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023198198871131632:10:0)
[12:05:33.336] Timer tick, asking Buildbucket for the build status
[12:05:33.694] Build 8857768137010536736: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:05:33.694] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023198198871131632:11:0) after 1m0s
[12:06:33.833] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023198198871131632:11:0)
[12:06:33.833] Timer tick, asking Buildbucket for the build status
[12:06:33.905] Build 8857768137010536736: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:06:33.905] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023198198871131632:12:0) after 1m0s
[12:07:33.921] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023198198871131632:12:0)
[12:07:33.921] Timer tick, asking Buildbucket for the build status
[12:07:34.043] Build 8857768137010536736: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:07:34.043] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023198198871131632:13:0) after 1m0s
[12:08:34.133] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023198198871131632:13:0)
[12:08:34.133] Timer tick, asking Buildbucket for the build status
[12:08:34.693] Build 8857768137010536736: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:08:34.693] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023198198871131632:14:0) after 1m0s
[12:09:34.942] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023198198871131632:14:0)
[12:09:34.942] Timer tick, asking Buildbucket for the build status
[12:09:35.015] Build 8857768137010536736: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:09:35.015] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023198198871131632:15:0) after 1m0s
[12:10:35.284] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023198198871131632:15:0)
[12:10:35.284] Timer tick, asking Buildbucket for the build status
[12:10:35.496] Build 8857768137010536736: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:10:35.496] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023198198871131632:16:0) after 1m0s
[12:11:35.503] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023198198871131632:16:0)
[12:11:35.503] Timer tick, asking Buildbucket for the build status
[12:11:35.711] Build 8857768137010536736: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:11:35.711] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023198198871131632:17:0) after 1m0s
[12:12:35.748] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023198198871131632:17:0)
[12:12:35.748] Timer tick, asking Buildbucket for the build status
[12:12:35.859] Build 8857768137010536736: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:12:35.859] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023198198871131632:18:0) after 1m0s
[12:13:35.881] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023198198871131632:18:0)
[12:13:35.881] Timer tick, asking Buildbucket for the build status
[12:13:35.953] Build 8857768137010536736: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:13:35.953] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023198198871131632:19:0) after 1m0s
[12:14:36.100] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023198198871131632:19:0)
[12:14:36.100] Timer tick, asking Buildbucket for the build status
[12:14:36.327] Build 8857768137010536736: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:14:36.327] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023198198871131632:20:0) after 1m0s
[12:15:36.408] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023198198871131632:20:0)
[12:15:36.408] Timer tick, asking Buildbucket for the build status
[12:15:36.474] Build 8857768137010536736: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:15:36.474] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023198198871131632:21:0) after 1m0s
[12:16:36.553] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023198198871131632:21:0)
[12:16:36.553] Timer tick, asking Buildbucket for the build status
[12:16:36.725] Build 8857768137010536736: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:16:36.725] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023198198871131632:22:0) after 1m0s
[12:17:36.781] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023198198871131632:22:0)
[12:17:36.781] Timer tick, asking Buildbucket for the build status
[12:17:36.904] Build 8857768137010536736: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:17:36.904] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023198198871131632:23:0) after 1m0s
[12:18:37.059] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023198198871131632:23:0)
[12:18:37.059] Timer tick, asking Buildbucket for the build status
[12:18:37.137] Build 8857768137010536736: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:18:37.137] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023198198871131632:24:0) after 1m0s
[12:19:37.148] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023198198871131632:24:0)
[12:19:37.148] Timer tick, asking Buildbucket for the build status
[12:19:37.697] Build 8857768137010536736: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:19:37.697] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023198198871131632:25:0) after 1m0s
[12:20:37.790] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023198198871131632:25:0)
[12:20:37.790] Timer tick, asking Buildbucket for the build status
[12:20:37.852] Build 8857768137010536736: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:20:37.852] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023198198871131632:26:0) after 1m0s
[12:21:37.888] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023198198871131632:26:0)
[12:21:37.888] Timer tick, asking Buildbucket for the build status
[12:21:38.008] Build 8857768137010536736: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:21:38.008] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023198198871131632:27:0) after 1m0s
[12:22:38.050] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023198198871131632:27:0)
[12:22:38.050] Timer tick, asking Buildbucket for the build status
[12:22:38.152] Build 8857768137010536736: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:22:38.153] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023198198871131632:28:0) after 1m0s
[12:23:38.201] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023198198871131632:28:0)
[12:23:38.201] Timer tick, asking Buildbucket for the build status
[12:23:38.314] Build 8857768137010536736: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:23:38.314] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023198198871131632:29:0) after 1m0s
[12:24:38.355] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023198198871131632:29:0)
[12:24:38.355] Timer tick, asking Buildbucket for the build status
[12:24:38.529] Build 8857768137010536736: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:24:38.529] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023198198871131632:30:0) after 1m0s
[12:25:38.622] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023198198871131632:30:0)
[12:25:38.622] Timer tick, asking Buildbucket for the build status
[12:25:39.313] Build 8857768137010536736: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:25:39.313] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023198198871131632:31:0) after 1m0s
[12:26:39.368] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023198198871131632:31:0)
[12:26:39.368] Timer tick, asking Buildbucket for the build status
[12:26:39.444] Build 8857768137010536736: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:26:39.444] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023198198871131632:32:0) after 1m0s
[12:27:39.537] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023198198871131632:32:0)
[12:27:39.537] Timer tick, asking Buildbucket for the build status
[12:27:39.651] Build 8857768137010536736: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:27:39.651] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023198198871131632:33:0) after 1m0s
[12:28:39.691] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023198198871131632:33:0)
[12:28:39.691] Timer tick, asking Buildbucket for the build status
[12:28:39.746] Build 8857768137010536736: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:28:39.746] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023198198871131632:34:0) after 1m0s
[12:29:39.836] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023198198871131632:34:0)
[12:29:39.836] Timer tick, asking Buildbucket for the build status
[12:29:39.900] Build 8857768137010536736: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:29:39.900] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023198198871131632:35:0) after 1m0s
[12:30:39.999] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023198198871131632:35:0)
[12:30:39.999] Timer tick, asking Buildbucket for the build status
[12:30:40.217] Build 8857768137010536736: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:30:40.217] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023198198871131632:36:0) after 1m0s
[12:31:40.315] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023198198871131632:36:0)
[12:31:40.315] Timer tick, asking Buildbucket for the build status
[12:31:40.476] Build 8857768137010536736: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:31:40.476] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023198198871131632:37:0) after 1m0s
[12:32:40.564] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023198198871131632:37:0)
[12:32:40.564] Timer tick, asking Buildbucket for the build status
[12:32:41.097] Build 8857768137010536736: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:32:41.097] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023198198871131632:38:0) after 1m0s
[12:33:41.205] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023198198871131632:38:0)
[12:33:41.205] Timer tick, asking Buildbucket for the build status
[12:33:41.268] Build 8857768137010536736: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:33:41.268] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023198198871131632:39:0) after 1m0s
[12:34:41.294] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023198198871131632:39:0)
[12:34:41.294] Timer tick, asking Buildbucket for the build status
[12:34:41.412] Build 8857768137010536736: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:34:41.412] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023198198871131632:40:0) after 1m0s
[12:35:41.510] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023198198871131632:40:0)
[12:35:41.510] Timer tick, asking Buildbucket for the build status
[12:35:41.748] Build 8857768137010536736: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:35:41.748] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023198198871131632:41:0) after 1m0s
[12:36:41.809] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023198198871131632:41:0)
[12:36:41.809] Timer tick, asking Buildbucket for the build status
[12:36:41.877] Build 8857768137010536736: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:36:41.877] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023198198871131632:42:0) after 1m0s
[12:37:41.939] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023198198871131632:42:0)
[12:37:41.940] Timer tick, asking Buildbucket for the build status
[12:37:42.036] Build 8857768137010536736: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:37:42.036] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023198198871131632:43:0) after 1m0s
[12:38:42.169] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023198198871131632:43:0)
[12:38:42.169] Timer tick, asking Buildbucket for the build status
[12:38:42.242] Build 8857768137010536736: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:38:42.242] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023198198871131632:44:0) after 1m0s
[12:39:42.337] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023198198871131632:44:0)
[12:39:42.337] Timer tick, asking Buildbucket for the build status
[12:39:42.785] Build 8857768137010536736: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:39:42.785] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023198198871131632:45:0) after 1m0s
[12:40:42.840] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023198198871131632:45:0)
[12:40:42.840] Timer tick, asking Buildbucket for the build status
[12:40:42.948] Build 8857768137010536736: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:40:42.948] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023198198871131632:46:0) after 1m0s
[12:41:43.018] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023198198871131632:46:0)
[12:41:43.018] Timer tick, asking Buildbucket for the build status
[12:41:43.123] Build 8857768137010536736: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:41:43.123] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023198198871131632:47:0) after 1m0s
[12:42:43.251] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023198198871131632:47:0)
[12:42:43.251] Timer tick, asking Buildbucket for the build status
[12:42:43.858] Build 8857768137010536736: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:42:43.858] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023198198871131632:48:0) after 1m0s
[12:43:43.926] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023198198871131632:48:0)
[12:43:43.926] Timer tick, asking Buildbucket for the build status
[12:43:44.048] Build 8857768137010536736: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:43:44.048] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023198198871131632:49:0) after 1m0s
[12:44:44.065] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023198198871131632:49:0)
[12:44:44.065] Timer tick, asking Buildbucket for the build status
[12:44:44.380] Build 8857768137010536736: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:44:44.380] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023198198871131632:50:0) after 1m0s
[12:45:44.510] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023198198871131632:50:0)
[12:45:44.510] Timer tick, asking Buildbucket for the build status
[12:45:45.087] Build 8857768137010536736: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:45:45.087] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023198198871131632:51:0) after 1m0s
[12:46:45.233] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023198198871131632:51:0)
[12:46:45.233] Timer tick, asking Buildbucket for the build status
[12:46:45.447] Build 8857768137010536736: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:46:45.447] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023198198871131632:52:0) after 1m0s
[12:47:45.480] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023198198871131632:52:0)
[12:47:45.480] Timer tick, asking Buildbucket for the build status
[12:47:45.586] Build 8857768137010536736: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:47:45.586] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023198198871131632:53:0) after 1m0s
[12:48:45.672] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023198198871131632:53:0)
[12:48:45.672] Timer tick, asking Buildbucket for the build status
[12:48:45.743] Build 8857768137010536736: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:48:45.743] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023198198871131632:54:0) after 1m0s
[12:49:45.796] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023198198871131632:54:0)
[12:49:45.796] Timer tick, asking Buildbucket for the build status
[12:49:46.134] Build 8857768137010536736: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:49:46.134] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023198198871131632:55:0) after 1m0s
[12:50:46.172] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023198198871131632:55:0)
[12:50:46.172] Timer tick, asking Buildbucket for the build status
[12:50:48.365] Build 8857768137010536736: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:50:48.365] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023198198871131632:56:0) after 1m0s
[12:51:48.456] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023198198871131632:56:0)
[12:51:48.456] Timer tick, asking Buildbucket for the build status
[12:51:48.834] Build 8857768137010536736: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:51:48.834] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023198198871131632:57:0) after 1m0s
[12:52:48.947] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023198198871131632:57:0)
[12:52:48.947] Timer tick, asking Buildbucket for the build status
[12:52:49.107] Build 8857768137010536736: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:52:49.107] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023198198871131632:58:0) after 1m0s
[12:53:49.143] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023198198871131632:58:0)
[12:53:49.143] Timer tick, asking Buildbucket for the build status
[12:53:49.220] Build 8857768137010536736: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:53:49.220] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023198198871131632:59:0) after 1m0s
[12:54:49.272] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023198198871131632:59:0)
[12:54:49.272] Timer tick, asking Buildbucket for the build status
[12:54:49.440] Build 8857768137010536736: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:54:49.440] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023198198871131632:60:0) after 1m0s
[12:55:49.595] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023198198871131632:60:0)
[12:55:49.595] Timer tick, asking Buildbucket for the build status
[12:55:49.735] Build 8857768137010536736: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:55:49.735] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023198198871131632:61:0) after 1m0s
[12:56:49.995] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023198198871131632:61:0)
[12:56:49.995] Timer tick, asking Buildbucket for the build status
[12:56:50.387] Build 8857768137010536736: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:56:50.387] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023198198871131632:62:0) after 1m0s
[12:57:50.668] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023198198871131632:62:0)
[12:57:50.668] Timer tick, asking Buildbucket for the build status
[12:57:50.816] Build 8857768137010536736: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:57:50.816] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023198198871131632:63:0) after 1m0s
[12:58:51.066] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023198198871131632:63:0)
[12:58:51.066] Timer tick, asking Buildbucket for the build status
[12:58:51.402] Build 8857768137010536736: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:58:51.402] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023198198871131632:64:0) after 1m0s
[12:59:51.520] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023198198871131632:64:0)
[12:59:51.520] Timer tick, asking Buildbucket for the build status
[12:59:51.702] Build 8857768137010536736: status "STARTED", result "", failure_reason "", cancelation_reason ""
[12:59:51.702] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023198198871131632:65:0) after 1m0s
[13:00:51.744] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023198198871131632:65:0)
[13:00:51.744] Timer tick, asking Buildbucket for the build status
[13:00:51.897] Build 8857768137010536736: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:00:51.897] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023198198871131632:66:0) after 1m0s
[13:01:51.934] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023198198871131632:66:0)
[13:01:51.934] Timer tick, asking Buildbucket for the build status
[13:01:52.113] Build 8857768137010536736: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:01:52.113] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023198198871131632:67:0) after 1m0s
[13:02:52.112] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023198198871131632:67:0)
[13:02:52.112] Timer tick, asking Buildbucket for the build status
[13:02:52.290] Build 8857768137010536736: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:02:52.290] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023198198871131632:68:0) after 1m0s
[13:03:52.447] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023198198871131632:68:0)
[13:03:52.447] Timer tick, asking Buildbucket for the build status
[13:03:52.676] Build 8857768137010536736: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:03:52.676] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023198198871131632:69:0) after 1m0s
[13:04:52.682] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023198198871131632:69:0)
[13:04:52.682] Timer tick, asking Buildbucket for the build status
[13:04:52.880] Build 8857768137010536736: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:04:52.880] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023198198871131632:70:0) after 1m0s
[13:05:52.994] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023198198871131632:70:0)
[13:05:52.994] Timer tick, asking Buildbucket for the build status
[13:05:53.085] Build 8857768137010536736: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:05:53.085] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023198198871131632:71:0) after 1m0s
[13:06:53.127] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023198198871131632:71:0)
[13:06:53.127] Timer tick, asking Buildbucket for the build status
[13:06:53.201] Build 8857768137010536736: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:06:53.201] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023198198871131632:72:0) after 1m0s
[13:07:53.313] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023198198871131632:72:0)
[13:07:53.313] Timer tick, asking Buildbucket for the build status
[13:07:53.447] Build 8857768137010536736: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:07:53.447] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023198198871131632:73:0) after 1m0s
[13:08:53.513] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023198198871131632:73:0)
[13:08:53.513] Timer tick, asking Buildbucket for the build status
[13:08:53.604] Build 8857768137010536736: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:08:53.604] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023198198871131632:74:0) after 1m0s
[13:09:53.684] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023198198871131632:74:0)
[13:09:53.684] Timer tick, asking Buildbucket for the build status
[13:09:54.019] Build 8857768137010536736: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:09:54.019] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023198198871131632:75:0) after 1m0s
[13:10:54.088] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023198198871131632:75:0)
[13:10:54.088] Timer tick, asking Buildbucket for the build status
[13:10:54.163] Build 8857768137010536736: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:10:54.163] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023198198871131632:76:0) after 1m0s
[13:11:54.280] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023198198871131632:76:0)
[13:11:54.280] Timer tick, asking Buildbucket for the build status
[13:11:54.659] Build 8857768137010536736: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:11:54.659] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023198198871131632:77:0) after 1m0s
[13:12:54.738] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023198198871131632:77:0)
[13:12:54.738] Timer tick, asking Buildbucket for the build status
[13:12:55.148] Build 8857768137010536736: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:12:55.148] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023198198871131632:78:0) after 1m0s
[13:13:55.217] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023198198871131632:78:0)
[13:13:55.217] Timer tick, asking Buildbucket for the build status
[13:13:55.403] Build 8857768137010536736: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:13:55.403] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023198198871131632:79:0) after 1m0s
[13:14:55.425] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023198198871131632:79:0)
[13:14:55.425] Timer tick, asking Buildbucket for the build status
[13:14:55.806] Build 8857768137010536736: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:14:55.806] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023198198871131632:80:0) after 1m0s
[13:15:55.800] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023198198871131632:80:0)
[13:15:55.800] Timer tick, asking Buildbucket for the build status
[13:15:55.910] Build 8857768137010536736: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:15:55.910] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023198198871131632:81:0) after 1m0s
[13:16:55.934] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023198198871131632:81:0)
[13:16:55.934] Timer tick, asking Buildbucket for the build status
[13:16:56.085] Build 8857768137010536736: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:16:56.085] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023198198871131632:82:0) after 1m0s
[13:17:56.117] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023198198871131632:82:0)
[13:17:56.117] Timer tick, asking Buildbucket for the build status
[13:17:56.265] Build 8857768137010536736: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:17:56.265] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023198198871131632:83:0) after 1m0s
[13:18:56.296] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023198198871131632:83:0)
[13:18:56.296] Timer tick, asking Buildbucket for the build status
[13:18:56.766] Build 8857768137010536736: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:18:56.766] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023198198871131632:84:0) after 1m0s
[13:19:56.788] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023198198871131632:84:0)
[13:19:56.788] Timer tick, asking Buildbucket for the build status
[13:19:56.901] Build 8857768137010536736: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:19:56.901] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023198198871131632:85:0) after 1m0s
[13:20:56.946] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023198198871131632:85:0)
[13:20:56.946] Timer tick, asking Buildbucket for the build status
[13:20:57.073] Build 8857768137010536736: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:20:57.073] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023198198871131632:86:0) after 1m0s
[13:21:57.086] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023198198871131632:86:0)
[13:21:57.086] Timer tick, asking Buildbucket for the build status
[13:21:57.242] Build 8857768137010536736: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:21:57.242] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023198198871131632:87:0) after 1m0s
[13:22:57.253] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023198198871131632:87:0)
[13:22:57.253] Timer tick, asking Buildbucket for the build status
[13:22:57.664] Build 8857768137010536736: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:22:57.664] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023198198871131632:88:0) after 1m0s
[13:23:57.724] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023198198871131632:88:0)
[13:23:57.724] Timer tick, asking Buildbucket for the build status
[13:23:57.813] Build 8857768137010536736: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:23:57.813] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023198198871131632:89:0) after 1m0s
[13:24:57.823] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023198198871131632:89:0)
[13:24:57.823] Timer tick, asking Buildbucket for the build status
[13:24:57.905] Build 8857768137010536736: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:24:57.905] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023198198871131632:90:0) after 1m0s
[13:25:57.940] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023198198871131632:90:0)
[13:25:57.940] Timer tick, asking Buildbucket for the build status
[13:25:58.120] Build 8857768137010536736: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:25:58.120] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023198198871131632:91:0) after 1m0s
[13:26:58.161] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023198198871131632:91:0)
[13:26:58.161] Timer tick, asking Buildbucket for the build status
[13:26:58.237] Build 8857768137010536736: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:26:58.237] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023198198871131632:92:0) after 1m0s
[13:27:58.282] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023198198871131632:92:0)
[13:27:58.282] Timer tick, asking Buildbucket for the build status
[13:27:58.399] Build 8857768137010536736: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:27:58.399] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023198198871131632:93:0) after 1m0s
[13:28:58.498] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023198198871131632:93:0)
[13:28:58.498] Timer tick, asking Buildbucket for the build status
[13:28:58.580] Build 8857768137010536736: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:28:58.580] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023198198871131632:94:0) after 1m0s
[13:29:58.602] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023198198871131632:94:0)
[13:29:58.602] Timer tick, asking Buildbucket for the build status
[13:29:58.839] Build 8857768137010536736: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:29:58.839] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023198198871131632:95:0) after 1m0s
[13:30:58.871] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023198198871131632:95:0)
[13:30:58.871] Timer tick, asking Buildbucket for the build status
[13:30:59.001] Build 8857768137010536736: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:30:59.001] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023198198871131632:96:0) after 1m0s
[13:31:59.053] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023198198871131632:96:0)
[13:31:59.053] Timer tick, asking Buildbucket for the build status
[13:31:59.687] Build 8857768137010536736: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:31:59.687] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023198198871131632:97:0) after 1m0s
[13:32:59.712] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023198198871131632:97:0)
[13:32:59.712] Timer tick, asking Buildbucket for the build status
[13:33:00.184] Build 8857768137010536736: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:33:00.184] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023198198871131632:98:0) after 1m0s
[13:34:00.179] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023198198871131632:98:0)
[13:34:00.179] Timer tick, asking Buildbucket for the build status
[13:34:01.988] Build 8857768137010536736: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:34:01.988] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023198198871131632:99:0) after 1m0s
[13:35:02.018] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023198198871131632:99:0)
[13:35:02.018] Timer tick, asking Buildbucket for the build status
[13:35:02.435] Build 8857768137010536736: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:35:02.435] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023198198871131632:100:0) after 1m0s
[13:36:02.554] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023198198871131632:100:0)
[13:36:02.554] Timer tick, asking Buildbucket for the build status
[13:36:03.200] Build 8857768137010536736: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:36:03.200] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023198198871131632:101:0) after 1m0s
[13:37:03.194] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023198198871131632:101:0)
[13:37:03.194] Timer tick, asking Buildbucket for the build status
[13:37:03.439] Build 8857768137010536736: status "STARTED", result "", failure_reason "", cancelation_reason ""
[13:37:03.439] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9023198198871131632:102:0) after 1m0s
[13:37:07.743] Received PubSub notification, asking Buildbucket for the build status
[13:37:07.820] Build 8857768137010536736: status "COMPLETED", result "SUCCESS", failure_reason "", cancelation_reason ""
[13:37:07.820] Buildbucket build:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "PROD",
"completed_ts": "1610977023761161",
"created_by": "project:chromium",
"created_ts": "1610971049259498",
"id": "8857768137010536736",
"parameters_json": "{\"builder_name\": \"linux-chromeos-dbg\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"21a8ee36d10ae1ea202f95fe4ddb0d8eb9154f7d\"}}",
"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\": \"21a8ee36d10ae1ea202f95fe4ddb0d8eb9154f7d\", \"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-86-wu7l\", \"branch\": \"refs/heads/master\", \"builder_group\": \"chromium.chromiumos\", \"buildername\": \"linux-chromeos-dbg\", \"buildnumber\": 22240, \"got_angle_revision\": \"bd2954a9c499381ddaf10bd5ca3d93dd7b0b9bed\", \"got_dawn_revision\": \"5c20f1ec9ca95008eb452e04133c332af3a2b3fa\", \"got_nacl_revision\": \"cb31feffa500401c95c6c44d88b7c358236bca36\", \"got_revision\": \"21a8ee36d10ae1ea202f95fe4ddb0d8eb9154f7d\", \"got_revision_cp\": \"refs/heads/master@{#844496}\", \"got_swarming_client_revision\": \"1a072711d4388c62e02480fabc26c68c24494be9\", \"got_swiftshader_revision\": \"149733cead636de93d96c5c64f30168d5f6bb03f\", \"got_v8_revision\": \"16b9bbbd581c25391981aa03180b76aa60463a3e\", \"got_v8_revision_cp\": \"refs/heads/8.9.255@{#1}\", \"got_webrtc_revision\": \"12971a22d265c7ba1c3c388f5d487580939a1162\", \"got_webrtc_revision_cp\": \"refs/heads/master@{#33014}\", \"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\": \"21a8ee36d10ae1ea202f95fe4ddb0d8eb9154f7d\", \"swarm_hashes_refs/heads/master(at){#844496}_without_patch\": {\"absl_hardening_tests\": \"3f1489c23fd7b59b413ac1a611f1a6312c71b796\", \"accessibility_unittests\": \"b7c0d91c0c47520d72b33a1dc260a276a6f0258f\", \"angle_unittests\": \"a97d56a6776ad1c52476f9251a2425a6f8d40790\", \"app_list_unittests\": \"1e850b27abea95853c9745cfd0e62f8372d4bf64\", \"app_shell_unittests\": \"66a87f5d8336b3b63da56ef43692dfb4409a55ce\", \"ash_unittests\": \"374fdf80a49da7a23f23bb93827179f1d3dd272e\", \"aura_unittests\": \"eea1ea7d430df02f228ca0866bed0ad179abdab0\", \"base_unittests\": \"0593a4b5ddeccb7d263d999be11ac1adc1ee20e2\", \"base_util_unittests\": \"11e966dd968881457a1990623093d9e4b737a4c3\", \"blink_common_unittests\": \"d7b45995158fd1abe6936257e95c4f9c638cee35\", \"blink_fuzzer_unittests\": \"d35d3b09ab69d4da180ed663942f2d6a04785c03\", \"blink_heap_unittests\": \"065d929f5b78c6a6d52630a0ff8326c7e93d2e28\", \"blink_platform_unittests\": \"9339ee88b066fdd88d9baf6ff8543773cf9558cd\", \"blink_unittests\": \"b488a438f4db3dee5386daac1fb1b096feab3836\", \"boringssl_crypto_tests\": \"a0e0e0060683f7e677b6503445ee8debb90fda67\", \"boringssl_ssl_tests\": \"fd7fd48d3b15c87468dbed414301f29d0c9a52e7\", \"browser_tests\": \"740ccad1d1e0dfc498217974d688564472f6e72d\", \"capture_unittests\": \"84847e661fbe724dd619fab29a45973f6495eef5\", \"cast_unittests\": \"661d0983153b016c9178ee9614840cfa682a5b1b\", \"cc_unittests\": \"b532ec0cdd04b8bd4907125018ca3fd7e186dcaf\", \"chrome_app_unittests\": \"412c8ae22d93f569b2a99a33b081356224590319\", \"chromedriver_unittests\": \"9e2e8ce7bdc2debddfd1a6e873f08d44233b462d\", \"chromeos_components_unittests\": \"44f9b95e7886069f8d6ead3a42af3dcf3c780458\", \"chromeos_unittests\": \"c1cc6c21af24ef444c36863ada09c402bfe660cf\", \"components_browsertests\": \"e14828b342cf0b244024ae461e745261bc923a93\", \"components_unittests\": \"0aa1d07e724b746703fc38fd0d71ea706a1801da\", \"compositor_unittests\": \"8e3837fce5d53f67b3a3ec5c992954137ce70ddf\", \"content_browsertests\": \"ff9aeb385fdbae19a3d2f2009084402280689646\", \"content_unittests\": \"f5c4c0084432bd6b7f639c432b12fb81b142becb\", \"crashpad_tests\": \"19df648f301a413b33c2df3c3342bc96a35080f6\", \"crypto_unittests\": \"5d9a1d0fb813d45f3b0c618f31fff9a4cbca194f\", \"dbus_unittests\": \"2ad3b2603d8ece44f8a048ae70231eb00b2e9c79\", \"device_unittests\": \"724b1115d0e27aeee2bafffe82bc8a08a70dfb99\", \"display_unittests\": \"d3586e5bbaf85d232ce2d1f2360b3e6cca87d2aa\", \"events_unittests\": \"cc0788009913ee63bd478c51d36aeeb7490aac41\", \"exo_unittests\": \"0463f8fe34241d7f403362a7e43d22f015e26831\", \"extensions_browsertests\": \"a5fafbd9631bcf2cbf589774c56842b2a14c7a34\", \"extensions_unittests\": \"156e45750c7279c7baf86e5eb2674da13f02fb26\", \"filesystem_service_unittests\": \"fb5f5e2f1bdafb78ea8d01d3f6fbd66591659002\", \"gcm_unit_tests\": \"be1db30cada1c7aad8b972e8da495f05b05b19bd\", \"gfx_unittests\": \"1eb95dc5a3ba9673f228b7f43bb56f00f4a7c38b\", \"gin_unittests\": \"b010920a0bb6d6b887a540b156c974a0dd112f26\", \"gl_unittests_ozone\": \"0fa2c73459e3647ff0064a37899f048868ede91f\", \"google_apis_unittests\": \"e0822386a3007456c8d33d39f9ac0d14c960f4d4\", \"gpu_unittests\": \"20086123dad7c21203f613979fa43b1fa1315d8d\", \"gwp_asan_unittests\": \"04c2f895021fdccd1b1967e68ac4f86d5092b81d\", \"interactive_ui_tests\": \"2052043f68090e3c0cc8d4729d0fd6ad53a8aee9\", \"ipc_tests\": \"73a846a52730019d457c8b6f9db3323e78249757\", \"jingle_unittests\": \"5a5ca4b9ad255bf034347dbba1fc03c1424e5ce7\", \"keyboard_unittests\": \"a084d0eb94f6a890e3dc8f9412bfa04dda8e6f20\", \"latency_unittests\": \"f686e1dc1e776b6db83383ac43aba021fa0f2823\", \"libjingle_xmpp_unittests\": \"3962bb1d48417ac9789c326c245666e883680bdb\", \"liburlpattern_unittests\": \"1f60672bd0e27d6f11cbf5b24fae754709b78553\", \"media_blink_unittests\": \"d4224c8dd7f7b1a8eff7f2e9c1d29676ef609bd0\", \"media_unittests\": \"11da037535a6d1a2cab0ff2dc50a222cc815f30b\", \"message_center_unittests\": \"b2df9c68a4d49917cfe229bc25a0f8af2b5269a0\", \"midi_unittests\": \"3d4072d1cd457c1690c6f565c5174331d30febfc\", \"mojo_core_unittests\": \"12eaa11b51638184be717128dcbb2a1bf872e4a2\", \"mojo_unittests\": \"7325d190b96435640c83c2a07fc4be1fe3b19d62\", \"nacl_helper_nonsfi_unittests\": \"0211b8b8e28996a1332e320ff42de38c943125d3\", \"nacl_loader_unittests\": \"5645ae6d8bdea96e10bbe119db07b55f2a7df7f3\", \"native_theme_unittests\": \"dde4c48b260cb5f31797fc43847482f224673c14\", \"net_unittests\": \"a2f6e8c9b71d65bda3454ed1a74a96ec08e3d990\", \"ozone_gl_unittests\": \"22630609f66b59eff84db1e677b962be35a0c15f\", \"ozone_unittests\": \"702def37d5f9895e0deeac90dc6ecdc330f23638\", \"ozone_x11_unittests\": \"0ce26ca927d7c042342e248f71de6576a45e4b7d\", \"pdf_unittests\": \"c5d2d1afa711d4cc51119b0485e1d21c3cf87e99\", \"perfetto_unittests\": \"0cff25b5d13917746806a17750baaa2347ea4412\", \"ppapi_unittests\": \"b73a2a559ab868372f8ac2866b244399e82be056\", \"printing_unittests\": \"c2ec302d6b7c8e740a37bc9590427ecb91d951dd\", \"remoting_unittests\": \"6d581050e7f7273fe180ddad091fbebf5d5ef650\", \"sandbox_linux_unittests\": \"23187a116cd6f4f21203a0cd5866ebfd194759fd\", \"service_manager_unittests\": \"9eb73324ab3e60e588db4838193bd0c5005ce5f2\", \"services_unittests\": \"819f83d4b37354ceecb5f3c858480ab85a0c0cd4\", \"shell_dialogs_unittests\": \"56c46d8d27171c26aaea885950923c6f3bb82316\", \"shell_encryption_unittests\": \"38fc16b47a2cdc152054704896a21445c277d0bb\", \"skia_unittests\": \"bfdbd9cde4f4d9040cc0a7cefb72a42f8bb0a541\", \"snapshot_unittests\": \"a62d8feae0b8a47849edc4539ad1fbb1bc0f6fca\", \"sql_unittests\": \"9a517e70c5a700484dec80f04fd2e21a4369daaf\", \"storage_unittests\": \"a7dabe0b4e871a51292b5d29ddae5830c2fbf1c8\", \"sync_integration_tests\": \"995337c5631c9af11817f501a994b5e77bb6d5e3\", \"traffic_annotation_auditor_unittests\": \"47d056faeed1a94398edb929baf8244c81fd3160\", \"ui_base_unittests\": \"b0aa8ece27329b6a8d93c2c3070ae6ae79fe6877\", \"ui_chromeos_unittests\": \"1e76bbb4c718586dc4ce4b6013bfddb1befbed95\", \"ui_touch_selection_unittests\": \"9274a49e837ab1f0405bcc0f6dfbf10122e39b8c\", \"unit_tests\": \"52a59d45048fc06d52206233b7c281891a9fd270\", \"url_unittests\": \"e345df9e78f12423a145bee23594afd2cffdbfc5\", \"usage_time_limit_unittests\": \"301e2d61e233c03e2ef02ffc7500618faa414468\", \"views_unittests\": \"de194517642b4932c7388574b61086605e7637f8\", \"viz_unittests\": \"df0082232250f5195d38113f586e75dbdc280a81\", \"wm_unittests\": \"e76d75936c777d55810d1c99181fbd5301dcd54a\", \"wtf_unittests\": \"373e0c45266c8c01808154f571dcd88a64242bec\", \"zlib_unittests\": \"3b2f3293e852fbf150a5f15942ba13e3055b7484\"}}, \"swarming\": {\"bot_dimensions\": {\"builderless\": [\"1\"], \"caches\": [\"builder_4973d939604d11dcbaec68575e69c80c756ff63e355ab013b29b8bca26434b7c_v2\", \"git\", \"goma_v2\", \"vpython\"], \"cores\": [\"8\"], \"cpu\": [\"x86\", \"x86-64\", \"x86-64-Haswell_GCE\", \"x86-64-avx2\"], \"gce\": [\"1\"], \"gcp\": [\"google.com:chromecompute\"], \"gpu\": [\"none\"], \"id\": [\"luci-chromium-ci-xenial-us-central1-b-8-86-wu7l\"], \"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\": [\"5666-679c9bd\"], \"ssd\": [\"0\"], \"zone\": [\"us\", \"us-central\", \"us-central1\", \"us-central1-b\"]}}}",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"started_ts": "1610971052006882",
"status": "COMPLETED",
"status_changed_ts": "1610977024520330",
"tags": [
"build_address:luci.chromium.ci/linux-chromeos-dbg/22240",
"builder:linux-chromeos-dbg",
"buildset:commit/git/21a8ee36d10ae1ea202f95fe4ddb0d8eb9154f7d",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/21a8ee36d10ae1ea202f95fe4ddb0d8eb9154f7d",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9023198198871131632",
"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/8857768137010536736/+/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:512e2cfb2efdb310",
"user_agent:luci-scheduler"
],
"updated_ts": "1610977024663608",
"url": "https://ci.chromium.org/b/8857768137010536736",
"utcnow_ts": "1610977027808020"
}
}
[13:37:07.820] Invocation finished in 1h39m39.719323195s with status SUCCEEDED