[06:13:47.549] New invocation is queued and will start shortly
[06:13:48.606] Starting the invocation (attempt 1)
[06:13:48.629] Popped buildset tag "buildset:commit/gitiles/fuchsia.googlesource.com/integration/+/436ffac890f11420f4dfbd1d8a79b815593fa6b8"
[06:13:48.629] Popped gitiles commit info from properties and tags
[06:13:48.629] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[06:13:48.629] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[06:13:48.630] Buildbucket request:
{
"requestId": "8892850786450585744",
"builder": {
"project": "fuchsia",
"bucket": "global.ci",
"builder": "core.x64-asan-dir_insensitivity"
},
"properties": {
"$recipe_engine/scheduler": {
"hostname": "luci-scheduler.appspot.com",
"invocation": "8892850786450585744",
"job": "fuchsia/core.x64-asan-dir_insensitivity-e5a0ec7f",
"triggers": [
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "0e7db3b0201ad82c006de0c4bef58d26bbc958be"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@0e7db3b0201ad82c006de0c4bef58d26bbc958be",
"title": "0e7db3b0201ad82c006de0c4bef58d26bbc958be",
"url": "https://fuchsia.googlesource.com/integration/+/0e7db3b0201ad82c006de0c4bef58d26bbc958be"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "f5166563323418a9b01327a9c40b70ca8c3f29a2"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@f5166563323418a9b01327a9c40b70ca8c3f29a2",
"title": "f5166563323418a9b01327a9c40b70ca8c3f29a2",
"url": "https://fuchsia.googlesource.com/integration/+/f5166563323418a9b01327a9c40b70ca8c3f29a2"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://fuchsia.googlesource.com/integration",
"revision": "436ffac890f11420f4dfbd1d8a79b815593fa6b8"
},
"id": "https://fuchsia.googlesource.com/integration/+/refs/heads/main@436ffac890f11420f4dfbd1d8a79b815593fa6b8",
"title": "436ffac890f11420f4dfbd1d8a79b815593fa6b8",
"url": "https://fuchsia.googlesource.com/integration/+/436ffac890f11420f4dfbd1d8a79b815593fa6b8"
}
]
}
},
"gitilesCommit": {
"host": "fuchsia.googlesource.com",
"project": "integration",
"id": "436ffac890f11420f4dfbd1d8a79b815593fa6b8",
"ref": "refs/heads/main"
},
"tags": [
{
"key": "scheduler_invocation_id",
"value": "8892850786450585744"
},
{
"key": "scheduler_job_id",
"value": "fuchsia/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"
}
}
[06:13:49.326] Scheduled build:
{
"id": "8727420724544443153",
"builder": {
"project": "fuchsia",
"bucket": "global.ci",
"builder": "core.x64-asan-dir_insensitivity"
},
"createdBy": "project:fuchsia",
"createTime": "2024-12-27T06:13:48.738170895Z",
"updateTime": "2024-12-27T06:13:48.738170895Z",
"status": "SCHEDULED",
"input": {
"gitilesCommit": {
"host": "fuchsia.googlesource.com",
"project": "integration",
"id": "436ffac890f11420f4dfbd1d8a79b815593fa6b8",
"ref": "refs/heads/main"
}
}
}
[06:13:49.326] Task URL: https://cr-buildbucket.appspot.com/build/8727420724544443153
[06:13:49.326] Scheduling timer "check-buildbucket-build-status" (fuchsia/core.x64-asan-dir_insensitivity-e5a0ec7f:8892850786450585744:2:0) after 6m56s
[06:13:50.073] Received PubSub notification, asking Buildbucket for the build status
[06:13:50.099] Build status: SCHEDULED
[06:13:53.760] Received PubSub notification, asking Buildbucket for the build status
[06:13:53.783] Build status: STARTED
[06:20:45.519] Handling timer "check-buildbucket-build-status" (fuchsia/core.x64-asan-dir_insensitivity-e5a0ec7f:8892850786450585744:2:0)
[06:20:45.550] Build status: STARTED
[06:20:45.550] Scheduling timer "check-buildbucket-build-status" (fuchsia/core.x64-asan-dir_insensitivity-e5a0ec7f:8892850786450585744:5:0) after 1m24s
[06:22:09.673] Handling timer "check-buildbucket-build-status" (fuchsia/core.x64-asan-dir_insensitivity-e5a0ec7f:8892850786450585744:5:0)
[06:22:09.696] Build status: STARTED
[06:22:09.696] Scheduling timer "check-buildbucket-build-status" (fuchsia/core.x64-asan-dir_insensitivity-e5a0ec7f:8892850786450585744:6:0) after 8m22s
[06:30:31.759] Handling timer "check-buildbucket-build-status" (fuchsia/core.x64-asan-dir_insensitivity-e5a0ec7f:8892850786450585744:6:0)
[06:30:31.796] Build status: STARTED
[06:30:31.796] Scheduling timer "check-buildbucket-build-status" (fuchsia/core.x64-asan-dir_insensitivity-e5a0ec7f:8892850786450585744:7:0) after 7m55s
[06:38:26.959] Handling timer "check-buildbucket-build-status" (fuchsia/core.x64-asan-dir_insensitivity-e5a0ec7f:8892850786450585744:7:0)
[06:38:26.982] Build status: STARTED
[06:38:26.982] Scheduling timer "check-buildbucket-build-status" (fuchsia/core.x64-asan-dir_insensitivity-e5a0ec7f:8892850786450585744:8:0) after 6m55s
[06:45:21.999] Handling timer "check-buildbucket-build-status" (fuchsia/core.x64-asan-dir_insensitivity-e5a0ec7f:8892850786450585744:8:0)
[06:45:22.016] Build status: STARTED
[06:45:22.016] Scheduling timer "check-buildbucket-build-status" (fuchsia/core.x64-asan-dir_insensitivity-e5a0ec7f:8892850786450585744:9:0) after 9m44s
[06:55:06.257] Handling timer "check-buildbucket-build-status" (fuchsia/core.x64-asan-dir_insensitivity-e5a0ec7f:8892850786450585744:9:0)
[06:55:06.327] Build status: STARTED
[06:55:06.327] Scheduling timer "check-buildbucket-build-status" (fuchsia/core.x64-asan-dir_insensitivity-e5a0ec7f:8892850786450585744:10:0) after 2m6s
[06:57:12.349] Handling timer "check-buildbucket-build-status" (fuchsia/core.x64-asan-dir_insensitivity-e5a0ec7f:8892850786450585744:10:0)
[06:57:12.372] Build status: STARTED
[06:57:12.372] Scheduling timer "check-buildbucket-build-status" (fuchsia/core.x64-asan-dir_insensitivity-e5a0ec7f:8892850786450585744:11:0) after 5m33s
[07:02:45.387] Handling timer "check-buildbucket-build-status" (fuchsia/core.x64-asan-dir_insensitivity-e5a0ec7f:8892850786450585744:11:0)
[07:02:45.417] Build status: STARTED
[07:02:45.417] Scheduling timer "check-buildbucket-build-status" (fuchsia/core.x64-asan-dir_insensitivity-e5a0ec7f:8892850786450585744:12:0) after 1m4s
[07:03:49.474] Handling timer "check-buildbucket-build-status" (fuchsia/core.x64-asan-dir_insensitivity-e5a0ec7f:8892850786450585744:12:0)
[07:03:49.494] Build status: STARTED
[07:03:49.494] Scheduling timer "check-buildbucket-build-status" (fuchsia/core.x64-asan-dir_insensitivity-e5a0ec7f:8892850786450585744:13:0) after 8m48s
[07:12:37.515] Handling timer "check-buildbucket-build-status" (fuchsia/core.x64-asan-dir_insensitivity-e5a0ec7f:8892850786450585744:13:0)
[07:12:37.532] Build status: STARTED
[07:12:37.532] Scheduling timer "check-buildbucket-build-status" (fuchsia/core.x64-asan-dir_insensitivity-e5a0ec7f:8892850786450585744:14:0) after 4m39s
[07:17:16.558] Handling timer "check-buildbucket-build-status" (fuchsia/core.x64-asan-dir_insensitivity-e5a0ec7f:8892850786450585744:14:0)
[07:17:16.575] Build status: STARTED
[07:17:16.575] Scheduling timer "check-buildbucket-build-status" (fuchsia/core.x64-asan-dir_insensitivity-e5a0ec7f:8892850786450585744:15:0) after 2m3s
[07:19:19.676] Handling timer "check-buildbucket-build-status" (fuchsia/core.x64-asan-dir_insensitivity-e5a0ec7f:8892850786450585744:15:0)
[07:19:19.692] Build status: STARTED
[07:19:19.692] Scheduling timer "check-buildbucket-build-status" (fuchsia/core.x64-asan-dir_insensitivity-e5a0ec7f:8892850786450585744:16:0) after 4m34s
[07:23:53.708] Handling timer "check-buildbucket-build-status" (fuchsia/core.x64-asan-dir_insensitivity-e5a0ec7f:8892850786450585744:16:0)
[07:23:53.737] Build status: STARTED
[07:23:53.737] Scheduling timer "check-buildbucket-build-status" (fuchsia/core.x64-asan-dir_insensitivity-e5a0ec7f:8892850786450585744:17:0) after 6m50s
[07:30:43.854] Handling timer "check-buildbucket-build-status" (fuchsia/core.x64-asan-dir_insensitivity-e5a0ec7f:8892850786450585744:17:0)
[07:30:43.872] Build status: STARTED
[07:30:43.872] Scheduling timer "check-buildbucket-build-status" (fuchsia/core.x64-asan-dir_insensitivity-e5a0ec7f:8892850786450585744:18:0) after 1m43s
[07:32:27.026] Handling timer "check-buildbucket-build-status" (fuchsia/core.x64-asan-dir_insensitivity-e5a0ec7f:8892850786450585744:18:0)
[07:32:27.043] Build status: STARTED
[07:32:27.043] Scheduling timer "check-buildbucket-build-status" (fuchsia/core.x64-asan-dir_insensitivity-e5a0ec7f:8892850786450585744:19:0) after 6m14s
[07:38:41.063] Handling timer "check-buildbucket-build-status" (fuchsia/core.x64-asan-dir_insensitivity-e5a0ec7f:8892850786450585744:19:0)
[07:38:41.085] Build status: STARTED
[07:38:41.085] Scheduling timer "check-buildbucket-build-status" (fuchsia/core.x64-asan-dir_insensitivity-e5a0ec7f:8892850786450585744:20:0) after 1m24s
[07:40:05.408] Handling timer "check-buildbucket-build-status" (fuchsia/core.x64-asan-dir_insensitivity-e5a0ec7f:8892850786450585744:20:0)
[07:40:05.438] Build status: STARTED
[07:40:05.438] Scheduling timer "check-buildbucket-build-status" (fuchsia/core.x64-asan-dir_insensitivity-e5a0ec7f:8892850786450585744:21:0) after 9m34s
[07:49:39.937] Handling timer "check-buildbucket-build-status" (fuchsia/core.x64-asan-dir_insensitivity-e5a0ec7f:8892850786450585744:21:0)
[07:49:39.965] Build status: STARTED
[07:49:39.965] Scheduling timer "check-buildbucket-build-status" (fuchsia/core.x64-asan-dir_insensitivity-e5a0ec7f:8892850786450585744:22:0) after 2m35s
[07:52:14.988] Handling timer "check-buildbucket-build-status" (fuchsia/core.x64-asan-dir_insensitivity-e5a0ec7f:8892850786450585744:22:0)
[07:52:15.006] Build status: STARTED
[07:52:15.006] Scheduling timer "check-buildbucket-build-status" (fuchsia/core.x64-asan-dir_insensitivity-e5a0ec7f:8892850786450585744:23:0) after 9m0s
[08:01:15.030] Handling timer "check-buildbucket-build-status" (fuchsia/core.x64-asan-dir_insensitivity-e5a0ec7f:8892850786450585744:23:0)
[08:01:15.050] Build status: STARTED
[08:01:15.050] Scheduling timer "check-buildbucket-build-status" (fuchsia/core.x64-asan-dir_insensitivity-e5a0ec7f:8892850786450585744:24:0) after 7m2s
[08:08:17.170] Handling timer "check-buildbucket-build-status" (fuchsia/core.x64-asan-dir_insensitivity-e5a0ec7f:8892850786450585744:24:0)
[08:08:17.189] Build status: STARTED
[08:08:17.189] Scheduling timer "check-buildbucket-build-status" (fuchsia/core.x64-asan-dir_insensitivity-e5a0ec7f:8892850786450585744:25:0) after 6m7s
[08:14:24.207] Handling timer "check-buildbucket-build-status" (fuchsia/core.x64-asan-dir_insensitivity-e5a0ec7f:8892850786450585744:25:0)
[08:14:24.238] Build status: STARTED
[08:14:24.238] Scheduling timer "check-buildbucket-build-status" (fuchsia/core.x64-asan-dir_insensitivity-e5a0ec7f:8892850786450585744:26:0) after 6m3s
[08:20:27.263] Handling timer "check-buildbucket-build-status" (fuchsia/core.x64-asan-dir_insensitivity-e5a0ec7f:8892850786450585744:26:0)
[08:20:27.288] Build status: STARTED
[08:20:27.288] Scheduling timer "check-buildbucket-build-status" (fuchsia/core.x64-asan-dir_insensitivity-e5a0ec7f:8892850786450585744:27:0) after 6m58s
[08:27:25.710] Handling timer "check-buildbucket-build-status" (fuchsia/core.x64-asan-dir_insensitivity-e5a0ec7f:8892850786450585744:27:0)
[08:27:25.776] Build status: STARTED
[08:27:25.776] Scheduling timer "check-buildbucket-build-status" (fuchsia/core.x64-asan-dir_insensitivity-e5a0ec7f:8892850786450585744:28:0) after 4m40s
[08:32:06.102] Handling timer "check-buildbucket-build-status" (fuchsia/core.x64-asan-dir_insensitivity-e5a0ec7f:8892850786450585744:28:0)
[08:32:06.129] Build status: STARTED
[08:32:06.129] Scheduling timer "check-buildbucket-build-status" (fuchsia/core.x64-asan-dir_insensitivity-e5a0ec7f:8892850786450585744:29:0) after 1m1s
[08:33:07.501] Handling timer "check-buildbucket-build-status" (fuchsia/core.x64-asan-dir_insensitivity-e5a0ec7f:8892850786450585744:29:0)
[08:33:07.522] Build status: STARTED
[08:33:07.522] Scheduling timer "check-buildbucket-build-status" (fuchsia/core.x64-asan-dir_insensitivity-e5a0ec7f:8892850786450585744:30:0) after 4m32s
[08:37:39.552] Handling timer "check-buildbucket-build-status" (fuchsia/core.x64-asan-dir_insensitivity-e5a0ec7f:8892850786450585744:30:0)
[08:37:39.568] Build status: STARTED
[08:37:39.568] Scheduling timer "check-buildbucket-build-status" (fuchsia/core.x64-asan-dir_insensitivity-e5a0ec7f:8892850786450585744:31:0) after 5m9s
[08:42:48.578] Handling timer "check-buildbucket-build-status" (fuchsia/core.x64-asan-dir_insensitivity-e5a0ec7f:8892850786450585744:31:0)
[08:42:48.628] Build status: STARTED
[08:42:48.628] Scheduling timer "check-buildbucket-build-status" (fuchsia/core.x64-asan-dir_insensitivity-e5a0ec7f:8892850786450585744:32:0) after 1m57s
[08:44:45.650] Handling timer "check-buildbucket-build-status" (fuchsia/core.x64-asan-dir_insensitivity-e5a0ec7f:8892850786450585744:32:0)
[08:44:45.669] Build status: STARTED
[08:44:45.669] Scheduling timer "check-buildbucket-build-status" (fuchsia/core.x64-asan-dir_insensitivity-e5a0ec7f:8892850786450585744:33:0) after 4m12s
[08:48:57.756] Handling timer "check-buildbucket-build-status" (fuchsia/core.x64-asan-dir_insensitivity-e5a0ec7f:8892850786450585744:33:0)
[08:48:57.774] Build status: STARTED
[08:48:57.774] Scheduling timer "check-buildbucket-build-status" (fuchsia/core.x64-asan-dir_insensitivity-e5a0ec7f:8892850786450585744:34:0) after 7m22s
[08:56:19.779] Handling timer "check-buildbucket-build-status" (fuchsia/core.x64-asan-dir_insensitivity-e5a0ec7f:8892850786450585744:34:0)
[08:56:19.796] Build status: STARTED
[08:56:19.796] Scheduling timer "check-buildbucket-build-status" (fuchsia/core.x64-asan-dir_insensitivity-e5a0ec7f:8892850786450585744:35:0) after 6m35s
[09:00:54.052] Received PubSub notification, asking Buildbucket for the build status
[09:00:54.067] Build:
{
"id": "8727420724544443153",
"builder": {
"project": "fuchsia",
"bucket": "global.ci",
"builder": "core.x64-asan-dir_insensitivity"
},
"createdBy": "project:fuchsia",
"createTime": "2024-12-27T06:13:48.738170895Z",
"startTime": "2024-12-27T06:13:53.465921817Z",
"endTime": "2024-12-27T09:00:47.654628967Z",
"updateTime": "2024-12-27T09:00:47.654628967Z",
"status": "SUCCESS",
"input": {
"gitilesCommit": {
"host": "fuchsia.googlesource.com",
"project": "integration",
"id": "436ffac890f11420f4dfbd1d8a79b815593fa6b8",
"ref": "refs/heads/main"
}
}
}
[09:00:54.067] Invocation finished in 2h47m6.531474502s with status SUCCEEDED