[16:42:13.299] New invocation is queued and will start shortly
[16:42:14.625] Starting the invocation (attempt 1)
[16:42:14.654] Popped buildset tag "buildset:commit/gitiles/fuchsia.googlesource.com/integration/+/79d72a1d009be9a2081439b22a75c14f23729076"
[16:42:14.654] Popped gitiles commit info from properties and tags
[16:42:14.654] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[16:42:14.654] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[16:42:14.654] Buildbucket request:
{
"requestId": "8882936179775342720",
"builder": {
"project": "fuchsia",
"bucket": "global.ci",
"builder": "core.x64-asan-dir_insensitivity"
},
"properties": {
"$recipe_engine/scheduler": {
"hostname": "luci-scheduler.appspot.com",
"invocation": "8882936179775342720",
"job": "fuchsia/global.ci-core.x64-asan-dir_insensitivity-e5a0ec7f",
"triggers": [
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "5282a5c0be69630b1e5169d12a988de61f177436"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@5282a5c0be69630b1e5169d12a988de61f177436",
"title": "5282a5c0be69630b1e5169d12a988de61f177436",
"url": "https://fuchsia.googlesource.com/integration/+/5282a5c0be69630b1e5169d12a988de61f177436"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "84e2caaf573623b72147c28ca0d0995a8c894ebe"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@84e2caaf573623b72147c28ca0d0995a8c894ebe",
"title": "84e2caaf573623b72147c28ca0d0995a8c894ebe",
"url": "https://fuchsia.googlesource.com/integration/+/84e2caaf573623b72147c28ca0d0995a8c894ebe"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "546ce0f66660928e6f2dbe42e42effcdd7f4bad4"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@546ce0f66660928e6f2dbe42e42effcdd7f4bad4",
"title": "546ce0f66660928e6f2dbe42e42effcdd7f4bad4",
"url": "https://fuchsia.googlesource.com/integration/+/546ce0f66660928e6f2dbe42e42effcdd7f4bad4"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "e19ed842407a668bb232f2d07566ae8842d2312c"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@e19ed842407a668bb232f2d07566ae8842d2312c",
"title": "e19ed842407a668bb232f2d07566ae8842d2312c",
"url": "https://fuchsia.googlesource.com/integration/+/e19ed842407a668bb232f2d07566ae8842d2312c"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "5a3cfe3c269c052dcb6be16e12728dec60984cab"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@5a3cfe3c269c052dcb6be16e12728dec60984cab",
"title": "5a3cfe3c269c052dcb6be16e12728dec60984cab",
"url": "https://fuchsia.googlesource.com/integration/+/5a3cfe3c269c052dcb6be16e12728dec60984cab"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "d6ec2ddbf79465a92c3be7223389caf890adfcd2"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@d6ec2ddbf79465a92c3be7223389caf890adfcd2",
"title": "d6ec2ddbf79465a92c3be7223389caf890adfcd2",
"url": "https://fuchsia.googlesource.com/integration/+/d6ec2ddbf79465a92c3be7223389caf890adfcd2"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "1e7d943740a973ce1a16ae56507e857f39a8d3f4"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@1e7d943740a973ce1a16ae56507e857f39a8d3f4",
"title": "1e7d943740a973ce1a16ae56507e857f39a8d3f4",
"url": "https://fuchsia.googlesource.com/integration/+/1e7d943740a973ce1a16ae56507e857f39a8d3f4"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "334a6cc8b3b41dc297f5a72eafa1fab79ff23203"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@334a6cc8b3b41dc297f5a72eafa1fab79ff23203",
"title": "334a6cc8b3b41dc297f5a72eafa1fab79ff23203",
"url": "https://fuchsia.googlesource.com/integration/+/334a6cc8b3b41dc297f5a72eafa1fab79ff23203"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "a13f402b5dd84cde70dcf9049c11a0ffebc65956"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@a13f402b5dd84cde70dcf9049c11a0ffebc65956",
"title": "a13f402b5dd84cde70dcf9049c11a0ffebc65956",
"url": "https://fuchsia.googlesource.com/integration/+/a13f402b5dd84cde70dcf9049c11a0ffebc65956"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "3828e785d6c8cc5d2195f7223740ecc449003f50"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@3828e785d6c8cc5d2195f7223740ecc449003f50",
"title": "3828e785d6c8cc5d2195f7223740ecc449003f50",
"url": "https://fuchsia.googlesource.com/integration/+/3828e785d6c8cc5d2195f7223740ecc449003f50"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "79d72a1d009be9a2081439b22a75c14f23729076"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@79d72a1d009be9a2081439b22a75c14f23729076",
"title": "79d72a1d009be9a2081439b22a75c14f23729076",
"url": "https://fuchsia.googlesource.com/integration/+/79d72a1d009be9a2081439b22a75c14f23729076"
}
]
}
},
"gitilesCommit": {
"host": "fuchsia.googlesource.com",
"project": "integration",
"id": "79d72a1d009be9a2081439b22a75c14f23729076",
"ref": "refs/heads/main"
},
"tags": [
{
"key": "scheduler_invocation_id",
"value": "8882936179775342720"
},
{
"key": "scheduler_job_id",
"value": "fuchsia/global.ci-core.x64-asan-dir_insensitivity-e5a0ec7f"
},
{
"key": "user_agent",
"value": "luci-scheduler"
}
],
"notify": {
"pubsubTopic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
}
}
[16:42:15.555] Scheduled build:
{
"id": "8717506117526618737",
"builder": {
"project": "fuchsia",
"bucket": "global.ci",
"builder": "core.x64-asan-dir_insensitivity"
},
"createdBy": "project:fuchsia",
"createTime": "2025-04-15T16:42:14.808153205Z",
"updateTime": "2025-04-15T16:42:14.808153205Z",
"status": "SCHEDULED",
"input": {
"gitilesCommit": {
"host": "fuchsia.googlesource.com",
"project": "integration",
"id": "79d72a1d009be9a2081439b22a75c14f23729076",
"ref": "refs/heads/main"
}
}
}
[16:42:15.555] Task URL: https://cr-buildbucket.appspot.com/build/8717506117526618737
[16:42:15.555] Scheduling timer "check-buildbucket-build-status" (fuchsia/global.ci-core.x64-asan-dir_insensitivity-e5a0ec7f:8882936179775342720:2:0) after 4m44s
[16:42:40.939] Received PubSub notification, asking Buildbucket for the build status
[16:42:41.023] Build status: STARTED
[16:42:45.451] Received PubSub notification, asking Buildbucket for the build status
[16:42:45.478] Build status: STARTED
[16:46:59.640] Handling timer "check-buildbucket-build-status" (fuchsia/global.ci-core.x64-asan-dir_insensitivity-e5a0ec7f:8882936179775342720:2:0)
[16:46:59.667] Build status: STARTED
[16:46:59.667] Scheduling timer "check-buildbucket-build-status" (fuchsia/global.ci-core.x64-asan-dir_insensitivity-e5a0ec7f:8882936179775342720:5:0) after 3m30s
[16:50:29.690] Handling timer "check-buildbucket-build-status" (fuchsia/global.ci-core.x64-asan-dir_insensitivity-e5a0ec7f:8882936179775342720:5:0)
[16:50:29.712] Build status: STARTED
[16:50:29.713] Scheduling timer "check-buildbucket-build-status" (fuchsia/global.ci-core.x64-asan-dir_insensitivity-e5a0ec7f:8882936179775342720:6:0) after 6m9s
[16:56:38.756] Handling timer "check-buildbucket-build-status" (fuchsia/global.ci-core.x64-asan-dir_insensitivity-e5a0ec7f:8882936179775342720:6:0)
[16:56:38.778] Build status: STARTED
[16:56:38.779] Scheduling timer "check-buildbucket-build-status" (fuchsia/global.ci-core.x64-asan-dir_insensitivity-e5a0ec7f:8882936179775342720:7:0) after 7m13s
[17:03:51.864] Handling timer "check-buildbucket-build-status" (fuchsia/global.ci-core.x64-asan-dir_insensitivity-e5a0ec7f:8882936179775342720:7:0)
[17:03:51.884] Build status: STARTED
[17:03:51.884] Scheduling timer "check-buildbucket-build-status" (fuchsia/global.ci-core.x64-asan-dir_insensitivity-e5a0ec7f:8882936179775342720:8:0) after 9m49s
[17:13:40.889] Handling timer "check-buildbucket-build-status" (fuchsia/global.ci-core.x64-asan-dir_insensitivity-e5a0ec7f:8882936179775342720:8:0)
[17:13:40.905] Build status: STARTED
[17:13:40.905] Scheduling timer "check-buildbucket-build-status" (fuchsia/global.ci-core.x64-asan-dir_insensitivity-e5a0ec7f:8882936179775342720:9:0) after 2m40s
[17:16:20.922] Handling timer "check-buildbucket-build-status" (fuchsia/global.ci-core.x64-asan-dir_insensitivity-e5a0ec7f:8882936179775342720:9:0)
[17:16:20.942] Build status: STARTED
[17:16:20.942] Scheduling timer "check-buildbucket-build-status" (fuchsia/global.ci-core.x64-asan-dir_insensitivity-e5a0ec7f:8882936179775342720:10:0) after 6m48s
[17:23:08.978] Handling timer "check-buildbucket-build-status" (fuchsia/global.ci-core.x64-asan-dir_insensitivity-e5a0ec7f:8882936179775342720:10:0)
[17:23:09.049] Build status: STARTED
[17:23:09.049] Scheduling timer "check-buildbucket-build-status" (fuchsia/global.ci-core.x64-asan-dir_insensitivity-e5a0ec7f:8882936179775342720:11:0) after 6m50s
[17:29:59.072] Handling timer "check-buildbucket-build-status" (fuchsia/global.ci-core.x64-asan-dir_insensitivity-e5a0ec7f:8882936179775342720:11:0)
[17:29:59.087] Build status: STARTED
[17:29:59.087] Scheduling timer "check-buildbucket-build-status" (fuchsia/global.ci-core.x64-asan-dir_insensitivity-e5a0ec7f:8882936179775342720:12:0) after 4m52s
[17:34:51.104] Handling timer "check-buildbucket-build-status" (fuchsia/global.ci-core.x64-asan-dir_insensitivity-e5a0ec7f:8882936179775342720:12:0)
[17:34:51.129] Build status: STARTED
[17:34:51.129] Scheduling timer "check-buildbucket-build-status" (fuchsia/global.ci-core.x64-asan-dir_insensitivity-e5a0ec7f:8882936179775342720:13:0) after 7m46s
[17:42:37.151] Handling timer "check-buildbucket-build-status" (fuchsia/global.ci-core.x64-asan-dir_insensitivity-e5a0ec7f:8882936179775342720:13:0)
[17:42:37.170] Build status: STARTED
[17:42:37.170] Scheduling timer "check-buildbucket-build-status" (fuchsia/global.ci-core.x64-asan-dir_insensitivity-e5a0ec7f:8882936179775342720:14:0) after 6m11s
[17:48:48.394] Handling timer "check-buildbucket-build-status" (fuchsia/global.ci-core.x64-asan-dir_insensitivity-e5a0ec7f:8882936179775342720:14:0)
[17:48:48.463] Build status: STARTED
[17:48:48.463] Scheduling timer "check-buildbucket-build-status" (fuchsia/global.ci-core.x64-asan-dir_insensitivity-e5a0ec7f:8882936179775342720:15:0) after 5m28s
[17:54:16.522] Handling timer "check-buildbucket-build-status" (fuchsia/global.ci-core.x64-asan-dir_insensitivity-e5a0ec7f:8882936179775342720:15:0)
[17:54:16.545] Build status: STARTED
[17:54:16.546] Scheduling timer "check-buildbucket-build-status" (fuchsia/global.ci-core.x64-asan-dir_insensitivity-e5a0ec7f:8882936179775342720:16:0) after 9m14s
[18:03:30.565] Handling timer "check-buildbucket-build-status" (fuchsia/global.ci-core.x64-asan-dir_insensitivity-e5a0ec7f:8882936179775342720:16:0)
[18:03:30.590] Build status: STARTED
[18:03:30.590] Scheduling timer "check-buildbucket-build-status" (fuchsia/global.ci-core.x64-asan-dir_insensitivity-e5a0ec7f:8882936179775342720:17:0) after 4m21s
[18:07:51.614] Handling timer "check-buildbucket-build-status" (fuchsia/global.ci-core.x64-asan-dir_insensitivity-e5a0ec7f:8882936179775342720:17:0)
[18:07:51.628] Build status: STARTED
[18:07:51.629] Scheduling timer "check-buildbucket-build-status" (fuchsia/global.ci-core.x64-asan-dir_insensitivity-e5a0ec7f:8882936179775342720:18:0) after 7m9s
[18:15:00.649] Handling timer "check-buildbucket-build-status" (fuchsia/global.ci-core.x64-asan-dir_insensitivity-e5a0ec7f:8882936179775342720:18:0)
[18:15:00.671] Build status: STARTED
[18:15:00.671] Scheduling timer "check-buildbucket-build-status" (fuchsia/global.ci-core.x64-asan-dir_insensitivity-e5a0ec7f:8882936179775342720:19:0) after 5m8s
[18:20:08.741] Handling timer "check-buildbucket-build-status" (fuchsia/global.ci-core.x64-asan-dir_insensitivity-e5a0ec7f:8882936179775342720:19:0)
[18:20:08.767] Build status: STARTED
[18:20:08.767] Scheduling timer "check-buildbucket-build-status" (fuchsia/global.ci-core.x64-asan-dir_insensitivity-e5a0ec7f:8882936179775342720:20:0) after 1m17s
[18:21:26.108] Handling timer "check-buildbucket-build-status" (fuchsia/global.ci-core.x64-asan-dir_insensitivity-e5a0ec7f:8882936179775342720:20:0)
[18:21:26.139] Build status: STARTED
[18:21:26.139] Scheduling timer "check-buildbucket-build-status" (fuchsia/global.ci-core.x64-asan-dir_insensitivity-e5a0ec7f:8882936179775342720:21:0) after 9m41s
[18:31:07.199] Handling timer "check-buildbucket-build-status" (fuchsia/global.ci-core.x64-asan-dir_insensitivity-e5a0ec7f:8882936179775342720:21:0)
[18:31:07.224] Build status: STARTED
[18:31:07.224] Scheduling timer "check-buildbucket-build-status" (fuchsia/global.ci-core.x64-asan-dir_insensitivity-e5a0ec7f:8882936179775342720:22:0) after 7m41s
[18:38:48.250] Handling timer "check-buildbucket-build-status" (fuchsia/global.ci-core.x64-asan-dir_insensitivity-e5a0ec7f:8882936179775342720:22:0)
[18:38:48.266] Build status: STARTED
[18:38:48.266] Scheduling timer "check-buildbucket-build-status" (fuchsia/global.ci-core.x64-asan-dir_insensitivity-e5a0ec7f:8882936179775342720:23:0) after 1m35s
[18:40:23.290] Handling timer "check-buildbucket-build-status" (fuchsia/global.ci-core.x64-asan-dir_insensitivity-e5a0ec7f:8882936179775342720:23:0)
[18:40:23.305] Build status: STARTED
[18:40:23.305] Scheduling timer "check-buildbucket-build-status" (fuchsia/global.ci-core.x64-asan-dir_insensitivity-e5a0ec7f:8882936179775342720:24:0) after 3m0s
[18:43:23.297] Handling timer "check-buildbucket-build-status" (fuchsia/global.ci-core.x64-asan-dir_insensitivity-e5a0ec7f:8882936179775342720:24:0)
[18:43:23.317] Build status: STARTED
[18:43:23.318] Scheduling timer "check-buildbucket-build-status" (fuchsia/global.ci-core.x64-asan-dir_insensitivity-e5a0ec7f:8882936179775342720:25:0) after 5m29s
[18:48:52.435] Handling timer "check-buildbucket-build-status" (fuchsia/global.ci-core.x64-asan-dir_insensitivity-e5a0ec7f:8882936179775342720:25:0)
[18:48:52.450] Build status: STARTED
[18:48:52.450] Scheduling timer "check-buildbucket-build-status" (fuchsia/global.ci-core.x64-asan-dir_insensitivity-e5a0ec7f:8882936179775342720:26:0) after 8m6s
[18:56:58.480] Handling timer "check-buildbucket-build-status" (fuchsia/global.ci-core.x64-asan-dir_insensitivity-e5a0ec7f:8882936179775342720:26:0)
[18:56:58.505] Build status: STARTED
[18:56:58.505] Scheduling timer "check-buildbucket-build-status" (fuchsia/global.ci-core.x64-asan-dir_insensitivity-e5a0ec7f:8882936179775342720:27:0) after 7m20s
[19:04:18.554] Handling timer "check-buildbucket-build-status" (fuchsia/global.ci-core.x64-asan-dir_insensitivity-e5a0ec7f:8882936179775342720:27:0)
[19:04:18.584] Build status: STARTED
[19:04:18.584] Scheduling timer "check-buildbucket-build-status" (fuchsia/global.ci-core.x64-asan-dir_insensitivity-e5a0ec7f:8882936179775342720:28:0) after 1m27s
[19:05:45.609] Handling timer "check-buildbucket-build-status" (fuchsia/global.ci-core.x64-asan-dir_insensitivity-e5a0ec7f:8882936179775342720:28:0)
[19:05:45.623] Build status: STARTED
[19:05:45.623] Scheduling timer "check-buildbucket-build-status" (fuchsia/global.ci-core.x64-asan-dir_insensitivity-e5a0ec7f:8882936179775342720:29:0) after 6m0s
[19:11:45.624] Handling timer "check-buildbucket-build-status" (fuchsia/global.ci-core.x64-asan-dir_insensitivity-e5a0ec7f:8882936179775342720:29:0)
[19:11:45.660] Build status: STARTED
[19:11:45.660] Scheduling timer "check-buildbucket-build-status" (fuchsia/global.ci-core.x64-asan-dir_insensitivity-e5a0ec7f:8882936179775342720:30:0) after 9m29s
[19:21:14.724] Handling timer "check-buildbucket-build-status" (fuchsia/global.ci-core.x64-asan-dir_insensitivity-e5a0ec7f:8882936179775342720:30:0)
[19:21:14.778] Build status: STARTED
[19:21:14.779] Scheduling timer "check-buildbucket-build-status" (fuchsia/global.ci-core.x64-asan-dir_insensitivity-e5a0ec7f:8882936179775342720:31:0) after 7m31s
[19:28:45.802] Handling timer "check-buildbucket-build-status" (fuchsia/global.ci-core.x64-asan-dir_insensitivity-e5a0ec7f:8882936179775342720:31:0)
[19:28:45.820] Build status: STARTED
[19:28:45.820] Scheduling timer "check-buildbucket-build-status" (fuchsia/global.ci-core.x64-asan-dir_insensitivity-e5a0ec7f:8882936179775342720:32:0) after 6m6s
[19:34:51.840] Handling timer "check-buildbucket-build-status" (fuchsia/global.ci-core.x64-asan-dir_insensitivity-e5a0ec7f:8882936179775342720:32:0)
[19:34:51.882] Build status: STARTED
[19:34:51.882] Scheduling timer "check-buildbucket-build-status" (fuchsia/global.ci-core.x64-asan-dir_insensitivity-e5a0ec7f:8882936179775342720:33:0) after 8m42s
[19:43:33.930] Handling timer "check-buildbucket-build-status" (fuchsia/global.ci-core.x64-asan-dir_insensitivity-e5a0ec7f:8882936179775342720:33:0)
[19:43:33.950] Build status: STARTED
[19:43:33.950] Scheduling timer "check-buildbucket-build-status" (fuchsia/global.ci-core.x64-asan-dir_insensitivity-e5a0ec7f:8882936179775342720:34:0) after 1m44s
[19:45:17.974] Handling timer "check-buildbucket-build-status" (fuchsia/global.ci-core.x64-asan-dir_insensitivity-e5a0ec7f:8882936179775342720:34:0)
[19:45:17.993] Build status: STARTED
[19:45:17.993] Scheduling timer "check-buildbucket-build-status" (fuchsia/global.ci-core.x64-asan-dir_insensitivity-e5a0ec7f:8882936179775342720:35:0) after 6m42s
[19:45:43.635] Received PubSub notification, asking Buildbucket for the build status
[19:45:43.675] Build:
{
"id": "8717506117526618737",
"builder": {
"project": "fuchsia",
"bucket": "global.ci",
"builder": "core.x64-asan-dir_insensitivity"
},
"createdBy": "project:fuchsia",
"createTime": "2025-04-15T16:42:14.808153205Z",
"startTime": "2025-04-15T16:42:19.932869459Z",
"endTime": "2025-04-15T19:45:43.381413318Z",
"updateTime": "2025-04-15T19:45:43.381413318Z",
"status": "SUCCESS",
"input": {
"gitilesCommit": {
"host": "fuchsia.googlesource.com",
"project": "integration",
"id": "79d72a1d009be9a2081439b22a75c14f23729076",
"ref": "refs/heads/main"
}
}
}
[19:45:43.675] Invocation finished in 3h3m30.395020462s with status SUCCEEDED