[05:00:06.547] New invocation is queued and will start shortly
[05:00:07.889] Starting the invocation (attempt 1)
[05:00:07.929] Popped buildset tag "buildset:commit/gitiles/dart.googlesource.com/sdk/+/e2e6ee8b0264ef1809462033100b60fbeff148c0"
[05:00:07.929] Popped gitiles commit info from properties and tags
[05:00:07.929] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[05:00:07.929] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[05:00:07.930] Buildbucket request:
{
"requestId": "8919037945488388736",
"builder": {
"project": "dart",
"bucket": "ci.sandbox",
"builder": "vm-gcc-linux"
},
"properties": {
"$recipe_engine/scheduler": {
"hostname": "luci-scheduler.appspot.com",
"invocation": "8919037945488388736",
"job": "dart/vm-gcc-linux",
"triggers": [
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://dart.googlesource.com/sdk",
"revision": "e7daade2913335534ea2cdcf9fbee1f74ec83d49"
},
"id": "https://dart.googlesource.com/sdk/+/refs/heads/main@e7daade2913335534ea2cdcf9fbee1f74ec83d49",
"title": "e7daade2913335534ea2cdcf9fbee1f74ec83d49",
"url": "https://dart.googlesource.com/sdk/+/e7daade2913335534ea2cdcf9fbee1f74ec83d49"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://dart.googlesource.com/sdk",
"revision": "c2e9ceeb6b97329f75a84bd41e40b540dd40e7a4"
},
"id": "https://dart.googlesource.com/sdk/+/refs/heads/main@c2e9ceeb6b97329f75a84bd41e40b540dd40e7a4",
"title": "c2e9ceeb6b97329f75a84bd41e40b540dd40e7a4",
"url": "https://dart.googlesource.com/sdk/+/c2e9ceeb6b97329f75a84bd41e40b540dd40e7a4"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://dart.googlesource.com/sdk",
"revision": "f15dd6980a7312fbebd5d500067b59fbec5b16cb"
},
"id": "https://dart.googlesource.com/sdk/+/refs/heads/main@f15dd6980a7312fbebd5d500067b59fbec5b16cb",
"title": "f15dd6980a7312fbebd5d500067b59fbec5b16cb",
"url": "https://dart.googlesource.com/sdk/+/f15dd6980a7312fbebd5d500067b59fbec5b16cb"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://dart.googlesource.com/sdk",
"revision": "f694d3ea180fd95e4abcb509c081c861e7c29a32"
},
"id": "https://dart.googlesource.com/sdk/+/refs/heads/main@f694d3ea180fd95e4abcb509c081c861e7c29a32",
"title": "f694d3ea180fd95e4abcb509c081c861e7c29a32",
"url": "https://dart.googlesource.com/sdk/+/f694d3ea180fd95e4abcb509c081c861e7c29a32"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://dart.googlesource.com/sdk",
"revision": "0f839e8d1d3799579f12047d9498285c5b823789"
},
"id": "https://dart.googlesource.com/sdk/+/refs/heads/main@0f839e8d1d3799579f12047d9498285c5b823789",
"title": "0f839e8d1d3799579f12047d9498285c5b823789",
"url": "https://dart.googlesource.com/sdk/+/0f839e8d1d3799579f12047d9498285c5b823789"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://dart.googlesource.com/sdk",
"revision": "e38f4fa4acc3a6529271c1bfba97b595932943cf"
},
"id": "https://dart.googlesource.com/sdk/+/refs/heads/main@e38f4fa4acc3a6529271c1bfba97b595932943cf",
"title": "e38f4fa4acc3a6529271c1bfba97b595932943cf",
"url": "https://dart.googlesource.com/sdk/+/e38f4fa4acc3a6529271c1bfba97b595932943cf"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://dart.googlesource.com/sdk",
"revision": "4b9dd9d586394082b5ba2092a7e39b897c881f36"
},
"id": "https://dart.googlesource.com/sdk/+/refs/heads/main@4b9dd9d586394082b5ba2092a7e39b897c881f36",
"title": "4b9dd9d586394082b5ba2092a7e39b897c881f36",
"url": "https://dart.googlesource.com/sdk/+/4b9dd9d586394082b5ba2092a7e39b897c881f36"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://dart.googlesource.com/sdk",
"revision": "0a68ca97b9636f0f99d8699fb628d3eba7ba41a6"
},
"id": "https://dart.googlesource.com/sdk/+/refs/heads/main@0a68ca97b9636f0f99d8699fb628d3eba7ba41a6",
"title": "0a68ca97b9636f0f99d8699fb628d3eba7ba41a6",
"url": "https://dart.googlesource.com/sdk/+/0a68ca97b9636f0f99d8699fb628d3eba7ba41a6"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://dart.googlesource.com/sdk",
"revision": "bca5e833cb6e2cbdd2e51dab97094280423e0859"
},
"id": "https://dart.googlesource.com/sdk/+/refs/heads/main@bca5e833cb6e2cbdd2e51dab97094280423e0859",
"title": "bca5e833cb6e2cbdd2e51dab97094280423e0859",
"url": "https://dart.googlesource.com/sdk/+/bca5e833cb6e2cbdd2e51dab97094280423e0859"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://dart.googlesource.com/sdk",
"revision": "06490d1032e03b5ac872d4219f64e0a6c2e63ed0"
},
"id": "https://dart.googlesource.com/sdk/+/refs/heads/main@06490d1032e03b5ac872d4219f64e0a6c2e63ed0",
"title": "06490d1032e03b5ac872d4219f64e0a6c2e63ed0",
"url": "https://dart.googlesource.com/sdk/+/06490d1032e03b5ac872d4219f64e0a6c2e63ed0"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://dart.googlesource.com/sdk",
"revision": "e9dd95a10bc0f02d8f0ae860914b9f4e4c4409ea"
},
"id": "https://dart.googlesource.com/sdk/+/refs/heads/main@e9dd95a10bc0f02d8f0ae860914b9f4e4c4409ea",
"title": "e9dd95a10bc0f02d8f0ae860914b9f4e4c4409ea",
"url": "https://dart.googlesource.com/sdk/+/e9dd95a10bc0f02d8f0ae860914b9f4e4c4409ea"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://dart.googlesource.com/sdk",
"revision": "af700baa49b9fdab170ff8ed2b4b9fe26772f48b"
},
"id": "https://dart.googlesource.com/sdk/+/refs/heads/main@af700baa49b9fdab170ff8ed2b4b9fe26772f48b",
"title": "af700baa49b9fdab170ff8ed2b4b9fe26772f48b",
"url": "https://dart.googlesource.com/sdk/+/af700baa49b9fdab170ff8ed2b4b9fe26772f48b"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://dart.googlesource.com/sdk",
"revision": "df3d7e339dd24d6867b64f0867575f80953d0d70"
},
"id": "https://dart.googlesource.com/sdk/+/refs/heads/main@df3d7e339dd24d6867b64f0867575f80953d0d70",
"title": "df3d7e339dd24d6867b64f0867575f80953d0d70",
"url": "https://dart.googlesource.com/sdk/+/df3d7e339dd24d6867b64f0867575f80953d0d70"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://dart.googlesource.com/sdk",
"revision": "23d7347c906e1b7e05fec3611400d41b72fa0b4f"
},
"id": "https://dart.googlesource.com/sdk/+/refs/heads/main@23d7347c906e1b7e05fec3611400d41b72fa0b4f",
"title": "23d7347c906e1b7e05fec3611400d41b72fa0b4f",
"url": "https://dart.googlesource.com/sdk/+/23d7347c906e1b7e05fec3611400d41b72fa0b4f"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://dart.googlesource.com/sdk",
"revision": "a7831723fc8db02a6ed1e4fd895fbe68d16671c0"
},
"id": "https://dart.googlesource.com/sdk/+/refs/heads/main@a7831723fc8db02a6ed1e4fd895fbe68d16671c0",
"title": "a7831723fc8db02a6ed1e4fd895fbe68d16671c0",
"url": "https://dart.googlesource.com/sdk/+/a7831723fc8db02a6ed1e4fd895fbe68d16671c0"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://dart.googlesource.com/sdk",
"revision": "3bb1ada6e6b6621fedc306b834a33751176c71a4"
},
"id": "https://dart.googlesource.com/sdk/+/refs/heads/main@3bb1ada6e6b6621fedc306b834a33751176c71a4",
"title": "3bb1ada6e6b6621fedc306b834a33751176c71a4",
"url": "https://dart.googlesource.com/sdk/+/3bb1ada6e6b6621fedc306b834a33751176c71a4"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://dart.googlesource.com/sdk",
"revision": "9becf40378834e35be7daad874bce96a3b2b54a8"
},
"id": "https://dart.googlesource.com/sdk/+/refs/heads/main@9becf40378834e35be7daad874bce96a3b2b54a8",
"title": "9becf40378834e35be7daad874bce96a3b2b54a8",
"url": "https://dart.googlesource.com/sdk/+/9becf40378834e35be7daad874bce96a3b2b54a8"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://dart.googlesource.com/sdk",
"revision": "1ab083ae487af531d1e28fb8fd6d50fb71aaadf9"
},
"id": "https://dart.googlesource.com/sdk/+/refs/heads/main@1ab083ae487af531d1e28fb8fd6d50fb71aaadf9",
"title": "1ab083ae487af531d1e28fb8fd6d50fb71aaadf9",
"url": "https://dart.googlesource.com/sdk/+/1ab083ae487af531d1e28fb8fd6d50fb71aaadf9"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://dart.googlesource.com/sdk",
"revision": "ff0f5c4bdb9f2a55cebe438ef367c6dc7f6ea433"
},
"id": "https://dart.googlesource.com/sdk/+/refs/heads/main@ff0f5c4bdb9f2a55cebe438ef367c6dc7f6ea433",
"title": "ff0f5c4bdb9f2a55cebe438ef367c6dc7f6ea433",
"url": "https://dart.googlesource.com/sdk/+/ff0f5c4bdb9f2a55cebe438ef367c6dc7f6ea433"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://dart.googlesource.com/sdk",
"revision": "12859761b9d46b14e7f33c7433ddd3e991709a54"
},
"id": "https://dart.googlesource.com/sdk/+/refs/heads/main@12859761b9d46b14e7f33c7433ddd3e991709a54",
"title": "12859761b9d46b14e7f33c7433ddd3e991709a54",
"url": "https://dart.googlesource.com/sdk/+/12859761b9d46b14e7f33c7433ddd3e991709a54"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://dart.googlesource.com/sdk",
"revision": "6d12146e75d453051adace0c9d58dd2469f2f73e"
},
"id": "https://dart.googlesource.com/sdk/+/refs/heads/main@6d12146e75d453051adace0c9d58dd2469f2f73e",
"title": "6d12146e75d453051adace0c9d58dd2469f2f73e",
"url": "https://dart.googlesource.com/sdk/+/6d12146e75d453051adace0c9d58dd2469f2f73e"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://dart.googlesource.com/sdk",
"revision": "c78f973ce8dfcc97b38259d99773d035e4642612"
},
"id": "https://dart.googlesource.com/sdk/+/refs/heads/main@c78f973ce8dfcc97b38259d99773d035e4642612",
"title": "c78f973ce8dfcc97b38259d99773d035e4642612",
"url": "https://dart.googlesource.com/sdk/+/c78f973ce8dfcc97b38259d99773d035e4642612"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://dart.googlesource.com/sdk",
"revision": "e2e6ee8b0264ef1809462033100b60fbeff148c0"
},
"id": "https://dart.googlesource.com/sdk/+/refs/heads/main@e2e6ee8b0264ef1809462033100b60fbeff148c0",
"title": "e2e6ee8b0264ef1809462033100b60fbeff148c0",
"url": "https://dart.googlesource.com/sdk/+/e2e6ee8b0264ef1809462033100b60fbeff148c0"
}
]
}
},
"gitilesCommit": {
"host": "dart.googlesource.com",
"project": "sdk",
"id": "e2e6ee8b0264ef1809462033100b60fbeff148c0",
"ref": "refs/heads/main"
},
"tags": [
{
"key": "scheduler_invocation_id",
"value": "8919037945488388736"
},
{
"key": "scheduler_job_id",
"value": "dart/vm-gcc-linux"
},
{
"key": "user_agent",
"value": "luci-scheduler"
}
],
"notify": {
"pubsubTopic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
}
}
[05:00:08.495] Scheduled build:
{
"id": "8753607883301413409",
"builder": {
"project": "dart",
"bucket": "ci.sandbox",
"builder": "vm-gcc-linux"
},
"number": 289,
"createdBy": "project:dart",
"createTime": "2024-03-13T05:00:08.012239681Z",
"updateTime": "2024-03-13T05:00:08.012239681Z",
"status": "SCHEDULED",
"input": {
"gitilesCommit": {
"host": "dart.googlesource.com",
"project": "sdk",
"id": "e2e6ee8b0264ef1809462033100b60fbeff148c0",
"ref": "refs/heads/main"
}
}
}
[05:00:08.495] Task URL: https://cr-buildbucket.appspot.com/build/8753607883301413409
[05:00:08.495] Scheduling timer "check-buildbucket-build-status" (dart/vm-gcc-linux:8919037945488388736:2:0) after 9m0s
[05:00:08.580] Received PubSub notification, asking Buildbucket for the build status
[05:00:08.624] Build status: SCHEDULED
[05:00:12.453] Received PubSub notification, asking Buildbucket for the build status
[05:00:12.480] Build status: STARTED
[05:09:08.793] Handling timer "check-buildbucket-build-status" (dart/vm-gcc-linux:8919037945488388736:2:0)
[05:09:08.815] Build status: STARTED
[05:09:08.815] Scheduling timer "check-buildbucket-build-status" (dart/vm-gcc-linux:8919037945488388736:5:0) after 3m7s
[05:12:15.832] Handling timer "check-buildbucket-build-status" (dart/vm-gcc-linux:8919037945488388736:5:0)
[05:12:15.866] Build status: STARTED
[05:12:15.866] Scheduling timer "check-buildbucket-build-status" (dart/vm-gcc-linux:8919037945488388736:6:0) after 8m21s
[05:20:37.026] Handling timer "check-buildbucket-build-status" (dart/vm-gcc-linux:8919037945488388736:6:0)
[05:20:37.045] Build status: STARTED
[05:20:37.045] Scheduling timer "check-buildbucket-build-status" (dart/vm-gcc-linux:8919037945488388736:7:0) after 7m27s
[05:28:04.321] Handling timer "check-buildbucket-build-status" (dart/vm-gcc-linux:8919037945488388736:7:0)
[05:28:04.357] Build status: STARTED
[05:28:04.357] Scheduling timer "check-buildbucket-build-status" (dart/vm-gcc-linux:8919037945488388736:8:0) after 6m25s
[05:34:29.498] Handling timer "check-buildbucket-build-status" (dart/vm-gcc-linux:8919037945488388736:8:0)
[05:34:29.529] Build status: STARTED
[05:34:29.529] Scheduling timer "check-buildbucket-build-status" (dart/vm-gcc-linux:8919037945488388736:9:0) after 6m28s
[05:40:57.775] Handling timer "check-buildbucket-build-status" (dart/vm-gcc-linux:8919037945488388736:9:0)
[05:40:57.793] Build status: STARTED
[05:40:57.793] Scheduling timer "check-buildbucket-build-status" (dart/vm-gcc-linux:8919037945488388736:10:0) after 8m51s
[05:49:48.810] Handling timer "check-buildbucket-build-status" (dart/vm-gcc-linux:8919037945488388736:10:0)
[05:49:48.868] Build status: STARTED
[05:49:48.868] Scheduling timer "check-buildbucket-build-status" (dart/vm-gcc-linux:8919037945488388736:11:0) after 9m5s
[05:58:54.044] Handling timer "check-buildbucket-build-status" (dart/vm-gcc-linux:8919037945488388736:11:0)
[05:58:54.061] Build status: STARTED
[05:58:54.061] Scheduling timer "check-buildbucket-build-status" (dart/vm-gcc-linux:8919037945488388736:12:0) after 5m34s
[06:04:28.326] Handling timer "check-buildbucket-build-status" (dart/vm-gcc-linux:8919037945488388736:12:0)
[06:04:28.354] Build status: STARTED
[06:04:28.354] Scheduling timer "check-buildbucket-build-status" (dart/vm-gcc-linux:8919037945488388736:13:0) after 6m3s
[06:10:31.506] Handling timer "check-buildbucket-build-status" (dart/vm-gcc-linux:8919037945488388736:13:0)
[06:10:31.530] Build status: STARTED
[06:10:31.530] Scheduling timer "check-buildbucket-build-status" (dart/vm-gcc-linux:8919037945488388736:14:0) after 8m52s
[06:19:23.651] Handling timer "check-buildbucket-build-status" (dart/vm-gcc-linux:8919037945488388736:14:0)
[06:19:23.670] Build status: STARTED
[06:19:23.670] Scheduling timer "check-buildbucket-build-status" (dart/vm-gcc-linux:8919037945488388736:15:0) after 1m36s
[06:20:59.673] Handling timer "check-buildbucket-build-status" (dart/vm-gcc-linux:8919037945488388736:15:0)
[06:20:59.693] Build status: STARTED
[06:20:59.693] Scheduling timer "check-buildbucket-build-status" (dart/vm-gcc-linux:8919037945488388736:16:0) after 8m31s
[06:29:31.026] Handling timer "check-buildbucket-build-status" (dart/vm-gcc-linux:8919037945488388736:16:0)
[06:29:31.047] Build status: STARTED
[06:29:31.047] Scheduling timer "check-buildbucket-build-status" (dart/vm-gcc-linux:8919037945488388736:17:0) after 3m19s
[06:32:50.088] Handling timer "check-buildbucket-build-status" (dart/vm-gcc-linux:8919037945488388736:17:0)
[06:32:50.114] Build status: STARTED
[06:32:50.114] Scheduling timer "check-buildbucket-build-status" (dart/vm-gcc-linux:8919037945488388736:18:0) after 7m39s
[06:40:29.134] Handling timer "check-buildbucket-build-status" (dart/vm-gcc-linux:8919037945488388736:18:0)
[06:40:29.188] Build status: STARTED
[06:40:29.188] Scheduling timer "check-buildbucket-build-status" (dart/vm-gcc-linux:8919037945488388736:19:0) after 7m22s
[06:47:51.495] Handling timer "check-buildbucket-build-status" (dart/vm-gcc-linux:8919037945488388736:19:0)
[06:47:51.531] Build status: STARTED
[06:47:51.531] Scheduling timer "check-buildbucket-build-status" (dart/vm-gcc-linux:8919037945488388736:20:0) after 8m53s
[06:56:44.770] Handling timer "check-buildbucket-build-status" (dart/vm-gcc-linux:8919037945488388736:20:0)
[06:56:44.802] Build status: STARTED
[06:56:44.802] Scheduling timer "check-buildbucket-build-status" (dart/vm-gcc-linux:8919037945488388736:21:0) after 9m4s
[07:05:49.095] Handling timer "check-buildbucket-build-status" (dart/vm-gcc-linux:8919037945488388736:21:0)
[07:05:49.132] Build status: STARTED
[07:05:49.132] Scheduling timer "check-buildbucket-build-status" (dart/vm-gcc-linux:8919037945488388736:22:0) after 8m10s
[07:13:59.188] Handling timer "check-buildbucket-build-status" (dart/vm-gcc-linux:8919037945488388736:22:0)
[07:13:59.267] Build status: STARTED
[07:13:59.267] Scheduling timer "check-buildbucket-build-status" (dart/vm-gcc-linux:8919037945488388736:23:0) after 3m37s
[07:17:36.383] Handling timer "check-buildbucket-build-status" (dart/vm-gcc-linux:8919037945488388736:23:0)
[07:17:36.400] Build status: STARTED
[07:17:36.400] Scheduling timer "check-buildbucket-build-status" (dart/vm-gcc-linux:8919037945488388736:24:0) after 7m12s
[07:24:49.032] Handling timer "check-buildbucket-build-status" (dart/vm-gcc-linux:8919037945488388736:24:0)
[07:24:49.123] Build status: STARTED
[07:24:49.123] Scheduling timer "check-buildbucket-build-status" (dart/vm-gcc-linux:8919037945488388736:25:0) after 6m9s
[07:30:58.143] Handling timer "check-buildbucket-build-status" (dart/vm-gcc-linux:8919037945488388736:25:0)
[07:30:58.166] Build status: STARTED
[07:30:58.166] Scheduling timer "check-buildbucket-build-status" (dart/vm-gcc-linux:8919037945488388736:26:0) after 5m32s
[07:36:30.182] Handling timer "check-buildbucket-build-status" (dart/vm-gcc-linux:8919037945488388736:26:0)
[07:36:30.205] Build status: STARTED
[07:36:30.206] Scheduling timer "check-buildbucket-build-status" (dart/vm-gcc-linux:8919037945488388736:27:0) after 8m14s
[07:44:44.237] Handling timer "check-buildbucket-build-status" (dart/vm-gcc-linux:8919037945488388736:27:0)
[07:44:44.266] Build status: STARTED
[07:44:44.266] Scheduling timer "check-buildbucket-build-status" (dart/vm-gcc-linux:8919037945488388736:28:0) after 4m26s
[07:49:10.392] Handling timer "check-buildbucket-build-status" (dart/vm-gcc-linux:8919037945488388736:28:0)
[07:49:10.429] Build status: STARTED
[07:49:10.429] Scheduling timer "check-buildbucket-build-status" (dart/vm-gcc-linux:8919037945488388736:29:0) after 6m6s
[07:49:54.496] Received PubSub notification, asking Buildbucket for the build status
[07:49:54.539] Build:
{
"id": "8753607883301413409",
"builder": {
"project": "dart",
"bucket": "ci.sandbox",
"builder": "vm-gcc-linux"
},
"number": 289,
"createdBy": "project:dart",
"createTime": "2024-03-13T05:00:08.012239681Z",
"startTime": "2024-03-13T05:00:09.694807Z",
"endTime": "2024-03-13T07:49:52.673618Z",
"updateTime": "2024-03-13T07:49:52.673618Z",
"status": "SUCCESS",
"input": {
"gitilesCommit": {
"host": "dart.googlesource.com",
"project": "sdk",
"id": "e2e6ee8b0264ef1809462033100b60fbeff148c0",
"ref": "refs/heads/main"
}
}
}
[07:49:54.539] Invocation finished in 2h49m47.997315156s with status SUCCEEDED