[18:34:01.718] New invocation is queued and will start shortly
[18:34:03.781] Starting the invocation (attempt 1)
[18:34:03.816] Popped buildset tag "buildset:commit/gitiles/gnu.googlesource.com/binutils-gdb/+/44d469c5f85a4243462b8966722dafa62b602bf5"
[18:34:03.816] Popped gitiles commit info from properties and tags
[18:34:03.816] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[18:34:03.816] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[18:34:03.816] Buildbucket request:
{
"requestId": "8978055960203303744",
"builder": {
"project": "fuchsia",
"bucket": "toolchain.ci",
"builder": "gcc-arm64-linux"
},
"properties": {
"$recipe_engine/scheduler": {
"hostname": "luci-scheduler.appspot.com",
"invocation": "8978055960203303744",
"job": "fuchsia/toolchain.ci-gcc-arm64-linux-3e002780",
"triggers": [
{
"gitiles": {
"ref": "refs/heads/master",
"repo": "https://gnu.googlesource.com/binutils-gdb",
"revision": "2918df9368abdedffe2e2be1c93c760d85d545ab"
},
"id": "https://gnu.googlesource.com/binutils-gdb/+/refs/heads/master@2918df9368abdedffe2e2be1c93c760d85d545ab",
"title": "2918df9368abdedffe2e2be1c93c760d85d545ab",
"url": "https://gnu.googlesource.com/binutils-gdb/+/2918df9368abdedffe2e2be1c93c760d85d545ab"
},
{
"gitiles": {
"ref": "refs/heads/master",
"repo": "https://gnu.googlesource.com/binutils-gdb",
"revision": "74a04e5b2a496b18bad615fc19a621c0ff1452df"
},
"id": "https://gnu.googlesource.com/binutils-gdb/+/refs/heads/master@74a04e5b2a496b18bad615fc19a621c0ff1452df",
"title": "74a04e5b2a496b18bad615fc19a621c0ff1452df",
"url": "https://gnu.googlesource.com/binutils-gdb/+/74a04e5b2a496b18bad615fc19a621c0ff1452df"
},
{
"gitiles": {
"ref": "refs/heads/master",
"repo": "https://gnu.googlesource.com/binutils-gdb",
"revision": "e953510c3bfda9a39f1da76e00ab810917e32b78"
},
"id": "https://gnu.googlesource.com/binutils-gdb/+/refs/heads/master@e953510c3bfda9a39f1da76e00ab810917e32b78",
"title": "e953510c3bfda9a39f1da76e00ab810917e32b78",
"url": "https://gnu.googlesource.com/binutils-gdb/+/e953510c3bfda9a39f1da76e00ab810917e32b78"
},
{
"gitiles": {
"ref": "refs/heads/master",
"repo": "https://gnu.googlesource.com/binutils-gdb",
"revision": "30596893ab5c82081bfdf81cebe0b973f4e7c516"
},
"id": "https://gnu.googlesource.com/binutils-gdb/+/refs/heads/master@30596893ab5c82081bfdf81cebe0b973f4e7c516",
"title": "30596893ab5c82081bfdf81cebe0b973f4e7c516",
"url": "https://gnu.googlesource.com/binutils-gdb/+/30596893ab5c82081bfdf81cebe0b973f4e7c516"
},
{
"gitiles": {
"ref": "refs/heads/master",
"repo": "https://gnu.googlesource.com/binutils-gdb",
"revision": "44d469c5f85a4243462b8966722dafa62b602bf5"
},
"id": "https://gnu.googlesource.com/binutils-gdb/+/refs/heads/master@44d469c5f85a4243462b8966722dafa62b602bf5",
"title": "44d469c5f85a4243462b8966722dafa62b602bf5",
"url": "https://gnu.googlesource.com/binutils-gdb/+/44d469c5f85a4243462b8966722dafa62b602bf5"
}
]
}
},
"gitilesCommit": {
"host": "gnu.googlesource.com",
"project": "binutils-gdb",
"id": "44d469c5f85a4243462b8966722dafa62b602bf5",
"ref": "refs/heads/master"
},
"tags": [
{
"key": "scheduler_invocation_id",
"value": "8978055960203303744"
},
{
"key": "scheduler_job_id",
"value": "fuchsia/toolchain.ci-gcc-arm64-linux-3e002780"
},
{
"key": "user_agent",
"value": "luci-scheduler"
}
],
"notify": {
"pubsubTopic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
}
}
[18:34:04.232] Scheduled build:
{
"id": "8812625897259994369",
"builder": {
"project": "fuchsia",
"bucket": "toolchain.ci",
"builder": "gcc-arm64-linux"
},
"createdBy": "project:fuchsia",
"createTime": "2022-05-31T18:34:03.894101842Z",
"updateTime": "2022-05-31T18:34:03.894101842Z",
"status": "SCHEDULED",
"input": {
"gitilesCommit": {
"host": "gnu.googlesource.com",
"project": "binutils-gdb",
"id": "44d469c5f85a4243462b8966722dafa62b602bf5",
"ref": "refs/heads/master"
}
}
}
[18:34:04.232] Task URL: https://cr-buildbucket.appspot.com/build/8812625897259994369
[18:34:04.232] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-gcc-arm64-linux-3e002780:8978055960203303744:2:0) after 5m56s
[18:40:00.252] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-gcc-arm64-linux-3e002780:8978055960203303744:2:0)
[18:40:00.338] Build status: SCHEDULED
[18:40:00.338] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-gcc-arm64-linux-3e002780:8978055960203303744:3:0) after 7m33s
[18:47:33.711] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-gcc-arm64-linux-3e002780:8978055960203303744:3:0)
[18:47:33.738] Build status: SCHEDULED
[18:47:33.738] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-gcc-arm64-linux-3e002780:8978055960203303744:4:0) after 1m46s
[18:49:19.743] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-gcc-arm64-linux-3e002780:8978055960203303744:4:0)
[18:49:19.774] Build status: SCHEDULED
[18:49:19.774] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-gcc-arm64-linux-3e002780:8978055960203303744:5:0) after 5m59s
[18:55:18.789] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-gcc-arm64-linux-3e002780:8978055960203303744:5:0)
[18:55:18.819] Build status: SCHEDULED
[18:55:18.819] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-gcc-arm64-linux-3e002780:8978055960203303744:6:0) after 6m57s
[19:02:15.837] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-gcc-arm64-linux-3e002780:8978055960203303744:6:0)
[19:02:15.862] Build status: SCHEDULED
[19:02:15.862] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-gcc-arm64-linux-3e002780:8978055960203303744:7:0) after 4m58s
[19:07:14.385] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-gcc-arm64-linux-3e002780:8978055960203303744:7:0)
[19:07:14.407] Build status: SCHEDULED
[19:07:14.407] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-gcc-arm64-linux-3e002780:8978055960203303744:8:0) after 1m32s
[19:08:46.422] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-gcc-arm64-linux-3e002780:8978055960203303744:8:0)
[19:08:46.456] Build status: SCHEDULED
[19:08:46.456] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-gcc-arm64-linux-3e002780:8978055960203303744:9:0) after 5m15s
[19:14:01.473] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-gcc-arm64-linux-3e002780:8978055960203303744:9:0)
[19:14:01.513] Build status: SCHEDULED
[19:14:01.513] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-gcc-arm64-linux-3e002780:8978055960203303744:10:0) after 2m12s
[19:16:13.746] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-gcc-arm64-linux-3e002780:8978055960203303744:10:0)
[19:16:13.780] Build status: SCHEDULED
[19:16:13.780] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-gcc-arm64-linux-3e002780:8978055960203303744:11:0) after 3m32s
[19:19:45.800] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-gcc-arm64-linux-3e002780:8978055960203303744:11:0)
[19:19:45.845] Build status: SCHEDULED
[19:19:45.845] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-gcc-arm64-linux-3e002780:8978055960203303744:12:0) after 9m14s
[19:29:00.133] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-gcc-arm64-linux-3e002780:8978055960203303744:12:0)
[19:29:00.162] Build status: SCHEDULED
[19:29:00.162] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-gcc-arm64-linux-3e002780:8978055960203303744:13:0) after 2m43s
[19:29:49.178] Received PubSub notification, asking Buildbucket for the build status
[19:29:49.221] Build status: STARTED
[19:31:43.182] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-gcc-arm64-linux-3e002780:8978055960203303744:13:0)
[19:31:43.220] Build status: STARTED
[19:31:43.220] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-gcc-arm64-linux-3e002780:8978055960203303744:15:0) after 5m51s
[19:37:34.238] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-gcc-arm64-linux-3e002780:8978055960203303744:15:0)
[19:37:34.267] Build status: STARTED
[19:37:34.268] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-gcc-arm64-linux-3e002780:8978055960203303744:16:0) after 1m26s
[19:39:00.413] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-gcc-arm64-linux-3e002780:8978055960203303744:16:0)
[19:39:00.440] Build status: STARTED
[19:39:00.440] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-gcc-arm64-linux-3e002780:8978055960203303744:17:0) after 6m38s
[19:45:38.708] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-gcc-arm64-linux-3e002780:8978055960203303744:17:0)
[19:45:38.752] Build status: STARTED
[19:45:38.752] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-gcc-arm64-linux-3e002780:8978055960203303744:18:0) after 3m50s
[19:49:28.932] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-gcc-arm64-linux-3e002780:8978055960203303744:18:0)
[19:49:28.963] Build status: STARTED
[19:49:28.963] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-gcc-arm64-linux-3e002780:8978055960203303744:19:0) after 7m14s
[19:56:43.173] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-gcc-arm64-linux-3e002780:8978055960203303744:19:0)
[19:56:43.214] Build status: STARTED
[19:56:43.214] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-gcc-arm64-linux-3e002780:8978055960203303744:20:0) after 3m23s
[20:00:06.621] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-gcc-arm64-linux-3e002780:8978055960203303744:20:0)
[20:00:06.651] Build status: STARTED
[20:00:06.651] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-gcc-arm64-linux-3e002780:8978055960203303744:21:0) after 6m27s
[20:06:33.674] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-gcc-arm64-linux-3e002780:8978055960203303744:21:0)
[20:06:33.707] Build status: STARTED
[20:06:33.707] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-gcc-arm64-linux-3e002780:8978055960203303744:22:0) after 9m45s
[20:16:18.746] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-gcc-arm64-linux-3e002780:8978055960203303744:22:0)
[20:16:18.852] Build status: STARTED
[20:16:18.852] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-gcc-arm64-linux-3e002780:8978055960203303744:23:0) after 9m34s
[20:25:53.019] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-gcc-arm64-linux-3e002780:8978055960203303744:23:0)
[20:25:53.057] Build status: STARTED
[20:25:53.057] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-gcc-arm64-linux-3e002780:8978055960203303744:24:0) after 7m38s
[20:33:31.079] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-gcc-arm64-linux-3e002780:8978055960203303744:24:0)
[20:33:31.114] Build status: STARTED
[20:33:31.114] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-gcc-arm64-linux-3e002780:8978055960203303744:25:0) after 1m37s
[20:35:08.306] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-gcc-arm64-linux-3e002780:8978055960203303744:25:0)
[20:35:08.337] Build status: STARTED
[20:35:08.337] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-gcc-arm64-linux-3e002780:8978055960203303744:26:0) after 3m53s
[20:39:01.361] Handling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-gcc-arm64-linux-3e002780:8978055960203303744:26:0)
[20:39:01.443] Build status: STARTED
[20:39:01.443] Scheduling timer "check-buildbucket-build-status" (fuchsia/toolchain.ci-gcc-arm64-linux-3e002780:8978055960203303744:27:0) after 7m18s
[20:45:24.751] Received PubSub notification, asking Buildbucket for the build status
[20:45:24.881] Build:
{
"id": "8812625897259994369",
"builder": {
"project": "fuchsia",
"bucket": "toolchain.ci",
"builder": "gcc-arm64-linux"
},
"createdBy": "project:fuchsia",
"createTime": "2022-05-31T18:34:03.894101842Z",
"startTime": "2022-05-31T19:29:31.664037Z",
"endTime": "2022-05-31T20:45:24.329676191Z",
"updateTime": "2022-05-31T20:45:24.329676191Z",
"status": "SUCCESS",
"input": {
"gitilesCommit": {
"host": "gnu.googlesource.com",
"project": "binutils-gdb",
"id": "44d469c5f85a4243462b8966722dafa62b602bf5",
"ref": "refs/heads/master"
}
}
}
[20:45:24.881] Invocation finished in 2h11m23.177578953s with status SUCCEEDED