[04:36:10.336] New invocation is queued and will start shortly
[04:36:11.425] Starting the invocation (attempt 1)
[04:36:11.481] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[04:36:11.481] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[04:36:11.481] Buildbucket request:
{
"bucket": "luci.chromium.ci",
"client_operation_id": "9030020735321792880",
"parameters_json": "{\"builder_name\":\"linux-chromeos-dbg\",\"properties\":{\"branch\":\"refs/heads/master\",\"repository\":\"https://chromium.googlesource.com/chromium/src\",\"revision\":\"0ae8a002c1b9ac48af9437d473882a1d300ae21f\"}}",
"pubsub_callback": {
"auth_token": "...",
"topic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
},
"tags": [
"builder:linux-chromeos-dbg",
"scheduler_invocation_id:9030020735321792880",
"scheduler_job_id:chromium/linux-chromeos-dbg",
"user_agent:luci-scheduler",
"buildset:commit/git/0ae8a002c1b9ac48af9437d473882a1d300ae21f",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/0ae8a002c1b9ac48af9437d473882a1d300ae21f",
"gitiles_ref:refs/heads/master"
]
}
[04:36:12.183] Buildbucket response:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "PROD",
"created_by": "project:chromium",
"created_ts": "1604464571598531",
"id": "8864590673330386912",
"parameters_json": "{\"builder_name\": \"linux-chromeos-dbg\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"0ae8a002c1b9ac48af9437d473882a1d300ae21f\"}}",
"project": "chromium",
"result_details_json": "{\"properties\": {}}",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"status": "SCHEDULED",
"status_changed_ts": "1604464572054282",
"tags": [
"build_address:luci.chromium.ci/linux-chromeos-dbg/21138",
"builder:linux-chromeos-dbg",
"buildset:commit/git/0ae8a002c1b9ac48af9437d473882a1d300ae21f",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/0ae8a002c1b9ac48af9437d473882a1d300ae21f",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9030020735321792880",
"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/8864590673330386912/+/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": "1604464572054433",
"url": "https://ci.chromium.org/b/8864590673330386912",
"utcnow_ts": "1604464572172818"
}
}
[04:36:12.183] Task URL: https://ci.chromium.org/b/8864590673330386912
[04:36:12.183] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9030020735321792880:2:0) after 1m0s
[04:36:34.169] Received PubSub notification, asking Buildbucket for the build status
[04:36:34.271] Build 8864590673330386912: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:37:12.248] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9030020735321792880:2:0)
[04:37:12.248] Timer tick, asking Buildbucket for the build status
[04:37:12.430] Build 8864590673330386912: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:37:12.430] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9030020735321792880:4:0) after 1m0s
[04:38:12.510] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9030020735321792880:4:0)
[04:38:12.510] Timer tick, asking Buildbucket for the build status
[04:38:12.614] Build 8864590673330386912: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:38:12.614] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9030020735321792880:5:0) after 1m0s
[04:39:12.600] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9030020735321792880:5:0)
[04:39:12.600] Timer tick, asking Buildbucket for the build status
[04:39:12.770] Build 8864590673330386912: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:39:12.770] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9030020735321792880:6:0) after 1m0s
[04:40:12.827] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9030020735321792880:6:0)
[04:40:12.827] Timer tick, asking Buildbucket for the build status
[04:40:13.025] Build 8864590673330386912: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:40:13.025] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9030020735321792880:7:0) after 1m0s
[04:41:13.044] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9030020735321792880:7:0)
[04:41:13.044] Timer tick, asking Buildbucket for the build status
[04:41:13.474] Build 8864590673330386912: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:41:13.474] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9030020735321792880:8:0) after 1m0s
[04:42:13.557] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9030020735321792880:8:0)
[04:42:13.557] Timer tick, asking Buildbucket for the build status
[04:42:14.144] Build 8864590673330386912: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:42:14.144] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9030020735321792880:9:0) after 1m0s
[04:43:14.168] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9030020735321792880:9:0)
[04:43:14.168] Timer tick, asking Buildbucket for the build status
[04:43:14.252] Build 8864590673330386912: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:43:14.252] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9030020735321792880:10:0) after 1m0s
[04:44:14.343] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9030020735321792880:10:0)
[04:44:14.343] Timer tick, asking Buildbucket for the build status
[04:44:14.431] Build 8864590673330386912: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:44:14.433] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9030020735321792880:11:0) after 1m0s
[04:45:14.496] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9030020735321792880:11:0)
[04:45:14.496] Timer tick, asking Buildbucket for the build status
[04:45:14.635] Build 8864590673330386912: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:45:14.635] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9030020735321792880:12:0) after 1m0s
[04:46:14.661] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9030020735321792880:12:0)
[04:46:14.661] Timer tick, asking Buildbucket for the build status
[04:46:14.730] Build 8864590673330386912: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:46:14.730] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9030020735321792880:13:0) after 1m0s
[04:47:14.761] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9030020735321792880:13:0)
[04:47:14.761] Timer tick, asking Buildbucket for the build status
[04:47:14.887] Build 8864590673330386912: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:47:14.887] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9030020735321792880:14:0) after 1m0s
[04:48:14.902] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9030020735321792880:14:0)
[04:48:14.902] Timer tick, asking Buildbucket for the build status
[04:48:15.016] Build 8864590673330386912: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:48:15.016] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9030020735321792880:15:0) after 1m0s
[04:49:15.083] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9030020735321792880:15:0)
[04:49:15.083] Timer tick, asking Buildbucket for the build status
[04:49:15.478] Build 8864590673330386912: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:49:15.478] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9030020735321792880:16:0) after 1m0s
[04:50:15.536] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9030020735321792880:16:0)
[04:50:15.536] Timer tick, asking Buildbucket for the build status
[04:50:15.610] Build 8864590673330386912: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:50:15.610] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9030020735321792880:17:0) after 1m0s
[04:51:15.588] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9030020735321792880:17:0)
[04:51:15.588] Timer tick, asking Buildbucket for the build status
[04:51:15.745] Build 8864590673330386912: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:51:15.745] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9030020735321792880:18:0) after 1m0s
[04:52:15.776] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9030020735321792880:18:0)
[04:52:15.776] Timer tick, asking Buildbucket for the build status
[04:52:15.975] Build 8864590673330386912: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:52:15.975] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9030020735321792880:19:0) after 1m0s
[04:53:16.069] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9030020735321792880:19:0)
[04:53:16.069] Timer tick, asking Buildbucket for the build status
[04:53:16.128] Build 8864590673330386912: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:53:16.128] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9030020735321792880:20:0) after 1m0s
[04:54:16.186] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9030020735321792880:20:0)
[04:54:16.186] Timer tick, asking Buildbucket for the build status
[04:54:16.253] Build 8864590673330386912: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:54:16.254] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9030020735321792880:21:0) after 1m0s
[04:55:16.274] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9030020735321792880:21:0)
[04:55:16.274] Timer tick, asking Buildbucket for the build status
[04:55:16.375] Build 8864590673330386912: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:55:16.375] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9030020735321792880:22:0) after 1m0s
[04:56:16.412] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9030020735321792880:22:0)
[04:56:16.412] Timer tick, asking Buildbucket for the build status
[04:56:16.481] Build 8864590673330386912: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:56:16.481] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9030020735321792880:23:0) after 1m0s
[04:57:16.513] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9030020735321792880:23:0)
[04:57:16.513] Timer tick, asking Buildbucket for the build status
[04:57:16.651] Build 8864590673330386912: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:57:16.651] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9030020735321792880:24:0) after 1m0s
[04:58:16.708] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9030020735321792880:24:0)
[04:58:16.708] Timer tick, asking Buildbucket for the build status
[04:58:16.966] Build 8864590673330386912: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:58:16.966] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9030020735321792880:25:0) after 1m0s
[04:59:17.003] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9030020735321792880:25:0)
[04:59:17.003] Timer tick, asking Buildbucket for the build status
[04:59:17.096] Build 8864590673330386912: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:59:17.096] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9030020735321792880:26:0) after 1m0s
[05:00:17.220] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9030020735321792880:26:0)
[05:00:17.220] Timer tick, asking Buildbucket for the build status
[05:00:17.329] Build 8864590673330386912: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:00:17.330] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9030020735321792880:27:0) after 1m0s
[05:01:17.408] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9030020735321792880:27:0)
[05:01:17.408] Timer tick, asking Buildbucket for the build status
[05:01:17.508] Build 8864590673330386912: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:01:17.508] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9030020735321792880:28:0) after 1m0s
[05:02:17.666] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9030020735321792880:28:0)
[05:02:17.666] Timer tick, asking Buildbucket for the build status
[05:02:18.050] Build 8864590673330386912: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:02:18.050] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9030020735321792880:29:0) after 1m0s
[05:03:18.054] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9030020735321792880:29:0)
[05:03:18.054] Timer tick, asking Buildbucket for the build status
[05:03:18.591] Build 8864590673330386912: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:03:18.591] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9030020735321792880:30:0) after 1m0s
[05:04:18.711] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9030020735321792880:30:0)
[05:04:18.711] Timer tick, asking Buildbucket for the build status
[05:04:18.892] Build 8864590673330386912: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:04:18.893] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9030020735321792880:31:0) after 1m0s
[05:05:18.980] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9030020735321792880:31:0)
[05:05:18.980] Timer tick, asking Buildbucket for the build status
[05:05:19.049] Build 8864590673330386912: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:05:19.049] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9030020735321792880:32:0) after 1m0s
[05:06:19.155] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9030020735321792880:32:0)
[05:06:19.155] Timer tick, asking Buildbucket for the build status
[05:06:19.359] Build 8864590673330386912: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:06:19.359] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9030020735321792880:33:0) after 1m0s
[05:07:19.461] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9030020735321792880:33:0)
[05:07:19.461] Timer tick, asking Buildbucket for the build status
[05:07:19.602] Build 8864590673330386912: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:07:19.602] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9030020735321792880:34:0) after 1m0s
[05:08:19.624] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9030020735321792880:34:0)
[05:08:19.624] Timer tick, asking Buildbucket for the build status
[05:08:19.926] Build 8864590673330386912: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:08:19.926] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9030020735321792880:35:0) after 1m0s
[05:09:19.985] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9030020735321792880:35:0)
[05:09:19.985] Timer tick, asking Buildbucket for the build status
[05:09:20.061] Build 8864590673330386912: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:09:20.061] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9030020735321792880:36:0) after 1m0s
[05:10:20.085] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9030020735321792880:36:0)
[05:10:20.085] Timer tick, asking Buildbucket for the build status
[05:10:20.289] Build 8864590673330386912: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:10:20.289] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9030020735321792880:37:0) after 1m0s
[05:11:20.391] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9030020735321792880:37:0)
[05:11:20.391] Timer tick, asking Buildbucket for the build status
[05:11:20.561] Build 8864590673330386912: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:11:20.561] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9030020735321792880:38:0) after 1m0s
[05:12:20.608] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9030020735321792880:38:0)
[05:12:20.608] Timer tick, asking Buildbucket for the build status
[05:12:20.946] Build 8864590673330386912: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:12:20.946] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9030020735321792880:39:0) after 1m0s
[05:13:21.025] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9030020735321792880:39:0)
[05:13:21.025] Timer tick, asking Buildbucket for the build status
[05:13:21.148] Build 8864590673330386912: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:13:21.148] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9030020735321792880:40:0) after 1m0s
[05:14:21.191] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9030020735321792880:40:0)
[05:14:21.191] Timer tick, asking Buildbucket for the build status
[05:14:21.447] Build 8864590673330386912: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:14:21.447] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9030020735321792880:41:0) after 1m0s
[05:15:21.472] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9030020735321792880:41:0)
[05:15:21.472] Timer tick, asking Buildbucket for the build status
[05:15:21.590] Build 8864590673330386912: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:15:21.590] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9030020735321792880:42:0) after 1m0s
[05:16:21.619] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9030020735321792880:42:0)
[05:16:21.619] Timer tick, asking Buildbucket for the build status
[05:16:21.782] Build 8864590673330386912: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:16:21.782] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9030020735321792880:43:0) after 1m0s
[05:17:21.823] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9030020735321792880:43:0)
[05:17:21.823] Timer tick, asking Buildbucket for the build status
[05:17:22.354] Build 8864590673330386912: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:17:22.354] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9030020735321792880:44:0) after 1m0s
[05:18:22.441] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9030020735321792880:44:0)
[05:18:22.441] Timer tick, asking Buildbucket for the build status
[05:18:22.557] Build 8864590673330386912: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:18:22.557] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9030020735321792880:45:0) after 1m0s
[05:19:22.612] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9030020735321792880:45:0)
[05:19:22.612] Timer tick, asking Buildbucket for the build status
[05:19:22.672] Build 8864590673330386912: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:19:22.672] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9030020735321792880:46:0) after 1m0s
[05:20:22.788] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9030020735321792880:46:0)
[05:20:22.788] Timer tick, asking Buildbucket for the build status
[05:20:22.992] Build 8864590673330386912: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:20:22.993] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9030020735321792880:47:0) after 1m0s
[05:21:23.035] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9030020735321792880:47:0)
[05:21:23.035] Timer tick, asking Buildbucket for the build status
[05:21:23.205] Build 8864590673330386912: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:21:23.205] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9030020735321792880:48:0) after 1m0s
[05:22:23.232] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9030020735321792880:48:0)
[05:22:23.233] Timer tick, asking Buildbucket for the build status
[05:22:23.366] Build 8864590673330386912: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:22:23.366] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9030020735321792880:49:0) after 1m0s
[05:23:23.490] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9030020735321792880:49:0)
[05:23:23.490] Timer tick, asking Buildbucket for the build status
[05:23:23.607] Build 8864590673330386912: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:23:23.607] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9030020735321792880:50:0) after 1m0s
[05:24:23.645] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9030020735321792880:50:0)
[05:24:23.645] Timer tick, asking Buildbucket for the build status
[05:24:24.142] Build 8864590673330386912: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:24:24.142] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9030020735321792880:51:0) after 1m0s
[05:25:24.215] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9030020735321792880:51:0)
[05:25:24.215] Timer tick, asking Buildbucket for the build status
[05:25:24.684] Build 8864590673330386912: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:25:24.684] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9030020735321792880:52:0) after 1m0s
[05:26:24.783] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9030020735321792880:52:0)
[05:26:24.783] Timer tick, asking Buildbucket for the build status
[05:26:24.995] Build 8864590673330386912: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:26:24.995] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9030020735321792880:53:0) after 1m0s
[05:27:25.108] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9030020735321792880:53:0)
[05:27:25.108] Timer tick, asking Buildbucket for the build status
[05:27:25.268] Build 8864590673330386912: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:27:25.268] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9030020735321792880:54:0) after 1m0s
[05:28:25.329] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9030020735321792880:54:0)
[05:28:25.329] Timer tick, asking Buildbucket for the build status
[05:28:25.466] Build 8864590673330386912: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:28:25.466] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9030020735321792880:55:0) after 1m0s
[05:29:25.507] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9030020735321792880:55:0)
[05:29:25.507] Timer tick, asking Buildbucket for the build status
[05:29:25.619] Build 8864590673330386912: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:29:25.619] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9030020735321792880:56:0) after 1m0s
[05:30:25.682] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9030020735321792880:56:0)
[05:30:25.682] Timer tick, asking Buildbucket for the build status
[05:30:25.774] Build 8864590673330386912: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:30:25.774] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9030020735321792880:57:0) after 1m0s
[05:31:26.083] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9030020735321792880:57:0)
[05:31:26.083] Timer tick, asking Buildbucket for the build status
[05:31:26.185] Build 8864590673330386912: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:31:26.185] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9030020735321792880:58:0) after 1m0s
[05:32:26.216] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9030020735321792880:58:0)
[05:32:26.216] Timer tick, asking Buildbucket for the build status
[05:32:26.309] Build 8864590673330386912: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:32:26.309] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9030020735321792880:59:0) after 1m0s
[05:33:26.424] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9030020735321792880:59:0)
[05:33:26.424] Timer tick, asking Buildbucket for the build status
[05:33:26.583] Build 8864590673330386912: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:33:26.583] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9030020735321792880:60:0) after 1m0s
[05:34:26.667] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9030020735321792880:60:0)
[05:34:26.667] Timer tick, asking Buildbucket for the build status
[05:34:26.962] Build 8864590673330386912: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:34:26.962] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9030020735321792880:61:0) after 1m0s
[05:35:27.064] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9030020735321792880:61:0)
[05:35:27.064] Timer tick, asking Buildbucket for the build status
[05:35:27.153] Build 8864590673330386912: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:35:27.153] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9030020735321792880:62:0) after 1m0s
[05:36:27.276] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9030020735321792880:62:0)
[05:36:27.276] Timer tick, asking Buildbucket for the build status
[05:36:27.471] Build 8864590673330386912: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:36:27.471] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9030020735321792880:63:0) after 1m0s
[05:37:27.620] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9030020735321792880:63:0)
[05:37:27.620] Timer tick, asking Buildbucket for the build status
[05:37:27.769] Build 8864590673330386912: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:37:27.769] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9030020735321792880:64:0) after 1m0s
[05:38:27.829] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9030020735321792880:64:0)
[05:38:27.829] Timer tick, asking Buildbucket for the build status
[05:38:28.269] Build 8864590673330386912: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:38:28.269] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9030020735321792880:65:0) after 1m0s
[05:39:28.303] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9030020735321792880:65:0)
[05:39:28.303] Timer tick, asking Buildbucket for the build status
[05:39:28.712] Build 8864590673330386912: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:39:28.712] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9030020735321792880:66:0) after 1m0s
[05:40:28.764] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9030020735321792880:66:0)
[05:40:28.764] Timer tick, asking Buildbucket for the build status
[05:40:28.869] Build 8864590673330386912: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:40:28.869] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9030020735321792880:67:0) after 1m0s
[05:41:28.851] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9030020735321792880:67:0)
[05:41:28.851] Timer tick, asking Buildbucket for the build status
[05:41:29.215] Build 8864590673330386912: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:41:29.215] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9030020735321792880:68:0) after 1m0s
[05:42:29.223] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9030020735321792880:68:0)
[05:42:29.223] Timer tick, asking Buildbucket for the build status
[05:42:29.329] Build 8864590673330386912: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:42:29.329] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9030020735321792880:69:0) after 1m0s
[05:43:29.378] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9030020735321792880:69:0)
[05:43:29.378] Timer tick, asking Buildbucket for the build status
[05:43:29.452] Build 8864590673330386912: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:43:29.452] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9030020735321792880:70:0) after 1m0s
[05:44:29.484] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9030020735321792880:70:0)
[05:44:29.484] Timer tick, asking Buildbucket for the build status
[05:44:29.636] Build 8864590673330386912: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:44:29.636] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9030020735321792880:71:0) after 1m0s
[05:45:29.670] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9030020735321792880:71:0)
[05:45:29.670] Timer tick, asking Buildbucket for the build status
[05:45:30.727] Build 8864590673330386912: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:45:30.727] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9030020735321792880:72:0) after 1m0s
[05:46:30.758] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9030020735321792880:72:0)
[05:46:30.758] Timer tick, asking Buildbucket for the build status
[05:46:30.861] Build 8864590673330386912: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:46:30.861] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9030020735321792880:73:0) after 1m0s
[05:47:30.899] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9030020735321792880:73:0)
[05:47:30.899] Timer tick, asking Buildbucket for the build status
[05:47:31.097] Build 8864590673330386912: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:47:31.097] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9030020735321792880:74:0) after 1m0s
[05:48:31.128] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9030020735321792880:74:0)
[05:48:31.128] Timer tick, asking Buildbucket for the build status
[05:48:31.225] Build 8864590673330386912: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:48:31.225] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9030020735321792880:75:0) after 1m0s
[05:49:31.254] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9030020735321792880:75:0)
[05:49:31.254] Timer tick, asking Buildbucket for the build status
[05:49:31.334] Build 8864590673330386912: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:49:31.334] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9030020735321792880:76:0) after 1m0s
[05:50:31.407] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9030020735321792880:76:0)
[05:50:31.407] Timer tick, asking Buildbucket for the build status
[05:50:31.857] Build 8864590673330386912: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:50:31.857] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9030020735321792880:77:0) after 1m0s
[05:51:31.915] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9030020735321792880:77:0)
[05:51:31.915] Timer tick, asking Buildbucket for the build status
[05:51:32.066] Build 8864590673330386912: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:51:32.066] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9030020735321792880:78:0) after 1m0s
[05:52:32.148] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9030020735321792880:78:0)
[05:52:32.148] Timer tick, asking Buildbucket for the build status
[05:52:32.225] Build 8864590673330386912: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:52:32.225] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9030020735321792880:79:0) after 1m0s
[05:53:32.268] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9030020735321792880:79:0)
[05:53:32.268] Timer tick, asking Buildbucket for the build status
[05:53:32.342] Build 8864590673330386912: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:53:32.342] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9030020735321792880:80:0) after 1m0s
[05:54:32.368] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9030020735321792880:80:0)
[05:54:32.368] Timer tick, asking Buildbucket for the build status
[05:54:32.450] Build 8864590673330386912: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:54:32.450] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9030020735321792880:81:0) after 1m0s
[05:55:32.509] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9030020735321792880:81:0)
[05:55:32.509] Timer tick, asking Buildbucket for the build status
[05:55:32.876] Build 8864590673330386912: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:55:32.876] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9030020735321792880:82:0) after 1m0s
[05:56:32.932] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9030020735321792880:82:0)
[05:56:32.932] Timer tick, asking Buildbucket for the build status
[05:56:33.048] Build 8864590673330386912: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:56:33.048] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9030020735321792880:83:0) after 1m0s
[05:57:33.102] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9030020735321792880:83:0)
[05:57:33.102] Timer tick, asking Buildbucket for the build status
[05:57:35.368] Build 8864590673330386912: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:57:35.368] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9030020735321792880:84:0) after 1m0s
[05:58:35.457] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9030020735321792880:84:0)
[05:58:35.457] Timer tick, asking Buildbucket for the build status
[05:58:35.538] Build 8864590673330386912: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:58:35.538] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9030020735321792880:85:0) after 1m0s
[05:59:35.565] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9030020735321792880:85:0)
[05:59:35.565] Timer tick, asking Buildbucket for the build status
[05:59:36.040] Build 8864590673330386912: status "STARTED", result "", failure_reason "", cancelation_reason ""
[05:59:36.040] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9030020735321792880:86:0) after 1m0s
[06:00:36.171] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9030020735321792880:86:0)
[06:00:36.171] Timer tick, asking Buildbucket for the build status
[06:00:36.382] Build 8864590673330386912: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:00:36.382] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9030020735321792880:87:0) after 1m0s
[06:01:48.222] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9030020735321792880:87:0)
[06:01:48.222] Timer tick, asking Buildbucket for the build status
[06:01:48.421] Build 8864590673330386912: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:01:48.421] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9030020735321792880:88:0) after 1m0s
[06:02:48.602] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9030020735321792880:88:0)
[06:02:48.602] Timer tick, asking Buildbucket for the build status
[06:02:48.793] Build 8864590673330386912: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:02:48.793] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9030020735321792880:89:0) after 1m0s
[06:03:48.895] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9030020735321792880:89:0)
[06:03:48.895] Timer tick, asking Buildbucket for the build status
[06:03:49.011] Build 8864590673330386912: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:03:49.011] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9030020735321792880:90:0) after 1m0s
[06:04:49.028] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9030020735321792880:90:0)
[06:04:49.028] Timer tick, asking Buildbucket for the build status
[06:04:50.847] Build 8864590673330386912: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:04:50.847] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9030020735321792880:91:0) after 1m0s
[06:05:50.868] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9030020735321792880:91:0)
[06:05:50.868] Timer tick, asking Buildbucket for the build status
[06:05:51.200] Build 8864590673330386912: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:05:51.200] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9030020735321792880:92:0) after 1m0s
[06:06:51.390] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9030020735321792880:92:0)
[06:06:51.390] Timer tick, asking Buildbucket for the build status
[06:06:51.569] Build 8864590673330386912: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:06:51.569] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9030020735321792880:93:0) after 1m0s
[06:07:51.613] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9030020735321792880:93:0)
[06:07:51.613] Timer tick, asking Buildbucket for the build status
[06:07:52.155] Build 8864590673330386912: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:07:52.155] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9030020735321792880:94:0) after 1m0s
[06:08:52.230] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9030020735321792880:94:0)
[06:08:52.230] Timer tick, asking Buildbucket for the build status
[06:08:52.422] Build 8864590673330386912: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:08:52.422] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9030020735321792880:95:0) after 1m0s
[06:09:52.454] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9030020735321792880:95:0)
[06:09:52.454] Timer tick, asking Buildbucket for the build status
[06:09:52.567] Build 8864590673330386912: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:09:52.567] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9030020735321792880:96:0) after 1m0s
[06:10:52.666] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9030020735321792880:96:0)
[06:10:52.666] Timer tick, asking Buildbucket for the build status
[06:10:52.783] Build 8864590673330386912: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:10:52.783] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9030020735321792880:97:0) after 1m0s
[06:11:52.851] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9030020735321792880:97:0)
[06:11:52.851] Timer tick, asking Buildbucket for the build status
[06:11:53.537] Build 8864590673330386912: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:11:53.537] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9030020735321792880:98:0) after 1m0s
[06:12:53.639] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9030020735321792880:98:0)
[06:12:53.639] Timer tick, asking Buildbucket for the build status
[06:12:53.930] Build 8864590673330386912: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:12:53.930] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9030020735321792880:99:0) after 1m0s
[06:13:54.046] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9030020735321792880:99:0)
[06:13:54.046] Timer tick, asking Buildbucket for the build status
[06:13:54.136] Build 8864590673330386912: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:13:54.136] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9030020735321792880:100:0) after 1m0s
[06:14:54.286] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9030020735321792880:100:0)
[06:14:54.286] Timer tick, asking Buildbucket for the build status
[06:14:54.777] Build 8864590673330386912: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:14:54.777] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9030020735321792880:101:0) after 1m0s
[06:15:54.843] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9030020735321792880:101:0)
[06:15:54.843] Timer tick, asking Buildbucket for the build status
[06:15:54.916] Build 8864590673330386912: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:15:54.916] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9030020735321792880:102:0) after 1m0s
[06:16:54.938] Handling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9030020735321792880:102:0)
[06:16:54.938] Timer tick, asking Buildbucket for the build status
[06:16:55.322] Build 8864590673330386912: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:16:55.322] Scheduling timer "check-buildbucket-build-status" (chromium/linux-chromeos-dbg:9030020735321792880:103:0) after 1m0s
[06:17:43.460] Received PubSub notification, asking Buildbucket for the build status
[06:17:43.598] Build 8864590673330386912: status "COMPLETED", result "SUCCESS", failure_reason "", cancelation_reason ""
[06:17:43.598] Buildbucket build:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "PROD",
"completed_ts": "1604470662275660",
"created_by": "project:chromium",
"created_ts": "1604464571598531",
"id": "8864590673330386912",
"parameters_json": "{\"builder_name\": \"linux-chromeos-dbg\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"0ae8a002c1b9ac48af9437d473882a1d300ae21f\"}}",
"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\": \"0ae8a002c1b9ac48af9437d473882a1d300ae21f\", \"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-40-5hxr\", \"branch\": \"refs/heads/master\", \"builder_group\": \"chromium.chromiumos\", \"buildername\": \"linux-chromeos-dbg\", \"buildnumber\": 21138, \"got_angle_revision\": \"3980b1f815aa10caf5dc94adde9d5a7c31a1797c\", \"got_dawn_revision\": \"43ef0a365b8443226916c090b88b3a0b09d6df96\", \"got_nacl_revision\": \"f9e6f257d1a0934dbeed3c5c8f83b651dc4f55e1\", \"got_revision\": \"0ae8a002c1b9ac48af9437d473882a1d300ae21f\", \"got_revision_cp\": \"refs/heads/master@{#823885}\", \"got_swarming_client_revision\": \"d46ea7635f2911208268170512cb611412488fd8\", \"got_swiftshader_revision\": \"31e28d20f8783cda3bb6ec856459ebf3c15d21b7\", \"got_v8_revision\": \"f014ab9299eed4f879b06b06873e7eac3b20b0e5\", \"got_v8_revision_cp\": \"refs/heads/8.8.227@{#1}\", \"got_webrtc_revision\": \"42cafa5696f516712bbe6709fedeedffac61544c\", \"got_webrtc_revision_cp\": \"refs/heads/master@{#32540}\", \"isolate_server\": \"https://isolateserver.appspot.com\", \"path_config\": \"generic\", \"recipe\": \"chromium\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"0ae8a002c1b9ac48af9437d473882a1d300ae21f\", \"swarm_hashes_refs/heads/master(at){#823885}_without_patch\": {\"absl_hardening_tests\": \"cd5997449e5729127bfde1ec369fe1f954b4f9cf\", \"accessibility_unittests\": \"0135e7e4f03594e7f9b3a81d0c6f6e8ec7bc4431\", \"angle_unittests\": \"e78ee3c4b8aa5e441b2d4b18cac99b7bd4a8e111\", \"app_list_unittests\": \"5c80c6444e8d32a23cd26e7c3b7d248ee4adcebd\", \"app_shell_unittests\": \"7279e86ac62756451240660f413f207e17f2e1e4\", \"ash_unittests\": \"c4c318da65cae89e1ad090eb2bceb6e193624fab\", \"aura_unittests\": \"38e53fa86335059808278e5ad88f7c4dd14190ad\", \"base_unittests\": \"d10fde68b912bb7c00974b40bfae5e5f5856348a\", \"base_util_unittests\": \"8744e6cac4f7252b65a3db51797d64dfbae734e1\", \"blink_common_unittests\": \"c478c114478596e2f2bb0256c82990468dab8d22\", \"blink_fuzzer_unittests\": \"cac16e83146bd2aba6a757838b9aa19eee6a2468\", \"blink_heap_unittests\": \"eed4e9f12be4a9aae2e38de6dd67c51153aecf6f\", \"blink_platform_unittests\": \"bf05ed39943a2737afd40103c68edb35aa2d95b4\", \"blink_unittests\": \"fab58ddf4153a37e9c500314091e966e9fa03efb\", \"boringssl_crypto_tests\": \"7570113ee5bbd130592aee5c45ae2337ed6ce018\", \"boringssl_ssl_tests\": \"60e55766bdc1c27a953c0494453d50ce25b84eda\", \"browser_tests\": \"00acfbe9c8caed3c267c4ae207ed041c7bdf6019\", \"capture_unittests\": \"8fc95e7d3d313533a9e3f1a2c8ccff955f0b4f3f\", \"cast_unittests\": \"9138f92d64581db6f892434d63119378cbd94321\", \"cc_unittests\": \"e4aaf4d239fadf3d6b6caaa5fe79b056b7be3c6a\", \"chrome_app_unittests\": \"ffd68f253bd3acc237f4ee64763187f81d9a1e49\", \"chromedriver_unittests\": \"ddfc3bf30e2718ad46dab1ae2697f404ec828606\", \"chromeos_components_unittests\": \"25f6b0817dca8c34f911f6e12d86cd3f8fb5afc2\", \"chromeos_unittests\": \"2af32a9b401782a4e8c6dbd6a4df9f14195b78f1\", \"components_browsertests\": \"eba99c1d80e7de6806ec9c26a41135ba7dd96a94\", \"components_unittests\": \"2d464c651c61a5a7867bfec4c5465576a64aaceb\", \"compositor_unittests\": \"16d105529cd5331a1652e4378d89bd060111e273\", \"content_browsertests\": \"bb02efa60529e6939fde24b3154e710142d755c6\", \"content_unittests\": \"549d967342846a7fad2aa5a7ff2968e74f01631d\", \"crypto_unittests\": \"98bcd1b7888f7947ff863664ccc7d0b73ec6ae86\", \"dbus_unittests\": \"36e94bc9835a9a12458626ddf9959e4a52c2cfb1\", \"device_unittests\": \"8356ffbe4614672e5a4134d6503d3423a3a79b88\", \"display_unittests\": \"51d29f960ae222563273ebac61bbea071ca20220\", \"events_unittests\": \"b7578060acaa0881fc9f9c568ab9b436f082ff2b\", \"exo_unittests\": \"cd80c861021ac47ca125599d44c6fd69f5372f8b\", \"extensions_browsertests\": \"c8b1c1f9ce729bd3d03e538285cec82af7d6d9f4\", \"extensions_unittests\": \"5e06204f448430804b827c1df005a95b4e4a194e\", \"filesystem_service_unittests\": \"9c557d0fc1158d99d562085e4f148d5bc11dec08\", \"gcm_unit_tests\": \"05b57675ab771e48bfe187c62cf541f0e5abc44a\", \"gfx_unittests\": \"6bcafbd9f57b8a00360697859736c259fc0ad62f\", \"gin_unittests\": \"dec0be9222700f5eda171dd9ed06038903843f88\", \"gl_unittests_ozone\": \"80a034c0eacfd222353edf3d7b699c0e7f03fc73\", \"google_apis_unittests\": \"cb674894ea0fb14bf2a6fcdb99f7f4370441accd\", \"gpu_unittests\": \"aea72710f1bee826f51f432b45844f2e1336e697\", \"gwp_asan_unittests\": \"f1352198e90fcc9800a5b86488e3dae2c5c68510\", \"interactive_ui_tests\": \"5b48e25e62a143d8a52fbf9f7c8ee60b2457f7f7\", \"ipc_tests\": \"c3185c49e9853b36b0a0a12dde1912bb5058602b\", \"jingle_unittests\": \"81093a6e0d4f093f3f63e9c940e8b1b41bfe7b26\", \"keyboard_unittests\": \"9155a32e60ed4b04a2ae23b14543c7b2f99560ac\", \"latency_unittests\": \"292cd0f5144686c217a08a4c86ef7cc3e5529a06\", \"libjingle_xmpp_unittests\": \"30b70196e5eb8f16692b320c60f72de519ee7430\", \"liburlpattern_unittests\": \"29a1d56236537227b0180235c8372e8d65f80cf1\", \"media_blink_unittests\": \"e651383f83fa2996d3b40261d2e9a10962463a4d\", \"media_unittests\": \"eaee2a7ac792bdd9761f3da5819fb183e612d32d\", \"message_center_unittests\": \"752e88e5f09073b6e08b092ac9b45cdb0d6b3bf4\", \"midi_unittests\": \"78d2f12f4300d6a6796f62cd3a5e8078897b1e44\", \"mojo_core_unittests\": \"fba639f305819ce365c9d18dd1ca95e2ed4a8909\", \"mojo_unittests\": \"6d6b4b7fbdb03d11a21f1662f7b1500b2a98f27d\", \"nacl_helper_nonsfi_unittests\": \"2047eb6e39d4d6f6a9595a61fbf887e3f6c9be56\", \"nacl_loader_unittests\": \"e8dca261347c3c08bc2e78b8e85223d2e4b8f6e7\", \"native_theme_unittests\": \"f2df6ca1d2ab06ebc88bbc84c1a82db6893e792d\", \"net_unittests\": \"1e3cb7bae791da4ebce07d309b44c18f6217faba\", \"ozone_gl_unittests\": \"31fffb4969ada06fcef57c76f66772599bb09bda\", \"ozone_unittests\": \"9da48dcf985690ff2b840baba24e56c9551b8a85\", \"ozone_x11_unittests\": \"0843e27b4eb11750b98cf8e27e8acbfb2ba07b56\", \"pdf_unittests\": \"e83f80eebb674c1a9bf73a964f57618f21b585a9\", \"perfetto_unittests\": \"756405453a9a9291c9ab9d37fe9ed6ab51cb713a\", \"ppapi_unittests\": \"f256b2f92a71178c8d3c3255f943126bc7986f47\", \"printing_unittests\": \"d43820621f597f34c2fce9b5a7baf30ac573b296\", \"remoting_unittests\": \"b445e9156dfb9bcfe17aa2665774cc89872fde09\", \"sandbox_linux_unittests\": \"a2181e16f01628046a22c2510cba1db835772c84\", \"service_manager_unittests\": \"939d93249166f6a7d9ca94116d3cc054ec3c90a0\", \"services_unittests\": \"08ba65004fd02603344fbd3535fb595da54f7ffe\", \"shell_dialogs_unittests\": \"5d99c29bf6d0b135c08eb4025a988965a0928cfb\", \"skia_unittests\": \"2c1734fa70a6f6b5e60d02253f27b4f0cbc6150c\", \"snapshot_unittests\": \"afd2e6d6810e1e5902b0da2e073aa2ba0c22a568\", \"sql_unittests\": \"a639e4263b43d6d7ed395a0fc2be8967fd544f3f\", \"storage_unittests\": \"e3f86cb409f173a719472cd97d8465f79eec98fc\", \"sync_integration_tests\": \"b98a9107e8840d3177156ba7d07eaa6669865846\", \"traffic_annotation_auditor_unittests\": \"2ce7df9451eaa9e7084cb83e34632755273d4e9a\", \"ui_base_unittests\": \"a34db060a1426892e5f0a0abe97bbb3d5a7cb732\", \"ui_chromeos_unittests\": \"ea7437013f83a77fdfcbe5a5eae2db812570704d\", \"ui_touch_selection_unittests\": \"67c63faa1466af752844dff5423860b5909cdb2c\", \"unit_tests\": \"3b342764facf6f9dcfffdcefaf474bc4a442fcc6\", \"url_unittests\": \"afc230d3c7730ea80403ab5440cc625dee77f533\", \"usage_time_limit_unittests\": \"715b752f3a98a7aabec11d6d0ab8e8f9d0c1f551\", \"views_unittests\": \"58174ca3197abd5ddb9238d23c270a61852bc12e\", \"viz_unittests\": \"81df5b8332aa011db96fd2f0b598f4cca81feb50\", \"wm_unittests\": \"305d8d2b6920646ad2d2c248036dea981316a827\", \"wtf_unittests\": \"ca7aed11f2ca6ab1851574f39b5e1b3a78c71940\", \"zlib_unittests\": \"1f530175ca558330725fc7361ce090c386d7b413\"}}, \"swarming\": {\"bot_dimensions\": {\"builderless\": [\"1\"], \"caches\": [\"builder_151f80801b9f29276c11c5f05dab27ce5673f9c9ba442aaf2cf20aab9215f522_v2\", \"builder_2295bac873f7edd8c9763e89419d85b38a875955550d968c436d775d3f06377b_v2\", \"builder_4973d939604d11dcbaec68575e69c80c756ff63e355ab013b29b8bca26434b7c_v2\", \"builder_55253def7cf185b290c24a7d0b74f783205e145476ba9938944ce33e13edac5f_v2\", \"builder_a432d290b72bc0f3cae401fbd647c33c14340f64e89770e9c9c39d6230495526_v2\", \"builder_dc45faf1d7d5fa61c97a020287f0c8532c944f5ffcf96875ec590f5c9bab0d83_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-40-5hxr\"], \"image\": [\"chrome-xenial-20102500-5da31bca5f9\"], \"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\": [\"5614-d862eaa\"], \"ssd\": [\"0\"], \"zone\": [\"us\", \"us-central\", \"us-central1\", \"us-central1-b\"]}}}",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"started_ts": "1604464592764780",
"status": "COMPLETED",
"status_changed_ts": "1604470662691301",
"tags": [
"build_address:luci.chromium.ci/linux-chromeos-dbg/21138",
"builder:linux-chromeos-dbg",
"buildset:commit/git/0ae8a002c1b9ac48af9437d473882a1d300ae21f",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/0ae8a002c1b9ac48af9437d473882a1d300ae21f",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9030020735321792880",
"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/8864590673330386912/+/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:4faa5c135e53b210",
"user_agent:luci-scheduler"
],
"updated_ts": "1604470662701398",
"url": "https://ci.chromium.org/b/8864590673330386912",
"utcnow_ts": "1604470663584942"
}
}
[06:17:43.598] Invocation finished in 1h41m33.283065218s with status SUCCEEDED