[08:55:07.372] New invocation is queued and will start shortly
[08:55:09.808] Starting the invocation (attempt 1)
[08:55:09.836] Popped buildset tag "buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/c023163bed4cabe445f7d9b7a25c4b0e1226a33b"
[08:55:09.836] Popped gitiles commit info from properties and tags
[08:55:09.836] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[08:55:09.836] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[08:55:09.836] Buildbucket request:
{
"requestId": "8971207012352779008",
"builder": {
"project": "chromium",
"bucket": "ci",
"builder": "Mac deterministic"
},
"properties": {
},
"gitilesCommit": {
"host": "chromium.googlesource.com",
"project": "chromium/src",
"id": "c023163bed4cabe445f7d9b7a25c4b0e1226a33b",
"ref": "refs/heads/main"
},
"tags": [
{
"key": "scheduler_invocation_id",
"value": "8971207012352779008"
},
{
"key": "scheduler_job_id",
"value": "chromium/Mac deterministic"
},
{
"key": "user_agent",
"value": "luci-scheduler"
}
],
"notify": {
"pubsubTopic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
}
}
[08:55:10.382] Scheduled build:
{
"id": "8805776949045996449",
"builder": {
"project": "chromium",
"bucket": "ci",
"builder": "Mac deterministic"
},
"number": 57040,
"createdBy": "project:chromium",
"createTime": "2022-08-15T08:55:09.900398280Z",
"updateTime": "2022-08-15T08:55:09.900398280Z",
"status": "SCHEDULED",
"input": {
"gitilesCommit": {
"host": "chromium.googlesource.com",
"project": "chromium/src",
"id": "c023163bed4cabe445f7d9b7a25c4b0e1226a33b",
"ref": "refs/heads/main"
}
}
}
[08:55:10.382] Task URL: https://cr-buildbucket.appspot.com/build/8805776949045996449
[08:55:10.382] Scheduling timer "check-buildbucket-build-status" (chromium/Mac deterministic:8971207012352779008:2:0) after 2m48s
[08:57:58.556] Handling timer "check-buildbucket-build-status" (chromium/Mac deterministic:8971207012352779008:2:0)
[08:57:58.588] Build status: SCHEDULED
[08:57:58.588] Scheduling timer "check-buildbucket-build-status" (chromium/Mac deterministic:8971207012352779008:3:0) after 2m30s
[09:00:28.770] Handling timer "check-buildbucket-build-status" (chromium/Mac deterministic:8971207012352779008:3:0)
[09:00:28.798] Build status: SCHEDULED
[09:00:28.798] Scheduling timer "check-buildbucket-build-status" (chromium/Mac deterministic:8971207012352779008:4:0) after 6m30s
[09:06:58.904] Handling timer "check-buildbucket-build-status" (chromium/Mac deterministic:8971207012352779008:4:0)
[09:06:58.953] Build status: SCHEDULED
[09:06:58.953] Scheduling timer "check-buildbucket-build-status" (chromium/Mac deterministic:8971207012352779008:5:0) after 8m58s
[09:15:57.239] Handling timer "check-buildbucket-build-status" (chromium/Mac deterministic:8971207012352779008:5:0)
[09:15:57.268] Build status: SCHEDULED
[09:15:57.268] Scheduling timer "check-buildbucket-build-status" (chromium/Mac deterministic:8971207012352779008:6:0) after 3m17s
[09:19:14.377] Handling timer "check-buildbucket-build-status" (chromium/Mac deterministic:8971207012352779008:6:0)
[09:19:14.395] Build status: SCHEDULED
[09:19:14.395] Scheduling timer "check-buildbucket-build-status" (chromium/Mac deterministic:8971207012352779008:7:0) after 5m27s
[09:24:41.412] Handling timer "check-buildbucket-build-status" (chromium/Mac deterministic:8971207012352779008:7:0)
[09:24:41.439] Build status: SCHEDULED
[09:24:41.439] Scheduling timer "check-buildbucket-build-status" (chromium/Mac deterministic:8971207012352779008:8:0) after 4m9s
[09:28:50.544] Handling timer "check-buildbucket-build-status" (chromium/Mac deterministic:8971207012352779008:8:0)
[09:28:50.576] Build status: SCHEDULED
[09:28:50.576] Scheduling timer "check-buildbucket-build-status" (chromium/Mac deterministic:8971207012352779008:9:0) after 5m48s
[09:34:38.561] Handling timer "check-buildbucket-build-status" (chromium/Mac deterministic:8971207012352779008:9:0)
[09:34:38.594] Build status: SCHEDULED
[09:34:38.594] Scheduling timer "check-buildbucket-build-status" (chromium/Mac deterministic:8971207012352779008:10:0) after 4m24s
[09:39:02.745] Handling timer "check-buildbucket-build-status" (chromium/Mac deterministic:8971207012352779008:10:0)
[09:39:02.767] Build status: SCHEDULED
[09:39:02.767] Scheduling timer "check-buildbucket-build-status" (chromium/Mac deterministic:8971207012352779008:11:0) after 2m21s
[09:41:23.793] Handling timer "check-buildbucket-build-status" (chromium/Mac deterministic:8971207012352779008:11:0)
[09:41:23.846] Build status: SCHEDULED
[09:41:23.847] Scheduling timer "check-buildbucket-build-status" (chromium/Mac deterministic:8971207012352779008:12:0) after 2m3s
[09:43:26.864] Handling timer "check-buildbucket-build-status" (chromium/Mac deterministic:8971207012352779008:12:0)
[09:43:26.883] Build status: SCHEDULED
[09:43:26.883] Scheduling timer "check-buildbucket-build-status" (chromium/Mac deterministic:8971207012352779008:13:0) after 7m40s
[09:51:07.070] Handling timer "check-buildbucket-build-status" (chromium/Mac deterministic:8971207012352779008:13:0)
[09:51:07.092] Build status: SCHEDULED
[09:51:07.092] Scheduling timer "check-buildbucket-build-status" (chromium/Mac deterministic:8971207012352779008:14:0) after 5m53s
[09:57:00.136] Handling timer "check-buildbucket-build-status" (chromium/Mac deterministic:8971207012352779008:14:0)
[09:57:00.157] Build status: SCHEDULED
[09:57:00.157] Scheduling timer "check-buildbucket-build-status" (chromium/Mac deterministic:8971207012352779008:15:0) after 5m21s
[10:02:21.157] Handling timer "check-buildbucket-build-status" (chromium/Mac deterministic:8971207012352779008:15:0)
[10:02:21.174] Build status: SCHEDULED
[10:02:21.175] Scheduling timer "check-buildbucket-build-status" (chromium/Mac deterministic:8971207012352779008:16:0) after 6m25s
[10:08:46.299] Handling timer "check-buildbucket-build-status" (chromium/Mac deterministic:8971207012352779008:16:0)
[10:08:46.335] Build status: SCHEDULED
[10:08:46.335] Scheduling timer "check-buildbucket-build-status" (chromium/Mac deterministic:8971207012352779008:17:0) after 7m29s
[10:16:15.360] Handling timer "check-buildbucket-build-status" (chromium/Mac deterministic:8971207012352779008:17:0)
[10:16:15.388] Build status: SCHEDULED
[10:16:15.388] Scheduling timer "check-buildbucket-build-status" (chromium/Mac deterministic:8971207012352779008:18:0) after 5m57s
[10:22:12.632] Handling timer "check-buildbucket-build-status" (chromium/Mac deterministic:8971207012352779008:18:0)
[10:22:12.660] Build status: SCHEDULED
[10:22:12.660] Scheduling timer "check-buildbucket-build-status" (chromium/Mac deterministic:8971207012352779008:19:0) after 8m3s
[10:30:15.677] Handling timer "check-buildbucket-build-status" (chromium/Mac deterministic:8971207012352779008:19:0)
[10:30:15.695] Build status: SCHEDULED
[10:30:15.695] Scheduling timer "check-buildbucket-build-status" (chromium/Mac deterministic:8971207012352779008:20:0) after 7m23s
[10:37:38.799] Handling timer "check-buildbucket-build-status" (chromium/Mac deterministic:8971207012352779008:20:0)
[10:37:38.830] Build status: SCHEDULED
[10:37:38.830] Scheduling timer "check-buildbucket-build-status" (chromium/Mac deterministic:8971207012352779008:21:0) after 3m29s
[10:41:07.887] Handling timer "check-buildbucket-build-status" (chromium/Mac deterministic:8971207012352779008:21:0)
[10:41:07.912] Build status: SCHEDULED
[10:41:07.912] Scheduling timer "check-buildbucket-build-status" (chromium/Mac deterministic:8971207012352779008:22:0) after 9m56s
[10:51:03.932] Handling timer "check-buildbucket-build-status" (chromium/Mac deterministic:8971207012352779008:22:0)
[10:51:03.962] Build status: SCHEDULED
[10:51:03.962] Scheduling timer "check-buildbucket-build-status" (chromium/Mac deterministic:8971207012352779008:23:0) after 9m54s
[11:00:57.991] Handling timer "check-buildbucket-build-status" (chromium/Mac deterministic:8971207012352779008:23:0)
[11:00:58.012] Build status: SCHEDULED
[11:00:58.012] Scheduling timer "check-buildbucket-build-status" (chromium/Mac deterministic:8971207012352779008:24:0) after 1m13s
[11:02:11.392] Handling timer "check-buildbucket-build-status" (chromium/Mac deterministic:8971207012352779008:24:0)
[11:02:11.438] Build status: SCHEDULED
[11:02:11.438] Scheduling timer "check-buildbucket-build-status" (chromium/Mac deterministic:8971207012352779008:25:0) after 4m47s
[11:06:58.489] Handling timer "check-buildbucket-build-status" (chromium/Mac deterministic:8971207012352779008:25:0)
[11:06:58.512] Build status: SCHEDULED
[11:06:58.512] Scheduling timer "check-buildbucket-build-status" (chromium/Mac deterministic:8971207012352779008:26:0) after 2m41s
[11:09:39.529] Handling timer "check-buildbucket-build-status" (chromium/Mac deterministic:8971207012352779008:26:0)
[11:09:39.550] Build status: SCHEDULED
[11:09:39.550] Scheduling timer "check-buildbucket-build-status" (chromium/Mac deterministic:8971207012352779008:27:0) after 6m29s
[11:16:08.568] Handling timer "check-buildbucket-build-status" (chromium/Mac deterministic:8971207012352779008:27:0)
[11:16:08.595] Build status: SCHEDULED
[11:16:08.595] Scheduling timer "check-buildbucket-build-status" (chromium/Mac deterministic:8971207012352779008:28:0) after 4m57s
[11:21:05.612] Handling timer "check-buildbucket-build-status" (chromium/Mac deterministic:8971207012352779008:28:0)
[11:21:05.671] Build status: SCHEDULED
[11:21:05.671] Scheduling timer "check-buildbucket-build-status" (chromium/Mac deterministic:8971207012352779008:29:0) after 6m39s
[11:27:44.799] Handling timer "check-buildbucket-build-status" (chromium/Mac deterministic:8971207012352779008:29:0)
[11:27:44.836] Build status: SCHEDULED
[11:27:44.836] Scheduling timer "check-buildbucket-build-status" (chromium/Mac deterministic:8971207012352779008:30:0) after 5m9s
[11:32:53.972] Handling timer "check-buildbucket-build-status" (chromium/Mac deterministic:8971207012352779008:30:0)
[11:32:53.993] Build status: SCHEDULED
[11:32:53.993] Scheduling timer "check-buildbucket-build-status" (chromium/Mac deterministic:8971207012352779008:31:0) after 9m35s
[11:42:29.049] Handling timer "check-buildbucket-build-status" (chromium/Mac deterministic:8971207012352779008:31:0)
[11:42:29.069] Build status: SCHEDULED
[11:42:29.069] Scheduling timer "check-buildbucket-build-status" (chromium/Mac deterministic:8971207012352779008:32:0) after 6m13s
[11:48:42.068] Handling timer "check-buildbucket-build-status" (chromium/Mac deterministic:8971207012352779008:32:0)
[11:48:42.087] Build status: SCHEDULED
[11:48:42.087] Scheduling timer "check-buildbucket-build-status" (chromium/Mac deterministic:8971207012352779008:33:0) after 9m53s
[11:58:35.112] Handling timer "check-buildbucket-build-status" (chromium/Mac deterministic:8971207012352779008:33:0)
[11:58:35.133] Build status: SCHEDULED
[11:58:35.133] Scheduling timer "check-buildbucket-build-status" (chromium/Mac deterministic:8971207012352779008:34:0) after 6m55s
[12:05:30.154] Handling timer "check-buildbucket-build-status" (chromium/Mac deterministic:8971207012352779008:34:0)
[12:05:30.192] Build status: SCHEDULED
[12:05:30.193] Scheduling timer "check-buildbucket-build-status" (chromium/Mac deterministic:8971207012352779008:35:0) after 3m3s
[12:08:33.326] Handling timer "check-buildbucket-build-status" (chromium/Mac deterministic:8971207012352779008:35:0)
[12:08:33.359] Build status: SCHEDULED
[12:08:33.359] Scheduling timer "check-buildbucket-build-status" (chromium/Mac deterministic:8971207012352779008:36:0) after 3m41s
[12:12:14.374] Handling timer "check-buildbucket-build-status" (chromium/Mac deterministic:8971207012352779008:36:0)
[12:12:14.409] Build status: SCHEDULED
[12:12:14.409] Scheduling timer "check-buildbucket-build-status" (chromium/Mac deterministic:8971207012352779008:37:0) after 8m11s
[12:20:25.447] Handling timer "check-buildbucket-build-status" (chromium/Mac deterministic:8971207012352779008:37:0)
[12:20:25.483] Build status: SCHEDULED
[12:20:25.483] Scheduling timer "check-buildbucket-build-status" (chromium/Mac deterministic:8971207012352779008:38:0) after 2m29s
[12:22:54.509] Handling timer "check-buildbucket-build-status" (chromium/Mac deterministic:8971207012352779008:38:0)
[12:22:54.528] Build status: SCHEDULED
[12:22:54.528] Scheduling timer "check-buildbucket-build-status" (chromium/Mac deterministic:8971207012352779008:39:0) after 7m3s
[12:29:57.838] Handling timer "check-buildbucket-build-status" (chromium/Mac deterministic:8971207012352779008:39:0)
[12:29:57.910] Build status: SCHEDULED
[12:29:57.910] Scheduling timer "check-buildbucket-build-status" (chromium/Mac deterministic:8971207012352779008:40:0) after 6m24s
[12:36:21.979] Handling timer "check-buildbucket-build-status" (chromium/Mac deterministic:8971207012352779008:40:0)
[12:36:21.997] Build status: SCHEDULED
[12:36:21.997] Scheduling timer "check-buildbucket-build-status" (chromium/Mac deterministic:8971207012352779008:41:0) after 9m43s
[12:46:05.039] Handling timer "check-buildbucket-build-status" (chromium/Mac deterministic:8971207012352779008:41:0)
[12:46:05.082] Build status: SCHEDULED
[12:46:05.082] Scheduling timer "check-buildbucket-build-status" (chromium/Mac deterministic:8971207012352779008:42:0) after 6m7s
[12:52:12.191] Handling timer "check-buildbucket-build-status" (chromium/Mac deterministic:8971207012352779008:42:0)
[12:52:12.212] Build status: SCHEDULED
[12:52:12.212] Scheduling timer "check-buildbucket-build-status" (chromium/Mac deterministic:8971207012352779008:43:0) after 1m35s
[12:53:47.472] Handling timer "check-buildbucket-build-status" (chromium/Mac deterministic:8971207012352779008:43:0)
[12:53:47.503] Build status: SCHEDULED
[12:53:47.503] Scheduling timer "check-buildbucket-build-status" (chromium/Mac deterministic:8971207012352779008:44:0) after 8m26s
[13:02:13.633] Handling timer "check-buildbucket-build-status" (chromium/Mac deterministic:8971207012352779008:44:0)
[13:02:13.657] Build status: SCHEDULED
[13:02:13.657] Scheduling timer "check-buildbucket-build-status" (chromium/Mac deterministic:8971207012352779008:45:0) after 1m34s
[13:03:47.738] Handling timer "check-buildbucket-build-status" (chromium/Mac deterministic:8971207012352779008:45:0)
[13:03:47.772] Build status: SCHEDULED
[13:03:47.772] Scheduling timer "check-buildbucket-build-status" (chromium/Mac deterministic:8971207012352779008:46:0) after 3m21s
[13:07:09.124] Handling timer "check-buildbucket-build-status" (chromium/Mac deterministic:8971207012352779008:46:0)
[13:07:09.157] Build status: SCHEDULED
[13:07:09.157] Scheduling timer "check-buildbucket-build-status" (chromium/Mac deterministic:8971207012352779008:47:0) after 7m24s
[13:14:33.207] Handling timer "check-buildbucket-build-status" (chromium/Mac deterministic:8971207012352779008:47:0)
[13:14:33.236] Build status: SCHEDULED
[13:14:33.236] Scheduling timer "check-buildbucket-build-status" (chromium/Mac deterministic:8971207012352779008:48:0) after 3m29s
[13:18:02.263] Handling timer "check-buildbucket-build-status" (chromium/Mac deterministic:8971207012352779008:48:0)
[13:18:02.298] Build status: SCHEDULED
[13:18:02.298] Scheduling timer "check-buildbucket-build-status" (chromium/Mac deterministic:8971207012352779008:49:0) after 2m31s
[13:20:33.417] Handling timer "check-buildbucket-build-status" (chromium/Mac deterministic:8971207012352779008:49:0)
[13:20:33.445] Build status: SCHEDULED
[13:20:33.445] Scheduling timer "check-buildbucket-build-status" (chromium/Mac deterministic:8971207012352779008:50:0) after 6m24s
[13:26:57.484] Handling timer "check-buildbucket-build-status" (chromium/Mac deterministic:8971207012352779008:50:0)
[13:26:57.523] Build status: SCHEDULED
[13:26:57.523] Scheduling timer "check-buildbucket-build-status" (chromium/Mac deterministic:8971207012352779008:51:0) after 1m23s
[13:28:20.570] Handling timer "check-buildbucket-build-status" (chromium/Mac deterministic:8971207012352779008:51:0)
[13:28:20.590] Build status: SCHEDULED
[13:28:20.590] Scheduling timer "check-buildbucket-build-status" (chromium/Mac deterministic:8971207012352779008:52:0) after 3m21s
[13:31:41.657] Handling timer "check-buildbucket-build-status" (chromium/Mac deterministic:8971207012352779008:52:0)
[13:31:41.681] Build status: SCHEDULED
[13:31:41.681] Scheduling timer "check-buildbucket-build-status" (chromium/Mac deterministic:8971207012352779008:53:0) after 7m8s
[13:38:49.734] Handling timer "check-buildbucket-build-status" (chromium/Mac deterministic:8971207012352779008:53:0)
[13:38:49.756] Build status: SCHEDULED
[13:38:49.756] Scheduling timer "check-buildbucket-build-status" (chromium/Mac deterministic:8971207012352779008:54:0) after 4m11s
[13:43:00.786] Handling timer "check-buildbucket-build-status" (chromium/Mac deterministic:8971207012352779008:54:0)
[13:43:00.809] Build status: SCHEDULED
[13:43:00.809] Scheduling timer "check-buildbucket-build-status" (chromium/Mac deterministic:8971207012352779008:55:0) after 1m8s
[13:44:08.829] Handling timer "check-buildbucket-build-status" (chromium/Mac deterministic:8971207012352779008:55:0)
[13:44:08.851] Build status: SCHEDULED
[13:44:08.851] Scheduling timer "check-buildbucket-build-status" (chromium/Mac deterministic:8971207012352779008:56:0) after 9m37s
[13:53:45.869] Handling timer "check-buildbucket-build-status" (chromium/Mac deterministic:8971207012352779008:56:0)
[13:53:45.886] Build status: SCHEDULED
[13:53:45.886] Scheduling timer "check-buildbucket-build-status" (chromium/Mac deterministic:8971207012352779008:57:0) after 6m12s
[13:59:57.906] Handling timer "check-buildbucket-build-status" (chromium/Mac deterministic:8971207012352779008:57:0)
[13:59:57.930] Build status: SCHEDULED
[13:59:57.930] Scheduling timer "check-buildbucket-build-status" (chromium/Mac deterministic:8971207012352779008:58:0) after 5m38s
[14:05:35.949] Handling timer "check-buildbucket-build-status" (chromium/Mac deterministic:8971207012352779008:58:0)
[14:05:35.986] Build status: SCHEDULED
[14:05:35.986] Scheduling timer "check-buildbucket-build-status" (chromium/Mac deterministic:8971207012352779008:59:0) after 3m59s
[14:09:35.004] Handling timer "check-buildbucket-build-status" (chromium/Mac deterministic:8971207012352779008:59:0)
[14:09:35.043] Build status: SCHEDULED
[14:09:35.043] Scheduling timer "check-buildbucket-build-status" (chromium/Mac deterministic:8971207012352779008:60:0) after 6m52s
[14:16:27.192] Handling timer "check-buildbucket-build-status" (chromium/Mac deterministic:8971207012352779008:60:0)
[14:16:27.211] Build status: SCHEDULED
[14:16:27.211] Scheduling timer "check-buildbucket-build-status" (chromium/Mac deterministic:8971207012352779008:61:0) after 1m38s
[14:18:05.328] Handling timer "check-buildbucket-build-status" (chromium/Mac deterministic:8971207012352779008:61:0)
[14:18:05.354] Build status: SCHEDULED
[14:18:05.354] Scheduling timer "check-buildbucket-build-status" (chromium/Mac deterministic:8971207012352779008:62:0) after 9m42s
[14:27:47.502] Handling timer "check-buildbucket-build-status" (chromium/Mac deterministic:8971207012352779008:62:0)
[14:27:47.518] Build status: SCHEDULED
[14:27:47.518] Scheduling timer "check-buildbucket-build-status" (chromium/Mac deterministic:8971207012352779008:63:0) after 8m30s
[14:36:17.762] Handling timer "check-buildbucket-build-status" (chromium/Mac deterministic:8971207012352779008:63:0)
[14:36:17.791] Build status: SCHEDULED
[14:36:17.791] Scheduling timer "check-buildbucket-build-status" (chromium/Mac deterministic:8971207012352779008:64:0) after 1m8s
[14:37:25.887] Handling timer "check-buildbucket-build-status" (chromium/Mac deterministic:8971207012352779008:64:0)
[14:37:25.918] Build status: SCHEDULED
[14:37:25.918] Scheduling timer "check-buildbucket-build-status" (chromium/Mac deterministic:8971207012352779008:65:0) after 9m59s
[14:47:24.956] Handling timer "check-buildbucket-build-status" (chromium/Mac deterministic:8971207012352779008:65:0)
[14:47:25.001] Build status: SCHEDULED
[14:47:25.001] Scheduling timer "check-buildbucket-build-status" (chromium/Mac deterministic:8971207012352779008:66:0) after 1m57s
[14:49:22.021] Handling timer "check-buildbucket-build-status" (chromium/Mac deterministic:8971207012352779008:66:0)
[14:49:22.043] Build status: SCHEDULED
[14:49:22.043] Scheduling timer "check-buildbucket-build-status" (chromium/Mac deterministic:8971207012352779008:67:0) after 9m25s
[14:56:02.460] Received PubSub notification, asking Buildbucket for the build status
[14:56:02.478] Build:
{
"id": "8805776949045996449",
"builder": {
"project": "chromium",
"bucket": "ci",
"builder": "Mac deterministic"
},
"number": 57040,
"createdBy": "project:chromium",
"createTime": "2022-08-15T08:55:09.900398280Z",
"endTime": "2022-08-15T14:56:01.853413Z",
"updateTime": "2022-08-15T14:56:02.178534Z",
"status": "INFRA_FAILURE",
"statusDetails": {
"resourceExhaustion": {
},
"timeout": {
}
},
"input": {
"gitilesCommit": {
"host": "chromium.googlesource.com",
"project": "chromium/src",
"id": "c023163bed4cabe445f7d9b7a25c4b0e1226a33b",
"ref": "refs/heads/main"
}
}
}
[14:56:02.478] Invocation finished in 6h0m55.115303117s with status FAILED