[14:29:04.215] New invocation is queued and will start shortly
[14:29:05.289] Starting the invocation (attempt 1)
[14:29:05.345] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[14:29:05.345] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[14:29:05.345] Buildbucket request:
{
"bucket": "luci.chromium.ci",
"client_operation_id": "9017571649007625200",
"parameters_json": "{\"builder_name\":\"Deterministic Android (dbg)\",\"properties\":{\"branch\":\"refs/heads/master\",\"repository\":\"https://chromium.googlesource.com/chromium/src\",\"revision\":\"b1a9dec29bf7faeef5ad1be2592dd64bb864d64c\"}}",
"pubsub_callback": {
"auth_token": "...",
"topic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
},
"tags": [
"builder:Deterministic Android (dbg)",
"scheduler_invocation_id:9017571649007625200",
"scheduler_job_id:chromium/Deterministic Android (dbg)",
"user_agent:luci-scheduler",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/b1a9dec29bf7faeef5ad1be2592dd64bb864d64c",
"gitiles_ref:refs/heads/master"
]
}
[14:29:06.066] Buildbucket response:
{
"build": {
"bucket": "luci.chromium.ci",
"canary_preference": "PROD",
"created_by": "project:chromium",
"created_ts": "1616336945551214",
"id": "8852141586940038576",
"parameters_json": "{\"builder_name\": \"Deterministic Android (dbg)\", \"properties\": {\"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/chromium/src\", \"revision\": \"b1a9dec29bf7faeef5ad1be2592dd64bb864d64c\"}}",
"project": "chromium",
"result_details_json": "{\"properties\": {}}",
"service_account": "chromium-ci-builder@chops-service-accounts.iam.gserviceaccount.com",
"status": "SCHEDULED",
"status_changed_ts": "1616336945886104",
"tags": [
"build_address:luci.chromium.ci/Deterministic Android (dbg)/8876",
"builder:Deterministic Android (dbg)",
"buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/b1a9dec29bf7faeef5ad1be2592dd64bb864d64c",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9017571649007625200",
"scheduler_job_id:chromium/Deterministic Android (dbg)",
"swarming_hostname:chromium-swarm.appspot.com",
"swarming_tag:log_location:logdog://logs.chromium.org/chromium/buildbucket/cr-buildbucket.appspot.com/8852141586940038576/+/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": "1616336945886212",
"url": "https://ci.chromium.org/b/8852141586940038576",
"utcnow_ts": "1616336946055036"
}
}
[14:29:06.066] Task URL: https://ci.chromium.org/b/8852141586940038576
[14:29:06.066] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9017571649007625200:2:0) after 1m0s
[14:30:06.083] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9017571649007625200:2:0)
[14:30:06.123] Build status: SCHEDULED
[14:30:06.123] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9017571649007625200:3:0) after 6m8s
[14:36:14.138] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9017571649007625200:3:0)
[14:36:14.163] Build status: SCHEDULED
[14:36:14.163] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9017571649007625200:4:0) after 4m47s
[14:41:01.261] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9017571649007625200:4:0)
[14:41:01.294] Build status: SCHEDULED
[14:41:01.294] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9017571649007625200:5:0) after 2m16s
[14:43:17.337] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9017571649007625200:5:0)
[14:43:17.337] Timer tick, asking Buildbucket for the build status
[14:43:17.411] Build 8852141586940038576: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[14:43:17.411] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9017571649007625200:6:0) after 1m0s
[14:44:17.499] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9017571649007625200:6:0)
[14:44:17.569] Build status: SCHEDULED
[14:44:17.569] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9017571649007625200:7:0) after 9m48s
[14:54:05.705] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9017571649007625200:7:0)
[14:54:05.735] Build status: SCHEDULED
[14:54:05.735] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9017571649007625200:8:0) after 9m21s
[14:59:05.507] Received PubSub notification, asking Buildbucket for the build status
[14:59:05.583] Build 8852141586940038576: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:03:26.841] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9017571649007625200:8:0)
[15:03:26.867] Build status: STARTED
[15:03:26.867] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9017571649007625200:10:0) after 2m50s
[15:06:16.853] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9017571649007625200:10:0)
[15:06:16.853] Timer tick, asking Buildbucket for the build status
[15:06:16.989] Build 8852141586940038576: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:06:16.989] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9017571649007625200:11:0) after 1m0s
[15:07:17.014] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9017571649007625200:11:0)
[15:07:17.095] Build status: STARTED
[15:07:17.095] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9017571649007625200:12:0) after 2m27s
[15:09:44.113] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9017571649007625200:12:0)
[15:09:44.138] Build status: STARTED
[15:09:44.138] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9017571649007625200:13:0) after 8m16s
[15:18:00.164] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9017571649007625200:13:0)
[15:18:00.192] Build status: STARTED
[15:18:00.192] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9017571649007625200:14:0) after 6m24s
[15:24:24.212] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9017571649007625200:14:0)
[15:24:24.259] Build status: STARTED
[15:24:24.259] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9017571649007625200:15:0) after 5m55s
[15:30:19.552] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9017571649007625200:15:0)
[15:30:19.552] Timer tick, asking Buildbucket for the build status
[15:30:19.965] Build 8852141586940038576: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:30:19.965] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9017571649007625200:16:0) after 1m0s
[15:31:20.657] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9017571649007625200:16:0)
[15:31:20.657] Timer tick, asking Buildbucket for the build status
[15:31:20.741] Build 8852141586940038576: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:31:20.741] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9017571649007625200:17:0) after 1m0s
[15:32:21.137] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9017571649007625200:17:0)
[15:32:21.180] Build status: STARTED
[15:32:21.180] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9017571649007625200:18:0) after 7m14s
[15:39:35.196] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9017571649007625200:18:0)
[15:39:35.196] Timer tick, asking Buildbucket for the build status
[15:39:35.277] Build 8852141586940038576: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:39:35.277] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9017571649007625200:19:0) after 1m0s
[15:40:35.299] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9017571649007625200:19:0)
[15:40:35.323] Build status: STARTED
[15:40:35.323] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9017571649007625200:20:0) after 7m17s
[15:47:52.325] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9017571649007625200:20:0)
[15:47:52.325] Timer tick, asking Buildbucket for the build status
[15:47:52.406] Build 8852141586940038576: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:47:52.406] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9017571649007625200:21:0) after 1m0s
[15:48:52.421] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9017571649007625200:21:0)
[15:48:52.421] Timer tick, asking Buildbucket for the build status
[15:48:52.986] Build 8852141586940038576: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:48:52.986] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9017571649007625200:22:0) after 1m0s
[15:49:53.001] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9017571649007625200:22:0)
[15:49:53.027] Build status: STARTED
[15:49:53.027] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9017571649007625200:23:0) after 9m44s
[15:59:37.041] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9017571649007625200:23:0)
[15:59:37.041] Timer tick, asking Buildbucket for the build status
[15:59:37.218] Build 8852141586940038576: status "STARTED", result "", failure_reason "", cancelation_reason ""
[15:59:37.218] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9017571649007625200:24:0) after 1m0s
[16:00:37.237] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9017571649007625200:24:0)
[16:00:37.282] Build status: STARTED
[16:00:37.282] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9017571649007625200:25:0) after 6m15s
[16:06:52.362] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9017571649007625200:25:0)
[16:06:52.389] Build status: STARTED
[16:06:52.389] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9017571649007625200:26:0) after 9m41s
[16:16:33.409] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9017571649007625200:26:0)
[16:16:33.409] Timer tick, asking Buildbucket for the build status
[16:16:33.494] Build 8852141586940038576: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:16:33.494] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9017571649007625200:27:0) after 1m0s
[16:17:33.560] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9017571649007625200:27:0)
[16:17:33.560] Timer tick, asking Buildbucket for the build status
[16:17:33.635] Build 8852141586940038576: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:17:33.635] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9017571649007625200:28:0) after 1m0s
[16:18:33.677] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9017571649007625200:28:0)
[16:18:33.677] Timer tick, asking Buildbucket for the build status
[16:18:33.738] Build 8852141586940038576: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:18:33.738] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9017571649007625200:29:0) after 1m0s
[16:19:33.754] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9017571649007625200:29:0)
[16:19:33.754] Timer tick, asking Buildbucket for the build status
[16:19:33.820] Build 8852141586940038576: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:19:33.820] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9017571649007625200:30:0) after 1m0s
[16:20:33.837] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9017571649007625200:30:0)
[16:20:33.880] Build status: STARTED
[16:20:33.880] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9017571649007625200:31:0) after 8m17s
[16:28:51.107] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9017571649007625200:31:0)
[16:28:51.139] Build status: STARTED
[16:28:51.139] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9017571649007625200:32:0) after 3m21s
[16:32:12.813] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9017571649007625200:32:0)
[16:32:12.840] Build status: STARTED
[16:32:12.840] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9017571649007625200:33:0) after 4m8s
[16:36:20.859] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9017571649007625200:33:0)
[16:36:20.882] Build status: STARTED
[16:36:20.882] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9017571649007625200:34:0) after 2m23s
[16:38:43.971] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9017571649007625200:34:0)
[16:38:43.998] Build status: STARTED
[16:38:43.998] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9017571649007625200:35:0) after 6m59s
[16:45:43.014] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9017571649007625200:35:0)
[16:45:43.014] Timer tick, asking Buildbucket for the build status
[16:45:43.110] Build 8852141586940038576: status "STARTED", result "", failure_reason "", cancelation_reason ""
[16:45:43.110] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9017571649007625200:36:0) after 1m0s
[16:46:43.134] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9017571649007625200:36:0)
[16:46:43.281] Build status: STARTED
[16:46:43.281] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9017571649007625200:37:0) after 8m21s
[16:55:04.741] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9017571649007625200:37:0)
[16:55:04.767] Build status: STARTED
[16:55:04.767] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9017571649007625200:38:0) after 7m38s
[17:02:42.748] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9017571649007625200:38:0)
[17:02:42.775] Build status: STARTED
[17:02:42.775] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9017571649007625200:39:0) after 2m36s
[17:05:18.790] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9017571649007625200:39:0)
[17:05:18.886] Build status: STARTED
[17:05:18.886] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9017571649007625200:40:0) after 8m27s
[17:13:45.910] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9017571649007625200:40:0)
[17:13:45.910] Timer tick, asking Buildbucket for the build status
[17:13:46.061] Build 8852141586940038576: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:13:46.061] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9017571649007625200:41:0) after 1m0s
[17:14:46.078] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9017571649007625200:41:0)
[17:14:46.078] Timer tick, asking Buildbucket for the build status
[17:14:46.148] Build 8852141586940038576: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:14:46.148] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9017571649007625200:42:0) after 1m0s
[17:15:46.169] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9017571649007625200:42:0)
[17:15:46.210] Build status: STARTED
[17:15:46.210] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9017571649007625200:43:0) after 7m54s
[17:23:40.294] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9017571649007625200:43:0)
[17:23:40.294] Timer tick, asking Buildbucket for the build status
[17:23:40.408] Build 8852141586940038576: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:23:40.408] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9017571649007625200:44:0) after 1m0s
[17:24:40.429] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9017571649007625200:44:0)
[17:24:40.454] Build status: STARTED
[17:24:40.454] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9017571649007625200:45:0) after 2m51s
[17:27:31.476] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9017571649007625200:45:0)
[17:27:31.476] Timer tick, asking Buildbucket for the build status
[17:27:31.604] Build 8852141586940038576: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:27:31.605] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9017571649007625200:46:0) after 1m0s
[17:28:31.723] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9017571649007625200:46:0)
[17:28:31.751] Build status: STARTED
[17:28:31.751] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9017571649007625200:47:0) after 9m15s
[17:37:47.087] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9017571649007625200:47:0)
[17:37:47.111] Build status: STARTED
[17:37:47.111] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9017571649007625200:48:0) after 6m1s
[17:43:48.154] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9017571649007625200:48:0)
[17:43:48.154] Timer tick, asking Buildbucket for the build status
[17:43:48.268] Build 8852141586940038576: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:43:48.268] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9017571649007625200:49:0) after 1m0s
[17:44:48.492] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9017571649007625200:49:0)
[17:44:48.492] Timer tick, asking Buildbucket for the build status
[17:44:48.705] Build 8852141586940038576: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:44:48.705] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9017571649007625200:50:0) after 1m0s
[17:45:48.724] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9017571649007625200:50:0)
[17:45:48.725] Timer tick, asking Buildbucket for the build status
[17:45:48.796] Build 8852141586940038576: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:45:48.796] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9017571649007625200:51:0) after 1m0s
[17:46:48.781] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9017571649007625200:51:0)
[17:46:48.807] Build status: STARTED
[17:46:48.807] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9017571649007625200:52:0) after 5m7s
[17:51:55.825] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9017571649007625200:52:0)
[17:51:55.825] Timer tick, asking Buildbucket for the build status
[17:51:56.122] Build 8852141586940038576: status "STARTED", result "", failure_reason "", cancelation_reason ""
[17:51:56.122] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9017571649007625200:53:0) after 1m0s
[17:52:56.143] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9017571649007625200:53:0)
[17:52:56.172] Build status: STARTED
[17:52:56.172] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9017571649007625200:54:0) after 3m31s
[17:56:27.202] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9017571649007625200:54:0)
[17:56:27.234] Build status: STARTED
[17:56:27.234] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9017571649007625200:55:0) after 5m33s
[18:02:00.650] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9017571649007625200:55:0)
[18:02:00.650] Timer tick, asking Buildbucket for the build status
[18:02:01.367] Build 8852141586940038576: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:02:01.367] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9017571649007625200:56:0) after 1m0s
[18:03:01.390] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9017571649007625200:56:0)
[18:03:01.390] Timer tick, asking Buildbucket for the build status
[18:03:01.703] Build 8852141586940038576: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:03:01.703] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9017571649007625200:57:0) after 1m0s
[18:04:01.739] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9017571649007625200:57:0)
[18:04:01.739] Timer tick, asking Buildbucket for the build status
[18:04:01.992] Build 8852141586940038576: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:04:01.992] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9017571649007625200:58:0) after 1m0s
[18:05:02.012] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9017571649007625200:58:0)
[18:05:02.012] Timer tick, asking Buildbucket for the build status
[18:05:02.110] Build 8852141586940038576: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:05:02.110] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9017571649007625200:59:0) after 1m0s
[18:06:02.139] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9017571649007625200:59:0)
[18:06:02.172] Build status: STARTED
[18:06:02.172] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9017571649007625200:60:0) after 7m56s
[18:13:58.191] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9017571649007625200:60:0)
[18:13:58.239] Build status: STARTED
[18:13:58.239] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9017571649007625200:61:0) after 8m35s
[18:22:33.276] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9017571649007625200:61:0)
[18:22:33.313] Build status: STARTED
[18:22:33.313] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9017571649007625200:62:0) after 3m46s
[18:26:19.429] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9017571649007625200:62:0)
[18:26:19.429] Timer tick, asking Buildbucket for the build status
[18:26:19.514] Build 8852141586940038576: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:26:19.514] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9017571649007625200:63:0) after 1m0s
[18:27:19.659] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9017571649007625200:63:0)
[18:27:19.659] Timer tick, asking Buildbucket for the build status
[18:27:19.816] Build 8852141586940038576: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:27:19.816] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9017571649007625200:64:0) after 1m0s
[18:28:19.837] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9017571649007625200:64:0)
[18:28:19.837] Timer tick, asking Buildbucket for the build status
[18:28:19.952] Build 8852141586940038576: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:28:19.952] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9017571649007625200:65:0) after 1m0s
[18:29:20.054] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9017571649007625200:65:0)
[18:29:20.113] Build status: STARTED
[18:29:20.113] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9017571649007625200:66:0) after 7m9s
[18:36:29.144] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9017571649007625200:66:0)
[18:36:29.144] Timer tick, asking Buildbucket for the build status
[18:36:29.228] Build 8852141586940038576: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:36:29.228] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9017571649007625200:67:0) after 1m0s
[18:37:29.248] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9017571649007625200:67:0)
[18:37:29.248] Timer tick, asking Buildbucket for the build status
[18:37:29.313] Build 8852141586940038576: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:37:29.313] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9017571649007625200:68:0) after 1m0s
[18:38:29.295] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9017571649007625200:68:0)
[18:38:29.295] Timer tick, asking Buildbucket for the build status
[18:38:29.419] Build 8852141586940038576: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:38:29.419] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9017571649007625200:69:0) after 1m0s
[18:39:29.574] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9017571649007625200:69:0)
[18:39:29.597] Build status: STARTED
[18:39:29.597] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9017571649007625200:70:0) after 6m47s
[18:46:16.621] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9017571649007625200:70:0)
[18:46:16.621] Timer tick, asking Buildbucket for the build status
[18:46:16.709] Build 8852141586940038576: status "STARTED", result "", failure_reason "", cancelation_reason ""
[18:46:16.709] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9017571649007625200:71:0) after 1m0s
[18:47:16.802] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9017571649007625200:71:0)
[18:47:16.834] Build status: STARTED
[18:47:16.834] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9017571649007625200:72:0) after 6m39s
[18:53:55.878] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9017571649007625200:72:0)
[18:53:55.904] Build status: STARTED
[18:53:55.904] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9017571649007625200:73:0) after 7m29s
[19:01:24.923] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9017571649007625200:73:0)
[19:01:24.958] Build status: STARTED
[19:01:24.958] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9017571649007625200:74:0) after 7m57s
[19:09:21.980] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9017571649007625200:74:0)
[19:09:22.009] Build status: STARTED
[19:09:22.009] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9017571649007625200:75:0) after 4m48s
[19:14:10.030] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9017571649007625200:75:0)
[19:14:10.030] Timer tick, asking Buildbucket for the build status
[19:14:10.157] Build 8852141586940038576: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:14:10.157] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9017571649007625200:76:0) after 1m0s
[19:15:10.176] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9017571649007625200:76:0)
[19:15:10.204] Build status: STARTED
[19:15:10.204] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9017571649007625200:77:0) after 5m30s
[19:20:40.537] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9017571649007625200:77:0)
[19:20:40.564] Build status: STARTED
[19:20:40.564] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9017571649007625200:78:0) after 9m56s
[19:30:36.889] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9017571649007625200:78:0)
[19:30:36.964] Build status: STARTED
[19:30:36.964] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9017571649007625200:79:0) after 2m6s
[19:32:43.083] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9017571649007625200:79:0)
[19:32:43.083] Timer tick, asking Buildbucket for the build status
[19:32:43.171] Build 8852141586940038576: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:32:43.171] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9017571649007625200:80:0) after 1m0s
[19:33:43.192] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9017571649007625200:80:0)
[19:33:43.192] Timer tick, asking Buildbucket for the build status
[19:33:43.280] Build 8852141586940038576: status "STARTED", result "", failure_reason "", cancelation_reason ""
[19:33:43.280] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9017571649007625200:81:0) after 1m0s
[19:34:43.414] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9017571649007625200:81:0)
[19:34:43.444] Build status: STARTED
[19:34:43.444] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9017571649007625200:82:0) after 6m38s
[19:41:21.602] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9017571649007625200:82:0)
[19:41:21.736] Build status: STARTED
[19:41:21.736] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9017571649007625200:83:0) after 6m35s
[19:47:56.806] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9017571649007625200:83:0)
[19:47:56.832] Build status: STARTED
[19:47:56.832] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9017571649007625200:84:0) after 4m35s
[19:52:31.851] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9017571649007625200:84:0)
[19:52:31.878] Build status: STARTED
[19:52:31.878] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9017571649007625200:85:0) after 7m30s
[20:00:01.932] Handling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9017571649007625200:85:0)
[20:00:01.962] Build status: STARTED
[20:00:01.962] Scheduling timer "check-buildbucket-build-status" (chromium/Deterministic Android (dbg):9017571649007625200:86:0) after 9m46s
[20:00:52.594] Received PubSub notification, asking Buildbucket for the build status
[20:00:52.618] Build:
{
"id": "8852141586940038576",
"builder": {
"project": "chromium",
"bucket": "ci",
"builder": "Deterministic Android (dbg)"
},
"number": 8876,
"createdBy": "project:chromium",
"createTime": "2021-03-21T14:29:05.551214Z",
"startTime": "2021-03-21T14:59:04.539838Z",
"endTime": "2021-03-21T20:00:51.322648Z",
"updateTime": "2021-03-21T20:00:52.258976Z",
"status": "SUCCESS",
"input": {
"gitilesCommit": {
"host": "chromium.googlesource.com",
"project": "chromium/src",
"id": "b1a9dec29bf7faeef5ad1be2592dd64bb864d64c",
"ref": "refs/heads/master"
}
}
}
[20:00:52.618] Invocation finished in 5h31m48.42173327s with status SUCCEEDED