[14:43:50.503] New invocation is queued and will start shortly
[14:43:51.609] Starting the invocation (attempt 1)
[14:43:51.683] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[14:43:51.683] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[14:43:51.683] Buildbucket request:
{
"bucket": "luci.chromium.ci",
"client_operation_id": "9022825343716596256",
"parameters_json": "{\"builder_name\":\"Linux CFI\",\"properties\":{\"branch\":\"refs/heads/master\",\"repository\":\"https://chromium.googlesource.com/chromium/src\",\"revision\":\"b1f88a5efa581b0f735d042c505dadc0fd155b38\"}}",
"pubsub_callback": {
"auth_token": "...",
"topic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
},
"tags": [
"builder:Linux CFI",
"scheduler_invocation_id:9022825343716596256",
"scheduler_job_id:chromium/Linux CFI",
"user_agent:luci-scheduler",
"buildset:commit/git/b1f88a5efa581b0f735d042c505dadc0fd155b38",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/b1f88a5efa581b0f735d042c505dadc0fd155b38",
"gitiles_ref:refs/heads/master"
]
}
[14:44:11.805] Failed to add buildbucket build - googleapi: got HTTP response code 500 with body:
<html><head>
<meta http-equiv="content-type" content="text/html;charset=utf-8">
<title>500 Server Error</title>
</head>
<body text=#000000 bgcolor=#ffffff>
<h1>Error: Server Error</h1>
<h2>The server encountered an error and could not complete your request.<p>Please try again in 30 seconds.</h2>
<h2></h2>
</body></html>
[14:44:11.805] The invocation will be retried
[14:44:16.853] Starting the invocation (attempt 2)
[14:44:16.893] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[14:44:16.894] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[14:44:16.894] Buildbucket request:
{
"bucket": "luci.chromium.ci",
"client_operation_id": "9022825343716596256",
"parameters_json": "{\"builder_name\":\"Linux CFI\",\"properties\":{\"branch\":\"refs/heads/master\",\"repository\":\"https://chromium.googlesource.com/chromium/src\",\"revision\":\"b1f88a5efa581b0f735d042c505dadc0fd155b38\"}}",
"pubsub_callback": {
"auth_token": "...",
"topic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
},
"tags": [
"builder:Linux CFI",
"scheduler_invocation_id:9022825343716596256",
"scheduler_job_id:chromium/Linux CFI",
"user_agent:luci-scheduler",
"buildset:commit/git/b1f88a5efa581b0f735d042c505dadc0fd155b38",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/b1f88a5efa581b0f735d042c505dadc0fd155b38",
"gitiles_ref:refs/heads/master"
]
}
[14:44:18.014] Buildbucket response:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "PROD",
"created_by": "project:chromium",
"created_ts": "1611326657319326",
"id": "8857395254933587968",
"parameters_json": "{\"builder_name\": \"Linux CFI\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"b1f88a5efa581b0f735d042c505dadc0fd155b38\"}}",
"project": "chromium",
"result_details_json": "{\"properties\": {}}",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"status": "SCHEDULED",
"status_changed_ts": "1611326657884446",
"tags": [
"build_address:luci.chromium.ci/Linux CFI/19538",
"builder:Linux CFI",
"buildset:commit/git/b1f88a5efa581b0f735d042c505dadc0fd155b38",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/b1f88a5efa581b0f735d042c505dadc0fd155b38",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9022825343716596256",
"scheduler_job_id:chromium/Linux CFI",
"swarming_hostname:chromium-swarm.appspot.com",
"swarming_tag:log_location:logdog://logs.chromium.org/chromium/buildbucket/cr-buildbucket.appspot.com/8857395254933587968/+/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": "1611326657884569",
"url": "https://ci.chromium.org/b/8857395254933587968",
"utcnow_ts": "1611326658000207"
}
}
[14:44:18.014] Task URL: https://ci.chromium.org/b/8857395254933587968
[14:44:18.014] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9022825343716596256:5:0) after 1m0s
[14:44:27.657] Received PubSub notification, asking Buildbucket for the build status
[14:44:27.862] Build 8857395254933587968: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:45:18.062] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9022825343716596256:5:0)
[14:45:18.062] Timer tick, asking Buildbucket for the build status
[14:45:18.307] Build 8857395254933587968: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:45:18.307] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9022825343716596256:7:0) after 1m0s
[14:46:18.373] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9022825343716596256:7:0)
[14:46:18.373] Timer tick, asking Buildbucket for the build status
[14:46:18.497] Build 8857395254933587968: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:46:18.497] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9022825343716596256:8:0) after 1m0s
[14:47:18.589] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9022825343716596256:8:0)
[14:47:18.589] Timer tick, asking Buildbucket for the build status
[14:47:18.816] Build 8857395254933587968: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:47:18.816] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9022825343716596256:9:0) after 1m0s
[14:48:18.869] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9022825343716596256:9:0)
[14:48:18.869] Timer tick, asking Buildbucket for the build status
[14:48:18.967] Build 8857395254933587968: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:48:18.967] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9022825343716596256:10:0) after 1m0s
[14:49:19.142] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9022825343716596256:10:0)
[14:49:19.142] Timer tick, asking Buildbucket for the build status
[14:49:19.317] Build 8857395254933587968: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:49:19.317] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9022825343716596256:11:0) after 1m0s
[14:50:19.371] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9022825343716596256:11:0)
[14:50:19.371] Timer tick, asking Buildbucket for the build status
[14:50:19.480] Build 8857395254933587968: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:50:19.480] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9022825343716596256:12:0) after 1m0s
[14:51:19.511] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9022825343716596256:12:0)
[14:51:19.511] Timer tick, asking Buildbucket for the build status
[14:51:19.575] Build 8857395254933587968: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:51:19.575] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9022825343716596256:13:0) after 1m0s
[14:52:19.645] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9022825343716596256:13:0)
[14:52:19.645] Timer tick, asking Buildbucket for the build status
[14:52:19.721] Build 8857395254933587968: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:52:19.721] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9022825343716596256:14:0) after 1m0s
[14:53:19.764] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9022825343716596256:14:0)
[14:53:19.764] Timer tick, asking Buildbucket for the build status
[14:53:19.878] Build 8857395254933587968: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:53:19.878] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9022825343716596256:15:0) after 1m0s
[14:54:19.925] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9022825343716596256:15:0)
[14:54:19.925] Timer tick, asking Buildbucket for the build status
[14:54:20.086] Build 8857395254933587968: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:54:20.086] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9022825343716596256:16:0) after 1m0s
[14:55:20.151] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9022825343716596256:16:0)
[14:55:20.151] Timer tick, asking Buildbucket for the build status
[14:55:20.225] Build 8857395254933587968: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:55:20.225] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9022825343716596256:17:0) after 1m0s
[14:56:20.261] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9022825343716596256:17:0)
[14:56:20.261] Timer tick, asking Buildbucket for the build status
[14:56:20.446] Build 8857395254933587968: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:56:20.446] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9022825343716596256:18:0) after 1m0s
[14:57:20.576] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9022825343716596256:18:0)
[14:57:20.576] Timer tick, asking Buildbucket for the build status
[14:57:21.130] Build 8857395254933587968: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:57:21.130] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9022825343716596256:19:0) after 1m0s
[14:58:21.173] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9022825343716596256:19:0)
[14:58:21.173] Timer tick, asking Buildbucket for the build status
[14:58:21.534] Build 8857395254933587968: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:58:21.534] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9022825343716596256:20:0) after 1m0s
[14:59:21.595] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9022825343716596256:20:0)
[14:59:21.595] Timer tick, asking Buildbucket for the build status
[14:59:21.755] Build 8857395254933587968: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:59:21.755] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9022825343716596256:21:0) after 1m0s
[15:00:21.773] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9022825343716596256:21:0)
[15:00:21.773] Timer tick, asking Buildbucket for the build status
[15:00:22.258] Build 8857395254933587968: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:00:22.258] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9022825343716596256:22:0) after 1m0s
[15:01:22.364] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9022825343716596256:22:0)
[15:01:22.364] Timer tick, asking Buildbucket for the build status
[15:01:22.466] Build 8857395254933587968: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:01:22.466] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9022825343716596256:23:0) after 1m0s
[15:02:22.552] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9022825343716596256:23:0)
[15:02:22.552] Timer tick, asking Buildbucket for the build status
[15:02:22.815] Build 8857395254933587968: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:02:22.816] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9022825343716596256:24:0) after 1m0s
[15:03:22.822] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9022825343716596256:24:0)
[15:03:22.822] Timer tick, asking Buildbucket for the build status
[15:03:22.909] Build 8857395254933587968: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:03:22.909] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9022825343716596256:25:0) after 1m0s
[15:04:22.990] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9022825343716596256:25:0)
[15:04:22.990] Timer tick, asking Buildbucket for the build status
[15:04:23.106] Build 8857395254933587968: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:04:23.106] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9022825343716596256:26:0) after 1m0s
[15:05:23.197] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9022825343716596256:26:0)
[15:05:23.197] Timer tick, asking Buildbucket for the build status
[15:05:23.272] Build 8857395254933587968: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:05:23.272] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9022825343716596256:27:0) after 1m0s
[15:06:23.402] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9022825343716596256:27:0)
[15:06:23.402] Timer tick, asking Buildbucket for the build status
[15:06:23.587] Build 8857395254933587968: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:06:23.587] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9022825343716596256:28:0) after 1m0s
[15:07:23.714] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9022825343716596256:28:0)
[15:07:23.714] Timer tick, asking Buildbucket for the build status
[15:07:23.799] Build 8857395254933587968: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:07:23.799] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9022825343716596256:29:0) after 1m0s
[15:08:23.834] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9022825343716596256:29:0)
[15:08:23.834] Timer tick, asking Buildbucket for the build status
[15:08:23.905] Build 8857395254933587968: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:08:23.905] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9022825343716596256:30:0) after 1m0s
[15:09:23.937] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9022825343716596256:30:0)
[15:09:23.937] Timer tick, asking Buildbucket for the build status
[15:09:24.106] Build 8857395254933587968: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:09:24.106] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9022825343716596256:31:0) after 1m0s
[15:10:24.144] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9022825343716596256:31:0)
[15:10:24.144] Timer tick, asking Buildbucket for the build status
[15:10:24.257] Build 8857395254933587968: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:10:24.257] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9022825343716596256:32:0) after 1m0s
[15:11:24.273] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9022825343716596256:32:0)
[15:11:24.274] Timer tick, asking Buildbucket for the build status
[15:11:24.341] Build 8857395254933587968: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:11:24.341] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9022825343716596256:33:0) after 1m0s
[15:12:24.380] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9022825343716596256:33:0)
[15:12:24.380] Timer tick, asking Buildbucket for the build status
[15:12:24.464] Build 8857395254933587968: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:12:24.464] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9022825343716596256:34:0) after 1m0s
[15:13:24.630] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9022825343716596256:34:0)
[15:13:24.630] Timer tick, asking Buildbucket for the build status
[15:13:24.809] Build 8857395254933587968: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:13:24.809] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9022825343716596256:35:0) after 1m0s
[15:14:24.829] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9022825343716596256:35:0)
[15:14:24.829] Timer tick, asking Buildbucket for the build status
[15:14:25.274] Build 8857395254933587968: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:14:25.274] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9022825343716596256:36:0) after 1m0s
[15:15:25.369] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9022825343716596256:36:0)
[15:15:25.369] Timer tick, asking Buildbucket for the build status
[15:15:25.528] Build 8857395254933587968: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:15:25.528] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9022825343716596256:37:0) after 1m0s
[15:16:25.565] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9022825343716596256:37:0)
[15:16:25.565] Timer tick, asking Buildbucket for the build status
[15:16:25.621] Build 8857395254933587968: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:16:25.621] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9022825343716596256:38:0) after 1m0s
[15:17:25.670] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9022825343716596256:38:0)
[15:17:25.670] Timer tick, asking Buildbucket for the build status
[15:17:26.016] Build 8857395254933587968: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:17:26.016] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9022825343716596256:39:0) after 1m0s
[15:18:26.095] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9022825343716596256:39:0)
[15:18:26.095] Timer tick, asking Buildbucket for the build status
[15:18:26.244] Build 8857395254933587968: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:18:26.244] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9022825343716596256:40:0) after 1m0s
[15:19:26.263] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9022825343716596256:40:0)
[15:19:26.263] Timer tick, asking Buildbucket for the build status
[15:19:26.540] Build 8857395254933587968: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:19:26.540] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9022825343716596256:41:0) after 1m0s
[15:20:26.603] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9022825343716596256:41:0)
[15:20:26.603] Timer tick, asking Buildbucket for the build status
[15:20:26.962] Build 8857395254933587968: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:20:26.962] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9022825343716596256:42:0) after 1m0s
[15:21:27.019] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9022825343716596256:42:0)
[15:21:27.019] Timer tick, asking Buildbucket for the build status
[15:21:27.299] Build 8857395254933587968: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:21:27.299] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9022825343716596256:43:0) after 1m0s
[15:22:27.330] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9022825343716596256:43:0)
[15:22:27.330] Timer tick, asking Buildbucket for the build status
[15:22:27.451] Build 8857395254933587968: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:22:27.451] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9022825343716596256:44:0) after 1m0s
[15:23:27.472] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9022825343716596256:44:0)
[15:23:27.472] Timer tick, asking Buildbucket for the build status
[15:23:27.753] Build 8857395254933587968: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:23:27.753] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9022825343716596256:45:0) after 1m0s
[15:24:27.852] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9022825343716596256:45:0)
[15:24:27.852] Timer tick, asking Buildbucket for the build status
[15:24:27.956] Build 8857395254933587968: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:24:27.956] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9022825343716596256:46:0) after 1m0s
[15:25:28.034] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9022825343716596256:46:0)
[15:25:28.034] Timer tick, asking Buildbucket for the build status
[15:25:28.129] Build 8857395254933587968: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:25:28.129] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9022825343716596256:47:0) after 1m0s
[15:26:28.151] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9022825343716596256:47:0)
[15:26:28.151] Timer tick, asking Buildbucket for the build status
[15:26:28.208] Build 8857395254933587968: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:26:28.208] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9022825343716596256:48:0) after 1m0s
[15:27:28.242] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9022825343716596256:48:0)
[15:27:28.242] Timer tick, asking Buildbucket for the build status
[15:27:28.304] Build 8857395254933587968: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:27:28.304] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9022825343716596256:49:0) after 1m0s
[15:28:28.348] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9022825343716596256:49:0)
[15:28:28.348] Timer tick, asking Buildbucket for the build status
[15:28:28.441] Build 8857395254933587968: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:28:28.441] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9022825343716596256:50:0) after 1m0s
[15:29:28.490] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9022825343716596256:50:0)
[15:29:28.490] Timer tick, asking Buildbucket for the build status
[15:29:28.594] Build 8857395254933587968: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:29:28.594] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9022825343716596256:51:0) after 1m0s
[15:30:28.650] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9022825343716596256:51:0)
[15:30:28.650] Timer tick, asking Buildbucket for the build status
[15:30:28.734] Build 8857395254933587968: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:30:28.734] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9022825343716596256:52:0) after 1m0s
[15:31:28.888] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9022825343716596256:52:0)
[15:31:28.888] Timer tick, asking Buildbucket for the build status
[15:31:28.970] Build 8857395254933587968: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:31:28.970] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9022825343716596256:53:0) after 1m0s
[15:32:29.007] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9022825343716596256:53:0)
[15:32:29.007] Timer tick, asking Buildbucket for the build status
[15:32:29.222] Build 8857395254933587968: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:32:29.222] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9022825343716596256:54:0) after 1m0s
[15:33:29.358] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9022825343716596256:54:0)
[15:33:29.358] Timer tick, asking Buildbucket for the build status
[15:33:29.507] Build 8857395254933587968: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:33:29.507] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9022825343716596256:55:0) after 1m0s
[15:34:29.595] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9022825343716596256:55:0)
[15:34:29.595] Timer tick, asking Buildbucket for the build status
[15:34:30.128] Build 8857395254933587968: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:34:30.128] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9022825343716596256:56:0) after 1m0s
[15:35:30.261] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9022825343716596256:56:0)
[15:35:30.261] Timer tick, asking Buildbucket for the build status
[15:35:30.449] Build 8857395254933587968: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:35:30.449] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9022825343716596256:57:0) after 1m0s
[15:36:30.454] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9022825343716596256:57:0)
[15:36:30.454] Timer tick, asking Buildbucket for the build status
[15:36:31.239] Build 8857395254933587968: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:36:31.239] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9022825343716596256:58:0) after 1m0s
[15:37:31.445] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9022825343716596256:58:0)
[15:37:31.445] Timer tick, asking Buildbucket for the build status
[15:37:31.627] Build 8857395254933587968: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:37:31.627] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9022825343716596256:59:0) after 1m0s
[15:38:31.831] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9022825343716596256:59:0)
[15:38:31.831] Timer tick, asking Buildbucket for the build status
[15:38:32.017] Build 8857395254933587968: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:38:32.017] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9022825343716596256:60:0) after 1m0s
[15:39:31.996] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9022825343716596256:60:0)
[15:39:31.996] Timer tick, asking Buildbucket for the build status
[15:39:32.100] Build 8857395254933587968: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:39:32.100] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9022825343716596256:61:0) after 1m0s
[15:40:32.158] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9022825343716596256:61:0)
[15:40:32.158] Timer tick, asking Buildbucket for the build status
[15:40:32.452] Build 8857395254933587968: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:40:32.452] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9022825343716596256:62:0) after 1m0s
[15:41:32.526] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9022825343716596256:62:0)
[15:41:32.526] Timer tick, asking Buildbucket for the build status
[15:41:33.094] Build 8857395254933587968: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:41:33.094] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9022825343716596256:63:0) after 1m0s
[15:42:33.157] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9022825343716596256:63:0)
[15:42:33.157] Timer tick, asking Buildbucket for the build status
[15:42:33.216] Build 8857395254933587968: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:42:33.216] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9022825343716596256:64:0) after 1m0s
[15:43:33.438] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9022825343716596256:64:0)
[15:43:33.438] Timer tick, asking Buildbucket for the build status
[15:43:33.725] Build 8857395254933587968: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:43:33.725] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9022825343716596256:65:0) after 1m0s
[15:44:33.810] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9022825343716596256:65:0)
[15:44:33.810] Timer tick, asking Buildbucket for the build status
[15:44:33.925] Build 8857395254933587968: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:44:33.925] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9022825343716596256:66:0) after 1m0s
[15:45:33.949] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9022825343716596256:66:0)
[15:45:33.949] Timer tick, asking Buildbucket for the build status
[15:45:34.119] Build 8857395254933587968: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:45:34.119] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9022825343716596256:67:0) after 1m0s
[15:46:34.170] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9022825343716596256:67:0)
[15:46:34.170] Timer tick, asking Buildbucket for the build status
[15:46:34.320] Build 8857395254933587968: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:46:34.320] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9022825343716596256:68:0) after 1m0s
[15:47:34.457] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9022825343716596256:68:0)
[15:47:34.458] Timer tick, asking Buildbucket for the build status
[15:47:34.521] Build 8857395254933587968: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:47:34.521] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9022825343716596256:69:0) after 1m0s
[15:48:34.670] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9022825343716596256:69:0)
[15:48:34.670] Timer tick, asking Buildbucket for the build status
[15:48:34.793] Build 8857395254933587968: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:48:34.793] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9022825343716596256:70:0) after 1m0s
[15:49:34.934] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9022825343716596256:70:0)
[15:49:34.934] Timer tick, asking Buildbucket for the build status
[15:49:35.079] Build 8857395254933587968: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:49:35.079] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9022825343716596256:71:0) after 1m0s
[15:50:35.189] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9022825343716596256:71:0)
[15:50:35.189] Timer tick, asking Buildbucket for the build status
[15:50:35.260] Build 8857395254933587968: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:50:35.260] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9022825343716596256:72:0) after 1m0s
[15:51:35.338] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9022825343716596256:72:0)
[15:51:35.338] Timer tick, asking Buildbucket for the build status
[15:51:35.451] Build 8857395254933587968: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:51:35.451] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9022825343716596256:73:0) after 1m0s
[15:52:35.594] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9022825343716596256:73:0)
[15:52:35.594] Timer tick, asking Buildbucket for the build status
[15:52:35.692] Build 8857395254933587968: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:52:35.692] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9022825343716596256:74:0) after 1m0s
[15:53:35.970] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9022825343716596256:74:0)
[15:53:35.970] Timer tick, asking Buildbucket for the build status
[15:53:36.046] Build 8857395254933587968: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:53:36.046] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9022825343716596256:75:0) after 1m0s
[15:54:36.165] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9022825343716596256:75:0)
[15:54:36.165] Timer tick, asking Buildbucket for the build status
[15:54:36.393] Build 8857395254933587968: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:54:36.394] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9022825343716596256:76:0) after 1m0s
[15:55:36.493] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9022825343716596256:76:0)
[15:55:36.493] Timer tick, asking Buildbucket for the build status
[15:55:37.825] Build 8857395254933587968: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:55:37.825] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9022825343716596256:77:0) after 1m0s
[15:56:37.856] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9022825343716596256:77:0)
[15:56:37.856] Timer tick, asking Buildbucket for the build status
[15:56:38.262] Build 8857395254933587968: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:56:38.262] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9022825343716596256:78:0) after 1m0s
[15:57:38.415] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9022825343716596256:78:0)
[15:57:38.415] Timer tick, asking Buildbucket for the build status
[15:57:38.501] Build 8857395254933587968: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:57:38.501] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9022825343716596256:79:0) after 1m0s
[15:58:38.563] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9022825343716596256:79:0)
[15:58:38.563] Timer tick, asking Buildbucket for the build status
[15:58:39.023] Build 8857395254933587968: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:58:39.023] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9022825343716596256:80:0) after 1m0s
[15:59:39.057] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9022825343716596256:80:0)
[15:59:39.057] Timer tick, asking Buildbucket for the build status
[15:59:39.215] Build 8857395254933587968: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:59:39.215] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9022825343716596256:81:0) after 1m0s
[16:00:39.286] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9022825343716596256:81:0)
[16:00:39.286] Timer tick, asking Buildbucket for the build status
[16:00:39.986] Build 8857395254933587968: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:00:39.986] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9022825343716596256:82:0) after 1m0s
[16:01:40.116] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9022825343716596256:82:0)
[16:01:40.116] Timer tick, asking Buildbucket for the build status
[16:01:40.407] Build 8857395254933587968: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:01:40.407] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9022825343716596256:83:0) after 1m0s
[16:02:40.517] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9022825343716596256:83:0)
[16:02:40.517] Timer tick, asking Buildbucket for the build status
[16:02:40.587] Build 8857395254933587968: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:02:40.587] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9022825343716596256:84:0) after 1m0s
[16:03:40.782] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9022825343716596256:84:0)
[16:03:40.782] Timer tick, asking Buildbucket for the build status
[16:03:41.019] Build 8857395254933587968: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:03:41.020] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9022825343716596256:85:0) after 1m0s
[16:04:41.057] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9022825343716596256:85:0)
[16:04:41.057] Timer tick, asking Buildbucket for the build status
[16:04:41.185] Build 8857395254933587968: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:04:41.185] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9022825343716596256:86:0) after 1m0s
[16:05:41.431] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9022825343716596256:86:0)
[16:05:41.431] Timer tick, asking Buildbucket for the build status
[16:05:41.520] Build 8857395254933587968: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:05:41.520] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9022825343716596256:87:0) after 1m0s
[16:06:41.591] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9022825343716596256:87:0)
[16:06:41.591] Timer tick, asking Buildbucket for the build status
[16:06:41.718] Build 8857395254933587968: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:06:41.718] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9022825343716596256:88:0) after 1m0s
[16:07:41.818] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9022825343716596256:88:0)
[16:07:41.818] Timer tick, asking Buildbucket for the build status
[16:07:42.126] Build 8857395254933587968: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:07:42.126] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9022825343716596256:89:0) after 1m0s
[16:08:42.185] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9022825343716596256:89:0)
[16:08:42.185] Timer tick, asking Buildbucket for the build status
[16:08:42.259] Build 8857395254933587968: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:08:42.259] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9022825343716596256:90:0) after 1m0s
[16:09:42.339] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9022825343716596256:90:0)
[16:09:42.339] Timer tick, asking Buildbucket for the build status
[16:09:42.477] Build 8857395254933587968: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:09:42.477] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9022825343716596256:91:0) after 1m0s
[16:10:42.613] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9022825343716596256:91:0)
[16:10:42.613] Timer tick, asking Buildbucket for the build status
[16:10:42.703] Build 8857395254933587968: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:10:42.703] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9022825343716596256:92:0) after 1m0s
[16:11:42.822] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9022825343716596256:92:0)
[16:11:42.822] Timer tick, asking Buildbucket for the build status
[16:11:43.004] Build 8857395254933587968: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:11:43.004] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9022825343716596256:93:0) after 1m0s
[16:12:43.172] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9022825343716596256:93:0)
[16:12:43.172] Timer tick, asking Buildbucket for the build status
[16:12:43.248] Build 8857395254933587968: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:12:43.248] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9022825343716596256:94:0) after 1m0s
[16:13:43.304] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9022825343716596256:94:0)
[16:13:43.304] Timer tick, asking Buildbucket for the build status
[16:13:43.527] Build 8857395254933587968: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:13:43.527] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9022825343716596256:95:0) after 1m0s
[16:14:43.506] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9022825343716596256:95:0)
[16:14:43.506] Timer tick, asking Buildbucket for the build status
[16:14:43.797] Build 8857395254933587968: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:14:43.797] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9022825343716596256:96:0) after 1m0s
[16:15:43.863] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9022825343716596256:96:0)
[16:15:43.863] Timer tick, asking Buildbucket for the build status
[16:15:43.943] Build 8857395254933587968: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:15:43.943] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9022825343716596256:97:0) after 1m0s
[16:16:44.003] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9022825343716596256:97:0)
[16:16:44.003] Timer tick, asking Buildbucket for the build status
[16:16:45.304] Build 8857395254933587968: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:16:45.304] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9022825343716596256:98:0) after 1m0s
[16:17:45.386] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9022825343716596256:98:0)
[16:17:45.386] Timer tick, asking Buildbucket for the build status
[16:17:45.462] Build 8857395254933587968: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:17:45.462] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9022825343716596256:99:0) after 1m0s
[16:18:45.588] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9022825343716596256:99:0)
[16:18:45.588] Timer tick, asking Buildbucket for the build status
[16:18:45.715] Build 8857395254933587968: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:18:45.715] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9022825343716596256:100:0) after 1m0s
[16:19:45.801] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9022825343716596256:100:0)
[16:19:45.801] Timer tick, asking Buildbucket for the build status
[16:19:45.950] Build 8857395254933587968: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:19:45.950] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9022825343716596256:101:0) after 1m0s
[16:20:45.997] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9022825343716596256:101:0)
[16:20:45.997] Timer tick, asking Buildbucket for the build status
[16:20:46.073] Build 8857395254933587968: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:20:46.073] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9022825343716596256:102:0) after 1m0s
[16:21:46.155] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9022825343716596256:102:0)
[16:21:46.155] Timer tick, asking Buildbucket for the build status
[16:21:46.360] Build 8857395254933587968: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:21:46.360] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9022825343716596256:103:0) after 1m0s
[16:22:46.424] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9022825343716596256:103:0)
[16:22:46.424] Timer tick, asking Buildbucket for the build status
[16:22:46.498] Build 8857395254933587968: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:22:46.498] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9022825343716596256:104:0) after 1m0s
[16:23:46.614] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9022825343716596256:104:0)
[16:23:46.614] Timer tick, asking Buildbucket for the build status
[16:23:46.910] Build 8857395254933587968: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:23:46.910] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9022825343716596256:105:0) after 1m0s
[16:24:47.494] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9022825343716596256:105:0)
[16:24:47.494] Timer tick, asking Buildbucket for the build status
[16:24:47.855] Build 8857395254933587968: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:24:47.855] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9022825343716596256:106:0) after 1m0s
[16:25:48.168] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9022825343716596256:106:0)
[16:25:48.168] Timer tick, asking Buildbucket for the build status
[16:25:48.284] Build 8857395254933587968: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:25:48.284] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9022825343716596256:107:0) after 1m0s
[16:26:48.543] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9022825343716596256:107:0)
[16:26:48.543] Timer tick, asking Buildbucket for the build status
[16:26:48.652] Build 8857395254933587968: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:26:48.652] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9022825343716596256:108:0) after 1m0s
[16:27:48.854] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9022825343716596256:108:0)
[16:27:48.854] Timer tick, asking Buildbucket for the build status
[16:27:48.929] Build 8857395254933587968: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:27:48.929] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9022825343716596256:109:0) after 1m0s
[16:28:49.222] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9022825343716596256:109:0)
[16:28:49.222] Timer tick, asking Buildbucket for the build status
[16:28:49.570] Build 8857395254933587968: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:28:49.570] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9022825343716596256:110:0) after 1m0s
[16:29:49.729] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9022825343716596256:110:0)
[16:29:49.729] Timer tick, asking Buildbucket for the build status
[16:29:50.222] Build 8857395254933587968: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:29:50.222] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9022825343716596256:111:0) after 1m0s
[16:30:50.258] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9022825343716596256:111:0)
[16:30:50.258] Timer tick, asking Buildbucket for the build status
[16:30:50.701] Build 8857395254933587968: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:30:50.701] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9022825343716596256:112:0) after 1m0s
[16:31:50.798] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9022825343716596256:112:0)
[16:31:50.798] Timer tick, asking Buildbucket for the build status
[16:31:50.940] Build 8857395254933587968: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:31:50.941] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9022825343716596256:113:0) after 1m0s
[16:32:51.048] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9022825343716596256:113:0)
[16:32:51.048] Timer tick, asking Buildbucket for the build status
[16:32:51.132] Build 8857395254933587968: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:32:51.132] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9022825343716596256:114:0) after 1m0s
[16:33:51.178] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9022825343716596256:114:0)
[16:33:51.178] Timer tick, asking Buildbucket for the build status
[16:33:51.273] Build 8857395254933587968: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:33:51.273] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9022825343716596256:115:0) after 1m0s
[16:34:51.321] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9022825343716596256:115:0)
[16:34:51.321] Timer tick, asking Buildbucket for the build status
[16:34:51.463] Build 8857395254933587968: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:34:51.463] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9022825343716596256:116:0) after 1m0s
[16:35:51.554] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9022825343716596256:116:0)
[16:35:51.554] Timer tick, asking Buildbucket for the build status
[16:35:51.746] Build 8857395254933587968: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:35:51.746] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9022825343716596256:117:0) after 1m0s
[16:36:51.851] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9022825343716596256:117:0)
[16:36:51.851] Timer tick, asking Buildbucket for the build status
[16:36:52.384] Build 8857395254933587968: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:36:52.384] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9022825343716596256:118:0) after 1m0s
[16:37:52.541] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9022825343716596256:118:0)
[16:37:52.541] Timer tick, asking Buildbucket for the build status
[16:37:53.009] Build 8857395254933587968: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:37:53.009] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9022825343716596256:119:0) after 1m0s
[16:38:53.061] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9022825343716596256:119:0)
[16:38:53.061] Timer tick, asking Buildbucket for the build status
[16:38:53.371] Build 8857395254933587968: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:38:53.371] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9022825343716596256:120:0) after 1m0s
[16:39:53.445] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9022825343716596256:120:0)
[16:39:53.445] Timer tick, asking Buildbucket for the build status
[16:39:53.642] Build 8857395254933587968: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:39:53.642] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9022825343716596256:121:0) after 1m0s
[16:40:53.786] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9022825343716596256:121:0)
[16:40:53.786] Timer tick, asking Buildbucket for the build status
[16:40:54.061] Build 8857395254933587968: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:40:54.061] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9022825343716596256:122:0) after 1m0s
[16:41:54.139] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9022825343716596256:122:0)
[16:41:54.139] Timer tick, asking Buildbucket for the build status
[16:41:54.223] Build 8857395254933587968: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:41:54.223] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9022825343716596256:123:0) after 1m0s
[16:42:54.266] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9022825343716596256:123:0)
[16:42:54.266] Timer tick, asking Buildbucket for the build status
[16:42:54.345] Build 8857395254933587968: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:42:54.345] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9022825343716596256:124:0) after 1m0s
[16:43:54.468] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9022825343716596256:124:0)
[16:43:54.468] Timer tick, asking Buildbucket for the build status
[16:43:54.561] Build 8857395254933587968: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:43:54.561] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9022825343716596256:125:0) after 1m0s
[16:44:54.657] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9022825343716596256:125:0)
[16:44:54.657] Timer tick, asking Buildbucket for the build status
[16:44:54.793] Build 8857395254933587968: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:44:54.793] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9022825343716596256:126:0) after 1m0s
[16:45:54.863] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9022825343716596256:126:0)
[16:45:54.863] Timer tick, asking Buildbucket for the build status
[16:45:54.983] Build 8857395254933587968: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:45:54.983] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9022825343716596256:127:0) after 1m0s
[16:46:55.173] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9022825343716596256:127:0)
[16:46:55.173] Timer tick, asking Buildbucket for the build status
[16:46:55.266] Build 8857395254933587968: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:46:55.266] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9022825343716596256:128:0) after 1m0s
[16:47:55.352] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9022825343716596256:128:0)
[16:47:55.352] Timer tick, asking Buildbucket for the build status
[16:47:55.442] Build 8857395254933587968: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:47:55.442] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9022825343716596256:129:0) after 1m0s
[16:48:55.492] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9022825343716596256:129:0)
[16:48:55.492] Timer tick, asking Buildbucket for the build status
[16:48:55.628] Build 8857395254933587968: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:48:55.628] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9022825343716596256:130:0) after 1m0s
[16:49:55.670] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9022825343716596256:130:0)
[16:49:55.670] Timer tick, asking Buildbucket for the build status
[16:49:55.781] Build 8857395254933587968: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:49:55.781] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9022825343716596256:131:0) after 1m0s
[16:50:55.875] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9022825343716596256:131:0)
[16:50:55.875] Timer tick, asking Buildbucket for the build status
[16:50:56.205] Build 8857395254933587968: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:50:56.205] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9022825343716596256:132:0) after 1m0s
[16:51:56.289] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9022825343716596256:132:0)
[16:51:56.289] Timer tick, asking Buildbucket for the build status
[16:51:56.371] Build 8857395254933587968: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:51:56.371] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9022825343716596256:133:0) after 1m0s
[16:52:56.523] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9022825343716596256:133:0)
[16:52:56.523] Timer tick, asking Buildbucket for the build status
[16:52:56.602] Build 8857395254933587968: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:52:56.602] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9022825343716596256:134:0) after 1m0s
[16:53:56.690] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9022825343716596256:134:0)
[16:53:56.690] Timer tick, asking Buildbucket for the build status
[16:53:57.093] Build 8857395254933587968: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:53:57.093] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9022825343716596256:135:0) after 1m0s
[16:54:57.162] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9022825343716596256:135:0)
[16:54:57.162] Timer tick, asking Buildbucket for the build status
[16:54:57.290] Build 8857395254933587968: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:54:57.290] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9022825343716596256:136:0) after 1m0s
[16:55:57.422] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9022825343716596256:136:0)
[16:55:57.422] Timer tick, asking Buildbucket for the build status
[16:55:57.548] Build 8857395254933587968: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:55:57.548] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9022825343716596256:137:0) after 1m0s
[16:56:57.600] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9022825343716596256:137:0)
[16:56:57.600] Timer tick, asking Buildbucket for the build status
[16:56:57.661] Build 8857395254933587968: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:56:57.661] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9022825343716596256:138:0) after 1m0s
[16:57:57.719] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9022825343716596256:138:0)
[16:57:57.719] Timer tick, asking Buildbucket for the build status
[16:57:58.454] Build 8857395254933587968: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:57:58.454] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9022825343716596256:139:0) after 1m0s
[16:58:58.541] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9022825343716596256:139:0)
[16:58:58.541] Timer tick, asking Buildbucket for the build status
[16:58:58.661] Build 8857395254933587968: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:58:58.661] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9022825343716596256:140:0) after 1m0s
[16:59:58.726] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9022825343716596256:140:0)
[16:59:58.726] Timer tick, asking Buildbucket for the build status
[16:59:58.890] Build 8857395254933587968: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:59:58.890] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9022825343716596256:141:0) after 1m0s
[17:00:58.961] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9022825343716596256:141:0)
[17:00:58.961] Timer tick, asking Buildbucket for the build status
[17:00:59.506] Build 8857395254933587968: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:00:59.506] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9022825343716596256:142:0) after 1m0s
[17:01:59.728] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9022825343716596256:142:0)
[17:01:59.728] Timer tick, asking Buildbucket for the build status
[17:01:59.917] Build 8857395254933587968: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:01:59.917] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9022825343716596256:143:0) after 1m0s
[17:03:00.001] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9022825343716596256:143:0)
[17:03:00.002] Timer tick, asking Buildbucket for the build status
[17:03:00.333] Build 8857395254933587968: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:03:00.333] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9022825343716596256:144:0) after 1m0s
[17:04:00.444] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9022825343716596256:144:0)
[17:04:00.444] Timer tick, asking Buildbucket for the build status
[17:04:00.825] Build 8857395254933587968: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:04:00.825] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9022825343716596256:145:0) after 1m0s
[17:05:00.973] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9022825343716596256:145:0)
[17:05:00.973] Timer tick, asking Buildbucket for the build status
[17:05:01.532] Build 8857395254933587968: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:05:01.532] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9022825343716596256:146:0) after 1m0s
[17:06:01.605] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9022825343716596256:146:0)
[17:06:01.605] Timer tick, asking Buildbucket for the build status
[17:06:04.345] Build 8857395254933587968: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:06:04.345] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9022825343716596256:147:0) after 1m0s
[17:07:04.466] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9022825343716596256:147:0)
[17:07:04.466] Timer tick, asking Buildbucket for the build status
[17:07:04.670] Build 8857395254933587968: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:07:04.670] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9022825343716596256:148:0) after 1m0s
[17:08:04.773] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9022825343716596256:148:0)
[17:08:04.773] Timer tick, asking Buildbucket for the build status
[17:08:05.027] Build 8857395254933587968: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:08:05.027] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9022825343716596256:149:0) after 1m0s
[17:09:05.069] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9022825343716596256:149:0)
[17:09:05.070] Timer tick, asking Buildbucket for the build status
[17:09:05.530] Build 8857395254933587968: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:09:05.530] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9022825343716596256:150:0) after 1m0s
[17:10:05.572] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9022825343716596256:150:0)
[17:10:05.572] Timer tick, asking Buildbucket for the build status
[17:10:06.107] Build 8857395254933587968: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:10:06.108] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9022825343716596256:151:0) after 1m0s
[17:11:06.192] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9022825343716596256:151:0)
[17:11:06.192] Timer tick, asking Buildbucket for the build status
[17:11:06.528] Build 8857395254933587968: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:11:06.528] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9022825343716596256:152:0) after 1m0s
[17:12:06.605] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9022825343716596256:152:0)
[17:12:06.605] Timer tick, asking Buildbucket for the build status
[17:12:06.836] Build 8857395254933587968: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:12:06.836] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9022825343716596256:153:0) after 1m0s
[17:13:06.891] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9022825343716596256:153:0)
[17:13:06.891] Timer tick, asking Buildbucket for the build status
[17:13:06.972] Build 8857395254933587968: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:13:06.972] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9022825343716596256:154:0) after 1m0s
[17:14:06.980] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9022825343716596256:154:0)
[17:14:06.980] Timer tick, asking Buildbucket for the build status
[17:14:07.083] Build 8857395254933587968: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:14:07.083] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9022825343716596256:155:0) after 1m0s
[17:15:07.153] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9022825343716596256:155:0)
[17:15:07.153] Timer tick, asking Buildbucket for the build status
[17:15:07.303] Build 8857395254933587968: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:15:07.303] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9022825343716596256:156:0) after 1m0s
[17:16:07.475] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9022825343716596256:156:0)
[17:16:07.475] Timer tick, asking Buildbucket for the build status
[17:16:07.598] Build 8857395254933587968: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:16:07.598] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9022825343716596256:157:0) after 1m0s
[17:17:07.791] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9022825343716596256:157:0)
[17:17:07.791] Timer tick, asking Buildbucket for the build status
[17:17:07.897] Build 8857395254933587968: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:17:07.897] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9022825343716596256:158:0) after 1m0s
[17:18:08.000] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9022825343716596256:158:0)
[17:18:08.000] Timer tick, asking Buildbucket for the build status
[17:18:08.076] Build 8857395254933587968: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:18:08.076] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9022825343716596256:159:0) after 1m0s
[17:19:08.162] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9022825343716596256:159:0)
[17:19:08.162] Timer tick, asking Buildbucket for the build status
[17:19:08.256] Build 8857395254933587968: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:19:08.256] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9022825343716596256:160:0) after 1m0s
[17:20:08.444] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9022825343716596256:160:0)
[17:20:08.444] Timer tick, asking Buildbucket for the build status
[17:20:08.638] Build 8857395254933587968: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:20:08.639] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9022825343716596256:161:0) after 1m0s
[17:21:08.705] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9022825343716596256:161:0)
[17:21:08.705] Timer tick, asking Buildbucket for the build status
[17:21:08.784] Build 8857395254933587968: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:21:08.784] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9022825343716596256:162:0) after 1m0s
[17:22:09.015] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9022825343716596256:162:0)
[17:22:09.015] Timer tick, asking Buildbucket for the build status
[17:22:09.353] Build 8857395254933587968: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:22:09.353] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9022825343716596256:163:0) after 1m0s
[17:23:09.499] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9022825343716596256:163:0)
[17:23:09.502] Timer tick, asking Buildbucket for the build status
[17:23:09.618] Build 8857395254933587968: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:23:09.618] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9022825343716596256:164:0) after 1m0s
[17:24:09.793] Handling timer "check-buildbucket-build-status" (chromium/Linux CFI:9022825343716596256:164:0)
[17:24:09.793] Timer tick, asking Buildbucket for the build status
[17:24:09.909] Build 8857395254933587968: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:24:09.909] Scheduling timer "check-buildbucket-build-status" (chromium/Linux CFI:9022825343716596256:165:0) after 1m0s
[17:25:01.242] Received PubSub notification, asking Buildbucket for the build status
[17:25:01.361] Build 8857395254933587968: status "COMPLETED", result "SUCCESS", failure_reason "", cancelation_reason ""
[17:25:01.361] Buildbucket build:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "PROD",
"completed_ts": "1611336299361973",
"created_by": "project:chromium",
"created_ts": "1611326657319326",
"id": "8857395254933587968",
"parameters_json": "{\"builder_name\": \"Linux CFI\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"b1f88a5efa581b0f735d042c505dadc0fd155b38\"}}",
"project": "chromium",
"result": "SUCCESS",
"result_details_json": "{\"properties\": {\"$build/goma\": {\"enable_ats\": true, \"jobs\": 500.0, \"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\": \"b1f88a5efa581b0f735d042c505dadc0fd155b38\", \"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-32-1-qijo\", \"branch\": \"refs/heads/master\", \"builder_group\": \"chromium.memory\", \"buildername\": \"Linux CFI\", \"buildnumber\": 19538, \"got_angle_revision\": \"c827ccbb58b8ceef91628527bad74fc90b135b61\", \"got_dawn_revision\": \"72cd1a5e8953292dd97c4006973850c880d39db8\", \"got_nacl_revision\": \"cb31feffa500401c95c6c44d88b7c358236bca36\", \"got_revision\": \"b1f88a5efa581b0f735d042c505dadc0fd155b38\", \"got_revision_cp\": \"refs/heads/master@{#846104}\", \"got_swarming_client_revision\": \"1a072711d4388c62e02480fabc26c68c24494be9\", \"got_swiftshader_revision\": \"1d5174b9dc3be500d63daf227b163b5e86bbc7b5\", \"got_v8_revision\": \"fbab010f750a89cd201b80da97f378dadde58ff4\", \"got_v8_revision_cp\": \"refs/heads/9.0.50@{#1}\", \"got_webrtc_revision\": \"11215febb9500c597c940a40f1b9fe86c939413f\", \"got_webrtc_revision_cp\": \"refs/heads/master@{#33056}\", \"isolate_server\": \"https://isolateserver.appspot.com\", \"mirrored_builders\": [\"tryserver.chromium.linux:linux_chromium_cfi_rel_ng\"], \"path_config\": \"generic\", \"recipe\": \"chromium\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"b1f88a5efa581b0f735d042c505dadc0fd155b38\", \"swarm_hashes_refs/heads/master(at){#846104}_without_patch\": {\"absl_hardening_tests\": \"321de62fe0762564610158371fb022688bdb800b\", \"accessibility_unittests\": \"19735165163735ef484bd4298fb3995628db88c8\", \"angle_unittests\": \"6f12d7d939fbccc687c42440ef8795d6904a0fb1\", \"app_shell_unittests\": \"a2f22908b0a3efc98eb4661d569b0c6ba9dea9e7\", \"aura_unittests\": \"da43845487ed533df6a202a04450aabc9eb57771\", \"base_unittests\": \"0e00d07cd910d9e3369c77d27b247cdad861a543\", \"base_util_unittests\": \"2e93ea131f9229c98d29aa60e3ca36fb75685aa2\", \"blink_common_unittests\": \"0633f523737f8e53d9d8bb1e34e9e3fa449d303f\", \"blink_fuzzer_unittests\": \"0e2451f25fb2e1ca92bccde44e6821e197d966d4\", \"blink_heap_unittests\": \"401b195ca1a2aeda3eafff86f5b87abd7d7a573c\", \"blink_platform_unittests\": \"26b59d064bff51b6f7b30481fb91c39448260631\", \"blink_unittests\": \"cb6155e55be388811434d4895543da44ad0751ab\", \"boringssl_crypto_tests\": \"13ac673e3bbddd99a6fc42db5d12fc52ae8ec99e\", \"boringssl_ssl_tests\": \"3a53980c6a7907f9b7e2c577ea6223543a3cfa6a\", \"browser_tests\": \"7741af0b1bce85475921dbba41540a7db9aa4ddf\", \"capture_unittests\": \"e5bf8f66ebff18bb69f2e218692e71a64dd2a65a\", \"cast_unittests\": \"75d1d25e2e3fa9d54df3b2452219eeee27590e20\", \"cc_unittests\": \"1bbfcaba09b69c4b5369c6b90b0b41926ad9cf12\", \"chrome_app_unittests\": \"6334b3b27851e0d905b638f46de46cf76aa5256b\", \"chromedriver_unittests\": \"d5df10f312052006dbbbdd6e8498d248978661cf\", \"components_browsertests\": \"c31b59a6195d9202e3f075581c012afc2069a4ea\", \"components_unittests\": \"b489d333800d5d0b94004f3a3e82f08eff7a15c5\", \"compositor_unittests\": \"5aba31a0faac4239ad4854bd211435c9841c71d7\", \"content_browsertests\": \"35258367295cdf32e5cd6ac8ccfccf9f0af7600f\", \"content_unittests\": \"7654d225b171051ab1d7efb776935263765a8195\", \"cronet_tests\": \"914140c67d187bd59f9574eccf608813827e36a0\", \"cronet_unittests\": \"b154b1f21ae9439d3d69e8e01a98126b5fdcbe11\", \"crypto_unittests\": \"251e2086f1110200a7e6b3523be8f2624b0df419\", \"dbus_unittests\": \"058f37b3123841046d941d90d17d1fb90dc9dc83\", \"device_unittests\": \"83f36290b05df64dbd106a1e791f4928d19e322c\", \"display_unittests\": \"1e58586530e2ef89776a06785de473e3469bb1a1\", \"events_unittests\": \"aa2910cfc9b977ca26e98bf9dc3a67c366bb3264\", \"extensions_browsertests\": \"024200c665b371a6f7e455f641e33ccebea80729\", \"extensions_unittests\": \"9ea79ab8f330c938365ea8c14175239bd43c4a31\", \"filesystem_service_unittests\": \"51422c8102ee8c9c29fe74536fc73f720c47fd07\", \"gcm_unit_tests\": \"5b45f357fbc2ef2daf54b9674c0d88454285f570\", \"gfx_unittests\": \"e2c63c124adbb64be6d57d9b750dbf8d183949f0\", \"gin_unittests\": \"9df39268ce5587c1ddd7ad0d4e85b12ca3a2726e\", \"gl_tests\": \"b2c3215da95687e3878ed40e8dbf920dc37cd7f7\", \"gl_unittests\": \"e9456653bc6d6b3ac1baf21f115da397a216c961\", \"google_apis_unittests\": \"eef69cf032740d3f134bf18654632a7296c58c39\", \"gpu_unittests\": \"dcd9e45c61c631d98af830f5fe2e5eea3a9177b7\", \"gwp_asan_unittests\": \"51f9431582eb2d9d34c1f35a447318d551fd5ef5\", \"headless_browsertests\": \"d7bee99d724de0b19611a0c82b2aeaab6f32ffb3\", \"headless_unittests\": \"fe787c980317a735b7d9299c3df00a3ad9bd1d69\", \"interactive_ui_tests\": \"0d25a843dd18b4c3ab39e3348325bbe52e790dda\", \"ipc_tests\": \"93c9a652a7d883a76949990b6178b0cc382fa547\", \"jingle_unittests\": \"cc18600156896532ccc5497d19007efd993981c1\", \"latency_unittests\": \"5065d151bbbc96787bd8aa5a657ff2c2e7769886\", \"libjingle_xmpp_unittests\": \"ab64157d8c43cb2c041484f93e7487b27bd6461f\", \"liburlpattern_unittests\": \"436b79fbaa6cecfbaa9146af02ef5db0341445b2\", \"media_blink_unittests\": \"8c768263965b7d151c179198d85abb90cf7c4a34\", \"media_unittests\": \"62911f8a260fd16416291b7b2709990c5ce0fbd8\", \"message_center_unittests\": \"6864dfb83cad0d9b25bb7c2ec1a7d68923b4ee99\", \"midi_unittests\": \"3a9bef00753872f104e1ed69cbb3047e2cb30da6\", \"mojo_core_unittests\": \"d512b955cfc2f25e19aae766c213cd407461219c\", \"mojo_unittests\": \"9c99177b31b49b337b49e65b6132dc18ea82c383\", \"nacl_helper_nonsfi_unittests\": \"faa64c87da2cc529b4a8c132c24a8ba302168348\", \"nacl_loader_unittests\": \"317af225007dce398342e54b3412c4bb0d5ea551\", \"native_theme_unittests\": \"227056a41b3533eee92980e2a42c96650a423e36\", \"net_unittests\": \"bd7764ac68b789bb53a0f24e115901c281e736c6\", \"pdf_unittests\": \"10b613d0333322a87e719f948c2e73d47e8b4058\", \"perfetto_unittests\": \"bfeacf19b5c30bfe997b09db9100d0b77ef77b0f\", \"ppapi_unittests\": \"706c53f8b089a76674b66b85e050029795ec3827\", \"printing_unittests\": \"44014a0a56e98bf5fe09422efaf9228a8e24407d\", \"remoting_unittests\": \"c6def73fd9c3cc54256971204e6310e155daa7b7\", \"sandbox_linux_unittests\": \"adc9fb50b10709947ce78a1619095f2f65155ec8\", \"service_manager_unittests\": \"fe15e611447af98b4b37f25fd71780d886afe81b\", \"services_unittests\": \"2ed2d916b8c9aa161baf1535b3fbff83a1928c57\", \"shell_dialogs_unittests\": \"bca6cd33c4a87ca88e05b14841f57db620a2d566\", \"skia_unittests\": \"3c8e1fbd3cd08dc335ec27fa40c016031838a524\", \"snapshot_unittests\": \"3f05df0c2888af94b35c2631f8de1f7981e979d4\", \"sql_unittests\": \"ef40257b9e4b1f4a9669f2f5408709ceb960d190\", \"storage_unittests\": \"35f811f67ea29626e7e8f250857ac927dcf68f8b\", \"sync_integration_tests\": \"63c041d11df660bc04cc49fd2a6cdce97794199e\", \"traffic_annotation_auditor_unittests\": \"d581c034dc17e172a174c1942ca61ae2dfc3b39d\", \"ui_base_unittests\": \"407ac8fc6050363422f09e9239a7b76ce7a69dac\", \"ui_touch_selection_unittests\": \"23dfa7b628ab4a5dd7b83942871bd8b781175c17\", \"unit_tests\": \"af4db9a27b68c0f0d561f991e7e093fd7dcc61e6\", \"url_unittests\": \"0a5090b0a1b7c4077cf9a48277e8da69be4db9a9\", \"views_unittests\": \"c6585c3dbc1bdac3c8c11c18b6622de80d2685d7\", \"viz_unittests\": \"3468ec3485e00b170ee0312a50b18e5d0283d94d\", \"vr_common_unittests\": \"524f574dad63b6977f5e879f6922f42e0d79552b\", \"vr_pixeltests\": \"c7834592516e614f10bb14259901d7e222599776\", \"weblayer_browsertests\": \"c37286ab8605ba2252902b6bb6acac372b8fbc8b\", \"weblayer_unittests\": \"0b2d884ffda0720d6c6c93f31c6b71cc99669315\", \"wm_unittests\": \"f89d4e2cebfc6b8197fa710a572a3cd1b4002ed2\", \"wtf_unittests\": \"d79a1ec53775c2403ff69a3413b5424ab96f7a52\", \"x11_unittests\": \"5c91edf2317e41dbca59a7aa566351897f4cfce7\", \"xr_browser_tests\": \"9343aad636eea63df04405c7cf9aaaf3ee1ab4e9\", \"zlib_unittests\": \"1e04e16d1e252ea8d2e128af4ff1d89c27d93da0\"}}, \"swarming\": {\"bot_dimensions\": {\"builderless\": [\"1\"], \"caches\": [\"builder_094ae2b7d41fc2d72094b7b6da708c57b0f9cf30da4d1b138156f1458af77f67_v2\", \"builder_4546ef179f50eb727f19fe6abd7705a7b8921ff8263e4e2e8e2644dd615ef1a7_v2\", \"builder_61e4d25dfd74628f421fe7d90da475349672e571b4dfd9a5326b66319dc94b9e_v2\", \"git\", \"goma_v2\", \"vpython\"], \"cores\": [\"32\"], \"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-32-1-qijo\"], \"image\": [\"chrome-xenial-21011100-9488e34e558\"], \"inside_docker\": [\"0\"], \"kvm\": [\"1\"], \"locale\": [\"en_US.UTF-8\"], \"machine_type\": [\"e2-standard-32\"], \"os\": [\"Linux\", \"Ubuntu\", \"Ubuntu-16\", \"Ubuntu-16.04\", \"Ubuntu-16.04.6\"], \"pool\": [\"luci.chromium.ci\"], \"python\": [\"2.7.12\"], \"server_version\": [\"5671-1d9dea8\"], \"ssd\": [\"0\"], \"zone\": [\"us\", \"us-central\", \"us-central1\", \"us-central1-b\"]}}}",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"started_ts": "1611326666419756",
"status": "COMPLETED",
"status_changed_ts": "1611336299745483",
"tags": [
"build_address:luci.chromium.ci/Linux CFI/19538",
"builder:Linux CFI",
"buildset:commit/git/b1f88a5efa581b0f735d042c505dadc0fd155b38",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/b1f88a5efa581b0f735d042c505dadc0fd155b38",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9022825343716596256",
"scheduler_job_id:chromium/Linux CFI",
"swarming_hostname:chromium-swarm.appspot.com",
"swarming_tag:log_location:logdog://logs.chromium.org/chromium/buildbucket/cr-buildbucket.appspot.com/8857395254933587968/+/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:51435f1efd818b10",
"user_agent:luci-scheduler"
],
"updated_ts": "1611336299782616",
"url": "https://ci.chromium.org/b/8857395254933587968",
"utcnow_ts": "1611336301349673"
}
}
[17:25:01.361] Invocation finished in 2h41m10.875023508s with status SUCCEEDED