[01:29:33.323] New invocation is queued and will start shortly
[01:29:34.633] Starting the invocation (attempt 1)
[01:29:34.665] Popped buildset tag "buildset:commit/gitiles/chromium.googlesource.com/chromium/src/+/ef0c43d6c72ccba6dd9721c5c54b07500298239c"
[01:29:34.665] Popped gitiles commit info from properties and tags
[01:29:34.665] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[01:29:34.665] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[01:29:34.665] Buildbucket request:
{
"requestId": "8905008662595316192",
"builder": {
"project": "chromium",
"bucket": "ci",
"builder": "ToTWinArm64PGO"
},
"properties": {
},
"gitilesCommit": {
"host": "chromium.googlesource.com",
"project": "chromium/src",
"id": "ef0c43d6c72ccba6dd9721c5c54b07500298239c",
"ref": "refs/heads/main"
},
"tags": [
{
"key": "scheduler_invocation_id",
"value": "8905008662595316192"
},
{
"key": "scheduler_job_id",
"value": "chromium/ToTWinArm64PGO"
},
{
"key": "user_agent",
"value": "luci-scheduler"
}
],
"notify": {
"pubsubTopic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
}
}
[01:29:35.269] Scheduled build:
{
"id": "8739578600445790209",
"builder": {
"project": "chromium",
"bucket": "ci",
"builder": "ToTWinArm64PGO"
},
"number": 3648,
"createdBy": "project:chromium",
"createTime": "2024-08-15T01:29:34.749627412Z",
"updateTime": "2024-08-15T01:29:34.749627412Z",
"status": "SCHEDULED",
"input": {
"gitilesCommit": {
"host": "chromium.googlesource.com",
"project": "chromium/src",
"id": "ef0c43d6c72ccba6dd9721c5c54b07500298239c",
"ref": "refs/heads/main"
}
}
}
[01:29:35.269] Task URL: https://cr-buildbucket.appspot.com/build/8739578600445790209
[01:29:35.269] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWinArm64PGO:8905008662595316192:2:0) after 4m6s
[01:29:36.228] Received PubSub notification, asking Buildbucket for the build status
[01:29:36.249] Build status: SCHEDULED
[01:33:41.324] Handling timer "check-buildbucket-build-status" (chromium/ToTWinArm64PGO:8905008662595316192:2:0)
[01:33:41.350] Build status: SCHEDULED
[01:33:41.350] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWinArm64PGO:8905008662595316192:4:0) after 8m12s
[01:41:53.476] Handling timer "check-buildbucket-build-status" (chromium/ToTWinArm64PGO:8905008662595316192:4:0)
[01:41:53.503] Build status: SCHEDULED
[01:41:53.503] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWinArm64PGO:8905008662595316192:5:0) after 3m10s
[01:45:03.523] Handling timer "check-buildbucket-build-status" (chromium/ToTWinArm64PGO:8905008662595316192:5:0)
[01:45:03.547] Build status: SCHEDULED
[01:45:03.547] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWinArm64PGO:8905008662595316192:6:0) after 4m34s
[01:49:37.612] Handling timer "check-buildbucket-build-status" (chromium/ToTWinArm64PGO:8905008662595316192:6:0)
[01:49:37.639] Build status: SCHEDULED
[01:49:37.639] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWinArm64PGO:8905008662595316192:7:0) after 7m35s
[01:51:42.156] Received PubSub notification, asking Buildbucket for the build status
[01:51:42.172] Build status: STARTED
[01:57:12.691] Handling timer "check-buildbucket-build-status" (chromium/ToTWinArm64PGO:8905008662595316192:7:0)
[01:57:12.708] Build status: STARTED
[01:57:12.708] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWinArm64PGO:8905008662595316192:9:0) after 7m31s
[02:04:43.826] Handling timer "check-buildbucket-build-status" (chromium/ToTWinArm64PGO:8905008662595316192:9:0)
[02:04:43.850] Build status: STARTED
[02:04:43.850] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWinArm64PGO:8905008662595316192:10:0) after 4m11s
[02:08:54.871] Handling timer "check-buildbucket-build-status" (chromium/ToTWinArm64PGO:8905008662595316192:10:0)
[02:08:54.887] Build status: STARTED
[02:08:54.887] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWinArm64PGO:8905008662595316192:11:0) after 1m48s
[02:10:42.909] Handling timer "check-buildbucket-build-status" (chromium/ToTWinArm64PGO:8905008662595316192:11:0)
[02:10:42.976] Build status: STARTED
[02:10:42.976] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWinArm64PGO:8905008662595316192:12:0) after 5m36s
[02:16:18.951] Handling timer "check-buildbucket-build-status" (chromium/ToTWinArm64PGO:8905008662595316192:12:0)
[02:16:19.055] Build status: STARTED
[02:16:19.055] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWinArm64PGO:8905008662595316192:13:0) after 8m52s
[02:25:11.078] Handling timer "check-buildbucket-build-status" (chromium/ToTWinArm64PGO:8905008662595316192:13:0)
[02:25:11.129] Build status: STARTED
[02:25:11.129] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWinArm64PGO:8905008662595316192:14:0) after 3m57s
[02:29:08.689] Handling timer "check-buildbucket-build-status" (chromium/ToTWinArm64PGO:8905008662595316192:14:0)
[02:29:08.708] Build status: STARTED
[02:29:08.708] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWinArm64PGO:8905008662595316192:15:0) after 3m42s
[02:32:50.843] Handling timer "check-buildbucket-build-status" (chromium/ToTWinArm64PGO:8905008662595316192:15:0)
[02:32:50.866] Build status: STARTED
[02:32:50.866] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWinArm64PGO:8905008662595316192:16:0) after 1m45s
[02:34:35.907] Handling timer "check-buildbucket-build-status" (chromium/ToTWinArm64PGO:8905008662595316192:16:0)
[02:34:35.925] Build status: STARTED
[02:34:35.926] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWinArm64PGO:8905008662595316192:17:0) after 7m26s
[02:42:02.150] Handling timer "check-buildbucket-build-status" (chromium/ToTWinArm64PGO:8905008662595316192:17:0)
[02:42:02.169] Build status: STARTED
[02:42:02.169] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWinArm64PGO:8905008662595316192:18:0) after 3m36s
[02:45:38.290] Handling timer "check-buildbucket-build-status" (chromium/ToTWinArm64PGO:8905008662595316192:18:0)
[02:45:38.313] Build status: STARTED
[02:45:38.313] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWinArm64PGO:8905008662595316192:19:0) after 4m55s
[02:50:33.405] Handling timer "check-buildbucket-build-status" (chromium/ToTWinArm64PGO:8905008662595316192:19:0)
[02:50:33.422] Build status: STARTED
[02:50:33.422] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWinArm64PGO:8905008662595316192:20:0) after 4m51s
[02:55:24.808] Handling timer "check-buildbucket-build-status" (chromium/ToTWinArm64PGO:8905008662595316192:20:0)
[02:55:24.830] Build status: STARTED
[02:55:24.830] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWinArm64PGO:8905008662595316192:21:0) after 7m20s
[03:02:45.374] Handling timer "check-buildbucket-build-status" (chromium/ToTWinArm64PGO:8905008662595316192:21:0)
[03:02:45.394] Build status: STARTED
[03:02:45.394] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWinArm64PGO:8905008662595316192:22:0) after 2m53s
[03:05:38.475] Handling timer "check-buildbucket-build-status" (chromium/ToTWinArm64PGO:8905008662595316192:22:0)
[03:05:38.497] Build status: STARTED
[03:05:38.498] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWinArm64PGO:8905008662595316192:23:0) after 7m26s
[03:13:04.523] Handling timer "check-buildbucket-build-status" (chromium/ToTWinArm64PGO:8905008662595316192:23:0)
[03:13:04.552] Build status: STARTED
[03:13:04.552] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWinArm64PGO:8905008662595316192:24:0) after 1m56s
[03:15:00.570] Handling timer "check-buildbucket-build-status" (chromium/ToTWinArm64PGO:8905008662595316192:24:0)
[03:15:00.590] Build status: STARTED
[03:15:00.590] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWinArm64PGO:8905008662595316192:25:0) after 7m7s
[03:22:08.141] Handling timer "check-buildbucket-build-status" (chromium/ToTWinArm64PGO:8905008662595316192:25:0)
[03:22:08.157] Build status: STARTED
[03:22:08.157] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWinArm64PGO:8905008662595316192:26:0) after 3m18s
[03:25:26.174] Handling timer "check-buildbucket-build-status" (chromium/ToTWinArm64PGO:8905008662595316192:26:0)
[03:25:26.194] Build status: STARTED
[03:25:26.194] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWinArm64PGO:8905008662595316192:27:0) after 6m35s
[03:32:01.562] Handling timer "check-buildbucket-build-status" (chromium/ToTWinArm64PGO:8905008662595316192:27:0)
[03:32:01.580] Build status: STARTED
[03:32:01.580] Scheduling timer "check-buildbucket-build-status" (chromium/ToTWinArm64PGO:8905008662595316192:28:0) after 7m18s
[03:35:17.191] Received PubSub notification, asking Buildbucket for the build status
[03:35:17.214] Build:
{
"id": "8739578600445790209",
"builder": {
"project": "chromium",
"bucket": "ci",
"builder": "ToTWinArm64PGO"
},
"number": 3648,
"createdBy": "project:chromium",
"createTime": "2024-08-15T01:29:34.749627412Z",
"startTime": "2024-08-15T01:51:41.905356155Z",
"endTime": "2024-08-15T03:35:16.805855887Z",
"updateTime": "2024-08-15T03:35:16.805855887Z",
"status": "FAILURE",
"input": {
"gitilesCommit": {
"host": "chromium.googlesource.com",
"project": "chromium/src",
"id": "ef0c43d6c72ccba6dd9721c5c54b07500298239c",
"ref": "refs/heads/main"
}
}
}
[03:35:17.214] Invocation finished in 2h5m43.899451362s with status FAILED