[22:25:22.373] New invocation is queued and will start shortly
[22:25:23.565] Starting the invocation (attempt 1)
[22:25:23.605] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[22:25:23.605] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[22:25:23.605] Buildbucket request:
{
"bucket": "luci.chromium.ci",
"client_operation_id": "9023068097586469760",
"parameters_json": "{\"builder_name\":\"ToTWin(dbg)\",\"properties\":{\"branch\":\"refs/heads/master\",\"repository\":\"https://chromium.googlesource.com/chromium/src\",\"revision\":\"1e2eb038e916a65476cc6d178913e2a2b8bc3b77\"}}",
"pubsub_callback": {
"auth_token": "...",
"topic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
},
"tags": [
"builder:ToTWin(dbg)",
"scheduler_invocation_id:9023068097586469760",
"scheduler_job_id:chromium/ToTWin(dbg)",
"user_agent:luci-scheduler",
"buildset:commit/git/1e2eb038e916a65476cc6d178913e2a2b8bc3b77",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/1e2eb038e916a65476cc6d178913e2a2b8bc3b77",
"gitiles_ref:refs/heads/master"
]
}
[22:25:24.472] Buildbucket response:
{
"build": {
"bucket": "luci.chromium.ci",
"canary": true,
"canary_preference": "CANARY",
"created_by": "project:chromium",
"created_ts": "1611095123705023",
"id": "8857638035524485856",
"parameters_json": "{\"builder_name\": \"ToTWin(dbg)\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"1e2eb038e916a65476cc6d178913e2a2b8bc3b77\"}}",
"project": "chromium",
"result_details_json": "{\"properties\": {}}",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"status": "SCHEDULED",
"status_changed_ts": "1611095124305488",
"tags": [
"build_address:luci.chromium.ci/ToTWin(dbg)/6430",
"builder:ToTWin(dbg)",
"buildset:commit/git/1e2eb038e916a65476cc6d178913e2a2b8bc3b77",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/1e2eb038e916a65476cc6d178913e2a2b8bc3b77",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9023068097586469760",
"scheduler_job_id:chromium/ToTWin(dbg)",
"swarming_hostname:chromium-swarm.appspot.com",
"swarming_tag:log_location:logdog://logs.chromium.org/chromium/buildbucket/cr-buildbucket.appspot.com/8857638035524485856/+/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": "1611095124305605",
"url": "https://ci.chromium.org/b/8857638035524485856",
"utcnow_ts": "1611095124464129"
}
}
[22:25:24.472] Task URL: https://ci.chromium.org/b/8857638035524485856
[22:25:24.472] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):9023068097586469760:2:0) after 1m0s
[22:26:13.051] Received PubSub notification, asking Buildbucket for the build status
[22:26:13.481] Build 8857638035524485856: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:26:24.532] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):9023068097586469760:2:0)
[22:26:24.532] Timer tick, asking Buildbucket for the build status
[22:26:24.644] Build 8857638035524485856: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:26:24.644] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):9023068097586469760:4:0) after 1m0s
[22:27:24.749] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):9023068097586469760:4:0)
[22:27:24.749] Timer tick, asking Buildbucket for the build status
[22:27:24.866] Build 8857638035524485856: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:27:24.866] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):9023068097586469760:5:0) after 1m0s
[22:28:24.899] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):9023068097586469760:5:0)
[22:28:24.899] Timer tick, asking Buildbucket for the build status
[22:28:25.204] Build 8857638035524485856: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:28:25.204] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):9023068097586469760:6:0) after 1m0s
[22:29:25.260] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):9023068097586469760:6:0)
[22:29:25.260] Timer tick, asking Buildbucket for the build status
[22:29:25.342] Build 8857638035524485856: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:29:25.342] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):9023068097586469760:7:0) after 1m0s
[22:30:25.468] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):9023068097586469760:7:0)
[22:30:25.468] Timer tick, asking Buildbucket for the build status
[22:30:25.562] Build 8857638035524485856: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:30:25.562] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):9023068097586469760:8:0) after 1m0s
[22:31:25.701] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):9023068097586469760:8:0)
[22:31:25.701] Timer tick, asking Buildbucket for the build status
[22:31:25.937] Build 8857638035524485856: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:31:25.937] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):9023068097586469760:9:0) after 1m0s
[22:32:26.025] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):9023068097586469760:9:0)
[22:32:26.025] Timer tick, asking Buildbucket for the build status
[22:32:26.503] Build 8857638035524485856: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:32:26.503] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):9023068097586469760:10:0) after 1m0s
[22:33:26.664] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):9023068097586469760:10:0)
[22:33:26.664] Timer tick, asking Buildbucket for the build status
[22:33:26.745] Build 8857638035524485856: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:33:26.745] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):9023068097586469760:11:0) after 1m0s
[22:34:26.976] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):9023068097586469760:11:0)
[22:34:26.976] Timer tick, asking Buildbucket for the build status
[22:34:27.069] Build 8857638035524485856: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:34:27.069] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):9023068097586469760:12:0) after 1m0s
[22:35:27.108] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):9023068097586469760:12:0)
[22:35:27.108] Timer tick, asking Buildbucket for the build status
[22:35:27.253] Build 8857638035524485856: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:35:27.253] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):9023068097586469760:13:0) after 1m0s
[22:36:27.331] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):9023068097586469760:13:0)
[22:36:27.331] Timer tick, asking Buildbucket for the build status
[22:36:27.444] Build 8857638035524485856: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:36:27.444] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):9023068097586469760:14:0) after 1m0s
[22:37:27.453] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):9023068097586469760:14:0)
[22:37:27.453] Timer tick, asking Buildbucket for the build status
[22:37:27.524] Build 8857638035524485856: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:37:27.524] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):9023068097586469760:15:0) after 1m0s
[22:38:27.625] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):9023068097586469760:15:0)
[22:38:27.625] Timer tick, asking Buildbucket for the build status
[22:38:27.971] Build 8857638035524485856: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:38:27.971] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):9023068097586469760:16:0) after 1m0s
[22:39:28.082] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):9023068097586469760:16:0)
[22:39:28.082] Timer tick, asking Buildbucket for the build status
[22:39:28.211] Build 8857638035524485856: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:39:28.212] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):9023068097586469760:17:0) after 1m0s
[22:40:28.338] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):9023068097586469760:17:0)
[22:40:28.338] Timer tick, asking Buildbucket for the build status
[22:40:28.487] Build 8857638035524485856: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:40:28.487] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):9023068097586469760:18:0) after 1m0s
[22:41:28.520] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):9023068097586469760:18:0)
[22:41:28.520] Timer tick, asking Buildbucket for the build status
[22:41:28.585] Build 8857638035524485856: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:41:28.585] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):9023068097586469760:19:0) after 1m0s
[22:42:28.660] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):9023068097586469760:19:0)
[22:42:28.660] Timer tick, asking Buildbucket for the build status
[22:42:28.747] Build 8857638035524485856: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:42:28.747] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):9023068097586469760:20:0) after 1m0s
[22:43:28.795] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):9023068097586469760:20:0)
[22:43:28.795] Timer tick, asking Buildbucket for the build status
[22:43:28.860] Build 8857638035524485856: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:43:28.860] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):9023068097586469760:21:0) after 1m0s
[22:44:28.890] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):9023068097586469760:21:0)
[22:44:28.890] Timer tick, asking Buildbucket for the build status
[22:44:29.293] Build 8857638035524485856: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:44:29.293] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):9023068097586469760:22:0) after 1m0s
[22:45:29.388] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):9023068097586469760:22:0)
[22:45:29.388] Timer tick, asking Buildbucket for the build status
[22:45:29.528] Build 8857638035524485856: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:45:29.528] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):9023068097586469760:23:0) after 1m0s
[22:46:29.615] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):9023068097586469760:23:0)
[22:46:29.615] Timer tick, asking Buildbucket for the build status
[22:46:29.824] Build 8857638035524485856: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:46:29.824] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):9023068097586469760:24:0) after 1m0s
[22:47:29.873] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):9023068097586469760:24:0)
[22:47:29.873] Timer tick, asking Buildbucket for the build status
[22:47:29.923] Build 8857638035524485856: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:47:29.923] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):9023068097586469760:25:0) after 1m0s
[22:48:30.024] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):9023068097586469760:25:0)
[22:48:30.024] Timer tick, asking Buildbucket for the build status
[22:48:30.153] Build 8857638035524485856: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:48:30.153] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):9023068097586469760:26:0) after 1m0s
[22:49:30.185] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):9023068097586469760:26:0)
[22:49:30.185] Timer tick, asking Buildbucket for the build status
[22:49:30.349] Build 8857638035524485856: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:49:30.349] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):9023068097586469760:27:0) after 1m0s
[22:50:30.361] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):9023068097586469760:27:0)
[22:50:30.361] Timer tick, asking Buildbucket for the build status
[22:50:30.474] Build 8857638035524485856: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:50:30.474] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):9023068097586469760:28:0) after 1m0s
[22:51:30.528] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):9023068097586469760:28:0)
[22:51:30.528] Timer tick, asking Buildbucket for the build status
[22:51:30.581] Build 8857638035524485856: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:51:30.581] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):9023068097586469760:29:0) after 1m0s
[22:52:30.604] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):9023068097586469760:29:0)
[22:52:30.604] Timer tick, asking Buildbucket for the build status
[22:52:30.750] Build 8857638035524485856: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:52:30.750] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):9023068097586469760:30:0) after 1m0s
[22:53:30.822] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):9023068097586469760:30:0)
[22:53:30.822] Timer tick, asking Buildbucket for the build status
[22:53:30.884] Build 8857638035524485856: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:53:30.884] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):9023068097586469760:31:0) after 1m0s
[22:54:30.961] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):9023068097586469760:31:0)
[22:54:30.961] Timer tick, asking Buildbucket for the build status
[22:54:31.069] Build 8857638035524485856: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:54:31.069] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):9023068097586469760:32:0) after 1m0s
[22:55:31.065] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):9023068097586469760:32:0)
[22:55:31.065] Timer tick, asking Buildbucket for the build status
[22:55:31.184] Build 8857638035524485856: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:55:31.184] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):9023068097586469760:33:0) after 1m0s
[22:56:31.314] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):9023068097586469760:33:0)
[22:56:31.315] Timer tick, asking Buildbucket for the build status
[22:56:31.407] Build 8857638035524485856: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:56:31.407] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):9023068097586469760:34:0) after 1m0s
[22:57:31.492] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):9023068097586469760:34:0)
[22:57:31.492] Timer tick, asking Buildbucket for the build status
[22:57:31.576] Build 8857638035524485856: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:57:31.576] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):9023068097586469760:35:0) after 1m0s
[22:58:31.619] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):9023068097586469760:35:0)
[22:58:31.619] Timer tick, asking Buildbucket for the build status
[22:58:31.679] Build 8857638035524485856: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:58:31.679] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):9023068097586469760:36:0) after 1m0s
[22:59:31.777] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):9023068097586469760:36:0)
[22:59:31.777] Timer tick, asking Buildbucket for the build status
[22:59:31.932] Build 8857638035524485856: status "STARTED", result "", failure_reason "", cancelation_reason ""
[22:59:31.932] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):9023068097586469760:37:0) after 1m0s
[23:00:32.023] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):9023068097586469760:37:0)
[23:00:32.023] Timer tick, asking Buildbucket for the build status
[23:00:32.227] Build 8857638035524485856: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:00:32.227] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):9023068097586469760:38:0) after 1m0s
[23:01:32.317] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):9023068097586469760:38:0)
[23:01:32.317] Timer tick, asking Buildbucket for the build status
[23:01:32.392] Build 8857638035524485856: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:01:32.392] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):9023068097586469760:39:0) after 1m0s
[23:02:32.524] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):9023068097586469760:39:0)
[23:02:32.524] Timer tick, asking Buildbucket for the build status
[23:02:32.720] Build 8857638035524485856: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:02:32.720] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):9023068097586469760:40:0) after 1m0s
[23:03:32.797] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):9023068097586469760:40:0)
[23:03:32.797] Timer tick, asking Buildbucket for the build status
[23:03:32.866] Build 8857638035524485856: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:03:32.866] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):9023068097586469760:41:0) after 1m0s
[23:04:32.886] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):9023068097586469760:41:0)
[23:04:32.886] Timer tick, asking Buildbucket for the build status
[23:04:32.972] Build 8857638035524485856: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:04:32.972] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):9023068097586469760:42:0) after 1m0s
[23:05:33.018] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):9023068097586469760:42:0)
[23:05:33.018] Timer tick, asking Buildbucket for the build status
[23:05:33.561] Build 8857638035524485856: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:05:33.561] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):9023068097586469760:43:0) after 1m0s
[23:06:33.601] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):9023068097586469760:43:0)
[23:06:33.601] Timer tick, asking Buildbucket for the build status
[23:06:33.660] Build 8857638035524485856: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:06:33.660] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):9023068097586469760:44:0) after 1m0s
[23:07:33.694] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):9023068097586469760:44:0)
[23:07:33.694] Timer tick, asking Buildbucket for the build status
[23:07:33.745] Build 8857638035524485856: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:07:33.745] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):9023068097586469760:45:0) after 1m0s
[23:08:33.769] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):9023068097586469760:45:0)
[23:08:33.769] Timer tick, asking Buildbucket for the build status
[23:08:33.974] Build 8857638035524485856: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:08:33.974] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):9023068097586469760:46:0) after 1m0s
[23:09:33.976] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):9023068097586469760:46:0)
[23:09:33.976] Timer tick, asking Buildbucket for the build status
[23:09:34.047] Build 8857638035524485856: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:09:34.047] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):9023068097586469760:47:0) after 1m0s
[23:10:34.063] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):9023068097586469760:47:0)
[23:10:34.063] Timer tick, asking Buildbucket for the build status
[23:10:34.456] Build 8857638035524485856: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:10:34.456] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):9023068097586469760:48:0) after 1m0s
[23:11:34.498] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):9023068097586469760:48:0)
[23:11:34.498] Timer tick, asking Buildbucket for the build status
[23:11:34.590] Build 8857638035524485856: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:11:34.590] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):9023068097586469760:49:0) after 1m0s
[23:12:34.586] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):9023068097586469760:49:0)
[23:12:34.586] Timer tick, asking Buildbucket for the build status
[23:12:34.704] Build 8857638035524485856: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:12:34.704] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):9023068097586469760:50:0) after 1m0s
[23:13:34.757] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):9023068097586469760:50:0)
[23:13:34.757] Timer tick, asking Buildbucket for the build status
[23:13:34.832] Build 8857638035524485856: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:13:34.832] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):9023068097586469760:51:0) after 1m0s
[23:14:34.878] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):9023068097586469760:51:0)
[23:14:34.878] Timer tick, asking Buildbucket for the build status
[23:14:34.957] Build 8857638035524485856: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:14:34.957] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):9023068097586469760:52:0) after 1m0s
[23:15:34.994] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):9023068097586469760:52:0)
[23:15:34.994] Timer tick, asking Buildbucket for the build status
[23:15:35.175] Build 8857638035524485856: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:15:35.175] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):9023068097586469760:53:0) after 1m0s
[23:16:35.209] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):9023068097586469760:53:0)
[23:16:35.209] Timer tick, asking Buildbucket for the build status
[23:16:35.386] Build 8857638035524485856: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:16:35.386] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):9023068097586469760:54:0) after 1m0s
[23:17:35.408] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):9023068097586469760:54:0)
[23:17:35.408] Timer tick, asking Buildbucket for the build status
[23:17:35.478] Build 8857638035524485856: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:17:35.478] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):9023068097586469760:55:0) after 1m0s
[23:18:35.544] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):9023068097586469760:55:0)
[23:18:35.544] Timer tick, asking Buildbucket for the build status
[23:18:35.618] Build 8857638035524485856: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:18:35.619] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):9023068097586469760:56:0) after 1m0s
[23:19:35.620] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):9023068097586469760:56:0)
[23:19:35.620] Timer tick, asking Buildbucket for the build status
[23:19:35.731] Build 8857638035524485856: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:19:35.731] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):9023068097586469760:57:0) after 1m0s
[23:20:35.829] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):9023068097586469760:57:0)
[23:20:35.829] Timer tick, asking Buildbucket for the build status
[23:20:36.013] Build 8857638035524485856: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:20:36.013] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):9023068097586469760:58:0) after 1m0s
[23:21:36.093] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):9023068097586469760:58:0)
[23:21:36.093] Timer tick, asking Buildbucket for the build status
[23:21:36.154] Build 8857638035524485856: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:21:36.155] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):9023068097586469760:59:0) after 1m0s
[23:22:36.246] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):9023068097586469760:59:0)
[23:22:36.246] Timer tick, asking Buildbucket for the build status
[23:22:36.315] Build 8857638035524485856: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:22:36.315] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):9023068097586469760:60:0) after 1m0s
[23:23:36.393] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):9023068097586469760:60:0)
[23:23:36.393] Timer tick, asking Buildbucket for the build status
[23:23:36.464] Build 8857638035524485856: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:23:36.464] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):9023068097586469760:61:0) after 1m0s
[23:24:36.646] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):9023068097586469760:61:0)
[23:24:36.646] Timer tick, asking Buildbucket for the build status
[23:24:36.715] Build 8857638035524485856: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:24:36.715] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):9023068097586469760:62:0) after 1m0s
[23:25:36.783] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):9023068097586469760:62:0)
[23:25:36.783] Timer tick, asking Buildbucket for the build status
[23:25:37.028] Build 8857638035524485856: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:25:37.028] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):9023068097586469760:63:0) after 1m0s
[23:26:37.199] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):9023068097586469760:63:0)
[23:26:37.199] Timer tick, asking Buildbucket for the build status
[23:26:37.276] Build 8857638035524485856: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:26:37.276] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):9023068097586469760:64:0) after 1m0s
[23:27:37.443] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):9023068097586469760:64:0)
[23:27:37.443] Timer tick, asking Buildbucket for the build status
[23:27:37.509] Build 8857638035524485856: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:27:37.509] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):9023068097586469760:65:0) after 1m0s
[23:28:37.642] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):9023068097586469760:65:0)
[23:28:37.642] Timer tick, asking Buildbucket for the build status
[23:28:37.889] Build 8857638035524485856: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:28:37.889] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):9023068097586469760:66:0) after 1m0s
[23:29:38.013] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):9023068097586469760:66:0)
[23:29:38.014] Timer tick, asking Buildbucket for the build status
[23:29:38.089] Build 8857638035524485856: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:29:38.089] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):9023068097586469760:67:0) after 1m0s
[23:30:38.171] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):9023068097586469760:67:0)
[23:30:38.171] Timer tick, asking Buildbucket for the build status
[23:30:38.298] Build 8857638035524485856: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:30:38.298] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):9023068097586469760:68:0) after 1m0s
[23:31:38.374] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):9023068097586469760:68:0)
[23:31:38.374] Timer tick, asking Buildbucket for the build status
[23:31:38.481] Build 8857638035524485856: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:31:38.481] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):9023068097586469760:69:0) after 1m0s
[23:32:38.508] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):9023068097586469760:69:0)
[23:32:38.508] Timer tick, asking Buildbucket for the build status
[23:32:38.626] Build 8857638035524485856: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:32:38.626] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):9023068097586469760:70:0) after 1m0s
[23:33:38.855] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):9023068097586469760:70:0)
[23:33:38.855] Timer tick, asking Buildbucket for the build status
[23:33:39.018] Build 8857638035524485856: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:33:39.018] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):9023068097586469760:71:0) after 1m0s
[23:34:39.384] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):9023068097586469760:71:0)
[23:34:39.384] Timer tick, asking Buildbucket for the build status
[23:34:39.474] Build 8857638035524485856: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:34:39.474] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):9023068097586469760:72:0) after 1m0s
[23:35:39.574] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):9023068097586469760:72:0)
[23:35:39.574] Timer tick, asking Buildbucket for the build status
[23:35:39.717] Build 8857638035524485856: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:35:39.717] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):9023068097586469760:73:0) after 1m0s
[23:36:40.110] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):9023068097586469760:73:0)
[23:36:40.110] Timer tick, asking Buildbucket for the build status
[23:36:40.320] Build 8857638035524485856: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:36:40.320] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):9023068097586469760:74:0) after 1m0s
[23:37:40.484] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):9023068097586469760:74:0)
[23:37:40.484] Timer tick, asking Buildbucket for the build status
[23:37:40.558] Build 8857638035524485856: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:37:40.558] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):9023068097586469760:75:0) after 1m0s
[23:38:40.812] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):9023068097586469760:75:0)
[23:38:40.812] Timer tick, asking Buildbucket for the build status
[23:38:40.963] Build 8857638035524485856: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:38:40.963] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):9023068097586469760:76:0) after 1m0s
[23:39:41.079] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):9023068097586469760:76:0)
[23:39:41.080] Timer tick, asking Buildbucket for the build status
[23:39:41.160] Build 8857638035524485856: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:39:41.160] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):9023068097586469760:77:0) after 1m0s
[23:40:41.386] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):9023068097586469760:77:0)
[23:40:41.386] Timer tick, asking Buildbucket for the build status
[23:40:41.497] Build 8857638035524485856: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:40:41.497] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):9023068097586469760:78:0) after 1m0s
[23:41:41.570] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):9023068097586469760:78:0)
[23:41:41.570] Timer tick, asking Buildbucket for the build status
[23:41:41.639] Build 8857638035524485856: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:41:41.639] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):9023068097586469760:79:0) after 1m0s
[23:42:41.664] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):9023068097586469760:79:0)
[23:42:41.664] Timer tick, asking Buildbucket for the build status
[23:42:41.793] Build 8857638035524485856: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:42:41.793] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):9023068097586469760:80:0) after 1m0s
[23:43:41.824] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):9023068097586469760:80:0)
[23:43:41.824] Timer tick, asking Buildbucket for the build status
[23:43:41.893] Build 8857638035524485856: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:43:41.893] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):9023068097586469760:81:0) after 1m0s
[23:44:41.941] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):9023068097586469760:81:0)
[23:44:41.941] Timer tick, asking Buildbucket for the build status
[23:44:42.004] Build 8857638035524485856: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:44:42.004] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):9023068097586469760:82:0) after 1m0s
[23:45:42.126] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):9023068097586469760:82:0)
[23:45:42.126] Timer tick, asking Buildbucket for the build status
[23:45:42.614] Build 8857638035524485856: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:45:42.614] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):9023068097586469760:83:0) after 1m0s
[23:46:42.642] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):9023068097586469760:83:0)
[23:46:42.643] Timer tick, asking Buildbucket for the build status
[23:46:42.710] Build 8857638035524485856: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:46:42.710] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):9023068097586469760:84:0) after 1m0s
[23:47:42.812] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):9023068097586469760:84:0)
[23:47:42.812] Timer tick, asking Buildbucket for the build status
[23:47:42.873] Build 8857638035524485856: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:47:42.873] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):9023068097586469760:85:0) after 1m0s
[23:48:42.956] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):9023068097586469760:85:0)
[23:48:42.956] Timer tick, asking Buildbucket for the build status
[23:48:43.041] Build 8857638035524485856: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:48:43.041] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):9023068097586469760:86:0) after 1m0s
[23:49:43.056] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):9023068097586469760:86:0)
[23:49:43.056] Timer tick, asking Buildbucket for the build status
[23:49:43.124] Build 8857638035524485856: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:49:43.124] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):9023068097586469760:87:0) after 1m0s
[23:50:43.195] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):9023068097586469760:87:0)
[23:50:43.195] Timer tick, asking Buildbucket for the build status
[23:50:43.297] Build 8857638035524485856: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:50:43.297] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):9023068097586469760:88:0) after 1m0s
[23:51:43.342] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):9023068097586469760:88:0)
[23:51:43.342] Timer tick, asking Buildbucket for the build status
[23:51:43.418] Build 8857638035524485856: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:51:43.418] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):9023068097586469760:89:0) after 1m0s
[23:52:43.451] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):9023068097586469760:89:0)
[23:52:43.451] Timer tick, asking Buildbucket for the build status
[23:52:43.711] Build 8857638035524485856: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:52:43.711] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):9023068097586469760:90:0) after 1m0s
[23:53:43.766] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):9023068097586469760:90:0)
[23:53:43.766] Timer tick, asking Buildbucket for the build status
[23:53:43.832] Build 8857638035524485856: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:53:43.832] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):9023068097586469760:91:0) after 1m0s
[23:54:43.832] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):9023068097586469760:91:0)
[23:54:43.832] Timer tick, asking Buildbucket for the build status
[23:54:43.895] Build 8857638035524485856: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:54:43.895] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):9023068097586469760:92:0) after 1m0s
[23:55:44.017] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):9023068097586469760:92:0)
[23:55:44.017] Timer tick, asking Buildbucket for the build status
[23:55:44.128] Build 8857638035524485856: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:55:44.128] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):9023068097586469760:93:0) after 1m0s
[23:56:44.377] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):9023068097586469760:93:0)
[23:56:44.377] Timer tick, asking Buildbucket for the build status
[23:56:44.447] Build 8857638035524485856: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:56:44.447] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):9023068097586469760:94:0) after 1m0s
[23:57:45.031] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):9023068097586469760:94:0)
[23:57:45.031] Timer tick, asking Buildbucket for the build status
[23:57:45.107] Build 8857638035524485856: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:57:45.107] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):9023068097586469760:95:0) after 1m0s
[23:58:45.166] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):9023068097586469760:95:0)
[23:58:45.167] Timer tick, asking Buildbucket for the build status
[23:58:45.251] Build 8857638035524485856: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:58:45.251] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):9023068097586469760:96:0) after 1m0s
[23:59:45.293] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):9023068097586469760:96:0)
[23:59:45.293] Timer tick, asking Buildbucket for the build status
[23:59:45.509] Build 8857638035524485856: status "STARTED", result "", failure_reason "", cancelation_reason ""
[23:59:45.509] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):9023068097586469760:97:0) after 1m0s
[00:00:45.584] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):9023068097586469760:97:0)
[00:00:45.584] Timer tick, asking Buildbucket for the build status
[00:00:45.907] Build 8857638035524485856: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:00:45.907] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):9023068097586469760:98:0) after 1m0s
[00:01:45.936] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):9023068097586469760:98:0)
[00:01:45.936] Timer tick, asking Buildbucket for the build status
[00:01:46.001] Build 8857638035524485856: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:01:46.001] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):9023068097586469760:99:0) after 1m0s
[00:02:46.129] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):9023068097586469760:99:0)
[00:02:46.129] Timer tick, asking Buildbucket for the build status
[00:02:46.227] Build 8857638035524485856: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:02:46.227] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):9023068097586469760:100:0) after 1m0s
[00:03:46.271] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):9023068097586469760:100:0)
[00:03:46.271] Timer tick, asking Buildbucket for the build status
[00:03:46.331] Build 8857638035524485856: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:03:46.331] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):9023068097586469760:101:0) after 1m0s
[00:04:46.341] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):9023068097586469760:101:0)
[00:04:46.341] Timer tick, asking Buildbucket for the build status
[00:04:46.405] Build 8857638035524485856: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:04:46.405] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):9023068097586469760:102:0) after 1m0s
[00:05:46.487] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):9023068097586469760:102:0)
[00:05:46.487] Timer tick, asking Buildbucket for the build status
[00:05:46.712] Build 8857638035524485856: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:05:46.712] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):9023068097586469760:103:0) after 1m0s
[00:06:46.774] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):9023068097586469760:103:0)
[00:06:46.774] Timer tick, asking Buildbucket for the build status
[00:06:47.145] Build 8857638035524485856: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:06:47.145] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):9023068097586469760:104:0) after 1m0s
[00:07:47.162] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):9023068097586469760:104:0)
[00:07:47.162] Timer tick, asking Buildbucket for the build status
[00:07:47.222] Build 8857638035524485856: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:07:47.222] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):9023068097586469760:105:0) after 1m0s
[00:08:47.319] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):9023068097586469760:105:0)
[00:08:47.319] Timer tick, asking Buildbucket for the build status
[00:08:47.401] Build 8857638035524485856: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:08:47.401] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):9023068097586469760:106:0) after 1m0s
[00:09:47.482] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):9023068097586469760:106:0)
[00:09:47.482] Timer tick, asking Buildbucket for the build status
[00:09:47.563] Build 8857638035524485856: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:09:47.564] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):9023068097586469760:107:0) after 1m0s
[00:10:48.420] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):9023068097586469760:107:0)
[00:10:48.420] Timer tick, asking Buildbucket for the build status
[00:10:48.547] Build 8857638035524485856: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:10:48.547] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):9023068097586469760:108:0) after 1m0s
[00:11:48.662] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):9023068097586469760:108:0)
[00:11:48.662] Timer tick, asking Buildbucket for the build status
[00:11:48.756] Build 8857638035524485856: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:11:48.756] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):9023068097586469760:109:0) after 1m0s
[00:12:48.941] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):9023068097586469760:109:0)
[00:12:48.941] Timer tick, asking Buildbucket for the build status
[00:12:49.001] Build 8857638035524485856: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:12:49.001] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):9023068097586469760:110:0) after 1m0s
[00:13:49.287] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):9023068097586469760:110:0)
[00:13:49.287] Timer tick, asking Buildbucket for the build status
[00:13:49.400] Build 8857638035524485856: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:13:49.400] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):9023068097586469760:111:0) after 1m0s
[00:14:49.492] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):9023068097586469760:111:0)
[00:14:49.492] Timer tick, asking Buildbucket for the build status
[00:14:49.865] Build 8857638035524485856: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:14:49.865] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):9023068097586469760:112:0) after 1m0s
[00:15:50.100] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):9023068097586469760:112:0)
[00:15:50.100] Timer tick, asking Buildbucket for the build status
[00:15:50.259] Build 8857638035524485856: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:15:50.259] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):9023068097586469760:113:0) after 1m0s
[00:16:50.352] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):9023068097586469760:113:0)
[00:16:50.352] Timer tick, asking Buildbucket for the build status
[00:16:50.628] Build 8857638035524485856: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:16:50.628] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):9023068097586469760:114:0) after 1m0s
[00:17:50.742] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):9023068097586469760:114:0)
[00:17:50.742] Timer tick, asking Buildbucket for the build status
[00:17:50.817] Build 8857638035524485856: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:17:50.817] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):9023068097586469760:115:0) after 1m0s
[00:18:50.888] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):9023068097586469760:115:0)
[00:18:50.888] Timer tick, asking Buildbucket for the build status
[00:18:51.355] Build 8857638035524485856: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:18:51.355] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):9023068097586469760:116:0) after 1m0s
[00:19:51.534] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):9023068097586469760:116:0)
[00:19:51.534] Timer tick, asking Buildbucket for the build status
[00:19:51.596] Build 8857638035524485856: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:19:51.596] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):9023068097586469760:117:0) after 1m0s
[00:20:51.721] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):9023068097586469760:117:0)
[00:20:51.721] Timer tick, asking Buildbucket for the build status
[00:20:51.883] Build 8857638035524485856: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:20:51.883] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):9023068097586469760:118:0) after 1m0s
[00:21:51.996] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):9023068097586469760:118:0)
[00:21:51.996] Timer tick, asking Buildbucket for the build status
[00:21:52.053] Build 8857638035524485856: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:21:52.053] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):9023068097586469760:119:0) after 1m0s
[00:22:52.125] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):9023068097586469760:119:0)
[00:22:52.125] Timer tick, asking Buildbucket for the build status
[00:22:52.215] Build 8857638035524485856: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:22:52.215] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):9023068097586469760:120:0) after 1m0s
[00:23:52.286] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):9023068097586469760:120:0)
[00:23:52.286] Timer tick, asking Buildbucket for the build status
[00:23:52.358] Build 8857638035524485856: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:23:52.358] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):9023068097586469760:121:0) after 1m0s
[00:24:52.457] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):9023068097586469760:121:0)
[00:24:52.457] Timer tick, asking Buildbucket for the build status
[00:24:52.533] Build 8857638035524485856: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:24:52.533] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):9023068097586469760:122:0) after 1m0s
[00:25:52.578] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):9023068097586469760:122:0)
[00:25:52.578] Timer tick, asking Buildbucket for the build status
[00:25:52.789] Build 8857638035524485856: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:25:52.791] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):9023068097586469760:123:0) after 1m0s
[00:26:52.948] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):9023068097586469760:123:0)
[00:26:52.948] Timer tick, asking Buildbucket for the build status
[00:26:53.015] Build 8857638035524485856: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:26:53.015] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):9023068097586469760:124:0) after 1m0s
[00:27:53.134] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):9023068097586469760:124:0)
[00:27:53.134] Timer tick, asking Buildbucket for the build status
[00:27:53.255] Build 8857638035524485856: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:27:53.255] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):9023068097586469760:125:0) after 1m0s
[00:28:53.312] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):9023068097586469760:125:0)
[00:28:53.312] Timer tick, asking Buildbucket for the build status
[00:28:53.410] Build 8857638035524485856: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:28:53.410] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):9023068097586469760:126:0) after 1m0s
[00:29:53.521] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):9023068097586469760:126:0)
[00:29:53.521] Timer tick, asking Buildbucket for the build status
[00:29:53.587] Build 8857638035524485856: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:29:53.587] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):9023068097586469760:127:0) after 1m0s
[00:30:53.766] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):9023068097586469760:127:0)
[00:30:53.766] Timer tick, asking Buildbucket for the build status
[00:30:53.901] Build 8857638035524485856: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:30:53.901] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):9023068097586469760:128:0) after 1m0s
[00:31:53.935] Handling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):9023068097586469760:128:0)
[00:31:53.935] Timer tick, asking Buildbucket for the build status
[00:31:54.141] Build 8857638035524485856: status "STARTED", result "", failure_reason "", cancelation_reason ""
[00:31:54.141] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWin(dbg):9023068097586469760:129:0) after 1m0s
[00:32:32.765] Received PubSub notification, asking Buildbucket for the build status
[00:32:32.829] Build 8857638035524485856: status "COMPLETED", result "FAILURE", failure_reason "BUILD_FAILURE", cancelation_reason ""
[00:32:32.829] Buildbucket build:
{
"build": {
"bucket": "luci.chromium.ci",
"canary": true,
"canary_preference": "CANARY",
"completed_ts": "1611102751957416",
"created_by": "project:chromium",
"created_ts": "1611095123705023",
"failure_reason": "BUILD_FAILURE",
"id": "8857638035524485856",
"parameters_json": "{\"builder_name\": \"ToTWin(dbg)\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"1e2eb038e916a65476cc6d178913e2a2b8bc3b77\"}}",
"project": "chromium",
"result": "FAILURE",
"result_details_json": "{\"error\": {\"message\": \"#### Step _compile_ failed. Error logs are shown below:\\n```\\n[40651/108862] CXX obj/base/base_unittests/gmock_callback_support_unittest.obj\\nFAILED: obj/base/base_unittests/gmock_callback_support_unittest.obj\\n..\\\\..\\\\third_party\\\\llvm-build\\\\Release+Asserts\\\\bin\\\\clang-cl.exe /nologo /showIncludes:user -imsvc..\\\\.....(too long)\\nAssertion failed: !Init-\u003eisValueDependent(), file C:\\\\b\\\\s\\\\w\\\\ir\\\\cache\\\\builder\\\\src\\\\third_party\\\\llvm\\\\clang\\\\lib\\\\AST\\\\Decl.cpp, line 2402\\nPLEASE submit a bug report to https://crbug.com and run tools/clang/scripts/process_crashreports.py (only works inside Google) which will upload a report and include the crash backtrace, preprocessed source, and associated run script.\\nStack dump:\\n```\\n##### ...The message was too long...\\n#### More information in raw_io.output[failure_summary]\"}, \"properties\": {\"$build/goma\": {\"use_luci_auth\": true}, \"$recipe_engine/isolated\": {\"server\": \"https://isolateserver.appspot.com\"}, \"$recipe_engine/milo/blamelist_pins\": [{\"host\": \"chromium.googlesource.com\", \"id\": \"1e2eb038e916a65476cc6d178913e2a2b8bc3b77\", \"project\": \"chromium/src\"}], \"$recipe_engine/path\": {\"cache_dir\": \"C:\\\\b\\\\s\\\\w\\\\ir\\\\cache\", \"temp_dir\": \"C:\\\\b\\\\s\\\\w\\\\ir\\\\tmp\\\\rt\"}, \"$recipe_engine/runtime\": {\"is_experimental\": false, \"is_luci\": true}, \"bot_id\": \"luci-chromium-ci-win10-32-2-b8ir\", \"branch\": \"refs/heads/master\", \"builder_group\": \"chromium.clang\", \"buildername\": \"ToTWin(dbg)\", \"buildnumber\": 6430, \"clang_revision\": \"llvmorg-12-init-17107-g22eb1cf8-0\", \"got_angle_revision\": \"e670fc72a5aec91c7b0249c6512993a77f3ac14d\", \"got_dawn_revision\": \"4b316994ad01ab6b87032c5fd9b53c6d18956d8d\", \"got_nacl_revision\": \"cb31feffa500401c95c6c44d88b7c358236bca36\", \"got_revision\": \"1e2eb038e916a65476cc6d178913e2a2b8bc3b77\", \"got_revision_cp\": \"refs/heads/master@{#844931}\", \"got_swarming_client_revision\": \"1a072711d4388c62e02480fabc26c68c24494be9\", \"got_swiftshader_revision\": \"8da0f82baf359e2b91464f111306a094f86fe71b\", \"got_v8_revision\": \"870bd0b9a8bc7aa777926e94b031264fcddca0d1\", \"got_v8_revision_cp\": \"refs/heads/9.0.15@{#1}\", \"got_webrtc_revision\": \"5eb527cf7fb28e22d0687c0295cb9f1bb458160c\", \"got_webrtc_revision_cp\": \"refs/heads/master@{#33034}\", \"path_config\": \"generic\", \"perf_dashboard_machine_group\": \"ChromiumClang\", \"recipe\": \"chromium\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"1e2eb038e916a65476cc6d178913e2a2b8bc3b77\"}, \"swarming\": {\"bot_dimensions\": {\"builderless\": [\"1\"], \"caches\": [\"builder_05f97ad14167df9074a6905c05cccbc862b4a7ff68b1655c21ecf0b33d70df67_v2\"], \"cores\": [\"32\"], \"cpu\": [\"x86\", \"x86-64\", \"x86-64-Broadwell_GCE\"], \"gce\": [\"1\"], \"gcp\": [\"google.com:chromecompute\"], \"gpu\": [\"none\"], \"id\": [\"luci-chromium-ci-win10-32-2-b8ir\"], \"image\": [\"chrome-win10-1703-20111600-a937a23cefb\"], \"integrity\": [\"high\"], \"locale\": [\"en_US.cp1252\"], \"machine_type\": [\"e2-standard-32\"], \"os\": [\"Windows\", \"Windows-10\", \"Windows-10-15063\"], \"pool\": [\"luci.chromium.ci\"], \"python\": [\"2.7.13\"], \"server_version\": [\"5666-679c9bd\"], \"ssd\": [\"0\"], \"windows_client_version\": [\"10\"], \"zone\": [\"us\", \"us-west\", \"us-west1\", \"us-west1-b\"]}}, \"ui\": {\"info\": \"#### Step _compile_ failed. Error logs are shown below:\\n```\\n[40651/108862] CXX obj/base/base_unittests/gmock_callback_support_unittest.obj\\nFAILED: obj/base/base_unittests/gmock_callback_support_unittest.obj\\n..\\\\..\\\\third_party\\\\llvm-build\\\\Release+Asserts\\\\bin\\\\clang-cl.exe /nologo /showIncludes:user -imsvc..\\\\.....(too long)\\nAssertion failed: !Init-\u003eisValueDependent(), file C:\\\\b\\\\s\\\\w\\\\ir\\\\cache\\\\builder\\\\src\\\\third_party\\\\llvm\\\\clang\\\\lib\\\\AST\\\\Decl.cpp, line 2402\\nPLEASE submit a bug report to https://crbug.com and run tools/clang/scripts/process_crashreports.py (only works inside Google) which will upload a report and include the crash backtrace, preprocessed source, and associated run script.\\nStack dump:\\n```\\n##### ...The message was too long...\\n#### More information in raw_io.output[failure_summary]\"}}",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"started_ts": "1611095172174200",
"status": "COMPLETED",
"status_changed_ts": "1611095172748962",
"tags": [
"build_address:luci.chromium.ci/ToTWin(dbg)/6430",
"builder:ToTWin(dbg)",
"buildset:commit/git/1e2eb038e916a65476cc6d178913e2a2b8bc3b77",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/1e2eb038e916a65476cc6d178913e2a2b8bc3b77",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9023068097586469760",
"scheduler_job_id:chromium/ToTWin(dbg)",
"swarming_hostname:chromium-swarm.appspot.com",
"swarming_tag:log_location:logdog://logs.chromium.org/chromium/buildbucket/cr-buildbucket.appspot.com/8857638035524485856/+/annotations",
"swarming_tag:luci_project:chromium",
"swarming_tag:os:Windows",
"swarming_tag:recipe_name:chromium",
"swarming_tag:recipe_package:infra/recipe_bundles/chromium.googlesource.com/chromium/tools/build",
"swarming_task_id:513592383ab2d410",
"user_agent:luci-scheduler"
],
"updated_ts": "1611102752207443",
"url": "https://ci.chromium.org/b/8857638035524485856",
"utcnow_ts": "1611102752820575"
}
}
[00:32:32.829] Invocation finished in 2h7m10.473708024s with status FAILED