2020-05-23T23:05:36.3179361Z ##[section]Starting: Job Linux
2020-05-23T23:05:36.5322320Z ##[section]Starting: Initialize job
2020-05-23T23:05:36.5333958Z Agent name: 'Azure Pipelines 3'
2020-05-23T23:05:36.5341788Z Agent machine name: 'fv-az193'
2020-05-23T23:05:36.5347421Z Current agent version: '2.169.0'
2020-05-23T23:05:36.5399258Z ##[group]Operating System
2020-05-23T23:05:36.5403366Z Ubuntu
2020-05-23T23:05:36.5406433Z 18.04.4
2020-05-23T23:05:36.5409355Z LTS
2020-05-23T23:05:36.5412197Z ##[endgroup]
2020-05-23T23:05:36.5416479Z ##[group]Virtual Environment
2020-05-23T23:05:36.5421909Z Environment: ubuntu-18.04
2020-05-23T23:05:36.5426839Z Version: 20200518.1
2020-05-23T23:05:36.5437311Z Included Software: https://github.com/actions/virtual-environments/blob/ubuntu18/20200518.1/images/linux/Ubuntu1804-README.md
2020-05-23T23:05:36.5447355Z ##[endgroup]
2020-05-23T23:05:36.5452896Z Current image version: '20200518.1'
2020-05-23T23:05:36.5463321Z Agent running as: 'vsts'
2020-05-23T23:05:36.5587303Z Prepare build directory.
2020-05-23T23:05:36.6198225Z Set build variables.
2020-05-23T23:05:36.6272835Z Download all required tasks.
2020-05-23T23:05:36.6445783Z Downloading task: UsePythonVersion (0.151.3)
2020-05-23T23:05:38.7376203Z Downloading task: CmdLine (2.164.1)
2020-05-23T23:05:38.9107570Z Checking job knob settings.
2020-05-23T23:05:38.9126271Z    Knob: AgentToolsDirectory = /opt/hostedtoolcache Source: ${AGENT_TOOLSDIRECTORY} 
2020-05-23T23:05:38.9148859Z    Knob: AgentPerflog = /home/vsts/perflog Source: ${VSTS_AGENT_PERFLOG} 
2020-05-23T23:05:38.9161203Z Finished checking job knob settings.
2020-05-23T23:05:39.0172686Z Plugin: 'Test Result Parser plugin' is running in background.
2020-05-23T23:05:39.0180759Z Plugin: 'Test File Publisher plugin' is running in background.
2020-05-23T23:05:39.0193115Z Start tracking orphan processes.
2020-05-23T23:05:39.0385794Z ##[section]Finishing: Initialize job
2020-05-23T23:05:39.1280673Z ##[section]Starting: Checkout pallets/click@refs/pull/1560/merge to s
2020-05-23T23:05:39.1532578Z ==============================================================================
2020-05-23T23:05:39.1555086Z Task         : Get sources
2020-05-23T23:05:39.1563452Z Description  : Get sources from a repository. Supports Git, TfsVC, and SVN repositories.
2020-05-23T23:05:39.1570687Z Version      : 1.0.0
2020-05-23T23:05:39.1575743Z Author       : Microsoft
2020-05-23T23:05:39.1583527Z Help         : [More Information](https://go.microsoft.com/fwlink/?LinkId=798199)
2020-05-23T23:05:39.1610123Z ==============================================================================
2020-05-23T23:05:39.7462160Z Syncing repository: pallets/click (GitHub)
2020-05-23T23:05:39.7496329Z ##[command]git version
2020-05-23T23:05:39.7534083Z git version 2.26.2
2020-05-23T23:05:39.7547320Z ##[command]git lfs version
2020-05-23T23:05:40.7237916Z git-lfs/2.11.0 (GitHub; linux amd64; go 1.13.4)
2020-05-23T23:05:40.7265270Z ##[command]git init "/home/vsts/work/1/s"
2020-05-23T23:05:40.7303552Z Initialized empty Git repository in /home/vsts/work/1/s/.git/
2020-05-23T23:05:40.7323288Z ##[command]git remote add origin https://github.com/pallets/click
2020-05-23T23:05:40.7381072Z ##[command]git config gc.auto 0
2020-05-23T23:05:40.7433904Z ##[command]git config --get-all http.https://github.com/pallets/click.extraheader
2020-05-23T23:05:40.7480200Z ##[command]git config --get-all http.proxy
2020-05-23T23:05:40.7550484Z ##[command]git -c http.extraheader="AUTHORIZATION: basic ***" fetch --force --tags --prune --progress --no-recurse-submodules origin +refs/heads/*:refs/remotes/origin/* +refs/pull/1560/merge:refs/remotes/pull/1560/merge
2020-05-23T23:05:40.7598193Z remote: Enumerating objects: 18, done.        
2020-05-23T23:05:40.7607606Z remote: Counting objects:   5% (1/18)        
2020-05-23T23:05:40.7616528Z remote: Counting objects:  11% (2/18)        
2020-05-23T23:05:40.7625517Z remote: Counting objects:  16% (3/18)        
2020-05-23T23:05:40.7634383Z remote: Counting objects:  22% (4/18)        
2020-05-23T23:05:40.7643298Z remote: Counting objects:  27% (5/18)        
2020-05-23T23:05:40.7652401Z remote: Counting objects:  33% (6/18)        
2020-05-23T23:05:40.7661836Z remote: Counting objects:  38% (7/18)        
2020-05-23T23:05:40.7670691Z remote: Counting objects:  44% (8/18)        
2020-05-23T23:05:40.7679461Z remote: Counting objects:  50% (9/18)        
2020-05-23T23:05:40.7688334Z remote: Counting objects:  55% (10/18)        
2020-05-23T23:05:40.7697289Z remote: Counting objects:  61% (11/18)        
2020-05-23T23:05:40.7706343Z remote: Counting objects:  66% (12/18)        
2020-05-23T23:05:40.7715291Z remote: Counting objects:  72% (13/18)        
2020-05-23T23:05:40.7724264Z remote: Counting objects:  77% (14/18)        
2020-05-23T23:05:40.7733192Z remote: Counting objects:  83% (15/18)        
2020-05-23T23:05:40.7742954Z remote: Counting objects:  88% (16/18)        
2020-05-23T23:05:40.7752562Z remote: Counting objects:  94% (17/18)        
2020-05-23T23:05:40.7761658Z remote: Counting objects: 100% (18/18)        
2020-05-23T23:05:40.7770930Z remote: Counting objects: 100% (18/18), done.        
2020-05-23T23:05:40.7781034Z remote: Compressing objects:   7% (1/14)        
2020-05-23T23:05:40.7790321Z remote: Compressing objects:  14% (2/14)        
2020-05-23T23:05:40.7801101Z remote: Compressing objects:  21% (3/14)        
2020-05-23T23:05:40.7810362Z remote: Compressing objects:  28% (4/14)        
2020-05-23T23:05:40.7819755Z remote: Compressing objects:  35% (5/14)        
2020-05-23T23:05:40.7829256Z remote: Compressing objects:  42% (6/14)        
2020-05-23T23:05:40.7838473Z remote: Compressing objects:  50% (7/14)        
2020-05-23T23:05:40.7847665Z remote: Compressing objects:  57% (8/14)        
2020-05-23T23:05:40.7856949Z remote: Compressing objects:  64% (9/14)        
2020-05-23T23:05:40.7866644Z remote: Compressing objects:  71% (10/14)        
2020-05-23T23:05:40.7876237Z remote: Compressing objects:  78% (11/14)        
2020-05-23T23:05:40.7885898Z remote: Compressing objects:  85% (12/14)        
2020-05-23T23:05:40.7895252Z remote: Compressing objects:  92% (13/14)        
2020-05-23T23:05:40.7905495Z remote: Compressing objects: 100% (14/14)        
2020-05-23T23:05:40.7915590Z remote: Compressing objects: 100% (14/14), done.        
2020-05-23T23:05:40.7924041Z Receiving objects:   0% (1/7139)
2020-05-23T23:05:40.7933692Z Receiving objects:   1% (72/7139)
2020-05-23T23:05:40.7942611Z Receiving objects:   2% (143/7139)
2020-05-23T23:05:40.7950774Z Receiving objects:   3% (215/7139)
2020-05-23T23:05:40.7957599Z Receiving objects:   4% (286/7139)
2020-05-23T23:05:40.7964893Z Receiving objects:   5% (357/7139)
2020-05-23T23:05:40.7971760Z Receiving objects:   6% (429/7139)
2020-05-23T23:05:40.7978467Z Receiving objects:   7% (500/7139)
2020-05-23T23:05:40.7985772Z Receiving objects:   8% (572/7139)
2020-05-23T23:05:40.7992517Z Receiving objects:   9% (643/7139)
2020-05-23T23:05:40.7999149Z Receiving objects:  10% (714/7139)
2020-05-23T23:05:40.8005701Z Receiving objects:  11% (786/7139)
2020-05-23T23:05:40.8012265Z Receiving objects:  12% (857/7139)
2020-05-23T23:05:40.8018827Z Receiving objects:  13% (929/7139)
2020-05-23T23:05:40.8025926Z Receiving objects:  14% (1000/7139)
2020-05-23T23:05:40.8032647Z Receiving objects:  15% (1071/7139)
2020-05-23T23:05:40.8039312Z Receiving objects:  16% (1143/7139)
2020-05-23T23:05:40.8046031Z Receiving objects:  17% (1214/7139)
2020-05-23T23:05:40.8053201Z Receiving objects:  18% (1286/7139)
2020-05-23T23:05:40.8060825Z Receiving objects:  19% (1357/7139)
2020-05-23T23:05:40.8067572Z Receiving objects:  20% (1428/7139)
2020-05-23T23:05:40.8074205Z Receiving objects:  21% (1500/7139)
2020-05-23T23:05:40.8081040Z Receiving objects:  22% (1571/7139)
2020-05-23T23:05:40.8087740Z Receiving objects:  23% (1642/7139)
2020-05-23T23:05:40.8094423Z Receiving objects:  24% (1714/7139)
2020-05-23T23:05:40.8101189Z Receiving objects:  25% (1785/7139)
2020-05-23T23:05:40.8108211Z Receiving objects:  26% (1857/7139)
2020-05-23T23:05:40.8114946Z Receiving objects:  27% (1928/7139)
2020-05-23T23:05:40.8121883Z Receiving objects:  28% (1999/7139)
2020-05-23T23:05:40.8128498Z Receiving objects:  29% (2071/7139)
2020-05-23T23:05:40.8134853Z Receiving objects:  30% (2142/7139)
2020-05-23T23:05:40.8143350Z Receiving objects:  31% (2214/7139)
2020-05-23T23:05:40.8151585Z Receiving objects:  32% (2285/7139)
2020-05-23T23:05:40.8158332Z Receiving objects:  33% (2356/7139)
2020-05-23T23:05:40.8164993Z Receiving objects:  34% (2428/7139)
2020-05-23T23:05:40.8171663Z Receiving objects:  35% (2499/7139)
2020-05-23T23:05:40.8178820Z Receiving objects:  36% (2571/7139)
2020-05-23T23:05:40.8185545Z Receiving objects:  37% (2642/7139)
2020-05-23T23:05:40.8191745Z Receiving objects:  38% (2713/7139)
2020-05-23T23:05:40.8198428Z Receiving objects:  39% (2785/7139)
2020-05-23T23:05:40.8205099Z Receiving objects:  40% (2856/7139)
2020-05-23T23:05:40.8212804Z Receiving objects:  41% (2927/7139)
2020-05-23T23:05:40.8219713Z Receiving objects:  42% (2999/7139)
2020-05-23T23:05:40.8226674Z Receiving objects:  43% (3070/7139)
2020-05-23T23:05:40.8233485Z Receiving objects:  44% (3142/7139)
2020-05-23T23:05:40.8240413Z Receiving objects:  45% (3213/7139)
2020-05-23T23:05:40.8247319Z Receiving objects:  46% (3284/7139)
2020-05-23T23:05:40.8254061Z Receiving objects:  47% (3356/7139)
2020-05-23T23:05:40.8262697Z Receiving objects:  48% (3427/7139)
2020-05-23T23:05:40.8269615Z Receiving objects:  49% (3499/7139)
2020-05-23T23:05:40.8276333Z Receiving objects:  50% (3570/7139)
2020-05-23T23:05:40.8283017Z Receiving objects:  51% (3641/7139)
2020-05-23T23:05:40.8289744Z Receiving objects:  52% (3713/7139)
2020-05-23T23:05:40.8296483Z Receiving objects:  53% (3784/7139)
2020-05-23T23:05:40.8303529Z Receiving objects:  54% (3856/7139)
2020-05-23T23:05:40.8310373Z Receiving objects:  55% (3927/7139)
2020-05-23T23:05:40.8317060Z Receiving objects:  56% (3998/7139)
2020-05-23T23:05:40.8324119Z Receiving objects:  57% (4070/7139)
2020-05-23T23:05:40.8330840Z Receiving objects:  58% (4141/7139)
2020-05-23T23:05:40.8337519Z Receiving objects:  59% (4213/7139)
2020-05-23T23:05:40.8344309Z Receiving objects:  60% (4284/7139)
2020-05-23T23:05:40.8351037Z Receiving objects:  61% (4355/7139)
2020-05-23T23:05:40.8358386Z Receiving objects:  62% (4427/7139)
2020-05-23T23:05:40.8365420Z Receiving objects:  63% (4498/7139)
2020-05-23T23:05:40.8372765Z Receiving objects:  64% (4569/7139)
2020-05-23T23:05:40.8379620Z Receiving objects:  65% (4641/7139)
2020-05-23T23:05:40.8386294Z Receiving objects:  66% (4712/7139)
2020-05-23T23:05:40.8393031Z Receiving objects:  67% (4784/7139)
2020-05-23T23:05:40.8399741Z Receiving objects:  68% (4855/7139)
2020-05-23T23:05:40.8406445Z Receiving objects:  69% (4926/7139)
2020-05-23T23:05:40.8413138Z Receiving objects:  70% (4998/7139)
2020-05-23T23:05:40.8419897Z Receiving objects:  71% (5069/7139)
2020-05-23T23:05:40.8426603Z Receiving objects:  72% (5141/7139)
2020-05-23T23:05:40.8433926Z Receiving objects:  73% (5212/7139)
2020-05-23T23:05:40.8440705Z Receiving objects:  74% (5283/7139)
2020-05-23T23:05:40.8447415Z Receiving objects:  75% (5355/7139)
2020-05-23T23:05:40.8454114Z Receiving objects:  76% (5426/7139)
2020-05-23T23:05:40.8461032Z Receiving objects:  77% (5498/7139)
2020-05-23T23:05:40.8467712Z Receiving objects:  78% (5569/7139)
2020-05-23T23:05:40.8474366Z Receiving objects:  79% (5640/7139)
2020-05-23T23:05:40.8481067Z Receiving objects:  80% (5712/7139)
2020-05-23T23:05:40.8487796Z Receiving objects:  81% (5783/7139)
2020-05-23T23:05:40.8494444Z Receiving objects:  82% (5854/7139)
2020-05-23T23:05:40.8501163Z Receiving objects:  83% (5926/7139)
2020-05-23T23:05:40.8508191Z Receiving objects:  84% (5997/7139)
2020-05-23T23:05:40.8514734Z Receiving objects:  85% (6069/7139)
2020-05-23T23:05:40.8521702Z Receiving objects:  86% (6140/7139)
2020-05-23T23:05:40.8528655Z Receiving objects:  87% (6211/7139)
2020-05-23T23:05:40.8535356Z Receiving objects:  88% (6283/7139)
2020-05-23T23:05:40.8542154Z Receiving objects:  89% (6354/7139)
2020-05-23T23:05:40.8548853Z Receiving objects:  90% (6426/7139)
2020-05-23T23:05:40.8555961Z Receiving objects:  91% (6497/7139)
2020-05-23T23:05:40.8562702Z Receiving objects:  92% (6568/7139)
2020-05-23T23:05:40.8569910Z Receiving objects:  93% (6640/7139)
2020-05-23T23:05:40.8576156Z Receiving objects:  94% (6711/7139)
2020-05-23T23:05:40.8585722Z remote: Total 7139 (delta 2), reused 13 (delta 2), pack-reused 7121        
2020-05-23T23:05:40.8594863Z Receiving objects:  95% (6783/7139)
2020-05-23T23:05:40.8601593Z Receiving objects:  96% (6854/7139)
2020-05-23T23:05:40.8608329Z Receiving objects:  97% (6925/7139)
2020-05-23T23:05:40.8614990Z Receiving objects:  98% (6997/7139)
2020-05-23T23:05:40.8621814Z Receiving objects:  99% (7068/7139)
2020-05-23T23:05:40.8628486Z Receiving objects: 100% (7139/7139)
2020-05-23T23:05:40.8636797Z Receiving objects: 100% (7139/7139), 2.24 MiB | 27.02 MiB/s, done.
2020-05-23T23:05:40.8644433Z Resolving deltas:   0% (0/5063)
2020-05-23T23:05:40.8650670Z Resolving deltas:   1% (51/5063)
2020-05-23T23:05:40.8657171Z Resolving deltas:   2% (131/5063)
2020-05-23T23:05:40.8663988Z Resolving deltas:   3% (168/5063)
2020-05-23T23:05:40.8670807Z Resolving deltas:   4% (203/5063)
2020-05-23T23:05:40.8677053Z Resolving deltas:   5% (277/5063)
2020-05-23T23:05:40.8687691Z Resolving deltas:   6% (304/5063)
2020-05-23T23:05:40.8694519Z Resolving deltas:   7% (357/5063)
2020-05-23T23:05:40.8701260Z Resolving deltas:   8% (410/5063)
2020-05-23T23:05:40.8707813Z Resolving deltas:   9% (458/5063)
2020-05-23T23:05:40.8714332Z Resolving deltas:  10% (514/5063)
2020-05-23T23:05:40.8720774Z Resolving deltas:  11% (566/5063)
2020-05-23T23:05:40.8727213Z Resolving deltas:  12% (621/5063)
2020-05-23T23:05:40.8733649Z Resolving deltas:  13% (683/5063)
2020-05-23T23:05:40.8740249Z Resolving deltas:  14% (716/5063)
2020-05-23T23:05:40.8746709Z Resolving deltas:  15% (778/5063)
2020-05-23T23:05:40.8753144Z Resolving deltas:  16% (835/5063)
2020-05-23T23:05:40.8759731Z Resolving deltas:  17% (870/5063)
2020-05-23T23:05:40.8766196Z Resolving deltas:  18% (919/5063)
2020-05-23T23:05:40.8772637Z Resolving deltas:  19% (962/5063)
2020-05-23T23:05:40.8779486Z Resolving deltas:  20% (1013/5063)
2020-05-23T23:05:40.8787660Z Resolving deltas:  21% (1066/5063)
2020-05-23T23:05:40.8794542Z Resolving deltas:  22% (1150/5063)
2020-05-23T23:05:40.8800819Z Resolving deltas:  23% (1165/5063)
2020-05-23T23:05:40.8807667Z Resolving deltas:  24% (1217/5063)
2020-05-23T23:05:40.8813791Z Resolving deltas:  25% (1286/5063)
2020-05-23T23:05:40.8820280Z Resolving deltas:  26% (1320/5063)
2020-05-23T23:05:40.8826346Z Resolving deltas:  27% (1369/5063)
2020-05-23T23:05:40.8832339Z Resolving deltas:  28% (1426/5063)
2020-05-23T23:05:40.8841776Z Resolving deltas:  29% (1491/5063)
2020-05-23T23:05:40.8848492Z Resolving deltas:  30% (1540/5063)
2020-05-23T23:05:40.8856036Z Resolving deltas:  31% (1601/5063)
2020-05-23T23:05:40.8862876Z Resolving deltas:  32% (1640/5063)
2020-05-23T23:05:40.8869911Z Resolving deltas:  33% (1678/5063)
2020-05-23T23:05:40.8877029Z Resolving deltas:  34% (1728/5063)
2020-05-23T23:05:40.8883660Z Resolving deltas:  35% (1795/5063)
2020-05-23T23:05:40.8890245Z Resolving deltas:  37% (1883/5063)
2020-05-23T23:05:40.8897021Z Resolving deltas:  38% (1925/5063)
2020-05-23T23:05:40.8903979Z Resolving deltas:  39% (2018/5063)
2020-05-23T23:05:40.8910587Z Resolving deltas:  40% (2052/5063)
2020-05-23T23:05:40.8917691Z Resolving deltas:  41% (2086/5063)
2020-05-23T23:05:40.8924323Z Resolving deltas:  42% (2157/5063)
2020-05-23T23:05:40.8930875Z Resolving deltas:  43% (2187/5063)
2020-05-23T23:05:40.8937435Z Resolving deltas:  44% (2254/5063)
2020-05-23T23:05:40.8944136Z Resolving deltas:  45% (2290/5063)
2020-05-23T23:05:40.8950684Z Resolving deltas:  46% (2338/5063)
2020-05-23T23:05:40.8957590Z Resolving deltas:  47% (2386/5063)
2020-05-23T23:05:40.8964910Z Resolving deltas:  48% (2439/5063)
2020-05-23T23:05:40.8971551Z Resolving deltas:  49% (2481/5063)
2020-05-23T23:05:40.8978091Z Resolving deltas:  50% (2557/5063)
2020-05-23T23:05:40.8985489Z Resolving deltas:  51% (2603/5063)
2020-05-23T23:05:40.8992581Z Resolving deltas:  53% (2701/5063)
2020-05-23T23:05:40.8999193Z Resolving deltas:  55% (2797/5063)
2020-05-23T23:05:40.9005756Z Resolving deltas:  56% (2837/5063)
2020-05-23T23:05:40.9012332Z Resolving deltas:  57% (2912/5063)
2020-05-23T23:05:40.9019292Z Resolving deltas:  58% (2941/5063)
2020-05-23T23:05:40.9025890Z Resolving deltas:  59% (3022/5063)
2020-05-23T23:05:40.9032476Z Resolving deltas:  60% (3042/5063)
2020-05-23T23:05:40.9039048Z Resolving deltas:  61% (3091/5063)
2020-05-23T23:05:40.9045603Z Resolving deltas:  62% (3176/5063)
2020-05-23T23:05:40.9052157Z Resolving deltas:  63% (3208/5063)
2020-05-23T23:05:40.9058701Z Resolving deltas:  64% (3244/5063)
2020-05-23T23:05:40.9065675Z Resolving deltas:  65% (3291/5063)
2020-05-23T23:05:40.9071795Z Resolving deltas:  68% (3459/5063)
2020-05-23T23:05:40.9077871Z Resolving deltas:  69% (3515/5063)
2020-05-23T23:05:40.9084414Z Resolving deltas:  70% (3553/5063)
2020-05-23T23:05:40.9091080Z Resolving deltas:  71% (3640/5063)
2020-05-23T23:05:40.9097644Z Resolving deltas:  72% (3656/5063)
2020-05-23T23:05:40.9104322Z Resolving deltas:  73% (3712/5063)
2020-05-23T23:05:40.9110893Z Resolving deltas:  77% (3899/5063)
2020-05-23T23:05:40.9117197Z Resolving deltas:  78% (3958/5063)
2020-05-23T23:05:40.9123504Z Resolving deltas:  79% (4002/5063)
2020-05-23T23:05:40.9130051Z Resolving deltas:  81% (4107/5063)
2020-05-23T23:05:40.9136586Z Resolving deltas:  82% (4181/5063)
2020-05-23T23:05:40.9142771Z Resolving deltas:  83% (4221/5063)
2020-05-23T23:05:40.9150157Z Resolving deltas:  84% (4268/5063)
2020-05-23T23:05:40.9156819Z Resolving deltas:  85% (4311/5063)
2020-05-23T23:05:40.9163377Z Resolving deltas:  86% (4398/5063)
2020-05-23T23:05:40.9169934Z Resolving deltas:  87% (4416/5063)
2020-05-23T23:05:40.9176518Z Resolving deltas:  88% (4496/5063)
2020-05-23T23:05:40.9183158Z Resolving deltas:  89% (4507/5063)
2020-05-23T23:05:40.9190219Z Resolving deltas:  90% (4557/5063)
2020-05-23T23:05:40.9196814Z Resolving deltas:  91% (4620/5063)
2020-05-23T23:05:40.9203841Z Resolving deltas:  92% (4667/5063)
2020-05-23T23:05:40.9210859Z Resolving deltas:  93% (4715/5063)
2020-05-23T23:05:40.9217825Z Resolving deltas:  94% (4761/5063)
2020-05-23T23:05:40.9225411Z Resolving deltas:  95% (4820/5063)
2020-05-23T23:05:40.9232071Z Resolving deltas:  96% (4864/5063)
2020-05-23T23:05:40.9239449Z Resolving deltas:  97% (4914/5063)
2020-05-23T23:05:40.9247497Z Resolving deltas:  98% (4966/5063)
2020-05-23T23:05:40.9254252Z Resolving deltas:  99% (5015/5063)
2020-05-23T23:05:40.9260928Z Resolving deltas: 100% (5063/5063)
2020-05-23T23:05:40.9267786Z Resolving deltas: 100% (5063/5063), done.
2020-05-23T23:05:40.9275329Z From https://github.com/pallets/click
2020-05-23T23:05:40.9286994Z  * [new branch]      1.x                  -> origin/1.x
2020-05-23T23:05:40.9301724Z  * [new branch]      2.x                  -> origin/2.x
2020-05-23T23:05:40.9317648Z  * [new branch]      3.x                  -> origin/3.x
2020-05-23T23:05:40.9332475Z  * [new branch]      4.x                  -> origin/4.x
2020-05-23T23:05:40.9347282Z  * [new branch]      5.x                  -> origin/5.x
2020-05-23T23:05:40.9362872Z  * [new branch]      6.x                  -> origin/6.x
2020-05-23T23:05:40.9377610Z  * [new branch]      7.x                  -> origin/7.x
2020-05-23T23:05:40.9392293Z  * [new branch]      master               -> origin/master
2020-05-23T23:05:40.9407202Z  * [new branch]      requirements         -> origin/requirements
2020-05-23T23:05:40.9419962Z  * [new ref]         refs/pull/1560/merge -> pull/1560/merge
2020-05-23T23:05:40.9433578Z  * [new tag]         0.1                  -> 0.1
2020-05-23T23:05:40.9448821Z  * [new tag]         0.2                  -> 0.2
2020-05-23T23:05:40.9464304Z  * [new tag]         0.3                  -> 0.3
2020-05-23T23:05:40.9506992Z  * [new tag]         0.4                  -> 0.4
2020-05-23T23:05:40.9522958Z  * [new tag]         0.5                  -> 0.5
2020-05-23T23:05:40.9540284Z  * [new tag]         0.5.1                -> 0.5.1
2020-05-23T23:05:40.9555439Z  * [new tag]         0.6                  -> 0.6
2020-05-23T23:05:40.9570267Z  * [new tag]         0.7                  -> 0.7
2020-05-23T23:05:40.9585665Z  * [new tag]         1.0                  -> 1.0
2020-05-23T23:05:40.9601416Z  * [new tag]         1.1                  -> 1.1
2020-05-23T23:05:40.9627790Z  * [new tag]         2.0                  -> 2.0
2020-05-23T23:05:40.9645363Z  * [new tag]         2.1                  -> 2.1
2020-05-23T23:05:40.9661455Z  * [new tag]         2.2                  -> 2.2
2020-05-23T23:05:40.9676776Z  * [new tag]         2.4                  -> 2.4
2020-05-23T23:05:40.9691717Z  * [new tag]         2.5                  -> 2.5
2020-05-23T23:05:40.9706817Z  * [new tag]         2.6                  -> 2.6
2020-05-23T23:05:40.9721507Z  * [new tag]         3.0                  -> 3.0
2020-05-23T23:05:40.9736347Z  * [new tag]         3.1                  -> 3.1
2020-05-23T23:05:40.9751329Z  * [new tag]         3.2                  -> 3.2
2020-05-23T23:05:40.9765650Z  * [new tag]         3.3                  -> 3.3
2020-05-23T23:05:40.9781774Z  * [new tag]         4.0                  -> 4.0
2020-05-23T23:05:40.9796817Z  * [new tag]         4.1                  -> 4.1
2020-05-23T23:05:40.9812146Z  * [new tag]         5.0                  -> 5.0
2020-05-23T23:05:40.9827240Z  * [new tag]         5.1                  -> 5.1
2020-05-23T23:05:40.9842114Z  * [new tag]         6.0                  -> 6.0
2020-05-23T23:05:40.9856978Z  * [new tag]         6.1                  -> 6.1
2020-05-23T23:05:40.9873879Z  * [new tag]         6.2                  -> 6.2
2020-05-23T23:05:40.9889154Z  * [new tag]         6.3                  -> 6.3
2020-05-23T23:05:40.9904891Z  * [new tag]         6.4                  -> 6.4
2020-05-23T23:05:40.9919768Z  * [new tag]         6.5                  -> 6.5
2020-05-23T23:05:40.9935353Z  * [new tag]         6.6                  -> 6.6
2020-05-23T23:05:40.9950643Z  * [new tag]         6.7                  -> 6.7
2020-05-23T23:05:40.9965602Z  * [new tag]         7.0                  -> 7.0
2020-05-23T23:05:40.9980666Z  * [new tag]         7.1                  -> 7.1
2020-05-23T23:05:40.9995221Z  * [new tag]         7.1.1                -> 7.1.1
2020-05-23T23:05:41.0009413Z  * [new tag]         7.1.2                -> 7.1.2
2020-05-23T23:05:41.0616335Z ##[command]git checkout --progress --force refs/remotes/pull/1560/merge
2020-05-23T23:05:41.0665638Z Note: switching to 'refs/remotes/pull/1560/merge'.
2020-05-23T23:05:41.0673219Z 
2020-05-23T23:05:41.0680110Z You are in 'detached HEAD' state. You can look around, make experimental
2020-05-23T23:05:41.0691204Z changes and commit them, and you can discard any commits you make in this
2020-05-23T23:05:41.0702127Z state without impacting any branches by switching back to a branch.
2020-05-23T23:05:41.0708507Z 
2020-05-23T23:05:41.0718172Z If you want to create a new branch to retain commits you create, you may
2020-05-23T23:05:41.0747450Z do so (now or later) by using -c with the switch command. Example:
2020-05-23T23:05:41.0773058Z 
2020-05-23T23:05:41.0778088Z   git switch -c <new-branch-name>
2020-05-23T23:05:41.0933288Z 
2020-05-23T23:05:41.0997081Z Or undo this operation with:
2020-05-23T23:05:41.1001245Z 
2020-05-23T23:05:41.1004914Z   git switch -
2020-05-23T23:05:41.1008175Z 
2020-05-23T23:05:41.1015359Z Turn off this advice by setting config variable advice.detachedHead to false
2020-05-23T23:05:41.1022614Z 
2020-05-23T23:05:41.1130902Z HEAD is now at cd0a8ed Merge *** into ***
2020-05-23T23:05:41.1237445Z ##[section]Finishing: Checkout pallets/click@refs/pull/1560/merge to s
2020-05-23T23:05:41.1684855Z ##[section]Starting: Use Python 3.8
2020-05-23T23:05:41.1771744Z ==============================================================================
2020-05-23T23:05:41.1803087Z Task         : Use Python version
2020-05-23T23:05:41.1815993Z Description  : Use the specified version of Python from the tool cache, optionally adding it to the PATH
2020-05-23T23:05:41.1826604Z Version      : 0.151.3
2020-05-23T23:05:41.1833857Z Author       : Microsoft Corporation
2020-05-23T23:05:41.1845360Z Help         : https://docs.microsoft.com/azure/devops/pipelines/tasks/tool/use-python-version
2020-05-23T23:05:41.1879238Z ==============================================================================
2020-05-23T23:05:42.2562291Z Found tool in cache: Python 3.8.3 x64
2020-05-23T23:05:42.2611125Z Prepending PATH environment variable with directory: /opt/hostedtoolcache/Python/3.8.3/x64
2020-05-23T23:05:42.2663394Z Prepending PATH environment variable with directory: /opt/hostedtoolcache/Python/3.8.3/x64/bin
2020-05-23T23:05:42.2718208Z ##[section]Finishing: Use Python 3.8
2020-05-23T23:05:42.3155121Z ##[section]Starting: Install tox
2020-05-23T23:05:42.3241270Z ==============================================================================
2020-05-23T23:05:42.3272048Z Task         : Command line
2020-05-23T23:05:42.3282648Z Description  : Run a command line script using Bash on Linux and macOS and cmd.exe on Windows
2020-05-23T23:05:42.3292094Z Version      : 2.164.1
2020-05-23T23:05:42.3299728Z Author       : Microsoft Corporation
2020-05-23T23:05:42.3310860Z Help         : https://docs.microsoft.com/azure/devops/pipelines/tasks/utility/command-line
2020-05-23T23:05:42.3343682Z ==============================================================================
2020-05-23T23:05:43.2439335Z Generating script.
2020-05-23T23:05:43.2633489Z Script contents:
2020-05-23T23:05:43.2642402Z pip --disable-pip-version-check install -U tox
2020-05-23T23:05:43.2664236Z ========================== Starting Command Output ===========================
2020-05-23T23:05:43.2750572Z [command]/bin/bash --noprofile --norc /home/vsts/work/_temp/877dca60-64a1-487c-a4c1-f471ec3dbbdc.sh
2020-05-23T23:05:43.2956353Z Collecting tox
2020-05-23T23:05:43.3181181Z   Downloading tox-3.15.1-py2.py3-none-any.whl (82 kB)
2020-05-23T23:05:43.5136316Z Collecting virtualenv!=20.0.0,!=20.0.1,!=20.0.2,!=20.0.3,!=20.0.4,!=20.0.5,!=20.0.6,!=20.0.7,>=16.0.0
2020-05-23T23:05:43.5185021Z   Downloading virtualenv-20.0.21-py2.py3-none-any.whl (4.7 MB)
2020-05-23T23:05:43.7407013Z Collecting filelock>=3.0.0
2020-05-23T23:05:43.7470415Z   Downloading filelock-3.0.12-py3-none-any.whl (7.6 kB)
2020-05-23T23:05:43.7822098Z Collecting six>=1.14.0
2020-05-23T23:05:43.7889369Z   Downloading six-1.15.0-py2.py3-none-any.whl (10 kB)
2020-05-23T23:05:43.8247668Z Collecting pluggy>=0.12.0
2020-05-23T23:05:43.8299379Z   Downloading pluggy-0.13.1-py2.py3-none-any.whl (18 kB)
2020-05-23T23:05:43.8663228Z Collecting toml>=0.9.4
2020-05-23T23:05:43.8761575Z   Downloading toml-0.10.1-py2.py3-none-any.whl (19 kB)
2020-05-23T23:05:43.9272837Z Collecting py>=1.4.17
2020-05-23T23:05:43.9320554Z   Downloading py-1.8.1-py2.py3-none-any.whl (83 kB)
2020-05-23T23:05:43.9886566Z Collecting packaging>=14
2020-05-23T23:05:43.9944661Z   Downloading packaging-20.4-py2.py3-none-any.whl (37 kB)
2020-05-23T23:05:44.0227526Z Collecting distlib<1,>=0.3.0
2020-05-23T23:05:44.0282608Z   Downloading distlib-0.3.0.zip (571 kB)
2020-05-23T23:05:44.5139540Z Collecting appdirs<2,>=1.4.3
2020-05-23T23:05:44.5209315Z   Downloading appdirs-1.4.4-py2.py3-none-any.whl (9.6 kB)
2020-05-23T23:05:44.6112013Z Collecting pyparsing>=2.0.2
2020-05-23T23:05:44.6163552Z   Downloading pyparsing-2.4.7-py2.py3-none-any.whl (67 kB)
2020-05-23T23:05:44.6273849Z Could not build wheels for distlib, since package 'wheel' is not installed.
2020-05-23T23:05:44.6888532Z Installing collected packages: filelock, distlib, appdirs, six, virtualenv, pluggy, toml, py, pyparsing, packaging, tox
2020-05-23T23:05:44.6994377Z     Running setup.py install for distlib: started
2020-05-23T23:05:45.0865349Z     Running setup.py install for distlib: finished with status 'done'
2020-05-23T23:05:45.5914459Z Successfully installed appdirs-1.4.4 distlib-0.3.0 filelock-3.0.12 packaging-20.4 pluggy-0.13.1 py-1.8.1 pyparsing-2.4.7 six-1.15.0 toml-0.10.1 tox-3.15.1 virtualenv-20.0.21
2020-05-23T23:05:45.6620245Z 
2020-05-23T23:05:45.6693993Z ##[section]Finishing: Install tox
2020-05-23T23:05:45.7102064Z ##[section]Starting: Run tox
2020-05-23T23:05:45.7186691Z ==============================================================================
2020-05-23T23:05:45.7216313Z Task         : Command line
2020-05-23T23:05:45.7226481Z Description  : Run a command line script using Bash on Linux and macOS and cmd.exe on Windows
2020-05-23T23:05:45.7236037Z Version      : 2.164.1
2020-05-23T23:05:45.7242769Z Author       : Microsoft Corporation
2020-05-23T23:05:45.7253603Z Help         : https://docs.microsoft.com/azure/devops/pipelines/tasks/utility/command-line
2020-05-23T23:05:45.7287986Z ==============================================================================
2020-05-23T23:05:45.9387651Z Generating script.
2020-05-23T23:05:45.9407349Z Script contents:
2020-05-23T23:05:45.9410567Z tox
2020-05-23T23:05:45.9460287Z ========================== Starting Command Output ===========================
2020-05-23T23:05:45.9509229Z [command]/bin/bash --noprofile --norc /home/vsts/work/_temp/8090e167-0a78-4a08-8f46-9053adb7625c.sh
2020-05-23T23:05:46.2616597Z GLOB sdist-make: /home/vsts/work/1/s/setup.py
2020-05-23T23:05:46.5743860Z py create: /home/vsts/work/1/s/.tox/py
2020-05-23T23:05:46.9860374Z py installdeps: -rrequirements/tests.txt
2020-05-23T23:05:49.1878019Z py inst: /home/vsts/work/1/s/.tox/.tmp/package/1/click-8.0.0.dev0.zip
2020-05-23T23:05:50.6935015Z py installed: attrs==19.3.0,click @ file:///home/vsts/work/1/s/.tox/.tmp/package/1/click-8.0.0.dev0.zip,colorama==0.4.3,more-itertools==8.3.0,packaging==20.4,pluggy==0.13.1,py==1.8.1,pyparsing==2.4.7,pytest==5.4.2,six==1.15.0,wcwidth==0.1.9
2020-05-23T23:05:50.6955250Z py run-test-pre: PYTHONHASHSEED='1026706523'
2020-05-23T23:05:50.6964981Z py run-test: commands[0] | pytest --tb=short --basetemp=/home/vsts/work/1/s/.tox/py/tmp
2020-05-23T23:05:50.8932501Z ============================= test session starts ==============================
2020-05-23T23:05:50.8957431Z platform linux -- Python 3.8.3, pytest-5.4.2, py-1.8.1, pluggy-0.13.1
2020-05-23T23:05:50.8965632Z cachedir: .tox/py/.pytest_cache
2020-05-23T23:05:50.8973892Z rootdir: /home/vsts/work/1/s, inifile: setup.cfg, testpaths: tests
2020-05-23T23:05:51.6797583Z collected 307 items
2020-05-23T23:05:51.6809726Z 
2020-05-23T23:05:51.7178464Z tests/test_arguments.py ....................                             [  6%]
2020-05-23T23:05:51.7638912Z tests/test_bashcomplete.py ........................                      [ 14%]
2020-05-23T23:05:51.8130607Z tests/test_basic.py .......................                              [ 21%]
2020-05-23T23:05:51.8917751Z tests/test_chain.py .......x                                             [ 24%]
2020-05-23T23:05:51.9124290Z tests/test_commands.py .............                                     [ 28%]
2020-05-23T23:05:51.9155779Z tests/test_compat.py ...                                                 [ 29%]
2020-05-23T23:05:51.9480689Z tests/test_context.py ..................                                 [ 35%]
2020-05-23T23:05:51.9540096Z tests/test_defaults.py ...                                               [ 36%]
2020-05-23T23:05:51.9768124Z tests/test_formatting.py ...............                                 [ 41%]
2020-05-23T23:05:52.0216564Z tests/test_imports.py .                                                  [ 41%]
2020-05-23T23:05:52.0266611Z tests/test_normalization.py ...                                          [ 42%]
2020-05-23T23:05:52.1078932Z tests/test_options.py ..........................................         [ 56%]
2020-05-23T23:05:52.1724050Z tests/test_termui.py ..........................................sssssssss [ 72%]
2020-05-23T23:05:52.1846322Z ssssssssssss                                                             [ 76%]
2020-05-23T23:05:52.2092697Z tests/test_testing.py ................                                   [ 82%]
2020-05-23T23:05:52.3492364Z tests/test_utils.py .................................................... [ 99%]
2020-05-23T23:05:52.3586379Z ...                                                                      [100%]
2020-05-23T23:05:52.3612390Z 
2020-05-23T23:05:52.3624647Z ================== 285 passed, 21 skipped, 1 xfailed in 1.47s ==================
2020-05-23T23:05:52.3949801Z ___________________________________ summary ____________________________________
2020-05-23T23:05:52.3956902Z   py: commands succeeded
2020-05-23T23:05:52.3961567Z   congratulations :)
2020-05-23T23:05:52.4166037Z 
2020-05-23T23:05:52.4245268Z ##[section]Finishing: Run tox
2020-05-23T23:05:52.4637880Z ##[section]Starting: Checkout pallets/click@refs/pull/1560/merge to s
2020-05-23T23:05:52.4694395Z ==============================================================================
2020-05-23T23:05:52.4719344Z Task         : Get sources
2020-05-23T23:05:52.4728430Z Description  : Get sources from a repository. Supports Git, TfsVC, and SVN repositories.
2020-05-23T23:05:52.4735620Z Version      : 1.0.0
2020-05-23T23:05:52.4740504Z Author       : Microsoft
2020-05-23T23:05:52.4748340Z Help         : [More Information](https://go.microsoft.com/fwlink/?LinkId=798199)
2020-05-23T23:05:52.4776205Z ==============================================================================
2020-05-23T23:05:52.8291219Z Cleaning any cached credential from repository: pallets/click (GitHub)
2020-05-23T23:05:52.8347436Z ##[section]Finishing: Checkout pallets/click@refs/pull/1560/merge to s
2020-05-23T23:05:52.8484155Z ##[section]Starting: Finalize Job
2020-05-23T23:05:52.8560138Z TestResultLogParser: JasmineTestResultParser : Starting jasmine test result parser.
2020-05-23T23:05:52.8570366Z TestResultLogParser: JestTestResultParser : Starting jest test result parser.
2020-05-23T23:05:52.8580504Z TestResultLogParser: MochaTestResultParser : Starting mocha test result parser.
2020-05-23T23:05:52.8590714Z TestResultLogParser: PythonTestResultParser : Starting python test result parser.
2020-05-23T23:05:52.8604547Z TestResultLogParser: Waiting for log plugin to finish, pending process 2 log lines.
2020-05-23T23:05:53.3084423Z Cleaning up task key
2020-05-23T23:05:53.3101387Z Start cleaning up orphan processes.
2020-05-23T23:05:53.3621403Z ##[section]Finishing: Finalize Job
2020-05-23T23:05:53.3687292Z ##[section]Finishing: Job Linux