[17:32:12.393] New invocation is queued and will start shortly
[17:32:13.409] Starting the invocation (attempt 1)
[17:32:13.436] Popped buildset tag "buildset:commit/gitiles/dart.googlesource.com/sdk/+/1baa0c5fd1f2dec2fb1384ae51ebb646b8c53f13"
[17:32:13.436] Popped gitiles commit info from properties and tags
[17:32:13.436] Preparing PubSub topic for "https://cr-buildbucket.appspot.com"
[17:32:13.436] PubSub topic is "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
[17:32:13.436] Buildbucket request:
{
"requestId": "8916544509515976256",
"builder": {
"project": "dart",
"bucket": "ci.sandbox",
"builder": "dart2js-win-chrome"
},
"properties": {
"$recipe_engine/scheduler": {
"hostname": "luci-scheduler.appspot.com",
"invocation": "8916544509515976256",
"job": "dart/dart2js-win-chrome",
"triggers": [
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://dart.googlesource.com/sdk",
"revision": "c1dc26ab8dc773c18e63fde2cc1fbd0b41dbcccf"
},
"id": "https://dart.googlesource.com/sdk/+/refs/heads/main@c1dc26ab8dc773c18e63fde2cc1fbd0b41dbcccf",
"title": "c1dc26ab8dc773c18e63fde2cc1fbd0b41dbcccf",
"url": "https://dart.googlesource.com/sdk/+/c1dc26ab8dc773c18e63fde2cc1fbd0b41dbcccf"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://dart.googlesource.com/sdk",
"revision": "5733a98f4e5e9417ec2d7adfac3d145460ad2071"
},
"id": "https://dart.googlesource.com/sdk/+/refs/heads/main@5733a98f4e5e9417ec2d7adfac3d145460ad2071",
"title": "5733a98f4e5e9417ec2d7adfac3d145460ad2071",
"url": "https://dart.googlesource.com/sdk/+/5733a98f4e5e9417ec2d7adfac3d145460ad2071"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://dart.googlesource.com/sdk",
"revision": "07c17fbb9ff0f808ba400589a3db33c4e79e01b4"
},
"id": "https://dart.googlesource.com/sdk/+/refs/heads/main@07c17fbb9ff0f808ba400589a3db33c4e79e01b4",
"title": "07c17fbb9ff0f808ba400589a3db33c4e79e01b4",
"url": "https://dart.googlesource.com/sdk/+/07c17fbb9ff0f808ba400589a3db33c4e79e01b4"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://dart.googlesource.com/sdk",
"revision": "718748825c278bef9828eb9be31711ce936b97f1"
},
"id": "https://dart.googlesource.com/sdk/+/refs/heads/main@718748825c278bef9828eb9be31711ce936b97f1",
"title": "718748825c278bef9828eb9be31711ce936b97f1",
"url": "https://dart.googlesource.com/sdk/+/718748825c278bef9828eb9be31711ce936b97f1"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://dart.googlesource.com/sdk",
"revision": "bb77a3944527c699c398f257057177f0cfe82c43"
},
"id": "https://dart.googlesource.com/sdk/+/refs/heads/main@bb77a3944527c699c398f257057177f0cfe82c43",
"title": "bb77a3944527c699c398f257057177f0cfe82c43",
"url": "https://dart.googlesource.com/sdk/+/bb77a3944527c699c398f257057177f0cfe82c43"
},
{
"gitiles": {
"ref": "refs/heads/main",
"repo": "https://dart.googlesource.com/sdk",
"revision": "1baa0c5fd1f2dec2fb1384ae51ebb646b8c53f13"
},
"id": "https://dart.googlesource.com/sdk/+/refs/heads/main@1baa0c5fd1f2dec2fb1384ae51ebb646b8c53f13",
"title": "1baa0c5fd1f2dec2fb1384ae51ebb646b8c53f13",
"url": "https://dart.googlesource.com/sdk/+/1baa0c5fd1f2dec2fb1384ae51ebb646b8c53f13"
}
]
}
},
"gitilesCommit": {
"host": "dart.googlesource.com",
"project": "sdk",
"id": "1baa0c5fd1f2dec2fb1384ae51ebb646b8c53f13",
"ref": "refs/heads/main"
},
"tags": [
{
"key": "scheduler_invocation_id",
"value": "8916544509515976256"
},
{
"key": "scheduler_job_id",
"value": "dart/dart2js-win-chrome"
},
{
"key": "user_agent",
"value": "luci-scheduler"
}
],
"notify": {
"pubsubTopic": "projects/luci-scheduler/topics/scheduler.buildbucket.cr-buildbucket~appspot.gserviceaccount.com"
}
}
[17:32:14.020] Scheduled build:
{
"id": "8751114447720500545",
"builder": {
"project": "dart",
"bucket": "ci.sandbox",
"builder": "dart2js-win-chrome"
},
"number": 4476,
"createdBy": "project:dart",
"createTime": "2024-04-09T17:32:13.485813488Z",
"updateTime": "2024-04-09T17:32:13.485813488Z",
"status": "SCHEDULED",
"input": {
"gitilesCommit": {
"host": "dart.googlesource.com",
"project": "sdk",
"id": "1baa0c5fd1f2dec2fb1384ae51ebb646b8c53f13",
"ref": "refs/heads/main"
}
},
"canary": true
}
[17:32:14.020] Task URL: https://cr-buildbucket.appspot.com/build/8751114447720500545
[17:32:14.020] Scheduling timer "check-buildbucket-build-status" (dart/dart2js-win-chrome:8916544509515976256:2:0) after 2m44s
[17:32:14.145] Received PubSub notification, asking Buildbucket for the build status
[17:32:14.164] Build status: SCHEDULED
[17:32:22.104] Received PubSub notification, asking Buildbucket for the build status
[17:32:22.188] Build status: STARTED
[17:34:58.042] Handling timer "check-buildbucket-build-status" (dart/dart2js-win-chrome:8916544509515976256:2:0)
[17:34:58.104] Build status: STARTED
[17:34:58.104] Scheduling timer "check-buildbucket-build-status" (dart/dart2js-win-chrome:8916544509515976256:5:0) after 4m17s
[17:39:15.158] Handling timer "check-buildbucket-build-status" (dart/dart2js-win-chrome:8916544509515976256:5:0)
[17:39:15.194] Build status: STARTED
[17:39:15.194] Scheduling timer "check-buildbucket-build-status" (dart/dart2js-win-chrome:8916544509515976256:6:0) after 3m18s
[17:42:33.351] Handling timer "check-buildbucket-build-status" (dart/dart2js-win-chrome:8916544509515976256:6:0)
[17:42:33.663] Build status: STARTED
[17:42:33.663] Scheduling timer "check-buildbucket-build-status" (dart/dart2js-win-chrome:8916544509515976256:7:0) after 2m53s
[17:45:26.715] Handling timer "check-buildbucket-build-status" (dart/dart2js-win-chrome:8916544509515976256:7:0)
[17:45:26.784] Build status: STARTED
[17:45:26.784] Scheduling timer "check-buildbucket-build-status" (dart/dart2js-win-chrome:8916544509515976256:8:0) after 6m20s
[17:51:46.804] Handling timer "check-buildbucket-build-status" (dart/dart2js-win-chrome:8916544509515976256:8:0)
[17:51:46.834] Build status: STARTED
[17:51:46.834] Scheduling timer "check-buildbucket-build-status" (dart/dart2js-win-chrome:8916544509515976256:9:0) after 8m15s
[18:00:01.907] Handling timer "check-buildbucket-build-status" (dart/dart2js-win-chrome:8916544509515976256:9:0)
[18:00:01.983] Build status: STARTED
[18:00:01.983] Scheduling timer "check-buildbucket-build-status" (dart/dart2js-win-chrome:8916544509515976256:10:0) after 7m41s
[18:07:43.044] Handling timer "check-buildbucket-build-status" (dart/dart2js-win-chrome:8916544509515976256:10:0)
[18:07:43.165] Build status: STARTED
[18:07:43.165] Scheduling timer "check-buildbucket-build-status" (dart/dart2js-win-chrome:8916544509515976256:11:0) after 2m31s
[18:10:14.268] Handling timer "check-buildbucket-build-status" (dart/dart2js-win-chrome:8916544509515976256:11:0)
[18:10:14.305] Build status: STARTED
[18:10:14.306] Scheduling timer "check-buildbucket-build-status" (dart/dart2js-win-chrome:8916544509515976256:12:0) after 5m58s
[18:15:01.297] Received PubSub notification, asking Buildbucket for the build status
[18:15:01.316] Build:
{
"id": "8751114447720500545",
"builder": {
"project": "dart",
"bucket": "ci.sandbox",
"builder": "dart2js-win-chrome"
},
"number": 4476,
"createdBy": "project:dart",
"createTime": "2024-04-09T17:32:13.485813488Z",
"startTime": "2024-04-09T17:32:20.836276465Z",
"endTime": "2024-04-09T18:15:00.362436363Z",
"updateTime": "2024-04-09T18:15:00.362436363Z",
"status": "SUCCESS",
"input": {
"gitilesCommit": {
"host": "dart.googlesource.com",
"project": "sdk",
"id": "1baa0c5fd1f2dec2fb1384ae51ebb646b8c53f13",
"ref": "refs/heads/main"
}
},
"canary": true
}
[18:15:01.316] Invocation finished in 42m48.927274329s with status SUCCEEDED