[06:30:56.663] New invocation is queued and will start shortly
[06:30:57.936] Starting the invocation (attempt 1)
[06:30:57.977] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[06:30:57.977] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[06:30:57.977] Buildbucket request:
{
"bucket": "luci.emscripten-releases.ci",
"client_operation_id": "9039435598989883056",
"parameters_json": "{\"builder_name\":\"linux-test-suites\",\"properties\":{\"$recipe_engine/scheduler\":{\"hostname\":\"luci-scheduler.appspot.com\",\"triggers\":[{\"gitiles\":{\"ref\":\"refs/heads/master\",\"repo\":\"https://chromium.googlesource.com/emscripten-releases\",\"revision\":\"85f106641547876e0f6a6e41bc4c7feab310722b\"},\"id\":\"https://chromium.googlesource.com/emscripten-releases/+/refs/heads/master@85f106641547876e0f6a6e41bc4c7feab310722b\",\"title\":\"85f106641547876e0f6a6e41bc4c7feab310722b\",\"url\":\"https://chromium.googlesource.com/emscripten-releases/+/85f106641547876e0f6a6e41bc4c7feab310722b\"}]},\"branch\":\"refs/heads/master\",\"repository\":\"https://chromium.googlesource.com/emscripten-releases\",\"revision\":\"85f106641547876e0f6a6e41bc4c7feab310722b\"}}",
"pubsub_callback": {
"auth_token": "...",
"topic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
},
"tags": [
"builder:linux-test-suites",
"scheduler_invocation_id:9039435598989883056",
"scheduler_job_id:emscripten-releases/linux-test-suites",
"user_agent:luci-scheduler",
"buildset:commit/git/85f106641547876e0f6a6e41bc4c7feab310722b",
"buildset:commit/gitiles/chromium.googlesource.com/emscripten-releases/+/85f106641547876e0f6a6e41bc4c7feab310722b",
"gitiles_ref:refs/heads/master"
]
}
[06:30:59.105] Buildbucket response:
{
"build": {
"bucket": "luci.emscripten-releases.ci",
"canary_preference": "PROD",
"created_by": "project:emscripten-releases",
"created_ts": "1595485858085342",
"id": "8874005536830467088",
"parameters_json": "{\"builder_name\": \"linux-test-suites\", \"properties\": {\"$recipe_engine/scheduler\": {\"hostname\": \"luci-scheduler.appspot.com\", \"triggers\": [{\"gitiles\": {\"ref\": \"refs/heads/master\", \"repo\": \"https://chromium.googlesource.com/emscripten-releases\", \"revision\": \"85f106641547876e0f6a6e41bc4c7feab310722b\"}, \"id\": \"https://chromium.googlesource.com/emscripten-releases/+/refs/heads/master@85f106641547876e0f6a6e41bc4c7feab310722b\", \"title\": \"85f106641547876e0f6a6e41bc4c7feab310722b\", \"url\": \"https://chromium.googlesource.com/emscripten-releases/+/85f106641547876e0f6a6e41bc4c7feab310722b\"}]}, \"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/emscripten-releases\", \"revision\": \"85f106641547876e0f6a6e41bc4c7feab310722b\"}}",
"project": "emscripten-releases",
"result_details_json": "{\"properties\": {}}",
"service_account": "emscripten-releases-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"status": "SCHEDULED",
"status_changed_ts": "1595485858817097",
"tags": [
"builder:linux-test-suites",
"buildset:commit/git/85f106641547876e0f6a6e41bc4c7feab310722b",
"buildset:commit/gitiles/chromium.googlesource.com/emscripten-releases/+/85f106641547876e0f6a6e41bc4c7feab310722b",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9039435598989883056",
"scheduler_job_id:emscripten-releases/linux-test-suites",
"swarming_hostname:chromium-swarm.appspot.com",
"swarming_tag:log_location:logdog://logs.chromium.org/emscripten-releases/buildbucket/cr-buildbucket.appspot.com/8874005536830467088/+/annotations",
"swarming_tag:luci_project:emscripten-releases",
"swarming_tag:recipe_name:emscripten_releases",
"swarming_tag:recipe_package:infra/recipe_bundles/chromium.googlesource.com/chromium/tools/build",
"swarming_task_id:",
"user_agent:luci-scheduler"
],
"updated_ts": "1595485858817226",
"url": "https://ci.chromium.org/b/8874005536830467088",
"utcnow_ts": "1595485859087571"
}
}
[06:30:59.105] Task URL: https://ci.chromium.org/b/8874005536830467088
[06:30:59.105] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/linux-test-suites:9039435598989883056:2:0) after 1m0s
[06:31:36.863] Received PubSub notification, asking Buildbucket for the build status
[06:31:36.964] Build 8874005536830467088: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:31:59.247] Handling timer "check-buildbucket-build-status" (emscripten-releases/linux-test-suites:9039435598989883056:2:0)
[06:31:59.247] Timer tick, asking Buildbucket for the build status
[06:31:59.401] Build 8874005536830467088: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:31:59.401] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/linux-test-suites:9039435598989883056:4:0) after 1m0s
[06:32:59.537] Handling timer "check-buildbucket-build-status" (emscripten-releases/linux-test-suites:9039435598989883056:4:0)
[06:32:59.537] Timer tick, asking Buildbucket for the build status
[06:32:59.788] Build 8874005536830467088: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:32:59.788] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/linux-test-suites:9039435598989883056:5:0) after 1m0s
[06:33:59.845] Handling timer "check-buildbucket-build-status" (emscripten-releases/linux-test-suites:9039435598989883056:5:0)
[06:33:59.845] Timer tick, asking Buildbucket for the build status
[06:34:00.657] Build 8874005536830467088: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:34:00.657] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/linux-test-suites:9039435598989883056:6:0) after 1m0s
[06:35:01.820] Handling timer "check-buildbucket-build-status" (emscripten-releases/linux-test-suites:9039435598989883056:6:0)
[06:35:01.820] Timer tick, asking Buildbucket for the build status
[06:35:02.001] Build 8874005536830467088: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:35:02.001] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/linux-test-suites:9039435598989883056:7:0) after 1m0s
[06:36:02.538] Handling timer "check-buildbucket-build-status" (emscripten-releases/linux-test-suites:9039435598989883056:7:0)
[06:36:02.538] Timer tick, asking Buildbucket for the build status
[06:36:02.773] Build 8874005536830467088: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:36:02.773] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/linux-test-suites:9039435598989883056:8:0) after 1m0s
[06:37:02.869] Handling timer "check-buildbucket-build-status" (emscripten-releases/linux-test-suites:9039435598989883056:8:0)
[06:37:02.869] Timer tick, asking Buildbucket for the build status
[06:37:04.807] Build 8874005536830467088: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:37:04.807] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/linux-test-suites:9039435598989883056:9:0) after 1m0s
[06:38:04.832] Handling timer "check-buildbucket-build-status" (emscripten-releases/linux-test-suites:9039435598989883056:9:0)
[06:38:04.832] Timer tick, asking Buildbucket for the build status
[06:38:04.933] Build 8874005536830467088: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:38:04.933] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/linux-test-suites:9039435598989883056:10:0) after 1m0s
[06:39:04.975] Handling timer "check-buildbucket-build-status" (emscripten-releases/linux-test-suites:9039435598989883056:10:0)
[06:39:04.975] Timer tick, asking Buildbucket for the build status
[06:39:05.064] Build 8874005536830467088: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:39:05.064] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/linux-test-suites:9039435598989883056:11:0) after 1m0s
[06:40:05.210] Handling timer "check-buildbucket-build-status" (emscripten-releases/linux-test-suites:9039435598989883056:11:0)
[06:40:05.210] Timer tick, asking Buildbucket for the build status
[06:40:05.283] Build 8874005536830467088: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:40:05.283] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/linux-test-suites:9039435598989883056:12:0) after 1m0s
[06:41:05.340] Handling timer "check-buildbucket-build-status" (emscripten-releases/linux-test-suites:9039435598989883056:12:0)
[06:41:05.340] Timer tick, asking Buildbucket for the build status
[06:41:05.464] Build 8874005536830467088: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:41:05.464] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/linux-test-suites:9039435598989883056:13:0) after 1m0s
[06:42:05.540] Handling timer "check-buildbucket-build-status" (emscripten-releases/linux-test-suites:9039435598989883056:13:0)
[06:42:05.540] Timer tick, asking Buildbucket for the build status
[06:42:05.714] Build 8874005536830467088: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:42:05.714] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/linux-test-suites:9039435598989883056:14:0) after 1m0s
[06:43:05.744] Handling timer "check-buildbucket-build-status" (emscripten-releases/linux-test-suites:9039435598989883056:14:0)
[06:43:05.744] Timer tick, asking Buildbucket for the build status
[06:43:05.814] Build 8874005536830467088: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:43:05.814] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/linux-test-suites:9039435598989883056:15:0) after 1m0s
[06:44:05.888] Handling timer "check-buildbucket-build-status" (emscripten-releases/linux-test-suites:9039435598989883056:15:0)
[06:44:05.888] Timer tick, asking Buildbucket for the build status
[06:44:06.031] Build 8874005536830467088: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:44:06.031] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/linux-test-suites:9039435598989883056:16:0) after 1m0s
[06:45:07.043] Handling timer "check-buildbucket-build-status" (emscripten-releases/linux-test-suites:9039435598989883056:16:0)
[06:45:07.043] Timer tick, asking Buildbucket for the build status
[06:45:07.117] Build 8874005536830467088: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:45:07.117] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/linux-test-suites:9039435598989883056:17:0) after 1m0s
[06:46:07.224] Handling timer "check-buildbucket-build-status" (emscripten-releases/linux-test-suites:9039435598989883056:17:0)
[06:46:07.224] Timer tick, asking Buildbucket for the build status
[06:46:07.377] Build 8874005536830467088: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:46:07.377] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/linux-test-suites:9039435598989883056:18:0) after 1m0s
[06:47:07.399] Handling timer "check-buildbucket-build-status" (emscripten-releases/linux-test-suites:9039435598989883056:18:0)
[06:47:07.399] Timer tick, asking Buildbucket for the build status
[06:47:07.590] Build 8874005536830467088: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:47:07.590] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/linux-test-suites:9039435598989883056:19:0) after 1m0s
[06:48:07.700] Handling timer "check-buildbucket-build-status" (emscripten-releases/linux-test-suites:9039435598989883056:19:0)
[06:48:07.701] Timer tick, asking Buildbucket for the build status
[06:48:07.819] Build 8874005536830467088: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:48:07.819] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/linux-test-suites:9039435598989883056:20:0) after 1m0s
[06:49:07.834] Handling timer "check-buildbucket-build-status" (emscripten-releases/linux-test-suites:9039435598989883056:20:0)
[06:49:07.834] Timer tick, asking Buildbucket for the build status
[06:49:07.908] Build 8874005536830467088: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:49:07.908] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/linux-test-suites:9039435598989883056:21:0) after 1m0s
[06:50:07.961] Handling timer "check-buildbucket-build-status" (emscripten-releases/linux-test-suites:9039435598989883056:21:0)
[06:50:07.961] Timer tick, asking Buildbucket for the build status
[06:50:08.068] Build 8874005536830467088: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:50:08.068] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/linux-test-suites:9039435598989883056:22:0) after 1m0s
[06:51:08.116] Handling timer "check-buildbucket-build-status" (emscripten-releases/linux-test-suites:9039435598989883056:22:0)
[06:51:08.116] Timer tick, asking Buildbucket for the build status
[06:51:08.368] Build 8874005536830467088: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:51:08.368] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/linux-test-suites:9039435598989883056:23:0) after 1m0s
[06:52:08.361] Handling timer "check-buildbucket-build-status" (emscripten-releases/linux-test-suites:9039435598989883056:23:0)
[06:52:08.361] Timer tick, asking Buildbucket for the build status
[06:52:08.606] Build 8874005536830467088: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:52:08.606] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/linux-test-suites:9039435598989883056:24:0) after 1m0s
[06:53:08.634] Handling timer "check-buildbucket-build-status" (emscripten-releases/linux-test-suites:9039435598989883056:24:0)
[06:53:08.634] Timer tick, asking Buildbucket for the build status
[06:53:08.788] Build 8874005536830467088: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:53:08.788] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/linux-test-suites:9039435598989883056:25:0) after 1m0s
[06:54:08.887] Handling timer "check-buildbucket-build-status" (emscripten-releases/linux-test-suites:9039435598989883056:25:0)
[06:54:08.887] Timer tick, asking Buildbucket for the build status
[06:54:09.001] Build 8874005536830467088: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:54:09.001] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/linux-test-suites:9039435598989883056:26:0) after 1m0s
[06:55:09.062] Handling timer "check-buildbucket-build-status" (emscripten-releases/linux-test-suites:9039435598989883056:26:0)
[06:55:09.062] Timer tick, asking Buildbucket for the build status
[06:55:09.286] Build 8874005536830467088: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:55:09.286] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/linux-test-suites:9039435598989883056:27:0) after 1m0s
[06:56:09.339] Handling timer "check-buildbucket-build-status" (emscripten-releases/linux-test-suites:9039435598989883056:27:0)
[06:56:09.339] Timer tick, asking Buildbucket for the build status
[06:56:09.560] Build 8874005536830467088: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:56:09.560] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/linux-test-suites:9039435598989883056:28:0) after 1m0s
[06:57:09.656] Handling timer "check-buildbucket-build-status" (emscripten-releases/linux-test-suites:9039435598989883056:28:0)
[06:57:09.656] Timer tick, asking Buildbucket for the build status
[06:57:09.714] Build 8874005536830467088: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:57:09.714] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/linux-test-suites:9039435598989883056:29:0) after 1m0s
[06:58:09.755] Handling timer "check-buildbucket-build-status" (emscripten-releases/linux-test-suites:9039435598989883056:29:0)
[06:58:09.755] Timer tick, asking Buildbucket for the build status
[06:58:09.928] Build 8874005536830467088: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:58:09.928] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/linux-test-suites:9039435598989883056:30:0) after 1m0s
[06:59:09.930] Handling timer "check-buildbucket-build-status" (emscripten-releases/linux-test-suites:9039435598989883056:30:0)
[06:59:09.930] Timer tick, asking Buildbucket for the build status
[06:59:10.300] Build 8874005536830467088: status "STARTED", result "", failure_reason "", cancelation_reason ""
[06:59:10.300] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/linux-test-suites:9039435598989883056:31:0) after 1m0s
[07:00:10.334] Handling timer "check-buildbucket-build-status" (emscripten-releases/linux-test-suites:9039435598989883056:31:0)
[07:00:10.334] Timer tick, asking Buildbucket for the build status
[07:00:10.493] Build 8874005536830467088: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:00:10.493] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/linux-test-suites:9039435598989883056:32:0) after 1m0s
[07:01:10.493] Handling timer "check-buildbucket-build-status" (emscripten-releases/linux-test-suites:9039435598989883056:32:0)
[07:01:10.493] Timer tick, asking Buildbucket for the build status
[07:01:10.683] Build 8874005536830467088: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:01:10.683] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/linux-test-suites:9039435598989883056:33:0) after 1m0s
[07:02:10.771] Handling timer "check-buildbucket-build-status" (emscripten-releases/linux-test-suites:9039435598989883056:33:0)
[07:02:10.771] Timer tick, asking Buildbucket for the build status
[07:02:10.859] Build 8874005536830467088: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:02:10.860] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/linux-test-suites:9039435598989883056:34:0) after 1m0s
[07:03:10.888] Handling timer "check-buildbucket-build-status" (emscripten-releases/linux-test-suites:9039435598989883056:34:0)
[07:03:10.888] Timer tick, asking Buildbucket for the build status
[07:03:11.025] Build 8874005536830467088: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:03:11.025] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/linux-test-suites:9039435598989883056:35:0) after 1m0s
[07:04:11.086] Handling timer "check-buildbucket-build-status" (emscripten-releases/linux-test-suites:9039435598989883056:35:0)
[07:04:11.086] Timer tick, asking Buildbucket for the build status
[07:04:11.260] Build 8874005536830467088: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:04:11.260] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/linux-test-suites:9039435598989883056:36:0) after 1m0s
[07:05:11.396] Handling timer "check-buildbucket-build-status" (emscripten-releases/linux-test-suites:9039435598989883056:36:0)
[07:05:11.396] Timer tick, asking Buildbucket for the build status
[07:05:11.617] Build 8874005536830467088: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:05:11.617] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/linux-test-suites:9039435598989883056:37:0) after 1m0s
[07:06:11.712] Handling timer "check-buildbucket-build-status" (emscripten-releases/linux-test-suites:9039435598989883056:37:0)
[07:06:11.712] Timer tick, asking Buildbucket for the build status
[07:06:11.935] Build 8874005536830467088: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:06:11.935] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/linux-test-suites:9039435598989883056:38:0) after 1m0s
[07:07:12.038] Handling timer "check-buildbucket-build-status" (emscripten-releases/linux-test-suites:9039435598989883056:38:0)
[07:07:12.038] Timer tick, asking Buildbucket for the build status
[07:07:12.379] Build 8874005536830467088: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:07:12.379] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/linux-test-suites:9039435598989883056:39:0) after 1m0s
[07:08:12.483] Handling timer "check-buildbucket-build-status" (emscripten-releases/linux-test-suites:9039435598989883056:39:0)
[07:08:12.483] Timer tick, asking Buildbucket for the build status
[07:08:12.603] Build 8874005536830467088: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:08:12.603] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/linux-test-suites:9039435598989883056:40:0) after 1m0s
[07:09:12.637] Handling timer "check-buildbucket-build-status" (emscripten-releases/linux-test-suites:9039435598989883056:40:0)
[07:09:12.637] Timer tick, asking Buildbucket for the build status
[07:09:13.139] Build 8874005536830467088: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:09:13.139] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/linux-test-suites:9039435598989883056:41:0) after 1m0s
[07:10:13.212] Handling timer "check-buildbucket-build-status" (emscripten-releases/linux-test-suites:9039435598989883056:41:0)
[07:10:13.212] Timer tick, asking Buildbucket for the build status
[07:10:13.426] Build 8874005536830467088: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:10:13.426] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/linux-test-suites:9039435598989883056:42:0) after 1m0s
[07:11:13.452] Handling timer "check-buildbucket-build-status" (emscripten-releases/linux-test-suites:9039435598989883056:42:0)
[07:11:13.452] Timer tick, asking Buildbucket for the build status
[07:11:13.810] Build 8874005536830467088: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:11:13.810] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/linux-test-suites:9039435598989883056:43:0) after 1m0s
[07:12:13.904] Handling timer "check-buildbucket-build-status" (emscripten-releases/linux-test-suites:9039435598989883056:43:0)
[07:12:13.904] Timer tick, asking Buildbucket for the build status
[07:12:14.018] Build 8874005536830467088: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:12:14.018] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/linux-test-suites:9039435598989883056:44:0) after 1m0s
[07:13:14.020] Handling timer "check-buildbucket-build-status" (emscripten-releases/linux-test-suites:9039435598989883056:44:0)
[07:13:14.020] Timer tick, asking Buildbucket for the build status
[07:13:14.104] Build 8874005536830467088: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:13:14.104] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/linux-test-suites:9039435598989883056:45:0) after 1m0s
[07:14:14.104] Handling timer "check-buildbucket-build-status" (emscripten-releases/linux-test-suites:9039435598989883056:45:0)
[07:14:14.104] Timer tick, asking Buildbucket for the build status
[07:14:14.186] Build 8874005536830467088: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:14:14.186] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/linux-test-suites:9039435598989883056:46:0) after 1m0s
[07:15:14.207] Handling timer "check-buildbucket-build-status" (emscripten-releases/linux-test-suites:9039435598989883056:46:0)
[07:15:14.207] Timer tick, asking Buildbucket for the build status
[07:15:14.278] Build 8874005536830467088: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:15:14.278] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/linux-test-suites:9039435598989883056:47:0) after 1m0s
[07:16:14.449] Handling timer "check-buildbucket-build-status" (emscripten-releases/linux-test-suites:9039435598989883056:47:0)
[07:16:14.449] Timer tick, asking Buildbucket for the build status
[07:16:14.748] Build 8874005536830467088: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:16:14.748] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/linux-test-suites:9039435598989883056:48:0) after 1m0s
[07:17:14.794] Handling timer "check-buildbucket-build-status" (emscripten-releases/linux-test-suites:9039435598989883056:48:0)
[07:17:14.794] Timer tick, asking Buildbucket for the build status
[07:17:14.883] Build 8874005536830467088: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:17:14.883] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/linux-test-suites:9039435598989883056:49:0) after 1m0s
[07:18:14.930] Handling timer "check-buildbucket-build-status" (emscripten-releases/linux-test-suites:9039435598989883056:49:0)
[07:18:14.930] Timer tick, asking Buildbucket for the build status
[07:18:14.991] Build 8874005536830467088: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:18:14.992] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/linux-test-suites:9039435598989883056:50:0) after 1m0s
[07:19:15.164] Handling timer "check-buildbucket-build-status" (emscripten-releases/linux-test-suites:9039435598989883056:50:0)
[07:19:15.164] Timer tick, asking Buildbucket for the build status
[07:19:15.366] Build 8874005536830467088: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:19:15.366] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/linux-test-suites:9039435598989883056:51:0) after 1m0s
[07:20:15.407] Handling timer "check-buildbucket-build-status" (emscripten-releases/linux-test-suites:9039435598989883056:51:0)
[07:20:15.407] Timer tick, asking Buildbucket for the build status
[07:20:15.542] Build 8874005536830467088: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:20:15.542] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/linux-test-suites:9039435598989883056:52:0) after 1m0s
[07:21:15.764] Handling timer "check-buildbucket-build-status" (emscripten-releases/linux-test-suites:9039435598989883056:52:0)
[07:21:15.764] Timer tick, asking Buildbucket for the build status
[07:21:15.927] Build 8874005536830467088: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:21:15.927] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/linux-test-suites:9039435598989883056:53:0) after 1m0s
[07:22:16.201] Handling timer "check-buildbucket-build-status" (emscripten-releases/linux-test-suites:9039435598989883056:53:0)
[07:22:16.201] Timer tick, asking Buildbucket for the build status
[07:22:16.488] Build 8874005536830467088: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:22:16.488] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/linux-test-suites:9039435598989883056:54:0) after 1m0s
[07:23:16.583] Handling timer "check-buildbucket-build-status" (emscripten-releases/linux-test-suites:9039435598989883056:54:0)
[07:23:16.583] Timer tick, asking Buildbucket for the build status
[07:23:16.660] Build 8874005536830467088: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:23:16.660] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/linux-test-suites:9039435598989883056:55:0) after 1m0s
[07:24:16.741] Handling timer "check-buildbucket-build-status" (emscripten-releases/linux-test-suites:9039435598989883056:55:0)
[07:24:16.741] Timer tick, asking Buildbucket for the build status
[07:24:16.839] Build 8874005536830467088: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:24:16.839] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/linux-test-suites:9039435598989883056:56:0) after 1m0s
[07:25:16.873] Handling timer "check-buildbucket-build-status" (emscripten-releases/linux-test-suites:9039435598989883056:56:0)
[07:25:16.873] Timer tick, asking Buildbucket for the build status
[07:25:16.940] Build 8874005536830467088: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:25:16.940] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/linux-test-suites:9039435598989883056:57:0) after 1m0s
[07:26:16.972] Handling timer "check-buildbucket-build-status" (emscripten-releases/linux-test-suites:9039435598989883056:57:0)
[07:26:16.972] Timer tick, asking Buildbucket for the build status
[07:26:17.111] Build 8874005536830467088: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:26:17.111] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/linux-test-suites:9039435598989883056:58:0) after 1m0s
[07:27:17.144] Handling timer "check-buildbucket-build-status" (emscripten-releases/linux-test-suites:9039435598989883056:58:0)
[07:27:17.144] Timer tick, asking Buildbucket for the build status
[07:27:17.769] Build 8874005536830467088: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:27:17.769] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/linux-test-suites:9039435598989883056:59:0) after 1m0s
[07:28:17.868] Handling timer "check-buildbucket-build-status" (emscripten-releases/linux-test-suites:9039435598989883056:59:0)
[07:28:17.868] Timer tick, asking Buildbucket for the build status
[07:28:18.055] Build 8874005536830467088: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:28:18.055] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/linux-test-suites:9039435598989883056:60:0) after 1m0s
[07:29:18.152] Handling timer "check-buildbucket-build-status" (emscripten-releases/linux-test-suites:9039435598989883056:60:0)
[07:29:18.152] Timer tick, asking Buildbucket for the build status
[07:29:18.227] Build 8874005536830467088: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:29:18.227] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/linux-test-suites:9039435598989883056:61:0) after 1m0s
[07:30:18.284] Handling timer "check-buildbucket-build-status" (emscripten-releases/linux-test-suites:9039435598989883056:61:0)
[07:30:18.284] Timer tick, asking Buildbucket for the build status
[07:30:18.649] Build 8874005536830467088: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:30:18.649] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/linux-test-suites:9039435598989883056:62:0) after 1m0s
[07:31:18.722] Handling timer "check-buildbucket-build-status" (emscripten-releases/linux-test-suites:9039435598989883056:62:0)
[07:31:18.722] Timer tick, asking Buildbucket for the build status
[07:31:18.877] Build 8874005536830467088: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:31:18.877] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/linux-test-suites:9039435598989883056:63:0) after 1m0s
[07:32:18.910] Handling timer "check-buildbucket-build-status" (emscripten-releases/linux-test-suites:9039435598989883056:63:0)
[07:32:18.910] Timer tick, asking Buildbucket for the build status
[07:32:18.973] Build 8874005536830467088: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:32:18.973] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/linux-test-suites:9039435598989883056:64:0) after 1m0s
[07:33:19.149] Handling timer "check-buildbucket-build-status" (emscripten-releases/linux-test-suites:9039435598989883056:64:0)
[07:33:19.149] Timer tick, asking Buildbucket for the build status
[07:33:19.264] Build 8874005536830467088: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:33:19.264] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/linux-test-suites:9039435598989883056:65:0) after 1m0s
[07:34:19.301] Handling timer "check-buildbucket-build-status" (emscripten-releases/linux-test-suites:9039435598989883056:65:0)
[07:34:19.301] Timer tick, asking Buildbucket for the build status
[07:34:19.399] Build 8874005536830467088: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:34:19.399] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/linux-test-suites:9039435598989883056:66:0) after 1m0s
[07:35:19.453] Handling timer "check-buildbucket-build-status" (emscripten-releases/linux-test-suites:9039435598989883056:66:0)
[07:35:19.454] Timer tick, asking Buildbucket for the build status
[07:35:19.548] Build 8874005536830467088: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:35:19.548] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/linux-test-suites:9039435598989883056:67:0) after 1m0s
[07:36:19.575] Handling timer "check-buildbucket-build-status" (emscripten-releases/linux-test-suites:9039435598989883056:67:0)
[07:36:19.575] Timer tick, asking Buildbucket for the build status
[07:36:19.756] Build 8874005536830467088: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:36:19.756] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/linux-test-suites:9039435598989883056:68:0) after 1m0s
[07:37:19.813] Handling timer "check-buildbucket-build-status" (emscripten-releases/linux-test-suites:9039435598989883056:68:0)
[07:37:19.813] Timer tick, asking Buildbucket for the build status
[07:37:19.888] Build 8874005536830467088: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:37:19.888] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/linux-test-suites:9039435598989883056:69:0) after 1m0s
[07:38:20.017] Handling timer "check-buildbucket-build-status" (emscripten-releases/linux-test-suites:9039435598989883056:69:0)
[07:38:20.017] Timer tick, asking Buildbucket for the build status
[07:38:20.082] Build 8874005536830467088: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:38:20.082] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/linux-test-suites:9039435598989883056:70:0) after 1m0s
[07:39:20.125] Handling timer "check-buildbucket-build-status" (emscripten-releases/linux-test-suites:9039435598989883056:70:0)
[07:39:20.125] Timer tick, asking Buildbucket for the build status
[07:39:20.206] Build 8874005536830467088: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:39:20.206] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/linux-test-suites:9039435598989883056:71:0) after 1m0s
[07:40:20.275] Handling timer "check-buildbucket-build-status" (emscripten-releases/linux-test-suites:9039435598989883056:71:0)
[07:40:20.275] Timer tick, asking Buildbucket for the build status
[07:40:20.350] Build 8874005536830467088: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:40:20.350] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/linux-test-suites:9039435598989883056:72:0) after 1m0s
[07:41:20.330] Handling timer "check-buildbucket-build-status" (emscripten-releases/linux-test-suites:9039435598989883056:72:0)
[07:41:20.330] Timer tick, asking Buildbucket for the build status
[07:41:20.607] Build 8874005536830467088: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:41:20.607] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/linux-test-suites:9039435598989883056:73:0) after 1m0s
[07:42:20.698] Handling timer "check-buildbucket-build-status" (emscripten-releases/linux-test-suites:9039435598989883056:73:0)
[07:42:20.698] Timer tick, asking Buildbucket for the build status
[07:42:20.856] Build 8874005536830467088: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:42:20.857] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/linux-test-suites:9039435598989883056:74:0) after 1m0s
[07:43:20.874] Handling timer "check-buildbucket-build-status" (emscripten-releases/linux-test-suites:9039435598989883056:74:0)
[07:43:20.874] Timer tick, asking Buildbucket for the build status
[07:43:21.017] Build 8874005536830467088: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:43:21.017] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/linux-test-suites:9039435598989883056:75:0) after 1m0s
[07:44:21.021] Handling timer "check-buildbucket-build-status" (emscripten-releases/linux-test-suites:9039435598989883056:75:0)
[07:44:21.021] Timer tick, asking Buildbucket for the build status
[07:44:21.507] Build 8874005536830467088: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:44:21.507] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/linux-test-suites:9039435598989883056:76:0) after 1m0s
[07:45:21.524] Handling timer "check-buildbucket-build-status" (emscripten-releases/linux-test-suites:9039435598989883056:76:0)
[07:45:21.524] Timer tick, asking Buildbucket for the build status
[07:45:21.633] Build 8874005536830467088: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:45:21.633] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/linux-test-suites:9039435598989883056:77:0) after 1m0s
[07:46:21.646] Handling timer "check-buildbucket-build-status" (emscripten-releases/linux-test-suites:9039435598989883056:77:0)
[07:46:21.646] Timer tick, asking Buildbucket for the build status
[07:46:21.783] Build 8874005536830467088: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:46:21.783] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/linux-test-suites:9039435598989883056:78:0) after 1m0s
[07:47:21.779] Handling timer "check-buildbucket-build-status" (emscripten-releases/linux-test-suites:9039435598989883056:78:0)
[07:47:21.779] Timer tick, asking Buildbucket for the build status
[07:47:21.861] Build 8874005536830467088: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:47:21.861] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/linux-test-suites:9039435598989883056:79:0) after 1m0s
[07:48:21.958] Handling timer "check-buildbucket-build-status" (emscripten-releases/linux-test-suites:9039435598989883056:79:0)
[07:48:21.958] Timer tick, asking Buildbucket for the build status
[07:48:22.189] Build 8874005536830467088: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:48:22.189] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/linux-test-suites:9039435598989883056:80:0) after 1m0s
[07:49:22.218] Handling timer "check-buildbucket-build-status" (emscripten-releases/linux-test-suites:9039435598989883056:80:0)
[07:49:22.218] Timer tick, asking Buildbucket for the build status
[07:49:22.335] Build 8874005536830467088: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:49:22.335] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/linux-test-suites:9039435598989883056:81:0) after 1m0s
[07:50:22.370] Handling timer "check-buildbucket-build-status" (emscripten-releases/linux-test-suites:9039435598989883056:81:0)
[07:50:22.370] Timer tick, asking Buildbucket for the build status
[07:50:22.570] Build 8874005536830467088: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:50:22.570] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/linux-test-suites:9039435598989883056:82:0) after 1m0s
[07:51:22.610] Handling timer "check-buildbucket-build-status" (emscripten-releases/linux-test-suites:9039435598989883056:82:0)
[07:51:22.610] Timer tick, asking Buildbucket for the build status
[07:51:22.811] Build 8874005536830467088: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:51:22.811] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/linux-test-suites:9039435598989883056:83:0) after 1m0s
[07:52:22.849] Handling timer "check-buildbucket-build-status" (emscripten-releases/linux-test-suites:9039435598989883056:83:0)
[07:52:22.849] Timer tick, asking Buildbucket for the build status
[07:52:22.925] Build 8874005536830467088: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:52:22.925] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/linux-test-suites:9039435598989883056:84:0) after 1m0s
[07:53:22.957] Handling timer "check-buildbucket-build-status" (emscripten-releases/linux-test-suites:9039435598989883056:84:0)
[07:53:22.957] Timer tick, asking Buildbucket for the build status
[07:53:23.376] Build 8874005536830467088: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:53:23.376] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/linux-test-suites:9039435598989883056:85:0) after 1m0s
[07:54:23.402] Handling timer "check-buildbucket-build-status" (emscripten-releases/linux-test-suites:9039435598989883056:85:0)
[07:54:23.402] Timer tick, asking Buildbucket for the build status
[07:54:23.525] Build 8874005536830467088: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:54:23.525] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/linux-test-suites:9039435598989883056:86:0) after 1m0s
[07:55:23.585] Handling timer "check-buildbucket-build-status" (emscripten-releases/linux-test-suites:9039435598989883056:86:0)
[07:55:23.585] Timer tick, asking Buildbucket for the build status
[07:55:23.877] Build 8874005536830467088: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:55:23.877] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/linux-test-suites:9039435598989883056:87:0) after 1m0s
[07:56:23.906] Handling timer "check-buildbucket-build-status" (emscripten-releases/linux-test-suites:9039435598989883056:87:0)
[07:56:23.906] Timer tick, asking Buildbucket for the build status
[07:56:24.062] Build 8874005536830467088: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:56:24.062] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/linux-test-suites:9039435598989883056:88:0) after 1m0s
[07:57:24.059] Handling timer "check-buildbucket-build-status" (emscripten-releases/linux-test-suites:9039435598989883056:88:0)
[07:57:24.059] Timer tick, asking Buildbucket for the build status
[07:57:25.738] Build 8874005536830467088: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:57:25.738] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/linux-test-suites:9039435598989883056:89:0) after 1m0s
[07:58:25.864] Handling timer "check-buildbucket-build-status" (emscripten-releases/linux-test-suites:9039435598989883056:89:0)
[07:58:25.864] Timer tick, asking Buildbucket for the build status
[07:58:25.972] Build 8874005536830467088: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:58:25.972] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/linux-test-suites:9039435598989883056:90:0) after 1m0s
[07:59:26.353] Handling timer "check-buildbucket-build-status" (emscripten-releases/linux-test-suites:9039435598989883056:90:0)
[07:59:26.353] Timer tick, asking Buildbucket for the build status
[07:59:26.464] Build 8874005536830467088: status "STARTED", result "", failure_reason "", cancelation_reason ""
[07:59:26.464] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/linux-test-suites:9039435598989883056:91:0) after 1m0s
[08:00:26.665] Handling timer "check-buildbucket-build-status" (emscripten-releases/linux-test-suites:9039435598989883056:91:0)
[08:00:26.665] Timer tick, asking Buildbucket for the build status
[08:00:27.696] Build 8874005536830467088: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:00:27.696] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/linux-test-suites:9039435598989883056:92:0) after 1m0s
[08:01:27.757] Handling timer "check-buildbucket-build-status" (emscripten-releases/linux-test-suites:9039435598989883056:92:0)
[08:01:27.757] Timer tick, asking Buildbucket for the build status
[08:01:28.386] Build 8874005536830467088: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:01:28.386] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/linux-test-suites:9039435598989883056:93:0) after 1m0s
[08:02:28.403] Handling timer "check-buildbucket-build-status" (emscripten-releases/linux-test-suites:9039435598989883056:93:0)
[08:02:28.403] Timer tick, asking Buildbucket for the build status
[08:02:28.481] Build 8874005536830467088: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:02:28.481] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/linux-test-suites:9039435598989883056:94:0) after 1m0s
[08:03:28.571] Handling timer "check-buildbucket-build-status" (emscripten-releases/linux-test-suites:9039435598989883056:94:0)
[08:03:28.571] Timer tick, asking Buildbucket for the build status
[08:03:28.994] Build 8874005536830467088: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:03:28.994] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/linux-test-suites:9039435598989883056:95:0) after 1m0s
[08:04:29.062] Handling timer "check-buildbucket-build-status" (emscripten-releases/linux-test-suites:9039435598989883056:95:0)
[08:04:29.062] Timer tick, asking Buildbucket for the build status
[08:04:29.137] Build 8874005536830467088: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:04:29.137] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/linux-test-suites:9039435598989883056:96:0) after 1m0s
[08:05:29.240] Handling timer "check-buildbucket-build-status" (emscripten-releases/linux-test-suites:9039435598989883056:96:0)
[08:05:29.240] Timer tick, asking Buildbucket for the build status
[08:05:29.319] Build 8874005536830467088: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:05:29.319] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/linux-test-suites:9039435598989883056:97:0) after 1m0s
[08:06:29.442] Handling timer "check-buildbucket-build-status" (emscripten-releases/linux-test-suites:9039435598989883056:97:0)
[08:06:29.442] Timer tick, asking Buildbucket for the build status
[08:06:29.911] Build 8874005536830467088: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:06:29.911] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/linux-test-suites:9039435598989883056:98:0) after 1m0s
[08:07:29.928] Handling timer "check-buildbucket-build-status" (emscripten-releases/linux-test-suites:9039435598989883056:98:0)
[08:07:29.928] Timer tick, asking Buildbucket for the build status
[08:07:29.993] Build 8874005536830467088: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:07:29.993] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/linux-test-suites:9039435598989883056:99:0) after 1m0s
[08:08:30.055] Handling timer "check-buildbucket-build-status" (emscripten-releases/linux-test-suites:9039435598989883056:99:0)
[08:08:30.055] Timer tick, asking Buildbucket for the build status
[08:08:30.336] Build 8874005536830467088: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:08:30.336] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/linux-test-suites:9039435598989883056:100:0) after 1m0s
[08:09:30.427] Handling timer "check-buildbucket-build-status" (emscripten-releases/linux-test-suites:9039435598989883056:100:0)
[08:09:30.427] Timer tick, asking Buildbucket for the build status
[08:09:30.520] Build 8874005536830467088: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:09:30.520] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/linux-test-suites:9039435598989883056:101:0) after 1m0s
[08:10:30.622] Handling timer "check-buildbucket-build-status" (emscripten-releases/linux-test-suites:9039435598989883056:101:0)
[08:10:30.622] Timer tick, asking Buildbucket for the build status
[08:10:30.692] Build 8874005536830467088: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:10:30.692] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/linux-test-suites:9039435598989883056:102:0) after 1m0s
[08:11:30.773] Handling timer "check-buildbucket-build-status" (emscripten-releases/linux-test-suites:9039435598989883056:102:0)
[08:11:30.773] Timer tick, asking Buildbucket for the build status
[08:11:31.073] Build 8874005536830467088: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:11:31.073] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/linux-test-suites:9039435598989883056:103:0) after 1m0s
[08:12:31.288] Handling timer "check-buildbucket-build-status" (emscripten-releases/linux-test-suites:9039435598989883056:103:0)
[08:12:31.288] Timer tick, asking Buildbucket for the build status
[08:12:31.372] Build 8874005536830467088: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:12:31.372] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/linux-test-suites:9039435598989883056:104:0) after 1m0s
[08:13:31.464] Handling timer "check-buildbucket-build-status" (emscripten-releases/linux-test-suites:9039435598989883056:104:0)
[08:13:31.464] Timer tick, asking Buildbucket for the build status
[08:13:31.699] Build 8874005536830467088: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:13:31.699] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/linux-test-suites:9039435598989883056:105:0) after 1m0s
[08:14:31.768] Handling timer "check-buildbucket-build-status" (emscripten-releases/linux-test-suites:9039435598989883056:105:0)
[08:14:31.768] Timer tick, asking Buildbucket for the build status
[08:14:32.116] Build 8874005536830467088: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:14:32.116] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/linux-test-suites:9039435598989883056:106:0) after 1m0s
[08:15:32.167] Handling timer "check-buildbucket-build-status" (emscripten-releases/linux-test-suites:9039435598989883056:106:0)
[08:15:32.167] Timer tick, asking Buildbucket for the build status
[08:15:32.246] Build 8874005536830467088: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:15:32.246] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/linux-test-suites:9039435598989883056:107:0) after 1m0s
[08:16:32.340] Handling timer "check-buildbucket-build-status" (emscripten-releases/linux-test-suites:9039435598989883056:107:0)
[08:16:32.340] Timer tick, asking Buildbucket for the build status
[08:16:32.763] Build 8874005536830467088: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:16:32.763] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/linux-test-suites:9039435598989883056:108:0) after 1m0s
[08:17:32.847] Handling timer "check-buildbucket-build-status" (emscripten-releases/linux-test-suites:9039435598989883056:108:0)
[08:17:32.847] Timer tick, asking Buildbucket for the build status
[08:17:33.084] Build 8874005536830467088: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:17:33.084] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/linux-test-suites:9039435598989883056:109:0) after 1m0s
[08:18:33.261] Handling timer "check-buildbucket-build-status" (emscripten-releases/linux-test-suites:9039435598989883056:109:0)
[08:18:33.261] Timer tick, asking Buildbucket for the build status
[08:18:33.382] Build 8874005536830467088: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:18:33.382] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/linux-test-suites:9039435598989883056:110:0) after 1m0s
[08:19:33.422] Handling timer "check-buildbucket-build-status" (emscripten-releases/linux-test-suites:9039435598989883056:110:0)
[08:19:33.422] Timer tick, asking Buildbucket for the build status
[08:19:33.717] Build 8874005536830467088: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:19:33.717] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/linux-test-suites:9039435598989883056:111:0) after 1m0s
[08:20:33.818] Handling timer "check-buildbucket-build-status" (emscripten-releases/linux-test-suites:9039435598989883056:111:0)
[08:20:33.818] Timer tick, asking Buildbucket for the build status
[08:20:34.485] Build 8874005536830467088: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:20:34.485] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/linux-test-suites:9039435598989883056:112:0) after 1m0s
[08:21:34.564] Handling timer "check-buildbucket-build-status" (emscripten-releases/linux-test-suites:9039435598989883056:112:0)
[08:21:34.564] Timer tick, asking Buildbucket for the build status
[08:21:34.741] Build 8874005536830467088: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:21:34.741] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/linux-test-suites:9039435598989883056:113:0) after 1m0s
[08:22:34.924] Handling timer "check-buildbucket-build-status" (emscripten-releases/linux-test-suites:9039435598989883056:113:0)
[08:22:34.924] Timer tick, asking Buildbucket for the build status
[08:22:35.425] Build 8874005536830467088: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:22:35.425] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/linux-test-suites:9039435598989883056:114:0) after 1m0s
[08:23:35.474] Handling timer "check-buildbucket-build-status" (emscripten-releases/linux-test-suites:9039435598989883056:114:0)
[08:23:35.474] Timer tick, asking Buildbucket for the build status
[08:23:35.593] Build 8874005536830467088: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:23:35.593] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/linux-test-suites:9039435598989883056:115:0) after 1m0s
[08:24:35.623] Handling timer "check-buildbucket-build-status" (emscripten-releases/linux-test-suites:9039435598989883056:115:0)
[08:24:35.623] Timer tick, asking Buildbucket for the build status
[08:24:35.729] Build 8874005536830467088: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:24:35.729] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/linux-test-suites:9039435598989883056:116:0) after 1m0s
[08:25:35.761] Handling timer "check-buildbucket-build-status" (emscripten-releases/linux-test-suites:9039435598989883056:116:0)
[08:25:35.761] Timer tick, asking Buildbucket for the build status
[08:25:35.983] Build 8874005536830467088: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:25:35.983] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/linux-test-suites:9039435598989883056:117:0) after 1m0s
[08:26:36.056] Handling timer "check-buildbucket-build-status" (emscripten-releases/linux-test-suites:9039435598989883056:117:0)
[08:26:36.056] Timer tick, asking Buildbucket for the build status
[08:26:36.247] Build 8874005536830467088: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:26:36.247] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/linux-test-suites:9039435598989883056:118:0) after 1m0s
[08:27:36.414] Handling timer "check-buildbucket-build-status" (emscripten-releases/linux-test-suites:9039435598989883056:118:0)
[08:27:36.414] Timer tick, asking Buildbucket for the build status
[08:27:36.547] Build 8874005536830467088: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:27:36.547] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/linux-test-suites:9039435598989883056:119:0) after 1m0s
[08:28:36.629] Handling timer "check-buildbucket-build-status" (emscripten-releases/linux-test-suites:9039435598989883056:119:0)
[08:28:36.629] Timer tick, asking Buildbucket for the build status
[08:28:37.549] Build 8874005536830467088: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:28:37.549] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/linux-test-suites:9039435598989883056:120:0) after 1m0s
[08:29:37.720] Handling timer "check-buildbucket-build-status" (emscripten-releases/linux-test-suites:9039435598989883056:120:0)
[08:29:37.720] Timer tick, asking Buildbucket for the build status
[08:29:37.793] Build 8874005536830467088: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:29:37.793] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/linux-test-suites:9039435598989883056:121:0) after 1m0s
[08:30:37.979] Handling timer "check-buildbucket-build-status" (emscripten-releases/linux-test-suites:9039435598989883056:121:0)
[08:30:37.979] Timer tick, asking Buildbucket for the build status
[08:30:38.124] Build 8874005536830467088: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:30:38.124] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/linux-test-suites:9039435598989883056:122:0) after 1m0s
[08:31:38.167] Handling timer "check-buildbucket-build-status" (emscripten-releases/linux-test-suites:9039435598989883056:122:0)
[08:31:38.167] Timer tick, asking Buildbucket for the build status
[08:31:38.299] Build 8874005536830467088: status "STARTED", result "", failure_reason "", cancelation_reason ""
[08:31:38.299] Scheduling timer "check-buildbucket-build-status" (emscripten-releases/linux-test-suites:9039435598989883056:123:0) after 1m0s
[08:32:06.765] Received PubSub notification, asking Buildbucket for the build status
[08:32:07.208] Build 8874005536830467088: status "COMPLETED", result "CANCELED", failure_reason "", cancelation_reason "TIMEOUT"
[08:32:07.208] Buildbucket build:
{
"build": {
"bucket": "luci.emscripten-releases.ci",
"canary_preference": "PROD",
"cancelation_reason": "TIMEOUT",
"completed_ts": "1595493125807104",
"created_by": "project:emscripten-releases",
"created_ts": "1595485858085342",
"id": "8874005536830467088",
"parameters_json": "{\"builder_name\": \"linux-test-suites\", \"properties\": {\"$recipe_engine/scheduler\": {\"hostname\": \"luci-scheduler.appspot.com\", \"triggers\": [{\"gitiles\": {\"ref\": \"refs/heads/master\", \"repo\": \"https://chromium.googlesource.com/emscripten-releases\", \"revision\": \"85f106641547876e0f6a6e41bc4c7feab310722b\"}, \"id\": \"https://chromium.googlesource.com/emscripten-releases/+/refs/heads/master@85f106641547876e0f6a6e41bc4c7feab310722b\", \"title\": \"85f106641547876e0f6a6e41bc4c7feab310722b\", \"url\": \"https://chromium.googlesource.com/emscripten-releases/+/85f106641547876e0f6a6e41bc4c7feab310722b\"}]}, \"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/emscripten-releases\", \"revision\": \"85f106641547876e0f6a6e41bc4c7feab310722b\"}}",
"project": "emscripten-releases",
"result": "CANCELED",
"result_details_json": "{\"properties\": {\"$build/goma\": {\"enable_ats\": true, \"rpc_extra_params\": \"?prod\", \"server_host\": \"goma.chromium.org\"}, \"$recipe_engine/path\": {\"cache_dir\": \"/b/s/w/ir/cache\", \"temp_dir\": \"/b/s/w/ir/tmp/rt\"}, \"$recipe_engine/runtime\": {\"is_experimental\": false, \"is_luci\": true}, \"$recipe_engine/scheduler\": {\"hostname\": \"luci-scheduler.appspot.com\", \"triggers\": [{\"gitiles\": {\"ref\": \"refs/heads/master\", \"repo\": \"https://chromium.googlesource.com/emscripten-releases\", \"revision\": \"85f106641547876e0f6a6e41bc4c7feab310722b\"}, \"id\": \"https://chromium.googlesource.com/emscripten-releases/+/refs/heads/master@85f106641547876e0f6a6e41bc4c7feab310722b\", \"title\": \"85f106641547876e0f6a6e41bc4c7feab310722b\", \"url\": \"https://chromium.googlesource.com/emscripten-releases/+/85f106641547876e0f6a6e41bc4c7feab310722b\"}]}, \"archive\": false, \"bot_id\": \"luci-emscripten-releases-ci-xenial-0-eble\", \"branch\": \"refs/heads/master\", \"buildername\": \"linux-test-suites\", \"got_revision\": \"85f106641547876e0f6a6e41bc4c7feab310722b\", \"path_config\": \"generic\", \"recipe\": \"emscripten_releases\", \"repository\": \"https://chromium.googlesource.com/emscripten-releases\", \"revision\": \"85f106641547876e0f6a6e41bc4c7feab310722b\"}, \"swarming\": {\"bot_dimensions\": {\"caches\": [\"builder_e437bc7da551d62da6a64b09ca05a66344db3b0846e125cb83052108c473fa36_v2\", \"git\", \"goma_v2\", \"vpython\"], \"cores\": [\"8\"], \"cpu\": [\"x86\", \"x86-64\", \"x86-64-Broadwell_GCE\", \"x86-64-avx2\"], \"gce\": [\"1\"], \"gcp\": [\"google.com:chromecompute\"], \"gpu\": [\"none\"], \"host_class\": [\"default\"], \"id\": [\"luci-emscripten-releases-ci-xenial-0-eble\"], \"image\": [\"chrome-xenial-20052400-59eb8623c93\"], \"inside_docker\": [\"0\"], \"kvm\": [\"1\"], \"locale\": [\"en_US.UTF-8\"], \"machine_type\": [\"n1-standard-8\"], \"os\": [\"Linux\", \"Ubuntu\", \"Ubuntu-16\", \"Ubuntu-16.04\", \"Ubuntu-16.04.6\"], \"pool\": [\"luci.emscripten-releases.ci\"], \"python\": [\"2.7.12\"], \"server_version\": [\"5425-e4e3059\"], \"ssd\": [\"0\"], \"zone\": [\"us\", \"us-east\", \"us-east1\", \"us-east1-b\"]}}}",
"service_account": "emscripten-releases-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"started_ts": "1595485895652451",
"status": "COMPLETED",
"status_changed_ts": "1595493126260314",
"tags": [
"builder:linux-test-suites",
"buildset:commit/git/85f106641547876e0f6a6e41bc4c7feab310722b",
"buildset:commit/gitiles/chromium.googlesource.com/emscripten-releases/+/85f106641547876e0f6a6e41bc4c7feab310722b",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9039435598989883056",
"scheduler_job_id:emscripten-releases/linux-test-suites",
"swarming_hostname:chromium-swarm.appspot.com",
"swarming_tag:log_location:logdog://logs.chromium.org/emscripten-releases/buildbucket/cr-buildbucket.appspot.com/8874005536830467088/+/annotations",
"swarming_tag:luci_project:emscripten-releases",
"swarming_tag:os:Linux",
"swarming_tag:recipe_name:emscripten_releases",
"swarming_tag:recipe_package:infra/recipe_bundles/chromium.googlesource.com/chromium/tools/build",
"swarming_task_id:4d932fb55d937610",
"user_agent:luci-scheduler"
],
"updated_ts": "1595493126339548",
"url": "https://ci.chromium.org/b/8874005536830467088",
"utcnow_ts": "1595493126913803"
}
}
[08:32:07.208] Invocation finished in 2h1m10.564955327s with status FAILED