builder: mozilla-aurora_ubuntu64_hw_test-dromaeojs-e10s-pgo slave: talos-linux64-ix-007 starttime: 1453470732.51 results: success (0) buildid: 20160122032328 builduid: 2320f5f3157644089eea98ed7cf7f1aa revision: 882e6011c18f968f3e6993e4fac60c68ae6366a0 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-01-22 05:52:12.507467) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-01-22 05:52:12.507872) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2016-01-22 05:52:12.508151) ========= bash -c pwd in dir /builds/slave/test-pgo/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', 'pwd'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test-pgo SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=b5f16d05e5ea93ddf675e67e000001bf-1453470511.106647-1655455357 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False /builds/slave/test-pgo program finished with exit code 0 elapsedTime=0.006437 basedir: '/builds/slave/test-pgo' ========= master_lag: 0.03 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2016-01-22 05:52:12.540843) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-01-22 05:52:12.541118) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-01-22 05:52:12.592034) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-01-22 05:52:12.592322) ========= rm -rf properties in dir /builds/slave/test-pgo/. (timeout 1200 secs) watching logfiles {} argv: ['rm', '-rf', 'properties'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test-pgo SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=b5f16d05e5ea93ddf675e67e000001bf-1453470511.106647-1655455357 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.022912 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-01-22 05:52:12.640752) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-01-22 05:52:12.641034) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-01-22 05:52:12.641400) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-01-22 05:52:12.641704) ========= bash -c 'wget -Oarchiver_client.py --no-check-certificate --tries=10 --waitretry=3 https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py' in dir /builds/slave/test-pgo/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', 'wget -Oarchiver_client.py --no-check-certificate --tries=10 --waitretry=3 https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test-pgo SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=b5f16d05e5ea93ddf675e67e000001bf-1453470511.106647-1655455357 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-01-22 05:52:12-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 219M=0s 2016-01-22 05:52:13 (219 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.171884 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-01-22 05:52:12.825602) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-01-22 05:52:12.825902) ========= rm -rf scripts in dir /builds/slave/test-pgo/. (timeout 1200 secs) watching logfiles {} argv: ['rm', '-rf', 'scripts'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test-pgo SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=b5f16d05e5ea93ddf675e67e000001bf-1453470511.106647-1655455357 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.085748 ========= master_lag: 0.01 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-01-22 05:52:12.920476) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-01-22 05:52:12.920835) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev 882e6011c18f968f3e6993e4fac60c68ae6366a0 --destination scripts --debug' in dir /builds/slave/test-pgo/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev 882e6011c18f968f3e6993e4fac60c68ae6366a0 --destination scripts --debug'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test-pgo SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=b5f16d05e5ea93ddf675e67e000001bf-1453470511.106647-1655455357 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-01-22 05:52:13,202 truncating revision to first 12 chars 2016-01-22 05:52:13,203 Setting DEBUG logging. 2016-01-22 05:52:13,203 attempt 1/10 2016-01-22 05:52:13,203 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-aurora/882e6011c18f?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-01-22 05:52:13,459 unpacking tar archive at: mozilla-aurora-882e6011c18f/testing/mozharness/ program finished with exit code 0 elapsedTime=0.571897 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-01-22 05:52:13.508352) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-01-22 05:52:13.508661) ========= echo 882e6011c18f968f3e6993e4fac60c68ae6366a0 in dir /builds/slave/test-pgo/. (timeout 1200 secs) watching logfiles {} argv: ['echo', u'882e6011c18f968f3e6993e4fac60c68ae6366a0'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test-pgo SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=b5f16d05e5ea93ddf675e67e000001bf-1453470511.106647-1655455357 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 882e6011c18f968f3e6993e4fac60c68ae6366a0 program finished with exit code 0 elapsedTime=0.004668 script_repo_revision: '882e6011c18f968f3e6993e4fac60c68ae6366a0' ========= master_lag: 0.05 ========= ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-01-22 05:52:13.558726) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-01-22 05:52:13.559030) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-01-22 05:52:13.570142) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 8 secs) (at 2016-01-22 05:52:13.570446) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Mozilla-Aurora --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Aurora in dir /builds/slave/test-pgo/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs-e10s', '--add-option', '--webServer,localhost', '--branch-name', 'Mozilla-Aurora', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Mozilla-Aurora'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test-pgo/buildprops.json PWD=/builds/slave/test-pgo SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=b5f16d05e5ea93ddf675e67e000001bf-1453470511.106647-1655455357 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 05:52:13 INFO - MultiFileLogger online at 20160122 05:52:13 in /builds/slave/test-pgo 05:52:13 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Mozilla-Aurora --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Aurora 05:52:13 INFO - Dumping config to /builds/slave/test-pgo/logs/localconfig.json. 05:52:13 INFO - {'append_to_log': False, 05:52:13 INFO - 'base_work_dir': '/builds/slave/test-pgo', 05:52:13 INFO - 'blob_upload_branch': 'Mozilla-Aurora', 05:52:13 INFO - 'blob_uploader_auth_file': '/builds/slave/test-pgo/oauth.txt', 05:52:13 INFO - 'branch': 'Mozilla-Aurora', 05:52:13 INFO - 'buildbot_json_path': 'buildprops.json', 05:52:13 INFO - 'config_files': ('talos/linux_config.py',), 05:52:13 INFO - 'default_actions': ('clobber', 05:52:13 INFO - 'read-buildbot-config', 05:52:13 INFO - 'download-and-extract', 05:52:13 INFO - 'populate-webroot', 05:52:13 INFO - 'create-virtualenv', 05:52:13 INFO - 'install', 05:52:13 INFO - 'run-tests'), 05:52:13 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 05:52:13 INFO - 'download_minidump_stackwalk': True, 05:52:13 INFO - 'download_symbols': 'ondemand', 05:52:13 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 05:52:13 INFO - 'tooltool.py': '/tools/tooltool.py', 05:52:13 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 05:52:13 INFO - '/tools/misc-python/virtualenv.py')}, 05:52:13 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 05:52:13 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 05:52:13 INFO - 'installer_path': 'installer.exe', 05:52:13 INFO - 'log_level': 'info', 05:52:13 INFO - 'log_name': 'talos', 05:52:13 INFO - 'log_to_console': True, 05:52:13 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 05:52:13 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 05:52:13 INFO - 'opt_config_files': (), 05:52:13 INFO - 'pip_index': False, 05:52:13 INFO - 'sps_profile': False, 05:52:13 INFO - 'sps_profile_interval': 0, 05:52:13 INFO - 'suite': 'dromaeojs-e10s', 05:52:13 INFO - 'system_bits': '32', 05:52:13 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 05:52:13 INFO - 'title': 'talos-linux64-ix-007', 05:52:13 INFO - 'tooltool_cache': '/builds/tooltool_cache', 05:52:13 INFO - 'use_talos_json': True, 05:52:13 INFO - 'virtualenv_path': '/builds/slave/test-pgo/build/venv', 05:52:13 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 05:52:13 INFO - 'work_dir': 'build'} 05:52:13 INFO - ##### 05:52:13 INFO - ##### Running clobber step. 05:52:13 INFO - ##### 05:52:13 INFO - Running pre-action listener: _resource_record_pre_action 05:52:13 INFO - Running main action method: clobber 05:52:13 INFO - rmtree: /builds/slave/test-pgo/build 05:52:13 INFO - retry: Calling rmtree with args: ('/builds/slave/test-pgo/build',), kwargs: {}, attempt #1 05:52:18 INFO - Running post-action listener: _resource_record_post_action 05:52:18 INFO - ##### 05:52:18 INFO - ##### Running read-buildbot-config step. 05:52:18 INFO - ##### 05:52:18 INFO - Running pre-action listener: _resource_record_pre_action 05:52:18 INFO - Running main action method: read_buildbot_config 05:52:18 INFO - Using buildbot properties: 05:52:18 INFO - { 05:52:18 INFO - "properties": { 05:52:18 INFO - "buildnumber": 68, 05:52:18 INFO - "product": "firefox", 05:52:18 INFO - "script_repo_revision": "production", 05:52:18 INFO - "builddir": "mozilla-aurora_ubuntu64_hw_test-dromaeojs-e10s", 05:52:18 INFO - "repository": "", 05:52:18 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-aurora pgo talos dromaeojs-e10s", 05:52:18 INFO - "buildid": "20160122032328", 05:52:18 INFO - "slavename": "talos-linux64-ix-007", 05:52:18 INFO - "pgo_build": "True", 05:52:18 INFO - "basedir": "/builds/slave/test-pgo", 05:52:18 INFO - "project": "", 05:52:18 INFO - "platform": "ubuntu64_hw", 05:52:18 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 05:52:18 INFO - "slavebuilddir": "test", 05:52:18 INFO - "scheduler": "tests-mozilla-aurora-linux64-pgo-talos", 05:52:18 INFO - "branch": "mozilla-aurora", 05:52:18 INFO - "repo_path": "releases/mozilla-aurora", 05:52:18 INFO - "stage_platform": "linux64-pgo", 05:52:18 INFO - "builduid": "2320f5f3157644089eea98ed7cf7f1aa", 05:52:18 INFO - "revision": "882e6011c18f968f3e6993e4fac60c68ae6366a0" 05:52:18 INFO - }, 05:52:18 INFO - "sourcestamp": { 05:52:18 INFO - "repository": "", 05:52:18 INFO - "hasPatch": false, 05:52:18 INFO - "project": "", 05:52:18 INFO - "branch": "mozilla-aurora-linux64-pgo-talos", 05:52:18 INFO - "changes": [ 05:52:18 INFO - { 05:52:18 INFO - "category": null, 05:52:18 INFO - "files": [ 05:52:18 INFO - { 05:52:18 INFO - "url": null, 05:52:18 INFO - "name": "https://queue.taskcluster.net/v1/task/2p0v77w4SLK4Lf8Vflb2rg/artifacts/public/build/firefox-45.0a2.en-US.linux-x86_64.tar.bz2" 05:52:18 INFO - } 05:52:18 INFO - ], 05:52:18 INFO - "repository": "", 05:52:18 INFO - "rev": "882e6011c18f968f3e6993e4fac60c68ae6366a0", 05:52:18 INFO - "who": "ttaubert@mozilla.com", 05:52:18 INFO - "when": 1453470698, 05:52:18 INFO - "number": 7500350, 05:52:18 INFO - "comments": "Bug 1230209 - Add more telemetry for Geolocation usage f=bsmedberg r=tanvi,rbarnes,jdm a=sylvestre", 05:52:18 INFO - "project": "", 05:52:18 INFO - "at": "Fri 22 Jan 2016 05:51:38", 05:52:18 INFO - "branch": "mozilla-aurora-linux64-pgo-talos", 05:52:18 INFO - "revlink": "", 05:52:18 INFO - "properties": [ 05:52:18 INFO - [ 05:52:18 INFO - "buildid", 05:52:18 INFO - "20160122032328", 05:52:18 INFO - "Change" 05:52:18 INFO - ], 05:52:18 INFO - [ 05:52:18 INFO - "builduid", 05:52:18 INFO - "2320f5f3157644089eea98ed7cf7f1aa", 05:52:18 INFO - "Change" 05:52:18 INFO - ], 05:52:18 INFO - [ 05:52:18 INFO - "pgo_build", 05:52:18 INFO - "True", 05:52:18 INFO - "Change" 05:52:18 INFO - ] 05:52:18 INFO - ], 05:52:18 INFO - "revision": "882e6011c18f968f3e6993e4fac60c68ae6366a0" 05:52:18 INFO - } 05:52:18 INFO - ], 05:52:18 INFO - "revision": "882e6011c18f968f3e6993e4fac60c68ae6366a0" 05:52:18 INFO - } 05:52:18 INFO - } 05:52:18 INFO - Found installer url https://queue.taskcluster.net/v1/task/2p0v77w4SLK4Lf8Vflb2rg/artifacts/public/build/firefox-45.0a2.en-US.linux-x86_64.tar.bz2. 05:52:18 INFO - Running post-action listener: _resource_record_post_action 05:52:18 INFO - ##### 05:52:18 INFO - ##### Running download-and-extract step. 05:52:18 INFO - ##### 05:52:18 INFO - Running pre-action listener: _resource_record_pre_action 05:52:18 INFO - Running main action method: download_and_extract 05:52:18 INFO - mkdir: /builds/slave/test-pgo/build/tests 05:52:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:52:18 INFO - https://queue.taskcluster.net/v1/task/2p0v77w4SLK4Lf8Vflb2rg/artifacts/public/build/test_packages.json matches https://queue.taskcluster.net 05:52:18 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/2p0v77w4SLK4Lf8Vflb2rg/artifacts/public/build/test_packages.json 05:52:18 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/2p0v77w4SLK4Lf8Vflb2rg/artifacts/public/build/test_packages.json 05:52:18 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/2p0v77w4SLK4Lf8Vflb2rg/artifacts/public/build/test_packages.json to /builds/slave/test-pgo/build/test_packages.json 05:52:18 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/2p0v77w4SLK4Lf8Vflb2rg/artifacts/public/build/test_packages.json', 'file_name': '/builds/slave/test-pgo/build/test_packages.json'}, attempt #1 05:52:20 INFO - Downloaded 1302 bytes. 05:52:20 INFO - Reading from file /builds/slave/test-pgo/build/test_packages.json 05:52:20 INFO - Using the following test package requirements: 05:52:20 INFO - {u'common': [u'firefox-45.0a2.en-US.linux-x86_64.common.tests.zip'], 05:52:20 INFO - u'cppunittest': [u'firefox-45.0a2.en-US.linux-x86_64.common.tests.zip', 05:52:20 INFO - u'firefox-45.0a2.en-US.linux-x86_64.cppunittest.tests.zip'], 05:52:20 INFO - u'jittest': [u'firefox-45.0a2.en-US.linux-x86_64.common.tests.zip', 05:52:20 INFO - u'jsshell-linux-x86_64.zip'], 05:52:20 INFO - u'mochitest': [u'firefox-45.0a2.en-US.linux-x86_64.common.tests.zip', 05:52:20 INFO - u'firefox-45.0a2.en-US.linux-x86_64.mochitest.tests.zip'], 05:52:20 INFO - u'mozbase': [u'firefox-45.0a2.en-US.linux-x86_64.common.tests.zip'], 05:52:20 INFO - u'reftest': [u'firefox-45.0a2.en-US.linux-x86_64.common.tests.zip', 05:52:20 INFO - u'firefox-45.0a2.en-US.linux-x86_64.reftest.tests.zip'], 05:52:20 INFO - u'talos': [u'firefox-45.0a2.en-US.linux-x86_64.common.tests.zip', 05:52:20 INFO - u'firefox-45.0a2.en-US.linux-x86_64.talos.tests.zip'], 05:52:20 INFO - u'web-platform': [u'firefox-45.0a2.en-US.linux-x86_64.common.tests.zip', 05:52:20 INFO - u'firefox-45.0a2.en-US.linux-x86_64.web-platform.tests.zip'], 05:52:20 INFO - u'webapprt': [u'firefox-45.0a2.en-US.linux-x86_64.common.tests.zip'], 05:52:20 INFO - u'xpcshell': [u'firefox-45.0a2.en-US.linux-x86_64.common.tests.zip', 05:52:20 INFO - u'firefox-45.0a2.en-US.linux-x86_64.xpcshell.tests.zip']} 05:52:20 INFO - Downloading packages: [u'firefox-45.0a2.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 05:52:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:52:20 INFO - https://queue.taskcluster.net/v1/task/2p0v77w4SLK4Lf8Vflb2rg/artifacts/public/build/firefox-45.0a2.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 05:52:20 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/2p0v77w4SLK4Lf8Vflb2rg/artifacts/public/build/firefox-45.0a2.en-US.linux-x86_64.common.tests.zip 05:52:20 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/2p0v77w4SLK4Lf8Vflb2rg/artifacts/public/build/firefox-45.0a2.en-US.linux-x86_64.common.tests.zip 05:52:20 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/2p0v77w4SLK4Lf8Vflb2rg/artifacts/public/build/firefox-45.0a2.en-US.linux-x86_64.common.tests.zip to /builds/slave/test-pgo/build/firefox-45.0a2.en-US.linux-x86_64.common.tests.zip 05:52:20 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/2p0v77w4SLK4Lf8Vflb2rg/artifacts/public/build/firefox-45.0a2.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test-pgo/build/firefox-45.0a2.en-US.linux-x86_64.common.tests.zip'}, attempt #1 05:52:21 INFO - Downloaded 23159812 bytes. 05:52:21 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-45.0a2.en-US.linux-x86_64.common.tests.zip'] in /builds/slave/test-pgo/build/tests 05:52:21 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-45.0a2.en-US.linux-x86_64.common.tests.zip 05:52:21 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-45.0a2.en-US.linux-x86_64.common.tests.zip'] with output_timeout 1760 05:52:23 INFO - Return code: 0 05:52:23 INFO - Downloading packages: [u'firefox-45.0a2.en-US.linux-x86_64.common.tests.zip', u'firefox-45.0a2.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 05:52:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:52:23 INFO - https://queue.taskcluster.net/v1/task/2p0v77w4SLK4Lf8Vflb2rg/artifacts/public/build/firefox-45.0a2.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 05:52:23 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/2p0v77w4SLK4Lf8Vflb2rg/artifacts/public/build/firefox-45.0a2.en-US.linux-x86_64.common.tests.zip 05:52:23 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/2p0v77w4SLK4Lf8Vflb2rg/artifacts/public/build/firefox-45.0a2.en-US.linux-x86_64.common.tests.zip 05:52:23 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/2p0v77w4SLK4Lf8Vflb2rg/artifacts/public/build/firefox-45.0a2.en-US.linux-x86_64.common.tests.zip to /builds/slave/test-pgo/build/firefox-45.0a2.en-US.linux-x86_64.common.tests.zip 05:52:23 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/2p0v77w4SLK4Lf8Vflb2rg/artifacts/public/build/firefox-45.0a2.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test-pgo/build/firefox-45.0a2.en-US.linux-x86_64.common.tests.zip'}, attempt #1 05:52:29 INFO - Downloaded 23159812 bytes. 05:52:29 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-45.0a2.en-US.linux-x86_64.common.tests.zip'] in /builds/slave/test-pgo/build/tests 05:52:29 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-45.0a2.en-US.linux-x86_64.common.tests.zip 05:52:29 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-45.0a2.en-US.linux-x86_64.common.tests.zip'] with output_timeout 1760 05:52:30 INFO - Return code: 0 05:52:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:52:30 INFO - https://queue.taskcluster.net/v1/task/2p0v77w4SLK4Lf8Vflb2rg/artifacts/public/build/firefox-45.0a2.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 05:52:30 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/2p0v77w4SLK4Lf8Vflb2rg/artifacts/public/build/firefox-45.0a2.en-US.linux-x86_64.talos.tests.zip 05:52:30 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/2p0v77w4SLK4Lf8Vflb2rg/artifacts/public/build/firefox-45.0a2.en-US.linux-x86_64.talos.tests.zip 05:52:30 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/2p0v77w4SLK4Lf8Vflb2rg/artifacts/public/build/firefox-45.0a2.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test-pgo/build/firefox-45.0a2.en-US.linux-x86_64.talos.tests.zip 05:52:30 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/2p0v77w4SLK4Lf8Vflb2rg/artifacts/public/build/firefox-45.0a2.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test-pgo/build/firefox-45.0a2.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 05:52:31 INFO - Downloaded 11132038 bytes. 05:52:31 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-45.0a2.en-US.linux-x86_64.talos.tests.zip'] in /builds/slave/test-pgo/build/tests 05:52:31 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-45.0a2.en-US.linux-x86_64.talos.tests.zip 05:52:31 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-45.0a2.en-US.linux-x86_64.talos.tests.zip'] with output_timeout 1760 05:52:31 INFO - Return code: 0 05:52:31 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:52:31 INFO - https://queue.taskcluster.net/v1/task/2p0v77w4SLK4Lf8Vflb2rg/artifacts/public/build/firefox-45.0a2.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 05:52:31 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/2p0v77w4SLK4Lf8Vflb2rg/artifacts/public/build/firefox-45.0a2.en-US.linux-x86_64.tar.bz2 05:52:31 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/2p0v77w4SLK4Lf8Vflb2rg/artifacts/public/build/firefox-45.0a2.en-US.linux-x86_64.tar.bz2 05:52:31 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/2p0v77w4SLK4Lf8Vflb2rg/artifacts/public/build/firefox-45.0a2.en-US.linux-x86_64.tar.bz2 to /builds/slave/test-pgo/build/firefox-45.0a2.en-US.linux-x86_64.tar.bz2 05:52:31 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/2p0v77w4SLK4Lf8Vflb2rg/artifacts/public/build/firefox-45.0a2.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test-pgo/build/firefox-45.0a2.en-US.linux-x86_64.tar.bz2'}, attempt #1 05:52:33 INFO - Downloaded 58150750 bytes. 05:52:33 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/2p0v77w4SLK4Lf8Vflb2rg/artifacts/public/build/firefox-45.0a2.en-US.linux-x86_64.tar.bz2 05:52:33 INFO - mkdir: /builds/slave/test-pgo/properties 05:52:33 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test-pgo/properties/build_url 05:52:33 INFO - Writing to file /builds/slave/test-pgo/properties/build_url 05:52:33 INFO - Contents: 05:52:33 INFO - build_url:https://queue.taskcluster.net/v1/task/2p0v77w4SLK4Lf8Vflb2rg/artifacts/public/build/firefox-45.0a2.en-US.linux-x86_64.tar.bz2 05:52:33 INFO - Running post-action listener: _resource_record_post_action 05:52:33 INFO - Running post-action listener: set_extra_try_arguments 05:52:33 INFO - ##### 05:52:33 INFO - ##### Running populate-webroot step. 05:52:33 INFO - ##### 05:52:33 INFO - Running pre-action listener: _resource_record_pre_action 05:52:33 INFO - Running main action method: populate_webroot 05:52:33 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 05:52:33 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 05:52:33 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 05:52:33 INFO - '--tppagecycles', 05:52:33 INFO - '7'], 05:52:33 INFO - 'tests': ['tsvgm']}}, 05:52:33 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 05:52:33 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 05:52:33 INFO - 'tests': ['tresize', 'tcanvasmark']}, 05:52:33 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 05:52:33 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 05:52:33 INFO - 'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 05:52:33 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:52:33 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 05:52:33 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:52:33 INFO - 'talos_options': ['--e10s'], 05:52:33 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 05:52:33 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:52:33 INFO - 'tests': ['damp', 'tps']}, 05:52:33 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:52:33 INFO - 'talos_options': ['--e10s'], 05:52:33 INFO - 'tests': ['damp', 'tps']}, 05:52:33 INFO - 'g3': {'tests': ['dromaeo_dom']}, 05:52:33 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 05:52:33 INFO - 'other': {'tests': ['a11yr', 05:52:33 INFO - 'ts_paint', 05:52:33 INFO - 'tpaint', 05:52:33 INFO - 'sessionrestore', 05:52:33 INFO - 'sessionrestore_no_auto_restore']}, 05:52:33 INFO - 'other-e10s': {'talos_options': ['--e10s'], 05:52:33 INFO - 'tests': ['a11yr', 05:52:33 INFO - 'ts_paint', 05:52:33 INFO - 'tpaint', 05:52:33 INFO - 'sessionrestore', 05:52:33 INFO - 'sessionrestore_no_auto_restore']}, 05:52:33 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 05:52:33 INFO - 'tests': ['a11yr', 05:52:33 INFO - 'ts_paint', 05:52:33 INFO - 'tpaint', 05:52:33 INFO - 'sessionrestore', 05:52:33 INFO - 'sessionrestore_no_auto_restore']}, 05:52:33 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 05:52:33 INFO - 'tests': ['a11yr', 05:52:33 INFO - 'ts_paint', 05:52:33 INFO - 'tpaint', 05:52:33 INFO - 'sessionrestore', 05:52:33 INFO - 'sessionrestore_no_auto_restore']}, 05:52:33 INFO - 'other_l64': {'tests': ['a11yr', 05:52:33 INFO - 'ts_paint', 05:52:33 INFO - 'tpaint', 05:52:33 INFO - 'sessionrestore', 05:52:33 INFO - 'sessionrestore_no_auto_restore']}, 05:52:33 INFO - 'other_nol64': {'tests': ['a11yr', 05:52:33 INFO - 'ts_paint', 05:52:33 INFO - 'tpaint', 05:52:33 INFO - 'sessionrestore', 05:52:33 INFO - 'sessionrestore_no_auto_restore']}, 05:52:33 INFO - 'svgr': {'tests': ['tsvgx', 05:52:33 INFO - 'tsvgr_opacity', 05:52:33 INFO - 'tart', 05:52:33 INFO - 'tscrollx', 05:52:33 INFO - 'cart']}, 05:52:33 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 05:52:33 INFO - 'tests': ['tsvgx', 05:52:33 INFO - 'tsvgr_opacity', 05:52:33 INFO - 'tart', 05:52:33 INFO - 'tscrollx', 05:52:33 INFO - 'cart']}, 05:52:33 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:52:33 INFO - 'tests': ['tp5o']}, 05:52:33 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:52:33 INFO - 'talos_options': ['--e10s'], 05:52:33 INFO - 'tests': ['tp5o']}, 05:52:33 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:52:33 INFO - 'talos_options': ['--xperf_path', 05:52:33 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 05:52:33 INFO - 'tests': ['tp5n']}, 05:52:33 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:52:33 INFO - 'talos_options': ['--e10s', 05:52:33 INFO - '--xperf_path', 05:52:33 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 05:52:33 INFO - 'tests': ['tp5n']}}, 05:52:33 INFO - 'talos.zip': {'path': '', 05:52:33 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 05:52:33 INFO - Running post-action listener: _resource_record_post_action 05:52:33 INFO - ##### 05:52:33 INFO - ##### Running create-virtualenv step. 05:52:33 INFO - ##### 05:52:33 INFO - Running pre-action listener: _resource_record_pre_action 05:52:33 INFO - Running main action method: create_virtualenv 05:52:33 INFO - Creating virtualenv /builds/slave/test-pgo/build/venv 05:52:33 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test-pgo/build/venv'] in /builds/slave/test-pgo/build 05:52:33 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test-pgo/build/venv 05:52:33 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 05:52:33 INFO - Using real prefix '/usr' 05:52:33 INFO - New python executable in /builds/slave/test-pgo/build/venv/bin/python 05:52:34 INFO - Installing distribute.............................................................................................................................................................................................done. 05:52:36 INFO - Installing pip.................done. 05:52:36 INFO - Return code: 0 05:52:36 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test-pgo/build/venv 05:52:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:52:36 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:52:36 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:52:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:52:36 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:52:36 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:52:36 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7feb40de8f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19638a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1a31450>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ac3a50>, 'level': 'warning'}, {'substr': 'Traceback (most recent call last)', 'level': 'error'}, {'substr': 'SyntaxError: ', 'level': 'error'}, {'substr': 'TypeError: ', 'level': 'error'}, {'substr': 'NameError: ', 'level': 'error'}, {'substr': 'ZeroDivisionError: ', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a2f550>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1a2f9e0>, 'level': 'critical'}], 'cwd': '/builds/slave/test-pgo/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': 'b5f16d05e5ea93ddf675e67e000001bf-1453470511.106647-1655455357', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test-pgo', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 05:52:36 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test-pgo/build 05:52:36 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 05:52:36 INFO - Using env: {'DISPLAY': ':0', 05:52:36 INFO - 'HOME': '/home/cltbld', 05:52:36 INFO - 'LANG': 'en_US.UTF-8', 05:52:36 INFO - 'LANGUAGE': 'en_US:en', 05:52:36 INFO - 'LOGNAME': 'cltbld', 05:52:36 INFO - 'MAIL': '/var/mail/cltbld', 05:52:36 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:52:36 INFO - 'MOZ_NO_REMOTE': '1', 05:52:36 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:52:36 INFO - 'NO_EM_RESTART': '1', 05:52:36 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:52:36 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 05:52:36 INFO - 'PWD': '/builds/slave/test-pgo', 05:52:36 INFO - 'SHELL': '/bin/bash', 05:52:36 INFO - 'SHLVL': '1', 05:52:36 INFO - 'TERM': 'linux', 05:52:36 INFO - 'TMOUT': '86400', 05:52:36 INFO - 'USER': 'cltbld', 05:52:36 INFO - 'XDG_SESSION_COOKIE': 'b5f16d05e5ea93ddf675e67e000001bf-1453470511.106647-1655455357', 05:52:36 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:52:36 INFO - '_': '/tools/buildbot/bin/python'} 05:52:36 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:52:36 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 05:52:36 INFO - Cleaning up... 05:52:36 INFO - Return code: 0 05:52:36 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test-pgo/build/venv 05:52:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:52:36 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:52:36 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:52:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:52:36 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:52:36 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:52:36 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=0.7.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7feb40de8f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19638a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1a31450>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ac3a50>, 'level': 'warning'}, {'substr': 'Traceback (most recent call last)', 'level': 'error'}, {'substr': 'SyntaxError: ', 'level': 'error'}, {'substr': 'TypeError: ', 'level': 'error'}, {'substr': 'NameError: ', 'level': 'error'}, {'substr': 'ZeroDivisionError: ', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a2f550>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1a2f9e0>, 'level': 'critical'}], 'cwd': '/builds/slave/test-pgo/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': 'b5f16d05e5ea93ddf675e67e000001bf-1453470511.106647-1655455357', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test-pgo', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 05:52:36 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=0.7.1'] in /builds/slave/test-pgo/build 05:52:36 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=0.7.1 05:52:36 INFO - Using env: {'DISPLAY': ':0', 05:52:36 INFO - 'HOME': '/home/cltbld', 05:52:36 INFO - 'LANG': 'en_US.UTF-8', 05:52:36 INFO - 'LANGUAGE': 'en_US:en', 05:52:36 INFO - 'LOGNAME': 'cltbld', 05:52:36 INFO - 'MAIL': '/var/mail/cltbld', 05:52:36 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:52:36 INFO - 'MOZ_NO_REMOTE': '1', 05:52:36 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:52:36 INFO - 'NO_EM_RESTART': '1', 05:52:36 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:52:36 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 05:52:36 INFO - 'PWD': '/builds/slave/test-pgo', 05:52:36 INFO - 'SHELL': '/bin/bash', 05:52:36 INFO - 'SHLVL': '1', 05:52:36 INFO - 'TERM': 'linux', 05:52:36 INFO - 'TMOUT': '86400', 05:52:36 INFO - 'USER': 'cltbld', 05:52:36 INFO - 'XDG_SESSION_COOKIE': 'b5f16d05e5ea93ddf675e67e000001bf-1453470511.106647-1655455357', 05:52:36 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:52:36 INFO - '_': '/tools/buildbot/bin/python'} 05:52:36 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:52:36 INFO - Downloading/unpacking psutil>=0.7.1 05:52:36 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:52:36 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:52:36 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:52:36 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:52:36 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:52:36 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:52:38 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/psutil/setup.py) egg_info for package psutil 05:52:38 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 05:52:38 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 05:52:38 INFO - Installing collected packages: psutil 05:52:38 INFO - Running setup.py install for psutil 05:52:38 INFO - building 'psutil._psutil_linux' extension 05:52:38 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -DPSUTIL_VERSION=311 -I/usr/include/python2.7 -c psutil/_psutil_linux.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o 05:52:38 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_linux.so 05:52:38 INFO - building 'psutil._psutil_posix' extension 05:52:38 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -I/usr/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o 05:52:38 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_posix.so 05:52:38 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 05:52:38 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 05:52:38 INFO - Successfully installed psutil 05:52:38 INFO - Cleaning up... 05:52:38 INFO - Return code: 0 05:52:38 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test-pgo/build/venv 05:52:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:52:38 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:52:38 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:52:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:52:38 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:52:38 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:52:38 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.0.0']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7feb40de8f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19638a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1a31450>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ac3a50>, 'level': 'warning'}, {'substr': 'Traceback (most recent call last)', 'level': 'error'}, {'substr': 'SyntaxError: ', 'level': 'error'}, {'substr': 'TypeError: ', 'level': 'error'}, {'substr': 'NameError: ', 'level': 'error'}, {'substr': 'ZeroDivisionError: ', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a2f550>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1a2f9e0>, 'level': 'critical'}], 'cwd': '/builds/slave/test-pgo/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': 'b5f16d05e5ea93ddf675e67e000001bf-1453470511.106647-1655455357', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test-pgo', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 05:52:38 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.0.0'] in /builds/slave/test-pgo/build 05:52:38 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.0.0 05:52:38 INFO - Using env: {'DISPLAY': ':0', 05:52:38 INFO - 'HOME': '/home/cltbld', 05:52:38 INFO - 'LANG': 'en_US.UTF-8', 05:52:38 INFO - 'LANGUAGE': 'en_US:en', 05:52:38 INFO - 'LOGNAME': 'cltbld', 05:52:38 INFO - 'MAIL': '/var/mail/cltbld', 05:52:38 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:52:38 INFO - 'MOZ_NO_REMOTE': '1', 05:52:38 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:52:38 INFO - 'NO_EM_RESTART': '1', 05:52:38 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:52:38 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 05:52:38 INFO - 'PWD': '/builds/slave/test-pgo', 05:52:38 INFO - 'SHELL': '/bin/bash', 05:52:38 INFO - 'SHLVL': '1', 05:52:38 INFO - 'TERM': 'linux', 05:52:38 INFO - 'TMOUT': '86400', 05:52:38 INFO - 'USER': 'cltbld', 05:52:38 INFO - 'XDG_SESSION_COOKIE': 'b5f16d05e5ea93ddf675e67e000001bf-1453470511.106647-1655455357', 05:52:38 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:52:38 INFO - '_': '/tools/buildbot/bin/python'} 05:52:39 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:52:39 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 05:52:39 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:52:39 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:52:39 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:52:39 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:52:39 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:52:39 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:52:40 INFO - Downloading mozsystemmonitor-0.0.tar.gz 05:52:40 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 05:52:40 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 05:52:40 INFO - Installing collected packages: mozsystemmonitor 05:52:40 INFO - Running setup.py install for mozsystemmonitor 05:52:41 INFO - Successfully installed mozsystemmonitor 05:52:41 INFO - Cleaning up... 05:52:41 INFO - Return code: 0 05:52:41 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test-pgo/build/venv 05:52:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:52:41 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:52:41 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:52:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:52:41 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:52:41 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:52:41 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7feb40de8f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19638a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1a31450>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ac3a50>, 'level': 'warning'}, {'substr': 'Traceback (most recent call last)', 'level': 'error'}, {'substr': 'SyntaxError: ', 'level': 'error'}, {'substr': 'TypeError: ', 'level': 'error'}, {'substr': 'NameError: ', 'level': 'error'}, {'substr': 'ZeroDivisionError: ', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a2f550>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1a2f9e0>, 'level': 'critical'}], 'cwd': '/builds/slave/test-pgo/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': 'b5f16d05e5ea93ddf675e67e000001bf-1453470511.106647-1655455357', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test-pgo', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 05:52:41 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test-pgo/build 05:52:41 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 05:52:41 INFO - Using env: {'DISPLAY': ':0', 05:52:41 INFO - 'HOME': '/home/cltbld', 05:52:41 INFO - 'LANG': 'en_US.UTF-8', 05:52:41 INFO - 'LANGUAGE': 'en_US:en', 05:52:41 INFO - 'LOGNAME': 'cltbld', 05:52:41 INFO - 'MAIL': '/var/mail/cltbld', 05:52:41 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:52:41 INFO - 'MOZ_NO_REMOTE': '1', 05:52:41 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:52:41 INFO - 'NO_EM_RESTART': '1', 05:52:41 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:52:41 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 05:52:41 INFO - 'PWD': '/builds/slave/test-pgo', 05:52:41 INFO - 'SHELL': '/bin/bash', 05:52:41 INFO - 'SHLVL': '1', 05:52:41 INFO - 'TERM': 'linux', 05:52:41 INFO - 'TMOUT': '86400', 05:52:41 INFO - 'USER': 'cltbld', 05:52:41 INFO - 'XDG_SESSION_COOKIE': 'b5f16d05e5ea93ddf675e67e000001bf-1453470511.106647-1655455357', 05:52:41 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:52:41 INFO - '_': '/tools/buildbot/bin/python'} 05:52:41 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:52:41 INFO - Downloading/unpacking blobuploader==1.2.4 05:52:41 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:52:41 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:52:41 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:52:41 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:52:41 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:52:41 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:52:43 INFO - Downloading blobuploader-1.2.4.tar.gz 05:52:43 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 05:52:43 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 05:52:43 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:52:43 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:52:43 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:52:43 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:52:43 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:52:43 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:52:43 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/requests/setup.py) egg_info for package requests 05:52:43 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 05:52:43 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:52:43 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:52:43 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:52:43 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:52:43 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:52:43 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:52:43 INFO - Downloading docopt-0.6.1.tar.gz 05:52:43 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/docopt/setup.py) egg_info for package docopt 05:52:43 INFO - Installing collected packages: blobuploader, requests, docopt 05:52:43 INFO - Running setup.py install for blobuploader 05:52:43 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 05:52:43 INFO - changing mode of /builds/slave/test-pgo/build/venv/bin/blobberc.py to 775 05:52:43 INFO - Running setup.py install for requests 05:52:44 INFO - Running setup.py install for docopt 05:52:44 INFO - Successfully installed blobuploader requests docopt 05:52:44 INFO - Cleaning up... 05:52:44 INFO - Return code: 0 05:52:44 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 05:52:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:52:44 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:52:44 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:52:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:52:44 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:52:44 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:52:44 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7feb40de8f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19638a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1a31450>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ac3a50>, 'level': 'warning'}, {'substr': 'Traceback (most recent call last)', 'level': 'error'}, {'substr': 'SyntaxError: ', 'level': 'error'}, {'substr': 'TypeError: ', 'level': 'error'}, {'substr': 'NameError: ', 'level': 'error'}, {'substr': 'ZeroDivisionError: ', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a2f550>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1a2f9e0>, 'level': 'critical'}], 'cwd': '/builds/slave/test-pgo/build/tests/config', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': 'b5f16d05e5ea93ddf675e67e000001bf-1453470511.106647-1655455357', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test-pgo', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 05:52:44 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test-pgo/build/tests/config 05:52:44 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 05:52:44 INFO - Using env: {'DISPLAY': ':0', 05:52:44 INFO - 'HOME': '/home/cltbld', 05:52:44 INFO - 'LANG': 'en_US.UTF-8', 05:52:44 INFO - 'LANGUAGE': 'en_US:en', 05:52:44 INFO - 'LOGNAME': 'cltbld', 05:52:44 INFO - 'MAIL': '/var/mail/cltbld', 05:52:44 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:52:44 INFO - 'MOZ_NO_REMOTE': '1', 05:52:44 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:52:44 INFO - 'NO_EM_RESTART': '1', 05:52:44 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:52:44 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 05:52:44 INFO - 'PWD': '/builds/slave/test-pgo', 05:52:44 INFO - 'SHELL': '/bin/bash', 05:52:44 INFO - 'SHLVL': '1', 05:52:44 INFO - 'TERM': 'linux', 05:52:44 INFO - 'TMOUT': '86400', 05:52:44 INFO - 'USER': 'cltbld', 05:52:44 INFO - 'XDG_SESSION_COOKIE': 'b5f16d05e5ea93ddf675e67e000001bf-1453470511.106647-1655455357', 05:52:44 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:52:44 INFO - '_': '/tools/buildbot/bin/python'} 05:52:44 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:52:44 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 05:52:44 INFO - Running setup.py (path:/tmp/pip-gnemc0-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 05:52:44 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 05:52:44 INFO - Running setup.py (path:/tmp/pip-i__K0h-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 05:52:44 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 05:52:44 INFO - Running setup.py (path:/tmp/pip-V_klpv-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 05:52:44 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 05:52:44 INFO - Running setup.py (path:/tmp/pip-3zq9VV-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 05:52:44 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 05:52:44 INFO - Running setup.py (path:/tmp/pip-O4oae3-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 05:52:45 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 05:52:45 INFO - Running setup.py (path:/tmp/pip-472pfs-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 05:52:45 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 05:52:45 INFO - Running setup.py (path:/tmp/pip-7iDfPS-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 05:52:45 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 05:52:45 INFO - Running setup.py (path:/tmp/pip-hnnlBI-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 05:52:45 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 05:52:45 INFO - Running setup.py (path:/tmp/pip-aGMQ7F-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 05:52:45 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 05:52:45 INFO - Running setup.py (path:/tmp/pip-n_DMw5-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 05:52:45 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 05:52:45 INFO - Running setup.py (path:/tmp/pip-WnMP8O-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 05:52:45 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 05:52:45 INFO - Running setup.py (path:/tmp/pip-Xxx9vK-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 05:52:45 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 05:52:45 INFO - Running setup.py (path:/tmp/pip-NRThI6-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 05:52:45 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 05:52:45 INFO - Running setup.py (path:/tmp/pip-tkEpYt-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 05:52:45 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 05:52:45 INFO - Running setup.py (path:/tmp/pip-8ZLlkg-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 05:52:45 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 05:52:45 INFO - Running setup.py (path:/tmp/pip-JG1Ywr-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 05:52:45 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 05:52:45 INFO - Running setup.py (path:/tmp/pip-UbCwM_-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 05:52:45 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 05:52:45 INFO - Running setup.py install for manifestparser 05:52:45 INFO - Installing manifestparser script to /builds/slave/test-pgo/build/venv/bin 05:52:45 INFO - Running setup.py install for mozcrash 05:52:46 INFO - Running setup.py install for mozdebug 05:52:46 INFO - Running setup.py install for mozdevice 05:52:46 INFO - Installing sutini script to /builds/slave/test-pgo/build/venv/bin 05:52:46 INFO - Installing dm script to /builds/slave/test-pgo/build/venv/bin 05:52:46 INFO - Running setup.py install for mozfile 05:52:46 INFO - Running setup.py install for mozhttpd 05:52:46 INFO - Installing mozhttpd script to /builds/slave/test-pgo/build/venv/bin 05:52:46 INFO - Running setup.py install for mozinfo 05:52:46 INFO - Installing mozinfo script to /builds/slave/test-pgo/build/venv/bin 05:52:46 INFO - Running setup.py install for mozInstall 05:52:46 INFO - Installing moz_remove_from_system script to /builds/slave/test-pgo/build/venv/bin 05:52:46 INFO - Installing mozuninstall script to /builds/slave/test-pgo/build/venv/bin 05:52:46 INFO - Installing mozinstall script to /builds/slave/test-pgo/build/venv/bin 05:52:46 INFO - Installing moz_add_to_system script to /builds/slave/test-pgo/build/venv/bin 05:52:46 INFO - Running setup.py install for mozleak 05:52:46 INFO - Running setup.py install for mozlog 05:52:46 INFO - Installing structlog script to /builds/slave/test-pgo/build/venv/bin 05:52:46 INFO - Running setup.py install for moznetwork 05:52:46 INFO - Installing moznetwork script to /builds/slave/test-pgo/build/venv/bin 05:52:47 INFO - Running setup.py install for mozprocess 05:52:47 INFO - Running setup.py install for mozprofile 05:52:47 INFO - Installing mozprofile script to /builds/slave/test-pgo/build/venv/bin 05:52:47 INFO - Installing diff-profiles script to /builds/slave/test-pgo/build/venv/bin 05:52:47 INFO - Installing view-profile script to /builds/slave/test-pgo/build/venv/bin 05:52:47 INFO - Running setup.py install for mozrunner 05:52:47 INFO - Installing mozrunner script to /builds/slave/test-pgo/build/venv/bin 05:52:47 INFO - Running setup.py install for mozscreenshot 05:52:47 INFO - Running setup.py install for moztest 05:52:47 INFO - Running setup.py install for mozversion 05:52:47 INFO - Installing mozversion script to /builds/slave/test-pgo/build/venv/bin 05:52:47 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 05:52:47 INFO - Cleaning up... 05:52:47 INFO - Return code: 0 05:52:47 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 05:52:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:52:47 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:52:47 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:52:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:52:47 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:52:47 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:52:47 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7feb40de8f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19638a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1a31450>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ac3a50>, 'level': 'warning'}, {'substr': 'Traceback (most recent call last)', 'level': 'error'}, {'substr': 'SyntaxError: ', 'level': 'error'}, {'substr': 'TypeError: ', 'level': 'error'}, {'substr': 'NameError: ', 'level': 'error'}, {'substr': 'ZeroDivisionError: ', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a2f550>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1a2f9e0>, 'level': 'critical'}], 'cwd': '/builds/slave/test-pgo/build/tests/config', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': 'b5f16d05e5ea93ddf675e67e000001bf-1453470511.106647-1655455357', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test-pgo', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 05:52:47 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test-pgo/build/tests/config 05:52:47 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --timeout 120 -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 05:52:47 INFO - Using env: {'DISPLAY': ':0', 05:52:47 INFO - 'HOME': '/home/cltbld', 05:52:47 INFO - 'LANG': 'en_US.UTF-8', 05:52:47 INFO - 'LANGUAGE': 'en_US:en', 05:52:47 INFO - 'LOGNAME': 'cltbld', 05:52:47 INFO - 'MAIL': '/var/mail/cltbld', 05:52:47 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:52:47 INFO - 'MOZ_NO_REMOTE': '1', 05:52:47 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:52:47 INFO - 'NO_EM_RESTART': '1', 05:52:47 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:52:47 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 05:52:47 INFO - 'PWD': '/builds/slave/test-pgo', 05:52:47 INFO - 'SHELL': '/bin/bash', 05:52:47 INFO - 'SHLVL': '1', 05:52:47 INFO - 'TERM': 'linux', 05:52:47 INFO - 'TMOUT': '86400', 05:52:47 INFO - 'USER': 'cltbld', 05:52:47 INFO - 'XDG_SESSION_COOKIE': 'b5f16d05e5ea93ddf675e67e000001bf-1453470511.106647-1655455357', 05:52:47 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:52:47 INFO - '_': '/tools/buildbot/bin/python'} 05:52:47 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:52:47 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 05:52:47 INFO - Running setup.py (path:/tmp/pip-bExeWp-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 05:52:47 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 1)) 05:52:47 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 05:52:47 INFO - Running setup.py (path:/tmp/pip-ieVvcx-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 05:52:48 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.16 from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 2)) 05:52:48 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 05:52:48 INFO - Running setup.py (path:/tmp/pip-WIFXk6-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 05:52:48 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 3)) 05:52:48 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 05:52:48 INFO - Running setup.py (path:/tmp/pip-TLbGk8-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 05:52:48 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.47 from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 4)) 05:52:48 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 05:52:48 INFO - Running setup.py (path:/tmp/pip-S7KH9h-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 05:52:48 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 5)) 05:52:48 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 05:52:48 INFO - Running setup.py (path:/tmp/pip-Rf9Pyr-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 05:52:48 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 6)) 05:52:48 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 05:52:48 INFO - Running setup.py (path:/tmp/pip-70Dnky-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 05:52:48 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 7)) 05:52:48 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 05:52:48 INFO - Running setup.py (path:/tmp/pip-SiEhhl-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 05:52:48 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 8)) 05:52:48 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 05:52:48 INFO - Running setup.py (path:/tmp/pip-PrU8NW-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 05:52:48 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 9)) 05:52:48 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 05:52:48 INFO - Running setup.py (path:/tmp/pip-kpIxVm-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 05:52:48 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.1 from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 10)) 05:52:48 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 05:52:48 INFO - Running setup.py (path:/tmp/pip-lUVBVy-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 05:52:48 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 11)) 05:52:48 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 05:52:48 INFO - Running setup.py (path:/tmp/pip-t2vDXl-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 05:52:48 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.22 from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 12)) 05:52:48 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 05:52:48 INFO - Running setup.py (path:/tmp/pip-HDpkjV-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 05:52:48 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.27 from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 13)) 05:52:48 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 05:52:48 INFO - Running setup.py (path:/tmp/pip-tRXfcy-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 05:52:48 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.11 from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 14)) 05:52:48 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 05:52:48 INFO - Running setup.py (path:/tmp/pip-591RTT-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 05:52:48 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 15)) 05:52:48 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 05:52:48 INFO - Running setup.py (path:/tmp/pip-ZgpQzB-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 05:52:49 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 from file:///builds/slave/test-pgo/build/tests/mozbase/moztest in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 16)) 05:52:49 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 05:52:49 INFO - Running setup.py (path:/tmp/pip-6_OADx-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 05:52:49 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 17)) 05:52:49 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozcrash==0.16->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 2)) 05:52:49 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozcrash==0.16->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 2)) 05:52:49 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 3)) 05:52:49 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozdevice==0.47->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 4)) 05:52:49 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozdevice==0.47->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 4)) 05:52:49 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 10)) 05:52:49 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:52:49 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:52:49 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:52:49 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:52:49 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:52:49 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:52:50 INFO - Downloading blessings-1.6.tar.gz 05:52:50 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blessings/setup.py) egg_info for package blessings 05:52:50 INFO - Installing collected packages: blessings 05:52:50 INFO - Running setup.py install for blessings 05:52:51 INFO - Successfully installed blessings 05:52:51 INFO - Cleaning up... 05:52:51 INFO - Return code: 0 05:52:51 INFO - Done creating virtualenv /builds/slave/test-pgo/build/venv. 05:52:51 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 05:52:51 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 05:52:51 INFO - Reading from file tmpfile_stdout 05:52:51 INFO - Current package versions: 05:52:51 INFO - argparse == 1.2.1 05:52:51 INFO - blessings == 1.6 05:52:51 INFO - blobuploader == 1.2.4 05:52:51 INFO - docopt == 0.6.1 05:52:51 INFO - manifestparser == 1.1 05:52:51 INFO - mozInstall == 1.12 05:52:51 INFO - mozcrash == 0.16 05:52:51 INFO - mozdebug == 0.1 05:52:51 INFO - mozdevice == 0.47 05:52:51 INFO - mozfile == 1.2 05:52:51 INFO - mozhttpd == 0.7 05:52:51 INFO - mozinfo == 0.9 05:52:51 INFO - mozleak == 0.1 05:52:51 INFO - mozlog == 3.1 05:52:51 INFO - moznetwork == 0.27 05:52:51 INFO - mozprocess == 0.22 05:52:51 INFO - mozprofile == 0.27 05:52:51 INFO - mozrunner == 6.11 05:52:51 INFO - mozscreenshot == 0.1 05:52:51 INFO - mozsystemmonitor == 0.0 05:52:51 INFO - moztest == 0.7 05:52:51 INFO - mozversion == 1.4 05:52:51 INFO - psutil == 3.1.1 05:52:51 INFO - requests == 1.2.3 05:52:51 INFO - wsgiref == 0.1.2 05:52:51 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 05:52:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:52:51 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:52:51 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:52:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:52:51 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:52:51 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:52:51 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test-pgo/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7feb40de8f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19638a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1a31450>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ac3a50>, 'level': 'warning'}, {'substr': 'Traceback (most recent call last)', 'level': 'error'}, {'substr': 'SyntaxError: ', 'level': 'error'}, {'substr': 'TypeError: ', 'level': 'error'}, {'substr': 'NameError: ', 'level': 'error'}, {'substr': 'ZeroDivisionError: ', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a2f550>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1a2f9e0>, 'level': 'critical'}], 'cwd': '/builds/slave/test-pgo/build/tests/talos', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': 'b5f16d05e5ea93ddf675e67e000001bf-1453470511.106647-1655455357', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test-pgo', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 05:52:51 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test-pgo/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test-pgo/build/tests/talos 05:52:51 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --timeout 120 -r /builds/slave/test-pgo/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 05:52:51 INFO - Using env: {'DISPLAY': ':0', 05:52:51 INFO - 'HOME': '/home/cltbld', 05:52:51 INFO - 'LANG': 'en_US.UTF-8', 05:52:51 INFO - 'LANGUAGE': 'en_US:en', 05:52:51 INFO - 'LOGNAME': 'cltbld', 05:52:51 INFO - 'MAIL': '/var/mail/cltbld', 05:52:51 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:52:51 INFO - 'MOZ_NO_REMOTE': '1', 05:52:51 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:52:51 INFO - 'NO_EM_RESTART': '1', 05:52:51 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:52:51 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 05:52:51 INFO - 'PWD': '/builds/slave/test-pgo', 05:52:51 INFO - 'SHELL': '/bin/bash', 05:52:51 INFO - 'SHLVL': '1', 05:52:51 INFO - 'TERM': 'linux', 05:52:51 INFO - 'TMOUT': '86400', 05:52:51 INFO - 'USER': 'cltbld', 05:52:51 INFO - 'XDG_SESSION_COOKIE': 'b5f16d05e5ea93ddf675e67e000001bf-1453470511.106647-1655455357', 05:52:51 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:52:51 INFO - '_': '/tools/buildbot/bin/python'} 05:52:51 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:52:51 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 1)) 05:52:51 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 2)) 05:52:51 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 3)) 05:52:51 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 4)) 05:52:51 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 5)) 05:52:51 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 6)) 05:52:51 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 7)) 05:52:51 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 8)) 05:52:51 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozcrash>=0.15->-r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 1)) 05:52:51 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 3)) 05:52:51 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozlog>=3.0->mozcrash>=0.15->-r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 1)) 05:52:51 INFO - Cleaning up... 05:52:51 INFO - Return code: 0 05:52:51 INFO - Installing jsonschema into virtualenv /builds/slave/test-pgo/build/venv 05:52:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:52:51 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:52:51 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:52:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:52:51 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:52:51 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:52:51 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7feb40de8f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19638a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1a31450>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ac3a50>, 'level': 'warning'}, {'substr': 'Traceback (most recent call last)', 'level': 'error'}, {'substr': 'SyntaxError: ', 'level': 'error'}, {'substr': 'TypeError: ', 'level': 'error'}, {'substr': 'NameError: ', 'level': 'error'}, {'substr': 'ZeroDivisionError: ', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a2f550>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1a2f9e0>, 'level': 'critical'}], 'cwd': '/builds/slave/test-pgo/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': 'b5f16d05e5ea93ddf675e67e000001bf-1453470511.106647-1655455357', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test-pgo', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 05:52:51 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test-pgo/build 05:52:51 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 05:52:51 INFO - Using env: {'DISPLAY': ':0', 05:52:51 INFO - 'HOME': '/home/cltbld', 05:52:51 INFO - 'LANG': 'en_US.UTF-8', 05:52:51 INFO - 'LANGUAGE': 'en_US:en', 05:52:51 INFO - 'LOGNAME': 'cltbld', 05:52:51 INFO - 'MAIL': '/var/mail/cltbld', 05:52:51 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:52:51 INFO - 'MOZ_NO_REMOTE': '1', 05:52:51 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:52:51 INFO - 'NO_EM_RESTART': '1', 05:52:51 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:52:51 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 05:52:51 INFO - 'PWD': '/builds/slave/test-pgo', 05:52:51 INFO - 'SHELL': '/bin/bash', 05:52:51 INFO - 'SHLVL': '1', 05:52:51 INFO - 'TERM': 'linux', 05:52:51 INFO - 'TMOUT': '86400', 05:52:51 INFO - 'USER': 'cltbld', 05:52:51 INFO - 'XDG_SESSION_COOKIE': 'b5f16d05e5ea93ddf675e67e000001bf-1453470511.106647-1655455357', 05:52:51 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:52:51 INFO - '_': '/tools/buildbot/bin/python'} 05:52:51 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:52:51 INFO - Downloading/unpacking jsonschema 05:52:51 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:52:51 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:52:51 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:52:51 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:52:51 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:52:51 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:52:53 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 05:52:53 INFO - Downloading/unpacking functools32 (from jsonschema) 05:52:53 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:52:53 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:52:53 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:52:53 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:52:53 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:52:53 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:52:53 INFO - Downloading functools32-3.2.3-2.tar.gz 05:52:53 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/functools32/setup.py) egg_info for package functools32 05:52:53 INFO - warning: no files found matching '*.txt' 05:52:53 INFO - no previously-included directories found matching 'build' 05:52:53 INFO - no previously-included directories found matching 'dist' 05:52:53 INFO - no previously-included directories found matching '.git*' 05:52:53 INFO - Installing collected packages: jsonschema, functools32 05:52:53 INFO - Running setup.py install for functools32 05:52:53 INFO - warning: no files found matching '*.txt' 05:52:53 INFO - no previously-included directories found matching 'build' 05:52:53 INFO - no previously-included directories found matching 'dist' 05:52:53 INFO - no previously-included directories found matching '.git*' 05:52:53 INFO - Successfully installed jsonschema functools32 05:52:53 INFO - Cleaning up... 05:52:54 INFO - Return code: 0 05:52:54 INFO - Installing flake8 into virtualenv /builds/slave/test-pgo/build/venv 05:52:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:52:54 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:52:54 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:52:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:52:54 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:52:54 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:52:54 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7feb40de8f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19638a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1a31450>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ac3a50>, 'level': 'warning'}, {'substr': 'Traceback (most recent call last)', 'level': 'error'}, {'substr': 'SyntaxError: ', 'level': 'error'}, {'substr': 'TypeError: ', 'level': 'error'}, {'substr': 'NameError: ', 'level': 'error'}, {'substr': 'ZeroDivisionError: ', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a2f550>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1a2f9e0>, 'level': 'critical'}], 'cwd': '/builds/slave/test-pgo/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': 'b5f16d05e5ea93ddf675e67e000001bf-1453470511.106647-1655455357', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test-pgo', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 05:52:54 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8'] in /builds/slave/test-pgo/build 05:52:54 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub flake8 05:52:54 INFO - Using env: {'DISPLAY': ':0', 05:52:54 INFO - 'HOME': '/home/cltbld', 05:52:54 INFO - 'LANG': 'en_US.UTF-8', 05:52:54 INFO - 'LANGUAGE': 'en_US:en', 05:52:54 INFO - 'LOGNAME': 'cltbld', 05:52:54 INFO - 'MAIL': '/var/mail/cltbld', 05:52:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:52:54 INFO - 'MOZ_NO_REMOTE': '1', 05:52:54 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:52:54 INFO - 'NO_EM_RESTART': '1', 05:52:54 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:52:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 05:52:54 INFO - 'PWD': '/builds/slave/test-pgo', 05:52:54 INFO - 'SHELL': '/bin/bash', 05:52:54 INFO - 'SHLVL': '1', 05:52:54 INFO - 'TERM': 'linux', 05:52:54 INFO - 'TMOUT': '86400', 05:52:54 INFO - 'USER': 'cltbld', 05:52:54 INFO - 'XDG_SESSION_COOKIE': 'b5f16d05e5ea93ddf675e67e000001bf-1453470511.106647-1655455357', 05:52:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:52:54 INFO - '_': '/tools/buildbot/bin/python'} 05:52:54 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:52:54 INFO - Downloading/unpacking flake8 05:52:54 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:52:54 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:52:54 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:52:54 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:52:54 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:52:54 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:52:55 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 05:52:55 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 05:52:55 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:52:55 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:52:55 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:52:55 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:52:55 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:52:55 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:52:56 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 05:52:56 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 05:52:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:52:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:52:56 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:52:56 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:52:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:52:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:52:56 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 05:52:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:52:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:52:56 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:52:56 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:52:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:52:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:52:56 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/pep8/setup.py) egg_info for package pep8 05:52:56 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 05:52:56 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 05:52:56 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 05:52:56 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 05:52:56 INFO - no previously-included directories found matching 'docs/_build' 05:52:56 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 05:52:56 INFO - Running setup.py install for pep8 05:52:56 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 05:52:56 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 05:52:56 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 05:52:56 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 05:52:56 INFO - no previously-included directories found matching 'docs/_build' 05:52:56 INFO - Installing pep8 script to /builds/slave/test-pgo/build/venv/bin 05:52:56 INFO - Successfully installed flake8 mccabe pyflakes pep8 05:52:56 INFO - Cleaning up... 05:52:56 INFO - Return code: 0 05:52:56 INFO - Running post-action listener: _resource_record_post_action 05:52:56 INFO - Running post-action listener: _start_resource_monitoring 05:52:56 INFO - Starting resource monitoring. 05:52:56 INFO - ##### 05:52:56 INFO - ##### Running install step. 05:52:56 INFO - ##### 05:52:56 INFO - Running pre-action listener: _resource_record_pre_action 05:52:56 INFO - Running main action method: install 05:52:56 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 05:52:56 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 05:52:57 INFO - Reading from file tmpfile_stdout 05:52:57 INFO - Detecting whether we're running mozinstall >=1.0... 05:52:57 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/mozinstall', '-h'] 05:52:57 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/mozinstall -h 05:52:57 INFO - Reading from file tmpfile_stdout 05:52:57 INFO - Output received: 05:52:57 INFO - Usage: mozinstall [options] installer 05:52:57 INFO - Options: 05:52:57 INFO - -h, --help show this help message and exit 05:52:57 INFO - -d DEST, --destination=DEST 05:52:57 INFO - Directory to install application into. [default: 05:52:57 INFO - "/builds/slave/test-pgo"] 05:52:57 INFO - --app=APP Application being installed. [default: firefox] 05:52:57 INFO - mkdir: /builds/slave/test-pgo/build/application 05:52:57 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/mozinstall', '/builds/slave/test-pgo/build/firefox-45.0a2.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test-pgo/build/application'] 05:52:57 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/mozinstall /builds/slave/test-pgo/build/firefox-45.0a2.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test-pgo/build/application 05:53:11 INFO - Reading from file tmpfile_stdout 05:53:11 INFO - Output received: 05:53:11 INFO - /builds/slave/test-pgo/build/application/firefox/firefox 05:53:11 INFO - Running post-action listener: _resource_record_post_action 05:53:11 INFO - ##### 05:53:11 INFO - ##### Running run-tests step. 05:53:11 INFO - ##### 05:53:11 INFO - Running pre-action listener: _resource_record_pre_action 05:53:11 INFO - Running main action method: run_tests 05:53:11 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '--version'] 05:53:11 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python --version 05:53:11 INFO - Python 2.7.3 05:53:11 INFO - Return code: 0 05:53:11 INFO - grabbing minidump binary from tooltool 05:53:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:53:11 INFO - retry: Calling run_command with args: (['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test-pgo/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'],), kwargs: {'error_list': [{'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ac3a50>, 'level': 'warning'}, {'substr': 'Traceback (most recent call last)', 'level': 'error'}, {'substr': 'SyntaxError: ', 'level': 'error'}, {'substr': 'TypeError: ', 'level': 'error'}, {'substr': 'NameError: ', 'level': 'error'}, {'substr': 'ZeroDivisionError: ', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a2f550>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1a2f9e0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test-pgo/build', 'privileged': False}, attempt #1 05:53:11 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test-pgo/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test-pgo/build 05:53:11 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test-pgo/build/tests/config/tooltool-manifests/linux64/releng.manifest -o -c /builds/tooltool_cache 05:53:11 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 05:53:11 INFO - Return code: 0 05:53:11 INFO - Chmoding /builds/slave/test-pgo/build/linux64-minidump_stackwalk to 0755 05:53:11 INFO - mkdir: /builds/slave/test-pgo/build/blobber_upload_dir 05:53:11 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test-pgo/build/blobber_upload_dir 05:53:11 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test-pgo/build/linux64-minidump_stackwalk 05:53:11 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test-pgo/build/blobber_upload_dir 05:53:11 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/flake8', '/builds/slave/test-pgo/build/tests/talos/talos'] 05:53:11 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/flake8 /builds/slave/test-pgo/build/tests/talos/talos 05:53:12 INFO - Return code: 0 05:53:12 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '/builds/slave/test-pgo/build/tests/talos/talos/run_tests.py', '--debug', '--branchName', 'Mozilla-Aurora', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test-pgo/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/2p0v77w4SLK4Lf8Vflb2rg/artifacts/public/build/firefox-45.0a2.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-007', '--webServer', 'localhost'] in /builds/slave/test-pgo/build 05:53:12 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python /builds/slave/test-pgo/build/tests/talos/talos/run_tests.py --debug --branchName Mozilla-Aurora --suite dromaeojs-e10s --executablePath /builds/slave/test-pgo/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/2p0v77w4SLK4Lf8Vflb2rg/artifacts/public/build/firefox-45.0a2.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-007 --webServer localhost 05:53:12 INFO - Using env: {'DISPLAY': ':0', 05:53:12 INFO - 'HOME': '/home/cltbld', 05:53:12 INFO - 'LANG': 'en_US.UTF-8', 05:53:12 INFO - 'LANGUAGE': 'en_US:en', 05:53:12 INFO - 'LOGNAME': 'cltbld', 05:53:12 INFO - 'MAIL': '/var/mail/cltbld', 05:53:12 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test-pgo/build/blobber_upload_dir', 05:53:12 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test-pgo/build/linux64-minidump_stackwalk', 05:53:12 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:53:12 INFO - 'MOZ_NO_REMOTE': '1', 05:53:12 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test-pgo/build/blobber_upload_dir', 05:53:12 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:53:12 INFO - 'NO_EM_RESTART': '1', 05:53:12 INFO - 'PATH': '/builds/slave/test-pgo/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:53:12 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 05:53:12 INFO - 'PWD': '/builds/slave/test-pgo', 05:53:12 INFO - 'PYTHONPATH': '/builds/slave/test-pgo/build/tests/talos', 05:53:12 INFO - 'SHELL': '/bin/bash', 05:53:12 INFO - 'SHLVL': '1', 05:53:12 INFO - 'TERM': 'linux', 05:53:12 INFO - 'TMOUT': '86400', 05:53:12 INFO - 'USER': 'cltbld', 05:53:12 INFO - 'XDG_SESSION_COOKIE': 'b5f16d05e5ea93ddf675e67e000001bf-1453470511.106647-1655455357', 05:53:12 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:53:12 INFO - '_': '/tools/buildbot/bin/python'} 05:53:12 INFO - Calling ['/builds/slave/test-pgo/build/venv/bin/python', '/builds/slave/test-pgo/build/tests/talos/talos/run_tests.py', '--debug', '--branchName', 'Mozilla-Aurora', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test-pgo/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/2p0v77w4SLK4Lf8Vflb2rg/artifacts/public/build/firefox-45.0a2.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-007', '--webServer', 'localhost'] with output_timeout 3600 05:53:13 INFO - mozversion INFO | application_buildid: 20160122032328 05:53:13 INFO - mozversion INFO | application_changeset: 882e6011c18f968f3e6993e4fac60c68ae6366a0 05:53:13 INFO - mozversion INFO | application_display_name: FirefoxDeveloperEdition 05:53:13 INFO - mozversion INFO | application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 05:53:13 INFO - mozversion INFO | application_name: Firefox 05:53:13 INFO - mozversion INFO | application_remotingname: firefox-dev 05:53:13 INFO - mozversion INFO | application_repository: https://hg.mozilla.org/releases/mozilla-aurora 05:53:13 INFO - mozversion INFO | application_vendor: Mozilla 05:53:13 INFO - mozversion INFO | application_version: 45.0a2 05:53:13 INFO - mozversion INFO | platform_buildid: 20160122032328 05:53:13 INFO - mozversion INFO | platform_changeset: 882e6011c18f968f3e6993e4fac60c68ae6366a0 05:53:13 INFO - mozversion INFO | platform_repository: https://hg.mozilla.org/releases/mozilla-aurora 05:53:13 INFO - mozversion INFO | platform_version: 45.0a2 05:53:13 INFO - 2016-01-22 05:53:13,131 DEBUG : using testdate: 1453470793 05:53:13 INFO - 2016-01-22 05:53:13,131 DEBUG : actual date: 1453470793 05:53:13 INFO - 2016-01-22 05:53:13,140 INFO : starting webserver on 'localhost:51170' 05:53:13 INFO - 2016-01-22 05:53:13,141 INFO : Starting test suite talos-linux64-ix-007.e 05:53:13 INFO - 2016-01-22 05:53:13,141 INFO : Starting test dromaeo_css 05:53:13 INFO - 2016-01-22 05:53:13,141 DEBUG : operating with platform_type : linux_ 05:53:13 INFO - 2016-01-22 05:53:13,142 INFO : Initialising browser for dromaeo_css test... 05:53:13 INFO - 2016-01-22 05:53:13,158 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmp7hFl3O/profile http://localhost:51170/getInfo.html 05:53:16 INFO - 2016-01-22 05:53:16,918 DEBUG : BROWSER_OUTPUT: 05:53:16 INFO - 2016-01-22 05:53:16,919 DEBUG : BROWSER_OUTPUT: (process:8964): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 05:53:17 INFO - 2016-01-22 05:53:17,814 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 05:53:17 INFO - 2016-01-22 05:53:17,814 DEBUG : BROWSER_OUTPUT: colorDepth:24 05:53:17 INFO - 2016-01-22 05:53:17,814 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 05:53:17 INFO - 2016-01-22 05:53:17,814 DEBUG : BROWSER_OUTPUT: __metrics 05:53:18 INFO - 2016-01-22 05:53:18,853 INFO : Browser initialized. 05:53:18 INFO - 2016-01-22 05:53:18,854 INFO : Running cycle 1/1 for dromaeo_css test... 05:53:18 INFO - 2016-01-22 05:53:18,854 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmp7hFl3O/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 05:53:20 INFO - 2016-01-22 05:53:20,124 DEBUG : BROWSER_OUTPUT: 05:53:20 INFO - 2016-01-22 05:53:20,124 DEBUG : BROWSER_OUTPUT: (process:9077): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 05:53:30 INFO - 2016-01-22 05:53:30,629 DEBUG : BROWSER_OUTPUT: RSS: Main: 137211904 05:53:30 INFO - 2016-01-22 05:53:30,629 DEBUG : BROWSER_OUTPUT: 05:54:20 INFO - 2016-01-22 05:54:20,249 DEBUG : BROWSER_OUTPUT: 1453470860247 addons.productaddons ERROR Request failed certificate checks: [Exception... "SSL is required and URI scheme is not https." nsresult: "0x8000ffff (NS_ERROR_UNEXPECTED)" location: "JS frame :: resource://gre/modules/CertUtils.jsm :: checkCert :: line 145" data: no] 05:56:28 INFO - 2016-01-22 05:56:28,183 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:51170/tests/dromaeo/cssquery-dojo.html (next: http://localhost:51170/tests/dromaeo/cssquery-ext.html) 05:56:29 INFO - 2016-01-22 05:56:29,253 DEBUG : BROWSER_OUTPUT: RSS: Main: 140787712 05:56:29 INFO - 2016-01-22 05:56:29,253 DEBUG : BROWSER_OUTPUT: 05:59:31 INFO - 2016-01-22 05:59:31,033 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:51170/tests/dromaeo/cssquery-ext.html (next: http://localhost:51170/tests/dromaeo/cssquery-jquery.html) 05:59:31 INFO - 2016-01-22 05:59:31,627 DEBUG : BROWSER_OUTPUT: RSS: Main: 139726848 05:59:31 INFO - 2016-01-22 05:59:31,627 DEBUG : BROWSER_OUTPUT: 06:02:33 INFO - 2016-01-22 06:02:33,149 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:51170/tests/dromaeo/cssquery-jquery.html (next: http://localhost:51170/tests/dromaeo/cssquery-mootools.html) 06:02:33 INFO - 2016-01-22 06:02:33,743 DEBUG : BROWSER_OUTPUT: RSS: Main: 140443648 06:02:33 INFO - 2016-01-22 06:02:33,743 DEBUG : BROWSER_OUTPUT: 06:05:35 INFO - 2016-01-22 06:05:35,297 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:51170/tests/dromaeo/cssquery-mootools.html (next: http://localhost:51170/tests/dromaeo/cssquery-prototype.html) 06:05:35 INFO - 2016-01-22 06:05:35,879 DEBUG : BROWSER_OUTPUT: RSS: Main: 140066816 06:05:35 INFO - 2016-01-22 06:05:35,879 DEBUG : BROWSER_OUTPUT: 06:08:38 INFO - 2016-01-22 06:08:38,187 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:51170/tests/dromaeo/cssquery-prototype.html (next: http://localhost:51170/tests/dromaeo/cssquery-yui.html) 06:08:38 INFO - 2016-01-22 06:08:38,772 DEBUG : BROWSER_OUTPUT: RSS: Main: 139911168 06:08:38 INFO - 2016-01-22 06:08:38,772 DEBUG : BROWSER_OUTPUT: 06:11:40 INFO - 2016-01-22 06:11:40,890 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:51170/tests/dromaeo/cssquery-yui.html (next: http://localhost:51170/tests/dromaeo/cssquery-dojo.html) 06:11:41 INFO - 2016-01-22 06:11:41,140 DEBUG : BROWSER_OUTPUT: RSS: Main: 141303808 06:11:41 INFO - 2016-01-22 06:11:41,140 DEBUG : BROWSER_OUTPUT: 06:11:41 INFO - 2016-01-22 06:11:41,140 DEBUG : BROWSER_OUTPUT: __start_tp_report 06:11:41 INFO - 2016-01-22 06:11:41,140 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 06:11:41 INFO - 2016-01-22 06:11:41,140 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 06:11:41 INFO - 2016-01-22 06:11:41,141 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 06:11:41 INFO - 2016-01-22 06:11:41,141 DEBUG : BROWSER_OUTPUT: |0;dojo.html;3210.9518357224647;3213.726833219176;3243.1081452600533;3258.4623537116377;3266.657001014894;5471.78112875485;5550.86122846929;5561.916571251434;5583.804566840166;5619.943800562003;5554.416786237448;5595.664260144395;5630.40880707525;5637.605367624268;5653.1520271959225;5066.822661206849;5109.69341839489;5131.563817075553;5135.486451354854;5165.690058596478;4940.160172770619;5006.899862002758;5111.693298402108;5121.103806833789;5157.690538567679;5102.668326558781;5161.819336323229;5187.6628019178825;5188.7146206958605;5200.063988482072;5155.097857874857;5211.348581427303;5212.035773381936;5224.843254702365;5252.579793616502;4892.535209155125;4950.554450099472;5016.673916195472;5117.053345131126;5127.461616530248;5342.839714808523;5379.193121031837;5417.431169727161;5452.672839629595;5481.342238931354;5948.524118070544;5965.582409231356;5977.641341519479;5991.550633702446;6016;5861.4724674779045;5883.970580147072;6025.15647809307;6040.697965101727;6051.062085376773;5674.517665998395;5716.942365662324;5719.056355701346;5727.083666613364;5735.713214339308;6157.599756015845;6188;6196.628202307876;6198.473129784019;6201.875962480815;5630.986422444;5791.3339965903615;5822.039363505059;5939.22790037301;5981.760729570856;5973.163757074013;6003.459688628044;6032.849178770566;6033;6085.786997455157;5959.433853783884;5987.850303742354;6045.576809623284;6057.394260573908;6074.848128796727;5832.3292821326095;5919.852003699942;5938.554608404387;5994.850128746729;6042.3655516170165;4634.976825115853;4650.302454631765;4656.720596764205;4657.86026419208;4676.3453116563705;4000.8199631016673;4150.64719498846;4158.4178215049915;4174.3947127666315;4187;5722.399148089391;5743.569232307594;5760.049591817303;5852.824415267549;5858.179854820329;6075.483583895419;6096.085587161872;6096.72564734588;6119.265688117454;6122.510199184055;5490.1764735289225;5658.236138121301;5770.16332631766;5776.104703770922;5786.450287222707;5176.870578235575;5250.606204534675;5260.368755749335;5282.181261904411;5297.443768404339;6152.938470615237;6179.84550386244;6180;6181.660008699565;6194.5973511721595;5860.179574859438;5969.194158788681;6061.272647282178;6062.7271772769445;6070.696465176812;6112.755489780359;6124.234470691164;6127.342242870382;6128.350350989301;6135.049067394561;5884.323302820059;5925.466707996301;5925.555583331354;5929.080992446177;5930.05119180929;5778.624389414675;5909.55678324136;6006.969965150146;6021.54838387114;6111.7132884518705;5891.49922256613;5954.76180952757;5966.522678185648;5968.46283834457;5991.041433370639;5875.441833025856;5887.61730487517;5913.526917846648;5954.404559544011;5976.491998180203;5618.971905140448;5744.597878148489;5794.62334948227;5914;5937.435943585352;5967.6419414835245;5972.014617588223;5978.671173085522;6019.819405417845;6022.397760223943;5542.889142217214;5845;5884.411558844253;5887.793927212699;5894.440028197314 06:11:41 INFO - 2016-01-22 06:11:41,141 DEBUG : BROWSER_OUTPUT: |1;ext.html;587.2277954489846;628.73278856486;633.0978355842929;637.5791977294984;660.6267458885729;37908.24183516328;38182;38323.23353532928;38446.23107537848;38730.22539549211;44053.55946440535;44233.77883110588;44688;44799.32801007987;44887.326690099595;9116.270698344133;9252.352335336529;9259.537023148849;9265.397749146317;9299.930507991567;8956.149165829269;9086.091390860927;9099.590518426687;9101;9113.817723645523;9108.089191080871;9195.12646298604;9212.401193922407;9216.354855160142;9224.584893679767;9118;9126.452412855184;9139.497327646977;9189.632414703405;9223;9040.367174297802;9108.81782364349;9131.726048218565;9137.040610735843;9168.220701240403;42891.35662965058;43106;43185;43534.34698479494;43546.56453435457;3664.633536646341;3673.2837096766143;3710.5547334319785;3756.887293381203;4030.6775457963295;31805.363892722016;32041.51937720936;32258.193545161324;32297;32869.6713032869;4272.679549033804;4311.1593239318345;4334.826606935719;4344.02259491615;4370.060437006027;287591;288898;289582;290611;290817;44676.3298550522;44773.55226447759;44776;44849.77575112104;63730;46203.768981155554;46423.53576464192;46427.67861606906;46473;46524;15323.387064517518;15438.845611543966;15462.536123916301;15543.222838858012;15549.611259718371;12724.936375318064;12741.55404560836;12835.165714228546;12891.677708057374;13028.54400096011;15384.076955382712;15500.457483988006;15547.766783498257;15566;15581.610459738371;6041.6375017499095;6192.349803270682;6220.25356957159;6280.340564240781;6285.057241413733;1063.4576366053213;1101.4162493878257;1126.5212284778936;1199.4422593493894;1202.6452196602024;28412.083965200538;29381;29433.85283073571;29494;29508.114756557337;1100.9284396514201;1115.7712668902855;1161.181367136167;1189.339916346436;1195.9222650527688;15208;15336.140728130835;15351.92324038395;15529.767053494206;15856.44502442409;571447;579351;579483;583790;766565;60406.697966509884;61510;61530;61733.69133154395;61765;1430.9069910455787;1489.4489039055618;1491.4407097338715;1497.0568541818802;1499.7150541397318;30084;30524.236894077825;30902.381952361276;31566.842165789025;31691.04926852106;51244;51660.22509662283;51712.74143629258;51846.74076629593;51979.480205198975;319628;322991;323397;323634;325039;33919;34483.96548103561;34657.48013779745;34746.47880281747;35057.474137888465;46225;46234.30648540207;46761.298580522;46990.76504617455;47179.76410117927;39826.402603960385;40159.79920100498;40296.3955540673;40437;41169.38245926373;39396.60603393929;39761.40357894692;41094;42746.1450770989;44132;38761.80619096886;38977.80511097427;39272.80363598164;39374.60625393709;39637;33867.49198761971;33977.150571235914;39548.40677389899;39608.801955990035;40162.79918600388;26150.34624134412;26651.20046398611;26679;26783.73226222289;27002.189934302 06:11:41 INFO - 2016-01-22 06:11:41,142 DEBUG : BROWSER_OUTPUT: |2;jquery.html;347.95998460177077;352.99999999999994;356.3727839003353;364.67361711268416;369.37944253653853;17881.463556093306;18599.814001859977;18941.242350305987;19238.807611923876;19685.409437716855;11397.202195846294;11857.525698972053;12207.962323202517;12263.141580089397;17910.74624776266;5083.898322033567;5350.785968561272;5653.4911857932775;5654.321481422235;5673.092305231164;5627.409122042188;5645.830625081254;5654.575906806986;5654.830355089333;5655.462731040545;3908.7850168240734;3998.040470287139;5457.727113644321;5548.389677135512;5561.805336813212;5426.782928682867;5597.132444471114;5660.405657405975;5667.886642267132;5698.373178950312;5107.055194788939;5261.894762104775;5453.018456677796;5456.399796022434;5460;13148.737025259441;13157.079004469691;13267.203967761869;19000.904995475074;20212.797872021387;733.5085492719837;734.0530715377157;2047.488127968008;2266.943326416853;2299.1837897546297;10060.39637621745;10191.133753630951;10286.485675716185;10426.947865260701;10467.63363282289;1910.522369407648;1919.8464122870137;1920.4430715092606;1932.594155227404;1977.2881762565464;63439;65320.34679653238;66755.3324466754;67051;67419.66290168568;10047.648332308334;10496.160307175407;10565.9471702641;10711.357318560911;10731.463426828628;13794.310284485735;13815.378307976165;13852.722945541032;13853.30733463343;13887.722245555033;8049.6377663005305;8092.878606820902;8221.753347399588;8239.134890836496;8253.380996425292;8219.095899451055;8237.135100814448;8254.463459875089;8268.917310826815;8306.54314012735;4466.39703640011;4488.506264310923;4515.345274935116;4537.160625284333;4615.699979501389;1887.6413481438483;1893.5455490682136;1910;1946.6106778644328;1957.2660252405349;428.259111736691;440.8963893485093;927.4481683398367;972.7227740094039;1059.56557811297;10067.194624430029;10680.732981675364;11087.889121108847;11197.384143872003;11360.261582997078;454.47735104629277;462.1727108475858;462.5536357415043;472.4236431553499;474.81719537978125;5863.560232982543;6161.44546990773;10210;10224.64213752515;10277.766667999887;609662;613165;618673;708555;710967;84571;87509;88482.55758721165;89924;90080;1208.0758219961735;1215.477344741752;1215.8540975083047;1216.8661447240797;1224.1125184241355;16049.598760031093;16258.430954916521;16333;16535.173241338125;16685.91657041707;37860;37887.242255155295;38166.23667526578;38169;39048.04759762057;51147;52435.47564524306;54258.72870635622;55305.44694553003;63130;15195.848041519885;15272.923635381752;15276.465323713617;15528.068315901082;15759.606009849387;20776.79223207809;20965.89517052405;20972.68540971856;21123.366299011053;21501;16330;16546.172691365624;16872.156392180586;17017;17326.566835829206;9908.702738917844;10093.243006774668;10119.645812396826;10204.897951020692;10222.335548189343;10287.382757034602;10338.534765935701;10521.842172367573;10564.947175264075;10703.946480267548;15971.44099956496;15977.281022354255;16023.759643605588;16133.67732645364;16190.91904540517;15997.360105595646;16139;16822.915885420494;16998.2350794217;17095.65808683844 06:11:41 INFO - 2016-01-22 06:11:41,143 DEBUG : BROWSER_OUTPUT: |3;mootools.html;1534.3018926388488;1535.071281874466;1727.904965226912;1758.358199257271;1822.232434538498;7054.894176587355;7131.786046418602;7396.926030739691;7775.183605721396;7791.454598178129;7228.710851565944;7379.077615298088;7391.704331826721;7430.331270185682;7459.515131516461;2220.977790222093;2245.5733410652006;2260.2880092770806;2261.0955617752948;2262.095161935231;2260.7965283124518;2271.2618399020303;2304.412374844421;2317.895694693743;2318.907243710258;2254.830887683422;2259.67234750961;2279.6466547685136;2282.5777231212196;2290.828187885907;2241.4396400899777;2253.5943530164564;2278.259565641173;2289.095807156181;2290.8510946788488;2291.9312420627407;2312.7340355859124;2330.207729372005;2341.4848733278823;2342.7774361435636;7732.6133693315105;7849;7852.17552157021;7853.764387068397;7874.448788584801;4484.573965473275;4563.338315944203;4564.269716845289;4571.26859702446;4574.4739354973935;2895.1459319500796;2917.6352955880516;2952.35048289376;2967.540031295153;2994.940101197964;970.1317320997738;977.0913050862695;991.5637119667323;1016.2530540053056;1024.7540590258284;9971.102600765893;9995.70012899614;10001.649942251986;10006.249531285182;10037.648682296085;4079.63283304504;4093.8771836844944;4094.406311084876;4112.794360282034;4129.648979836687;8679.392442529088;8756.605952732143;8765;8781.736547903573;8781.868271975925;4603.470600880942;4623.098495793355;4624.237000894882;4625.560571745679;4631.490536041033;3792.070942619021;3834.3481608126126;4115.1975364803575;4195.223883581547;4233.343831706091;3539.0444579963264;3545.503629491873;3562.251927095339;3572.499850020999;3578.3916734155255;1075.1076606416655;1085.4843949124104;1089.4661615808197;1091.858058452412;1100.8403781451646;1128.7629597784558;1135.8920902514249;1148.362658724416;1384.6953670192543;1458.1979911049093;7005.404540614003;7308.598027108454;7446.925530744732;7457.10514738224;7497.925020749832;1072.5388083124176;1116.4027245423658;1158.5829101523445;1187.4656404617956;1200.237848965913;5931;5951.226340575698;5964.582479226413;5969.79105731306;5979.611325263844;9066.184043435991;9126.08739126082;9231.584578693975;9273.907260927304;9358.766030849147;9112.453252804853;9164.037776033554;9179.632814687471;9184.219341355925;9199;7120.964395177991;7154.463415243774;7181.712731490682;7185.784426467214;7309.232530584319;7368.931504931647;7424.257574242532;7428.480006399716;7454.4781865268915;7462.925370746223;7928.167542407964;8059.234372734581;8259.628316725642;8328.6668533258;8350.58247087631;8393.706220282262;8398.538080405637;8400.495970241805;8439.746807595782;8463.36524760633;6680.5323627345615;6705.832354191184;6808.387245147763;6849.623270720158;6861.348171923659;7356.043714317105;7368.4842061055215;7370.48406611532;7422.554646721214;7491.662875170739;6958.547694399847;6977.33715297046;6991.615461149686;7064.752733654297;7126.144862616519;6885.1049363582415;6887.758928437481;6930.549514281555;6953.548019378724;6990.685419156049;6835.384815366641;6846.383825455733;6851.109355783717;6870.3473170048765;6966.711158435705;6306.369363063657;6311.558190926591;6361.554691171574;6369.49044076482;6373.521985850987;6524.902126468011;6525.804225873231;6556.8360790980605;6571.671416429255;6590.80227593173 06:11:41 INFO - 2016-01-22 06:11:41,143 DEBUG : BROWSER_OUTPUT: |4;prototype.html;347.72355976998284;350.6283339659959;353.33396547507954;355.2397868561279;357.1072319201995;6334.366563343663;6376.298607153215;6420.614763114217;6452.870942581151;6506.674666266679;6227.564070515065;6405;6416.679166041691;6416.967915160418;6418.646974416405;4863.9027219455675;4878.951210487903;4928.605711543086;4930.334404855353;4931.975340123312;4927.827526036589;4935.777889994941;4945.23348880924;4947.579455746266;4949.554540091391;4698.060387922429;4857.9757101214445;4871.074495845795;4888.584470320027;4898.363212782333;4821.059893320804;4865.708057516543;4871.634627402959;4875.244337127733;4880.9755951220195;4206.3690446432975;4232.576742325774;4242.236397448458;4244.766537840417;4253.914921701579;6007.219061522018;6051.425114614105;6088.391160883921;6094.8171554853425;6099.810536945298;5654.886902261932;5655.3779084300695;5655.434456554352;5656.066748986413;5661.433856614347;6744.325567443266;6745.696443660047;6749.325067493261;6752.257251702309;6752.696128674222;4679.064187162547;4689.437267527918;4695.272232803886;4699.389079419688;4707.952920470786;6875.346842049998;6952.478564107712;7002.229754726976;7020.262872398427;7056.259092795234;4787.0904528139545;4794.232922732346;4795.928061079087;4806.182948898696;4809.615230781529;4854.907645779671;4868.732219727878;4870.391201099863;4875.317455556225;4880.682755620874;5509.779608815683;5628.296462942132;5631.605787594829;5647.576431767634;5651.434856514398;6763.086983257295;6854.246032936473;6854.725810967605;6878.621675807779;6898.7240510380025;1722.9741553876702;1753.8070812210647;1768.7700598922315;1769.265754711806;1769.6283780406002;1188.102982248397;1207.5532053140394;1217.0507004536476;1223.975520489603;1226.791445454275;6480.481561475165;6480.837979050467;6503.382178693111;6507.934920650828;6515.315891831384;6988.93011069893;6990.790276291617;7001.054857594261;7003.54476958996;7013.719451221894;6402.583832050902;6485.8702825944165;6505.934940650533;6508.60948343101;6510.544261901621;3770.849166033383;3787.8295476703615;3802.239552089593;3802.7908465034134;3807.9809600951817;7161.606111663908;7164.462665300123;7182.174049984214;7186.784396468114;7188.245234250328;6983.812751832201;7107.182673992454;7111.573305601681;7125.1093613298335;7129.215786263507;7131.393831524275;7151.427885769126;7159.463040272;7159.606221657858;7176.390006849372;6972.058772065909;6981.825454363681;6984.3364880336285;6985.231624521197;7011;6814.795556133324;6866.313368663294;6871.759488417882;6994.440444764508;7022.1924478685605;7305.780826575211;7334.743283985035;7360.852782944418;7362.77911662651;7369.299916507923;4684.789184486638;4694.366260554782;4712.410948631421;4719.38647975761;4733.1716949533;7006.913928341115;7136.928630713626;7140.536190081125;7165.176004759311;7169.139703235645;6927.064846245894;6988;6988.650567471708;6996.720131194696;6997;6903;6906.930930690629;6951.7914462566205;6955.234924158237;6962.860742785218;6645.9003114954285;6775.288594697683;6804;6855.691493882688;6861.965690171517;6948.305169483214;6967.233604303421;6975.058367120374;6986;6995.195552511526;6675.8664826702225;6783.21992970795;6808.455323574201;6813.727450901908;6831.146106736658 06:11:41 INFO - 2016-01-22 06:11:41,144 DEBUG : BROWSER_OUTPUT: |5;yui.html;806.5402720449339;831.7671052105411;840.5335039053326;854.2653318146397;950.2018304624114;14920.701585968274;14941.92529037356;15077.019993700402;15108.622284442881;15192.848071519282;13935.581932542014;14071.648208794786;14093.577192684235;14138.434462621508;14144.929275353634;915.3455279475174;925.6297481007583;929.995350023249;930.5812384427;936.3445588088331;912.8219997100568;926.0507979321216;926.2913870888742;932.4451951089092;933.9066093390675;963.9614415423374;964.3587014635259;972.4214092614883;972.4262685015839;973.4354074636693;960.7117864640614;962.5860879821674;963.8361478548663;966.3477152921749;969.3263182088451;716.9856602867966;717.4296434334665;720.4020662849822;720.8738470767647;721.4733244731375;15344.07935523861;15438.459653912172;15523.844761552353;15537.533873983799;15570.610734731608;13084.21494710311;13163.276019818906;13168.144070635379;13177.670558236025;13576.660583485393;10992.835107473395;11333;11372.37451940143;11380.089592832554;11429.599964001303;3702.352088384549;3723.4600982857332;3755.887323380303;3763.510743603314;3865.1496670732395;50301.24548131781;50779;50780.49219507832;50982.7450862747;51092.23361649578;10994.455702599682;11012;11013.394263315595;11231.326120432801;11280.153988450898;19177.616447671247;19341.709874351895;19461.416157515298;19524.609507809764;19640.3125890596;8020.077691065486;8084.636191371284;8203.548804815673;8210.548419836847;8219.8356032879;4346.304591265382;4607.631389488833;4654.813807447664;4779.211430114062;4786.16242157621;3284.753643476749;3287.260366417585;3310.9834450828075;3314.436545787222;3318.9170270742943;585.7071464267866;587.9735411906474;589.6904125334148;596.1713218626113;604.4408921747454;689.8034060292792;723.2442098007594;724.6700517692402;746.7535713214626;752.7026824404439;8992.955035224782;9350.205232555309;9632.27757918159;9936.850947235796;10019.148372388283;714.3570786292274;736.988945165823;758.7534051433306;761.9352355049772;769.7036640893297;4225.535191128974;4250.426192463978;4263.219624185873;4323.265044942367;4383.649308055348;56904.71547642318;57225.14162287569;57393.42606573881;57504.424955749906;57820.421795781505;52046;52480;52650.736746316026;52670;52822.20766688503;49273.753631231615;49488;49501;49504.25743613848;49520.75239623779;8963.551822408985;9089.409188402733;9300.767480812763;9537.998510156334;9756.317057805885;37881.81059094797;38079.428808568446;38280.617193827704;38473.230535389695;38795;45309;46785.29822052604;46960;47336.52663473459;47532.7623361881;11401;12102.394880255775;12113.33376664292;12376.504939802307;12444.68888277764;13457.46170153222;13505.932470337586;13718.93140534291;13815.309234538434;14014.789778153132;11611.129165312466;11671;11675.76648467009;11683.474243658886;11824.23142495735;11386.089112870784;11617.070634349062;11731.88268117308;11978.76042479163;12111.091668124749;11314.773704525698;11447.771044578894;11547.653570392902;11555;11849.52601895949;10320.845187322046;10671.146308295472;10955.34267943926;11140.498677559368;11434.313941163557;9730.41617502952;9880.308378413441;9917.752056198364;9983.60065597368;10006.69979900604 06:11:41 INFO - 2016-01-22 06:11:41,144 DEBUG : BROWSER_OUTPUT: __end_tp_report 06:11:41 INFO - 2016-01-22 06:11:41,145 DEBUG : BROWSER_OUTPUT: __start_cc_report 06:11:41 INFO - 2016-01-22 06:11:41,145 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,299 06:11:41 INFO - 2016-01-22 06:11:41,145 DEBUG : BROWSER_OUTPUT: __end_cc_report 06:11:41 INFO - 2016-01-22 06:11:41,145 DEBUG : BROWSER_OUTPUT: __startTimestamp1453471901138__endTimestamp 06:11:41 INFO - 2016-01-22 06:11:41,145 DEBUG : BROWSER_OUTPUT: 06:11:41 INFO - 2016-01-22 06:11:41,145 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 06:11:41 INFO - 2016-01-22 06:11:41,145 DEBUG : BROWSER_OUTPUT: Number of tests: 6 06:11:41 INFO - 2016-01-22 06:11:41,145 DEBUG : BROWSER_OUTPUT: 06:11:41 INFO - 2016-01-22 06:11:41,145 DEBUG : BROWSER_OUTPUT: [#0] dojo.html Cycles:165 Average:5587.94 Median:5845.00 stddev:630.53 (10.8%) stddev-sans-first:604.26 06:11:41 INFO - 2016-01-22 06:11:41,146 DEBUG : BROWSER_OUTPUT: Values: 3211.0 3213.7 3243.1 3258.5 3266.7 5471.8 5550.9 5561.9 5583.8 5619.9 5554.4 5595.7 5630.4 5637.6 5653.2 5066.8 5109.7 5131.6 5135.5 5165.7 4940.2 5006.9 5111.7 5121.1 5157.7 5102.7 5161.8 5187.7 5188.7 5200.1 5155.1 5211.3 5212.0 5224.8 5252.6 4892.5 4950.6 5016.7 5117.1 5127.5 5342.8 5379.2 5417.4 5452.7 5481.3 5948.5 5965.6 5977.6 5991.6 6016.0 5861.5 5884.0 6025.2 6040.7 6051.1 5674.5 5716.9 5719.1 5727.1 5735.7 6157.6 6188.0 6196.6 6198.5 6201.9 5631.0 5791.3 5822.0 5939.2 5981.8 5973.2 6003.5 6032.8 6033.0 6085.8 5959.4 5987.9 6045.6 6057.4 6074.8 5832.3 5919.9 5938.6 5994.9 6042.4 4635.0 4650.3 4656.7 4657.9 4676.3 4000.8 4150.6 4158.4 4174.4 4187.0 5722.4 5743.6 5760.0 5852.8 5858.2 6075.5 6096.1 6096.7 6119.3 6122.5 5490.2 5658.2 5770.2 5776.1 5786.5 5176.9 5250.6 5260.4 5282.2 5297.4 6152.9 6179.8 6180.0 6181.7 6194.6 5860.2 5969.2 6061.3 6062.7 6070.7 6112.8 6124.2 6127.3 6128.4 6135.0 5884.3 5925.5 5925.6 5929.1 5930.1 5778.6 5909.6 6007.0 6021.5 6111.7 5891.5 5954.8 5966.5 5968.5 5991.0 5875.4 5887.6 5913.5 5954.4 5976.5 5619.0 5744.6 5794.6 5914.0 5937.4 5967.6 5972.0 5978.7 6019.8 6022.4 5542.9 5845.0 5884.4 5887.8 5894.4 06:11:41 INFO - 2016-01-22 06:11:41,146 DEBUG : BROWSER_OUTPUT: 06:11:41 INFO - 2016-01-22 06:11:41,146 DEBUG : BROWSER_OUTPUT: [#1] ext.html Cycles:180 Average:56813.20 Median:39993.10 stddev:116769.80 (292.0%) stddev-sans-first:117021.06 06:11:41 INFO - 2016-01-22 06:11:41,146 DEBUG : BROWSER_OUTPUT: Values: 587.2 628.7 633.1 637.6 660.6 37908.2 38182.0 38323.2 38446.2 38730.2 44053.6 44233.8 44688.0 44799.3 44887.3 9116.3 9252.4 9259.5 9265.4 9299.9 8956.1 9086.1 9099.6 9101.0 9113.8 9108.1 9195.1 9212.4 9216.4 9224.6 9118.0 9126.5 9139.5 9189.6 9223.0 9040.4 9108.8 9131.7 9137.0 9168.2 42891.4 43106.0 43185.0 43534.3 43546.6 3664.6 3673.3 3710.6 3756.9 4030.7 31805.4 32041.5 32258.2 32297.0 32869.7 4272.7 4311.2 4334.8 4344.0 4370.1 287591.0 288898.0 289582.0 290611.0 290817.0 44676.3 44773.6 44776.0 44849.8 63730.0 46203.8 46423.5 46427.7 46473.0 46524.0 15323.4 15438.8 15462.5 15543.2 15549.6 12724.9 12741.6 12835.2 12891.7 13028.5 15384.1 15500.5 15547.8 15566.0 15581.6 6041.6 6192.3 6220.3 6280.3 6285.1 1063.5 1101.4 1126.5 1199.4 1202.6 28412.1 29381.0 29433.9 29494.0 29508.1 1100.9 1115.8 1161.2 1189.3 1195.9 15208.0 15336.1 15351.9 15529.8 15856.4 571447.0 579351.0 579483.0 583790.0 766565.0 60406.7 61510.0 61530.0 61733.7 61765.0 1430.9 1489.4 1491.4 1497.1 1499.7 30084.0 30524.2 30902.4 31566.8 31691.0 51244.0 51660.2 51712.7 51846.7 51979.5 319628.0 322991.0 323397.0 323634.0 325039.0 33919.0 34484.0 34657.5 34746.5 35057.5 46225.0 46234.3 46761.3 46990.8 47179.8 39826.4 40159.8 40296.4 40437.0 41169.4 39396.6 39761.4 41094.0 42746.1 44132.0 38761.8 38977.8 39272.8 39374.6 39637.0 33867.5 33977.2 39548.4 39608.8 40162.8 26150.3 26651.2 26679.0 26783.7 27002.2 06:11:41 INFO - 2016-01-22 06:11:41,146 DEBUG : BROWSER_OUTPUT: 06:11:41 INFO - 2016-01-22 06:11:41,146 DEBUG : BROWSER_OUTPUT: [#2] jquery.html Cycles:180 Average:32798.67 Median:20969.29 stddev:106913.16 (509.9%) stddev-sans-first:107185.31 06:11:41 INFO - 2016-01-22 06:11:41,147 DEBUG : BROWSER_OUTPUT: Values: 348.0 353.0 356.4 364.7 369.4 17881.5 18599.8 18941.2 19238.8 19685.4 11397.2 11857.5 12208.0 12263.1 17910.7 5083.9 5350.8 5653.5 5654.3 5673.1 5627.4 5645.8 5654.6 5654.8 5655.5 3908.8 3998.0 5457.7 5548.4 5561.8 5426.8 5597.1 5660.4 5667.9 5698.4 5107.1 5261.9 5453.0 5456.4 5460.0 13148.7 13157.1 13267.2 19000.9 20212.8 733.5 734.1 2047.5 2266.9 2299.2 10060.4 10191.1 10286.5 10426.9 10467.6 1910.5 1919.8 1920.4 1932.6 1977.3 63439.0 65320.3 66755.3 67051.0 67419.7 10047.6 10496.2 10565.9 10711.4 10731.5 13794.3 13815.4 13852.7 13853.3 13887.7 8049.6 8092.9 8221.8 8239.1 8253.4 8219.1 8237.1 8254.5 8268.9 8306.5 4466.4 4488.5 4515.3 4537.2 4615.7 1887.6 1893.5 1910.0 1946.6 1957.3 428.3 440.9 927.4 972.7 1059.6 10067.2 10680.7 11087.9 11197.4 11360.3 454.5 462.2 462.6 472.4 474.8 5863.6 6161.4 10210.0 10224.6 10277.8 609662.0 613165.0 618673.0 708555.0 710967.0 84571.0 87509.0 88482.6 89924.0 90080.0 1208.1 1215.5 1215.9 1216.9 1224.1 16049.6 16258.4 16333.0 16535.2 16685.9 37860.0 37887.2 38166.2 38169.0 39048.0 51147.0 52435.5 54258.7 55305.4 63130.0 15195.8 15272.9 15276.5 15528.1 15759.6 20776.8 20965.9 20972.7 21123.4 21501.0 16330.0 16546.2 16872.2 17017.0 17326.6 9908.7 10093.2 10119.6 10204.9 10222.3 10287.4 10338.5 10521.8 10564.9 10703.9 15971.4 15977.3 16023.8 16133.7 16190.9 15997.4 16139.0 16822.9 16998.2 17095.7 06:11:41 INFO - 2016-01-22 06:11:41,148 DEBUG : BROWSER_OUTPUT: 06:11:41 INFO - 2016-01-22 06:11:41,148 DEBUG : BROWSER_OUTPUT: [#3] mootools.html Cycles:180 Average:5377.61 Median:6525.35 stddev:2740.98 (42.0%) stddev-sans-first:2733.44 06:11:41 INFO - 2016-01-22 06:11:41,148 DEBUG : BROWSER_OUTPUT: Values: 1534.3 1535.1 1727.9 1758.4 1822.2 7054.9 7131.8 7396.9 7775.2 7791.5 7228.7 7379.1 7391.7 7430.3 7459.5 2221.0 2245.6 2260.3 2261.1 2262.1 2260.8 2271.3 2304.4 2317.9 2318.9 2254.8 2259.7 2279.6 2282.6 2290.8 2241.4 2253.6 2278.3 2289.1 2290.9 2291.9 2312.7 2330.2 2341.5 2342.8 7732.6 7849.0 7852.2 7853.8 7874.4 4484.6 4563.3 4564.3 4571.3 4574.5 2895.1 2917.6 2952.4 2967.5 2994.9 970.1 977.1 991.6 1016.3 1024.8 9971.1 9995.7 10001.6 10006.2 10037.6 4079.6 4093.9 4094.4 4112.8 4129.6 8679.4 8756.6 8765.0 8781.7 8781.9 4603.5 4623.1 4624.2 4625.6 4631.5 3792.1 3834.3 4115.2 4195.2 4233.3 3539.0 3545.5 3562.3 3572.5 3578.4 1075.1 1085.5 1089.5 1091.9 1100.8 1128.8 1135.9 1148.4 1384.7 1458.2 7005.4 7308.6 7446.9 7457.1 7497.9 1072.5 1116.4 1158.6 1187.5 1200.2 5931.0 5951.2 5964.6 5969.8 5979.6 9066.2 9126.1 9231.6 9273.9 9358.8 9112.5 9164.0 9179.6 9184.2 9199.0 7121.0 7154.5 7181.7 7185.8 7309.2 7368.9 7424.3 7428.5 7454.5 7462.9 7928.2 8059.2 8259.6 8328.7 8350.6 8393.7 8398.5 8400.5 8439.7 8463.4 6680.5 6705.8 6808.4 6849.6 6861.3 7356.0 7368.5 7370.5 7422.6 7491.7 6958.5 6977.3 6991.6 7064.8 7126.1 6885.1 6887.8 6930.5 6953.5 6990.7 6835.4 6846.4 6851.1 6870.3 6966.7 6306.4 6311.6 6361.6 6369.5 6373.5 6524.9 6525.8 6556.8 6571.7 6590.8 06:11:41 INFO - 2016-01-22 06:11:41,148 DEBUG : BROWSER_OUTPUT: 06:11:41 INFO - 2016-01-22 06:11:41,148 DEBUG : BROWSER_OUTPUT: [#4] prototype.html Cycles:180 Average:5692.43 Median:6480.66 stddev:1717.55 (26.5%) stddev-sans-first:1674.87 06:11:41 INFO - 2016-01-22 06:11:41,150 DEBUG : BROWSER_OUTPUT: Values: 347.7 350.6 353.3 355.2 357.1 6334.4 6376.3 6420.6 6452.9 6506.7 6227.6 6405.0 6416.7 6417.0 6418.6 4863.9 4879.0 4928.6 4930.3 4932.0 4927.8 4935.8 4945.2 4947.6 4949.6 4698.1 4858.0 4871.1 4888.6 4898.4 4821.1 4865.7 4871.6 4875.2 4881.0 4206.4 4232.6 4242.2 4244.8 4253.9 6007.2 6051.4 6088.4 6094.8 6099.8 5654.9 5655.4 5655.4 5656.1 5661.4 6744.3 6745.7 6749.3 6752.3 6752.7 4679.1 4689.4 4695.3 4699.4 4708.0 6875.3 6952.5 7002.2 7020.3 7056.3 4787.1 4794.2 4795.9 4806.2 4809.6 4854.9 4868.7 4870.4 4875.3 4880.7 5509.8 5628.3 5631.6 5647.6 5651.4 6763.1 6854.2 6854.7 6878.6 6898.7 1723.0 1753.8 1768.8 1769.3 1769.6 1188.1 1207.6 1217.1 1224.0 1226.8 6480.5 6480.8 6503.4 6507.9 6515.3 6988.9 6990.8 7001.1 7003.5 7013.7 6402.6 6485.9 6505.9 6508.6 6510.5 3770.8 3787.8 3802.2 3802.8 3808.0 7161.6 7164.5 7182.2 7186.8 7188.2 6983.8 7107.2 7111.6 7125.1 7129.2 7131.4 7151.4 7159.5 7159.6 7176.4 6972.1 6981.8 6984.3 6985.2 7011.0 6814.8 6866.3 6871.8 6994.4 7022.2 7305.8 7334.7 7360.9 7362.8 7369.3 4684.8 4694.4 4712.4 4719.4 4733.2 7006.9 7136.9 7140.5 7165.2 7169.1 6927.1 6988.0 6988.7 6996.7 6997.0 6903.0 6906.9 6951.8 6955.2 6962.9 6645.9 6775.3 6804.0 6855.7 6862.0 6948.3 6967.2 6975.1 6986.0 6995.2 6675.9 6783.2 6808.5 6813.7 6831.1 06:11:41 INFO - 2016-01-22 06:11:41,150 DEBUG : BROWSER_OUTPUT: 06:11:41 INFO - 2016-01-22 06:11:41,150 DEBUG : BROWSER_OUTPUT: [#5] yui.html Cycles:180 Average:14638.85 Median:25720.06 stddev:16514.14 (64.2%) stddev-sans-first:16527.80 06:11:41 INFO - 2016-01-22 06:11:41,151 DEBUG : BROWSER_OUTPUT: Values: 806.5 831.8 840.5 854.3 950.2 14920.7 14941.9 15077.0 15108.6 15192.8 13935.6 14071.6 14093.6 14138.4 14144.9 915.3 925.6 930.0 930.6 936.3 912.8 926.1 926.3 932.4 933.9 964.0 964.4 972.4 972.4 973.4 960.7 962.6 963.8 966.3 969.3 717.0 717.4 720.4 720.9 721.5 15344.1 15438.5 15523.8 15537.5 15570.6 13084.2 13163.3 13168.1 13177.7 13576.7 10992.8 11333.0 11372.4 11380.1 11429.6 3702.4 3723.5 3755.9 3763.5 3865.1 50301.2 50779.0 50780.5 50982.7 51092.2 10994.5 11012.0 11013.4 11231.3 11280.2 19177.6 19341.7 19461.4 19524.6 19640.3 8020.1 8084.6 8203.5 8210.5 8219.8 4346.3 4607.6 4654.8 4779.2 4786.2 3284.8 3287.3 3311.0 3314.4 3318.9 585.7 588.0 589.7 596.2 604.4 689.8 723.2 724.7 746.8 752.7 8993.0 9350.2 9632.3 9936.9 10019.1 714.4 737.0 758.8 761.9 769.7 4225.5 4250.4 4263.2 4323.3 4383.6 56904.7 57225.1 57393.4 57504.4 57820.4 52046.0 52480.0 52650.7 52670.0 52822.2 49273.8 49488.0 49501.0 49504.3 49520.8 8963.6 9089.4 9300.8 9538.0 9756.3 37881.8 38079.4 38280.6 38473.2 38795.0 45309.0 46785.3 46960.0 47336.5 47532.8 11401.0 12102.4 12113.3 12376.5 12444.7 13457.5 13505.9 13718.9 13815.3 14014.8 11611.1 11671.0 11675.8 11683.5 11824.2 11386.1 11617.1 11731.9 11978.8 12111.1 11314.8 11447.8 11547.7 11555.0 11849.5 10320.8 10671.1 10955.3 11140.5 11434.3 9730.4 9880.3 9917.8 9983.6 10006.7 06:11:41 INFO - 2016-01-22 06:11:41,152 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 06:11:41 INFO - 2016-01-22 06:11:41,152 DEBUG : BROWSER_OUTPUT: 06:11:41 INFO - 2016-01-22 06:11:41,785 INFO : Browser exited with error code: 0 06:11:41 INFO - 2016-01-22 06:11:41,807 INFO : Completed test dromaeo_css (00:18:28) 06:11:41 INFO - 2016-01-22 06:11:41,807 INFO : Starting test kraken 06:11:41 INFO - 2016-01-22 06:11:41,807 DEBUG : operating with platform_type : linux_ 06:11:41 INFO - 2016-01-22 06:11:41,807 INFO : Initialising browser for kraken test... 06:11:41 INFO - 2016-01-22 06:11:41,813 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmps9WzR5/profile http://localhost:51170/getInfo.html 06:11:45 INFO - 2016-01-22 06:11:45,525 DEBUG : BROWSER_OUTPUT: 06:11:45 INFO - 2016-01-22 06:11:45,525 DEBUG : BROWSER_OUTPUT: (process:9344): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 06:11:46 INFO - 2016-01-22 06:11:46,454 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 06:11:46 INFO - 2016-01-22 06:11:46,454 DEBUG : BROWSER_OUTPUT: colorDepth:24 06:11:46 INFO - 2016-01-22 06:11:46,454 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 06:11:46 INFO - 2016-01-22 06:11:46,454 DEBUG : BROWSER_OUTPUT: __metrics 06:11:47 INFO - 2016-01-22 06:11:47,441 INFO : Browser initialized. 06:11:47 INFO - 2016-01-22 06:11:47,442 INFO : Running cycle 1/1 for kraken test... 06:11:47 INFO - 2016-01-22 06:11:47,442 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmps9WzR5/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 06:11:48 INFO - 2016-01-22 06:11:48,754 DEBUG : BROWSER_OUTPUT: 06:11:48 INFO - 2016-01-22 06:11:48,754 DEBUG : BROWSER_OUTPUT: (process:9462): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 06:11:59 INFO - 2016-01-22 06:11:59,261 DEBUG : BROWSER_OUTPUT: RSS: Main: 136744960 06:11:59 INFO - 2016-01-22 06:11:59,261 DEBUG : BROWSER_OUTPUT: 06:12:01 INFO - 2016-01-22 06:12:01,702 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:51170/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:51170/tests/kraken/driver.html?testName=audio-beat-detection) 06:12:02 INFO - 2016-01-22 06:12:02,309 DEBUG : BROWSER_OUTPUT: RSS: Main: 138670080 06:12:02 INFO - 2016-01-22 06:12:02,310 DEBUG : BROWSER_OUTPUT: 06:12:04 INFO - 2016-01-22 06:12:04,891 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:51170/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:51170/tests/kraken/driver.html?testName=audio-dft) 06:12:05 INFO - 2016-01-22 06:12:05,477 DEBUG : BROWSER_OUTPUT: RSS: Main: 137379840 06:12:05 INFO - 2016-01-22 06:12:05,477 DEBUG : BROWSER_OUTPUT: 06:12:08 INFO - 2016-01-22 06:12:08,308 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:51170/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:51170/tests/kraken/driver.html?testName=audio-fft) 06:12:08 INFO - 2016-01-22 06:12:08,890 DEBUG : BROWSER_OUTPUT: RSS: Main: 138969088 06:12:08 INFO - 2016-01-22 06:12:08,890 DEBUG : BROWSER_OUTPUT: 06:12:10 INFO - 2016-01-22 06:12:10,903 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:51170/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:51170/tests/kraken/driver.html?testName=audio-oscillator) 06:12:11 INFO - 2016-01-22 06:12:11,476 DEBUG : BROWSER_OUTPUT: RSS: Main: 137502720 06:12:11 INFO - 2016-01-22 06:12:11,476 DEBUG : BROWSER_OUTPUT: 06:12:13 INFO - 2016-01-22 06:12:13,662 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:51170/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:51170/tests/kraken/driver.html?testName=imaging-gaussian-blur) 06:12:14 INFO - 2016-01-22 06:12:14,236 DEBUG : BROWSER_OUTPUT: RSS: Main: 138637312 06:12:14 INFO - 2016-01-22 06:12:14,236 DEBUG : BROWSER_OUTPUT: 06:12:17 INFO - 2016-01-22 06:12:17,180 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:51170/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:51170/tests/kraken/driver.html?testName=imaging-darkroom) 06:12:17 INFO - 2016-01-22 06:12:17,766 DEBUG : BROWSER_OUTPUT: RSS: Main: 137580544 06:12:17 INFO - 2016-01-22 06:12:17,767 DEBUG : BROWSER_OUTPUT: 06:12:21 INFO - 2016-01-22 06:12:21,088 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:51170/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:51170/tests/kraken/driver.html?testName=imaging-desaturate) 06:12:21 INFO - 2016-01-22 06:12:21,670 DEBUG : BROWSER_OUTPUT: RSS: Main: 137854976 06:12:21 INFO - 2016-01-22 06:12:21,671 DEBUG : BROWSER_OUTPUT: 06:12:24 INFO - 2016-01-22 06:12:24,474 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:51170/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:51170/tests/kraken/driver.html?testName=json-parse-financial) 06:12:25 INFO - 2016-01-22 06:12:25,056 DEBUG : BROWSER_OUTPUT: RSS: Main: 137973760 06:12:25 INFO - 2016-01-22 06:12:25,056 DEBUG : BROWSER_OUTPUT: 06:12:26 INFO - 2016-01-22 06:12:26,617 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:51170/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:51170/tests/kraken/driver.html?testName=json-stringify-tinderbox) 06:12:27 INFO - 2016-01-22 06:12:27,186 DEBUG : BROWSER_OUTPUT: RSS: Main: 138444800 06:12:27 INFO - 2016-01-22 06:12:27,186 DEBUG : BROWSER_OUTPUT: 06:12:28 INFO - 2016-01-22 06:12:28,942 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:51170/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:51170/tests/kraken/driver.html?testName=stanford-crypto-aes) 06:12:29 INFO - 2016-01-22 06:12:29,550 DEBUG : BROWSER_OUTPUT: RSS: Main: 138010624 06:12:29 INFO - 2016-01-22 06:12:29,550 DEBUG : BROWSER_OUTPUT: 06:12:31 INFO - 2016-01-22 06:12:31,573 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:51170/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:51170/tests/kraken/driver.html?testName=stanford-crypto-ccm) 06:12:32 INFO - 2016-01-22 06:12:32,160 DEBUG : BROWSER_OUTPUT: RSS: Main: 139792384 06:12:32 INFO - 2016-01-22 06:12:32,161 DEBUG : BROWSER_OUTPUT: 06:12:34 INFO - 2016-01-22 06:12:34,575 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:51170/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:51170/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 06:12:35 INFO - 2016-01-22 06:12:35,177 DEBUG : BROWSER_OUTPUT: RSS: Main: 138706944 06:12:35 INFO - 2016-01-22 06:12:35,177 DEBUG : BROWSER_OUTPUT: 06:12:37 INFO - 2016-01-22 06:12:37,711 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:51170/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:51170/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 06:12:38 INFO - 2016-01-22 06:12:38,293 DEBUG : BROWSER_OUTPUT: RSS: Main: 139493376 06:12:38 INFO - 2016-01-22 06:12:38,293 DEBUG : BROWSER_OUTPUT: 06:12:39 INFO - 2016-01-22 06:12:39,974 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:51170/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:51170/tests/kraken/driver.html?testName=ai-astar) 06:12:40 INFO - 2016-01-22 06:12:40,224 DEBUG : BROWSER_OUTPUT: RSS: Main: 139153408 06:12:40 INFO - 2016-01-22 06:12:40,224 DEBUG : BROWSER_OUTPUT: 06:12:40 INFO - 2016-01-22 06:12:40,226 DEBUG : BROWSER_OUTPUT: __start_tp_report 06:12:40 INFO - 2016-01-22 06:12:40,227 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 06:12:40 INFO - 2016-01-22 06:12:40,227 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 06:12:40 INFO - 2016-01-22 06:12:40,227 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 06:12:40 INFO - 2016-01-22 06:12:40,228 DEBUG : BROWSER_OUTPUT: |0;ai-astar;110;104;110;112;111;123;111;111;110;111 06:12:40 INFO - 2016-01-22 06:12:40,228 DEBUG : BROWSER_OUTPUT: |1;audio-beat-detection;148;125;150;156;131;149;157;124;156;130 06:12:40 INFO - 2016-01-22 06:12:40,228 DEBUG : BROWSER_OUTPUT: |2;audio-dft;162;164;161;163;164;159;163;161;162;161 06:12:40 INFO - 2016-01-22 06:12:40,228 DEBUG : BROWSER_OUTPUT: |3;audio-fft;73;71;72;163;74;71;72;72;155;73 06:12:40 INFO - 2016-01-22 06:12:40,228 DEBUG : BROWSER_OUTPUT: |4;audio-oscillator;97;93;135;92;92;94;135;93;93;132 06:12:40 INFO - 2016-01-22 06:12:40,228 DEBUG : BROWSER_OUTPUT: |5;imaging-gaussian-blur;110;110;110;109;111;109;110;109;110;111 06:12:40 INFO - 2016-01-22 06:12:40,228 DEBUG : BROWSER_OUTPUT: |6;imaging-darkroom;146;148;147;147;146;148;146;148;146;146 06:12:40 INFO - 2016-01-22 06:12:40,229 DEBUG : BROWSER_OUTPUT: |7;imaging-desaturate;96;96;96;101;96;96;96;96;96;96 06:12:40 INFO - 2016-01-22 06:12:40,229 DEBUG : BROWSER_OUTPUT: |8;json-parse-financial;61;61;60;61;61;64;60;64;59;58 06:12:40 INFO - 2016-01-22 06:12:40,229 DEBUG : BROWSER_OUTPUT: |9;json-stringify-tinderbox;63;63;63;64;65;64;65;63;64;64 06:12:40 INFO - 2016-01-22 06:12:40,229 DEBUG : BROWSER_OUTPUT: |10;stanford-crypto-aes;81;85;82;81;81;88;82;81;84;83 06:12:40 INFO - 2016-01-22 06:12:40,229 DEBUG : BROWSER_OUTPUT: |11;stanford-crypto-ccm;118;126;113;121;125;126;127;127;114;118 06:12:40 INFO - 2016-01-22 06:12:40,229 DEBUG : BROWSER_OUTPUT: |12;stanford-crypto-pbkdf2;144;146;149;151;145;151;149;155;147;144 06:12:40 INFO - 2016-01-22 06:12:40,229 DEBUG : BROWSER_OUTPUT: |13;stanford-crypto-sha256-iterative;67;66;68;67;69;66;67;66;67;68 06:12:40 INFO - 2016-01-22 06:12:40,229 DEBUG : BROWSER_OUTPUT: __end_tp_report 06:12:40 INFO - 2016-01-22 06:12:40,229 DEBUG : BROWSER_OUTPUT: __start_cc_report 06:12:40 INFO - 2016-01-22 06:12:40,229 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,691 06:12:40 INFO - 2016-01-22 06:12:40,229 DEBUG : BROWSER_OUTPUT: __end_cc_report 06:12:40 INFO - 2016-01-22 06:12:40,229 DEBUG : BROWSER_OUTPUT: __startTimestamp1453471960225__endTimestamp 06:12:40 INFO - 2016-01-22 06:12:40,230 DEBUG : BROWSER_OUTPUT: 06:12:40 INFO - 2016-01-22 06:12:40,233 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 06:12:40 INFO - 2016-01-22 06:12:40,233 DEBUG : BROWSER_OUTPUT: Number of tests: 14 06:12:40 INFO - 2016-01-22 06:12:40,233 DEBUG : BROWSER_OUTPUT: 06:12:40 INFO - 2016-01-22 06:12:40,233 DEBUG : BROWSER_OUTPUT: [#0] ai-astar Cycles:10 Average:111.30 Median:111.00 stddev:4.67 (4.2%) stddev-sans-first:4.93 06:12:40 INFO - 2016-01-22 06:12:40,233 DEBUG : BROWSER_OUTPUT: Values: 110.0 104.0 110.0 112.0 111.0 123.0 111.0 111.0 110.0 111.0 06:12:40 INFO - 2016-01-22 06:12:40,233 DEBUG : BROWSER_OUTPUT: 06:12:40 INFO - 2016-01-22 06:12:40,233 DEBUG : BROWSER_OUTPUT: [#1] audio-beat-detection Cycles:10 Average:142.60 Median:149.50 stddev:13.50 (9.0%) stddev-sans-first:14.18 06:12:40 INFO - 2016-01-22 06:12:40,233 DEBUG : BROWSER_OUTPUT: Values: 148.0 125.0 150.0 156.0 131.0 149.0 157.0 124.0 156.0 130.0 06:12:40 INFO - 2016-01-22 06:12:40,233 DEBUG : BROWSER_OUTPUT: 06:12:40 INFO - 2016-01-22 06:12:40,233 DEBUG : BROWSER_OUTPUT: [#2] audio-dft Cycles:10 Average:162.00 Median:162.50 stddev:1.56 (1.0%) stddev-sans-first:1.66 06:12:40 INFO - 2016-01-22 06:12:40,233 DEBUG : BROWSER_OUTPUT: Values: 162.0 164.0 161.0 163.0 164.0 159.0 163.0 161.0 162.0 161.0 06:12:40 INFO - 2016-01-22 06:12:40,234 DEBUG : BROWSER_OUTPUT: 06:12:40 INFO - 2016-01-22 06:12:40,234 DEBUG : BROWSER_OUTPUT: [#3] audio-fft Cycles:10 Average:89.60 Median:72.00 stddev:36.64 (50.9%) stddev-sans-first:38.36 06:12:40 INFO - 2016-01-22 06:12:40,234 DEBUG : BROWSER_OUTPUT: Values: 73.0 71.0 72.0 163.0 74.0 71.0 72.0 72.0 155.0 73.0 06:12:40 INFO - 2016-01-22 06:12:40,234 DEBUG : BROWSER_OUTPUT: 06:12:40 INFO - 2016-01-22 06:12:40,234 DEBUG : BROWSER_OUTPUT: [#4] audio-oscillator Cycles:10 Average:105.60 Median:93.00 stddev:19.66 (21.1%) stddev-sans-first:20.61 06:12:40 INFO - 2016-01-22 06:12:40,234 DEBUG : BROWSER_OUTPUT: Values: 97.0 93.0 135.0 92.0 92.0 94.0 135.0 93.0 93.0 132.0 06:12:40 INFO - 2016-01-22 06:12:40,234 DEBUG : BROWSER_OUTPUT: 06:12:40 INFO - 2016-01-22 06:12:40,234 DEBUG : BROWSER_OUTPUT: [#5] imaging-gaussian-blur Cycles:10 Average:109.90 Median:110.00 stddev:0.74 (0.7%) stddev-sans-first:0.78 06:12:40 INFO - 2016-01-22 06:12:40,234 DEBUG : BROWSER_OUTPUT: Values: 110.0 110.0 110.0 109.0 111.0 109.0 110.0 109.0 110.0 111.0 06:12:40 INFO - 2016-01-22 06:12:40,234 DEBUG : BROWSER_OUTPUT: 06:12:40 INFO - 2016-01-22 06:12:40,234 DEBUG : BROWSER_OUTPUT: [#6] imaging-darkroom Cycles:10 Average:146.80 Median:147.00 stddev:0.92 (0.6%) stddev-sans-first:0.93 06:12:40 INFO - 2016-01-22 06:12:40,234 DEBUG : BROWSER_OUTPUT: Values: 146.0 148.0 147.0 147.0 146.0 148.0 146.0 148.0 146.0 146.0 06:12:40 INFO - 2016-01-22 06:12:40,234 DEBUG : BROWSER_OUTPUT: 06:12:40 INFO - 2016-01-22 06:12:40,235 DEBUG : BROWSER_OUTPUT: [#7] imaging-desaturate Cycles:10 Average:96.50 Median:96.00 stddev:1.58 (1.6%) stddev-sans-first:1.67 06:12:40 INFO - 2016-01-22 06:12:40,235 DEBUG : BROWSER_OUTPUT: Values: 96.0 96.0 96.0 101.0 96.0 96.0 96.0 96.0 96.0 96.0 06:12:40 INFO - 2016-01-22 06:12:40,235 DEBUG : BROWSER_OUTPUT: 06:12:40 INFO - 2016-01-22 06:12:40,235 DEBUG : BROWSER_OUTPUT: [#8] json-parse-financial Cycles:10 Average:60.90 Median:61.00 stddev:1.91 (3.1%) stddev-sans-first:2.03 06:12:40 INFO - 2016-01-22 06:12:40,235 DEBUG : BROWSER_OUTPUT: Values: 61.0 61.0 60.0 61.0 61.0 64.0 60.0 64.0 59.0 58.0 06:12:40 INFO - 2016-01-22 06:12:40,235 DEBUG : BROWSER_OUTPUT: 06:12:40 INFO - 2016-01-22 06:12:40,235 DEBUG : BROWSER_OUTPUT: [#9] json-stringify-tinderbox Cycles:10 Average:63.80 Median:64.00 stddev:0.79 (1.2%) stddev-sans-first:0.78 06:12:40 INFO - 2016-01-22 06:12:40,235 DEBUG : BROWSER_OUTPUT: Values: 63.0 63.0 63.0 64.0 65.0 64.0 65.0 63.0 64.0 64.0 06:12:40 INFO - 2016-01-22 06:12:40,235 DEBUG : BROWSER_OUTPUT: 06:12:40 INFO - 2016-01-22 06:12:40,235 DEBUG : BROWSER_OUTPUT: [#10] stanford-crypto-aes Cycles:10 Average:82.80 Median:82.50 stddev:2.30 (2.8%) stddev-sans-first:2.35 06:12:40 INFO - 2016-01-22 06:12:40,235 DEBUG : BROWSER_OUTPUT: Values: 81.0 85.0 82.0 81.0 81.0 88.0 82.0 81.0 84.0 83.0 06:12:40 INFO - 2016-01-22 06:12:40,235 DEBUG : BROWSER_OUTPUT: 06:12:40 INFO - 2016-01-22 06:12:40,236 DEBUG : BROWSER_OUTPUT: [#11] stanford-crypto-ccm Cycles:10 Average:121.50 Median:125.50 stddev:5.44 (4.3%) stddev-sans-first:5.62 06:12:40 INFO - 2016-01-22 06:12:40,236 DEBUG : BROWSER_OUTPUT: Values: 118.0 126.0 113.0 121.0 125.0 126.0 127.0 127.0 114.0 118.0 06:12:40 INFO - 2016-01-22 06:12:40,236 DEBUG : BROWSER_OUTPUT: 06:12:40 INFO - 2016-01-22 06:12:40,236 DEBUG : BROWSER_OUTPUT: [#12] stanford-crypto-pbkdf2 Cycles:10 Average:148.10 Median:149.00 stddev:3.57 (2.4%) stddev-sans-first:3.47 06:12:40 INFO - 2016-01-22 06:12:40,236 DEBUG : BROWSER_OUTPUT: Values: 144.0 146.0 149.0 151.0 145.0 151.0 149.0 155.0 147.0 144.0 06:12:40 INFO - 2016-01-22 06:12:40,236 DEBUG : BROWSER_OUTPUT: 06:12:40 INFO - 2016-01-22 06:12:40,236 DEBUG : BROWSER_OUTPUT: [#13] stanford-crypto-sha256-iterative Cycles:10 Average:67.10 Median:67.00 stddev:0.99 (1.5%) stddev-sans-first:1.05 06:12:40 INFO - 2016-01-22 06:12:40,236 DEBUG : BROWSER_OUTPUT: Values: 67.0 66.0 68.0 67.0 69.0 66.0 67.0 66.0 67.0 68.0 06:12:40 INFO - 2016-01-22 06:12:40,236 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 06:12:40 INFO - 2016-01-22 06:12:40,236 DEBUG : BROWSER_OUTPUT: 06:12:41 INFO - 2016-01-22 06:12:41,109 INFO : Browser exited with error code: 0 06:12:41 INFO - 2016-01-22 06:12:41,157 INFO : Completed test kraken (00:00:59) 06:12:41 INFO - 2016-01-22 06:12:41,158 INFO : Starting test v8_7 06:12:41 INFO - 2016-01-22 06:12:41,158 DEBUG : operating with platform_type : linux_ 06:12:41 INFO - 2016-01-22 06:12:41,158 INFO : Initialising browser for v8_7 test... 06:12:41 INFO - 2016-01-22 06:12:41,164 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmp1f_A2Z/profile http://localhost:51170/getInfo.html 06:12:44 INFO - 2016-01-22 06:12:44,784 DEBUG : BROWSER_OUTPUT: 06:12:44 INFO - 2016-01-22 06:12:44,785 DEBUG : BROWSER_OUTPUT: (process:9769): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 06:12:45 INFO - 2016-01-22 06:12:45,627 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 06:12:45 INFO - 2016-01-22 06:12:45,628 DEBUG : BROWSER_OUTPUT: colorDepth:24 06:12:45 INFO - 2016-01-22 06:12:45,628 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 06:12:45 INFO - 2016-01-22 06:12:45,628 DEBUG : BROWSER_OUTPUT: __metrics 06:12:46 INFO - 2016-01-22 06:12:46,609 INFO : Browser initialized. 06:12:46 INFO - 2016-01-22 06:12:46,610 INFO : Running cycle 1/1 for v8_7 test... 06:12:46 INFO - 2016-01-22 06:12:46,610 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmp1f_A2Z/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/v8_7/v8.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 06:12:47 INFO - 2016-01-22 06:12:47,844 DEBUG : BROWSER_OUTPUT: 06:12:47 INFO - 2016-01-22 06:12:47,844 DEBUG : BROWSER_OUTPUT: (process:9883): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 06:12:58 INFO - 2016-01-22 06:12:58,345 DEBUG : BROWSER_OUTPUT: RSS: Main: 136392704 06:12:58 INFO - 2016-01-22 06:12:58,346 DEBUG : BROWSER_OUTPUT: 06:13:19 INFO - 2016-01-22 06:13:19,688 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:51170/tests/v8_7/run.html (next: http://localhost:51170/tests/v8_7/run.html) 06:13:19 INFO - 2016-01-22 06:13:19,947 DEBUG : BROWSER_OUTPUT: RSS: Main: 136175616 06:13:19 INFO - 2016-01-22 06:13:19,947 DEBUG : BROWSER_OUTPUT: 06:13:19 INFO - 2016-01-22 06:13:19,947 DEBUG : BROWSER_OUTPUT: __start_tp_report 06:13:19 INFO - 2016-01-22 06:13:19,947 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 06:13:19 INFO - 2016-01-22 06:13:19,947 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 06:13:19 INFO - 2016-01-22 06:13:19,948 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 06:13:19 INFO - 2016-01-22 06:13:19,948 DEBUG : BROWSER_OUTPUT: |0;Richards;165.61775422325275 06:13:19 INFO - 2016-01-22 06:13:19,948 DEBUG : BROWSER_OUTPUT: |1;DeltaBlue;173.73175816539262 06:13:19 INFO - 2016-01-22 06:13:19,948 DEBUG : BROWSER_OUTPUT: |2;Encrypt;279.17364600781684 06:13:19 INFO - 2016-01-22 06:13:19,948 DEBUG : BROWSER_OUTPUT: |3;Decrypt;5218.75 06:13:19 INFO - 2016-01-22 06:13:19,948 DEBUG : BROWSER_OUTPUT: |4;RayTrace;912.4087591240876 06:13:19 INFO - 2016-01-22 06:13:19,948 DEBUG : BROWSER_OUTPUT: |5;Earley;549.7526113249038 06:13:19 INFO - 2016-01-22 06:13:19,949 DEBUG : BROWSER_OUTPUT: |6;Boyer;10989.010989010989 06:13:19 INFO - 2016-01-22 06:13:19,949 DEBUG : BROWSER_OUTPUT: |7;RegExp;24357.14285714286 06:13:19 INFO - 2016-01-22 06:13:19,949 DEBUG : BROWSER_OUTPUT: |8;Splay;529.3806246691371 06:13:19 INFO - 2016-01-22 06:13:19,949 DEBUG : BROWSER_OUTPUT: |9;NavierStokes;4835.748792270531 06:13:19 INFO - 2016-01-22 06:13:19,949 DEBUG : BROWSER_OUTPUT: __end_tp_report 06:13:19 INFO - 2016-01-22 06:13:19,949 DEBUG : BROWSER_OUTPUT: __startTimestamp1453471999939__endTimestamp 06:13:19 INFO - 2016-01-22 06:13:19,949 DEBUG : BROWSER_OUTPUT: 06:13:19 INFO - 2016-01-22 06:13:19,950 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 06:13:19 INFO - 2016-01-22 06:13:19,950 DEBUG : BROWSER_OUTPUT: Number of tests: 10 06:13:19 INFO - 2016-01-22 06:13:19,950 DEBUG : BROWSER_OUTPUT: 06:13:19 INFO - 2016-01-22 06:13:19,950 DEBUG : BROWSER_OUTPUT: [#0] Richards Cycles:1 Average:165.62 Median:165.62 stddev:0.00 (0.0%) 06:13:19 INFO - 2016-01-22 06:13:19,950 DEBUG : BROWSER_OUTPUT: Values: 165.6 06:13:19 INFO - 2016-01-22 06:13:19,950 DEBUG : BROWSER_OUTPUT: 06:13:19 INFO - 2016-01-22 06:13:19,950 DEBUG : BROWSER_OUTPUT: [#1] DeltaBlue Cycles:1 Average:173.73 Median:173.73 stddev:0.00 (0.0%) 06:13:19 INFO - 2016-01-22 06:13:19,950 DEBUG : BROWSER_OUTPUT: Values: 173.7 06:13:19 INFO - 2016-01-22 06:13:19,951 DEBUG : BROWSER_OUTPUT: 06:13:19 INFO - 2016-01-22 06:13:19,951 DEBUG : BROWSER_OUTPUT: [#2] Encrypt Cycles:1 Average:279.17 Median:279.17 stddev:0.00 (0.0%) 06:13:19 INFO - 2016-01-22 06:13:19,951 DEBUG : BROWSER_OUTPUT: Values: 279.2 06:13:19 INFO - 2016-01-22 06:13:19,951 DEBUG : BROWSER_OUTPUT: 06:13:19 INFO - 2016-01-22 06:13:19,951 DEBUG : BROWSER_OUTPUT: [#3] Decrypt Cycles:1 Average:5218.75 Median:5218.75 stddev:0.00 (0.0%) 06:13:19 INFO - 2016-01-22 06:13:19,951 DEBUG : BROWSER_OUTPUT: Values: 5218.8 06:13:19 INFO - 2016-01-22 06:13:19,952 DEBUG : BROWSER_OUTPUT: 06:13:19 INFO - 2016-01-22 06:13:19,952 DEBUG : BROWSER_OUTPUT: [#4] RayTrace Cycles:1 Average:912.41 Median:912.41 stddev:0.00 (0.0%) 06:13:19 INFO - 2016-01-22 06:13:19,952 DEBUG : BROWSER_OUTPUT: Values: 912.4 06:13:19 INFO - 2016-01-22 06:13:19,952 DEBUG : BROWSER_OUTPUT: 06:13:19 INFO - 2016-01-22 06:13:19,952 DEBUG : BROWSER_OUTPUT: [#5] Earley Cycles:1 Average:549.75 Median:549.75 stddev:0.00 (0.0%) 06:13:19 INFO - 2016-01-22 06:13:19,952 DEBUG : BROWSER_OUTPUT: Values: 549.8 06:13:19 INFO - 2016-01-22 06:13:19,952 DEBUG : BROWSER_OUTPUT: 06:13:19 INFO - 2016-01-22 06:13:19,953 DEBUG : BROWSER_OUTPUT: [#6] Boyer Cycles:1 Average:10989.01 Median:10989.01 stddev:0.00 (0.0%) 06:13:19 INFO - 2016-01-22 06:13:19,953 DEBUG : BROWSER_OUTPUT: Values: 10989.0 06:13:19 INFO - 2016-01-22 06:13:19,953 DEBUG : BROWSER_OUTPUT: 06:13:19 INFO - 2016-01-22 06:13:19,953 DEBUG : BROWSER_OUTPUT: [#7] RegExp Cycles:1 Average:24357.14 Median:24357.14 stddev:0.00 (0.0%) 06:13:19 INFO - 2016-01-22 06:13:19,953 DEBUG : BROWSER_OUTPUT: Values: 24357.1 06:13:19 INFO - 2016-01-22 06:13:19,953 DEBUG : BROWSER_OUTPUT: 06:13:19 INFO - 2016-01-22 06:13:19,953 DEBUG : BROWSER_OUTPUT: [#8] Splay Cycles:1 Average:529.38 Median:529.38 stddev:0.00 (0.0%) 06:13:19 INFO - 2016-01-22 06:13:19,953 DEBUG : BROWSER_OUTPUT: Values: 529.4 06:13:19 INFO - 2016-01-22 06:13:19,954 DEBUG : BROWSER_OUTPUT: 06:13:19 INFO - 2016-01-22 06:13:19,954 DEBUG : BROWSER_OUTPUT: [#9] NavierStokes Cycles:1 Average:4835.75 Median:4835.75 stddev:0.00 (0.0%) 06:13:19 INFO - 2016-01-22 06:13:19,954 DEBUG : BROWSER_OUTPUT: Values: 4835.7 06:13:19 INFO - 2016-01-22 06:13:19,954 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 06:13:19 INFO - 2016-01-22 06:13:19,954 DEBUG : BROWSER_OUTPUT: 06:13:20 INFO - 2016-01-22 06:13:20,785 INFO : Browser exited with error code: 0 06:13:20 INFO - 2016-01-22 06:13:20,802 INFO : Completed test v8_7 (00:00:39) 06:13:20 INFO - 2016-01-22 06:13:20,994 INFO : Completed test suite (00:20:07) 06:13:20 INFO - 2016-01-22 06:13:20,995 DEBUG : Working with test: dromaeo_css 06:13:20 INFO - 2016-01-22 06:13:20,995 DEBUG : Generating results file: dromaeo_css 06:13:20 INFO - 2016-01-22 06:13:20,996 DEBUG : Working with test: kraken 06:13:20 INFO - 2016-01-22 06:13:20,996 DEBUG : Generating results file: kraken 06:13:20 INFO - 2016-01-22 06:13:20,996 INFO : javascript benchmark 06:13:20 INFO - 2016-01-22 06:13:20,996 DEBUG : Working with test: v8_7 06:13:20 INFO - 2016-01-22 06:13:20,996 DEBUG : Generating results file: v8_7 06:13:20 INFO - 2016-01-22 06:13:20,997 INFO : Posting result 0 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 06:13:21 INFO - 2016-01-22 06:13:21,046 DEBUG : process_Request line: dromaeo_css graph.html#tests=[[72,52,43]] 06:13:21 INFO - 2016-01-22 06:13:21,046 DEBUG : process_Request line: dromaeo_css 7299.62 graph.html#tests=[[72,52,43]] 06:13:21 INFO - 2016-01-22 06:13:21,046 INFO : Posting result 1 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 06:13:21 INFO - 2016-01-22 06:13:21,074 DEBUG : process_Request line: kraken 1508.50 graph.html#tests=[[232,52,43]] 06:13:21 INFO - 2016-01-22 06:13:21,074 INFO : Posting result 2 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 06:13:21 INFO - 2016-01-22 06:13:21,104 DEBUG : process_Request line: v8_7 23097.68 graph.html#tests=[[230,52,43]] 06:13:21 INFO - 2016-01-22 06:13:21,105 INFO : javascript benchmark 06:13:21 INFO - 2016-01-22 06:13:21,109 INFO : PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [3210.9518357224647, 3213.726833219176, 3243.1081452600533, 3258.4623537116377, 3266.657001014894, 5471.78112875485, 5550.86122846929, 5561.916571251434, 5583.804566840166, 5619.943800562003, 5554.416786237448, 5595.664260144395, 5630.40880707525, 5637.605367624268, 5653.1520271959225, 5066.822661206849, 5109.69341839489, 5131.563817075553, 5135.486451354854, 5165.690058596478, 4940.160172770619, 5006.899862002758, 5111.693298402108, 5121.103806833789, 5157.690538567679, 5102.668326558781, 5161.819336323229, 5187.6628019178825, 5188.7146206958605, 5200.063988482072, 5155.097857874857, 5211.348581427303, 5212.035773381936, 5224.843254702365, 5252.579793616502, 4892.535209155125, 4950.554450099472, 5016.673916195472, 5117.053345131126, 5127.461616530248, 5342.839714808523, 5379.193121031837, 5417.431169727161, 5452.672839629595, 5481.342238931354, 5948.524118070544, 5965.582409231356, 5977.641341519479, 5991.550633702446, 6016.0, 5861.4724674779045, 5883.970580147072, 6025.15647809307, 6040.697965101727, 6051.062085376773, 5674.517665998395, 5716.942365662324, 5719.056355701346, 5727.083666613364, 5735.713214339308, 6157.599756015845, 6188.0, 6196.628202307876, 6198.473129784019, 6201.875962480815, 5630.986422444, 5791.3339965903615, 5822.039363505059, 5939.22790037301, 5981.760729570856, 5973.163757074013, 6003.459688628044, 6032.849178770566, 6033.0, 6085.786997455157, 5959.433853783884, 5987.850303742354, 6045.576809623284, 6057.394260573908, 6074.848128796727, 5832.3292821326095, 5919.852003699942, 5938.554608404387, 5994.850128746729, 6042.3655516170165, 4634.976825115853, 4650.302454631765, 4656.720596764205, 4657.86026419208, 4676.3453116563705, 4000.8199631016673, 4150.64719498846, 4158.4178215049915, 4174.3947127666315, 4187.0, 5722.399148089391, 5743.569232307594, 5760.049591817303, 5852.824415267549, 5858.179854820329, 6075.483583895419, 6096.085587161872, 6096.72564734588, 6119.265688117454, 6122.510199184055, 5490.1764735289225, 5658.236138121301, 5770.16332631766, 5776.104703770922, 5786.450287222707, 5176.870578235575, 5250.606204534675, 5260.368755749335, 5282.181261904411, 5297.443768404339, 6152.938470615237, 6179.84550386244, 6180.0, 6181.660008699565, 6194.5973511721595, 5860.179574859438, 5969.194158788681, 6061.272647282178, 6062.7271772769445, 6070.696465176812, 6112.755489780359, 6124.234470691164, 6127.342242870382, 6128.350350989301, 6135.049067394561, 5884.323302820059, 5925.466707996301, 5925.555583331354, 5929.080992446177, 5930.05119180929, 5778.624389414675, 5909.55678324136, 6006.969965150146, 6021.54838387114, 6111.7132884518705, 5891.49922256613, 5954.76180952757, 5966.522678185648, 5968.46283834457, 5991.041433370639, 5875.441833025856, 5887.61730487517, 5913.526917846648, 5954.404559544011, 5976.491998180203, 5618.971905140448, 5744.597878148489, 5794.62334948227, 5914.0, 5937.435943585352, 5967.6419414835245, 5972.014617588223, 5978.671173085522, 6019.819405417845, 6022.397760223943, 5542.889142217214, 5845.0, 5884.411558844253, 5887.793927212699, 5894.440028197314], "unit": "ms", "name": "dojo.html", "value": 5545.587203622974}, {"lowerIsBetter": false, "replicates": [587.2277954489846, 628.73278856486, 633.0978355842929, 637.5791977294984, 660.6267458885729, 37908.24183516328, 38182.0, 38323.23353532928, 38446.23107537848, 38730.22539549211, 44053.55946440535, 44233.77883110588, 44688.0, 44799.32801007987, 44887.326690099595, 9116.270698344133, 9252.352335336529, 9259.537023148849, 9265.397749146317, 9299.930507991567, 8956.149165829269, 9086.091390860927, 9099.590518426687, 9101.0, 9113.817723645523, 9108.089191080871, 9195.12646298604, 9212.401193922407, 9216.354855160142, 9224.584893679767, 9118.0, 9126.452412855184, 9139.497327646977, 9189.632414703405, 9223.0, 9040.367174297802, 9108.81782364349, 9131.726048218565, 9137.040610735843, 9168.220701240403, 42891.35662965058, 43106.0, 43185.0, 43534.34698479494, 43546.56453435457, 3664.633536646341, 3673.2837096766143, 3710.5547334319785, 3756.887293381203, 4030.6775457963295, 31805.363892722016, 32041.51937720936, 32258.193545161324, 32297.0, 32869.6713032869, 4272.679549033804, 4311.1593239318345, 4334.826606935719, 4344.02259491615, 4370.060437006027, 287591.0, 288898.0, 289582.0, 290611.0, 290817.0, 44676.3298550522, 44773.55226447759, 44776.0, 44849.77575112104, 63730.0, 46203.768981155554, 46423.53576464192, 46427.67861606906, 46473.0, 46524.0, 15323.387064517518, 15438.845611543966, 15462.536123916301, 15543.222838858012, 15549.611259718371, 12724.936375318064, 12741.55404560836, 12835.165714228546, 12891.677708057374, 13028.54400096011, 15384.076955382712, 15500.457483988006, 15547.766783498257, 15566.0, 15581.610459738371, 6041.6375017499095, 6192.349803270682, 6220.25356957159, 6280.340564240781, 6285.057241413733, 1063.4576366053213, 1101.4162493878257, 1126.5212284778936, 1199.4422593493894, 1202.6452196602024, 28412.083965200538, 29381.0, 29433.85283073571, 29494.0, 29508.114756557337, 1100.9284396514201, 1115.7712668902855, 1161.181367136167, 1189.339916346436, 1195.9222650527688, 15208.0, 15336.140728130835, 15351.92324038395, 15529.767053494206, 15856.44502442409, 571447.0, 579351.0, 579483.0, 583790.0, 766565.0, 60406.697966509884, 61510.0, 61530.0, 61733.69133154395, 61765.0, 1430.9069910455787, 1489.4489039055618, 1491.4407097338715, 1497.0568541818802, 1499.7150541397318, 30084.0, 30524.236894077825, 30902.381952361276, 31566.842165789025, 31691.04926852106, 51244.0, 51660.22509662283, 51712.74143629258, 51846.74076629593, 51979.480205198975, 319628.0, 322991.0, 323397.0, 323634.0, 325039.0, 33919.0, 34483.96548103561, 34657.48013779745, 34746.47880281747, 35057.474137888465, 46225.0, 46234.30648540207, 46761.298580522, 46990.76504617455, 47179.76410117927, 39826.402603960385, 40159.79920100498, 40296.3955540673, 40437.0, 41169.38245926373, 39396.60603393929, 39761.40357894692, 41094.0, 42746.1450770989, 44132.0, 38761.80619096886, 38977.80511097427, 39272.80363598164, 39374.60625393709, 39637.0, 33867.49198761971, 33977.150571235914, 39548.40677389899, 39608.801955990035, 40162.79918600388, 26150.34624134412, 26651.20046398611, 26679.0, 26783.73226222289, 27002.189934302], "unit": "ms", "name": "ext.html", "value": 19639.40579033708}, {"lowerIsBetter": false, "replicates": [347.95998460177077, 352.99999999999994, 356.3727839003353, 364.67361711268416, 369.37944253653853, 17881.463556093306, 18599.814001859977, 18941.242350305987, 19238.807611923876, 19685.409437716855, 11397.202195846294, 11857.525698972053, 12207.962323202517, 12263.141580089397, 17910.74624776266, 5083.898322033567, 5350.785968561272, 5653.4911857932775, 5654.321481422235, 5673.092305231164, 5627.409122042188, 5645.830625081254, 5654.575906806986, 5654.830355089333, 5655.462731040545, 3908.7850168240734, 3998.040470287139, 5457.727113644321, 5548.389677135512, 5561.805336813212, 5426.782928682867, 5597.132444471114, 5660.405657405975, 5667.886642267132, 5698.373178950312, 5107.055194788939, 5261.894762104775, 5453.018456677796, 5456.399796022434, 5460.0, 13148.737025259441, 13157.079004469691, 13267.203967761869, 19000.904995475074, 20212.797872021387, 733.5085492719837, 734.0530715377157, 2047.488127968008, 2266.943326416853, 2299.1837897546297, 10060.39637621745, 10191.133753630951, 10286.485675716185, 10426.947865260701, 10467.63363282289, 1910.522369407648, 1919.8464122870137, 1920.4430715092606, 1932.594155227404, 1977.2881762565464, 63439.0, 65320.34679653238, 66755.3324466754, 67051.0, 67419.66290168568, 10047.648332308334, 10496.160307175407, 10565.9471702641, 10711.357318560911, 10731.463426828628, 13794.310284485735, 13815.378307976165, 13852.722945541032, 13853.30733463343, 13887.722245555033, 8049.6377663005305, 8092.878606820902, 8221.753347399588, 8239.134890836496, 8253.380996425292, 8219.095899451055, 8237.135100814448, 8254.463459875089, 8268.917310826815, 8306.54314012735, 4466.39703640011, 4488.506264310923, 4515.345274935116, 4537.160625284333, 4615.699979501389, 1887.6413481438483, 1893.5455490682136, 1910.0, 1946.6106778644328, 1957.2660252405349, 428.259111736691, 440.8963893485093, 927.4481683398367, 972.7227740094039, 1059.56557811297, 10067.194624430029, 10680.732981675364, 11087.889121108847, 11197.384143872003, 11360.261582997078, 454.47735104629277, 462.1727108475858, 462.5536357415043, 472.4236431553499, 474.81719537978125, 5863.560232982543, 6161.44546990773, 10210.0, 10224.64213752515, 10277.766667999887, 609662.0, 613165.0, 618673.0, 708555.0, 710967.0, 84571.0, 87509.0, 88482.55758721165, 89924.0, 90080.0, 1208.0758219961735, 1215.477344741752, 1215.8540975083047, 1216.8661447240797, 1224.1125184241355, 16049.598760031093, 16258.430954916521, 16333.0, 16535.173241338125, 16685.91657041707, 37860.0, 37887.242255155295, 38166.23667526578, 38169.0, 39048.04759762057, 51147.0, 52435.47564524306, 54258.72870635622, 55305.44694553003, 63130.0, 15195.848041519885, 15272.923635381752, 15276.465323713617, 15528.068315901082, 15759.606009849387, 20776.79223207809, 20965.89517052405, 20972.68540971856, 21123.366299011053, 21501.0, 16330.0, 16546.172691365624, 16872.156392180586, 17017.0, 17326.566835829206, 9908.702738917844, 10093.243006774668, 10119.645812396826, 10204.897951020692, 10222.335548189343, 10287.382757034602, 10338.534765935701, 10521.842172367573, 10564.947175264075, 10703.946480267548, 15971.44099956496, 15977.281022354255, 16023.759643605588, 16133.67732645364, 16190.91904540517, 15997.360105595646, 16139.0, 16822.915885420494, 16998.2350794217, 17095.65808683844], "unit": "ms", "name": "jquery.html", "value": 8887.15236705448}, {"lowerIsBetter": false, "replicates": [1534.3018926388488, 1535.071281874466, 1727.904965226912, 1758.358199257271, 1822.232434538498, 7054.894176587355, 7131.786046418602, 7396.926030739691, 7775.183605721396, 7791.454598178129, 7228.710851565944, 7379.077615298088, 7391.704331826721, 7430.331270185682, 7459.515131516461, 2220.977790222093, 2245.5733410652006, 2260.2880092770806, 2261.0955617752948, 2262.095161935231, 2260.7965283124518, 2271.2618399020303, 2304.412374844421, 2317.895694693743, 2318.907243710258, 2254.830887683422, 2259.67234750961, 2279.6466547685136, 2282.5777231212196, 2290.828187885907, 2241.4396400899777, 2253.5943530164564, 2278.259565641173, 2289.095807156181, 2290.8510946788488, 2291.9312420627407, 2312.7340355859124, 2330.207729372005, 2341.4848733278823, 2342.7774361435636, 7732.6133693315105, 7849.0, 7852.17552157021, 7853.764387068397, 7874.448788584801, 4484.573965473275, 4563.338315944203, 4564.269716845289, 4571.26859702446, 4574.4739354973935, 2895.1459319500796, 2917.6352955880516, 2952.35048289376, 2967.540031295153, 2994.940101197964, 970.1317320997738, 977.0913050862695, 991.5637119667323, 1016.2530540053056, 1024.7540590258284, 9971.102600765893, 9995.70012899614, 10001.649942251986, 10006.249531285182, 10037.648682296085, 4079.63283304504, 4093.8771836844944, 4094.406311084876, 4112.794360282034, 4129.648979836687, 8679.392442529088, 8756.605952732143, 8765.0, 8781.736547903573, 8781.868271975925, 4603.470600880942, 4623.098495793355, 4624.237000894882, 4625.560571745679, 4631.490536041033, 3792.070942619021, 3834.3481608126126, 4115.1975364803575, 4195.223883581547, 4233.343831706091, 3539.0444579963264, 3545.503629491873, 3562.251927095339, 3572.499850020999, 3578.3916734155255, 1075.1076606416655, 1085.4843949124104, 1089.4661615808197, 1091.858058452412, 1100.8403781451646, 1128.7629597784558, 1135.8920902514249, 1148.362658724416, 1384.6953670192543, 1458.1979911049093, 7005.404540614003, 7308.598027108454, 7446.925530744732, 7457.10514738224, 7497.925020749832, 1072.5388083124176, 1116.4027245423658, 1158.5829101523445, 1187.4656404617956, 1200.237848965913, 5931.0, 5951.226340575698, 5964.582479226413, 5969.79105731306, 5979.611325263844, 9066.184043435991, 9126.08739126082, 9231.584578693975, 9273.907260927304, 9358.766030849147, 9112.453252804853, 9164.037776033554, 9179.632814687471, 9184.219341355925, 9199.0, 7120.964395177991, 7154.463415243774, 7181.712731490682, 7185.784426467214, 7309.232530584319, 7368.931504931647, 7424.257574242532, 7428.480006399716, 7454.4781865268915, 7462.925370746223, 7928.167542407964, 8059.234372734581, 8259.628316725642, 8328.6668533258, 8350.58247087631, 8393.706220282262, 8398.538080405637, 8400.495970241805, 8439.746807595782, 8463.36524760633, 6680.5323627345615, 6705.832354191184, 6808.387245147763, 6849.623270720158, 6861.348171923659, 7356.043714317105, 7368.4842061055215, 7370.48406611532, 7422.554646721214, 7491.662875170739, 6958.547694399847, 6977.33715297046, 6991.615461149686, 7064.752733654297, 7126.144862616519, 6885.1049363582415, 6887.758928437481, 6930.549514281555, 6953.548019378724, 6990.685419156049, 6835.384815366641, 6846.383825455733, 6851.109355783717, 6870.3473170048765, 6966.711158435705, 6306.369363063657, 6311.558190926591, 6361.554691171574, 6369.49044076482, 6373.521985850987, 6524.902126468011, 6525.804225873231, 6556.8360790980605, 6571.671416429255, 6590.80227593173], "unit": "ms", "name": "mootools.html", "value": 4445.212218633941}, {"lowerIsBetter": false, "replicates": [347.72355976998284, 350.6283339659959, 353.33396547507954, 355.2397868561279, 357.1072319201995, 6334.366563343663, 6376.298607153215, 6420.614763114217, 6452.870942581151, 6506.674666266679, 6227.564070515065, 6405.0, 6416.679166041691, 6416.967915160418, 6418.646974416405, 4863.9027219455675, 4878.951210487903, 4928.605711543086, 4930.334404855353, 4931.975340123312, 4927.827526036589, 4935.777889994941, 4945.23348880924, 4947.579455746266, 4949.554540091391, 4698.060387922429, 4857.9757101214445, 4871.074495845795, 4888.584470320027, 4898.363212782333, 4821.059893320804, 4865.708057516543, 4871.634627402959, 4875.244337127733, 4880.9755951220195, 4206.3690446432975, 4232.576742325774, 4242.236397448458, 4244.766537840417, 4253.914921701579, 6007.219061522018, 6051.425114614105, 6088.391160883921, 6094.8171554853425, 6099.810536945298, 5654.886902261932, 5655.3779084300695, 5655.434456554352, 5656.066748986413, 5661.433856614347, 6744.325567443266, 6745.696443660047, 6749.325067493261, 6752.257251702309, 6752.696128674222, 4679.064187162547, 4689.437267527918, 4695.272232803886, 4699.389079419688, 4707.952920470786, 6875.346842049998, 6952.478564107712, 7002.229754726976, 7020.262872398427, 7056.259092795234, 4787.0904528139545, 4794.232922732346, 4795.928061079087, 4806.182948898696, 4809.615230781529, 4854.907645779671, 4868.732219727878, 4870.391201099863, 4875.317455556225, 4880.682755620874, 5509.779608815683, 5628.296462942132, 5631.605787594829, 5647.576431767634, 5651.434856514398, 6763.086983257295, 6854.246032936473, 6854.725810967605, 6878.621675807779, 6898.7240510380025, 1722.9741553876702, 1753.8070812210647, 1768.7700598922315, 1769.265754711806, 1769.6283780406002, 1188.102982248397, 1207.5532053140394, 1217.0507004536476, 1223.975520489603, 1226.791445454275, 6480.481561475165, 6480.837979050467, 6503.382178693111, 6507.934920650828, 6515.315891831384, 6988.93011069893, 6990.790276291617, 7001.054857594261, 7003.54476958996, 7013.719451221894, 6402.583832050902, 6485.8702825944165, 6505.934940650533, 6508.60948343101, 6510.544261901621, 3770.849166033383, 3787.8295476703615, 3802.239552089593, 3802.7908465034134, 3807.9809600951817, 7161.606111663908, 7164.462665300123, 7182.174049984214, 7186.784396468114, 7188.245234250328, 6983.812751832201, 7107.182673992454, 7111.573305601681, 7125.1093613298335, 7129.215786263507, 7131.393831524275, 7151.427885769126, 7159.463040272, 7159.606221657858, 7176.390006849372, 6972.058772065909, 6981.825454363681, 6984.3364880336285, 6985.231624521197, 7011.0, 6814.795556133324, 6866.313368663294, 6871.759488417882, 6994.440444764508, 7022.1924478685605, 7305.780826575211, 7334.743283985035, 7360.852782944418, 7362.77911662651, 7369.299916507923, 4684.789184486638, 4694.366260554782, 4712.410948631421, 4719.38647975761, 4733.1716949533, 7006.913928341115, 7136.928630713626, 7140.536190081125, 7165.176004759311, 7169.139703235645, 6927.064846245894, 6988.0, 6988.650567471708, 6996.720131194696, 6997.0, 6903.0, 6906.930930690629, 6951.7914462566205, 6955.234924158237, 6962.860742785218, 6645.9003114954285, 6775.288594697683, 6804.0, 6855.691493882688, 6861.965690171517, 6948.305169483214, 6967.233604303421, 6975.058367120374, 6986.0, 6995.195552511526, 6675.8664826702225, 6783.21992970795, 6808.455323574201, 6813.727450901908, 6831.146106736658], "unit": "ms", "name": "prototype.html", "value": 5136.535604481557}, {"lowerIsBetter": false, "replicates": [806.5402720449339, 831.7671052105411, 840.5335039053326, 854.2653318146397, 950.2018304624114, 14920.701585968274, 14941.92529037356, 15077.019993700402, 15108.622284442881, 15192.848071519282, 13935.581932542014, 14071.648208794786, 14093.577192684235, 14138.434462621508, 14144.929275353634, 915.3455279475174, 925.6297481007583, 929.995350023249, 930.5812384427, 936.3445588088331, 912.8219997100568, 926.0507979321216, 926.2913870888742, 932.4451951089092, 933.9066093390675, 963.9614415423374, 964.3587014635259, 972.4214092614883, 972.4262685015839, 973.4354074636693, 960.7117864640614, 962.5860879821674, 963.8361478548663, 966.3477152921749, 969.3263182088451, 716.9856602867966, 717.4296434334665, 720.4020662849822, 720.8738470767647, 721.4733244731375, 15344.07935523861, 15438.459653912172, 15523.844761552353, 15537.533873983799, 15570.610734731608, 13084.21494710311, 13163.276019818906, 13168.144070635379, 13177.670558236025, 13576.660583485393, 10992.835107473395, 11333.0, 11372.37451940143, 11380.089592832554, 11429.599964001303, 3702.352088384549, 3723.4600982857332, 3755.887323380303, 3763.510743603314, 3865.1496670732395, 50301.24548131781, 50779.0, 50780.49219507832, 50982.7450862747, 51092.23361649578, 10994.455702599682, 11012.0, 11013.394263315595, 11231.326120432801, 11280.153988450898, 19177.616447671247, 19341.709874351895, 19461.416157515298, 19524.609507809764, 19640.3125890596, 8020.077691065486, 8084.636191371284, 8203.548804815673, 8210.548419836847, 8219.8356032879, 4346.304591265382, 4607.631389488833, 4654.813807447664, 4779.211430114062, 4786.16242157621, 3284.753643476749, 3287.260366417585, 3310.9834450828075, 3314.436545787222, 3318.9170270742943, 585.7071464267866, 587.9735411906474, 589.6904125334148, 596.1713218626113, 604.4408921747454, 689.8034060292792, 723.2442098007594, 724.6700517692402, 746.7535713214626, 752.7026824404439, 8992.955035224782, 9350.205232555309, 9632.27757918159, 9936.850947235796, 10019.148372388283, 714.3570786292274, 736.988945165823, 758.7534051433306, 761.9352355049772, 769.7036640893297, 4225.535191128974, 4250.426192463978, 4263.219624185873, 4323.265044942367, 4383.649308055348, 56904.71547642318, 57225.14162287569, 57393.42606573881, 57504.424955749906, 57820.421795781505, 52046.0, 52480.0, 52650.736746316026, 52670.0, 52822.20766688503, 49273.753631231615, 49488.0, 49501.0, 49504.25743613848, 49520.75239623779, 8963.551822408985, 9089.409188402733, 9300.767480812763, 9537.998510156334, 9756.317057805885, 37881.81059094797, 38079.428808568446, 38280.617193827704, 38473.230535389695, 38795.0, 45309.0, 46785.29822052604, 46960.0, 47336.52663473459, 47532.7623361881, 11401.0, 12102.394880255775, 12113.33376664292, 12376.504939802307, 12444.68888277764, 13457.46170153222, 13505.932470337586, 13718.93140534291, 13815.309234538434, 14014.789778153132, 11611.129165312466, 11671.0, 11675.76648467009, 11683.474243658886, 11824.23142495735, 11386.089112870784, 11617.070634349062, 11731.88268117308, 11978.76042479163, 12111.091668124749, 11314.773704525698, 11447.771044578894, 11547.653570392902, 11555.0, 11849.52601895949, 10320.845187322046, 10671.146308295472, 10955.34267943926, 11140.498677559368, 11434.313941163557, 9730.41617502952, 9880.308378413441, 9917.752056198364, 9983.60065597368, 10006.69979900604], "unit": "ms", "name": "yui.html", "value": 6844.8219850699315}], "name": "dromaeo_css", "value": 7299.619899449452}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [110.0, 104.0, 110.0, 112.0, 111.0, 123.0, 111.0, 111.0, 110.0, 111.0], "unit": "ms", "name": "ai-astar", "value": 111.3}, {"lowerIsBetter": true, "replicates": [148.0, 125.0, 150.0, 156.0, 131.0, 149.0, 157.0, 124.0, 156.0, 130.0], "unit": "ms", "name": "audio-beat-detection", "value": 142.6}, {"lowerIsBetter": true, "replicates": [162.0, 164.0, 161.0, 163.0, 164.0, 159.0, 163.0, 161.0, 162.0, 161.0], "unit": "ms", "name": "audio-dft", "value": 162.0}, {"lowerIsBetter": true, "replicates": [73.0, 71.0, 72.0, 163.0, 74.0, 71.0, 72.0, 72.0, 155.0, 73.0], "unit": "ms", "name": "audio-fft", "value": 89.6}, {"lowerIsBetter": true, "replicates": [97.0, 93.0, 135.0, 92.0, 92.0, 94.0, 135.0, 93.0, 93.0, 132.0], "unit": "ms", "name": "audio-oscillator", "value": 105.6}, {"lowerIsBetter": true, "replicates": [110.0, 110.0, 110.0, 109.0, 111.0, 109.0, 110.0, 109.0, 110.0, 111.0], "unit": "ms", "name": "imaging-gaussian-blur", "value": 109.9}, {"lowerIsBetter": true, "replicates": [146.0, 148.0, 147.0, 147.0, 146.0, 148.0, 146.0, 148.0, 146.0, 146.0], "unit": "ms", "name": "imaging-darkroom", "value": 146.8}, {"lowerIsBetter": true, "replicates": [96.0, 96.0, 96.0, 101.0, 96.0, 96.0, 96.0, 96.0, 96.0, 96.0], "unit": "ms", "name": "imaging-desaturate", "value": 96.5}, {"lowerIsBetter": true, "replicates": [61.0, 61.0, 60.0, 61.0, 61.0, 64.0, 60.0, 64.0, 59.0, 58.0], "unit": "ms", "name": "json-parse-financial", "value": 60.9}, {"lowerIsBetter": true, "replicates": [63.0, 63.0, 63.0, 64.0, 65.0, 64.0, 65.0, 63.0, 64.0, 64.0], "unit": "ms", "name": "json-stringify-tinderbox", "value": 63.8}, {"lowerIsBetter": true, "replicates": [81.0, 85.0, 82.0, 81.0, 81.0, 88.0, 82.0, 81.0, 84.0, 83.0], "unit": "ms", "name": "stanford-crypto-aes", "value": 82.8}, {"lowerIsBetter": true, "replicates": [118.0, 126.0, 113.0, 121.0, 125.0, 126.0, 127.0, 127.0, 114.0, 118.0], "unit": "ms", "name": "stanford-crypto-ccm", "value": 121.5}, {"lowerIsBetter": true, "replicates": [144.0, 146.0, 149.0, 151.0, 145.0, 151.0, 149.0, 155.0, 147.0, 144.0], "unit": "ms", "name": "stanford-crypto-pbkdf2", "value": 148.1}, {"lowerIsBetter": true, "replicates": [67.0, 66.0, 68.0, 67.0, 69.0, 66.0, 67.0, 66.0, 67.0, 68.0], "unit": "ms", "name": "stanford-crypto-sha256-iterative", "value": 67.1}], "name": "kraken", "value": 1508.4999999999998}, {"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [165.61775422325275], "unit": "score", "name": "Richards", "value": 213.15347599999996}, {"lowerIsBetter": false, "replicates": [173.73175816539262], "unit": "score", "name": "DeltaBlue", "value": 380.5752080000001}, {"lowerIsBetter": false, "replicates": [279.17364600781684], "unit": "score", "name": "Encrypt", "value": 953.4603419999996}, {"lowerIsBetter": false, "replicates": [5218.75], "unit": "score", "name": "Decrypt", "value": 51.00474251497002}, {"lowerIsBetter": false, "replicates": [912.4087591240876], "unit": "score", "name": "RayTrace", "value": 811.0279440000002}, {"lowerIsBetter": false, "replicates": [549.7526113249038], "unit": "score", "name": "Earley", "value": 1212.296197}, {"lowerIsBetter": false, "replicates": [10989.010989010989], "unit": "score", "name": "Boyer", "value": 60.64813299999995}, {"lowerIsBetter": false, "replicates": [24357.14285714286], "unit": "score", "name": "RegExp", "value": 37.40114369501463}, {"lowerIsBetter": false, "replicates": [529.3806246691371], "unit": "score", "name": "Splay", "value": 153.93649899999997}, {"lowerIsBetter": false, "replicates": [4835.748792270531], "unit": "score", "name": "NavierStokes", "value": 306.881118881119}], "name": "v8_7", "value": 23097.67613605751}]} 06:13:21 INFO - RETURN: dromaeo_css: 7299.62 06:13:21 INFO - RETURN: kraken: 1508.50 06:13:21 INFO - RETURN: v8_7: 23097.68 06:13:21 INFO - TinderboxPrint: TalosResult: {"graphserver": {"v8_7": {"url": "http://graphs.mozilla.org/graph.html#tests=[[230,52,43]]", "result": "23097.68"}, "kraken": {"url": "http://graphs.mozilla.org/graph.html#tests=[[232,52,43]]", "result": "1508.50"}, "dromaeo_css": {"url": "http://graphs.mozilla.org/graph.html#tests=[[72,52,43]]", "result": "7299.62"}}} 06:13:21 INFO - Return code: 0 06:13:21 INFO - Validating PERFHERDER_DATA against /builds/slave/test-pgo/build/tests/talos/treeherder-schemas/performance-artifact.json 06:13:21 INFO - # TBPL SUCCESS # 06:13:21 INFO - Running post-action listener: _resource_record_post_action 06:13:21 INFO - Running post-run listener: _resource_record_post_run 06:13:22 INFO - Total resource usage - Wall time: 1224s; CPU: 13.0%; Read bytes: 294912; Write bytes: 513585152; Read time: 500; Write time: 495772 06:13:22 INFO - install - Wall time: 15s; CPU: 14.0%; Read bytes: 4096; Write bytes: 237826048; Read time: 140; Write time: 301132 06:13:22 INFO - run-tests - Wall time: 1209s; CPU: 13.0%; Read bytes: 290816; Write bytes: 275759104; Read time: 360; Write time: 194640 06:13:22 INFO - Running post-run listener: _upload_blobber_files 06:13:22 INFO - Blob upload gear active. 06:13:22 INFO - There are no files to upload in the directory. Skipping the blob upload mechanism ... 06:13:22 INFO - Copying logs to upload dir... 06:13:22 INFO - mkdir: /builds/slave/test-pgo/build/upload/logs program finished with exit code 0 elapsedTime=1268.560585 ========= master_lag: 0.23 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 8 secs) (at 2016-01-22 06:13:22.360398) ========= ========= Started set props: build_url (results: 0, elapsed: 0 secs) (at 2016-01-22 06:13:22.363621) ========= bash -c 'for file in `ls -1`; do cat $file; done' in dir /builds/slave/test-pgo/properties (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', 'for file in `ls -1`; do cat $file; done'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test-pgo/properties SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=b5f16d05e5ea93ddf675e67e000001bf-1453470511.106647-1655455357 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False build_url:https://queue.taskcluster.net/v1/task/2p0v77w4SLK4Lf8Vflb2rg/artifacts/public/build/firefox-45.0a2.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.010028 build_url: 'https://queue.taskcluster.net/v1/task/2p0v77w4SLK4Lf8Vflb2rg/artifacts/public/build/firefox-45.0a2.en-US.linux-x86_64.tar.bz2' ========= master_lag: 0.01 ========= ========= Finished set props: build_url (results: 0, elapsed: 0 secs) (at 2016-01-22 06:13:22.386534) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-01-22 06:13:22.386859) ========= rm -f oauth.txt in dir /builds/slave/test-pgo/. (timeout 1200 secs) watching logfiles {} argv: ['rm', '-f', 'oauth.txt'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test-pgo SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=b5f16d05e5ea93ddf675e67e000001bf-1453470511.106647-1655455357 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004558 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-01-22 06:13:22.436174) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-01-22 06:13:22.436494) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-01-22 06:13:22.436794) ========= ========= Total master_lag: 0.42 =========