[22:42:04.430] New invocation is queued and will start shortly
[22:42:05.530] Starting the invocation (attempt 1)
[22:42:05.600] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[22:42:05.600] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[22:42:05.600] Buildbucket request:
{
"bucket": "luci.chromium.ci",
"client_operation_id": "9021617495388723648",
"parameters_json": "{\"builder_name\":\"linux-chromeos-dbg\",\"properties\":{\"branch\":\"refs/heads/master\",\"repository\":\"https://chromium.googlesource.com/chromium/src\",\"revision\":\"da796eeba23e5e49c625de916386fcbfa2d721ff\"}}",
"pubsub_callback": {
"auth_token": "...",
"topic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
},
"tags": [
"builder:linux-chromeos-dbg",
"scheduler_invocation_id:9021617495388723648",
"scheduler_job_id:chromium/linux-chromeos-dbg",
"user_agent:luci-scheduler",
"buildset:commit/git/da796eeba23e5e49c625de916386fcbfa2d721ff",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/da796eeba23e5e49c625de916386fcbfa2d721ff",
"gitiles_ref:refs/heads/master"
]
}
[22:42:06.273] Buildbucket response:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "PROD",
"created_by": "project:chromium",
"created_ts": "1612478525691142",
"id": "8856187433403223232",
"parameters_json": "{\"builder_name\": \"linux-chromeos-dbg\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"da796eeba23e5e49c625de916386fcbfa2d721ff\"}}",
"project": "chromium",
"result_details_json": "{\"properties\": {}}",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"status": "SCHEDULED",
"status_changed_ts": "1612478526144658",
"tags": [
"build_address:luci.chromium.ci/linux-chromeos-dbg/22483",
"builder:linux-chromeos-dbg",
"buildset:commit/git/da796eeba23e5e49c625de916386fcbfa2d721ff",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/da796eeba23e5e49c625de916386fcbfa2d721ff",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9021617495388723648",
"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/8856187433403223232/+/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": "1612478526144763",
"url": "https://ci.chromium.org/b/8856187433403223232",
"utcnow_ts": "1612478526264441"
}
}
[22:42:06.273] Task URL: https://ci.chromium.org/b/8856187433403223232
[22:42:06.273] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9021617495388723648:2:0) after 1m0s
[22:42:10.390] Received PubSub notification, asking Buildbucket for the build status
[22:42:10.487] Build 8856187433403223232: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:43:06.306] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9021617495388723648:2:0)
[22:43:06.306] Timer tick, asking Buildbucket for the build status
[22:43:06.418] Build 8856187433403223232: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:43:06.418] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9021617495388723648:4:0) after 1m0s
[22:44:06.529] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9021617495388723648:4:0)
[22:44:06.529] Timer tick, asking Buildbucket for the build status
[22:44:06.992] Build 8856187433403223232: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:44:06.992] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9021617495388723648:5:0) after 1m0s
[22:45:07.112] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9021617495388723648:5:0)
[22:45:07.112] Timer tick, asking Buildbucket for the build status
[22:45:07.222] Build 8856187433403223232: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:45:07.222] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9021617495388723648:6:0) after 1m0s
[22:46:07.366] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9021617495388723648:6:0)
[22:46:07.366] Timer tick, asking Buildbucket for the build status
[22:46:07.720] Build 8856187433403223232: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:46:07.720] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9021617495388723648:7:0) after 1m0s
[22:47:07.801] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9021617495388723648:7:0)
[22:47:07.801] Timer tick, asking Buildbucket for the build status
[22:47:07.985] Build 8856187433403223232: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:47:07.986] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9021617495388723648:8:0) after 1m0s
[22:48:08.036] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9021617495388723648:8:0)
[22:48:08.036] Timer tick, asking Buildbucket for the build status
[22:48:08.255] Build 8856187433403223232: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:48:08.255] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9021617495388723648:9:0) after 1m0s
[22:49:08.529] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9021617495388723648:9:0)
[22:49:08.529] Timer tick, asking Buildbucket for the build status
[22:49:08.587] Build 8856187433403223232: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:49:08.587] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9021617495388723648:10:0) after 1m0s
[22:50:08.589] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9021617495388723648:10:0)
[22:50:08.589] Timer tick, asking Buildbucket for the build status
[22:50:08.757] Build 8856187433403223232: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:50:08.757] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9021617495388723648:11:0) after 1m0s
[22:51:08.854] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9021617495388723648:11:0)
[22:51:08.854] Timer tick, asking Buildbucket for the build status
[22:51:09.023] Build 8856187433403223232: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:51:09.023] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9021617495388723648:12:0) after 1m0s
[22:52:09.092] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9021617495388723648:12:0)
[22:52:09.092] Timer tick, asking Buildbucket for the build status
[22:52:09.715] Build 8856187433403223232: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:52:09.715] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9021617495388723648:13:0) after 1m0s
[22:53:09.926] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9021617495388723648:13:0)
[22:53:09.926] Timer tick, asking Buildbucket for the build status
[22:53:09.974] Build 8856187433403223232: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:53:09.974] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9021617495388723648:14:0) after 1m0s
[22:54:10.308] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9021617495388723648:14:0)
[22:54:10.308] Timer tick, asking Buildbucket for the build status
[22:54:10.386] Build 8856187433403223232: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:54:10.386] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9021617495388723648:15:0) after 1m0s
[22:55:10.645] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9021617495388723648:15:0)
[22:55:10.645] Timer tick, asking Buildbucket for the build status
[22:55:10.708] Build 8856187433403223232: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:55:10.708] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9021617495388723648:16:0) after 1m0s
[22:56:11.332] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9021617495388723648:16:0)
[22:56:11.332] Timer tick, asking Buildbucket for the build status
[22:56:11.402] Build 8856187433403223232: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:56:11.402] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9021617495388723648:17:0) after 1m0s
[22:57:11.433] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9021617495388723648:17:0)
[22:57:11.433] Timer tick, asking Buildbucket for the build status
[22:57:11.566] Build 8856187433403223232: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:57:11.566] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9021617495388723648:18:0) after 1m0s
[22:58:11.637] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9021617495388723648:18:0)
[22:58:11.637] Timer tick, asking Buildbucket for the build status
[22:58:11.731] Build 8856187433403223232: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:58:11.731] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9021617495388723648:19:0) after 1m0s
[22:59:11.992] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9021617495388723648:19:0)
[22:59:11.992] Timer tick, asking Buildbucket for the build status
[22:59:12.069] Build 8856187433403223232: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:59:12.069] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9021617495388723648:20:0) after 1m0s
[23:00:12.294] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9021617495388723648:20:0)
[23:00:12.294] Timer tick, asking Buildbucket for the build status
[23:00:12.387] Build 8856187433403223232: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:00:12.387] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9021617495388723648:21:0) after 1m0s
[23:01:12.461] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9021617495388723648:21:0)
[23:01:12.461] Timer tick, asking Buildbucket for the build status
[23:01:12.577] Build 8856187433403223232: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:01:12.577] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9021617495388723648:22:0) after 1m0s
[23:02:12.732] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9021617495388723648:22:0)
[23:02:12.732] Timer tick, asking Buildbucket for the build status
[23:02:13.271] Build 8856187433403223232: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:02:13.271] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9021617495388723648:23:0) after 1m0s
[23:03:13.361] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9021617495388723648:23:0)
[23:03:13.361] Timer tick, asking Buildbucket for the build status
[23:03:13.519] Build 8856187433403223232: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:03:13.519] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9021617495388723648:24:0) after 1m0s
[23:04:13.650] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9021617495388723648:24:0)
[23:04:13.650] Timer tick, asking Buildbucket for the build status
[23:04:13.755] Build 8856187433403223232: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:04:13.755] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9021617495388723648:25:0) after 1m0s
[23:05:13.747] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9021617495388723648:25:0)
[23:05:13.747] Timer tick, asking Buildbucket for the build status
[23:05:13.811] Build 8856187433403223232: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:05:13.811] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9021617495388723648:26:0) after 1m0s
[23:06:13.851] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9021617495388723648:26:0)
[23:06:13.851] Timer tick, asking Buildbucket for the build status
[23:06:13.950] Build 8856187433403223232: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:06:13.950] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9021617495388723648:27:0) after 1m0s
[23:07:14.030] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9021617495388723648:27:0)
[23:07:14.030] Timer tick, asking Buildbucket for the build status
[23:07:14.172] Build 8856187433403223232: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:07:14.172] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9021617495388723648:28:0) after 1m0s
[23:08:14.224] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9021617495388723648:28:0)
[23:08:14.224] Timer tick, asking Buildbucket for the build status
[23:08:14.354] Build 8856187433403223232: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:08:14.354] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9021617495388723648:29:0) after 1m0s
[23:09:14.447] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9021617495388723648:29:0)
[23:09:14.447] Timer tick, asking Buildbucket for the build status
[23:09:14.844] Build 8856187433403223232: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:09:14.844] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9021617495388723648:30:0) after 1m0s
[23:10:14.907] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9021617495388723648:30:0)
[23:10:14.907] Timer tick, asking Buildbucket for the build status
[23:10:15.044] Build 8856187433403223232: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:10:15.045] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9021617495388723648:31:0) after 1m0s
[23:11:15.070] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9021617495388723648:31:0)
[23:11:15.070] Timer tick, asking Buildbucket for the build status
[23:11:15.142] Build 8856187433403223232: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:11:15.142] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9021617495388723648:32:0) after 1m0s
[23:12:15.165] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9021617495388723648:32:0)
[23:12:15.165] Timer tick, asking Buildbucket for the build status
[23:12:16.422] Build 8856187433403223232: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:12:16.422] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9021617495388723648:33:0) after 1m0s
[23:13:16.497] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9021617495388723648:33:0)
[23:13:16.497] Timer tick, asking Buildbucket for the build status
[23:13:16.618] Build 8856187433403223232: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:13:16.618] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9021617495388723648:34:0) after 1m0s
[23:14:16.895] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9021617495388723648:34:0)
[23:14:16.895] Timer tick, asking Buildbucket for the build status
[23:14:17.043] Build 8856187433403223232: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:14:17.044] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9021617495388723648:35:0) after 1m0s
[23:15:17.124] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9021617495388723648:35:0)
[23:15:17.124] Timer tick, asking Buildbucket for the build status
[23:15:17.256] Build 8856187433403223232: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:15:17.256] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9021617495388723648:36:0) after 1m0s
[23:16:17.283] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9021617495388723648:36:0)
[23:16:17.283] Timer tick, asking Buildbucket for the build status
[23:16:17.410] Build 8856187433403223232: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:16:17.410] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9021617495388723648:37:0) after 1m0s
[23:17:17.448] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9021617495388723648:37:0)
[23:17:17.448] Timer tick, asking Buildbucket for the build status
[23:17:17.557] Build 8856187433403223232: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:17:17.557] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9021617495388723648:38:0) after 1m0s
[23:18:17.906] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9021617495388723648:38:0)
[23:18:17.906] Timer tick, asking Buildbucket for the build status
[23:18:18.032] Build 8856187433403223232: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:18:18.032] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9021617495388723648:39:0) after 1m0s
[23:19:18.197] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9021617495388723648:39:0)
[23:19:18.197] Timer tick, asking Buildbucket for the build status
[23:19:18.371] Build 8856187433403223232: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:19:18.371] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9021617495388723648:40:0) after 1m0s
[23:20:18.373] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9021617495388723648:40:0)
[23:20:18.373] Timer tick, asking Buildbucket for the build status
[23:20:18.994] Build 8856187433403223232: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:20:18.994] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9021617495388723648:41:0) after 1m0s
[23:21:19.109] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9021617495388723648:41:0)
[23:21:19.109] Timer tick, asking Buildbucket for the build status
[23:21:19.238] Build 8856187433403223232: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:21:19.238] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9021617495388723648:42:0) after 1m0s
[23:22:19.594] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9021617495388723648:42:0)
[23:22:19.594] Timer tick, asking Buildbucket for the build status
[23:22:20.102] Build 8856187433403223232: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:22:20.102] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9021617495388723648:43:0) after 1m0s
[23:23:20.195] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9021617495388723648:43:0)
[23:23:20.196] Timer tick, asking Buildbucket for the build status
[23:23:20.342] Build 8856187433403223232: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:23:20.342] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9021617495388723648:44:0) after 1m0s
[23:24:20.414] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9021617495388723648:44:0)
[23:24:20.414] Timer tick, asking Buildbucket for the build status
[23:24:20.518] Build 8856187433403223232: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:24:20.518] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9021617495388723648:45:0) after 1m0s
[23:25:20.633] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9021617495388723648:45:0)
[23:25:20.633] Timer tick, asking Buildbucket for the build status
[23:25:20.794] Build 8856187433403223232: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:25:20.794] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9021617495388723648:46:0) after 1m0s
[23:26:20.903] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9021617495388723648:46:0)
[23:26:20.903] Timer tick, asking Buildbucket for the build status
[23:26:21.013] Build 8856187433403223232: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:26:21.013] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9021617495388723648:47:0) after 1m0s
[23:27:21.094] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9021617495388723648:47:0)
[23:27:21.094] Timer tick, asking Buildbucket for the build status
[23:27:21.406] Build 8856187433403223232: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:27:21.406] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9021617495388723648:48:0) after 1m0s
[23:28:21.475] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9021617495388723648:48:0)
[23:28:21.475] Timer tick, asking Buildbucket for the build status
[23:28:21.605] Build 8856187433403223232: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:28:21.605] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9021617495388723648:49:0) after 1m0s
[23:29:21.644] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9021617495388723648:49:0)
[23:29:21.644] Timer tick, asking Buildbucket for the build status
[23:29:21.839] Build 8856187433403223232: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:29:21.839] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9021617495388723648:50:0) after 1m0s
[23:30:21.860] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9021617495388723648:50:0)
[23:30:21.860] Timer tick, asking Buildbucket for the build status
[23:30:21.939] Build 8856187433403223232: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:30:21.939] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9021617495388723648:51:0) after 1m0s
[23:31:21.993] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9021617495388723648:51:0)
[23:31:21.993] Timer tick, asking Buildbucket for the build status
[23:31:22.074] Build 8856187433403223232: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:31:22.074] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9021617495388723648:52:0) after 1m0s
[23:32:22.085] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9021617495388723648:52:0)
[23:32:22.085] Timer tick, asking Buildbucket for the build status
[23:32:22.463] Build 8856187433403223232: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:32:22.463] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9021617495388723648:53:0) after 1m0s
[23:33:22.485] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9021617495388723648:53:0)
[23:33:22.485] Timer tick, asking Buildbucket for the build status
[23:33:22.716] Build 8856187433403223232: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:33:22.717] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9021617495388723648:54:0) after 1m0s
[23:34:22.769] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9021617495388723648:54:0)
[23:34:22.769] Timer tick, asking Buildbucket for the build status
[23:34:23.298] Build 8856187433403223232: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:34:23.298] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9021617495388723648:55:0) after 1m0s
[23:35:23.389] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9021617495388723648:55:0)
[23:35:23.389] Timer tick, asking Buildbucket for the build status
[23:35:23.474] Build 8856187433403223232: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:35:23.474] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9021617495388723648:56:0) after 1m0s
[23:36:23.599] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9021617495388723648:56:0)
[23:36:23.599] Timer tick, asking Buildbucket for the build status
[23:36:23.822] Build 8856187433403223232: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:36:23.822] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9021617495388723648:57:0) after 1m0s
[23:37:23.891] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9021617495388723648:57:0)
[23:37:23.891] Timer tick, asking Buildbucket for the build status
[23:37:24.020] Build 8856187433403223232: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:37:24.020] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9021617495388723648:58:0) after 1m0s
[23:38:24.015] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9021617495388723648:58:0)
[23:38:24.015] Timer tick, asking Buildbucket for the build status
[23:38:24.195] Build 8856187433403223232: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:38:24.195] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9021617495388723648:59:0) after 1m0s
[23:39:24.314] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9021617495388723648:59:0)
[23:39:24.314] Timer tick, asking Buildbucket for the build status
[23:39:24.424] Build 8856187433403223232: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:39:24.424] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9021617495388723648:60:0) after 1m0s
[23:40:24.696] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9021617495388723648:60:0)
[23:40:24.696] Timer tick, asking Buildbucket for the build status
[23:40:25.735] Build 8856187433403223232: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:40:25.735] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9021617495388723648:61:0) after 1m0s
[23:41:25.724] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9021617495388723648:61:0)
[23:41:25.724] Timer tick, asking Buildbucket for the build status
[23:41:25.844] Build 8856187433403223232: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:41:25.844] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9021617495388723648:62:0) after 1m0s
[23:42:25.949] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9021617495388723648:62:0)
[23:42:25.949] Timer tick, asking Buildbucket for the build status
[23:42:26.085] Build 8856187433403223232: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:42:26.085] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9021617495388723648:63:0) after 1m0s
[23:43:26.160] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9021617495388723648:63:0)
[23:43:26.160] Timer tick, asking Buildbucket for the build status
[23:43:26.528] Build 8856187433403223232: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:43:26.528] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9021617495388723648:64:0) after 1m0s
[23:44:26.563] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9021617495388723648:64:0)
[23:44:26.563] Timer tick, asking Buildbucket for the build status
[23:44:26.646] Build 8856187433403223232: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:44:26.646] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9021617495388723648:65:0) after 1m0s
[23:45:26.720] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9021617495388723648:65:0)
[23:45:26.720] Timer tick, asking Buildbucket for the build status
[23:45:27.096] Build 8856187433403223232: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:45:27.096] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9021617495388723648:66:0) after 1m0s
[23:46:27.103] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9021617495388723648:66:0)
[23:46:27.103] Timer tick, asking Buildbucket for the build status
[23:46:27.181] Build 8856187433403223232: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:46:27.181] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9021617495388723648:67:0) after 1m0s
[23:47:27.257] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9021617495388723648:67:0)
[23:47:27.257] Timer tick, asking Buildbucket for the build status
[23:47:27.750] Build 8856187433403223232: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:47:27.750] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9021617495388723648:68:0) after 1m0s
[23:48:27.824] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9021617495388723648:68:0)
[23:48:27.824] Timer tick, asking Buildbucket for the build status
[23:48:28.311] Build 8856187433403223232: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:48:28.311] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9021617495388723648:69:0) after 1m0s
[23:49:28.959] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9021617495388723648:69:0)
[23:49:28.959] Timer tick, asking Buildbucket for the build status
[23:49:29.115] Build 8856187433403223232: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:49:29.115] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9021617495388723648:70:0) after 1m0s
[23:50:29.303] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9021617495388723648:70:0)
[23:50:29.303] Timer tick, asking Buildbucket for the build status
[23:50:29.409] Build 8856187433403223232: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:50:29.409] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9021617495388723648:71:0) after 1m0s
[23:51:29.708] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9021617495388723648:71:0)
[23:51:29.708] Timer tick, asking Buildbucket for the build status
[23:51:30.538] Build 8856187433403223232: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:51:30.538] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9021617495388723648:72:0) after 1m0s
[23:52:30.691] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9021617495388723648:72:0)
[23:52:30.691] Timer tick, asking Buildbucket for the build status
[23:52:30.843] Build 8856187433403223232: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:52:30.843] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9021617495388723648:73:0) after 1m0s
[23:53:31.056] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9021617495388723648:73:0)
[23:53:31.056] Timer tick, asking Buildbucket for the build status
[23:53:31.124] Build 8856187433403223232: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:53:31.124] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9021617495388723648:74:0) after 1m0s
[23:54:31.270] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9021617495388723648:74:0)
[23:54:31.270] Timer tick, asking Buildbucket for the build status
[23:54:31.390] Build 8856187433403223232: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:54:31.390] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9021617495388723648:75:0) after 1m0s
[23:55:31.611] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9021617495388723648:75:0)
[23:55:31.611] Timer tick, asking Buildbucket for the build status
[23:55:31.900] Build 8856187433403223232: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:55:31.900] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9021617495388723648:76:0) after 1m0s
[23:56:31.965] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9021617495388723648:76:0)
[23:56:31.965] Timer tick, asking Buildbucket for the build status
[23:56:32.523] Build 8856187433403223232: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:56:32.523] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9021617495388723648:77:0) after 1m0s
[23:57:32.543] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9021617495388723648:77:0)
[23:57:32.543] Timer tick, asking Buildbucket for the build status
[23:57:32.651] Build 8856187433403223232: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:57:32.651] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9021617495388723648:78:0) after 1m0s
[23:58:32.759] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9021617495388723648:78:0)
[23:58:32.759] Timer tick, asking Buildbucket for the build status
[23:58:32.857] Build 8856187433403223232: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:58:32.857] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9021617495388723648:79:0) after 1m0s
[23:59:32.897] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9021617495388723648:79:0)
[23:59:32.897] Timer tick, asking Buildbucket for the build status
[23:59:33.016] Build 8856187433403223232: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:59:33.016] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9021617495388723648:80:0) after 1m0s
[00:00:33.157] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9021617495388723648:80:0)
[00:00:33.157] Timer tick, asking Buildbucket for the build status
[00:00:33.271] Build 8856187433403223232: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:00:33.272] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9021617495388723648:81:0) after 1m0s
[00:01:33.518] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9021617495388723648:81:0)
[00:01:33.518] Timer tick, asking Buildbucket for the build status
[00:01:33.590] Build 8856187433403223232: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:01:33.590] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9021617495388723648:82:0) after 1m0s
[00:02:33.693] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9021617495388723648:82:0)
[00:02:33.693] Timer tick, asking Buildbucket for the build status
[00:02:33.848] Build 8856187433403223232: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:02:33.848] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9021617495388723648:83:0) after 1m0s
[00:03:34.043] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9021617495388723648:83:0)
[00:03:34.043] Timer tick, asking Buildbucket for the build status
[00:03:34.137] Build 8856187433403223232: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:03:34.137] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9021617495388723648:84:0) after 1m0s
[00:04:34.259] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9021617495388723648:84:0)
[00:04:34.259] Timer tick, asking Buildbucket for the build status
[00:04:34.354] Build 8856187433403223232: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:04:34.354] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9021617495388723648:85:0) after 1m0s
[00:05:34.391] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9021617495388723648:85:0)
[00:05:34.391] Timer tick, asking Buildbucket for the build status
[00:05:34.487] Build 8856187433403223232: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:05:34.487] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9021617495388723648:86:0) after 1m0s
[00:06:34.701] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9021617495388723648:86:0)
[00:06:34.701] Timer tick, asking Buildbucket for the build status
[00:06:34.923] Build 8856187433403223232: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:06:34.923] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9021617495388723648:87:0) after 1m0s
[00:07:35.121] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9021617495388723648:87:0)
[00:07:35.121] Timer tick, asking Buildbucket for the build status
[00:07:35.498] Build 8856187433403223232: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:07:35.498] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9021617495388723648:88:0) after 1m0s
[00:08:35.634] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9021617495388723648:88:0)
[00:08:35.634] Timer tick, asking Buildbucket for the build status
[00:08:35.793] Build 8856187433403223232: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:08:35.793] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9021617495388723648:89:0) after 1m0s
[00:09:35.896] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9021617495388723648:89:0)
[00:09:35.896] Timer tick, asking Buildbucket for the build status
[00:09:36.136] Build 8856187433403223232: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:09:36.136] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9021617495388723648:90:0) after 1m0s
[00:10:36.214] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9021617495388723648:90:0)
[00:10:36.214] Timer tick, asking Buildbucket for the build status
[00:10:36.297] Build 8856187433403223232: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:10:36.297] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9021617495388723648:91:0) after 1m0s
[00:11:36.402] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9021617495388723648:91:0)
[00:11:36.402] Timer tick, asking Buildbucket for the build status
[00:11:36.466] Build 8856187433403223232: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:11:36.466] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9021617495388723648:92:0) after 1m0s
[00:12:36.480] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9021617495388723648:92:0)
[00:12:36.480] Timer tick, asking Buildbucket for the build status
[00:12:36.848] Build 8856187433403223232: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:12:36.848] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9021617495388723648:93:0) after 1m0s
[00:13:36.924] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9021617495388723648:93:0)
[00:13:36.924] Timer tick, asking Buildbucket for the build status
[00:13:37.062] Build 8856187433403223232: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:13:37.062] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9021617495388723648:94:0) after 1m0s
[00:14:37.118] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9021617495388723648:94:0)
[00:14:37.118] Timer tick, asking Buildbucket for the build status
[00:14:37.705] Build 8856187433403223232: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:14:37.705] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9021617495388723648:95:0) after 1m0s
[00:15:37.764] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9021617495388723648:95:0)
[00:15:37.764] Timer tick, asking Buildbucket for the build status
[00:15:38.343] Build 8856187433403223232: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:15:38.343] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9021617495388723648:96:0) after 1m0s
[00:16:38.441] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9021617495388723648:96:0)
[00:16:38.441] Timer tick, asking Buildbucket for the build status
[00:16:38.539] Build 8856187433403223232: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:16:38.539] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9021617495388723648:97:0) after 1m0s
[00:17:38.619] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9021617495388723648:97:0)
[00:17:38.619] Timer tick, asking Buildbucket for the build status
[00:17:38.774] Build 8856187433403223232: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:17:38.774] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9021617495388723648:98:0) after 1m0s
[00:18:38.842] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9021617495388723648:98:0)
[00:18:38.842] Timer tick, asking Buildbucket for the build status
[00:18:38.911] Build 8856187433403223232: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:18:38.911] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9021617495388723648:99:0) after 1m0s
[00:19:05.678] Received PubSub notification, asking Buildbucket for the build status
[00:19:05.831] Build 8856187433403223232: status "COMPLETED", result "SUCCESS", failure_reason "", cancelation_reason ""
[00:19:05.831] Buildbucket build:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "PROD",
"completed_ts": "1612484344983614",
"created_by": "project:chromium",
"created_ts": "1612478525691142",
"id": "8856187433403223232",
"parameters_json": "{\"builder_name\": \"linux-chromeos-dbg\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"da796eeba23e5e49c625de916386fcbfa2d721ff\"}}",
"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\": \"da796eeba23e5e49c625de916386fcbfa2d721ff\", \"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-93-pui4\", \"branch\": \"refs/heads/master\", \"builder_group\": \"chromium.chromiumos\", \"buildername\": \"linux-chromeos-dbg\", \"buildnumber\": 22483, \"got_angle_revision\": \"ad985fcdd806a26343b9b5f8408e551b515493e5\", \"got_dawn_revision\": \"bdbf98afca9fba5ca863c2c963ab10edae45b1cc\", \"got_nacl_revision\": \"952e81813a66902714b68f34b51073c5d1ba6c94\", \"got_revision\": \"da796eeba23e5e49c625de916386fcbfa2d721ff\", \"got_revision_cp\": \"refs/heads/master@{#850823}\", \"got_swarming_client_revision\": \"a32a1607f6093d338f756c7e7c7b4333b0c50c9c\", \"got_swiftshader_revision\": \"14dcbed947ce755af1fcbfb3ba8e643b4e769860\", \"got_v8_revision\": \"a71154a1ede8ce4ce90eb23ede108aef7e94691d\", \"got_v8_revision_cp\": \"refs/heads/9.0.133@{#1}\", \"got_webrtc_revision\": \"1d71fd9c61db8f1dcf30b5d0625e514b91200926\", \"got_webrtc_revision_cp\": \"refs/heads/master@{#33155}\", \"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\": \"da796eeba23e5e49c625de916386fcbfa2d721ff\", \"swarm_hashes_refs/heads/master(at){#850823}_without_patch\": {\"absl_hardening_tests\": \"c793682954c56b64b8615a660da30ebbe98780c3\", \"accessibility_unittests\": \"6b60d14686f6253bdf89aaf114f83625684f90e3\", \"angle_unittests\": \"9d739f48b8a311fb0edc8d54a7dc216e96d501da\", \"app_list_unittests\": \"b1d0ff1bef39a4c1be85ccac22be843aaca6ac9c\", \"app_shell_unittests\": \"b5fe1583ac32e6feedbe7730ade6ec3a9a350dba\", \"ash_unittests\": \"caa78b8f3626342e15003e6b7bc35c8630337fc4\", \"aura_unittests\": \"4a9436f3fa4f97f5f0a3d4dbde208a9098a763bb\", \"base_unittests\": \"5995430b57951ad244b467d4c8d54f4274a27e2e\", \"base_util_unittests\": \"34f70b2725057b1954865698d9a3284b9995a9c7\", \"blink_common_unittests\": \"ed01300c197ff566744619b5a0f76b6ca32ce5ca\", \"blink_fuzzer_unittests\": \"002daac79edb4f6a34f4db039bb77d2db5329038\", \"blink_heap_unittests\": \"88329dcc1999c206ad96bf7cce24d12f1dac0b4d\", \"blink_platform_unittests\": \"e94c03b1aca127bc8a924af53c018310d51ab795\", \"blink_unittests\": \"56a7ae817db4f6f0b17c58bafb6913c743f655eb\", \"boringssl_crypto_tests\": \"e36ab1d6fc158402a9cf1a62e8f87d48ec6686bf\", \"boringssl_ssl_tests\": \"83c3ff2b0206bf0224c69025e75bf497cdd74416\", \"browser_tests\": \"5de6c9b4fe16252b2b329a8a59405264b098bf15\", \"capture_unittests\": \"bca404e7577ffc1cfc43cc72a6aec75cfb80cd1f\", \"cast_unittests\": \"9d3fc866f47b79a09e852f9d7a035fcc42a0d19a\", \"cc_unittests\": \"81f73fe5d7797d46955e932ec8cd0bfae1e8e607\", \"chrome_app_unittests\": \"0059bfa57dbe025ace2d75d2b3ddbd14291bb657\", \"chromedriver_unittests\": \"941b2bcc098f9bd28af6cca3d3617bda55ae5c34\", \"chromeos_components_unittests\": \"2421a56b3403698b4e743cf613b493509adaa7e1\", \"chromeos_unittests\": \"b4fe65c2fb3d71325ecffb737b0e8a89029c609a\", \"components_browsertests\": \"d4e3ef57488d262771c5c03bfcbbd95bc82ff60b\", \"components_unittests\": \"551aa4fb2802e9fc8bb7168a7556b37846ba038c\", \"compositor_unittests\": \"2ca135ec47852e07c8bb1658e942b6d66cc51ebe\", \"content_browsertests\": \"38ba68963009fed5554e7ecbb7ecde7aaa23cc1e\", \"content_unittests\": \"2b5ab0d77bc3279108e99f2fa4fec4fa710ddb48\", \"crashpad_tests\": \"775660dda87157f2deba0feb0e7f52f34e6d08c4\", \"crypto_unittests\": \"ba8c5e66c959a9c38b913bfd2bc602d3d32e0c34\", \"dbus_unittests\": \"0f96655d852ebcafec2165093ab468edf1447d76\", \"device_unittests\": \"72838957bc48fa0ab35c04142af676b890fb7825\", \"display_unittests\": \"a43c798d0e7a2c6114e1820b700d369b45eb624a\", \"events_unittests\": \"d9089514d790bbed5b931cdce0fade9ca7e27af2\", \"exo_unittests\": \"86cc382ee111badf9efff0761c5f2921855c7ae7\", \"extensions_browsertests\": \"985fac4f7edfe7ccd9582f41d611dbe57d3a2d6e\", \"extensions_unittests\": \"1448802d3d24f9c444ef584e2d1978a90bca7318\", \"filesystem_service_unittests\": \"6f895e4580b1bde3b8b88a8492eafd9688e60aa8\", \"gcm_unit_tests\": \"528b72803781fa610465ce083110edb264b37e57\", \"gfx_unittests\": \"2904e1e81c508ff89d5d59a845c96aeed22e18bf\", \"gin_unittests\": \"d9b783728519bd5544ec6fc4f9a1fc0bab6ba617\", \"gl_unittests_ozone\": \"41352b6cf3843de793fad625133f3ef2788fdfc8\", \"google_apis_unittests\": \"42008781220f40da2bd112c9d80f2d01e1e25c97\", \"gpu_unittests\": \"e93370b3be69981e66a3266f95cd6a543bd78a9d\", \"gwp_asan_unittests\": \"81c834d15df2c800d10f7f720efe5b614d16231c\", \"interactive_ui_tests\": \"5000e97600260500588fb8e591df6d4407915273\", \"ipc_tests\": \"9bab73ffd439874b5dcf4a8a7a1f06509bfdba57\", \"jingle_unittests\": \"09e89907eb92c4f8d139dd5cd35473cd2c403b98\", \"keyboard_unittests\": \"595ce8d26405c5f9906842f4011fa537279e09f7\", \"latency_unittests\": \"d2cf7df14dd887a15524d18a95ca2276ba3453d1\", \"libjingle_xmpp_unittests\": \"5b3ba8e17fca0ad4c056419cc0ab3b0a9ede7984\", \"liburlpattern_unittests\": \"901f20e8218b58bd417c8da4d0c49bc9b22d76aa\", \"media_blink_unittests\": \"3b21a4559883652355d8510fc0746e63af86205e\", \"media_unittests\": \"69c8b4a4ba0b6e6bed36bf4605e3ecf14e35510c\", \"message_center_unittests\": \"922f6a13efa1d0ebdca0ea6faece84da82ce5f65\", \"midi_unittests\": \"8beda3ffe3349a23ab2fdcde03581396a93bfd47\", \"mojo_core_unittests\": \"31c79eb0bebb9728e17226677df52b7186934561\", \"mojo_unittests\": \"9143640abdc8f7d7b62d6a3032823638c21e6c76\", \"nacl_helper_nonsfi_unittests\": \"f086ea7b47c9ad0129efffbcb5c48e623b51abf6\", \"nacl_loader_unittests\": \"03fae71f8fecb856426891ebae79bbd5c237dbc4\", \"native_theme_unittests\": \"b19bc30cc58e0ce97a97b6d9368cc595b887d3ab\", \"net_unittests\": \"bafa31b5800d00e6b68b70eb790e16ea7170ee36\", \"ozone_gl_unittests\": \"d34548729f2921367553a74af97c5e2354da195b\", \"ozone_unittests\": \"2a2ef74a66eab757c34936cb057bd2ffb830f9c7\", \"ozone_x11_unittests\": \"dbe02d227f0bce8fded7cdc7809031ebd8c962ad\", \"pdf_unittests\": \"9afc37fbb14f048f78b5ddf51847b017fe638867\", \"perfetto_unittests\": \"f94379f2ead5817397114c4cf55d78ed4049b81d\", \"ppapi_unittests\": \"55c1b631b4e386b624adbd70031326f3bb6ccb4b\", \"printing_unittests\": \"7e8560f169e6447c3eed66a5b6425a88fda577a4\", \"remoting_unittests\": \"5717db4c491ccb6a9cf800c046e6018361fe9227\", \"sandbox_linux_unittests\": \"7a9c806dbc48a66f6bcc9eb9904ada132573204c\", \"service_manager_unittests\": \"fbddd45ff67421a6eb85a7fe7c99f2019a39270f\", \"services_unittests\": \"beb5d7ac05147d8f52ced3490cbe51ba203c7914\", \"shell_dialogs_unittests\": \"12ffb952de9c3590c74842fc4daad2b6edb70308\", \"shell_encryption_unittests\": \"b22be0aa0e3ab5f813699ba7221760b582712563\", \"skia_unittests\": \"596800c8ddddde173dbcfc0a4475daa1c5e35e19\", \"snapshot_unittests\": \"c39772745bffab35482018d235c45ff6aae8940b\", \"sql_unittests\": \"acc66702ae7f9c6deb0868565847757a11c58d42\", \"storage_unittests\": \"dd3cc04bd820f95f633e7c8ff8471d47f6913e39\", \"sync_integration_tests\": \"a04de469ee2267d7803e58961587c426b9e25b4a\", \"traffic_annotation_auditor_unittests\": \"b46abfbd431288f61fee4647aabb50240b235d21\", \"ui_base_unittests\": \"8cdd4bc007c227007db24579da3b5e1003cb01c6\", \"ui_chromeos_unittests\": \"82d6784472b4d16e9bd6da3640929137a6c06420\", \"ui_touch_selection_unittests\": \"7fea285206a30d6175a7fc41e0a9e6a71734a591\", \"unit_tests\": \"55b14cdf8ea4fed63dbf046464f79cf7940578c2\", \"url_unittests\": \"bdff1eb61fa637577e3616bd21e073a093018758\", \"usage_time_limit_unittests\": \"34afd8a37f5be2a040d7c471bb7fcd2bdba2c910\", \"views_unittests\": \"01c65a9fd09bcacab088ba464c09bd4a0020a9a4\", \"viz_unittests\": \"606e6ae605bc02c72cc1a2354543a3cd6e753419\", \"wm_unittests\": \"d2b7c272f33c14e8961da39798c1bc0e4ab88a68\", \"wtf_unittests\": \"887ab6d37210b99eaef6d06a660f662cf2875b4e\", \"zlib_unittests\": \"b8f55fe6ec097c0caa670b59f0c358558e8e6f4e\"}}, \"swarming\": {\"bot_dimensions\": {\"builderless\": [\"1\"], \"caches\": [\"builder_4973d939604d11dcbaec68575e69c80c756ff63e355ab013b29b8bca26434b7c_v2\", \"builder_9f02bd2de6eac19c457931accbc0b1e66d92a355209524fd30dfc8de3911a1f0_v2\", \"builder_f950d00180feebb913a151f4148df44a669def32bdb4d2b9a63ead64ebacc911_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-93-pui4\"], \"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\": [\"5676-c76598c\"], \"ssd\": [\"0\"], \"zone\": [\"us\", \"us-central\", \"us-central1\", \"us-central1-b\"]}}}",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"started_ts": "1612478529467922",
"status": "COMPLETED",
"status_changed_ts": "1612484345324349",
"tags": [
"build_address:luci.chromium.ci/linux-chromeos-dbg/22483",
"builder:linux-chromeos-dbg",
"buildset:commit/git/da796eeba23e5e49c625de916386fcbfa2d721ff",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/da796eeba23e5e49c625de916386fcbfa2d721ff",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9021617495388723648",
"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/8856187433403223232/+/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:5188073cdb498c10",
"user_agent:luci-scheduler"
],
"updated_ts": "1612484345330233",
"url": "https://ci.chromium.org/b/8856187433403223232",
"utcnow_ts": "1612484345821608"
}
}
[00:19:05.831] Invocation finished in 1h37m1.417046948s with status SUCCEEDED