[04:07:26.161] New invocation is queued and will start shortly
[04:07:27.272] Starting the invocation (attempt 1)
[04:07:27.346] Preparing PubSub topic for "https://cr-buildbucket-dev.appspot.com"
[04:07:27.346] PubSub topic is "projects/luci-scheduler-dev/topics/scheduler.buildbucket.cr-buildbucket-dev~appspot.gserviceaccount.com"
[04:07:27.347] Buildbucket request:
{
"bucket": "luci.infra.ci",
"client_operation_id": "9020962846612336272",
"parameters_json": "{\"builder_name\":\"infra-continuous-win10-64\",\"properties\":{\"$recipe_engine/scheduler\":{\"hostname\":\"luci-scheduler-dev.appspot.com\",\"triggers\":[{\"gitiles\":{\"ref\":\"refs/heads/master\",\"repo\":\"https://chromium.googlesource.com/infra/infra\",\"revision\":\"2abc3d146991b08b04c7069e8d6da4ecea147045\"},\"id\":\"https://chromium.googlesource.com/infra/infra/+/refs/heads/master@2abc3d146991b08b04c7069e8d6da4ecea147045\",\"title\":\"2abc3d146991b08b04c7069e8d6da4ecea147045\",\"url\":\"https://chromium.googlesource.com/infra/infra/+/2abc3d146991b08b04c7069e8d6da4ecea147045\"},{\"gitiles\":{\"ref\":\"refs/heads/master\",\"repo\":\"https://chromium.googlesource.com/infra/infra\",\"revision\":\"0f062ddb4e34198104af7609739c7f1968721cc3\"},\"id\":\"https://chromium.googlesource.com/infra/infra/+/refs/heads/master@0f062ddb4e34198104af7609739c7f1968721cc3\",\"title\":\"0f062ddb4e34198104af7609739c7f1968721cc3\",\"url\":\"https://chromium.googlesource.com/infra/infra/+/0f062ddb4e34198104af7609739c7f1968721cc3\"},{\"gitiles\":{\"ref\":\"refs/heads/master\",\"repo\":\"https://chromium.googlesource.com/infra/infra\",\"revision\":\"c728a4e7cb6ab74d0f80552a27109c3152464433\"},\"id\":\"https://chromium.googlesource.com/infra/infra/+/refs/heads/master@c728a4e7cb6ab74d0f80552a27109c3152464433\",\"title\":\"c728a4e7cb6ab74d0f80552a27109c3152464433\",\"url\":\"https://chromium.googlesource.com/infra/infra/+/c728a4e7cb6ab74d0f80552a27109c3152464433\"},{\"gitiles\":{\"ref\":\"refs/heads/master\",\"repo\":\"https://chromium.googlesource.com/infra/infra\",\"revision\":\"94d518709f4c007206843c635a14d71c30942150\"},\"id\":\"https://chromium.googlesource.com/infra/infra/+/refs/heads/master@94d518709f4c007206843c635a14d71c30942150\",\"title\":\"94d518709f4c007206843c635a14d71c30942150\",\"url\":\"https://chromium.googlesource.com/infra/infra/+/94d518709f4c007206843c635a14d71c30942150\"}]},\"branch\":\"refs/heads/master\",\"repository\":\"https://chromium.googlesource.com/infra/infra\",\"revision\":\"94d518709f4c007206843c635a14d71c30942150\"}}",
"pubsub_callback": {
"auth_token": "...",
"topic": "projects/luci-scheduler-dev/topics/scheduler.buildbucket.cr-buildbucket-dev~appspot.gserviceaccount.com"
},
"tags": [
"builder:infra-continuous-win10-64",
"scheduler_invocation_id:9020962846612336272",
"scheduler_job_id:infra/infra-continuous-win10-64",
"user_agent:luci-scheduler-dev",
"buildset:commit/git/94d518709f4c007206843c635a14d71c30942150",
"buildset:commit/gitiles/chromium.googlesource.com/infra/infra/+/94d518709f4c007206843c635a14d71c30942150",
"gitiles_ref:refs/heads/master"
]
}
[04:07:28.004] Buildbucket response:
{
"build": {
"bucket": "luci.infra.ci",
"canary_preference": "PROD",
"created_by": "project:infra",
"created_ts": "1613102847470479",
"id": "8855532784569403568",
"parameters_json": "{\"builder_name\": \"infra-continuous-win10-64\", \"properties\": {\"$recipe_engine/scheduler\": {\"hostname\": \"luci-scheduler-dev.appspot.com\", \"triggers\": [{\"gitiles\": {\"ref\": \"refs/heads/master\", \"repo\": \"https://chromium.googlesource.com/infra/infra\", \"revision\": \"2abc3d146991b08b04c7069e8d6da4ecea147045\"}, \"id\": \"https://chromium.googlesource.com/infra/infra/+/refs/heads/master@2abc3d146991b08b04c7069e8d6da4ecea147045\", \"title\": \"2abc3d146991b08b04c7069e8d6da4ecea147045\", \"url\": \"https://chromium.googlesource.com/infra/infra/+/2abc3d146991b08b04c7069e8d6da4ecea147045\"}, {\"gitiles\": {\"ref\": \"refs/heads/master\", \"repo\": \"https://chromium.googlesource.com/infra/infra\", \"revision\": \"0f062ddb4e34198104af7609739c7f1968721cc3\"}, \"id\": \"https://chromium.googlesource.com/infra/infra/+/refs/heads/master@0f062ddb4e34198104af7609739c7f1968721cc3\", \"title\": \"0f062ddb4e34198104af7609739c7f1968721cc3\", \"url\": \"https://chromium.googlesource.com/infra/infra/+/0f062ddb4e34198104af7609739c7f1968721cc3\"}, {\"gitiles\": {\"ref\": \"refs/heads/master\", \"repo\": \"https://chromium.googlesource.com/infra/infra\", \"revision\": \"c728a4e7cb6ab74d0f80552a27109c3152464433\"}, \"id\": \"https://chromium.googlesource.com/infra/infra/+/refs/heads/master@c728a4e7cb6ab74d0f80552a27109c3152464433\", \"title\": \"c728a4e7cb6ab74d0f80552a27109c3152464433\", \"url\": \"https://chromium.googlesource.com/infra/infra/+/c728a4e7cb6ab74d0f80552a27109c3152464433\"}, {\"gitiles\": {\"ref\": \"refs/heads/master\", \"repo\": \"https://chromium.googlesource.com/infra/infra\", \"revision\": \"94d518709f4c007206843c635a14d71c30942150\"}, \"id\": \"https://chromium.googlesource.com/infra/infra/+/refs/heads/master@94d518709f4c007206843c635a14d71c30942150\", \"title\": \"94d518709f4c007206843c635a14d71c30942150\", \"url\": \"https://chromium.googlesource.com/infra/infra/+/94d518709f4c007206843c635a14d71c30942150\"}]}, \"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/infra/infra\", \"revision\": \"94d518709f4c007206843c635a14d71c30942150\"}}",
"project": "infra",
"result_details_json": "{\"properties\": {}}",
"service_account": "adhoc-testing@luci-token-server-dev.iam.gserviceaccount.com",
"status": "SCHEDULED",
"status_changed_ts": "1613102847892406",
"tags": [
"build_address:luci.infra.ci/infra-continuous-win10-64/18592",
"builder:infra-continuous-win10-64",
"buildset:commit/git/94d518709f4c007206843c635a14d71c30942150",
"buildset:commit/gitiles/chromium.googlesource.com/infra/infra/+/94d518709f4c007206843c635a14d71c30942150",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9020962846612336272",
"scheduler_job_id:infra/infra-continuous-win10-64",
"swarming_hostname:chromium-swarm-dev.appspot.com",
"swarming_tag:log_location:logdog://luci-logdog-dev.appspot.com/infra/buildbucket/cr-buildbucket-dev.appspot.com/8855532784569403568/+/annotations",
"swarming_tag:luci_project:infra",
"swarming_tag:recipe_name:infra_continuous",
"swarming_tag:recipe_package:infra/recipe_bundles/chromium.googlesource.com/infra/infra",
"swarming_task_id:",
"user_agent:luci-scheduler-dev"
],
"updated_ts": "1613102847892534",
"url": "https://luci-milo-dev.appspot.com/b/8855532784569403568",
"utcnow_ts": "1613102847986004"
}
}
[04:07:28.004] Task URL: https://luci-milo-dev.appspot.com/b/8855532784569403568
[04:07:28.004] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9020962846612336272:2:0) after 1m0s
[04:08:28.025] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9020962846612336272:2:0)
[04:08:28.025] Timer tick, asking Buildbucket for the build status
[04:08:28.097] Build 8855532784569403568: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[04:08:28.097] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9020962846612336272:3:0) after 1m0s
[04:09:28.113] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9020962846612336272:3:0)
[04:09:28.113] Timer tick, asking Buildbucket for the build status
[04:09:28.209] Build 8855532784569403568: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[04:09:28.209] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9020962846612336272:4:0) after 1m0s
[04:10:28.226] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9020962846612336272:4:0)
[04:10:28.226] Timer tick, asking Buildbucket for the build status
[04:10:28.338] Build 8855532784569403568: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[04:10:28.338] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9020962846612336272:5:0) after 1m0s
[04:11:28.369] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9020962846612336272:5:0)
[04:11:28.369] Timer tick, asking Buildbucket for the build status
[04:11:28.440] Build 8855532784569403568: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[04:11:28.440] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9020962846612336272:6:0) after 1m0s
[04:12:28.490] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9020962846612336272:6:0)
[04:12:28.490] Timer tick, asking Buildbucket for the build status
[04:12:28.560] Build 8855532784569403568: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[04:12:28.560] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9020962846612336272:7:0) after 1m0s
[04:13:28.679] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9020962846612336272:7:0)
[04:13:28.679] Timer tick, asking Buildbucket for the build status
[04:13:28.853] Build 8855532784569403568: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[04:13:28.853] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9020962846612336272:8:0) after 1m0s
[04:14:28.899] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9020962846612336272:8:0)
[04:14:28.899] Timer tick, asking Buildbucket for the build status
[04:14:28.989] Build 8855532784569403568: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[04:14:28.989] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9020962846612336272:9:0) after 1m0s
[04:15:29.053] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9020962846612336272:9:0)
[04:15:29.053] Timer tick, asking Buildbucket for the build status
[04:15:29.135] Build 8855532784569403568: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[04:15:29.135] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9020962846612336272:10:0) after 1m0s
[04:16:29.191] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9020962846612336272:10:0)
[04:16:29.191] Timer tick, asking Buildbucket for the build status
[04:16:29.271] Build 8855532784569403568: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[04:16:29.271] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9020962846612336272:11:0) after 1m0s
[04:17:29.290] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9020962846612336272:11:0)
[04:17:29.290] Timer tick, asking Buildbucket for the build status
[04:17:29.362] Build 8855532784569403568: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[04:17:29.362] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9020962846612336272:12:0) after 1m0s
[04:18:29.467] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9020962846612336272:12:0)
[04:18:29.467] Timer tick, asking Buildbucket for the build status
[04:18:29.582] Build 8855532784569403568: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[04:18:29.582] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9020962846612336272:13:0) after 1m0s
[04:19:29.697] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9020962846612336272:13:0)
[04:19:29.697] Timer tick, asking Buildbucket for the build status
[04:19:29.793] Build 8855532784569403568: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[04:19:29.793] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9020962846612336272:14:0) after 1m0s
[04:20:29.867] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9020962846612336272:14:0)
[04:20:29.867] Timer tick, asking Buildbucket for the build status
[04:20:29.936] Build 8855532784569403568: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[04:20:29.936] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9020962846612336272:15:0) after 1m0s
[04:21:29.965] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9020962846612336272:15:0)
[04:21:29.965] Timer tick, asking Buildbucket for the build status
[04:21:30.079] Build 8855532784569403568: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[04:21:30.079] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9020962846612336272:16:0) after 1m0s
[04:22:30.100] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9020962846612336272:16:0)
[04:22:30.100] Timer tick, asking Buildbucket for the build status
[04:22:30.181] Build 8855532784569403568: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[04:22:30.181] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9020962846612336272:17:0) after 1m0s
[04:23:30.197] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9020962846612336272:17:0)
[04:23:30.197] Timer tick, asking Buildbucket for the build status
[04:23:30.343] Build 8855532784569403568: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[04:23:30.343] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9020962846612336272:18:0) after 1m0s
[04:24:30.403] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9020962846612336272:18:0)
[04:24:30.403] Timer tick, asking Buildbucket for the build status
[04:24:30.487] Build 8855532784569403568: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[04:24:30.487] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9020962846612336272:19:0) after 1m0s
[04:25:30.590] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9020962846612336272:19:0)
[04:25:30.590] Timer tick, asking Buildbucket for the build status
[04:25:30.772] Build 8855532784569403568: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[04:25:30.772] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9020962846612336272:20:0) after 1m0s
[04:26:30.792] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9020962846612336272:20:0)
[04:26:30.792] Timer tick, asking Buildbucket for the build status
[04:26:30.921] Build 8855532784569403568: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[04:26:30.921] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9020962846612336272:21:0) after 1m0s
[04:27:30.939] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9020962846612336272:21:0)
[04:27:30.939] Timer tick, asking Buildbucket for the build status
[04:27:31.027] Build 8855532784569403568: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[04:27:31.027] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9020962846612336272:22:0) after 1m0s
[04:28:31.089] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9020962846612336272:22:0)
[04:28:31.089] Timer tick, asking Buildbucket for the build status
[04:28:31.247] Build 8855532784569403568: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[04:28:31.247] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9020962846612336272:23:0) after 1m0s
[04:29:31.270] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9020962846612336272:23:0)
[04:29:31.270] Timer tick, asking Buildbucket for the build status
[04:29:31.359] Build 8855532784569403568: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[04:29:31.359] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9020962846612336272:24:0) after 1m0s
[04:30:31.378] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9020962846612336272:24:0)
[04:30:31.378] Timer tick, asking Buildbucket for the build status
[04:30:31.458] Build 8855532784569403568: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[04:30:31.458] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9020962846612336272:25:0) after 1m0s
[04:31:31.565] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9020962846612336272:25:0)
[04:31:31.565] Timer tick, asking Buildbucket for the build status
[04:31:31.675] Build 8855532784569403568: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[04:31:31.675] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9020962846612336272:26:0) after 1m0s
[04:32:31.702] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9020962846612336272:26:0)
[04:32:31.702] Timer tick, asking Buildbucket for the build status
[04:32:31.796] Build 8855532784569403568: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[04:32:31.796] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9020962846612336272:27:0) after 1m0s
[04:33:31.903] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9020962846612336272:27:0)
[04:33:31.903] Timer tick, asking Buildbucket for the build status
[04:33:32.042] Build 8855532784569403568: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[04:33:32.042] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9020962846612336272:28:0) after 1m0s
[04:34:32.097] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9020962846612336272:28:0)
[04:34:32.097] Timer tick, asking Buildbucket for the build status
[04:34:32.247] Build 8855532784569403568: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[04:34:32.247] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9020962846612336272:29:0) after 1m0s
[04:35:32.393] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9020962846612336272:29:0)
[04:35:32.393] Timer tick, asking Buildbucket for the build status
[04:35:32.517] Build 8855532784569403568: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[04:35:32.517] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9020962846612336272:30:0) after 1m0s
[04:36:32.568] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9020962846612336272:30:0)
[04:36:32.568] Timer tick, asking Buildbucket for the build status
[04:36:32.708] Build 8855532784569403568: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[04:36:32.708] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9020962846612336272:31:0) after 1m0s
[04:37:32.802] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9020962846612336272:31:0)
[04:37:32.802] Timer tick, asking Buildbucket for the build status
[04:37:32.901] Build 8855532784569403568: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[04:37:32.901] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9020962846612336272:32:0) after 1m0s
[04:38:33.010] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9020962846612336272:32:0)
[04:38:33.010] Timer tick, asking Buildbucket for the build status
[04:38:33.183] Build 8855532784569403568: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[04:38:33.183] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9020962846612336272:33:0) after 1m0s
[04:39:33.273] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9020962846612336272:33:0)
[04:39:33.273] Timer tick, asking Buildbucket for the build status
[04:39:33.360] Build 8855532784569403568: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[04:39:33.360] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9020962846612336272:34:0) after 1m0s
[04:40:33.399] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9020962846612336272:34:0)
[04:40:33.399] Timer tick, asking Buildbucket for the build status
[04:40:33.480] Build 8855532784569403568: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[04:40:33.480] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9020962846612336272:35:0) after 1m0s
[04:41:33.575] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9020962846612336272:35:0)
[04:41:33.575] Timer tick, asking Buildbucket for the build status
[04:41:33.664] Build 8855532784569403568: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[04:41:33.664] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9020962846612336272:36:0) after 1m0s
[04:42:33.703] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9020962846612336272:36:0)
[04:42:33.703] Timer tick, asking Buildbucket for the build status
[04:42:33.780] Build 8855532784569403568: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[04:42:33.780] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9020962846612336272:37:0) after 1m0s
[04:43:33.856] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9020962846612336272:37:0)
[04:43:33.856] Timer tick, asking Buildbucket for the build status
[04:43:33.958] Build 8855532784569403568: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[04:43:33.958] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9020962846612336272:38:0) after 1m0s
[04:44:34.066] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9020962846612336272:38:0)
[04:44:34.066] Timer tick, asking Buildbucket for the build status
[04:44:34.275] Build 8855532784569403568: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[04:44:34.275] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9020962846612336272:39:0) after 1m0s
[04:45:34.303] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9020962846612336272:39:0)
[04:45:34.303] Timer tick, asking Buildbucket for the build status
[04:45:34.476] Build 8855532784569403568: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[04:45:34.476] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9020962846612336272:40:0) after 1m0s
[04:46:34.513] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9020962846612336272:40:0)
[04:46:34.513] Timer tick, asking Buildbucket for the build status
[04:46:34.604] Build 8855532784569403568: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[04:46:34.604] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9020962846612336272:41:0) after 1m0s
[04:47:34.707] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9020962846612336272:41:0)
[04:47:34.707] Timer tick, asking Buildbucket for the build status
[04:47:34.806] Build 8855532784569403568: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[04:47:34.806] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9020962846612336272:42:0) after 1m0s
[04:48:34.912] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9020962846612336272:42:0)
[04:48:34.912] Timer tick, asking Buildbucket for the build status
[04:48:34.993] Build 8855532784569403568: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[04:48:34.993] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9020962846612336272:43:0) after 1m0s
[04:49:35.092] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9020962846612336272:43:0)
[04:49:35.092] Timer tick, asking Buildbucket for the build status
[04:49:35.194] Build 8855532784569403568: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[04:49:35.194] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9020962846612336272:44:0) after 1m0s
[04:50:35.256] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9020962846612336272:44:0)
[04:50:35.256] Timer tick, asking Buildbucket for the build status
[04:50:35.339] Build 8855532784569403568: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[04:50:35.339] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9020962846612336272:45:0) after 1m0s
[04:51:35.360] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9020962846612336272:45:0)
[04:51:35.360] Timer tick, asking Buildbucket for the build status
[04:51:35.449] Build 8855532784569403568: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[04:51:35.449] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9020962846612336272:46:0) after 1m0s
[04:52:35.491] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9020962846612336272:46:0)
[04:52:35.491] Timer tick, asking Buildbucket for the build status
[04:52:35.570] Build 8855532784569403568: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[04:52:35.570] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9020962846612336272:47:0) after 1m0s
[04:53:35.593] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9020962846612336272:47:0)
[04:53:35.593] Timer tick, asking Buildbucket for the build status
[04:53:35.670] Build 8855532784569403568: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[04:53:35.670] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9020962846612336272:48:0) after 1m0s
[04:54:35.768] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9020962846612336272:48:0)
[04:54:35.768] Timer tick, asking Buildbucket for the build status
[04:54:35.853] Build 8855532784569403568: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[04:54:35.853] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9020962846612336272:49:0) after 1m0s
[04:55:35.892] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9020962846612336272:49:0)
[04:55:35.892] Timer tick, asking Buildbucket for the build status
[04:55:35.969] Build 8855532784569403568: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[04:55:35.970] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9020962846612336272:50:0) after 1m0s
[04:56:35.990] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9020962846612336272:50:0)
[04:56:35.990] Timer tick, asking Buildbucket for the build status
[04:56:36.067] Build 8855532784569403568: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[04:56:36.067] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9020962846612336272:51:0) after 1m0s
[04:57:36.087] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9020962846612336272:51:0)
[04:57:36.087] Timer tick, asking Buildbucket for the build status
[04:57:36.156] Build 8855532784569403568: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[04:57:36.156] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9020962846612336272:52:0) after 1m0s
[04:58:36.178] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9020962846612336272:52:0)
[04:58:36.178] Timer tick, asking Buildbucket for the build status
[04:58:36.255] Build 8855532784569403568: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[04:58:36.255] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9020962846612336272:53:0) after 1m0s
[04:59:36.278] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9020962846612336272:53:0)
[04:59:36.278] Timer tick, asking Buildbucket for the build status
[04:59:36.348] Build 8855532784569403568: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[04:59:36.348] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9020962846612336272:54:0) after 1m0s
[05:00:36.377] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9020962846612336272:54:0)
[05:00:36.377] Timer tick, asking Buildbucket for the build status
[05:00:36.459] Build 8855532784569403568: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[05:00:36.459] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9020962846612336272:55:0) after 1m0s
[05:01:36.491] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9020962846612336272:55:0)
[05:01:36.491] Timer tick, asking Buildbucket for the build status
[05:01:36.583] Build 8855532784569403568: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[05:01:36.583] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9020962846612336272:56:0) after 1m0s
[05:02:36.614] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9020962846612336272:56:0)
[05:02:36.614] Timer tick, asking Buildbucket for the build status
[05:02:36.708] Build 8855532784569403568: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[05:02:36.708] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9020962846612336272:57:0) after 1m0s
[05:03:36.777] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9020962846612336272:57:0)
[05:03:36.777] Timer tick, asking Buildbucket for the build status
[05:03:36.871] Build 8855532784569403568: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[05:03:36.871] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9020962846612336272:58:0) after 1m0s
[05:04:36.892] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9020962846612336272:58:0)
[05:04:36.892] Timer tick, asking Buildbucket for the build status
[05:04:36.986] Build 8855532784569403568: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[05:04:36.986] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9020962846612336272:59:0) after 1m0s
[05:05:37.070] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9020962846612336272:59:0)
[05:05:37.070] Timer tick, asking Buildbucket for the build status
[05:05:37.146] Build 8855532784569403568: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[05:05:37.146] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9020962846612336272:60:0) after 1m0s
[05:06:37.203] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9020962846612336272:60:0)
[05:06:37.203] Timer tick, asking Buildbucket for the build status
[05:06:37.283] Build 8855532784569403568: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[05:06:37.283] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9020962846612336272:61:0) after 1m0s
[05:07:37.365] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9020962846612336272:61:0)
[05:07:37.365] Timer tick, asking Buildbucket for the build status
[05:07:37.443] Build 8855532784569403568: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[05:07:37.443] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9020962846612336272:62:0) after 1m0s
[05:08:37.479] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9020962846612336272:62:0)
[05:08:37.479] Timer tick, asking Buildbucket for the build status
[05:08:37.566] Build 8855532784569403568: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[05:08:37.566] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9020962846612336272:63:0) after 1m0s
[05:09:37.670] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9020962846612336272:63:0)
[05:09:37.670] Timer tick, asking Buildbucket for the build status
[05:09:37.754] Build 8855532784569403568: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[05:09:37.754] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9020962846612336272:64:0) after 1m0s
[05:10:37.857] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9020962846612336272:64:0)
[05:10:37.857] Timer tick, asking Buildbucket for the build status
[05:10:37.945] Build 8855532784569403568: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[05:10:37.945] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9020962846612336272:65:0) after 1m0s
[05:11:37.968] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9020962846612336272:65:0)
[05:11:37.968] Timer tick, asking Buildbucket for the build status
[05:11:38.058] Build 8855532784569403568: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[05:11:38.058] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9020962846612336272:66:0) after 1m0s
[05:12:38.097] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9020962846612336272:66:0)
[05:12:38.097] Timer tick, asking Buildbucket for the build status
[05:12:38.179] Build 8855532784569403568: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[05:12:38.179] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9020962846612336272:67:0) after 1m0s
[05:13:38.210] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9020962846612336272:67:0)
[05:13:38.210] Timer tick, asking Buildbucket for the build status
[05:13:38.295] Build 8855532784569403568: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[05:13:38.295] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9020962846612336272:68:0) after 1m0s
[05:14:38.405] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9020962846612336272:68:0)
[05:14:38.405] Timer tick, asking Buildbucket for the build status
[05:14:38.479] Build 8855532784569403568: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[05:14:38.479] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9020962846612336272:69:0) after 1m0s
[05:15:38.503] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9020962846612336272:69:0)
[05:15:38.503] Timer tick, asking Buildbucket for the build status
[05:15:38.582] Build 8855532784569403568: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[05:15:38.582] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9020962846612336272:70:0) after 1m0s
[05:16:38.603] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9020962846612336272:70:0)
[05:16:38.603] Timer tick, asking Buildbucket for the build status
[05:16:38.671] Build 8855532784569403568: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[05:16:38.671] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9020962846612336272:71:0) after 1m0s
[05:17:38.774] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9020962846612336272:71:0)
[05:17:38.774] Timer tick, asking Buildbucket for the build status
[05:17:38.860] Build 8855532784569403568: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[05:17:38.860] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9020962846612336272:72:0) after 1m0s
[05:18:38.885] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9020962846612336272:72:0)
[05:18:38.885] Timer tick, asking Buildbucket for the build status
[05:18:38.958] Build 8855532784569403568: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[05:18:38.958] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9020962846612336272:73:0) after 1m0s
[05:19:38.985] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9020962846612336272:73:0)
[05:19:38.985] Timer tick, asking Buildbucket for the build status
[05:19:39.197] Build 8855532784569403568: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[05:19:39.197] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9020962846612336272:74:0) after 1m0s
[05:20:39.273] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9020962846612336272:74:0)
[05:20:39.273] Timer tick, asking Buildbucket for the build status
[05:20:39.346] Build 8855532784569403568: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[05:20:39.346] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9020962846612336272:75:0) after 1m0s
[05:21:39.403] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9020962846612336272:75:0)
[05:21:39.403] Timer tick, asking Buildbucket for the build status
[05:21:39.491] Build 8855532784569403568: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[05:21:39.491] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9020962846612336272:76:0) after 1m0s
[05:22:39.605] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9020962846612336272:76:0)
[05:22:39.605] Timer tick, asking Buildbucket for the build status
[05:22:39.762] Build 8855532784569403568: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[05:22:39.762] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9020962846612336272:77:0) after 1m0s
[05:23:39.867] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9020962846612336272:77:0)
[05:23:39.867] Timer tick, asking Buildbucket for the build status
[05:23:39.962] Build 8855532784569403568: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[05:23:39.962] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9020962846612336272:78:0) after 1m0s
[05:24:39.992] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9020962846612336272:78:0)
[05:24:39.992] Timer tick, asking Buildbucket for the build status
[05:24:40.109] Build 8855532784569403568: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[05:24:40.109] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9020962846612336272:79:0) after 1m0s
[05:25:40.136] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9020962846612336272:79:0)
[05:25:40.136] Timer tick, asking Buildbucket for the build status
[05:25:40.211] Build 8855532784569403568: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[05:25:40.211] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9020962846612336272:80:0) after 1m0s
[05:26:40.232] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9020962846612336272:80:0)
[05:26:40.232] Timer tick, asking Buildbucket for the build status
[05:26:40.307] Build 8855532784569403568: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[05:26:40.307] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9020962846612336272:81:0) after 1m0s
[05:27:40.405] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9020962846612336272:81:0)
[05:27:40.405] Timer tick, asking Buildbucket for the build status
[05:27:40.506] Build 8855532784569403568: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[05:27:40.506] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9020962846612336272:82:0) after 1m0s
[05:28:40.530] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9020962846612336272:82:0)
[05:28:40.530] Timer tick, asking Buildbucket for the build status
[05:28:40.614] Build 8855532784569403568: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[05:28:40.614] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9020962846612336272:83:0) after 1m0s
[05:29:40.691] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9020962846612336272:83:0)
[05:29:40.691] Timer tick, asking Buildbucket for the build status
[05:29:40.769] Build 8855532784569403568: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[05:29:40.769] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9020962846612336272:84:0) after 1m0s
[05:30:40.875] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9020962846612336272:84:0)
[05:30:40.875] Timer tick, asking Buildbucket for the build status
[05:30:40.983] Build 8855532784569403568: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[05:30:40.983] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9020962846612336272:85:0) after 1m0s
[05:31:41.065] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9020962846612336272:85:0)
[05:31:41.065] Timer tick, asking Buildbucket for the build status
[05:31:41.228] Build 8855532784569403568: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[05:31:41.228] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9020962846612336272:86:0) after 1m0s
[05:32:41.269] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9020962846612336272:86:0)
[05:32:41.269] Timer tick, asking Buildbucket for the build status
[05:32:41.341] Build 8855532784569403568: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[05:32:41.341] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9020962846612336272:87:0) after 1m0s
[05:33:41.404] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9020962846612336272:87:0)
[05:33:41.404] Timer tick, asking Buildbucket for the build status
[05:33:41.529] Build 8855532784569403568: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[05:33:41.529] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9020962846612336272:88:0) after 1m0s
[05:34:41.560] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9020962846612336272:88:0)
[05:34:41.560] Timer tick, asking Buildbucket for the build status
[05:34:41.652] Build 8855532784569403568: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[05:34:41.652] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9020962846612336272:89:0) after 1m0s
[05:35:41.771] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9020962846612336272:89:0)
[05:35:41.771] Timer tick, asking Buildbucket for the build status
[05:35:41.849] Build 8855532784569403568: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[05:35:41.849] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9020962846612336272:90:0) after 1m0s
[05:36:41.910] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9020962846612336272:90:0)
[05:36:41.910] Timer tick, asking Buildbucket for the build status
[05:36:41.988] Build 8855532784569403568: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[05:36:41.988] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9020962846612336272:91:0) after 1m0s
[05:37:42.112] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9020962846612336272:91:0)
[05:37:42.112] Timer tick, asking Buildbucket for the build status
[05:37:42.285] Build 8855532784569403568: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[05:37:42.285] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9020962846612336272:92:0) after 1m0s
[05:38:42.394] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9020962846612336272:92:0)
[05:38:42.394] Timer tick, asking Buildbucket for the build status
[05:38:42.717] Build 8855532784569403568: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[05:38:42.717] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9020962846612336272:93:0) after 1m0s
[05:39:42.809] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9020962846612336272:93:0)
[05:39:42.809] Timer tick, asking Buildbucket for the build status
[05:39:42.950] Build 8855532784569403568: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[05:39:42.950] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9020962846612336272:94:0) after 1m0s
[05:40:43.005] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9020962846612336272:94:0)
[05:40:43.006] Timer tick, asking Buildbucket for the build status
[05:40:43.155] Build 8855532784569403568: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[05:40:43.155] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9020962846612336272:95:0) after 1m0s
[05:41:43.278] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9020962846612336272:95:0)
[05:41:43.278] Timer tick, asking Buildbucket for the build status
[05:41:43.365] Build 8855532784569403568: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[05:41:43.365] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9020962846612336272:96:0) after 1m0s
[05:42:43.409] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9020962846612336272:96:0)
[05:42:43.409] Timer tick, asking Buildbucket for the build status
[05:42:43.671] Build 8855532784569403568: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[05:42:43.671] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9020962846612336272:97:0) after 1m0s
[05:43:43.714] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9020962846612336272:97:0)
[05:43:43.714] Timer tick, asking Buildbucket for the build status
[05:43:44.105] Build 8855532784569403568: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[05:43:44.105] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9020962846612336272:98:0) after 1m0s
[05:44:44.206] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9020962846612336272:98:0)
[05:44:44.206] Timer tick, asking Buildbucket for the build status
[05:44:44.561] Build 8855532784569403568: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[05:44:44.561] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9020962846612336272:99:0) after 1m0s
[05:45:44.659] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9020962846612336272:99:0)
[05:45:44.659] Timer tick, asking Buildbucket for the build status
[05:45:45.093] Build 8855532784569403568: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[05:45:45.093] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9020962846612336272:100:0) after 1m0s
[05:46:45.125] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9020962846612336272:100:0)
[05:46:45.125] Timer tick, asking Buildbucket for the build status
[05:46:45.327] Build 8855532784569403568: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[05:46:45.327] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9020962846612336272:101:0) after 1m0s
[05:47:45.368] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9020962846612336272:101:0)
[05:47:45.368] Timer tick, asking Buildbucket for the build status
[05:47:45.651] Build 8855532784569403568: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[05:47:45.651] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9020962846612336272:102:0) after 1m0s
[05:48:45.675] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9020962846612336272:102:0)
[05:48:45.675] Timer tick, asking Buildbucket for the build status
[05:48:46.022] Build 8855532784569403568: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[05:48:46.022] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9020962846612336272:103:0) after 1m0s
[05:50:47.402] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9020962846612336272:103:0)
[05:50:47.402] Timer tick, asking Buildbucket for the build status
[05:50:47.489] Build 8855532784569403568: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[05:50:47.489] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9020962846612336272:104:0) after 1m0s
[05:51:47.556] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9020962846612336272:104:0)
[05:51:47.556] Timer tick, asking Buildbucket for the build status
[05:51:47.636] Build 8855532784569403568: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[05:51:47.636] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9020962846612336272:105:0) after 1m0s
[05:52:47.693] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9020962846612336272:105:0)
[05:52:47.693] Timer tick, asking Buildbucket for the build status
[05:52:47.815] Build 8855532784569403568: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[05:52:47.815] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9020962846612336272:106:0) after 1m0s
[05:53:47.893] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9020962846612336272:106:0)
[05:53:47.894] Timer tick, asking Buildbucket for the build status
[05:53:47.977] Build 8855532784569403568: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[05:53:47.977] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9020962846612336272:107:0) after 1m0s
[05:54:48.008] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9020962846612336272:107:0)
[05:54:48.008] Timer tick, asking Buildbucket for the build status
[05:54:48.093] Build 8855532784569403568: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[05:54:48.093] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9020962846612336272:108:0) after 1m0s
[05:55:48.124] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9020962846612336272:108:0)
[05:55:48.124] Timer tick, asking Buildbucket for the build status
[05:55:48.242] Build 8855532784569403568: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[05:55:48.242] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9020962846612336272:109:0) after 1m0s
[05:56:48.296] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9020962846612336272:109:0)
[05:56:48.296] Timer tick, asking Buildbucket for the build status
[05:56:48.376] Build 8855532784569403568: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[05:56:48.376] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9020962846612336272:110:0) after 1m0s
[05:57:48.406] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9020962846612336272:110:0)
[05:57:48.406] Timer tick, asking Buildbucket for the build status
[05:57:48.505] Build 8855532784569403568: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[05:57:48.505] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9020962846612336272:111:0) after 1m0s
[05:58:48.603] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9020962846612336272:111:0)
[05:58:48.603] Timer tick, asking Buildbucket for the build status
[05:58:48.696] Build 8855532784569403568: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[05:58:48.696] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9020962846612336272:112:0) after 1m0s
[05:59:48.808] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9020962846612336272:112:0)
[05:59:48.808] Timer tick, asking Buildbucket for the build status
[05:59:48.923] Build 8855532784569403568: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[05:59:48.923] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9020962846612336272:113:0) after 1m0s
[06:00:49.091] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9020962846612336272:113:0)
[06:00:49.091] Timer tick, asking Buildbucket for the build status
[06:00:49.160] Build 8855532784569403568: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[06:00:49.160] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9020962846612336272:114:0) after 1m0s
[06:01:49.260] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9020962846612336272:114:0)
[06:01:49.260] Timer tick, asking Buildbucket for the build status
[06:01:49.372] Build 8855532784569403568: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[06:01:49.372] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9020962846612336272:115:0) after 1m0s
[06:02:26.560] Received PubSub notification, asking Buildbucket for the build status
[06:02:26.661] Build 8855532784569403568: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:02:49.404] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9020962846612336272:115:0)
[06:02:49.404] Timer tick, asking Buildbucket for the build status
[06:02:49.484] Build 8855532784569403568: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:02:49.484] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9020962846612336272:117:0) after 1m0s
[06:03:49.514] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9020962846612336272:117:0)
[06:03:49.514] Timer tick, asking Buildbucket for the build status
[06:03:49.592] Build 8855532784569403568: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:03:49.592] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9020962846612336272:118:0) after 1m0s
[06:04:49.670] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9020962846612336272:118:0)
[06:04:49.670] Timer tick, asking Buildbucket for the build status
[06:04:49.765] Build 8855532784569403568: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:04:49.765] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9020962846612336272:119:0) after 1m0s
[06:05:49.806] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9020962846612336272:119:0)
[06:05:49.806] Timer tick, asking Buildbucket for the build status
[06:05:49.904] Build 8855532784569403568: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:05:49.904] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9020962846612336272:120:0) after 1m0s
[06:06:50.006] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9020962846612336272:120:0)
[06:06:50.006] Timer tick, asking Buildbucket for the build status
[06:06:50.096] Build 8855532784569403568: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:06:50.096] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9020962846612336272:121:0) after 1m0s
[06:07:50.137] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9020962846612336272:121:0)
[06:07:50.137] Timer tick, asking Buildbucket for the build status
[06:07:50.237] Build 8855532784569403568: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:07:50.237] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9020962846612336272:122:0) after 1m0s
[06:08:50.307] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9020962846612336272:122:0)
[06:08:50.307] Timer tick, asking Buildbucket for the build status
[06:08:50.390] Build 8855532784569403568: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:08:50.390] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9020962846612336272:123:0) after 1m0s
[06:09:30.359] Received PubSub notification, asking Buildbucket for the build status
[06:09:30.459] Build 8855532784569403568: status "COMPLETED", result "SUCCESS", failure_reason "", cancelation_reason ""
[06:09:30.459] Buildbucket build:
{
"build": {
"bucket": "luci.infra.ci",
"canary_preference": "PROD",
"completed_ts": "1613110169783327",
"created_by": "project:infra",
"created_ts": "1613102847470479",
"id": "8855532784569403568",
"lease_expiration_ts": "-62135596800000000",
"parameters_json": "{\"builder_name\": \"infra-continuous-win10-64\", \"properties\": {\"$recipe_engine/scheduler\": {\"hostname\": \"luci-scheduler-dev.appspot.com\", \"triggers\": [{\"gitiles\": {\"ref\": \"refs/heads/master\", \"repo\": \"https://chromium.googlesource.com/infra/infra\", \"revision\": \"2abc3d146991b08b04c7069e8d6da4ecea147045\"}, \"id\": \"https://chromium.googlesource.com/infra/infra/+/refs/heads/master@2abc3d146991b08b04c7069e8d6da4ecea147045\", \"title\": \"2abc3d146991b08b04c7069e8d6da4ecea147045\", \"url\": \"https://chromium.googlesource.com/infra/infra/+/2abc3d146991b08b04c7069e8d6da4ecea147045\"}, {\"gitiles\": {\"ref\": \"refs/heads/master\", \"repo\": \"https://chromium.googlesource.com/infra/infra\", \"revision\": \"0f062ddb4e34198104af7609739c7f1968721cc3\"}, \"id\": \"https://chromium.googlesource.com/infra/infra/+/refs/heads/master@0f062ddb4e34198104af7609739c7f1968721cc3\", \"title\": \"0f062ddb4e34198104af7609739c7f1968721cc3\", \"url\": \"https://chromium.googlesource.com/infra/infra/+/0f062ddb4e34198104af7609739c7f1968721cc3\"}, {\"gitiles\": {\"ref\": \"refs/heads/master\", \"repo\": \"https://chromium.googlesource.com/infra/infra\", \"revision\": \"c728a4e7cb6ab74d0f80552a27109c3152464433\"}, \"id\": \"https://chromium.googlesource.com/infra/infra/+/refs/heads/master@c728a4e7cb6ab74d0f80552a27109c3152464433\", \"title\": \"c728a4e7cb6ab74d0f80552a27109c3152464433\", \"url\": \"https://chromium.googlesource.com/infra/infra/+/c728a4e7cb6ab74d0f80552a27109c3152464433\"}, {\"gitiles\": {\"ref\": \"refs/heads/master\", \"repo\": \"https://chromium.googlesource.com/infra/infra\", \"revision\": \"94d518709f4c007206843c635a14d71c30942150\"}, \"id\": \"https://chromium.googlesource.com/infra/infra/+/refs/heads/master@94d518709f4c007206843c635a14d71c30942150\", \"title\": \"94d518709f4c007206843c635a14d71c30942150\", \"url\": \"https://chromium.googlesource.com/infra/infra/+/94d518709f4c007206843c635a14d71c30942150\"}]}, \"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/infra/infra\", \"revision\": \"94d518709f4c007206843c635a14d71c30942150\"}}",
"project": "infra",
"result": "SUCCESS",
"result_details_json": "{\"properties\": {\"got_revision\": \"94d518709f4c007206843c635a14d71c30942150\", \"got_revision_cp\": \"refs/heads/master@{#38478}\"}, \"swarming\": {\"bot_dimensions\": {\"caches\": [\"builder_044445a3bc7a4bfe795493d7956aa02cd526172de1fa7300f69fe152e82ea631_v2\", \"builder_5de1032f0e9ef497433aad28840ee258c037976023b410f653133cee0ad04e2c_v2\", \"builder_82ed111fed7ea8169e482f00b5f3e5338a65daa41208585de67cb0a736b1d538_v2\", \"builder_a9c54e560aab64ffcab932ab26ad711a72ff73dbcd0bfe47f54d3e3349e5c381_v2\", \"builder_d38bdc976f893fc6930479dce8a6d7dc793b2a74fe1392d4af00713a5c0bb46e_v2\", \"git\", \"goma\", \"infra_gclient_with_go\", \"vpython\"], \"cores\": [\"32\"], \"cpu\": [\"x86\", \"x86-64\", \"x86-64-Broadwell_GCE\"], \"gce\": [\"1\"], \"gcp\": [\"google.com:chromecompute\"], \"gpu\": [\"none\"], \"id\": [\"dev-luci-chromium-ci-win10-0-lwlk\"], \"image\": [\"chrome-win10-1703-20111600-a937a23cefb\"], \"integrity\": [\"high\"], \"locale\": [\"en_US.cp1252\"], \"machine_type\": [\"n1-standard-32\"], \"os\": [\"Windows\", \"Windows-10\", \"Windows-10-15063\"], \"pool\": [\"luci.chromium.ci\"], \"python\": [\"2.7.13\"], \"server_version\": [\"5690-40331dd\"], \"ssd\": [\"0\"], \"windows_client_version\": [\"10\"], \"zone\": [\"us\", \"us-west\", \"us-west1\", \"us-west1-c\"]}}}",
"service_account": "adhoc-testing@luci-token-server-dev.iam.gserviceaccount.com",
"started_ts": "1613109744643518",
"status": "COMPLETED",
"status_changed_ts": "1613109745102636",
"tags": [
"build_address:luci.infra.ci/infra-continuous-win10-64/18592",
"builder:infra-continuous-win10-64",
"buildset:commit/git/94d518709f4c007206843c635a14d71c30942150",
"buildset:commit/gitiles/chromium.googlesource.com/infra/infra/+/94d518709f4c007206843c635a14d71c30942150",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9020962846612336272",
"scheduler_job_id:infra/infra-continuous-win10-64",
"swarming_hostname:chromium-swarm-dev.appspot.com",
"swarming_tag:log_location:logdog://luci-logdog-dev.appspot.com/infra/buildbucket/cr-buildbucket-dev.appspot.com/8855532784569403568/+/annotations",
"swarming_tag:luci_project:infra",
"swarming_tag:os:Windows",
"swarming_tag:recipe_name:infra_continuous",
"swarming_tag:recipe_package:infra/recipe_bundles/chromium.googlesource.com/infra/infra",
"swarming_task_id:51ad3da0c5443510",
"user_agent:luci-scheduler-dev"
],
"updated_ts": "1613109745129273",
"url": "https://luci-milo-dev.appspot.com/b/8855532784569403568",
"utcnow_ts": "1613110170452640"
}
}
[06:09:30.459] Invocation finished in 2h2m4.321245711s with status SUCCEEDED