[04:06:06.332] New invocation is queued and will start shortly
[04:06:07.415] Starting the invocation (attempt 1)
[04:06:07.456] Preparing PubSub topic for "https://cr-buildbucket-dev.appspot.com"
[04:06:07.456] PubSub topic is "projects/luci-scheduler-dev/topics/scheduler.buildbucket.cr-buildbucket-dev~appspot.gserviceaccount.com"
[04:06:07.456] Buildbucket request:
{
"bucket": "luci.infra.ci",
"client_operation_id": "9040531875059004096",
"parameters_json": "{\"builder_name\":\"infra-continuous-win10-64\",\"properties\":{\"$recipe_engine/scheduler\":{\"hostname\":\"luci-scheduler-dev.appspot.com\",\"triggers\":[{\"gitiles\":{\"ref\":\"refs/heads/master\",\"repo\":\"https://chromium.googlesource.com/infra/infra\",\"revision\":\"e11748c0890e50dc7c7e2766ae99f919ad110645\"},\"id\":\"https://chromium.googlesource.com/infra/infra/+/refs/heads/master@e11748c0890e50dc7c7e2766ae99f919ad110645\",\"title\":\"e11748c0890e50dc7c7e2766ae99f919ad110645\",\"url\":\"https://chromium.googlesource.com/infra/infra/+/e11748c0890e50dc7c7e2766ae99f919ad110645\"},{\"gitiles\":{\"ref\":\"refs/heads/master\",\"repo\":\"https://chromium.googlesource.com/infra/infra\",\"revision\":\"472f19415f39dbaffe7f078fba56e7df539bd65c\"},\"id\":\"https://chromium.googlesource.com/infra/infra/+/refs/heads/master@472f19415f39dbaffe7f078fba56e7df539bd65c\",\"title\":\"472f19415f39dbaffe7f078fba56e7df539bd65c\",\"url\":\"https://chromium.googlesource.com/infra/infra/+/472f19415f39dbaffe7f078fba56e7df539bd65c\"},{\"gitiles\":{\"ref\":\"refs/heads/master\",\"repo\":\"https://chromium.googlesource.com/infra/infra\",\"revision\":\"2893789b314ddce11666151fea1253dacb3dd1b9\"},\"id\":\"https://chromium.googlesource.com/infra/infra/+/refs/heads/master@2893789b314ddce11666151fea1253dacb3dd1b9\",\"title\":\"2893789b314ddce11666151fea1253dacb3dd1b9\",\"url\":\"https://chromium.googlesource.com/infra/infra/+/2893789b314ddce11666151fea1253dacb3dd1b9\"},{\"gitiles\":{\"ref\":\"refs/heads/master\",\"repo\":\"https://chromium.googlesource.com/infra/infra\",\"revision\":\"2112a26bd6feb34cbcce2b60820f667dff9bf0bf\"},\"id\":\"https://chromium.googlesource.com/infra/infra/+/refs/heads/master@2112a26bd6feb34cbcce2b60820f667dff9bf0bf\",\"title\":\"2112a26bd6feb34cbcce2b60820f667dff9bf0bf\",\"url\":\"https://chromium.googlesource.com/infra/infra/+/2112a26bd6feb34cbcce2b60820f667dff9bf0bf\"},{\"gitiles\":{\"ref\":\"refs/heads/master\",\"repo\":\"https://chromium.googlesource.com/infra/infra\",\"revision\":\"f530367d95f7db21306a1f17d259fec85a3659d3\"},\"id\":\"https://chromium.googlesource.com/infra/infra/+/refs/heads/master@f530367d95f7db21306a1f17d259fec85a3659d3\",\"title\":\"f530367d95f7db21306a1f17d259fec85a3659d3\",\"url\":\"https://chromium.googlesource.com/infra/infra/+/f530367d95f7db21306a1f17d259fec85a3659d3\"},{\"gitiles\":{\"ref\":\"refs/heads/master\",\"repo\":\"https://chromium.googlesource.com/infra/infra\",\"revision\":\"ec9a5ef9ee047c765430f3717a17d9e9485a4ff1\"},\"id\":\"https://chromium.googlesource.com/infra/infra/+/refs/heads/master@ec9a5ef9ee047c765430f3717a17d9e9485a4ff1\",\"title\":\"ec9a5ef9ee047c765430f3717a17d9e9485a4ff1\",\"url\":\"https://chromium.googlesource.com/infra/infra/+/ec9a5ef9ee047c765430f3717a17d9e9485a4ff1\"},{\"gitiles\":{\"ref\":\"refs/heads/master\",\"repo\":\"https://chromium.googlesource.com/infra/infra\",\"revision\":\"710819a3ae2c46308f01edd2fe20f511e8e6fd1d\"},\"id\":\"https://chromium.googlesource.com/infra/infra/+/refs/heads/master@710819a3ae2c46308f01edd2fe20f511e8e6fd1d\",\"title\":\"710819a3ae2c46308f01edd2fe20f511e8e6fd1d\",\"url\":\"https://chromium.googlesource.com/infra/infra/+/710819a3ae2c46308f01edd2fe20f511e8e6fd1d\"},{\"gitiles\":{\"ref\":\"refs/heads/master\",\"repo\":\"https://chromium.googlesource.com/infra/infra\",\"revision\":\"50cb08ab67f43bdb270041341dc979316864e8ad\"},\"id\":\"https://chromium.googlesource.com/infra/infra/+/refs/heads/master@50cb08ab67f43bdb270041341dc979316864e8ad\",\"title\":\"50cb08ab67f43bdb270041341dc979316864e8ad\",\"url\":\"https://chromium.googlesource.com/infra/infra/+/50cb08ab67f43bdb270041341dc979316864e8ad\"},{\"gitiles\":{\"ref\":\"refs/heads/master\",\"repo\":\"https://chromium.googlesource.com/infra/infra\",\"revision\":\"262e404831dad888edc7c78b857effb12dee999d\"},\"id\":\"https://chromium.googlesource.com/infra/infra/+/refs/heads/master@262e404831dad888edc7c78b857effb12dee999d\",\"title\":\"262e404831dad888edc7c78b857effb12dee999d\",\"url\":\"https://chromium.googlesource.com/infra/infra/+/262e404831dad888edc7c78b857effb12dee999d\"},{\"gitiles\":{\"ref\":\"refs/heads/master\",\"repo\":\"https://chromium.googlesource.com/infra/infra\",\"revision\":\"9afd191689d5229b23fa921b99a889c102900478\"},\"id\":\"https://chromium.googlesource.com/infra/infra/+/refs/heads/master@9afd191689d5229b23fa921b99a889c102900478\",\"title\":\"9afd191689d5229b23fa921b99a889c102900478\",\"url\":\"https://chromium.googlesource.com/infra/infra/+/9afd191689d5229b23fa921b99a889c102900478\"},{\"gitiles\":{\"ref\":\"refs/heads/master\",\"repo\":\"https://chromium.googlesource.com/infra/infra\",\"revision\":\"f5220afc49a9f0c066e0c436117d0bd43e92daab\"},\"id\":\"https://chromium.googlesource.com/infra/infra/+/refs/heads/master@f5220afc49a9f0c066e0c436117d0bd43e92daab\",\"title\":\"f5220afc49a9f0c066e0c436117d0bd43e92daab\",\"url\":\"https://chromium.googlesource.com/infra/infra/+/f5220afc49a9f0c066e0c436117d0bd43e92daab\"},{\"gitiles\":{\"ref\":\"refs/heads/master\",\"repo\":\"https://chromium.googlesource.com/infra/infra\",\"revision\":\"6c76741f2c8031bef6a19282a17b1d113bf3273e\"},\"id\":\"https://chromium.googlesource.com/infra/infra/+/refs/heads/master@6c76741f2c8031bef6a19282a17b1d113bf3273e\",\"title\":\"6c76741f2c8031bef6a19282a17b1d113bf3273e\",\"url\":\"https://chromium.googlesource.com/infra/infra/+/6c76741f2c8031bef6a19282a17b1d113bf3273e\"}]},\"branch\":\"refs/heads/master\",\"repository\":\"https://chromium.googlesource.com/infra/infra\",\"revision\":\"6c76741f2c8031bef6a19282a17b1d113bf3273e\"}}",
"pubsub_callback": {
"auth_token": "...",
"topic": "projects/luci-scheduler-dev/topics/scheduler.buildbucket.cr-buildbucket-dev~appspot.gserviceaccount.com"
},
"tags": [
"builder:infra-continuous-win10-64",
"scheduler_invocation_id:9040531875059004096",
"scheduler_job_id:infra/infra-continuous-win10-64",
"user_agent:luci-scheduler-dev",
"buildset:commit/git/6c76741f2c8031bef6a19282a17b1d113bf3273e",
"buildset:commit/gitiles/chromium.googlesource.com/infra/infra/+/6c76741f2c8031bef6a19282a17b1d113bf3273e",
"gitiles_ref:refs/heads/master"
]
}
[04:06:08.710] Buildbucket response:
{
"build": {
"bucket": "luci.infra.ci",
"canary_preference": "PROD",
"created_by": "project:infra",
"created_ts": "1594440367581976",
"id": "8875101813081567520",
"parameters_json": "{\"builder_name\": \"infra-continuous-win10-64\", \"properties\": {\"$recipe_engine/scheduler\": {\"hostname\": \"luci-scheduler-dev.appspot.com\", \"triggers\": [{\"gitiles\": {\"ref\": \"refs/heads/master\", \"repo\": \"https://chromium.googlesource.com/infra/infra\", \"revision\": \"e11748c0890e50dc7c7e2766ae99f919ad110645\"}, \"id\": \"https://chromium.googlesource.com/infra/infra/+/refs/heads/master@e11748c0890e50dc7c7e2766ae99f919ad110645\", \"title\": \"e11748c0890e50dc7c7e2766ae99f919ad110645\", \"url\": \"https://chromium.googlesource.com/infra/infra/+/e11748c0890e50dc7c7e2766ae99f919ad110645\"}, {\"gitiles\": {\"ref\": \"refs/heads/master\", \"repo\": \"https://chromium.googlesource.com/infra/infra\", \"revision\": \"472f19415f39dbaffe7f078fba56e7df539bd65c\"}, \"id\": \"https://chromium.googlesource.com/infra/infra/+/refs/heads/master@472f19415f39dbaffe7f078fba56e7df539bd65c\", \"title\": \"472f19415f39dbaffe7f078fba56e7df539bd65c\", \"url\": \"https://chromium.googlesource.com/infra/infra/+/472f19415f39dbaffe7f078fba56e7df539bd65c\"}, {\"gitiles\": {\"ref\": \"refs/heads/master\", \"repo\": \"https://chromium.googlesource.com/infra/infra\", \"revision\": \"2893789b314ddce11666151fea1253dacb3dd1b9\"}, \"id\": \"https://chromium.googlesource.com/infra/infra/+/refs/heads/master@2893789b314ddce11666151fea1253dacb3dd1b9\", \"title\": \"2893789b314ddce11666151fea1253dacb3dd1b9\", \"url\": \"https://chromium.googlesource.com/infra/infra/+/2893789b314ddce11666151fea1253dacb3dd1b9\"}, {\"gitiles\": {\"ref\": \"refs/heads/master\", \"repo\": \"https://chromium.googlesource.com/infra/infra\", \"revision\": \"2112a26bd6feb34cbcce2b60820f667dff9bf0bf\"}, \"id\": \"https://chromium.googlesource.com/infra/infra/+/refs/heads/master@2112a26bd6feb34cbcce2b60820f667dff9bf0bf\", \"title\": \"2112a26bd6feb34cbcce2b60820f667dff9bf0bf\", \"url\": \"https://chromium.googlesource.com/infra/infra/+/2112a26bd6feb34cbcce2b60820f667dff9bf0bf\"}, {\"gitiles\": {\"ref\": \"refs/heads/master\", \"repo\": \"https://chromium.googlesource.com/infra/infra\", \"revision\": \"f530367d95f7db21306a1f17d259fec85a3659d3\"}, \"id\": \"https://chromium.googlesource.com/infra/infra/+/refs/heads/master@f530367d95f7db21306a1f17d259fec85a3659d3\", \"title\": \"f530367d95f7db21306a1f17d259fec85a3659d3\", \"url\": \"https://chromium.googlesource.com/infra/infra/+/f530367d95f7db21306a1f17d259fec85a3659d3\"}, {\"gitiles\": {\"ref\": \"refs/heads/master\", \"repo\": \"https://chromium.googlesource.com/infra/infra\", \"revision\": \"ec9a5ef9ee047c765430f3717a17d9e9485a4ff1\"}, \"id\": \"https://chromium.googlesource.com/infra/infra/+/refs/heads/master@ec9a5ef9ee047c765430f3717a17d9e9485a4ff1\", \"title\": \"ec9a5ef9ee047c765430f3717a17d9e9485a4ff1\", \"url\": \"https://chromium.googlesource.com/infra/infra/+/ec9a5ef9ee047c765430f3717a17d9e9485a4ff1\"}, {\"gitiles\": {\"ref\": \"refs/heads/master\", \"repo\": \"https://chromium.googlesource.com/infra/infra\", \"revision\": \"710819a3ae2c46308f01edd2fe20f511e8e6fd1d\"}, \"id\": \"https://chromium.googlesource.com/infra/infra/+/refs/heads/master@710819a3ae2c46308f01edd2fe20f511e8e6fd1d\", \"title\": \"710819a3ae2c46308f01edd2fe20f511e8e6fd1d\", \"url\": \"https://chromium.googlesource.com/infra/infra/+/710819a3ae2c46308f01edd2fe20f511e8e6fd1d\"}, {\"gitiles\": {\"ref\": \"refs/heads/master\", \"repo\": \"https://chromium.googlesource.com/infra/infra\", \"revision\": \"50cb08ab67f43bdb270041341dc979316864e8ad\"}, \"id\": \"https://chromium.googlesource.com/infra/infra/+/refs/heads/master@50cb08ab67f43bdb270041341dc979316864e8ad\", \"title\": \"50cb08ab67f43bdb270041341dc979316864e8ad\", \"url\": \"https://chromium.googlesource.com/infra/infra/+/50cb08ab67f43bdb270041341dc979316864e8ad\"}, {\"gitiles\": {\"ref\": \"refs/heads/master\", \"repo\": \"https://chromium.googlesource.com/infra/infra\", \"revision\": \"262e404831dad888edc7c78b857effb12dee999d\"}, \"id\": \"https://chromium.googlesource.com/infra/infra/+/refs/heads/master@262e404831dad888edc7c78b857effb12dee999d\", \"title\": \"262e404831dad888edc7c78b857effb12dee999d\", \"url\": \"https://chromium.googlesource.com/infra/infra/+/262e404831dad888edc7c78b857effb12dee999d\"}, {\"gitiles\": {\"ref\": \"refs/heads/master\", \"repo\": \"https://chromium.googlesource.com/infra/infra\", \"revision\": \"9afd191689d5229b23fa921b99a889c102900478\"}, \"id\": \"https://chromium.googlesource.com/infra/infra/+/refs/heads/master@9afd191689d5229b23fa921b99a889c102900478\", \"title\": \"9afd191689d5229b23fa921b99a889c102900478\", \"url\": \"https://chromium.googlesource.com/infra/infra/+/9afd191689d5229b23fa921b99a889c102900478\"}, {\"gitiles\": {\"ref\": \"refs/heads/master\", \"repo\": \"https://chromium.googlesource.com/infra/infra\", \"revision\": \"f5220afc49a9f0c066e0c436117d0bd43e92daab\"}, \"id\": \"https://chromium.googlesource.com/infra/infra/+/refs/heads/master@f5220afc49a9f0c066e0c436117d0bd43e92daab\", \"title\": \"f5220afc49a9f0c066e0c436117d0bd43e92daab\", \"url\": \"https://chromium.googlesource.com/infra/infra/+/f5220afc49a9f0c066e0c436117d0bd43e92daab\"}, {\"gitiles\": {\"ref\": \"refs/heads/master\", \"repo\": \"https://chromium.googlesource.com/infra/infra\", \"revision\": \"6c76741f2c8031bef6a19282a17b1d113bf3273e\"}, \"id\": \"https://chromium.googlesource.com/infra/infra/+/refs/heads/master@6c76741f2c8031bef6a19282a17b1d113bf3273e\", \"title\": \"6c76741f2c8031bef6a19282a17b1d113bf3273e\", \"url\": \"https://chromium.googlesource.com/infra/infra/+/6c76741f2c8031bef6a19282a17b1d113bf3273e\"}]}, \"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/infra/infra\", \"revision\": \"6c76741f2c8031bef6a19282a17b1d113bf3273e\"}}",
"project": "infra",
"result_details_json": "{\"properties\": {}}",
"service_account": "adhoc-testing@luci-token-server-dev.iam.gserviceaccount.com",
"status": "SCHEDULED",
"status_changed_ts": "1594440368470300",
"tags": [
"build_address:luci.infra.ci/infra-continuous-win10-64/17254",
"builder:infra-continuous-win10-64",
"buildset:commit/git/6c76741f2c8031bef6a19282a17b1d113bf3273e",
"buildset:commit/gitiles/chromium.googlesource.com/infra/infra/+/6c76741f2c8031bef6a19282a17b1d113bf3273e",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9040531875059004096",
"scheduler_job_id:infra/infra-continuous-win10-64",
"swarming_hostname:chromium-swarm-dev.appspot.com",
"swarming_tag:log_location:logdog://luci-logdog-dev.appspot.com/infra/buildbucket/cr-buildbucket-dev.appspot.com/8875101813081567520/+/annotations",
"swarming_tag:luci_project:infra",
"swarming_tag:recipe_name:infra_continuous",
"swarming_tag:recipe_package:infra/recipe_bundles/chromium.googlesource.com/infra/infra",
"swarming_task_id:",
"user_agent:luci-scheduler-dev"
],
"updated_ts": "1594440368470418",
"url": "https://luci-milo-dev.appspot.com/b/8875101813081567520",
"utcnow_ts": "1594440368702380"
}
}
[04:06:08.710] Task URL: https://luci-milo-dev.appspot.com/b/8875101813081567520
[04:06:08.710] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9040531875059004096:2:0) after 1m0s
[04:07:08.732] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9040531875059004096:2:0)
[04:07:08.732] Timer tick, asking Buildbucket for the build status
[04:07:08.983] Build 8875101813081567520: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[04:07:08.983] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9040531875059004096:3:0) after 1m0s
[04:08:09.029] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9040531875059004096:3:0)
[04:08:09.029] Timer tick, asking Buildbucket for the build status
[04:08:09.253] Build 8875101813081567520: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[04:08:09.253] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9040531875059004096:4:0) after 1m0s
[04:09:09.288] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9040531875059004096:4:0)
[04:09:09.288] Timer tick, asking Buildbucket for the build status
[04:09:09.638] Build 8875101813081567520: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[04:09:09.638] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9040531875059004096:5:0) after 1m0s
[04:10:09.677] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9040531875059004096:5:0)
[04:10:09.677] Timer tick, asking Buildbucket for the build status
[04:10:09.943] Build 8875101813081567520: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[04:10:09.943] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9040531875059004096:6:0) after 1m0s
[04:11:09.969] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9040531875059004096:6:0)
[04:11:09.969] Timer tick, asking Buildbucket for the build status
[04:11:10.153] Build 8875101813081567520: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[04:11:10.153] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9040531875059004096:7:0) after 1m0s
[04:12:10.179] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9040531875059004096:7:0)
[04:12:10.179] Timer tick, asking Buildbucket for the build status
[04:12:10.362] Build 8875101813081567520: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[04:12:10.362] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9040531875059004096:8:0) after 1m0s
[04:13:10.427] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9040531875059004096:8:0)
[04:13:10.427] Timer tick, asking Buildbucket for the build status
[04:13:10.646] Build 8875101813081567520: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[04:13:10.646] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9040531875059004096:9:0) after 1m0s
[04:14:10.668] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9040531875059004096:9:0)
[04:14:10.668] Timer tick, asking Buildbucket for the build status
[04:14:10.830] Build 8875101813081567520: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[04:14:10.830] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9040531875059004096:10:0) after 1m0s
[04:15:10.948] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9040531875059004096:10:0)
[04:15:10.948] Timer tick, asking Buildbucket for the build status
[04:15:11.126] Build 8875101813081567520: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[04:15:11.126] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9040531875059004096:11:0) after 1m0s
[04:16:11.217] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9040531875059004096:11:0)
[04:16:11.217] Timer tick, asking Buildbucket for the build status
[04:16:11.398] Build 8875101813081567520: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[04:16:11.398] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9040531875059004096:12:0) after 1m0s
[04:17:11.445] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9040531875059004096:12:0)
[04:17:11.445] Timer tick, asking Buildbucket for the build status
[04:17:11.596] Build 8875101813081567520: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[04:17:11.596] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9040531875059004096:13:0) after 1m0s
[04:18:11.635] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9040531875059004096:13:0)
[04:18:11.635] Timer tick, asking Buildbucket for the build status
[04:18:11.802] Build 8875101813081567520: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[04:18:11.803] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9040531875059004096:14:0) after 1m0s
[04:19:11.830] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9040531875059004096:14:0)
[04:19:11.830] Timer tick, asking Buildbucket for the build status
[04:19:11.970] Build 8875101813081567520: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[04:19:11.970] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9040531875059004096:15:0) after 1m0s
[04:20:12.048] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9040531875059004096:15:0)
[04:20:12.049] Timer tick, asking Buildbucket for the build status
[04:20:12.269] Build 8875101813081567520: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[04:20:12.269] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9040531875059004096:16:0) after 1m0s
[04:21:12.297] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9040531875059004096:16:0)
[04:21:12.297] Timer tick, asking Buildbucket for the build status
[04:21:12.491] Build 8875101813081567520: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[04:21:12.491] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9040531875059004096:17:0) after 1m0s
[04:22:12.515] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9040531875059004096:17:0)
[04:22:12.515] Timer tick, asking Buildbucket for the build status
[04:22:12.698] Build 8875101813081567520: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[04:22:12.698] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9040531875059004096:18:0) after 1m0s
[04:23:12.780] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9040531875059004096:18:0)
[04:23:12.780] Timer tick, asking Buildbucket for the build status
[04:23:13.001] Build 8875101813081567520: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[04:23:13.001] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9040531875059004096:19:0) after 1m0s
[04:24:13.122] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9040531875059004096:19:0)
[04:24:13.122] Timer tick, asking Buildbucket for the build status
[04:24:13.397] Build 8875101813081567520: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[04:24:13.397] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9040531875059004096:20:0) after 1m0s
[04:25:13.419] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9040531875059004096:20:0)
[04:25:13.420] Timer tick, asking Buildbucket for the build status
[04:25:13.644] Build 8875101813081567520: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[04:25:13.644] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9040531875059004096:21:0) after 1m0s
[04:26:13.666] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9040531875059004096:21:0)
[04:26:13.666] Timer tick, asking Buildbucket for the build status
[04:26:13.919] Build 8875101813081567520: status "SCHEDULED", result "", failure_reason "", cancelation_reason ""
[04:26:13.919] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9040531875059004096:22:0) after 1m0s
[04:26:36.814] Received PubSub notification, asking Buildbucket for the build status
[04:26:36.937] Build 8875101813081567520: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:27:14.029] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9040531875059004096:22:0)
[04:27:14.029] Timer tick, asking Buildbucket for the build status
[04:27:14.222] Build 8875101813081567520: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:27:14.222] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9040531875059004096:24:0) after 1m0s
[04:28:14.257] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9040531875059004096:24:0)
[04:28:14.257] Timer tick, asking Buildbucket for the build status
[04:28:14.517] Build 8875101813081567520: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:28:14.517] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9040531875059004096:25:0) after 1m0s
[04:29:14.538] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9040531875059004096:25:0)
[04:29:14.538] Timer tick, asking Buildbucket for the build status
[04:29:14.734] Build 8875101813081567520: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:29:14.734] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9040531875059004096:26:0) after 1m0s
[04:30:14.821] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9040531875059004096:26:0)
[04:30:14.821] Timer tick, asking Buildbucket for the build status
[04:30:15.099] Build 8875101813081567520: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:30:15.099] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9040531875059004096:27:0) after 1m0s
[04:31:15.166] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9040531875059004096:27:0)
[04:31:15.166] Timer tick, asking Buildbucket for the build status
[04:31:15.404] Build 8875101813081567520: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:31:15.404] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9040531875059004096:28:0) after 1m0s
[04:32:15.455] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9040531875059004096:28:0)
[04:32:15.455] Timer tick, asking Buildbucket for the build status
[04:32:15.695] Build 8875101813081567520: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:32:15.695] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9040531875059004096:29:0) after 1m0s
[04:33:15.731] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9040531875059004096:29:0)
[04:33:15.731] Timer tick, asking Buildbucket for the build status
[04:33:15.935] Build 8875101813081567520: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:33:15.935] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9040531875059004096:30:0) after 1m0s
[04:34:16.006] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9040531875059004096:30:0)
[04:34:16.006] Timer tick, asking Buildbucket for the build status
[04:34:16.262] Build 8875101813081567520: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:34:16.262] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9040531875059004096:31:0) after 1m0s
[04:35:16.290] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9040531875059004096:31:0)
[04:35:16.290] Timer tick, asking Buildbucket for the build status
[04:35:16.528] Build 8875101813081567520: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:35:16.528] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9040531875059004096:32:0) after 1m0s
[04:36:16.621] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9040531875059004096:32:0)
[04:36:16.621] Timer tick, asking Buildbucket for the build status
[04:36:16.838] Build 8875101813081567520: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:36:16.838] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9040531875059004096:33:0) after 1m0s
[04:37:16.867] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9040531875059004096:33:0)
[04:37:16.867] Timer tick, asking Buildbucket for the build status
[04:37:17.098] Build 8875101813081567520: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:37:17.098] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9040531875059004096:34:0) after 1m0s
[04:38:17.145] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9040531875059004096:34:0)
[04:38:17.145] Timer tick, asking Buildbucket for the build status
[04:38:17.320] Build 8875101813081567520: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:38:17.320] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9040531875059004096:35:0) after 1m0s
[04:39:17.344] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9040531875059004096:35:0)
[04:39:17.344] Timer tick, asking Buildbucket for the build status
[04:39:17.559] Build 8875101813081567520: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:39:17.559] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9040531875059004096:36:0) after 1m0s
[04:40:17.601] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9040531875059004096:36:0)
[04:40:17.601] Timer tick, asking Buildbucket for the build status
[04:40:17.812] Build 8875101813081567520: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:40:17.812] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9040531875059004096:37:0) after 1m0s
[04:41:17.838] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9040531875059004096:37:0)
[04:41:17.838] Timer tick, asking Buildbucket for the build status
[04:41:18.020] Build 8875101813081567520: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:41:18.020] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9040531875059004096:38:0) after 1m0s
[04:42:18.054] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9040531875059004096:38:0)
[04:42:18.054] Timer tick, asking Buildbucket for the build status
[04:42:18.238] Build 8875101813081567520: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:42:18.238] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9040531875059004096:39:0) after 1m0s
[04:43:18.303] Handling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9040531875059004096:39:0)
[04:43:18.303] Timer tick, asking Buildbucket for the build status
[04:43:18.509] Build 8875101813081567520: status "STARTED", result "", failure_reason "", cancelation_reason ""
[04:43:18.509] Scheduling timer "check-buildbucket-build-status" (infra/infra-continuous-win10-64:9040531875059004096:40:0) after 1m0s
[04:43:40.837] Received PubSub notification, asking Buildbucket for the build status
[04:43:40.954] Build 8875101813081567520: status "COMPLETED", result "SUCCESS", failure_reason "", cancelation_reason ""
[04:43:40.954] Buildbucket build:
{
"build": {
"bucket": "luci.infra.ci",
"canary_preference": "PROD",
"completed_ts": "1594442619070739",
"created_by": "project:infra",
"created_ts": "1594440367581976",
"id": "8875101813081567520",
"parameters_json": "{\"builder_name\": \"infra-continuous-win10-64\", \"properties\": {\"$recipe_engine/scheduler\": {\"hostname\": \"luci-scheduler-dev.appspot.com\", \"triggers\": [{\"gitiles\": {\"ref\": \"refs/heads/master\", \"repo\": \"https://chromium.googlesource.com/infra/infra\", \"revision\": \"e11748c0890e50dc7c7e2766ae99f919ad110645\"}, \"id\": \"https://chromium.googlesource.com/infra/infra/+/refs/heads/master@e11748c0890e50dc7c7e2766ae99f919ad110645\", \"title\": \"e11748c0890e50dc7c7e2766ae99f919ad110645\", \"url\": \"https://chromium.googlesource.com/infra/infra/+/e11748c0890e50dc7c7e2766ae99f919ad110645\"}, {\"gitiles\": {\"ref\": \"refs/heads/master\", \"repo\": \"https://chromium.googlesource.com/infra/infra\", \"revision\": \"472f19415f39dbaffe7f078fba56e7df539bd65c\"}, \"id\": \"https://chromium.googlesource.com/infra/infra/+/refs/heads/master@472f19415f39dbaffe7f078fba56e7df539bd65c\", \"title\": \"472f19415f39dbaffe7f078fba56e7df539bd65c\", \"url\": \"https://chromium.googlesource.com/infra/infra/+/472f19415f39dbaffe7f078fba56e7df539bd65c\"}, {\"gitiles\": {\"ref\": \"refs/heads/master\", \"repo\": \"https://chromium.googlesource.com/infra/infra\", \"revision\": \"2893789b314ddce11666151fea1253dacb3dd1b9\"}, \"id\": \"https://chromium.googlesource.com/infra/infra/+/refs/heads/master@2893789b314ddce11666151fea1253dacb3dd1b9\", \"title\": \"2893789b314ddce11666151fea1253dacb3dd1b9\", \"url\": \"https://chromium.googlesource.com/infra/infra/+/2893789b314ddce11666151fea1253dacb3dd1b9\"}, {\"gitiles\": {\"ref\": \"refs/heads/master\", \"repo\": \"https://chromium.googlesource.com/infra/infra\", \"revision\": \"2112a26bd6feb34cbcce2b60820f667dff9bf0bf\"}, \"id\": \"https://chromium.googlesource.com/infra/infra/+/refs/heads/master@2112a26bd6feb34cbcce2b60820f667dff9bf0bf\", \"title\": \"2112a26bd6feb34cbcce2b60820f667dff9bf0bf\", \"url\": \"https://chromium.googlesource.com/infra/infra/+/2112a26bd6feb34cbcce2b60820f667dff9bf0bf\"}, {\"gitiles\": {\"ref\": \"refs/heads/master\", \"repo\": \"https://chromium.googlesource.com/infra/infra\", \"revision\": \"f530367d95f7db21306a1f17d259fec85a3659d3\"}, \"id\": \"https://chromium.googlesource.com/infra/infra/+/refs/heads/master@f530367d95f7db21306a1f17d259fec85a3659d3\", \"title\": \"f530367d95f7db21306a1f17d259fec85a3659d3\", \"url\": \"https://chromium.googlesource.com/infra/infra/+/f530367d95f7db21306a1f17d259fec85a3659d3\"}, {\"gitiles\": {\"ref\": \"refs/heads/master\", \"repo\": \"https://chromium.googlesource.com/infra/infra\", \"revision\": \"ec9a5ef9ee047c765430f3717a17d9e9485a4ff1\"}, \"id\": \"https://chromium.googlesource.com/infra/infra/+/refs/heads/master@ec9a5ef9ee047c765430f3717a17d9e9485a4ff1\", \"title\": \"ec9a5ef9ee047c765430f3717a17d9e9485a4ff1\", \"url\": \"https://chromium.googlesource.com/infra/infra/+/ec9a5ef9ee047c765430f3717a17d9e9485a4ff1\"}, {\"gitiles\": {\"ref\": \"refs/heads/master\", \"repo\": \"https://chromium.googlesource.com/infra/infra\", \"revision\": \"710819a3ae2c46308f01edd2fe20f511e8e6fd1d\"}, \"id\": \"https://chromium.googlesource.com/infra/infra/+/refs/heads/master@710819a3ae2c46308f01edd2fe20f511e8e6fd1d\", \"title\": \"710819a3ae2c46308f01edd2fe20f511e8e6fd1d\", \"url\": \"https://chromium.googlesource.com/infra/infra/+/710819a3ae2c46308f01edd2fe20f511e8e6fd1d\"}, {\"gitiles\": {\"ref\": \"refs/heads/master\", \"repo\": \"https://chromium.googlesource.com/infra/infra\", \"revision\": \"50cb08ab67f43bdb270041341dc979316864e8ad\"}, \"id\": \"https://chromium.googlesource.com/infra/infra/+/refs/heads/master@50cb08ab67f43bdb270041341dc979316864e8ad\", \"title\": \"50cb08ab67f43bdb270041341dc979316864e8ad\", \"url\": \"https://chromium.googlesource.com/infra/infra/+/50cb08ab67f43bdb270041341dc979316864e8ad\"}, {\"gitiles\": {\"ref\": \"refs/heads/master\", \"repo\": \"https://chromium.googlesource.com/infra/infra\", \"revision\": \"262e404831dad888edc7c78b857effb12dee999d\"}, \"id\": \"https://chromium.googlesource.com/infra/infra/+/refs/heads/master@262e404831dad888edc7c78b857effb12dee999d\", \"title\": \"262e404831dad888edc7c78b857effb12dee999d\", \"url\": \"https://chromium.googlesource.com/infra/infra/+/262e404831dad888edc7c78b857effb12dee999d\"}, {\"gitiles\": {\"ref\": \"refs/heads/master\", \"repo\": \"https://chromium.googlesource.com/infra/infra\", \"revision\": \"9afd191689d5229b23fa921b99a889c102900478\"}, \"id\": \"https://chromium.googlesource.com/infra/infra/+/refs/heads/master@9afd191689d5229b23fa921b99a889c102900478\", \"title\": \"9afd191689d5229b23fa921b99a889c102900478\", \"url\": \"https://chromium.googlesource.com/infra/infra/+/9afd191689d5229b23fa921b99a889c102900478\"}, {\"gitiles\": {\"ref\": \"refs/heads/master\", \"repo\": \"https://chromium.googlesource.com/infra/infra\", \"revision\": \"f5220afc49a9f0c066e0c436117d0bd43e92daab\"}, \"id\": \"https://chromium.googlesource.com/infra/infra/+/refs/heads/master@f5220afc49a9f0c066e0c436117d0bd43e92daab\", \"title\": \"f5220afc49a9f0c066e0c436117d0bd43e92daab\", \"url\": \"https://chromium.googlesource.com/infra/infra/+/f5220afc49a9f0c066e0c436117d0bd43e92daab\"}, {\"gitiles\": {\"ref\": \"refs/heads/master\", \"repo\": \"https://chromium.googlesource.com/infra/infra\", \"revision\": \"6c76741f2c8031bef6a19282a17b1d113bf3273e\"}, \"id\": \"https://chromium.googlesource.com/infra/infra/+/refs/heads/master@6c76741f2c8031bef6a19282a17b1d113bf3273e\", \"title\": \"6c76741f2c8031bef6a19282a17b1d113bf3273e\", \"url\": \"https://chromium.googlesource.com/infra/infra/+/6c76741f2c8031bef6a19282a17b1d113bf3273e\"}]}, \"branch\": \"refs/heads/master\", \"repository\": \"https://chromium.googlesource.com/infra/infra\", \"revision\": \"6c76741f2c8031bef6a19282a17b1d113bf3273e\"}}",
"project": "infra",
"result": "SUCCESS",
"result_details_json": "{\"properties\": {\"got_revision\": \"6c76741f2c8031bef6a19282a17b1d113bf3273e\", \"got_revision_cp\": \"refs/heads/master@{#33215}\"}, \"swarming\": {\"bot_dimensions\": {\"caches\": [\"builder_5de1032f0e9ef497433aad28840ee258c037976023b410f653133cee0ad04e2c_v2\", \"builder_a9c54e560aab64ffcab932ab26ad711a72ff73dbcd0bfe47f54d3e3349e5c381_v2\", \"git\", \"goma\", \"vpython\"], \"cores\": [\"8\"], \"cpu\": [\"x86\", \"x86-64\", \"x86-64-Broadwell_GCE\"], \"gce\": [\"1\"], \"gcp\": [\"google.com:chromecompute\"], \"gpu\": [\"none\"], \"id\": [\"dev-luci-chromium-ci-win10-0-2hs3\"], \"image\": [\"chrome-win10-1703-20070700-8a9e7990cc1\"], \"integrity\": [\"high\"], \"locale\": [\"en_US.cp1252\"], \"machine_type\": [\"n1-standard-8\"], \"os\": [\"Windows\", \"Windows-10\", \"Windows-10-15063\"], \"pool\": [\"luci.chromium.ci\"], \"python\": [\"2.7.13\"], \"server_version\": [\"5396-9bdf331\"], \"ssd\": [\"0\"], \"windows_client_version\": [\"10\"], \"zone\": [\"us\", \"us-west\", \"us-west1\", \"us-west1-c\"]}}}",
"service_account": "adhoc-testing@luci-token-server-dev.iam.gserviceaccount.com",
"started_ts": "1594441594114946",
"status": "COMPLETED",
"status_changed_ts": "1594442619539294",
"tags": [
"build_address:luci.infra.ci/infra-continuous-win10-64/17254",
"builder:infra-continuous-win10-64",
"buildset:commit/git/6c76741f2c8031bef6a19282a17b1d113bf3273e",
"buildset:commit/gitiles/chromium.googlesource.com/infra/infra/+/6c76741f2c8031bef6a19282a17b1d113bf3273e",
"gitiles_ref:refs/heads/master",
"scheduler_invocation_id:9040531875059004096",
"scheduler_job_id:infra/infra-continuous-win10-64",
"swarming_hostname:chromium-swarm-dev.appspot.com",
"swarming_tag:log_location:logdog://luci-logdog-dev.appspot.com/infra/buildbucket/cr-buildbucket-dev.appspot.com/8875101813081567520/+/annotations",
"swarming_tag:luci_project:infra",
"swarming_tag:os:Windows",
"swarming_tag:recipe_name:infra_continuous",
"swarming_tag:recipe_package:infra/recipe_bundles/chromium.googlesource.com/infra/infra",
"swarming_task_id:4d54decd0d861910",
"user_agent:luci-scheduler-dev"
],
"updated_ts": "1594442619616771",
"url": "https://luci-milo-dev.appspot.com/b/8875101813081567520",
"utcnow_ts": "1594442620943771"
}
}
[04:43:40.954] Invocation finished in 37m34.64211548s with status SUCCEEDED