[01:35:01.963] New invocation is queued and will start shortly
[01:35:03.843] Starting the invocation (attempt 1)
[01:35:03.886] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[01:35:03.887] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[01:35:03.887] Buildbucket request:
{
"bucket": "luci.chromium.ci",
"client_operation_id": "9031119295230203712",
"parameters_json": "{\"builder_name\":\"linux-chromeos-dbg\",\"properties\":{\"branch\":\"refs/heads/master\",\"repository\":\"https://chromium.googlesource.com/chromium/src\",\"revision\":\"2333fd21068bca383d72754e00cce67bb15be3c8\"}}",
"pubsub_callback": {
"auth_token": "...",
"topic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
},
"tags": [
"builder:linux-chromeos-dbg",
"scheduler_invocation_id:9031119295230203712",
"scheduler_job_id:chromium/linux-chromeos-dbg",
"user_agent:luci-scheduler",
"buildset:commit/git/2333fd21068bca383d72754e00cce67bb15be3c8",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/2333fd21068bca383d72754e00cce67bb15be3c8",
"gitiles_ref:refs/heads/master"
]
}
[01:35:05.006] Buildbucket response:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "PROD",
"created_by": "project:chromium",
"created_ts": "1603416904038187",
"id": "8865689232389625056",
"parameters_json": "{\"builder_name\": \"linux-chromeos-dbg\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"2333fd21068bca383d72754e00cce67bb15be3c8\"}}",
"project": "chromium",
"result_details_json": "{\"properties\": {}}",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"status": "SCHEDULED",
"status_changed_ts": "1603416904699818",
"tags": [
"build_address:luci.chromium.ci/linux-chromeos-dbg/20971",
"builder:linux-chromeos-dbg",
"buildset:commit/git/2333fd21068bca383d72754e00cce67bb15be3c8",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/2333fd21068bca383d72754e00cce67bb15be3c8",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9031119295230203712",
"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/8865689232389625056/+/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": "1603416904700008",
"url": "https://ci.chromium.org/b/8865689232389625056",
"utcnow_ts": "1603416904994762"
}
}
[01:35:05.006] Task URL: https://ci.chromium.org/b/8865689232389625056
[01:35:05.006] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031119295230203712:2:0) after 1m0s
[01:36:05.031] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031119295230203712:2:0)
[01:36:05.031] Timer tick, asking Buildbucket for the build status
[01:36:05.633] Build 8865689232389625056: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[01:36:05.633] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031119295230203712:3:0) after 1m0s
[01:36:53.046] Received PubSub notification, asking Buildbucket for the build status
[01:36:53.106] Build 8865689232389625056: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:37:05.636] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031119295230203712:3:0)
[01:37:05.636] Timer tick, asking Buildbucket for the build status
[01:37:05.703] Build 8865689232389625056: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:37:05.703] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031119295230203712:5:0) after 1m0s
[01:38:05.730] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031119295230203712:5:0)
[01:38:05.730] Timer tick, asking Buildbucket for the build status
[01:38:05.995] Build 8865689232389625056: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:38:05.995] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031119295230203712:6:0) after 1m0s
[01:39:06.015] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031119295230203712:6:0)
[01:39:06.015] Timer tick, asking Buildbucket for the build status
[01:39:06.074] Build 8865689232389625056: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:39:06.074] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031119295230203712:7:0) after 1m0s
[01:40:06.113] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031119295230203712:7:0)
[01:40:06.114] Timer tick, asking Buildbucket for the build status
[01:40:06.858] Build 8865689232389625056: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:40:06.858] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031119295230203712:8:0) after 1m0s
[01:41:06.877] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031119295230203712:8:0)
[01:41:06.877] Timer tick, asking Buildbucket for the build status
[01:41:07.410] Build 8865689232389625056: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:41:07.410] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031119295230203712:9:0) after 1m0s
[01:42:07.472] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031119295230203712:9:0)
[01:42:07.472] Timer tick, asking Buildbucket for the build status
[01:42:07.567] Build 8865689232389625056: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:42:07.567] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031119295230203712:10:0) after 1m0s
[01:43:07.613] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031119295230203712:10:0)
[01:43:07.613] Timer tick, asking Buildbucket for the build status
[01:43:07.716] Build 8865689232389625056: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:43:07.716] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031119295230203712:11:0) after 1m0s
[01:44:07.783] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031119295230203712:11:0)
[01:44:07.783] Timer tick, asking Buildbucket for the build status
[01:44:07.925] Build 8865689232389625056: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:44:07.925] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031119295230203712:12:0) after 1m0s
[01:45:08.017] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031119295230203712:12:0)
[01:45:08.017] Timer tick, asking Buildbucket for the build status
[01:45:08.147] Build 8865689232389625056: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:45:08.147] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031119295230203712:13:0) after 1m0s
[01:46:08.200] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031119295230203712:13:0)
[01:46:08.200] Timer tick, asking Buildbucket for the build status
[01:46:08.316] Build 8865689232389625056: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:46:08.316] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031119295230203712:14:0) after 1m0s
[01:47:08.381] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031119295230203712:14:0)
[01:47:08.381] Timer tick, asking Buildbucket for the build status
[01:47:08.471] Build 8865689232389625056: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:47:08.471] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031119295230203712:15:0) after 1m0s
[01:48:08.528] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031119295230203712:15:0)
[01:48:08.528] Timer tick, asking Buildbucket for the build status
[01:48:08.615] Build 8865689232389625056: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:48:08.615] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031119295230203712:16:0) after 1m0s
[01:49:08.679] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031119295230203712:16:0)
[01:49:08.679] Timer tick, asking Buildbucket for the build status
[01:49:08.749] Build 8865689232389625056: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:49:08.749] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031119295230203712:17:0) after 1m0s
[01:50:08.940] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031119295230203712:17:0)
[01:50:08.940] Timer tick, asking Buildbucket for the build status
[01:50:09.054] Build 8865689232389625056: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:50:09.054] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031119295230203712:18:0) after 1m0s
[01:51:09.130] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031119295230203712:18:0)
[01:51:09.130] Timer tick, asking Buildbucket for the build status
[01:51:09.390] Build 8865689232389625056: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:51:09.390] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031119295230203712:19:0) after 1m0s
[01:52:09.467] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031119295230203712:19:0)
[01:52:09.467] Timer tick, asking Buildbucket for the build status
[01:52:09.601] Build 8865689232389625056: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:52:09.601] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031119295230203712:20:0) after 1m0s
[01:53:09.653] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031119295230203712:20:0)
[01:53:09.653] Timer tick, asking Buildbucket for the build status
[01:53:09.774] Build 8865689232389625056: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:53:09.774] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031119295230203712:21:0) after 1m0s
[01:54:09.915] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031119295230203712:21:0)
[01:54:09.915] Timer tick, asking Buildbucket for the build status
[01:54:09.970] Build 8865689232389625056: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:54:09.970] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031119295230203712:22:0) after 1m0s
[01:55:09.994] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031119295230203712:22:0)
[01:55:09.994] Timer tick, asking Buildbucket for the build status
[01:55:10.489] Build 8865689232389625056: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:55:10.489] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031119295230203712:23:0) after 1m0s
[01:56:10.552] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031119295230203712:23:0)
[01:56:10.552] Timer tick, asking Buildbucket for the build status
[01:56:10.618] Build 8865689232389625056: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:56:10.618] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031119295230203712:24:0) after 1m0s
[01:57:10.632] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031119295230203712:24:0)
[01:57:10.632] Timer tick, asking Buildbucket for the build status
[01:57:10.713] Build 8865689232389625056: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:57:10.713] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031119295230203712:25:0) after 1m0s
[01:58:10.842] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031119295230203712:25:0)
[01:58:10.842] Timer tick, asking Buildbucket for the build status
[01:58:10.910] Build 8865689232389625056: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:58:10.910] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031119295230203712:26:0) after 1m0s
[01:59:10.940] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031119295230203712:26:0)
[01:59:10.940] Timer tick, asking Buildbucket for the build status
[01:59:13.144] Build 8865689232389625056: status "STARTED", result "", failure_reason "", cancelation_reason ""
[01:59:13.144] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031119295230203712:27:0) after 1m0s
[02:00:13.170] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031119295230203712:27:0)
[02:00:13.170] Timer tick, asking Buildbucket for the build status
[02:00:13.303] Build 8865689232389625056: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:00:13.303] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031119295230203712:28:0) after 1m0s
[02:01:13.351] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031119295230203712:28:0)
[02:01:13.351] Timer tick, asking Buildbucket for the build status
[02:01:13.416] Build 8865689232389625056: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:01:13.416] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031119295230203712:29:0) after 1m0s
[02:02:13.417] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031119295230203712:29:0)
[02:02:13.417] Timer tick, asking Buildbucket for the build status
[02:02:13.479] Build 8865689232389625056: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:02:13.479] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031119295230203712:30:0) after 1m0s
[02:03:13.548] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031119295230203712:30:0)
[02:03:13.548] Timer tick, asking Buildbucket for the build status
[02:03:13.626] Build 8865689232389625056: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:03:13.626] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031119295230203712:31:0) after 1m0s
[02:04:13.694] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031119295230203712:31:0)
[02:04:13.694] Timer tick, asking Buildbucket for the build status
[02:04:13.892] Build 8865689232389625056: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:04:13.892] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031119295230203712:32:0) after 1m0s
[02:05:13.933] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031119295230203712:32:0)
[02:05:13.933] Timer tick, asking Buildbucket for the build status
[02:05:15.144] Build 8865689232389625056: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:05:15.144] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031119295230203712:33:0) after 1m0s
[02:06:15.252] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031119295230203712:33:0)
[02:06:15.252] Timer tick, asking Buildbucket for the build status
[02:06:15.454] Build 8865689232389625056: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:06:15.454] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031119295230203712:34:0) after 1m0s
[02:07:15.527] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031119295230203712:34:0)
[02:07:15.527] Timer tick, asking Buildbucket for the build status
[02:07:15.645] Build 8865689232389625056: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:07:15.645] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031119295230203712:35:0) after 1m0s
[02:08:15.701] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031119295230203712:35:0)
[02:08:15.701] Timer tick, asking Buildbucket for the build status
[02:08:15.808] Build 8865689232389625056: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:08:15.808] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031119295230203712:36:0) after 1m0s
[02:09:15.905] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031119295230203712:36:0)
[02:09:15.905] Timer tick, asking Buildbucket for the build status
[02:09:15.995] Build 8865689232389625056: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:09:15.995] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031119295230203712:37:0) after 1m0s
[02:10:16.029] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031119295230203712:37:0)
[02:10:16.029] Timer tick, asking Buildbucket for the build status
[02:10:16.151] Build 8865689232389625056: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:10:16.151] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031119295230203712:38:0) after 1m0s
[02:11:16.338] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031119295230203712:38:0)
[02:11:16.338] Timer tick, asking Buildbucket for the build status
[02:11:16.428] Build 8865689232389625056: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:11:16.428] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031119295230203712:39:0) after 1m0s
[02:12:16.458] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031119295230203712:39:0)
[02:12:16.458] Timer tick, asking Buildbucket for the build status
[02:12:16.535] Build 8865689232389625056: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:12:16.535] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031119295230203712:40:0) after 1m0s
[02:13:16.558] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031119295230203712:40:0)
[02:13:16.558] Timer tick, asking Buildbucket for the build status
[02:13:16.621] Build 8865689232389625056: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:13:16.621] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031119295230203712:41:0) after 1m0s
[02:14:16.607] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031119295230203712:41:0)
[02:14:16.607] Timer tick, asking Buildbucket for the build status
[02:14:16.671] Build 8865689232389625056: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:14:16.671] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031119295230203712:42:0) after 1m0s
[02:15:16.737] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031119295230203712:42:0)
[02:15:16.737] Timer tick, asking Buildbucket for the build status
[02:15:16.848] Build 8865689232389625056: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:15:16.848] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031119295230203712:43:0) after 1m0s
[02:16:16.840] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031119295230203712:43:0)
[02:16:16.840] Timer tick, asking Buildbucket for the build status
[02:16:17.118] Build 8865689232389625056: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:16:17.118] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031119295230203712:44:0) after 1m0s
[02:17:17.158] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031119295230203712:44:0)
[02:17:17.158] Timer tick, asking Buildbucket for the build status
[02:17:17.471] Build 8865689232389625056: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:17:17.471] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031119295230203712:45:0) after 1m0s
[02:18:17.658] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031119295230203712:45:0)
[02:18:17.658] Timer tick, asking Buildbucket for the build status
[02:18:17.763] Build 8865689232389625056: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:18:17.763] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031119295230203712:46:0) after 1m0s
[02:19:17.818] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031119295230203712:46:0)
[02:19:17.818] Timer tick, asking Buildbucket for the build status
[02:19:17.935] Build 8865689232389625056: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:19:17.935] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031119295230203712:47:0) after 1m0s
[02:20:17.977] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031119295230203712:47:0)
[02:20:17.977] Timer tick, asking Buildbucket for the build status
[02:20:18.182] Build 8865689232389625056: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:20:18.182] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031119295230203712:48:0) after 1m0s
[02:21:18.219] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031119295230203712:48:0)
[02:21:18.219] Timer tick, asking Buildbucket for the build status
[02:21:18.337] Build 8865689232389625056: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:21:18.337] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031119295230203712:49:0) after 1m0s
[02:22:18.365] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031119295230203712:49:0)
[02:22:18.365] Timer tick, asking Buildbucket for the build status
[02:22:18.468] Build 8865689232389625056: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:22:18.468] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031119295230203712:50:0) after 1m0s
[02:23:18.496] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031119295230203712:50:0)
[02:23:18.496] Timer tick, asking Buildbucket for the build status
[02:23:18.758] Build 8865689232389625056: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:23:18.758] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031119295230203712:51:0) after 1m0s
[02:24:18.792] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031119295230203712:51:0)
[02:24:18.792] Timer tick, asking Buildbucket for the build status
[02:24:18.922] Build 8865689232389625056: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:24:18.922] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031119295230203712:52:0) after 1m0s
[02:25:18.934] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031119295230203712:52:0)
[02:25:18.934] Timer tick, asking Buildbucket for the build status
[02:25:19.078] Build 8865689232389625056: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:25:19.078] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031119295230203712:53:0) after 1m0s
[02:26:19.122] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031119295230203712:53:0)
[02:26:19.122] Timer tick, asking Buildbucket for the build status
[02:26:19.233] Build 8865689232389625056: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:26:19.233] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031119295230203712:54:0) after 1m0s
[02:27:19.264] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031119295230203712:54:0)
[02:27:19.264] Timer tick, asking Buildbucket for the build status
[02:27:19.638] Build 8865689232389625056: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:27:19.638] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031119295230203712:55:0) after 1m0s
[02:28:19.686] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031119295230203712:55:0)
[02:28:19.686] Timer tick, asking Buildbucket for the build status
[02:28:20.371] Build 8865689232389625056: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:28:20.371] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031119295230203712:56:0) after 1m0s
[02:29:20.395] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031119295230203712:56:0)
[02:29:20.395] Timer tick, asking Buildbucket for the build status
[02:29:20.871] Build 8865689232389625056: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:29:20.871] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031119295230203712:57:0) after 1m0s
[02:30:20.983] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031119295230203712:57:0)
[02:30:20.983] Timer tick, asking Buildbucket for the build status
[02:30:21.103] Build 8865689232389625056: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:30:21.103] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031119295230203712:58:0) after 1m0s
[02:31:21.147] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031119295230203712:58:0)
[02:31:21.147] Timer tick, asking Buildbucket for the build status
[02:31:21.453] Build 8865689232389625056: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:31:21.453] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031119295230203712:59:0) after 1m0s
[02:32:21.479] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031119295230203712:59:0)
[02:32:21.479] Timer tick, asking Buildbucket for the build status
[02:32:21.547] Build 8865689232389625056: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:32:21.547] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031119295230203712:60:0) after 1m0s
[02:33:21.576] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031119295230203712:60:0)
[02:33:21.576] Timer tick, asking Buildbucket for the build status
[02:33:21.654] Build 8865689232389625056: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:33:21.654] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031119295230203712:61:0) after 1m0s
[02:34:21.682] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031119295230203712:61:0)
[02:34:21.682] Timer tick, asking Buildbucket for the build status
[02:34:21.803] Build 8865689232389625056: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:34:21.803] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031119295230203712:62:0) after 1m0s
[02:35:21.836] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031119295230203712:62:0)
[02:35:21.836] Timer tick, asking Buildbucket for the build status
[02:35:22.116] Build 8865689232389625056: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:35:22.116] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031119295230203712:63:0) after 1m0s
[02:36:22.101] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031119295230203712:63:0)
[02:36:22.101] Timer tick, asking Buildbucket for the build status
[02:36:22.198] Build 8865689232389625056: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:36:22.198] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031119295230203712:64:0) after 1m0s
[02:37:22.224] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031119295230203712:64:0)
[02:37:22.224] Timer tick, asking Buildbucket for the build status
[02:37:22.322] Build 8865689232389625056: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:37:22.322] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031119295230203712:65:0) after 1m0s
[02:38:22.351] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031119295230203712:65:0)
[02:38:22.351] Timer tick, asking Buildbucket for the build status
[02:38:22.451] Build 8865689232389625056: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:38:22.451] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031119295230203712:66:0) after 1m0s
[02:39:22.478] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031119295230203712:66:0)
[02:39:22.478] Timer tick, asking Buildbucket for the build status
[02:39:22.718] Build 8865689232389625056: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:39:22.718] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031119295230203712:67:0) after 1m0s
[02:40:22.795] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031119295230203712:67:0)
[02:40:22.795] Timer tick, asking Buildbucket for the build status
[02:40:22.917] Build 8865689232389625056: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:40:22.917] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031119295230203712:68:0) after 1m0s
[02:41:23.009] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031119295230203712:68:0)
[02:41:23.009] Timer tick, asking Buildbucket for the build status
[02:41:23.136] Build 8865689232389625056: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:41:23.136] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031119295230203712:69:0) after 1m0s
[02:42:23.237] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031119295230203712:69:0)
[02:42:23.237] Timer tick, asking Buildbucket for the build status
[02:42:23.362] Build 8865689232389625056: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:42:23.362] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031119295230203712:70:0) after 1m0s
[02:43:23.449] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031119295230203712:70:0)
[02:43:23.449] Timer tick, asking Buildbucket for the build status
[02:43:23.554] Build 8865689232389625056: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:43:23.554] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031119295230203712:71:0) after 1m0s
[02:44:23.667] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031119295230203712:71:0)
[02:44:23.667] Timer tick, asking Buildbucket for the build status
[02:44:23.742] Build 8865689232389625056: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:44:23.742] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031119295230203712:72:0) after 1m0s
[02:45:23.774] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031119295230203712:72:0)
[02:45:23.774] Timer tick, asking Buildbucket for the build status
[02:45:24.111] Build 8865689232389625056: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:45:24.111] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031119295230203712:73:0) after 1m0s
[02:46:24.340] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031119295230203712:73:0)
[02:46:24.340] Timer tick, asking Buildbucket for the build status
[02:46:24.586] Build 8865689232389625056: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:46:24.586] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031119295230203712:74:0) after 1m0s
[02:47:24.599] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031119295230203712:74:0)
[02:47:24.600] Timer tick, asking Buildbucket for the build status
[02:47:30.729] Build 8865689232389625056: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:47:30.729] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031119295230203712:75:0) after 1m0s
[02:48:31.014] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031119295230203712:75:0)
[02:48:31.014] Timer tick, asking Buildbucket for the build status
[02:48:31.088] Build 8865689232389625056: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:48:31.088] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031119295230203712:76:0) after 1m0s
[02:49:31.167] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031119295230203712:76:0)
[02:49:31.168] Timer tick, asking Buildbucket for the build status
[02:49:31.362] Build 8865689232389625056: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:49:31.362] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031119295230203712:77:0) after 1m0s
[02:50:31.422] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031119295230203712:77:0)
[02:50:31.422] Timer tick, asking Buildbucket for the build status
[02:50:31.545] Build 8865689232389625056: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:50:31.545] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031119295230203712:78:0) after 1m0s
[02:51:31.656] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031119295230203712:78:0)
[02:51:31.656] Timer tick, asking Buildbucket for the build status
[02:51:31.773] Build 8865689232389625056: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:51:31.773] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031119295230203712:79:0) after 1m0s
[02:52:31.847] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031119295230203712:79:0)
[02:52:31.847] Timer tick, asking Buildbucket for the build status
[02:52:31.981] Build 8865689232389625056: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:52:31.981] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031119295230203712:80:0) after 1m0s
[02:53:32.119] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031119295230203712:80:0)
[02:53:32.119] Timer tick, asking Buildbucket for the build status
[02:53:32.254] Build 8865689232389625056: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:53:32.254] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031119295230203712:81:0) after 1m0s
[02:54:32.403] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031119295230203712:81:0)
[02:54:32.403] Timer tick, asking Buildbucket for the build status
[02:54:32.530] Build 8865689232389625056: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:54:32.530] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031119295230203712:82:0) after 1m0s
[02:55:32.610] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031119295230203712:82:0)
[02:55:32.610] Timer tick, asking Buildbucket for the build status
[02:55:32.726] Build 8865689232389625056: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:55:32.726] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031119295230203712:83:0) after 1m0s
[02:56:32.791] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031119295230203712:83:0)
[02:56:32.791] Timer tick, asking Buildbucket for the build status
[02:56:32.857] Build 8865689232389625056: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:56:32.857] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031119295230203712:84:0) after 1m0s
[02:57:32.936] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031119295230203712:84:0)
[02:57:32.936] Timer tick, asking Buildbucket for the build status
[02:57:33.298] Build 8865689232389625056: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:57:33.298] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031119295230203712:85:0) after 1m0s
[02:58:33.382] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031119295230203712:85:0)
[02:58:33.382] Timer tick, asking Buildbucket for the build status
[02:58:33.461] Build 8865689232389625056: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:58:33.461] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031119295230203712:86:0) after 1m0s
[02:59:33.502] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031119295230203712:86:0)
[02:59:33.502] Timer tick, asking Buildbucket for the build status
[02:59:33.600] Build 8865689232389625056: status "STARTED", result "", failure_reason "", cancelation_reason ""
[02:59:33.600] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031119295230203712:87:0) after 1m0s
[03:00:33.703] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031119295230203712:87:0)
[03:00:33.703] Timer tick, asking Buildbucket for the build status
[03:00:33.855] Build 8865689232389625056: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:00:33.855] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031119295230203712:88:0) after 1m0s
[03:01:33.924] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031119295230203712:88:0)
[03:01:33.924] Timer tick, asking Buildbucket for the build status
[03:01:34.016] Build 8865689232389625056: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:01:34.017] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031119295230203712:89:0) after 1m0s
[03:02:34.027] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031119295230203712:89:0)
[03:02:34.027] Timer tick, asking Buildbucket for the build status
[03:02:34.148] Build 8865689232389625056: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:02:34.148] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031119295230203712:90:0) after 1m0s
[03:03:34.184] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031119295230203712:90:0)
[03:03:34.184] Timer tick, asking Buildbucket for the build status
[03:03:34.250] Build 8865689232389625056: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:03:34.250] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031119295230203712:91:0) after 1m0s
[03:04:34.310] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031119295230203712:91:0)
[03:04:34.310] Timer tick, asking Buildbucket for the build status
[03:04:34.390] Build 8865689232389625056: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:04:34.390] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031119295230203712:92:0) after 1m0s
[03:05:34.463] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031119295230203712:92:0)
[03:05:34.463] Timer tick, asking Buildbucket for the build status
[03:05:35.033] Build 8865689232389625056: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:05:35.033] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031119295230203712:93:0) after 1m0s
[03:06:35.110] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031119295230203712:93:0)
[03:06:35.110] Timer tick, asking Buildbucket for the build status
[03:06:35.397] Build 8865689232389625056: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:06:35.397] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031119295230203712:94:0) after 1m0s
[03:07:35.427] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031119295230203712:94:0)
[03:07:35.427] Timer tick, asking Buildbucket for the build status
[03:07:35.527] Build 8865689232389625056: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:07:35.527] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031119295230203712:95:0) after 1m0s
[03:08:35.590] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031119295230203712:95:0)
[03:08:35.590] Timer tick, asking Buildbucket for the build status
[03:08:35.703] Build 8865689232389625056: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:08:35.703] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031119295230203712:96:0) after 1m0s
[03:09:35.744] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031119295230203712:96:0)
[03:09:35.744] Timer tick, asking Buildbucket for the build status
[03:09:35.816] Build 8865689232389625056: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:09:35.816] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031119295230203712:97:0) after 1m0s
[03:10:35.907] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031119295230203712:97:0)
[03:10:35.907] Timer tick, asking Buildbucket for the build status
[03:10:36.532] Build 8865689232389625056: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:10:36.532] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031119295230203712:98:0) after 1m0s
[03:11:36.564] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031119295230203712:98:0)
[03:11:36.564] Timer tick, asking Buildbucket for the build status
[03:11:36.660] Build 8865689232389625056: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:11:36.660] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031119295230203712:99:0) after 1m0s
[03:12:36.693] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031119295230203712:99:0)
[03:12:36.693] Timer tick, asking Buildbucket for the build status
[03:12:36.821] Build 8865689232389625056: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:12:36.821] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031119295230203712:100:0) after 1m0s
[03:13:36.880] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031119295230203712:100:0)
[03:13:36.880] Timer tick, asking Buildbucket for the build status
[03:13:36.976] Build 8865689232389625056: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:13:36.976] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031119295230203712:101:0) after 1m0s
[03:14:37.056] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031119295230203712:101:0)
[03:14:37.056] Timer tick, asking Buildbucket for the build status
[03:14:37.233] Build 8865689232389625056: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:14:37.233] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031119295230203712:102:0) after 1m0s
[03:15:37.329] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031119295230203712:102:0)
[03:15:37.329] Timer tick, asking Buildbucket for the build status
[03:15:37.442] Build 8865689232389625056: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:15:37.442] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031119295230203712:103:0) after 1m0s
[03:16:37.471] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031119295230203712:103:0)
[03:16:37.471] Timer tick, asking Buildbucket for the build status
[03:16:37.618] Build 8865689232389625056: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:16:37.618] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031119295230203712:104:0) after 1m0s
[03:17:37.650] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031119295230203712:104:0)
[03:17:37.650] Timer tick, asking Buildbucket for the build status
[03:17:37.848] Build 8865689232389625056: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:17:37.848] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031119295230203712:105:0) after 1m0s
[03:18:37.880] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031119295230203712:105:0)
[03:18:37.880] Timer tick, asking Buildbucket for the build status
[03:18:38.035] Build 8865689232389625056: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:18:38.035] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031119295230203712:106:0) after 1m0s
[03:19:38.026] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031119295230203712:106:0)
[03:19:38.026] Timer tick, asking Buildbucket for the build status
[03:19:38.120] Build 8865689232389625056: status "STARTED", result "", failure_reason "", cancelation_reason ""
[03:19:38.120] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9031119295230203712:107:0) after 1m0s
[03:19:59.756] Received PubSub notification, asking Buildbucket for the build status
[03:19:59.835] Build 8865689232389625056: status "COMPLETED", result "SUCCESS", failure_reason "", cancelation_reason ""
[03:19:59.835] Buildbucket build:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "PROD",
"completed_ts": "1603423198894068",
"created_by": "project:chromium",
"created_ts": "1603416904038187",
"id": "8865689232389625056",
"parameters_json": "{\"builder_name\": \"linux-chromeos-dbg\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"2333fd21068bca383d72754e00cce67bb15be3c8\"}}",
"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\": \"2333fd21068bca383d72754e00cce67bb15be3c8\", \"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-9-csso\", \"branch\": \"refs/heads/master\", \"builder_group\": \"chromium.chromiumos\", \"buildername\": \"linux-chromeos-dbg\", \"buildnumber\": 20971, \"got_angle_revision\": \"5641e3c185a85c04f40441698d693773b1e9e808\", \"got_dawn_revision\": \"2ce1d927e98a654bb9b7137a07a7ccf5dbb5f4df\", \"got_nacl_revision\": \"0fabd6dc4222dfae664e55a84326e0c904f5b62c\", \"got_revision\": \"2333fd21068bca383d72754e00cce67bb15be3c8\", \"got_revision_cp\": \"refs/heads/master@{#820090}\", \"got_swarming_client_revision\": \"d46ea7635f2911208268170512cb611412488fd8\", \"got_swiftshader_revision\": \"df17a76102dfabb3f1bd6e51449cece9f77b45e3\", \"got_v8_revision\": \"d9ccb94fc2738d2c7bec626c287518c5e3ad14e9\", \"got_v8_revision_cp\": \"refs/heads/8.8.149@{#1}\", \"got_webrtc_revision\": \"7bc3356fbcb9b95ea2c810ae2f3152930d54577b\", \"got_webrtc_revision_cp\": \"refs/heads/master@{#32449}\", \"isolate_server\": \"https://isolateserver.appspot.com\", \"path_config\": \"generic\", \"recipe\": \"chromium\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"2333fd21068bca383d72754e00cce67bb15be3c8\", \"swarm_hashes_refs/heads/master(at){#820090}_without_patch\": {\"absl_hardening_tests\": \"f66b1ef68f129fc632878f79227a983d086c0e39\", \"accessibility_unittests\": \"b663028236031f5ec55c3b5968047ceae3932e08\", \"app_list_unittests\": \"2576d1475ddde33231b3d27acb5fc349a8dbc639\", \"app_shell_unittests\": \"7e682e427902a95381d5b60c975fdc8e881589d9\", \"ash_unittests\": \"6500261e1c94ecd95fb3bff0a3e2170ec0f444e0\", \"aura_unittests\": \"d42d43b6f58919f0f3b10e7dbf7158d7e512ae78\", \"base_unittests\": \"2e3385a38000e79de789713f3eec5366b2e512c6\", \"base_util_unittests\": \"743f443156f03aad63d784d91807948955201165\", \"blink_common_unittests\": \"b1c7894246cd0e6692f50214257fbdc80fc64cb1\", \"blink_fuzzer_unittests\": \"53b466e74d5442d2bfc9be3f3e135eff83d42b7f\", \"blink_heap_unittests\": \"7436308fc121c1c66bcf0eb808f0ba7cfeaad21b\", \"blink_platform_unittests\": \"47164385fe577683b6f028d28a1eadca2f8d05ce\", \"blink_unittests\": \"d2e45c281e2b5ea5ace5d3e39abb8ca906fb317e\", \"boringssl_crypto_tests\": \"0a54058dfc8efc251c619ace327fec14713e7f7e\", \"boringssl_ssl_tests\": \"4920012c2cfbed540563e32d6ec033d8ce520e2e\", \"browser_tests\": \"8c8644d301fceda2ea58df6521c74ffd6760ab3b\", \"capture_unittests\": \"8984db0b5cf195345021383356050f76f9f5490f\", \"cast_unittests\": \"b2957bb02830f0f0b6b5345f2927ced172287e56\", \"cc_unittests\": \"eceac99e5956aaba35afeb147dc29268bbce66cf\", \"chrome_app_unittests\": \"cc845329d45b3cd6b6d5d2f0419640edd68bd116\", \"chromedriver_unittests\": \"fde4df4c57cedf86f49e49167398736729884585\", \"chromeos_components_unittests\": \"28b8120e05d7c0f26e05e70da7dde3d7cdd80fb9\", \"chromeos_unittests\": \"222fbdf37a3bc172b3c1cc087277e7dcdf616e70\", \"components_browsertests\": \"92e9d7a2e4daa0ee8f755a906dec4e0104f4d1dd\", \"components_unittests\": \"202fafafd907deadca20d32f750469cce29d1b6c\", \"compositor_unittests\": \"59b7d037a26423aef20355cbd65918aeeb6218bf\", \"content_browsertests\": \"f175982cf397510e6b65a68b158350b4892310d6\", \"content_unittests\": \"047205ad1c81fd428021085dfddf447063403f22\", \"crypto_unittests\": \"592e77ee007b22ee0c2414a7f6ea3354b43fa121\", \"dbus_unittests\": \"1febe7b687af4b46b2ccd768486cc4c78cc54e92\", \"device_unittests\": \"614ba997328232fc675006d0d69e27b961c60fcd\", \"display_unittests\": \"7e4564bf55399a3acccc28466c6d5c47065eebec\", \"events_unittests\": \"18155a05fe892478f9101dc4a2e16972f4c7a021\", \"exo_unittests\": \"a1559bef2e36fca8e5f742555f0ea586a43a1114\", \"extensions_browsertests\": \"b89752aa828da43476c0c4635c06db5ec085dc2a\", \"extensions_unittests\": \"ed298bd2deca773aac13e9f442a8bd07db4d4fd5\", \"filesystem_service_unittests\": \"dc5e552b83153cd72c9537b63d4eb9c7e186f3b4\", \"gcm_unit_tests\": \"b456069340f2094ce788faecfc2f28a4dd2cb0ff\", \"gfx_unittests\": \"010b1a9f0952d9a562280874ac2fbb5f53e4fdd5\", \"gin_unittests\": \"a0509878273100aa27b6ce93d9652b942da37dc2\", \"gl_unittests_ozone\": \"c4721c6f4cef124dc551fbe48b671949e82a04b6\", \"google_apis_unittests\": \"4357b09b80af53cdb0bdc006c75fafea47d1b5d8\", \"gpu_unittests\": \"dbfaa09607862b15069ce334f92438fb164e20a8\", \"gwp_asan_unittests\": \"573d3cd554a41a36152a33cf5211b316a264c2de\", \"interactive_ui_tests\": \"34a29a4839b82ee4ac7ad566a09beac529912947\", \"ipc_tests\": \"01c42d1cb79ef7a7f03418dce92c06c41e16b382\", \"jingle_unittests\": \"83e6243be5a295be755445ecc9c25816e8623a06\", \"keyboard_unittests\": \"cbcfc4374df3733481df4c8bf25a069535aed9ef\", \"latency_unittests\": \"ae5e3578a727ccccd32aa7265326a8a3bcbd3e93\", \"libjingle_xmpp_unittests\": \"86d4102474302d7cdce91134192e06c89a049eba\", \"media_blink_unittests\": \"0ed177c0927846c4bebf51a55f4b8de8a10d4f2c\", \"media_unittests\": \"5b3a27172e6e011ace9d75fad496ceacc9eb2bcc\", \"message_center_unittests\": \"73cfeb384c03b3e02173f210b6c56971c284a498\", \"midi_unittests\": \"b6457c8b10e3005abe53bf64f0f4faf87f2b4c7d\", \"mojo_core_unittests\": \"ea946abd49798515b4a34d37fed29217b7228136\", \"mojo_unittests\": \"dbe9f09f84f2bf2ab0e0365830f9d1f66a994855\", \"nacl_helper_nonsfi_unittests\": \"56d8af40a5b86171f81a2168245e80441f2116e8\", \"nacl_loader_unittests\": \"92cbf3b000f8e336808da1dc4f9316ceb5a5f9ad\", \"native_theme_unittests\": \"4ffc8aae665984577919356f082303b5fa10992a\", \"net_unittests\": \"8b75d302b87da461b267d30ff4cec60b504b5c86\", \"ozone_gl_unittests\": \"7a520e423df96559f14c1f531ee01e0a814e312e\", \"ozone_unittests\": \"de35252d1d1a4b1e43e952d4a9c00a492cd8101c\", \"ozone_x11_unittests\": \"80fb9b5077c08785e5b2827d7150576e7567b904\", \"pdf_unittests\": \"061627b6c953120cdc3d30ac410e490e3efc5c47\", \"perfetto_unittests\": \"e0d1253ce667db07ce9e38cf1d2bf14355eb87d1\", \"ppapi_unittests\": \"cc4a34c19ca9d1d3562dbd8bff2ecfa0d091213a\", \"printing_unittests\": \"5ffc2b5b4b65bdd3d9e896d5ebd7196a98513013\", \"remoting_unittests\": \"5550b0301b5af8a4ecf8d1a5b1c57e47528cb887\", \"sandbox_linux_unittests\": \"375fd736a1f277ac62ecd2354d4fcecf2f366f51\", \"service_manager_unittests\": \"2f5ab1c78aa40a70210e73fd750d4b931d57d1af\", \"services_unittests\": \"136e193d13af3e5f1d7d290d9969ebea4473d5d7\", \"shell_dialogs_unittests\": \"8186ce5a1b096481c8abf26d6d181d437dab0d31\", \"skia_unittests\": \"a25e20c18ee76e522b099f236854ce3caa0881a5\", \"snapshot_unittests\": \"95328631bda1872e1eeea0a6e13701891640ab86\", \"sql_unittests\": \"4ed991040cb8331f141eacd4937e43aa6ab54b04\", \"standalone_angle_unittests\": \"5a7de1424068b5971721e0760c3c549778e651f8\", \"storage_unittests\": \"185d18ad57571a5680cecfc95cc8b5a31a92a52f\", \"sync_integration_tests\": \"474677e53b708e67f041ec4ed29c68a2fbb148bb\", \"traffic_annotation_auditor_unittests\": \"82e48e8f0cf3843e239792b048b1ef6476abf1d3\", \"ui_base_unittests\": \"da9a2976446617faf9fad7f992fee5a9dfaef669\", \"ui_chromeos_unittests\": \"08da8086068849a623d12355d62bb92c8878055b\", \"ui_touch_selection_unittests\": \"e3bcf41899589f5721e233a44db03beccf657f20\", \"unit_tests\": \"af011005ca6a99130252d6ebf6e4cc720b16d8ed\", \"url_unittests\": \"eed219cad8e5db97b5fbc2e49d65475750ab20b1\", \"usage_time_limit_unittests\": \"9eb7e5d5955a569b46c7af92f666388b51aa6f6a\", \"views_unittests\": \"0544bc87d6afb829bbb4992e0398f94f47f0dbf1\", \"viz_unittests\": \"4bf7e7145b0b407d7813ef2529703ec1557fd5f6\", \"wm_unittests\": \"bd3576e027793fcb836dd1fc7d5b6b357a7053fa\", \"wtf_unittests\": \"0527531777010b8b420606aa252d9a19b4f59b66\", \"zlib_unittests\": \"d7a6b24614a1beaf32f5f9995806169a5eb6cf44\"}}, \"swarming\": {\"bot_dimensions\": {\"builderless\": [\"1\"], \"caches\": [\"builder_4973d939604d11dcbaec68575e69c80c756ff63e355ab013b29b8bca26434b7c_v2\", \"builder_a1b9c6892397d61c3624774723419f5ae48fcf776e7d2304bd4682bf5cd4c049_v2\", \"builder_dacf669b49e3ec352df995227b58e62a545590985cca62e76e0831f920af4ccd_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-9-csso\"], \"image\": [\"chrome-xenial-20101800-2d400e1627f\"], \"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\": [\"5612-26d29a7\"], \"ssd\": [\"0\"], \"zone\": [\"us\", \"us-central\", \"us-central1\", \"us-central1-b\"]}}}",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"started_ts": "1603417012028907",
"status": "COMPLETED",
"status_changed_ts": "1603423199217074",
"tags": [
"build_address:luci.chromium.ci/linux-chromeos-dbg/20971",
"builder:linux-chromeos-dbg",
"buildset:commit/git/2333fd21068bca383d72754e00cce67bb15be3c8",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/2333fd21068bca383d72754e00cce67bb15be3c8",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9031119295230203712",
"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/8865689232389625056/+/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:4f6be9de8d322b10",
"user_agent:luci-scheduler"
],
"updated_ts": "1603423199224106",
"url": "https://ci.chromium.org/b/8865689232389625056",
"utcnow_ts": "1603423199826452"
}
}
[03:19:59.835] Invocation finished in 1h44m57.888865042s with status SUCCEEDED