buildbucket: < server: "cr-buildbucket-dev.appspot.com" bucket: "ci" builder: "build-proto-linux" >
[03:20:06.045] New invocation is queued and will start shortly
[03:20:07.111] Starting the invocation (attempt 1)
[03:20:07.137] Ignoring gitiles_ref tag without the buildset tag
[03:20:07.137] Preparing PubSub topic for "https://cr-buildbucket-dev.appspot.com"
[03:20:11.638] Failed to prepare PubSub topic - auth: HTTP code (500) when fetching https://cr-buildbucket-dev.appspot.com/auth/api/v1/server/info
[03:20:11.638] The invocation will be retried
[03:20:16.703] Starting the invocation (attempt 2)
[03:20:16.728] Ignoring gitiles_ref tag without the buildset tag
[03:20:16.728] Preparing PubSub topic for "https://cr-buildbucket-dev.appspot.com"
[03:20:21.373] Failed to prepare PubSub topic - auth: HTTP code (500) when fetching https://cr-buildbucket-dev.appspot.com/auth/api/v1/server/info
[03:20:21.373] The invocation will be retried
[03:20:31.431] Starting the invocation (attempt 3)
[03:20:31.458] Ignoring gitiles_ref tag without the buildset tag
[03:20:31.458] Preparing PubSub topic for "https://cr-buildbucket-dev.appspot.com"
[03:20:35.953] Failed to prepare PubSub topic - auth: HTTP code (500) when fetching https://cr-buildbucket-dev.appspot.com/auth/api/v1/server/info
[03:20:35.953] The invocation will be retried
[03:20:56.117] Starting the invocation (attempt 4)
[03:20:56.146] Ignoring gitiles_ref tag without the buildset tag
[03:20:56.146] Preparing PubSub topic for "https://cr-buildbucket-dev.appspot.com"
[03:21:05.094] Failed to prepare PubSub topic - auth: HTTP code (500) when fetching https://cr-buildbucket-dev.appspot.com/auth/api/v1/server/info
[03:21:05.094] The invocation will be retried
[03:21:45.164] Starting the invocation (attempt 5)
[03:21:45.194] Ignoring gitiles_ref tag without the buildset tag
[03:21:45.194] Preparing PubSub topic for "https://cr-buildbucket-dev.appspot.com"
[03:21:50.031] Failed to prepare PubSub topic - auth: HTTP code (500) when fetching https://cr-buildbucket-dev.appspot.com/auth/api/v1/server/info
[03:21:50.031] The invocation will be retried
[03:23:10.104] Starting the invocation (attempt 6)
[03:23:10.133] Ignoring gitiles_ref tag without the buildset tag
[03:23:10.133] Preparing PubSub topic for "https://cr-buildbucket-dev.appspot.com"
[03:23:14.742] Failed to prepare PubSub topic - auth: HTTP code (500) when fetching https://cr-buildbucket-dev.appspot.com/auth/api/v1/server/info
[03:23:14.742] The invocation will be retried
[03:25:54.818] Starting the invocation (attempt 7)
[03:25:54.847] Ignoring gitiles_ref tag without the buildset tag
[03:25:54.847] Preparing PubSub topic for "https://cr-buildbucket-dev.appspot.com"
[03:26:02.752] Failed to prepare PubSub topic - auth: HTTP code (500) when fetching https://cr-buildbucket-dev.appspot.com/auth/api/v1/server/info
[03:26:02.752] The invocation will be retried
[03:31:22.807] Starting the invocation (attempt 8)
[03:31:22.831] Ignoring gitiles_ref tag without the buildset tag
[03:31:22.832] Preparing PubSub topic for "https://cr-buildbucket-dev.appspot.com"
[03:31:28.216] Failed to prepare PubSub topic - auth: HTTP code (500) when fetching https://cr-buildbucket-dev.appspot.com/auth/api/v1/server/info
[03:31:28.216] The invocation will be retried
[03:41:28.336] Starting the invocation (attempt 9)
[03:41:28.369] Ignoring gitiles_ref tag without the buildset tag
[03:41:28.369] Preparing PubSub topic for "https://cr-buildbucket-dev.appspot.com"
[03:41:34.072] Failed to prepare PubSub topic - auth: HTTP code (500) when fetching https://cr-buildbucket-dev.appspot.com/auth/api/v1/server/info
[03:41:34.072] The invocation will be retried
[03:51:34.141] Starting the invocation (attempt 10)
[03:51:34.168] Ignoring gitiles_ref tag without the buildset tag
[03:51:34.168] Preparing PubSub topic for "https://cr-buildbucket-dev.appspot.com"
[03:51:37.826] Failed to prepare PubSub topic - auth: HTTP code (500) when fetching https://cr-buildbucket-dev.appspot.com/auth/api/v1/server/info
[03:51:37.826] The invocation will be retried
[04:01:37.881] Starting the invocation (attempt 11)
[04:01:37.910] Ignoring gitiles_ref tag without the buildset tag
[04:01:37.910] Preparing PubSub topic for "https://cr-buildbucket-dev.appspot.com"
[04:01:43.883] Failed to prepare PubSub topic - auth: HTTP code (500) when fetching https://cr-buildbucket-dev.appspot.com/auth/api/v1/server/info
[04:01:43.884] The invocation will be retried
[04:11:43.942] Starting the invocation (attempt 12)
[04:11:43.971] Ignoring gitiles_ref tag without the buildset tag
[04:11:43.971] Preparing PubSub topic for "https://cr-buildbucket-dev.appspot.com"
[04:11:48.389] Failed to prepare PubSub topic - auth: HTTP code (500) when fetching https://cr-buildbucket-dev.appspot.com/auth/api/v1/server/info
[04:11:48.389] The invocation will be retried
[04:21:48.450] Starting the invocation (attempt 13)
[04:21:48.475] Ignoring gitiles_ref tag without the buildset tag
[04:21:48.475] Preparing PubSub topic for "https://cr-buildbucket-dev.appspot.com"
[04:21:53.650] Failed to prepare PubSub topic - auth: HTTP code (500) when fetching https://cr-buildbucket-dev.appspot.com/auth/api/v1/server/info
[04:21:53.650] The invocation will be retried
[04:31:54.174] Starting the invocation (attempt 14)
[04:31:54.214] Ignoring gitiles_ref tag without the buildset tag
[04:31:54.214] Preparing PubSub topic for "https://cr-buildbucket-dev.appspot.com"
[04:31:58.742] Failed to prepare PubSub topic - auth: HTTP code (500) when fetching https://cr-buildbucket-dev.appspot.com/auth/api/v1/server/info
[04:31:58.742] The invocation will be retried
[04:41:58.806] Starting the invocation (attempt 15)
[04:41:58.836] Ignoring gitiles_ref tag without the buildset tag
[04:41:58.836] Preparing PubSub topic for "https://cr-buildbucket-dev.appspot.com"
[04:42:03.456] Failed to prepare PubSub topic - auth: HTTP code (500) when fetching https://cr-buildbucket-dev.appspot.com/auth/api/v1/server/info
[04:42:03.456] The invocation will be retried
[04:52:03.529] Starting the invocation (attempt 16)
[04:52:03.561] Ignoring gitiles_ref tag without the buildset tag
[04:52:03.562] Preparing PubSub topic for "https://cr-buildbucket-dev.appspot.com"
[04:52:08.349] Failed to prepare PubSub topic - auth: HTTP code (500) when fetching https://cr-buildbucket-dev.appspot.com/auth/api/v1/server/info
[04:52:08.349] The invocation will be retried
[05:02:08.407] Starting the invocation (attempt 17)
[05:02:08.433] Ignoring gitiles_ref tag without the buildset tag
[05:02:08.433] Preparing PubSub topic for "https://cr-buildbucket-dev.appspot.com"
[05:02:13.277] Failed to prepare PubSub topic - auth: HTTP code (500) when fetching https://cr-buildbucket-dev.appspot.com/auth/api/v1/server/info
[05:02:13.277] The invocation will be retried
[05:12:13.338] Starting the invocation (attempt 18)
[05:12:13.372] Ignoring gitiles_ref tag without the buildset tag
[05:12:13.372] Preparing PubSub topic for "https://cr-buildbucket-dev.appspot.com"
[05:12:17.976] Failed to prepare PubSub topic - auth: HTTP code (500) when fetching https://cr-buildbucket-dev.appspot.com/auth/api/v1/server/info
[05:12:17.976] The invocation will be retried
[05:22:18.033] Starting the invocation (attempt 19)
[05:22:18.059] Ignoring gitiles_ref tag without the buildset tag
[05:22:18.059] Preparing PubSub topic for "https://cr-buildbucket-dev.appspot.com"
[05:22:22.644] Failed to prepare PubSub topic - auth: HTTP code (500) when fetching https://cr-buildbucket-dev.appspot.com/auth/api/v1/server/info
[05:22:22.644] The invocation will be retried
[05:32:22.735] Starting the invocation (attempt 20)
[05:32:22.767] Ignoring gitiles_ref tag without the buildset tag
[05:32:22.767] Preparing PubSub topic for "https://cr-buildbucket-dev.appspot.com"
[05:32:27.441] Failed to prepare PubSub topic - auth: HTTP code (500) when fetching https://cr-buildbucket-dev.appspot.com/auth/api/v1/server/info
[05:32:27.441] The invocation will be retried
[05:42:27.511] Starting the invocation (attempt 21)
[05:42:27.537] Ignoring gitiles_ref tag without the buildset tag
[05:42:27.537] Preparing PubSub topic for "https://cr-buildbucket-dev.appspot.com"
[05:42:32.053] Failed to prepare PubSub topic - auth: HTTP code (500) when fetching https://cr-buildbucket-dev.appspot.com/auth/api/v1/server/info
[05:42:32.053] The invocation will be retried
[05:52:32.191] Starting the invocation (attempt 22)
[05:52:32.216] Ignoring gitiles_ref tag without the buildset tag
[05:52:32.216] Preparing PubSub topic for "https://cr-buildbucket-dev.appspot.com"
[05:52:36.760] Failed to prepare PubSub topic - auth: HTTP code (500) when fetching https://cr-buildbucket-dev.appspot.com/auth/api/v1/server/info
[05:52:36.760] The invocation will be retried
[06:02:36.859] Starting the invocation (attempt 23)
[06:02:36.894] Ignoring gitiles_ref tag without the buildset tag
[06:02:36.894] Preparing PubSub topic for "https://cr-buildbucket-dev.appspot.com"
[06:02:41.672] Failed to prepare PubSub topic - auth: HTTP code (500) when fetching https://cr-buildbucket-dev.appspot.com/auth/api/v1/server/info
[06:02:41.672] The invocation will be retried
[06:12:41.738] Starting the invocation (attempt 24)
[06:12:41.778] Ignoring gitiles_ref tag without the buildset tag
[06:12:41.778] Preparing PubSub topic for "https://cr-buildbucket-dev.appspot.com"
[06:12:46.378] Failed to prepare PubSub topic - auth: HTTP code (500) when fetching https://cr-buildbucket-dev.appspot.com/auth/api/v1/server/info
[06:12:46.379] The invocation will be retried
[06:22:46.436] Starting the invocation (attempt 25)
[06:22:46.463] Ignoring gitiles_ref tag without the buildset tag
[06:22:46.463] Preparing PubSub topic for "https://cr-buildbucket-dev.appspot.com"
[06:22:50.655] Failed to prepare PubSub topic - auth: HTTP code (500) when fetching https://cr-buildbucket-dev.appspot.com/auth/api/v1/server/info
[06:22:50.655] The invocation will be retried
[06:32:50.713] Starting the invocation (attempt 26)
[06:32:50.745] Ignoring gitiles_ref tag without the buildset tag
[06:32:50.745] Preparing PubSub topic for "https://cr-buildbucket-dev.appspot.com"
[06:32:55.293] Failed to prepare PubSub topic - auth: HTTP code (500) when fetching https://cr-buildbucket-dev.appspot.com/auth/api/v1/server/info
[06:32:55.293] The invocation will be retried
[06:42:55.357] Starting the invocation (attempt 27)
[06:42:55.395] Ignoring gitiles_ref tag without the buildset tag
[06:42:55.395] Preparing PubSub topic for "https://cr-buildbucket-dev.appspot.com"
[06:43:00.754] Failed to prepare PubSub topic - auth: HTTP code (500) when fetching https://cr-buildbucket-dev.appspot.com/auth/api/v1/server/info
[06:43:00.754] The invocation will be retried
[06:53:00.822] Starting the invocation (attempt 28)
[06:53:00.847] Ignoring gitiles_ref tag without the buildset tag
[06:53:00.847] Preparing PubSub topic for "https://cr-buildbucket-dev.appspot.com"
[06:53:04.610] Failed to prepare PubSub topic - auth: HTTP code (500) when fetching https://cr-buildbucket-dev.appspot.com/auth/api/v1/server/info
[06:53:04.610] The invocation will be retried
[07:03:04.754] Starting the invocation (attempt 29)
[07:03:04.792] Ignoring gitiles_ref tag without the buildset tag
[07:03:04.792] Preparing PubSub topic for "https://cr-buildbucket-dev.appspot.com"
[07:03:09.284] Failed to prepare PubSub topic - auth: HTTP code (500) when fetching https://cr-buildbucket-dev.appspot.com/auth/api/v1/server/info
[07:03:09.285] The invocation will be retried
[07:13:09.368] Starting the invocation (attempt 30)
[07:13:09.394] Ignoring gitiles_ref tag without the buildset tag
[07:13:09.394] Preparing PubSub topic for "https://cr-buildbucket-dev.appspot.com"
[07:13:14.167] Failed to prepare PubSub topic - auth: HTTP code (500) when fetching https://cr-buildbucket-dev.appspot.com/auth/api/v1/server/info
[07:13:14.167] The invocation will be retried
[07:23:14.296] Starting the invocation (attempt 31)
[07:23:14.326] Ignoring gitiles_ref tag without the buildset tag
[07:23:14.326] Preparing PubSub topic for "https://cr-buildbucket-dev.appspot.com"
[07:23:19.040] Failed to prepare PubSub topic - auth: HTTP code (500) when fetching https://cr-buildbucket-dev.appspot.com/auth/api/v1/server/info
[07:23:19.041] The invocation will be retried
[07:33:19.104] Starting the invocation (attempt 32)
[07:33:19.127] Ignoring gitiles_ref tag without the buildset tag
[07:33:19.127] Preparing PubSub topic for "https://cr-buildbucket-dev.appspot.com"
[07:33:19.127] PubSub topic is "projects/luci-scheduler-dev/topics/scheduler.buildbucket.cr-buildbucket-dev~appspot.gserviceaccount.com"
[07:33:19.128] Buildbucket request:
{
"requestId": "8905001707678922496",
"builder": {
"project": "infra",
"bucket": "ci",
"builder": "build-proto-linux"
},
"properties": {
"$recipe_engine/scheduler": {
"hostname": "luci-scheduler-dev.appspot.com",
"invocation": "8905001707678922496",
"job": "infra/build-proto-linux",
"triggers": [
{
"cron": {
"generation": "1039205"
},
"id": "cron:v1:1039205"
}
]
}
},
"tags": [
{
"key": "scheduler_invocation_id",
"value": "8905001707678922496"
},
{
"key": "scheduler_job_id",
"value": "infra/build-proto-linux"
},
{
"key": "user_agent",
"value": "luci-scheduler-dev"
}
],
"notify": {
"pubsubTopic": "projects/luci-scheduler-dev/topics/scheduler.buildbucket.cr-buildbucket-dev~appspot.gserviceaccount.com"
}
}
[07:33:19.783] Received PubSub notification, asking Buildbucket for the build status
[07:33:19.783] Fatal error when handling PubSub notification, aborting invocation - unexpected invocation status "RETRYING", expecting "RUNNING"
[07:33:19.783] Invocation finished in 4h13m13.74396405s with status FAILED