[14:50:46.137] New invocation is queued and will start shortly
[14:50:47.308] Starting the invocation (attempt 1)
[14:50:47.351] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[14:50:47.351] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[14:50:47.351] Buildbucket request:
{
"bucket": "luci.chromium.ci",
"client_operation_id": "9061962797377588848",
"parameters_json": "{\"builder_name\":\"Windows deterministic\",\"properties\":{\"branch\":\"refs/heads/master\",\"repository\":\"https://chromium.googlesource.com/chromium/src\",\"revision\":\"735232390e9de8fe155af38823db1d4ac6cabed6\"}}",
"pubsub_callback": {
"auth_token": "...",
"topic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
},
"tags": [
"builder:Windows deterministic",
"scheduler_invocation_id:9061962797377588848",
"scheduler_job_id:chromium/Windows deterministic",
"user_agent:luci-scheduler",
"buildset:commit/git/735232390e9de8fe155af38823db1d4ac6cabed6",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/735232390e9de8fe155af38823db1d4ac6cabed6",
"gitiles_ref:refs/heads/master"
]
}
[14:50:48.724] Buildbucket response:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "PROD",
"created_by": "project:chromium",
"created_ts": "1574002247907671",
"id": "8896532734857017632",
"parameters_json": "{\"builder_name\": \"Windows deterministic\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"735232390e9de8fe155af38823db1d4ac6cabed6\"}}",
"project": "chromium",
"result_details_json": "{\"properties\": {}}",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"status": "SCHEDULED",
"status_changed_ts": "1574002248571990",
"tags": [
"build_address:luci.chromium.ci/Windows deterministic/15227",
"builder:Windows deterministic",
"buildset:commit/git/735232390e9de8fe155af38823db1d4ac6cabed6",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/735232390e9de8fe155af38823db1d4ac6cabed6",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9061962797377588848",
"scheduler_job_id:chromium/Windows deterministic",
"swarming_hostname:chromium-swarm.appspot.com",
"swarming_tag:log_location:logdog://logs.chromium.org/chromium/buildbucket/cr-buildbucket.appspot.com/8896532734857017632/+/annotations",
"swarming_tag:luci_project:chromium",
"swarming_tag:recipe_name:swarming/deterministic_build",
"swarming_tag:recipe_package:infra/recipe_bundles/chromium.googlesource.com/chromium/tools/build",
"swarming_task_id:",
"user_agent:luci-scheduler"
],
"updated_ts": "1574002248572111",
"url": "https://ci.chromium.org/b/8896532734857017632",
"utcnow_ts": "1574002248708314"
}
}
[14:50:48.724] Task URL: https://ci.chromium.org/b/8896532734857017632
[14:50:48.724] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9061962797377588848:2:0) after 1m0s
[14:52:14.699] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9061962797377588848:2:0)
[14:52:14.699] Timer tick, asking Buildbucket for the build status
[14:52:14.873] Build 8896532734857017632: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[14:52:14.873] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9061962797377588848:3:0) after 1m0s
[14:52:55.039] Received PubSub notification, asking Buildbucket for the build status
[14:52:55.209] Build 8896532734857017632: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:53:14.900] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9061962797377588848:3:0)
[14:53:14.900] Timer tick, asking Buildbucket for the build status
[14:53:15.086] Build 8896532734857017632: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:53:15.086] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9061962797377588848:5:0) after 1m0s
[14:54:15.159] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9061962797377588848:5:0)
[14:54:15.159] Timer tick, asking Buildbucket for the build status
[14:54:15.935] Build 8896532734857017632: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:54:15.935] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9061962797377588848:6:0) after 1m0s
[14:55:15.988] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9061962797377588848:6:0)
[14:55:15.988] Timer tick, asking Buildbucket for the build status
[14:55:16.954] Build 8896532734857017632: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:55:16.954] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9061962797377588848:7:0) after 1m0s
[14:56:17.033] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9061962797377588848:7:0)
[14:56:17.033] Timer tick, asking Buildbucket for the build status
[14:56:18.042] Build 8896532734857017632: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:56:18.042] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9061962797377588848:8:0) after 1m0s
[14:57:18.064] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9061962797377588848:8:0)
[14:57:18.064] Timer tick, asking Buildbucket for the build status
[14:57:18.285] Build 8896532734857017632: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:57:18.285] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9061962797377588848:9:0) after 1m0s
[14:58:18.308] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9061962797377588848:9:0)
[14:58:18.308] Timer tick, asking Buildbucket for the build status
[14:58:18.474] Build 8896532734857017632: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:58:18.474] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9061962797377588848:10:0) after 1m0s
[14:59:18.624] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9061962797377588848:10:0)
[14:59:18.624] Timer tick, asking Buildbucket for the build status
[14:59:18.769] Build 8896532734857017632: status "STARTED", result "", failure_reason "", cancelation_reason ""
[14:59:18.770] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9061962797377588848:11:0) after 1m0s
[15:00:19.052] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9061962797377588848:11:0)
[15:00:19.052] Timer tick, asking Buildbucket for the build status
[15:00:19.396] Build 8896532734857017632: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:00:19.396] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9061962797377588848:12:0) after 1m0s
[15:01:19.519] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9061962797377588848:12:0)
[15:01:19.519] Timer tick, asking Buildbucket for the build status
[15:01:19.669] Build 8896532734857017632: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:01:19.669] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9061962797377588848:13:0) after 1m0s
[15:02:19.771] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9061962797377588848:13:0)
[15:02:19.771] Timer tick, asking Buildbucket for the build status
[15:02:20.716] Build 8896532734857017632: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:02:20.716] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9061962797377588848:14:0) after 1m0s
[15:03:20.926] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9061962797377588848:14:0)
[15:03:20.926] Timer tick, asking Buildbucket for the build status
[15:03:21.226] Build 8896532734857017632: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:03:21.226] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9061962797377588848:15:0) after 1m0s
[15:04:21.349] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9061962797377588848:15:0)
[15:04:21.349] Timer tick, asking Buildbucket for the build status
[15:04:21.491] Build 8896532734857017632: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:04:21.491] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9061962797377588848:16:0) after 1m0s
[15:05:21.634] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9061962797377588848:16:0)
[15:05:21.634] Timer tick, asking Buildbucket for the build status
[15:05:22.982] Build 8896532734857017632: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:05:22.982] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9061962797377588848:17:0) after 1m0s
[15:06:23.060] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9061962797377588848:17:0)
[15:06:23.060] Timer tick, asking Buildbucket for the build status
[15:06:24.193] Build 8896532734857017632: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:06:24.193] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9061962797377588848:18:0) after 1m0s
[15:07:24.256] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9061962797377588848:18:0)
[15:07:24.256] Timer tick, asking Buildbucket for the build status
[15:07:24.666] Build 8896532734857017632: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:07:24.666] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9061962797377588848:19:0) after 1m0s
[15:08:24.760] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9061962797377588848:19:0)
[15:08:24.760] Timer tick, asking Buildbucket for the build status
[15:08:25.819] Build 8896532734857017632: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:08:25.819] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9061962797377588848:20:0) after 1m0s
[15:09:25.851] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9061962797377588848:20:0)
[15:09:25.851] Timer tick, asking Buildbucket for the build status
[15:09:26.049] Build 8896532734857017632: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:09:26.049] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9061962797377588848:21:0) after 1m0s
[15:10:26.248] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9061962797377588848:21:0)
[15:10:26.248] Timer tick, asking Buildbucket for the build status
[15:10:26.456] Build 8896532734857017632: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:10:26.456] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9061962797377588848:22:0) after 1m0s
[15:11:26.549] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9061962797377588848:22:0)
[15:11:26.549] Timer tick, asking Buildbucket for the build status
[15:11:26.679] Build 8896532734857017632: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:11:26.679] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9061962797377588848:23:0) after 1m0s
[15:12:26.782] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9061962797377588848:23:0)
[15:12:26.782] Timer tick, asking Buildbucket for the build status
[15:12:28.039] Build 8896532734857017632: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:12:28.039] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9061962797377588848:24:0) after 1m0s
[15:13:28.059] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9061962797377588848:24:0)
[15:13:28.059] Timer tick, asking Buildbucket for the build status
[15:13:28.287] Build 8896532734857017632: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:13:28.287] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9061962797377588848:25:0) after 1m0s
[15:14:28.289] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9061962797377588848:25:0)
[15:14:28.289] Timer tick, asking Buildbucket for the build status
[15:14:28.570] Build 8896532734857017632: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:14:28.570] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9061962797377588848:26:0) after 1m0s
[15:15:28.689] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9061962797377588848:26:0)
[15:15:28.689] Timer tick, asking Buildbucket for the build status
[15:15:29.421] Build 8896532734857017632: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:15:29.421] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9061962797377588848:27:0) after 1m0s
[15:16:29.443] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9061962797377588848:27:0)
[15:16:29.443] Timer tick, asking Buildbucket for the build status
[15:16:29.701] Build 8896532734857017632: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:16:29.701] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9061962797377588848:28:0) after 1m0s
[15:17:29.702] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9061962797377588848:28:0)
[15:17:29.702] Timer tick, asking Buildbucket for the build status
[15:17:31.046] Build 8896532734857017632: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:17:31.046] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9061962797377588848:29:0) after 1m0s
[15:18:31.117] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9061962797377588848:29:0)
[15:18:31.117] Timer tick, asking Buildbucket for the build status
[15:18:31.460] Build 8896532734857017632: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:18:31.460] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9061962797377588848:30:0) after 1m0s
[15:19:31.575] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9061962797377588848:30:0)
[15:19:31.575] Timer tick, asking Buildbucket for the build status
[15:19:32.109] Build 8896532734857017632: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:19:32.109] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9061962797377588848:31:0) after 1m0s
[15:20:32.117] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9061962797377588848:31:0)
[15:20:32.117] Timer tick, asking Buildbucket for the build status
[15:20:32.273] Build 8896532734857017632: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:20:32.273] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9061962797377588848:32:0) after 1m0s
[15:21:32.293] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9061962797377588848:32:0)
[15:21:32.293] Timer tick, asking Buildbucket for the build status
[15:21:32.728] Build 8896532734857017632: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:21:32.728] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9061962797377588848:33:0) after 1m0s
[15:22:32.758] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9061962797377588848:33:0)
[15:22:32.758] Timer tick, asking Buildbucket for the build status
[15:22:33.399] Build 8896532734857017632: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:22:33.399] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9061962797377588848:34:0) after 1m0s
[15:23:33.493] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9061962797377588848:34:0)
[15:23:33.493] Timer tick, asking Buildbucket for the build status
[15:23:35.627] Build 8896532734857017632: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:23:35.627] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9061962797377588848:35:0) after 1m0s
[15:24:35.689] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9061962797377588848:35:0)
[15:24:35.689] Timer tick, asking Buildbucket for the build status
[15:24:35.946] Build 8896532734857017632: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:24:35.946] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9061962797377588848:36:0) after 1m0s
[15:25:35.970] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9061962797377588848:36:0)
[15:25:35.970] Timer tick, asking Buildbucket for the build status
[15:25:36.119] Build 8896532734857017632: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:25:36.119] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9061962797377588848:37:0) after 1m0s
[15:26:36.197] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9061962797377588848:37:0)
[15:26:36.197] Timer tick, asking Buildbucket for the build status
[15:26:36.648] Build 8896532734857017632: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:26:36.648] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9061962797377588848:38:0) after 1m0s
[15:27:37.590] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9061962797377588848:38:0)
[15:27:37.590] Timer tick, asking Buildbucket for the build status
[15:27:37.725] Build 8896532734857017632: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:27:37.725] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9061962797377588848:39:0) after 1m0s
[15:28:38.047] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9061962797377588848:39:0)
[15:28:38.047] Timer tick, asking Buildbucket for the build status
[15:28:38.202] Build 8896532734857017632: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:28:38.202] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9061962797377588848:40:0) after 1m0s
[15:29:38.582] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9061962797377588848:40:0)
[15:29:38.582] Timer tick, asking Buildbucket for the build status
[15:29:38.912] Build 8896532734857017632: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:29:38.912] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9061962797377588848:41:0) after 1m0s
[15:30:38.951] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9061962797377588848:41:0)
[15:30:38.951] Timer tick, asking Buildbucket for the build status
[15:30:39.575] Build 8896532734857017632: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:30:39.575] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9061962797377588848:42:0) after 1m0s
[15:31:39.818] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9061962797377588848:42:0)
[15:31:39.818] Timer tick, asking Buildbucket for the build status
[15:31:40.584] Build 8896532734857017632: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:31:40.584] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9061962797377588848:43:0) after 1m0s
[15:32:40.615] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9061962797377588848:43:0)
[15:32:40.615] Timer tick, asking Buildbucket for the build status
[15:32:40.822] Build 8896532734857017632: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:32:40.822] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9061962797377588848:44:0) after 1m0s
[15:33:41.075] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9061962797377588848:44:0)
[15:33:41.075] Timer tick, asking Buildbucket for the build status
[15:33:41.221] Build 8896532734857017632: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:33:41.221] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9061962797377588848:45:0) after 1m0s
[15:34:41.505] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9061962797377588848:45:0)
[15:34:41.505] Timer tick, asking Buildbucket for the build status
[15:34:42.059] Build 8896532734857017632: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:34:42.059] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9061962797377588848:46:0) after 1m0s
[15:35:42.340] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9061962797377588848:46:0)
[15:35:42.340] Timer tick, asking Buildbucket for the build status
[15:35:42.842] Build 8896532734857017632: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:35:42.842] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9061962797377588848:47:0) after 1m0s
[15:36:42.939] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9061962797377588848:47:0)
[15:36:42.939] Timer tick, asking Buildbucket for the build status
[15:36:43.300] Build 8896532734857017632: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:36:43.300] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9061962797377588848:48:0) after 1m0s
[15:37:43.327] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9061962797377588848:48:0)
[15:37:43.327] Timer tick, asking Buildbucket for the build status
[15:37:43.766] Build 8896532734857017632: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:37:43.766] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9061962797377588848:49:0) after 1m0s
[15:38:44.665] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9061962797377588848:49:0)
[15:38:44.665] Timer tick, asking Buildbucket for the build status
[15:38:44.810] Build 8896532734857017632: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:38:44.810] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9061962797377588848:50:0) after 1m0s
[15:39:45.205] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9061962797377588848:50:0)
[15:39:45.205] Timer tick, asking Buildbucket for the build status
[15:39:45.358] Build 8896532734857017632: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:39:45.358] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9061962797377588848:51:0) after 1m0s
[15:40:45.583] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9061962797377588848:51:0)
[15:40:45.583] Timer tick, asking Buildbucket for the build status
[15:40:45.731] Build 8896532734857017632: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:40:45.731] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9061962797377588848:52:0) after 1m0s
[15:41:46.094] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9061962797377588848:52:0)
[15:41:46.094] Timer tick, asking Buildbucket for the build status
[15:41:47.416] Build 8896532734857017632: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:41:47.416] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9061962797377588848:53:0) after 1m0s
[15:42:47.459] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9061962797377588848:53:0)
[15:42:47.459] Timer tick, asking Buildbucket for the build status
[15:42:47.994] Build 8896532734857017632: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:42:47.994] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9061962797377588848:54:0) after 1m0s
[15:43:48.092] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9061962797377588848:54:0)
[15:43:48.092] Timer tick, asking Buildbucket for the build status
[15:43:48.358] Build 8896532734857017632: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:43:48.358] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9061962797377588848:55:0) after 1m0s
[15:44:48.934] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9061962797377588848:55:0)
[15:44:48.934] Timer tick, asking Buildbucket for the build status
[15:44:49.063] Build 8896532734857017632: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:44:49.063] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9061962797377588848:56:0) after 1m0s
[15:45:49.334] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9061962797377588848:56:0)
[15:45:49.334] Timer tick, asking Buildbucket for the build status
[15:45:49.940] Build 8896532734857017632: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:45:49.940] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9061962797377588848:57:0) after 1m0s
[15:46:50.249] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9061962797377588848:57:0)
[15:46:50.249] Timer tick, asking Buildbucket for the build status
[15:46:50.524] Build 8896532734857017632: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:46:50.524] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9061962797377588848:58:0) after 1m0s
[15:47:50.621] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9061962797377588848:58:0)
[15:47:50.621] Timer tick, asking Buildbucket for the build status
[15:47:50.831] Build 8896532734857017632: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:47:50.831] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9061962797377588848:59:0) after 1m0s
[15:48:50.854] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9061962797377588848:59:0)
[15:48:50.854] Timer tick, asking Buildbucket for the build status
[15:48:51.191] Build 8896532734857017632: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:48:51.191] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9061962797377588848:60:0) after 1m0s
[15:49:51.362] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9061962797377588848:60:0)
[15:49:51.362] Timer tick, asking Buildbucket for the build status
[15:49:51.535] Build 8896532734857017632: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:49:51.535] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9061962797377588848:61:0) after 1m0s
[15:50:51.775] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9061962797377588848:61:0)
[15:50:51.775] Timer tick, asking Buildbucket for the build status
[15:50:53.454] Build 8896532734857017632: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:50:53.454] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9061962797377588848:62:0) after 1m0s
[15:51:53.748] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9061962797377588848:62:0)
[15:51:53.748] Timer tick, asking Buildbucket for the build status
[15:51:54.444] Build 8896532734857017632: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:51:54.444] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9061962797377588848:63:0) after 1m0s
[15:52:54.547] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9061962797377588848:63:0)
[15:52:54.547] Timer tick, asking Buildbucket for the build status
[15:52:54.711] Build 8896532734857017632: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:52:54.711] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9061962797377588848:64:0) after 1m0s
[15:53:54.968] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9061962797377588848:64:0)
[15:53:54.968] Timer tick, asking Buildbucket for the build status
[15:53:55.322] Build 8896532734857017632: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:53:55.322] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9061962797377588848:65:0) after 1m0s
[15:54:55.432] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9061962797377588848:65:0)
[15:54:55.432] Timer tick, asking Buildbucket for the build status
[15:54:56.029] Build 8896532734857017632: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:54:56.029] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9061962797377588848:66:0) after 1m0s
[15:55:56.097] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9061962797377588848:66:0)
[15:55:56.097] Timer tick, asking Buildbucket for the build status
[15:55:56.248] Build 8896532734857017632: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:55:56.248] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9061962797377588848:67:0) after 1m0s
[15:56:56.357] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9061962797377588848:67:0)
[15:56:56.357] Timer tick, asking Buildbucket for the build status
[15:56:57.704] Build 8896532734857017632: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:56:57.704] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9061962797377588848:68:0) after 1m0s
[15:57:57.940] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9061962797377588848:68:0)
[15:57:57.940] Timer tick, asking Buildbucket for the build status
[15:57:58.135] Build 8896532734857017632: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:57:58.135] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9061962797377588848:69:0) after 1m0s
[15:58:58.302] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9061962797377588848:69:0)
[15:58:58.302] Timer tick, asking Buildbucket for the build status
[15:58:58.524] Build 8896532734857017632: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:58:58.524] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9061962797377588848:70:0) after 1m0s
[15:59:58.706] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9061962797377588848:70:0)
[15:59:58.706] Timer tick, asking Buildbucket for the build status
[15:59:58.972] Build 8896532734857017632: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:59:58.972] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9061962797377588848:71:0) after 1m0s
[16:00:59.027] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9061962797377588848:71:0)
[16:00:59.027] Timer tick, asking Buildbucket for the build status
[16:00:59.218] Build 8896532734857017632: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:00:59.218] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9061962797377588848:72:0) after 1m0s
[16:01:59.348] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9061962797377588848:72:0)
[16:01:59.348] Timer tick, asking Buildbucket for the build status
[16:01:59.688] Build 8896532734857017632: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:01:59.688] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9061962797377588848:73:0) after 1m0s
[16:02:59.881] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9061962797377588848:73:0)
[16:02:59.881] Timer tick, asking Buildbucket for the build status
[16:03:00.508] Build 8896532734857017632: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:03:00.508] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9061962797377588848:74:0) after 1m0s
[16:04:00.765] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9061962797377588848:74:0)
[16:04:00.765] Timer tick, asking Buildbucket for the build status
[16:04:00.922] Build 8896532734857017632: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:04:00.922] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9061962797377588848:75:0) after 1m0s
[16:05:01.195] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9061962797377588848:75:0)
[16:05:01.195] Timer tick, asking Buildbucket for the build status
[16:05:01.805] Build 8896532734857017632: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:05:01.805] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9061962797377588848:76:0) after 1m0s
[16:06:01.864] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9061962797377588848:76:0)
[16:06:01.864] Timer tick, asking Buildbucket for the build status
[16:06:02.448] Build 8896532734857017632: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:06:02.448] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9061962797377588848:77:0) after 1m0s
[16:07:02.496] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9061962797377588848:77:0)
[16:07:02.496] Timer tick, asking Buildbucket for the build status
[16:07:02.645] Build 8896532734857017632: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:07:02.645] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9061962797377588848:78:0) after 1m0s
[16:08:02.699] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9061962797377588848:78:0)
[16:08:02.699] Timer tick, asking Buildbucket for the build status
[16:08:02.845] Build 8896532734857017632: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:08:02.845] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9061962797377588848:79:0) after 1m0s
[16:09:02.939] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9061962797377588848:79:0)
[16:09:02.939] Timer tick, asking Buildbucket for the build status
[16:09:03.105] Build 8896532734857017632: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:09:03.105] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9061962797377588848:80:0) after 1m0s
[16:10:03.238] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9061962797377588848:80:0)
[16:10:03.238] Timer tick, asking Buildbucket for the build status
[16:10:03.460] Build 8896532734857017632: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:10:03.460] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9061962797377588848:81:0) after 1m0s
[16:11:03.485] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9061962797377588848:81:0)
[16:11:03.485] Timer tick, asking Buildbucket for the build status
[16:11:03.625] Build 8896532734857017632: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:11:03.625] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9061962797377588848:82:0) after 1m0s
[16:12:03.656] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9061962797377588848:82:0)
[16:12:03.656] Timer tick, asking Buildbucket for the build status
[16:12:03.801] Build 8896532734857017632: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:12:03.801] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9061962797377588848:83:0) after 1m0s
[16:13:03.822] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9061962797377588848:83:0)
[16:13:03.822] Timer tick, asking Buildbucket for the build status
[16:13:04.489] Build 8896532734857017632: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:13:04.489] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9061962797377588848:84:0) after 1m0s
[16:14:04.986] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9061962797377588848:84:0)
[16:14:04.986] Timer tick, asking Buildbucket for the build status
[16:14:05.235] Build 8896532734857017632: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:14:05.235] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9061962797377588848:85:0) after 1m0s
[16:15:05.387] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9061962797377588848:85:0)
[16:15:05.387] Timer tick, asking Buildbucket for the build status
[16:15:05.589] Build 8896532734857017632: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:15:05.589] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9061962797377588848:86:0) after 1m0s
[16:18:44.287] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9061962797377588848:86:0)
[16:18:44.287] Timer tick, asking Buildbucket for the build status
[16:18:45.814] Build 8896532734857017632: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:18:45.814] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9061962797377588848:87:0) after 1m0s
[16:19:45.863] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9061962797377588848:87:0)
[16:19:45.863] Timer tick, asking Buildbucket for the build status
[16:19:46.955] Build 8896532734857017632: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:19:46.955] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9061962797377588848:88:0) after 1m0s
[16:20:47.257] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9061962797377588848:88:0)
[16:20:47.257] Timer tick, asking Buildbucket for the build status
[16:20:47.699] Build 8896532734857017632: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:20:47.699] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9061962797377588848:89:0) after 1m0s
[16:21:47.885] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9061962797377588848:89:0)
[16:21:47.885] Timer tick, asking Buildbucket for the build status
[16:21:50.887] Build 8896532734857017632: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:21:50.887] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9061962797377588848:90:0) after 1m0s
[16:22:50.926] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9061962797377588848:90:0)
[16:22:50.926] Timer tick, asking Buildbucket for the build status
[16:22:51.575] Build 8896532734857017632: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:22:51.575] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9061962797377588848:91:0) after 1m0s
[16:23:51.717] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9061962797377588848:91:0)
[16:23:51.717] Timer tick, asking Buildbucket for the build status
[16:23:52.155] Build 8896532734857017632: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:23:52.155] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9061962797377588848:92:0) after 1m0s
[16:24:52.216] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9061962797377588848:92:0)
[16:24:52.216] Timer tick, asking Buildbucket for the build status
[16:24:53.518] Build 8896532734857017632: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:24:53.518] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9061962797377588848:93:0) after 1m0s
[16:25:53.546] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9061962797377588848:93:0)
[16:25:53.546] Timer tick, asking Buildbucket for the build status
[16:25:53.967] Build 8896532734857017632: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:25:53.967] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9061962797377588848:94:0) after 1m0s
[16:26:53.991] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9061962797377588848:94:0)
[16:26:53.991] Timer tick, asking Buildbucket for the build status
[16:26:54.139] Build 8896532734857017632: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:26:54.139] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9061962797377588848:95:0) after 1m0s
[16:27:54.274] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9061962797377588848:95:0)
[16:27:54.274] Timer tick, asking Buildbucket for the build status
[16:27:54.434] Build 8896532734857017632: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:27:54.434] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9061962797377588848:96:0) after 1m0s
[16:28:54.542] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9061962797377588848:96:0)
[16:28:54.542] Timer tick, asking Buildbucket for the build status
[16:28:55.416] Build 8896532734857017632: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:28:55.416] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9061962797377588848:97:0) after 1m0s
[16:29:55.446] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9061962797377588848:97:0)
[16:29:55.446] Timer tick, asking Buildbucket for the build status
[16:29:56.697] Build 8896532734857017632: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:29:56.697] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9061962797377588848:98:0) after 1m0s
[16:30:56.726] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9061962797377588848:98:0)
[16:30:56.726] Timer tick, asking Buildbucket for the build status
[16:30:58.397] Build 8896532734857017632: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:30:58.397] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9061962797377588848:99:0) after 1m0s
[16:31:58.475] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9061962797377588848:99:0)
[16:31:58.475] Timer tick, asking Buildbucket for the build status
[16:31:58.923] Build 8896532734857017632: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:31:58.923] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9061962797377588848:100:0) after 1m0s
[16:32:59.096] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9061962797377588848:100:0)
[16:32:59.096] Timer tick, asking Buildbucket for the build status
[16:33:00.472] Build 8896532734857017632: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:33:00.472] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9061962797377588848:101:0) after 1m0s
[16:34:00.537] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9061962797377588848:101:0)
[16:34:00.537] Timer tick, asking Buildbucket for the build status
[16:34:00.751] Build 8896532734857017632: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:34:00.751] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9061962797377588848:102:0) after 1m0s
[16:35:00.817] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9061962797377588848:102:0)
[16:35:00.817] Timer tick, asking Buildbucket for the build status
[16:35:01.516] Build 8896532734857017632: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:35:01.516] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9061962797377588848:103:0) after 1m0s
[16:36:01.655] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9061962797377588848:103:0)
[16:36:01.655] Timer tick, asking Buildbucket for the build status
[16:36:02.929] Build 8896532734857017632: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:36:02.929] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9061962797377588848:104:0) after 1m0s
[16:37:03.047] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9061962797377588848:104:0)
[16:37:03.047] Timer tick, asking Buildbucket for the build status
[16:37:03.359] Build 8896532734857017632: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:37:03.359] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9061962797377588848:105:0) after 1m0s
[16:38:03.398] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9061962797377588848:105:0)
[16:38:03.398] Timer tick, asking Buildbucket for the build status
[16:38:04.273] Build 8896532734857017632: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:38:04.273] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9061962797377588848:106:0) after 1m0s
[16:39:04.435] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9061962797377588848:106:0)
[16:39:04.435] Timer tick, asking Buildbucket for the build status
[16:39:05.907] Build 8896532734857017632: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:39:05.907] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9061962797377588848:107:0) after 1m0s
[16:40:05.935] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9061962797377588848:107:0)
[16:40:05.935] Timer tick, asking Buildbucket for the build status
[16:40:06.662] Build 8896532734857017632: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:40:06.662] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9061962797377588848:108:0) after 1m0s
[16:41:06.820] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9061962797377588848:108:0)
[16:41:06.820] Timer tick, asking Buildbucket for the build status
[16:41:07.039] Build 8896532734857017632: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:41:07.039] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9061962797377588848:109:0) after 1m0s
[16:42:07.257] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9061962797377588848:109:0)
[16:42:07.257] Timer tick, asking Buildbucket for the build status
[16:42:07.446] Build 8896532734857017632: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:42:07.446] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9061962797377588848:110:0) after 1m0s
[16:43:07.477] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9061962797377588848:110:0)
[16:43:07.477] Timer tick, asking Buildbucket for the build status
[16:43:07.635] Build 8896532734857017632: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:43:07.635] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9061962797377588848:111:0) after 1m0s
[16:44:07.673] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9061962797377588848:111:0)
[16:44:07.673] Timer tick, asking Buildbucket for the build status
[16:44:07.923] Build 8896532734857017632: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:44:07.923] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9061962797377588848:112:0) after 1m0s
[16:45:07.981] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9061962797377588848:112:0)
[16:45:07.981] Timer tick, asking Buildbucket for the build status
[16:45:08.152] Build 8896532734857017632: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:45:08.152] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9061962797377588848:113:0) after 1m0s
[16:46:08.261] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9061962797377588848:113:0)
[16:46:08.261] Timer tick, asking Buildbucket for the build status
[16:46:09.227] Build 8896532734857017632: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:46:09.227] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9061962797377588848:114:0) after 1m0s
[16:47:09.289] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9061962797377588848:114:0)
[16:47:09.289] Timer tick, asking Buildbucket for the build status
[16:47:09.430] Build 8896532734857017632: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:47:09.430] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9061962797377588848:115:0) after 1m0s
[16:48:09.453] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9061962797377588848:115:0)
[16:48:09.453] Timer tick, asking Buildbucket for the build status
[16:48:09.706] Build 8896532734857017632: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:48:09.706] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9061962797377588848:116:0) after 1m0s
[16:49:09.792] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9061962797377588848:116:0)
[16:49:09.792] Timer tick, asking Buildbucket for the build status
[16:49:10.001] Build 8896532734857017632: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:49:10.001] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9061962797377588848:117:0) after 1m0s
[16:50:10.038] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9061962797377588848:117:0)
[16:50:10.038] Timer tick, asking Buildbucket for the build status
[16:50:10.200] Build 8896532734857017632: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:50:10.200] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9061962797377588848:118:0) after 1m0s
[16:51:10.281] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9061962797377588848:118:0)
[16:51:10.281] Timer tick, asking Buildbucket for the build status
[16:51:10.798] Build 8896532734857017632: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:51:10.798] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9061962797377588848:119:0) after 1m0s
[16:52:11.005] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9061962797377588848:119:0)
[16:52:11.005] Timer tick, asking Buildbucket for the build status
[16:52:11.531] Build 8896532734857017632: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:52:11.531] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9061962797377588848:120:0) after 1m0s
[16:53:11.556] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9061962797377588848:120:0)
[16:53:11.556] Timer tick, asking Buildbucket for the build status
[16:53:11.707] Build 8896532734857017632: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:53:11.707] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9061962797377588848:121:0) after 1m0s
[16:54:11.806] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9061962797377588848:121:0)
[16:54:11.806] Timer tick, asking Buildbucket for the build status
[16:54:11.937] Build 8896532734857017632: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:54:11.937] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9061962797377588848:122:0) after 1m0s
[16:55:12.162] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9061962797377588848:122:0)
[16:55:12.162] Timer tick, asking Buildbucket for the build status
[16:55:12.760] Build 8896532734857017632: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:55:12.760] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9061962797377588848:123:0) after 1m0s
[16:56:12.816] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9061962797377588848:123:0)
[16:56:12.816] Timer tick, asking Buildbucket for the build status
[16:56:13.023] Build 8896532734857017632: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:56:13.023] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9061962797377588848:124:0) after 1m0s
[16:57:13.084] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9061962797377588848:124:0)
[16:57:13.084] Timer tick, asking Buildbucket for the build status
[16:57:13.889] Build 8896532734857017632: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:57:13.889] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9061962797377588848:125:0) after 1m0s
[16:58:13.926] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9061962797377588848:125:0)
[16:58:13.926] Timer tick, asking Buildbucket for the build status
[16:58:14.486] Build 8896532734857017632: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:58:14.486] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9061962797377588848:126:0) after 1m0s
[16:59:14.523] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9061962797377588848:126:0)
[16:59:14.523] Timer tick, asking Buildbucket for the build status
[16:59:15.868] Build 8896532734857017632: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:59:15.868] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9061962797377588848:127:0) after 1m0s
[17:00:15.894] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9061962797377588848:127:0)
[17:00:15.894] Timer tick, asking Buildbucket for the build status
[17:00:16.048] Build 8896532734857017632: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:00:16.048] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9061962797377588848:128:0) after 1m0s
[17:01:16.248] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9061962797377588848:128:0)
[17:01:16.248] Timer tick, asking Buildbucket for the build status
[17:01:16.930] Build 8896532734857017632: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:01:16.930] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9061962797377588848:129:0) after 1m0s
[17:02:16.986] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9061962797377588848:129:0)
[17:02:16.986] Timer tick, asking Buildbucket for the build status
[17:02:17.444] Build 8896532734857017632: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:02:17.444] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9061962797377588848:130:0) after 1m0s
[17:03:17.472] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9061962797377588848:130:0)
[17:03:17.472] Timer tick, asking Buildbucket for the build status
[17:03:18.037] Build 8896532734857017632: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:03:18.037] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9061962797377588848:131:0) after 1m0s
[17:04:18.067] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9061962797377588848:131:0)
[17:04:18.067] Timer tick, asking Buildbucket for the build status
[17:04:18.442] Build 8896532734857017632: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:04:18.442] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9061962797377588848:132:0) after 1m0s
[17:05:18.471] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9061962797377588848:132:0)
[17:05:18.471] Timer tick, asking Buildbucket for the build status
[17:05:18.775] Build 8896532734857017632: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:05:18.775] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9061962797377588848:133:0) after 1m0s
[17:06:18.804] Handling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9061962797377588848:133:0)
[17:06:18.804] Timer tick, asking Buildbucket for the build status
[17:06:19.298] Build 8896532734857017632: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:06:19.298] Scheduling timer "check-buildbucket-build-status" (chromium/Windows deterministic:9061962797377588848:134:0) after 1m0s
[17:07:06.597] Received PubSub notification, asking Buildbucket for the build status
[17:07:06.811] Build 8896532734857017632: status "COMPLETED", result "SUCCESS", failure_reason "", cancelation_reason ""
[17:07:06.811] Buildbucket build:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "PROD",
"completed_ts": "1574010425260490",
"created_by": "project:chromium",
"created_ts": "1574002247907671",
"id": "8896532734857017632",
"parameters_json": "{\"builder_name\": \"Windows deterministic\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"735232390e9de8fe155af38823db1d4ac6cabed6\"}}",
"project": "chromium",
"result": "SUCCESS",
"result_details_json": "{\"properties\": {\"$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\": \"windows-deterministic-0-t6xr\", \"branch\": \"refs/heads/master\", \"buildername\": \"Windows deterministic\", \"buildnumber\": 15227, \"got_angle_revision\": \"51b5a3222b60d5f523d04b5a86eeb28278880db4\", \"got_dawn_revision\": \"a930e599e17c14e0a72fe7403aab69d791885da8\", \"got_nacl_revision\": \"3651f6c52037c96e034cc422746768d59182bff3\", \"got_revision\": \"735232390e9de8fe155af38823db1d4ac6cabed6\", \"got_revision_cp\": \"refs/heads/master@{#716047}\", \"got_swarming_client_revision\": \"885b3febcc170a60f25795304e60927b77d1e92d\", \"got_swiftshader_revision\": \"aba1020d39145285f8d8df82d6f0b83d0b0e5386\", \"got_v8_revision\": \"295649fd927eeaaaf8ec10d68b45602e89e94223\", \"got_v8_revision_cp\": \"refs/heads/8.0.284@{#1}\", \"got_webrtc_revision\": \"fd0e32a87a4e6a9a6cfeb02fbdcddd6edf4ac9c8\", \"got_webrtc_revision_cp\": \"refs/heads/master@{#29804}\", \"mastername\": \"chromium.win\", \"path_config\": \"generic\", \"recipe\": \"swarming/deterministic_build\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"735232390e9de8fe155af38823db1d4ac6cabed6\"}, \"swarming\": {\"bot_dimensions\": {\"builder\": [\"Windows deterministic\"], \"caches\": [\"builder_e8fffaf9fac16164b1ec16ebaa1f377b792d39a582f7640830518d8ff7303d0c_v2\", \"git\", \"goma_v2\", \"vpython\"], \"cores\": [\"8\"], \"cpu\": [\"x86\", \"x86-64\", \"x86-64-Broadwell_GCE\"], \"gce\": [\"1\"], \"gpu\": [\"none\"], \"id\": [\"windows-deterministic-0-t6xr\"], \"image\": [\"chrome-win10-1703-19102400-d35fedf5a0d\"], \"integrity\": [\"high\"], \"locale\": [\"en_US.cp1252\"], \"machine_type\": [\"n1-standard-8\"], \"os\": [\"Windows\", \"Windows-10\", \"Windows-10-15063\"], \"pool\": [\"luci.chromium.ci\"], \"python\": [\"2.7.13\"], \"server_version\": [\"4632-c6c17d9\"], \"ssd\": [\"0\"], \"windows_client_version\": [\"10\"], \"zone\": [\"us\", \"us-west\", \"us-west1\", \"us-west1-c\"]}}}",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"started_ts": "1574002371257328",
"status": "COMPLETED",
"status_changed_ts": "1574010425585904",
"tags": [
"build_address:luci.chromium.ci/Windows deterministic/15227",
"builder:Windows deterministic",
"buildset:commit/git/735232390e9de8fe155af38823db1d4ac6cabed6",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/735232390e9de8fe155af38823db1d4ac6cabed6",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9061962797377588848",
"scheduler_job_id:chromium/Windows deterministic",
"swarming_hostname:chromium-swarm.appspot.com",
"swarming_tag:log_location:logdog://logs.chromium.org/chromium/buildbucket/cr-buildbucket.appspot.com/8896532734857017632/+/annotations",
"swarming_tag:luci_project:chromium",
"swarming_tag:os:Windows",
"swarming_tag:recipe_name:swarming/deterministic_build",
"swarming_tag:recipe_package:infra/recipe_bundles/chromium.googlesource.com/chromium/tools/build",
"swarming_task_id:4892a9d6e16c0810",
"user_agent:luci-scheduler"
],
"updated_ts": "1574010425592815",
"url": "https://ci.chromium.org/b/8896532734857017632",
"utcnow_ts": "1574010426798056"
}
}
[17:07:06.811] Invocation finished in 2h16m20.691439553s with status SUCCEEDED