[18:34:01.341] New invocation is queued and will start shortly
[18:34:03.186] Starting the invocation (attempt 1)
[18:34:03.230] Popped buildset tag "buildset:commit/gitiles/gnu.googlesource.com/binutils-gdb/+/2c3c88db125df810ff0209d4a1fbc49161b3d9cf"
[18:34:03.230] Popped gitiles commit info from properties and tags
[18:34:03.230] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[18:34:03.230] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[18:34:03.231] Buildbucket request:
{
"requestId": "8979958496915413088",
"builder": {
"project": "fuchsia",
"bucket": "prod",
"builder": "binutils-arm64-linux"
},
"properties": {
"$recipe_engine/scheduler": {
"hostname": "luci-scheduler.appspot.com",
"invocation": "8979958496915413088",
"job": "fuchsia/prod-binutils-arm64-linux-3c6e8ef4",
"triggers": [
{
"gitiles": {
"ref": "refs/heads/master",
"repo": "https://gnu.googlesource.com/binutils-gdb",
"revision": "b773a1808d5ae1786cd62a985093cf3f9537f2e2"
},
"id": "https://gnu.googlesource.com/binutils-gdb/+/refs/heads/master@b773a1808d5ae1786cd62a985093cf3f9537f2e2",
"title": "b773a1808d5ae1786cd62a985093cf3f9537f2e2",
"url": "https://gnu.googlesource.com/binutils-gdb/+/b773a1808d5ae1786cd62a985093cf3f9537f2e2"
},
{
"gitiles": {
"ref": "refs/heads/master",
"repo": "https://gnu.googlesource.com/binutils-gdb",
"revision": "62b33fde9c7ffd498af0236a50e200210807374a"
},
"id": "https://gnu.googlesource.com/binutils-gdb/+/refs/heads/master@62b33fde9c7ffd498af0236a50e200210807374a",
"title": "62b33fde9c7ffd498af0236a50e200210807374a",
"url": "https://gnu.googlesource.com/binutils-gdb/+/62b33fde9c7ffd498af0236a50e200210807374a"
},
{
"gitiles": {
"ref": "refs/heads/master",
"repo": "https://gnu.googlesource.com/binutils-gdb",
"revision": "6dc7160b2d598201653f74d65d4c4d34a0284f6c"
},
"id": "https://gnu.googlesource.com/binutils-gdb/+/refs/heads/master@6dc7160b2d598201653f74d65d4c4d34a0284f6c",
"title": "6dc7160b2d598201653f74d65d4c4d34a0284f6c",
"url": "https://gnu.googlesource.com/binutils-gdb/+/6dc7160b2d598201653f74d65d4c4d34a0284f6c"
},
{
"gitiles": {
"ref": "refs/heads/master",
"repo": "https://gnu.googlesource.com/binutils-gdb",
"revision": "cb2cd8cba82a0a5480a147d95b16098ad74d33c6"
},
"id": "https://gnu.googlesource.com/binutils-gdb/+/refs/heads/master@cb2cd8cba82a0a5480a147d95b16098ad74d33c6",
"title": "cb2cd8cba82a0a5480a147d95b16098ad74d33c6",
"url": "https://gnu.googlesource.com/binutils-gdb/+/cb2cd8cba82a0a5480a147d95b16098ad74d33c6"
},
{
"gitiles": {
"ref": "refs/heads/master",
"repo": "https://gnu.googlesource.com/binutils-gdb",
"revision": "1c6fbf42e5bd3045a41ad32c5efbc2ab8ca5e941"
},
"id": "https://gnu.googlesource.com/binutils-gdb/+/refs/heads/master@1c6fbf42e5bd3045a41ad32c5efbc2ab8ca5e941",
"title": "1c6fbf42e5bd3045a41ad32c5efbc2ab8ca5e941",
"url": "https://gnu.googlesource.com/binutils-gdb/+/1c6fbf42e5bd3045a41ad32c5efbc2ab8ca5e941"
},
{
"gitiles": {
"ref": "refs/heads/master",
"repo": "https://gnu.googlesource.com/binutils-gdb",
"revision": "c7d029ea9cc566b8d3c50b08ef12d98394adf1b1"
},
"id": "https://gnu.googlesource.com/binutils-gdb/+/refs/heads/master@c7d029ea9cc566b8d3c50b08ef12d98394adf1b1",
"title": "c7d029ea9cc566b8d3c50b08ef12d98394adf1b1",
"url": "https://gnu.googlesource.com/binutils-gdb/+/c7d029ea9cc566b8d3c50b08ef12d98394adf1b1"
},
{
"gitiles": {
"ref": "refs/heads/master",
"repo": "https://gnu.googlesource.com/binutils-gdb",
"revision": "20c4eb4226997c0de0a47d5d4c6c2eed21ed9af4"
},
"id": "https://gnu.googlesource.com/binutils-gdb/+/refs/heads/master@20c4eb4226997c0de0a47d5d4c6c2eed21ed9af4",
"title": "20c4eb4226997c0de0a47d5d4c6c2eed21ed9af4",
"url": "https://gnu.googlesource.com/binutils-gdb/+/20c4eb4226997c0de0a47d5d4c6c2eed21ed9af4"
},
{
"gitiles": {
"ref": "refs/heads/master",
"repo": "https://gnu.googlesource.com/binutils-gdb",
"revision": "2c3c88db125df810ff0209d4a1fbc49161b3d9cf"
},
"id": "https://gnu.googlesource.com/binutils-gdb/+/refs/heads/master@2c3c88db125df810ff0209d4a1fbc49161b3d9cf",
"title": "2c3c88db125df810ff0209d4a1fbc49161b3d9cf",
"url": "https://gnu.googlesource.com/binutils-gdb/+/2c3c88db125df810ff0209d4a1fbc49161b3d9cf"
}
]
}
},
"gitilesCommit": {
"host": "gnu.googlesource.com",
"project": "binutils-gdb",
"id": "2c3c88db125df810ff0209d4a1fbc49161b3d9cf",
"ref": "refs/heads/master"
},
"tags": [
{
"key": "scheduler_invocation_id",
"value": "8979958496915413088"
},
{
"key": "scheduler_job_id",
"value": "fuchsia/prod-binutils-arm64-linux-3c6e8ef4"
},
{
"key": "user_agent",
"value": "luci-scheduler"
}
],
"notify": {
"pubsubTopic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
}
}
[18:34:03.808] Scheduled build:
{
"id": "8814528434155852369",
"builder": {
"project": "fuchsia",
"bucket": "prod",
"builder": "binutils-arm64-linux"
},
"createdBy": "project:fuchsia",
"createTime": "2022-05-10T18:34:03.320964366Z",
"updateTime": "2022-05-10T18:34:03.320964366Z",
"status": "SCHEDULED",
"input": {
"gitilesCommit": {
"host": "gnu.googlesource.com",
"project": "binutils-gdb",
"id": "2c3c88db125df810ff0209d4a1fbc49161b3d9cf",
"ref": "refs/heads/master"
}
}
}
[18:34:03.808] Task URL: https://cr-buildbucket.appspot.com/build/8814528434155852369
[18:34:03.809] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-binutils-arm64-linux-3c6e8ef4:8979958496915413088:2:0) after 1m12s
[18:35:15.808] Handling timer "check-buildbucket-build-status" (fuchsia/prod-binutils-arm64-linux-3c6e8ef4:8979958496915413088:2:0)
[18:35:15.839] Build status: SCHEDULED
[18:35:15.839] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-binutils-arm64-linux-3c6e8ef4:8979958496915413088:3:0) after 6m35s
[18:41:50.879] Handling timer "check-buildbucket-build-status" (fuchsia/prod-binutils-arm64-linux-3c6e8ef4:8979958496915413088:3:0)
[18:41:50.958] Build status: SCHEDULED
[18:41:50.958] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-binutils-arm64-linux-3c6e8ef4:8979958496915413088:4:0) after 9m14s
[18:51:05.055] Handling timer "check-buildbucket-build-status" (fuchsia/prod-binutils-arm64-linux-3c6e8ef4:8979958496915413088:4:0)
[18:51:05.092] Build status: SCHEDULED
[18:51:05.092] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-binutils-arm64-linux-3c6e8ef4:8979958496915413088:5:0) after 9m2s
[19:00:07.117] Handling timer "check-buildbucket-build-status" (fuchsia/prod-binutils-arm64-linux-3c6e8ef4:8979958496915413088:5:0)
[19:00:07.223] Build status: SCHEDULED
[19:00:07.223] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-binutils-arm64-linux-3c6e8ef4:8979958496915413088:6:0) after 3m12s
[19:03:19.238] Handling timer "check-buildbucket-build-status" (fuchsia/prod-binutils-arm64-linux-3c6e8ef4:8979958496915413088:6:0)
[19:03:19.302] Build status: SCHEDULED
[19:03:19.302] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-binutils-arm64-linux-3c6e8ef4:8979958496915413088:7:0) after 1m55s
[19:05:14.320] Handling timer "check-buildbucket-build-status" (fuchsia/prod-binutils-arm64-linux-3c6e8ef4:8979958496915413088:7:0)
[19:05:14.355] Build status: SCHEDULED
[19:05:14.355] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-binutils-arm64-linux-3c6e8ef4:8979958496915413088:8:0) after 4m16s
[19:09:30.375] Handling timer "check-buildbucket-build-status" (fuchsia/prod-binutils-arm64-linux-3c6e8ef4:8979958496915413088:8:0)
[19:09:30.433] Build status: SCHEDULED
[19:09:30.433] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-binutils-arm64-linux-3c6e8ef4:8979958496915413088:9:0) after 1m22s
[19:10:52.573] Handling timer "check-buildbucket-build-status" (fuchsia/prod-binutils-arm64-linux-3c6e8ef4:8979958496915413088:9:0)
[19:10:52.599] Build status: SCHEDULED
[19:10:52.599] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-binutils-arm64-linux-3c6e8ef4:8979958496915413088:10:0) after 1m42s
[19:12:34.632] Handling timer "check-buildbucket-build-status" (fuchsia/prod-binutils-arm64-linux-3c6e8ef4:8979958496915413088:10:0)
[19:12:34.663] Build status: SCHEDULED
[19:12:34.663] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-binutils-arm64-linux-3c6e8ef4:8979958496915413088:11:0) after 8m37s
[19:21:12.125] Handling timer "check-buildbucket-build-status" (fuchsia/prod-binutils-arm64-linux-3c6e8ef4:8979958496915413088:11:0)
[19:21:12.204] Build status: SCHEDULED
[19:21:12.204] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-binutils-arm64-linux-3c6e8ef4:8979958496915413088:12:0) after 8m58s
[19:29:18.905] Received PubSub notification, asking Buildbucket for the build status
[19:29:18.964] Build status: STARTED
[19:30:10.222] Handling timer "check-buildbucket-build-status" (fuchsia/prod-binutils-arm64-linux-3c6e8ef4:8979958496915413088:12:0)
[19:30:10.272] Build status: STARTED
[19:30:10.272] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-binutils-arm64-linux-3c6e8ef4:8979958496915413088:14:0) after 3m53s
[19:34:03.291] Handling timer "check-buildbucket-build-status" (fuchsia/prod-binutils-arm64-linux-3c6e8ef4:8979958496915413088:14:0)
[19:34:03.331] Build status: STARTED
[19:34:03.331] Scheduling timer "check-buildbucket-build-status" (fuchsia/prod-binutils-arm64-linux-3c6e8ef4:8979958496915413088:15:0) after 6m26s
[19:35:34.096] Received PubSub notification, asking Buildbucket for the build status
[19:35:34.148] Build:
{
"id": "8814528434155852369",
"builder": {
"project": "fuchsia",
"bucket": "prod",
"builder": "binutils-arm64-linux"
},
"createdBy": "project:fuchsia",
"createTime": "2022-05-10T18:34:03.320964366Z",
"startTime": "2022-05-10T19:29:15.863937Z",
"endTime": "2022-05-10T19:35:33.710517793Z",
"updateTime": "2022-05-10T19:35:33.710517793Z",
"status": "FAILURE",
"input": {
"gitilesCommit": {
"host": "gnu.googlesource.com",
"project": "binutils-gdb",
"id": "2c3c88db125df810ff0209d4a1fbc49161b3d9cf",
"ref": "refs/heads/master"
}
}
}
[19:35:34.148] Invocation finished in 1h1m32.84229859s with status FAILED