builder: mozilla-beta_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-007 starttime: 1467525960.7 results: success (0) buildid: 20160701065031 builduid: c767f5fb4f57427c8722dbadfbf73505 revision: 5e6976a28642d4d159071e14fd3251d76b9c46fa ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-07-02 23:06:00.700728) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-07-02 23:06:00.701069) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 2 secs) (at 2016-07-02 23:06:00.701356) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 2 secs) (at 2016-07-02 23:06:02.856546) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-02 23:06:02.856853) ========= 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/. (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 SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=923d835db2ba3686ebe126b700000192-1467524797.359105-1414661519 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-07-02 23:06:04-- 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% 19.8M=0.001s 2016-07-02 23:06:04 (19.8 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.107162 ========= master_lag: 0.03 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-02 23:06:02.993938) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-07-02 23:06:02.994252) ========= rm -rf scripts properties in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['rm', '-rf', 'scripts', '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 SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=923d835db2ba3686ebe126b700000192-1467524797.359105-1414661519 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.019100 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-07-02 23:06:03.056668) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-07-02 23:06:03.057472) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-beta --rev 5e6976a28642d4d159071e14fd3251d76b9c46fa --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo releases/mozilla-beta --rev 5e6976a28642d4d159071e14fd3251d76b9c46fa --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 SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=923d835db2ba3686ebe126b700000192-1467524797.359105-1414661519 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-07-02 23:06:04,503 truncating revision to first 12 chars 2016-07-02 23:06:04,503 Setting DEBUG logging. 2016-07-02 23:06:04,503 attempt 1/10 2016-07-02 23:06:04,503 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-beta/5e6976a28642?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-07-02 23:06:04,934 unpacking tar archive at: mozilla-beta-5e6976a28642/testing/mozharness/ program finished with exit code 0 elapsedTime=1.083365 ========= master_lag: 0.03 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-07-02 23:06:04.166488) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-07-02 23:06:04.166810) ========= script_repo_revision: 5e6976a28642d4d159071e14fd3251d76b9c46fa ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-07-02 23:06:04.167226) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-07-02 23:06:04.167540) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-07-02 23:06:04.201213) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 22 secs) (at 2016-07-02 23:06:04.201889) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Beta --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Beta in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Mozilla-Beta', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Mozilla-Beta'] 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/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=923d835db2ba3686ebe126b700000192-1467524797.359105-1414661519 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 23:06:05 INFO - MultiFileLogger online at 20160702 23:06:05 in /builds/slave/test 23:06:05 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Beta --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Beta 23:06:05 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 23:06:05 INFO - {'append_to_log': False, 23:06:05 INFO - 'base_work_dir': '/builds/slave/test', 23:06:05 INFO - 'blob_upload_branch': 'Mozilla-Beta', 23:06:05 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 23:06:05 INFO - 'branch': 'Mozilla-Beta', 23:06:05 INFO - 'buildbot_json_path': 'buildprops.json', 23:06:05 INFO - 'config_files': ('talos/linux_config.py',), 23:06:05 INFO - 'default_actions': ('clobber', 23:06:05 INFO - 'read-buildbot-config', 23:06:05 INFO - 'download-and-extract', 23:06:05 INFO - 'populate-webroot', 23:06:05 INFO - 'create-virtualenv', 23:06:05 INFO - 'install', 23:06:05 INFO - 'run-tests'), 23:06:05 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 23:06:05 INFO - 'download_minidump_stackwalk': True, 23:06:05 INFO - 'download_symbols': 'ondemand', 23:06:05 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 23:06:05 INFO - 'tooltool.py': '/tools/tooltool.py', 23:06:05 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 23:06:05 INFO - '/tools/misc-python/virtualenv.py')}, 23:06:05 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 23:06:05 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 23:06:05 INFO - 'installer_path': 'installer.exe', 23:06:05 INFO - 'log_level': 'info', 23:06:05 INFO - 'log_name': 'talos', 23:06:05 INFO - 'log_to_console': True, 23:06:05 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 23:06:05 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 23:06:05 INFO - 'opt_config_files': (), 23:06:05 INFO - 'pip_index': False, 23:06:05 INFO - 'sps_profile': False, 23:06:05 INFO - 'sps_profile_interval': 0, 23:06:05 INFO - 'suite': 'dromaeojs', 23:06:05 INFO - 'system_bits': '32', 23:06:05 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 23:06:05 INFO - 'title': 'talos-linux64-ix-007', 23:06:05 INFO - 'tooltool_cache': '/builds/tooltool_cache', 23:06:05 INFO - 'use_talos_json': True, 23:06:05 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 23:06:05 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 23:06:05 INFO - 'work_dir': 'build'} 23:06:05 INFO - ##### 23:06:05 INFO - ##### Running clobber step. 23:06:05 INFO - ##### 23:06:05 INFO - Running pre-action listener: _resource_record_pre_action 23:06:05 INFO - Running main action method: clobber 23:06:05 INFO - rmtree: /builds/slave/test/build 23:06:05 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 23:06:06 INFO - Running post-action listener: _resource_record_post_action 23:06:06 INFO - ##### 23:06:06 INFO - ##### Running read-buildbot-config step. 23:06:06 INFO - ##### 23:06:06 INFO - Running pre-action listener: _resource_record_pre_action 23:06:06 INFO - Running main action method: read_buildbot_config 23:06:06 INFO - Using buildbot properties: 23:06:06 INFO - { 23:06:06 INFO - "project": "", 23:06:06 INFO - "product": "firefox", 23:06:06 INFO - "script_repo_revision": "production", 23:06:06 INFO - "builddir": "mozilla-beta_ubuntu64_hw_test-dromaeojs", 23:06:06 INFO - "repository": "", 23:06:06 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-beta pgo talos dromaeojs", 23:06:06 INFO - "buildid": "20160701065031", 23:06:06 INFO - "pgo_build": "True", 23:06:06 INFO - "basedir": "/builds/slave/test", 23:06:06 INFO - "buildnumber": 82, 23:06:06 INFO - "slavename": "talos-linux64-ix-007", 23:06:06 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 23:06:06 INFO - "platform": "ubuntu64_hw", 23:06:06 INFO - "scheduler": "tests-mozilla-beta-linux64-pgo-talos", 23:06:06 INFO - "branch": "mozilla-beta", 23:06:06 INFO - "repo_path": "releases/mozilla-beta", 23:06:06 INFO - "revision": "5e6976a28642d4d159071e14fd3251d76b9c46fa", 23:06:06 INFO - "stage_platform": "linux64-pgo", 23:06:06 INFO - "builduid": "c767f5fb4f57427c8722dbadfbf73505", 23:06:06 INFO - "slavebuilddir": "test" 23:06:06 INFO - } 23:06:06 INFO - Found installer url https://queue.taskcluster.net/v1/task/Aava5bJ9QCOkDkcxZYB98w/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.tar.bz2. 23:06:06 INFO - Running post-action listener: _resource_record_post_action 23:06:06 INFO - ##### 23:06:06 INFO - ##### Running download-and-extract step. 23:06:06 INFO - ##### 23:06:06 INFO - Running pre-action listener: _resource_record_pre_action 23:06:06 INFO - Running main action method: download_and_extract 23:06:06 INFO - mkdir: /builds/slave/test/build/tests 23:06:06 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')]} 23:06:06 INFO - https://queue.taskcluster.net/v1/task/Aava5bJ9QCOkDkcxZYB98w/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 23:06:06 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Aava5bJ9QCOkDkcxZYB98w/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.test_packages.json 23:06:06 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Aava5bJ9QCOkDkcxZYB98w/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.test_packages.json 23:06:06 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Aava5bJ9QCOkDkcxZYB98w/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-48.0.en-US.linux-x86_64.test_packages.json 23:06:06 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Aava5bJ9QCOkDkcxZYB98w/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-48.0.en-US.linux-x86_64.test_packages.json'}, attempt #1 23:06:06 INFO - Downloaded 1327 bytes. 23:06:06 INFO - Reading from file /builds/slave/test/build/firefox-48.0.en-US.linux-x86_64.test_packages.json 23:06:06 INFO - Using the following test package requirements: 23:06:06 INFO - {u'common': [u'firefox-48.0.en-US.linux-x86_64.common.tests.zip'], 23:06:06 INFO - u'cppunittest': [u'firefox-48.0.en-US.linux-x86_64.common.tests.zip', 23:06:06 INFO - u'firefox-48.0.en-US.linux-x86_64.cppunittest.tests.zip'], 23:06:06 INFO - u'gtest': [u'firefox-48.0.en-US.linux-x86_64.common.tests.zip', 23:06:06 INFO - u'firefox-48.0.en-US.linux-x86_64.gtest.tests.zip'], 23:06:06 INFO - u'jittest': [u'firefox-48.0.en-US.linux-x86_64.common.tests.zip', 23:06:06 INFO - u'jsshell-linux-x86_64.zip'], 23:06:06 INFO - u'mochitest': [u'firefox-48.0.en-US.linux-x86_64.common.tests.zip', 23:06:06 INFO - u'firefox-48.0.en-US.linux-x86_64.mochitest.tests.zip'], 23:06:06 INFO - u'mozbase': [u'firefox-48.0.en-US.linux-x86_64.common.tests.zip'], 23:06:06 INFO - u'reftest': [u'firefox-48.0.en-US.linux-x86_64.common.tests.zip', 23:06:06 INFO - u'firefox-48.0.en-US.linux-x86_64.reftest.tests.zip'], 23:06:06 INFO - u'talos': [u'firefox-48.0.en-US.linux-x86_64.common.tests.zip', 23:06:06 INFO - u'firefox-48.0.en-US.linux-x86_64.talos.tests.zip'], 23:06:06 INFO - u'web-platform': [u'firefox-48.0.en-US.linux-x86_64.common.tests.zip', 23:06:06 INFO - u'firefox-48.0.en-US.linux-x86_64.web-platform.tests.zip'], 23:06:06 INFO - u'xpcshell': [u'firefox-48.0.en-US.linux-x86_64.common.tests.zip', 23:06:06 INFO - u'firefox-48.0.en-US.linux-x86_64.xpcshell.tests.zip']} 23:06:06 INFO - Downloading packages: [u'firefox-48.0.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 23:06:06 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')]} 23:06:06 INFO - https://queue.taskcluster.net/v1/task/Aava5bJ9QCOkDkcxZYB98w/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 23:06:06 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Aava5bJ9QCOkDkcxZYB98w/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.common.tests.zip 23:06:06 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Aava5bJ9QCOkDkcxZYB98w/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.common.tests.zip 23:06:06 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Aava5bJ9QCOkDkcxZYB98w/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-48.0.en-US.linux-x86_64.common.tests.zip 23:06:06 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Aava5bJ9QCOkDkcxZYB98w/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-48.0.en-US.linux-x86_64.common.tests.zip'}, attempt #1 23:06:08 INFO - Downloaded 24236612 bytes. 23:06:08 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-48.0.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 23:06:08 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-48.0.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 23:06:09 INFO - Return code: 0 23:06:09 INFO - Downloading packages: [u'firefox-48.0.en-US.linux-x86_64.common.tests.zip', u'firefox-48.0.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 23:06:09 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')]} 23:06:09 INFO - https://queue.taskcluster.net/v1/task/Aava5bJ9QCOkDkcxZYB98w/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 23:06:09 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Aava5bJ9QCOkDkcxZYB98w/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.common.tests.zip 23:06:09 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Aava5bJ9QCOkDkcxZYB98w/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.common.tests.zip 23:06:09 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Aava5bJ9QCOkDkcxZYB98w/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-48.0.en-US.linux-x86_64.common.tests.zip 23:06:09 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Aava5bJ9QCOkDkcxZYB98w/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-48.0.en-US.linux-x86_64.common.tests.zip'}, attempt #1 23:06:11 INFO - Downloaded 24236612 bytes. 23:06:11 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-48.0.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 23:06:11 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-48.0.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 23:06:12 INFO - Return code: 0 23:06:12 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')]} 23:06:12 INFO - https://queue.taskcluster.net/v1/task/Aava5bJ9QCOkDkcxZYB98w/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 23:06:12 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Aava5bJ9QCOkDkcxZYB98w/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.talos.tests.zip 23:06:12 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Aava5bJ9QCOkDkcxZYB98w/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.talos.tests.zip 23:06:12 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Aava5bJ9QCOkDkcxZYB98w/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test/build/firefox-48.0.en-US.linux-x86_64.talos.tests.zip 23:06:12 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Aava5bJ9QCOkDkcxZYB98w/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-48.0.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 23:06:14 INFO - Downloaded 10840145 bytes. 23:06:14 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-48.0.en-US.linux-x86_64.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 23:06:14 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-48.0.en-US.linux-x86_64.talos.tests.zip -d /builds/slave/test/build/tests 23:06:14 INFO - Return code: 0 23:06:14 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')]} 23:06:14 INFO - https://queue.taskcluster.net/v1/task/Aava5bJ9QCOkDkcxZYB98w/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 23:06:14 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Aava5bJ9QCOkDkcxZYB98w/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.tar.bz2 23:06:14 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Aava5bJ9QCOkDkcxZYB98w/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.tar.bz2 23:06:14 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Aava5bJ9QCOkDkcxZYB98w/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-48.0.en-US.linux-x86_64.tar.bz2 23:06:14 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Aava5bJ9QCOkDkcxZYB98w/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-48.0.en-US.linux-x86_64.tar.bz2'}, attempt #1 23:06:15 INFO - Downloaded 56023399 bytes. 23:06:15 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/Aava5bJ9QCOkDkcxZYB98w/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.tar.bz2 23:06:15 INFO - mkdir: /builds/slave/test/properties 23:06:15 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 23:06:15 INFO - Writing to file /builds/slave/test/properties/build_url 23:06:15 INFO - Contents: 23:06:15 INFO - build_url:https://queue.taskcluster.net/v1/task/Aava5bJ9QCOkDkcxZYB98w/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.tar.bz2 23:06:16 INFO - Running post-action listener: _resource_record_post_action 23:06:16 INFO - Running post-action listener: set_extra_try_arguments 23:06:16 INFO - ##### 23:06:16 INFO - ##### Running populate-webroot step. 23:06:16 INFO - ##### 23:06:16 INFO - Running pre-action listener: _resource_record_pre_action 23:06:16 INFO - Running main action method: populate_webroot 23:06:16 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 23:06:16 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 23:06:16 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 23:06:16 INFO - '--tppagecycles', 23:06:16 INFO - '7'], 23:06:16 INFO - 'tests': ['tsvgm']}}, 23:06:16 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 23:06:16 INFO - 'tests': ['tresize', 'tcanvasmark']}, 23:06:16 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 23:06:16 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 23:06:16 INFO - 'tests': ['dromaeo_css', 'kraken']}, 23:06:16 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 23:06:16 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 23:06:16 INFO - 'talos_options': ['--disable-e10s'], 23:06:16 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 23:06:16 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 23:06:16 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 23:06:16 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 23:06:16 INFO - 'talos_options': ['--disable-e10s'], 23:06:16 INFO - 'tests': ['damp', 'tps']}, 23:06:16 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 23:06:16 INFO - 'tests': ['damp', 'tps']}, 23:06:16 INFO - 'g3': {'talos_options': ['--disable-e10s'], 23:06:16 INFO - 'tests': ['dromaeo_dom']}, 23:06:16 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 23:06:16 INFO - 'other': {'talos_options': ['--disable-e10s'], 23:06:16 INFO - 'tests': ['a11yr', 23:06:16 INFO - 'ts_paint', 23:06:16 INFO - 'tpaint', 23:06:16 INFO - 'sessionrestore', 23:06:16 INFO - 'sessionrestore_no_auto_restore', 23:06:16 INFO - 'tabpaint']}, 23:06:16 INFO - 'other-e10s': {'tests': ['a11yr', 23:06:16 INFO - 'ts_paint', 23:06:16 INFO - 'tpaint', 23:06:16 INFO - 'sessionrestore', 23:06:16 INFO - 'sessionrestore_no_auto_restore', 23:06:16 INFO - 'tabpaint']}, 23:06:16 INFO - 'other-e10s_l64': {'tests': ['a11yr', 23:06:16 INFO - 'ts_paint', 23:06:16 INFO - 'tpaint', 23:06:16 INFO - 'sessionrestore', 23:06:16 INFO - 'sessionrestore_no_auto_restore', 23:06:16 INFO - 'tabpaint']}, 23:06:16 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 23:06:16 INFO - 'ts_paint', 23:06:16 INFO - 'tpaint', 23:06:16 INFO - 'sessionrestore', 23:06:16 INFO - 'sessionrestore_no_auto_restore', 23:06:16 INFO - 'tabpaint']}, 23:06:16 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 23:06:16 INFO - 'tests': ['a11yr', 23:06:16 INFO - 'ts_paint', 23:06:16 INFO - 'tpaint', 23:06:16 INFO - 'sessionrestore', 23:06:16 INFO - 'sessionrestore_no_auto_restore', 23:06:16 INFO - 'tabpaint']}, 23:06:16 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 23:06:16 INFO - 'tests': ['a11yr', 23:06:16 INFO - 'ts_paint', 23:06:16 INFO - 'tpaint', 23:06:16 INFO - 'sessionrestore', 23:06:16 INFO - 'sessionrestore_no_auto_restore', 23:06:16 INFO - 'tabpaint']}, 23:06:16 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 23:06:16 INFO - 'tests': ['tsvgx', 23:06:16 INFO - 'tsvgr_opacity', 23:06:16 INFO - 'tart', 23:06:16 INFO - 'tscrollx', 23:06:16 INFO - 'cart']}, 23:06:16 INFO - 'svgr-e10s': {'tests': ['tsvgx', 23:06:16 INFO - 'tsvgr_opacity', 23:06:16 INFO - 'tart', 23:06:16 INFO - 'tscrollx', 23:06:16 INFO - 'cart']}, 23:06:16 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 23:06:16 INFO - 'talos_options': ['--disable-e10s'], 23:06:16 INFO - 'tests': ['tp5o']}, 23:06:16 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 23:06:16 INFO - 'tests': ['tp5o']}, 23:06:16 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 23:06:16 INFO - 'talos_options': ['--disable-e10s', 23:06:16 INFO - '--xperf_path', 23:06:16 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 23:06:16 INFO - 'tests': ['tp5n']}, 23:06:16 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 23:06:16 INFO - 'talos_options': ['--xperf_path', 23:06:16 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 23:06:16 INFO - 'tests': ['tp5n']}}, 23:06:16 INFO - 'talos.zip': {'path': '', 23:06:16 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 23:06:16 INFO - Running post-action listener: _resource_record_post_action 23:06:16 INFO - ##### 23:06:16 INFO - ##### Running create-virtualenv step. 23:06:16 INFO - ##### 23:06:16 INFO - Running pre-action listener: _resource_record_pre_action 23:06:16 INFO - Running main action method: create_virtualenv 23:06:16 INFO - Creating virtualenv /builds/slave/test/build/venv 23:06:16 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 23:06:16 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 23:06:16 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 23:06:16 INFO - Using real prefix '/usr' 23:06:16 INFO - New python executable in /builds/slave/test/build/venv/bin/python 23:06:16 INFO - Installing distribute.............................................................................................................................................................................................done. 23:06:18 INFO - Installing pip.................done. 23:06:18 INFO - Return code: 0 23:06:18 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 23:06: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')]} 23:06:18 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 23:06:18 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:06: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')]} 23:06:18 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 23:06:18 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:06:18 INFO - retry: Calling run_command with args: [['/builds/slave/test/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 0x7f3d4175bf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe3d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xf085a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf97410>, '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 0xf98310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xf987a0>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '923d835db2ba3686ebe126b700000192-1467524797.359105-1414661519', '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', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/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 23:06:18 INFO - Running command: ['/builds/slave/test/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/build 23:06:18 INFO - Copy/paste: /builds/slave/test/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 23:06:18 INFO - Using env: {'DISPLAY': ':0', 23:06:18 INFO - 'HOME': '/home/cltbld', 23:06:18 INFO - 'LANG': 'en_US.UTF-8', 23:06:18 INFO - 'LANGUAGE': 'en_US:en', 23:06:18 INFO - 'LOGNAME': 'cltbld', 23:06:18 INFO - 'MAIL': '/var/mail/cltbld', 23:06:18 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:06:18 INFO - 'MOZ_NO_REMOTE': '1', 23:06:18 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 23:06:18 INFO - 'NO_EM_RESTART': '1', 23:06:18 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 23:06:18 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 23:06:18 INFO - 'PWD': '/builds/slave/test', 23:06:18 INFO - 'SHELL': '/bin/bash', 23:06:18 INFO - 'SHLVL': '1', 23:06:18 INFO - 'TERM': 'linux', 23:06:18 INFO - 'TMOUT': '86400', 23:06:18 INFO - 'USER': 'cltbld', 23:06:18 INFO - 'XDG_SESSION_COOKIE': '923d835db2ba3686ebe126b700000192-1467524797.359105-1414661519', 23:06:18 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:06:18 INFO - '_': '/tools/buildbot/bin/python'} 23:06:19 INFO - Ignoring indexes: https://pypi.python.org/simple/ 23:06:19 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 23:06:19 INFO - Cleaning up... 23:06:19 INFO - Return code: 0 23:06:19 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 23:06:19 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')]} 23:06:19 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 23:06:19 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:06:19 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')]} 23:06:19 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 23:06:19 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:06:19 INFO - retry: Calling run_command with args: [['/builds/slave/test/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 0x7f3d4175bf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe3d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xf085a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf97410>, '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 0xf98310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xf987a0>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '923d835db2ba3686ebe126b700000192-1467524797.359105-1414661519', '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', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/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 23:06:19 INFO - Running command: ['/builds/slave/test/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/build 23:06:19 INFO - Copy/paste: /builds/slave/test/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 23:06:19 INFO - Using env: {'DISPLAY': ':0', 23:06:19 INFO - 'HOME': '/home/cltbld', 23:06:19 INFO - 'LANG': 'en_US.UTF-8', 23:06:19 INFO - 'LANGUAGE': 'en_US:en', 23:06:19 INFO - 'LOGNAME': 'cltbld', 23:06:19 INFO - 'MAIL': '/var/mail/cltbld', 23:06:19 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:06:19 INFO - 'MOZ_NO_REMOTE': '1', 23:06:19 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 23:06:19 INFO - 'NO_EM_RESTART': '1', 23:06:19 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 23:06:19 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 23:06:19 INFO - 'PWD': '/builds/slave/test', 23:06:19 INFO - 'SHELL': '/bin/bash', 23:06:19 INFO - 'SHLVL': '1', 23:06:19 INFO - 'TERM': 'linux', 23:06:19 INFO - 'TMOUT': '86400', 23:06:19 INFO - 'USER': 'cltbld', 23:06:19 INFO - 'XDG_SESSION_COOKIE': '923d835db2ba3686ebe126b700000192-1467524797.359105-1414661519', 23:06:19 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:06:19 INFO - '_': '/tools/buildbot/bin/python'} 23:06:19 INFO - Ignoring indexes: https://pypi.python.org/simple/ 23:06:19 INFO - Downloading/unpacking psutil>=0.7.1 23:06:19 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 23:06:19 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 23:06:19 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 23:06:19 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 23:06:19 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 23:06:19 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 23:06:21 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 23:06:21 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 23:06:21 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 23:06:21 INFO - Installing collected packages: psutil 23:06:21 INFO - Running setup.py install for psutil 23:06:21 INFO - building 'psutil._psutil_linux' extension 23:06:21 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 23:06:21 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 23:06:21 INFO - building 'psutil._psutil_posix' extension 23:06:21 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 23:06:21 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 23:06:21 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 23:06:21 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 23:06:21 INFO - Successfully installed psutil 23:06:21 INFO - Cleaning up... 23:06:21 INFO - Return code: 0 23:06:21 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 23:06:21 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')]} 23:06:21 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 23:06:21 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:06:21 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')]} 23:06:21 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 23:06:21 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:06:21 INFO - retry: Calling run_command with args: [['/builds/slave/test/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 0x7f3d4175bf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe3d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xf085a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf97410>, '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 0xf98310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xf987a0>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '923d835db2ba3686ebe126b700000192-1467524797.359105-1414661519', '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', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/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 23:06:21 INFO - Running command: ['/builds/slave/test/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/build 23:06:21 INFO - Copy/paste: /builds/slave/test/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 23:06:21 INFO - Using env: {'DISPLAY': ':0', 23:06:21 INFO - 'HOME': '/home/cltbld', 23:06:21 INFO - 'LANG': 'en_US.UTF-8', 23:06:21 INFO - 'LANGUAGE': 'en_US:en', 23:06:21 INFO - 'LOGNAME': 'cltbld', 23:06:21 INFO - 'MAIL': '/var/mail/cltbld', 23:06:21 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:06:21 INFO - 'MOZ_NO_REMOTE': '1', 23:06:21 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 23:06:21 INFO - 'NO_EM_RESTART': '1', 23:06:21 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 23:06:21 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 23:06:21 INFO - 'PWD': '/builds/slave/test', 23:06:21 INFO - 'SHELL': '/bin/bash', 23:06:21 INFO - 'SHLVL': '1', 23:06:21 INFO - 'TERM': 'linux', 23:06:21 INFO - 'TMOUT': '86400', 23:06:21 INFO - 'USER': 'cltbld', 23:06:21 INFO - 'XDG_SESSION_COOKIE': '923d835db2ba3686ebe126b700000192-1467524797.359105-1414661519', 23:06:21 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:06:21 INFO - '_': '/tools/buildbot/bin/python'} 23:06:22 INFO - Ignoring indexes: https://pypi.python.org/simple/ 23:06:22 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 23:06:22 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 23:06:22 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 23:06:22 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 23:06:22 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 23:06:22 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 23:06:22 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 23:06:23 INFO - Downloading mozsystemmonitor-0.0.tar.gz 23:06:23 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 23:06:24 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 23:06:24 INFO - Installing collected packages: mozsystemmonitor 23:06:24 INFO - Running setup.py install for mozsystemmonitor 23:06:24 INFO - Successfully installed mozsystemmonitor 23:06:24 INFO - Cleaning up... 23:06:24 INFO - Return code: 0 23:06:24 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 23:06:24 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')]} 23:06:24 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 23:06:24 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:06:24 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')]} 23:06:24 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 23:06:24 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:06:24 INFO - retry: Calling run_command with args: [['/builds/slave/test/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 0x7f3d4175bf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe3d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xf085a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf97410>, '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 0xf98310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xf987a0>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '923d835db2ba3686ebe126b700000192-1467524797.359105-1414661519', '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', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/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 23:06:24 INFO - Running command: ['/builds/slave/test/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/build 23:06:24 INFO - Copy/paste: /builds/slave/test/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 23:06:24 INFO - Using env: {'DISPLAY': ':0', 23:06:24 INFO - 'HOME': '/home/cltbld', 23:06:24 INFO - 'LANG': 'en_US.UTF-8', 23:06:24 INFO - 'LANGUAGE': 'en_US:en', 23:06:24 INFO - 'LOGNAME': 'cltbld', 23:06:24 INFO - 'MAIL': '/var/mail/cltbld', 23:06:24 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:06:24 INFO - 'MOZ_NO_REMOTE': '1', 23:06:24 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 23:06:24 INFO - 'NO_EM_RESTART': '1', 23:06:24 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 23:06:24 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 23:06:24 INFO - 'PWD': '/builds/slave/test', 23:06:24 INFO - 'SHELL': '/bin/bash', 23:06:24 INFO - 'SHLVL': '1', 23:06:24 INFO - 'TERM': 'linux', 23:06:24 INFO - 'TMOUT': '86400', 23:06:24 INFO - 'USER': 'cltbld', 23:06:24 INFO - 'XDG_SESSION_COOKIE': '923d835db2ba3686ebe126b700000192-1467524797.359105-1414661519', 23:06:24 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:06:24 INFO - '_': '/tools/buildbot/bin/python'} 23:06:24 INFO - Ignoring indexes: https://pypi.python.org/simple/ 23:06:24 INFO - Downloading/unpacking blobuploader==1.2.4 23:06:24 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 23:06:24 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 23:06:24 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 23:06:24 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 23:06:24 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 23:06:24 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 23:06:26 INFO - Downloading blobuploader-1.2.4.tar.gz 23:06:26 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 23:06:26 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 23:06:26 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 23:06:26 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 23:06:26 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 23:06:26 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 23:06:26 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 23:06:26 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 23:06:26 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 23:06:26 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 23:06:26 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 23:06:26 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 23:06:26 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 23:06:26 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 23:06:26 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 23:06:26 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 23:06:26 INFO - Downloading docopt-0.6.1.tar.gz 23:06:27 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 23:06:27 INFO - Installing collected packages: blobuploader, requests, docopt 23:06:27 INFO - Running setup.py install for blobuploader 23:06:27 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 23:06:27 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 23:06:27 INFO - Running setup.py install for requests 23:06:27 INFO - Running setup.py install for docopt 23:06:27 INFO - Successfully installed blobuploader requests docopt 23:06:27 INFO - Cleaning up... 23:06:27 INFO - Return code: 0 23:06:27 INFO - Installing None into virtualenv /builds/slave/test/build/venv 23:06:27 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')]} 23:06:27 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 23:06:27 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:06:27 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')]} 23:06:27 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 23:06:27 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:06:27 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/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 0x7f3d4175bf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe3d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xf085a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf97410>, '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 0xf98310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xf987a0>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build/tests/config', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '923d835db2ba3686ebe126b700000192-1467524797.359105-1414661519', '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', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/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 23:06:27 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/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/build/tests/config 23:06:27 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test/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 23:06:27 INFO - Using env: {'DISPLAY': ':0', 23:06:27 INFO - 'HOME': '/home/cltbld', 23:06:27 INFO - 'LANG': 'en_US.UTF-8', 23:06:27 INFO - 'LANGUAGE': 'en_US:en', 23:06:27 INFO - 'LOGNAME': 'cltbld', 23:06:27 INFO - 'MAIL': '/var/mail/cltbld', 23:06:27 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:06:27 INFO - 'MOZ_NO_REMOTE': '1', 23:06:27 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 23:06:27 INFO - 'NO_EM_RESTART': '1', 23:06:27 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 23:06:27 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 23:06:27 INFO - 'PWD': '/builds/slave/test', 23:06:27 INFO - 'SHELL': '/bin/bash', 23:06:27 INFO - 'SHLVL': '1', 23:06:27 INFO - 'TERM': 'linux', 23:06:27 INFO - 'TMOUT': '86400', 23:06:27 INFO - 'USER': 'cltbld', 23:06:27 INFO - 'XDG_SESSION_COOKIE': '923d835db2ba3686ebe126b700000192-1467524797.359105-1414661519', 23:06:27 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:06:27 INFO - '_': '/tools/buildbot/bin/python'} 23:06:27 INFO - Ignoring indexes: https://pypi.python.org/simple/ 23:06:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 23:06:27 INFO - Running setup.py (path:/tmp/pip-t1U9UT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 23:06:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 23:06:27 INFO - Running setup.py (path:/tmp/pip-eZ7D2L-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 23:06:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 23:06:28 INFO - Running setup.py (path:/tmp/pip-BAeJ3m-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 23:06:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 23:06:28 INFO - Running setup.py (path:/tmp/pip-ilL_MN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 23:06:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 23:06:28 INFO - Running setup.py (path:/tmp/pip-1Vz1gC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 23:06:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 23:06:28 INFO - Running setup.py (path:/tmp/pip-ztFlcD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 23:06:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 23:06:28 INFO - Running setup.py (path:/tmp/pip-Fb2kwC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 23:06:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 23:06:28 INFO - Running setup.py (path:/tmp/pip-m8Rftm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 23:06:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 23:06:28 INFO - Running setup.py (path:/tmp/pip-tYn9Ag-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 23:06:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 23:06:28 INFO - Running setup.py (path:/tmp/pip-K03qK8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 23:06:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 23:06:28 INFO - Running setup.py (path:/tmp/pip-tpjQAu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 23:06:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 23:06:28 INFO - Running setup.py (path:/tmp/pip-B0rq6w-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 23:06:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 23:06:28 INFO - Running setup.py (path:/tmp/pip-AxpfXM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 23:06:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 23:06:28 INFO - Running setup.py (path:/tmp/pip-UIN1h6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 23:06:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 23:06:28 INFO - Running setup.py (path:/tmp/pip-4S8s9R-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 23:06:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 23:06:28 INFO - Running setup.py (path:/tmp/pip-88wRti-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 23:06:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 23:06:29 INFO - Running setup.py (path:/tmp/pip-KUulgy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 23:06:29 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 23:06:29 INFO - Running setup.py install for manifestparser 23:06:29 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 23:06:29 INFO - Running setup.py install for mozcrash 23:06:29 INFO - Running setup.py install for mozdebug 23:06:29 INFO - Running setup.py install for mozdevice 23:06:29 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 23:06:29 INFO - Installing dm script to /builds/slave/test/build/venv/bin 23:06:29 INFO - Running setup.py install for mozfile 23:06:29 INFO - Running setup.py install for mozhttpd 23:06:29 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 23:06:29 INFO - Running setup.py install for mozinfo 23:06:29 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 23:06:29 INFO - Running setup.py install for mozInstall 23:06:29 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 23:06:29 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 23:06:29 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 23:06:29 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 23:06:29 INFO - Running setup.py install for mozleak 23:06:30 INFO - Running setup.py install for mozlog 23:06:30 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 23:06:30 INFO - Running setup.py install for moznetwork 23:06:30 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 23:06:30 INFO - Running setup.py install for mozprocess 23:06:30 INFO - Running setup.py install for mozprofile 23:06:30 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 23:06:30 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 23:06:30 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 23:06:30 INFO - Running setup.py install for mozrunner 23:06:30 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 23:06:30 INFO - Running setup.py install for mozscreenshot 23:06:30 INFO - Running setup.py install for moztest 23:06:30 INFO - Running setup.py install for mozversion 23:06:30 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 23:06:30 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 23:06:30 INFO - Cleaning up... 23:06:30 INFO - Return code: 0 23:06:30 INFO - Installing None into virtualenv /builds/slave/test/build/venv 23:06: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')]} 23:06:30 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 23:06:30 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:06: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')]} 23:06:30 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 23:06:30 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:06:30 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/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 0x7f3d4175bf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe3d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xf085a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf97410>, '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 0xf98310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xf987a0>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build/tests/config', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '923d835db2ba3686ebe126b700000192-1467524797.359105-1414661519', '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', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/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 23:06:30 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/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/build/tests/config 23:06:30 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/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 23:06:30 INFO - Using env: {'DISPLAY': ':0', 23:06:30 INFO - 'HOME': '/home/cltbld', 23:06:30 INFO - 'LANG': 'en_US.UTF-8', 23:06:30 INFO - 'LANGUAGE': 'en_US:en', 23:06:30 INFO - 'LOGNAME': 'cltbld', 23:06:30 INFO - 'MAIL': '/var/mail/cltbld', 23:06:30 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:06:30 INFO - 'MOZ_NO_REMOTE': '1', 23:06:30 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 23:06:30 INFO - 'NO_EM_RESTART': '1', 23:06:30 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 23:06:30 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 23:06:30 INFO - 'PWD': '/builds/slave/test', 23:06:30 INFO - 'SHELL': '/bin/bash', 23:06:30 INFO - 'SHLVL': '1', 23:06:30 INFO - 'TERM': 'linux', 23:06:30 INFO - 'TMOUT': '86400', 23:06:30 INFO - 'USER': 'cltbld', 23:06:30 INFO - 'XDG_SESSION_COOKIE': '923d835db2ba3686ebe126b700000192-1467524797.359105-1414661519', 23:06:30 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:06:30 INFO - '_': '/tools/buildbot/bin/python'} 23:06:31 INFO - Ignoring indexes: https://pypi.python.org/simple/ 23:06:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 23:06:31 INFO - Running setup.py (path:/tmp/pip-ZckGgZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 23:06:31 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 23:06:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 23:06:31 INFO - Running setup.py (path:/tmp/pip-jq0Myd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 23:06:31 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.17 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 23:06:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 23:06:31 INFO - Running setup.py (path:/tmp/pip-Ag3TQN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 23:06:31 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 23:06:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 23:06:31 INFO - Running setup.py (path:/tmp/pip-LAcVzw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 23:06:31 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.48 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 23:06:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 23:06:31 INFO - Running setup.py (path:/tmp/pip-sZa4Kz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 23:06:31 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 23:06:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 23:06:31 INFO - Running setup.py (path:/tmp/pip-jd0iwa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 23:06:31 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 23:06:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 23:06:31 INFO - Running setup.py (path:/tmp/pip-XrZDmH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 23:06:31 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 23:06:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 23:06:31 INFO - Running setup.py (path:/tmp/pip-fZUe_V-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 23:06:31 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 23:06:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 23:06:31 INFO - Running setup.py (path:/tmp/pip-A4iZg4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 23:06:31 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 23:06:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 23:06:31 INFO - Running setup.py (path:/tmp/pip-_B5Ncc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 23:06:31 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.1 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 23:06:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 23:06:31 INFO - Running setup.py (path:/tmp/pip-icUnPY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 23:06:31 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 23:06:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 23:06:31 INFO - Running setup.py (path:/tmp/pip-laaQSi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 23:06:31 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.22 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 23:06:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 23:06:32 INFO - Running setup.py (path:/tmp/pip-oWJZH8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 23:06:32 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 23:06:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 23:06:32 INFO - Running setup.py (path:/tmp/pip-GRY1dU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 23:06:32 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.11 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 23:06:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 23:06:32 INFO - Running setup.py (path:/tmp/pip-wxc4Qv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 23:06:32 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 23:06:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 23:06:32 INFO - Running setup.py (path:/tmp/pip-Ma9QsG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 23:06:32 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 23:06:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 23:06:32 INFO - Running setup.py (path:/tmp/pip-9Dg6S4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 23:06:32 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 23:06:32 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 23:06:32 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 23:06:32 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 23:06:32 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 23:06:32 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 23:06:32 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 23:06:32 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 23:06:32 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 23:06:32 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 23:06:32 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 23:06:32 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 23:06:32 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 23:06:34 INFO - Downloading blessings-1.6.tar.gz 23:06:34 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 23:06:34 INFO - Installing collected packages: blessings 23:06:34 INFO - Running setup.py install for blessings 23:06:34 INFO - Successfully installed blessings 23:06:34 INFO - Cleaning up... 23:06:34 INFO - Return code: 0 23:06:34 INFO - Done creating virtualenv /builds/slave/test/build/venv. 23:06:34 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 23:06:34 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 23:06:34 INFO - Reading from file tmpfile_stdout 23:06:34 INFO - Current package versions: 23:06:34 INFO - argparse == 1.2.1 23:06:34 INFO - blessings == 1.6 23:06:34 INFO - blobuploader == 1.2.4 23:06:34 INFO - docopt == 0.6.1 23:06:34 INFO - manifestparser == 1.1 23:06:34 INFO - mozInstall == 1.12 23:06:34 INFO - mozcrash == 0.17 23:06:34 INFO - mozdebug == 0.1 23:06:34 INFO - mozdevice == 0.48 23:06:34 INFO - mozfile == 1.2 23:06:34 INFO - mozhttpd == 0.7 23:06:34 INFO - mozinfo == 0.9 23:06:34 INFO - mozleak == 0.1 23:06:34 INFO - mozlog == 3.1 23:06:34 INFO - moznetwork == 0.27 23:06:34 INFO - mozprocess == 0.22 23:06:34 INFO - mozprofile == 0.28 23:06:34 INFO - mozrunner == 6.11 23:06:34 INFO - mozscreenshot == 0.1 23:06:34 INFO - mozsystemmonitor == 0.0 23:06:34 INFO - moztest == 0.7 23:06:34 INFO - mozversion == 1.4 23:06:34 INFO - psutil == 3.1.1 23:06:34 INFO - requests == 1.2.3 23:06:34 INFO - wsgiref == 0.1.2 23:06:34 INFO - Installing None into virtualenv /builds/slave/test/build/venv 23:06:34 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')]} 23:06:34 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 23:06:34 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:06:34 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')]} 23:06:34 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 23:06:34 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:06:34 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/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 0x7f3d4175bf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe3d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xf085a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf97410>, '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 0xf98310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xf987a0>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build/tests/talos', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '923d835db2ba3686ebe126b700000192-1467524797.359105-1414661519', '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', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/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 23:06:34 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/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/build/tests/talos 23:06:34 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/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 23:06:34 INFO - Using env: {'DISPLAY': ':0', 23:06:34 INFO - 'HOME': '/home/cltbld', 23:06:34 INFO - 'LANG': 'en_US.UTF-8', 23:06:34 INFO - 'LANGUAGE': 'en_US:en', 23:06:34 INFO - 'LOGNAME': 'cltbld', 23:06:34 INFO - 'MAIL': '/var/mail/cltbld', 23:06:34 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:06:34 INFO - 'MOZ_NO_REMOTE': '1', 23:06:34 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 23:06:34 INFO - 'NO_EM_RESTART': '1', 23:06:34 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 23:06:34 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 23:06:34 INFO - 'PWD': '/builds/slave/test', 23:06:34 INFO - 'SHELL': '/bin/bash', 23:06:34 INFO - 'SHLVL': '1', 23:06:34 INFO - 'TERM': 'linux', 23:06:34 INFO - 'TMOUT': '86400', 23:06:34 INFO - 'USER': 'cltbld', 23:06:34 INFO - 'XDG_SESSION_COOKIE': '923d835db2ba3686ebe126b700000192-1467524797.359105-1414661519', 23:06:34 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:06:34 INFO - '_': '/tools/buildbot/bin/python'} 23:06:34 INFO - Ignoring indexes: https://pypi.python.org/simple/ 23:06:34 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 23:06:34 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 23:06:34 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 23:06:34 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 23:06:34 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 23:06:34 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 23:06:34 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 23:06:34 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 23:06:34 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 9)) 23:06:34 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 23:06:34 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 23:06:34 INFO - Cleaning up... 23:06:34 INFO - Return code: 0 23:06:34 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 23:06:34 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')]} 23:06:34 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 23:06:34 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:06:34 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')]} 23:06:34 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 23:06:34 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:06:34 INFO - retry: Calling run_command with args: [['/builds/slave/test/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 0x7f3d4175bf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe3d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xf085a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf97410>, '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 0xf98310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xf987a0>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '923d835db2ba3686ebe126b700000192-1467524797.359105-1414661519', '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', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/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 23:06:34 INFO - Running command: ['/builds/slave/test/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/build 23:06:34 INFO - Copy/paste: /builds/slave/test/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 23:06:34 INFO - Using env: {'DISPLAY': ':0', 23:06:34 INFO - 'HOME': '/home/cltbld', 23:06:34 INFO - 'LANG': 'en_US.UTF-8', 23:06:34 INFO - 'LANGUAGE': 'en_US:en', 23:06:34 INFO - 'LOGNAME': 'cltbld', 23:06:34 INFO - 'MAIL': '/var/mail/cltbld', 23:06:34 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:06:34 INFO - 'MOZ_NO_REMOTE': '1', 23:06:34 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 23:06:34 INFO - 'NO_EM_RESTART': '1', 23:06:34 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 23:06:34 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 23:06:34 INFO - 'PWD': '/builds/slave/test', 23:06:34 INFO - 'SHELL': '/bin/bash', 23:06:34 INFO - 'SHLVL': '1', 23:06:34 INFO - 'TERM': 'linux', 23:06:34 INFO - 'TMOUT': '86400', 23:06:34 INFO - 'USER': 'cltbld', 23:06:34 INFO - 'XDG_SESSION_COOKIE': '923d835db2ba3686ebe126b700000192-1467524797.359105-1414661519', 23:06:34 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:06:34 INFO - '_': '/tools/buildbot/bin/python'} 23:06:35 INFO - Ignoring indexes: https://pypi.python.org/simple/ 23:06:35 INFO - Downloading/unpacking jsonschema 23:06:35 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 23:06:35 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 23:06:35 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 23:06:35 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 23:06:35 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 23:06:35 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 23:06:37 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 23:06:37 INFO - Downloading/unpacking functools32 (from jsonschema) 23:06:37 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 23:06:37 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 23:06:37 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 23:06:37 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 23:06:37 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 23:06:37 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 23:06:37 INFO - Downloading functools32-3.2.3-2.tar.gz 23:06:37 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 23:06:37 INFO - warning: no files found matching '*.txt' 23:06:37 INFO - no previously-included directories found matching 'build' 23:06:37 INFO - no previously-included directories found matching 'dist' 23:06:37 INFO - no previously-included directories found matching '.git*' 23:06:37 INFO - Installing collected packages: jsonschema, functools32 23:06:37 INFO - Running setup.py install for functools32 23:06:37 INFO - warning: no files found matching '*.txt' 23:06:37 INFO - no previously-included directories found matching 'build' 23:06:37 INFO - no previously-included directories found matching 'dist' 23:06:37 INFO - no previously-included directories found matching '.git*' 23:06:37 INFO - Successfully installed jsonschema functools32 23:06:37 INFO - Cleaning up... 23:06:37 INFO - Return code: 0 23:06:37 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 23:06:37 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')]} 23:06:37 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 23:06:37 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:06:37 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')]} 23:06:37 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 23:06:37 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:06:37 INFO - retry: Calling run_command with args: [['/builds/slave/test/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 0x7f3d4175bf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe3d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xf085a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf97410>, '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 0xf98310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xf987a0>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '923d835db2ba3686ebe126b700000192-1467524797.359105-1414661519', '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', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/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 23:06:37 INFO - Running command: ['/builds/slave/test/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/build 23:06:37 INFO - Copy/paste: /builds/slave/test/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 23:06:37 INFO - Using env: {'DISPLAY': ':0', 23:06:37 INFO - 'HOME': '/home/cltbld', 23:06:37 INFO - 'LANG': 'en_US.UTF-8', 23:06:37 INFO - 'LANGUAGE': 'en_US:en', 23:06:37 INFO - 'LOGNAME': 'cltbld', 23:06:37 INFO - 'MAIL': '/var/mail/cltbld', 23:06:37 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:06:37 INFO - 'MOZ_NO_REMOTE': '1', 23:06:37 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 23:06:37 INFO - 'NO_EM_RESTART': '1', 23:06:37 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 23:06:37 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 23:06:37 INFO - 'PWD': '/builds/slave/test', 23:06:37 INFO - 'SHELL': '/bin/bash', 23:06:37 INFO - 'SHLVL': '1', 23:06:37 INFO - 'TERM': 'linux', 23:06:37 INFO - 'TMOUT': '86400', 23:06:37 INFO - 'USER': 'cltbld', 23:06:37 INFO - 'XDG_SESSION_COOKIE': '923d835db2ba3686ebe126b700000192-1467524797.359105-1414661519', 23:06:37 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:06:37 INFO - '_': '/tools/buildbot/bin/python'} 23:06:37 INFO - Ignoring indexes: https://pypi.python.org/simple/ 23:06:37 INFO - Downloading/unpacking flake8 23:06:37 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 23:06:37 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 23:06:37 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 23:06:37 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 23:06:37 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 23:06:37 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 23:06:39 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 23:06:39 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 23:06: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 23:06: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 23:06: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 23:06: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 23:06: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 23:06: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 23:06:39 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 23:06:39 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 23:06: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 23:06: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 23:06: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 23:06: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 23:06: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 23:06: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 23:06:40 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 23:06:40 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 23:06:40 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 23:06:40 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 23:06:40 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 23:06:40 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 23:06:40 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 23:06:40 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 23:06:40 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 23:06:40 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 23:06:40 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 23:06:40 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 23:06:40 INFO - no previously-included directories found matching 'docs/_build' 23:06:40 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 23:06:40 INFO - Running setup.py install for pep8 23:06:40 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 23:06:40 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 23:06:40 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 23:06:40 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 23:06:40 INFO - no previously-included directories found matching 'docs/_build' 23:06:40 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 23:06:40 INFO - Successfully installed flake8 mccabe pyflakes pep8 23:06:40 INFO - Cleaning up... 23:06:40 INFO - Return code: 0 23:06:40 INFO - Running post-action listener: _resource_record_post_action 23:06:40 INFO - Running post-action listener: _start_resource_monitoring 23:06:40 INFO - Starting resource monitoring. 23:06:40 INFO - ##### 23:06:40 INFO - ##### Running install step. 23:06:40 INFO - ##### 23:06:40 INFO - Running pre-action listener: _resource_record_pre_action 23:06:40 INFO - Running main action method: install 23:06:40 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 23:06:40 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 23:06:40 INFO - Reading from file tmpfile_stdout 23:06:40 INFO - Detecting whether we're running mozinstall >=1.0... 23:06:40 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 23:06:40 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 23:06:40 INFO - Reading from file tmpfile_stdout 23:06:40 INFO - Output received: 23:06:40 INFO - Usage: mozinstall [options] installer 23:06:40 INFO - Options: 23:06:40 INFO - -h, --help show this help message and exit 23:06:40 INFO - -d DEST, --destination=DEST 23:06:40 INFO - Directory to install application into. [default: 23:06:40 INFO - "/builds/slave/test"] 23:06:40 INFO - --app=APP Application being installed. [default: firefox] 23:06:40 INFO - mkdir: /builds/slave/test/build/application 23:06:40 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-48.0.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 23:06:40 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-48.0.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 23:06:54 INFO - Reading from file tmpfile_stdout 23:06:54 INFO - Output received: 23:06:54 INFO - /builds/slave/test/build/application/firefox/firefox 23:06:54 INFO - Running post-action listener: _resource_record_post_action 23:06:54 INFO - ##### 23:06:54 INFO - ##### Running run-tests step. 23:06:54 INFO - ##### 23:06:54 INFO - Running pre-action listener: _resource_record_pre_action 23:06:54 INFO - Running main action method: run_tests 23:06:54 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 23:06:54 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 23:06:54 INFO - Python 2.7.3 23:06:54 INFO - Return code: 0 23:06:54 INFO - grabbing minidump binary from tooltool 23:06: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')]} 23:06:54 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/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 0xf97410>, '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 0xf98310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xf987a0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 23:06:54 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 23:06:54 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest -o -c /builds/tooltool_cache 23:06:54 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 23:06:54 INFO - Return code: 0 23:06:54 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 23:06:54 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 23:06:54 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 23:06:54 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 23:06:54 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 23:06:54 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 23:06:54 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 23:06:55 INFO - Return code: 0 23:06:55 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Beta', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/Aava5bJ9QCOkDkcxZYB98w/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-007', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] in /builds/slave/test/build 23:06:55 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Mozilla-Beta --suite dromaeojs --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/Aava5bJ9QCOkDkcxZYB98w/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-007 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log 23:06:55 INFO - Using env: {'DISPLAY': ':0', 23:06:55 INFO - 'HOME': '/home/cltbld', 23:06:55 INFO - 'LANG': 'en_US.UTF-8', 23:06:55 INFO - 'LANGUAGE': 'en_US:en', 23:06:55 INFO - 'LOGNAME': 'cltbld', 23:06:55 INFO - 'MAIL': '/var/mail/cltbld', 23:06:55 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 23:06:55 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 23:06:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:06:55 INFO - 'MOZ_NO_REMOTE': '1', 23:06:55 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 23:06:55 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 23:06:55 INFO - 'NO_EM_RESTART': '1', 23:06:55 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 23:06:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 23:06:55 INFO - 'PWD': '/builds/slave/test', 23:06:55 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 23:06:55 INFO - 'SHELL': '/bin/bash', 23:06:55 INFO - 'SHLVL': '1', 23:06:55 INFO - 'TERM': 'linux', 23:06:55 INFO - 'TMOUT': '86400', 23:06:55 INFO - 'USER': 'cltbld', 23:06:55 INFO - 'XDG_SESSION_COOKIE': '923d835db2ba3686ebe126b700000192-1467524797.359105-1414661519', 23:06:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:06:55 INFO - '_': '/tools/buildbot/bin/python'} 23:06:55 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Beta', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/Aava5bJ9QCOkDkcxZYB98w/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-007', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] with output_timeout 3600 23:06:55 INFO - mozversion application_buildid: 20160701065031 23:06:55 INFO - mozversion application_changeset: 5e6976a28642d4d159071e14fd3251d76b9c46fa 23:06:55 INFO - mozversion application_display_name: Firefox 23:06:55 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 23:06:55 INFO - mozversion application_name: Firefox 23:06:55 INFO - mozversion application_remotingname: firefox 23:06:55 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-beta 23:06:55 INFO - mozversion application_vendor: Mozilla 23:06:55 INFO - mozversion application_version: 48.0 23:06:55 INFO - mozversion platform_buildid: 20160701065031 23:06:55 INFO - mozversion platform_changeset: 5e6976a28642d4d159071e14fd3251d76b9c46fa 23:06:55 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-beta 23:06:55 INFO - mozversion platform_version: 48.0 23:06:55 INFO - using testdate: 1467526015 23:06:55 INFO - actual date: 1467526015 23:06:55 INFO - starting webserver on 'localhost:48201' 23:06:55 INFO - SUITE-START | Running 2 tests 23:06:55 INFO - TEST-START | dromaeo_css 23:06:55 INFO - operating with platform_type : linux_ 23:06:55 INFO - Initialising browser for dromaeo_css test... 23:06:55 INFO - TEST-INFO | started process 25124 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpzdkiyZ/profile http://localhost:48201/getInfo.html) 23:06:58 INFO - PROCESS | 25124 | __metrics Screen width/height:1600/1200 23:06:58 INFO - PROCESS | 25124 | colorDepth:24 23:06:58 INFO - PROCESS | 25124 | Browser inner width/height: 1024/697 23:06:58 INFO - PROCESS | 25124 | __metrics 23:06:59 ERROR - PROCESS | 25124 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 23:07:00 INFO - TEST-INFO | 25124: exit 0 23:07:00 INFO - Browser initialized. 23:07:00 INFO - Running cycle 1/1 for dromaeo_css test... 23:07:00 INFO - TEST-INFO | started process 25215 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpzdkiyZ/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 23:07:12 INFO - PROCESS | 25215 | RSS: Main: 138850304 23:07:12 INFO - PROCESS | 25215 | 23:08:03 INFO - PROCESS | 25215 | 1467526083651 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] 23:10:10 INFO - PROCESS | 25215 | Cycle 1(1): loaded http://localhost:48201/tests/dromaeo/cssquery-dojo.html (next: http://localhost:48201/tests/dromaeo/cssquery-ext.html) 23:10:11 INFO - PROCESS | 25215 | RSS: Main: 249389056 23:10:11 INFO - PROCESS | 25215 | 23:13:13 INFO - PROCESS | 25215 | Cycle 1(1): loaded http://localhost:48201/tests/dromaeo/cssquery-ext.html (next: http://localhost:48201/tests/dromaeo/cssquery-jquery.html) 23:13:14 INFO - PROCESS | 25215 | RSS: Main: 225550336 23:13:14 INFO - PROCESS | 25215 | 23:16:16 INFO - PROCESS | 25215 | Cycle 1(1): loaded http://localhost:48201/tests/dromaeo/cssquery-jquery.html (next: http://localhost:48201/tests/dromaeo/cssquery-mootools.html) 23:16:16 INFO - PROCESS | 25215 | RSS: Main: 237195264 23:16:16 INFO - PROCESS | 25215 | 23:19:18 INFO - PROCESS | 25215 | Cycle 1(1): loaded http://localhost:48201/tests/dromaeo/cssquery-mootools.html (next: http://localhost:48201/tests/dromaeo/cssquery-prototype.html) 23:19:18 INFO - PROCESS | 25215 | RSS: Main: 227635200 23:19:18 INFO - PROCESS | 25215 | 23:22:21 INFO - PROCESS | 25215 | Cycle 1(1): loaded http://localhost:48201/tests/dromaeo/cssquery-prototype.html (next: http://localhost:48201/tests/dromaeo/cssquery-yui.html) 23:22:21 INFO - PROCESS | 25215 | RSS: Main: 181358592 23:22:21 INFO - PROCESS | 25215 | 23:25:24 INFO - PROCESS | 25215 | Cycle 1(1): loaded http://localhost:48201/tests/dromaeo/cssquery-yui.html (next: http://localhost:48201/tests/dromaeo/cssquery-dojo.html) 23:25:24 INFO - PROCESS | 25215 | RSS: Main: 260976640 23:25:24 INFO - PROCESS | 25215 | 23:25:24 INFO - PROCESS | 25215 | __start_tp_report 23:25:24 INFO - PROCESS | 25215 | _x_x_mozilla_page_load 23:25:24 INFO - PROCESS | 25215 | _x_x_mozilla_page_load_details 23:25:24 INFO - PROCESS | 25215 | |i|pagename|runs| 23:25:24 INFO - PROCESS | 25215 | |0;dojo.html;3313.403587354276;3359.4960755886614;3385.5768028996376;3393.3043726036135;3413.829308534574;5521.585881058922;5555.777768889239;5565.94247093052;5576.5817563682685;5585.776568937237;5506.311711036121;5531.0873705838485;5580.972095139518;5591.888162236763;5627.493525582697;4946.629002824785;5012.473690262515;5108.77010534525;5154.098032844256;5187.766550505236;4940.654154209206;4988.950110498903;4993.775280112385;5066.341375621164;5100.132977393852;5047.167217409142;5096.923546146811;5097.439281679012;5109.642325037249;5134.0758663440565;5036.471170527078;5047.823326183566;5097.3118628984985;5103.795848166087;5109.795608175668;4898.877528061791;4955.40535135786;5042.39491261051;5047.015831912779;5057.165567681328;5431;5451.672899626035;5462.481064298885;5462.808801691962;5473.480019398151;5792.768289268424;5893.322267939199;5913.172155898134;5913.408659134096;5917.20117784098;5829.446202610745;5888.499477544414;5944.583879128462;5953.613015154001;5959.344472108065;5578.41426650204;5581.776728930838;5582.218489411485;5585.74864131111;5619.943800562024;5881.088431293157;6045.304789949124;6082.7347434188305;6087.239095113111;6121.816345509553;5781.768729250867;5842.737076831553;5846.941530584725;5880.411958804171;5880.705964701748;5876.353601103875;5877.588568800228;5884.293884733774;5887.322957859816;5898.056310990307;5765.048766953406;5833.4749872511675;5838.562107841929;5844.9415505845245;5854.677992710442;5906.291245050621;5910.408959104056;5913.940860591339;5926.496247818984;5951;4503.977480112579;4540.409746732904;4545.2954792007295;4546.499885012646;4569.543045695404;3977.3636218204947;4005;4067.7559346439307;4068.349064149722;4107.137501124797;5664.6034777566;5688.146777983336;5693.544516438675;5696.857578560486;5705.22979397776;5960.523158147338;5961.821145365646;5973.044312909914;5974.85062873423;5977.760889564369;5564.443555644403;5663.575231857627;5697.601167918206;5743.770249190069;5759.769609215585;5088.1350170471105;5099.184130539096;5110.2590124431745;5114.156164232934;5128.8461346159675;6120.387961203844;6155.753769849156;6180.196574445294;6180.289266734293;6197.628142311476;5730;5823.796167134215;5825.242718446575;5848.2689663792025;5850.5904586678525;6167.907481387693;6193.071039343954;6195.473384762346;6199.039148931923;6199.659018754011;5667.5465962722055;5833.649981001154;5847.210626565529;5866.442687944638;5869.295684517885;5984.491318237999;6044.486218671462;6046.788362407295;6052.667103309184;6091.7258723358445;5763.769449221984;5786.247787787561;5802.65184088956;5812.7674893003805;5817.0983497557945;5609.523190528851;5794.275715535558;5796.362400135898;5796.855078623068;5807.390224026416;5775.451332123442;5781.739821707949;5789.131630255327;5793.478586927196;5830;5854.619449735754;5895.882082358243;5897.557683173865;5900;5904.970475147768;5621.606487545832;5719.2279042328755;5726.4273572642405;5764.711764411846;5801.883962320646 23:25:24 INFO - PROCESS | 25215 | |1;ext.html;600.4145957691252;651.3258777165631;652.4486808646693;653.2552889705739;671.8857794174992;32527.186820329505;40380.59619403805;40916.59083409165;41013.179736405255;41030.38454423186;43908;44501.77749111258;44522.10955780891;44574;44835.1032979341;8024.879626805603;8873.423227490193;9074.500902450363;9074.682386116487;10402.219833512518;10540.156787457023;10667.78664426711;10674.146068314554;10674.893251067468;10686.893131068706;10668.62659806907;10738.355698658066;10741.087007604325;10744.838827417596;10750.946245268762;10563.26057175998;10631.096356809641;10647.148228141808;10653.680389588324;10662.253642245047;10450.843237351446;10728.463576821128;10869.130469562417;10906.945465272624;10932.289401188897;44742;44884.55115448869;45165.548344516465;45186.77406612979;45212;3848.499695039627;3932.4494570760116;4043.1913617276664;4436.844710435152;4594.0122873582;32903.506447403306;33137.50293745596;33229.83385083059;33897.66102338969;34373;4560.452745670541;4576.977115114403;4578.610818080434;4582.1064892346;4846.442659094214;256861.71569142223;258850;259567;259922;261610;41834.581654183676;64832;65332;70944;70949.2905070953;41374;41640.1671966559;41664.791676042034;41673.166536669094;41718.79140604277;17293.13534323279;17589.824101759074;17593;17600.471985840446;17610;13821.308934553434;14578.927105364617;14955.177465239516;14970.70058598822;15032.473863414947;9588.76028099303;9598.520073996273;9631.951840240754;9669.323147379757;9687.70936871895;3738.5513738351574;3807.257584770943;3842.539834862734;3855.8072096395067;3871.709621778378;1093.2292733622776;1128.9266197697123;1140.948657310423;1150.0397168364343;1151.2229245259416;33722;33762.32475350529;33893.83053084719;34002.65997340044;34636.13409664728;1171.2679575265458;1178.3165763856941;1197.167968262067;1248;1323.483841301893;17470.213840377215;17502.096896593113;17560.29758809659;17563.560910977074;17911.462656120337;510219;513766;516096;517645;517969;63678;63937;64273.35726642767;64328.678356608856;64389;1457.5117335692662;1473.462186301992;1490.180400779567;1542.7608720648318;1565.1157096240588;30648.846755766972;31219;33453.66546334603;34581.48127778035;34603.4809477853;49275.26087108768;49683.254751178036;49720.751396242784;49828.75085624549;49885;304130;305894;306747;307269;307819;28348.85825570859;32280.838595806872;32735.83632081824;32768;32829.70192086627;49040.26439603337;51744.741276293375;51861;52111;52465;42386;42641.57358426376;42800.57199427966;42927;43541.12917741691;40671.38992915049;41535.169296614506;41959;41996.79001604972;42960;43414.34878476762;45570.31644525268;45951.3107303384;46706.76646616745;46930.76534617305;34593.65406345904;36053.27893442169;37721.62278377181;37869;39515;28965.275868103465;29256;29367.265818354714;29422.264443389085;29529.557056643738 23:25:24 INFO - PROCESS | 25215 | |2;jquery.html;432.7035980353458;438.327167797431;439.91201759648067;442.42496711706326;453.7844523851171;18383.81616183838;18462.815371846278;19378.321758738446;19442.805571944275;19508.609827803437;18260.817391826113;18564.814351856512;19118.90440547795;19241.711374329396;19282.807171928278;5820.767169313222;5877.794277200299;5979;5984.132300816379;6129.080637904328;5893;5905.645661260317;5940.554458415636;5954.434328738763;5973.940260597404;5916.497097746696;5927.2887253529425;5972.9701351493395;6250;6260.718267677943;6098.939010609926;6203.596766210182;6213.689315534228;6246.781362652308;6545.639989800559;5903.704814759288;5931.228940237785;5941.287045554518;5966.880662386728;5968.7612495500125;13724.382402791898;14481.855181448156;14492.855071449256;14509.492167774077;23519.294421167393;2419.0565679385054;2635.5387807133866;2671.3455203475078;2856.8000239983207;3175.237942893712;10240.641577544824;10337.121344685711;10568.207384446121;13100.344982750825;13322.134061286082;2034.5930813837144;2051.364077136078;2063.164418410546;2071.18188315616;2122.182959560565;76921.23078769197;81644.18355816425;81872;82931;83138;11041.116710663127;11184.608538701106;11539.826902596467;11574.363410012531;11695.649130526097;15777.921110394374;15809.683806323808;16019.439319623758;16023.839761602234;16029.519114426352;8891.422057566237;8973;9015.639374424949;9103.089691030844;9169.495677737788;9022.639094436281;9034.36759426847;9112.681056163003;9141.817163656822;9260.583273752698;4877.487863774323;4894.1679914414635;4910.90178196434;5017.57350625201;5070.087384270793;1949.1618604000132;2003.8597298188986;2044.0903797810129;2074.346580827035;2097.213544920655;962.6967505235968;1041.8903867381214;1049.4437947887632;1099.9495481814847;1133.0991861470152;19292.61414771725;19898.60202795965;19907.701384479245;20050.197992080153;20050.498737531678;1018.3024628129755;1085.5277954089995;1088.4394536813547;1113.7605414835687;1122.320995797547;10166.69499914989;10852.945735271272;10880.183986200907;10917.181211409175;11153.442327883573;515513;520098;524072;525249;531731;96708;100349.49825250973;100866;100885.49557252167;102401.48799255956;1132.1848269246295;1132.7224829916559;1136.8067428537167;1163.528770847808;1166.311875993151;16894.915525422293;16960.660786784443;17015.489535313962;17019.82980170232;17125.400610978555;37034.44448333331;37059.44410833894;37731.62268377281;37992.240155197294;38027.42958855675;58602.70698646479;60155;60609.39390606037;60659;60958.695206523684;9157.49633770149;9245;9420.434773913314;9549.952250238704;9588.56851441673;13867.508453665741;13911.860881391056;13966.37151328213;14085.507007254697;14267.857321426653;11861;12004;12202.877971220174;12552.623421297376;12645.74708505843;11953.820692689791;11955.940220298842;12013.75972480563;12236.265824050586;12362.938185309016;12106.51573937068;12460.750784984068;12498.625041248777;12527.310997895203;12716.554920577735;8658.610362533575;9220.124088211609;9256.72229833106;9270.026647202216;9492.430454172772;8798.516081615573;12175.573854915036;12184;12185.39073046362;12347.876521234673 23:25:24 INFO - PROCESS | 25215 | |3;mootools.html;1381.5302797049;1552.0299812617113;1562.8202756682979;1746.205476508189;1888.3768356442376;7891.487053341529;8118.878216826753;8135.877961830577;8170.346372290217;8182.386321025932;8147.837043259131;8367.205115514016;8368.288695460878;8373.12082231366;8415.116412776646;2369.8104151667867;2400.987995060022;2408.5303365843665;2410.95178096438;2412.1316326122583;2357.705286839145;2374.27584586701;2421.4793819328843;2436.707595088583;2437.756224377566;2390.8685022323766;2399.196269249803;2414.420539070628;2439.134107391868;2440.4143005678598;2291.3355127013315;2338.7193536775612;2352.8588284702887;2354.788069073783;2377.690900182965;2366.8343215974887;2409.1929203716777;2423.333583264616;2423.5879900416794;2426.7573242675767;7274.381677557414;7400.851982960311;8611.483311001297;8649.308055355556;8681.435706679045;5017.799288028475;5125.538701516844;5129.179331306973;5130.871728206787;5131.717755523445;3226.596675415573;3226.8870589529256;3296.2583418730833;3409.573803274591;3493.615702272748;1130.8021096308196;1150.711203452139;1176.535268568919;1189.9464524096436;1203.0616119426772;11382.146339024523;11595.94202028993;11624.593139240085;12025.51897924082;12041.698957525956;4501.7524036177665;4543.931841022388;4570.428696412949;4598.149342371672;4664.813407463664;10495.475226238657;10518.316309439862;10521.84217236742;10523.736906577396;10523.894761052445;5275.4460781618145;5275.4724527547705;5286.286351342519;5288.867778305573;5293.153095504777;4758.857234282977;4782.569568738831;4796.472388037313;4797.328374027639;4798.04039192163;3784.7729136251364;3962.8018599069933;4007.779572123561;4042;4049.088954985105;1173.266708307308;1253.9937300313622;1256.7612153690952;1257.2393701810272;1266.8353114095294;924.653255029364;1040.256216804988;1043.3270540501335;1046.785408991155;1064.9563427840606;6025.9397406026255;6031.004884194059;6042.728077236447;6069.514438844882;6225.8132256032395;1052.7947050325113;1058.3226734889677;1090.2858627598778;1091.3942761767296;1092;3968.2460332536725;4029.3553031515403;4039;4058.6144316289906;4060.6548443382053;10123.797524049478;10331.793364132674;10431.68704938853;10543.209259305582;10560.630377936735;10438.582456701646;10551.366917984791;10558.102561282223;10639;10695.732606684895;8123.512589244546;8327.333813294921;8335.374846886507;8341.66633334672;8351.832963340821;5914.526837853047;5932.911006334994;6000.639961602144;6046.909296360646;6228.968855155696;9331.580078896603;9350.95324523373;9405.683204351533;9444.433333999981;9493.952530237304;9197.678081267124;9518.428894266366;9609.135177834029;9690.515474226402;9698.563564639468;8074.071481779671;8250.38122140854;8281.83436331282;8489.193526614961;8491.320694344315;8406.369522285975;8443.408961372645;8463.830723385374;8463.873041904499;8466.322694184328;7664.3485303747575;7793.06483222017;7810.3751699865015;7917.089534703583;7988.84022319562;7208.603526806076;7462.8507429850015;7648.541087534766;7665.118511371264;7782.610869456617;6959.164900212007;6970.059042029261;7013.509054366145;7021.964890175516;7027.086478757728;5298.072837253542;5312;5391.568674505952;5450.127979523258;5518.365387980433;5139.408967968731;5175.585953123817;5199.688018718889;5241.842744717665;5300.549453296513 23:25:24 INFO - PROCESS | 25215 | |4;prototype.html;363.90356555512795;368.87827017084373;369.06442169101325;374.2216190324126;379.12233180187843;6179.691015449232;6190.350013248606;6217.098520714494;6223.284322302937;6259.311475737677;5901.085331773582;6036.275646922364;6184.876302473948;6196.194494715692;6225.626462412247;4784.545468180535;4825.469198388175;4829.130756463844;4839.588634966032;4839.758012099399;4819.927701084486;4838.225883858583;4845.878853028685;4850.878728031792;4854.538818812225;4524.163029839474;4663.976680116594;4794.592459640935;4802.423709154907;4809.086273608021;4778.689385189951;4781.784819683123;4795.6403269754555;4803.087413391444;4805.543473370041;4254.829806807755;4254.851080212177;4268.530461649216;4270.103278311558;4271.850485233002;5978.55160862937;5981.252343457068;5991.460768530809;5992.131140984533;5997.130416089686;5578.609497335188;5590.329160500725;5606.887862242773;5613.07384281593;5615.859603509904;6410.935890641081;6538.280789113193;6543.312952140052;6545.37818907203;6549.34506549346;4706.505816889212;4715.08055929094;4728.69263497875;4734.905301893978;4737.976310118462;6813.829654258683;6819.454443644497;6821.4542836572955;6825.726970921207;6830.316968303229;4743.193657078305;4821.216150024514;4834.734089625034;4836.540528649773;4837.516248375135;4887.828925987574;4901.656884018084;4902.3872015998;4910.312556242129;4914.8771280718265;5281.762320695578;5445.727713614304;5445.782168713207;5581.944180558224;5582.218489411485;6531.150950376421;6538.0192971053775;6574.934250657528;6578.934210657928;6580.374864387875;1554;1629.5518732348698;1654.3713388912377;1673.840985106413;1674.2716918140648;1085.375908852413;1086.1528008153653;1087.8313861351503;1094.5621751299384;1120.288616728367;6291.811245662638;6332.430081292706;6339;6345.238571371373;6359.872802544016;6629.801105966829;6646.8005959821285;6647.800565983028;6662.633555154416;6669.566478178903;6286.937130628727;6322.747090116436;6323.0199319104695;6324.936750632527;6328.746850125944;3572.2676851245433;3608.2061946371755;3612.187257866959;3616.3309787689363;3616.87340943071;6833.077534532874;6968.233494315621;6973.895391569131;7002.509824312351;7010.088688470466;6770.830729231809;6803.081583986099;6807.319268073153;6807.863842723118;6818.522703410714;6941.167059952838;6976.7209311627985;6978.232394436608;6979.1973922999505;6982.1272340957385;6639.2696803352555;6655.301193374626;6664.66676666155;6676;6676.031975363642;6504.252011018793;6563;6583.30875258091;6763.830904227434;6765.695543700447;7128;7157.0695809546505;7166.964165179141;7179.425645948207;7191.9212118182695;4707.035057813072;4767.618590512681;4768.427788665383;4770.0936822003705;4773.236282194832;6483.189601299838;6807.965960170365;6814.727410903707;6816;6822.420094292041;6465.418112369909;6605.636689982097;6621.834454138685;6626.56927299724;6626.734930602722;6557.475401967736;6596.736130554724;6603.669816509251;6611.438027767694;6621.404073633396;6510.056041873807;6514.185726784152;6521.347865213441;6528.118703974903;6531.314212007861;6535.411812936668;6609.041688954979;6653.866922661617;6661.700223489857;6664.133662624022;6442.484601231984;6460.3862633049785;6460.806175814733;6465.094886715958;6467.223933128054 23:25:24 INFO - PROCESS | 25215 | |5;yui.html;874.59768506487;914.8993610702821;937.8874535055794;944.655200851689;952.2191802721767;15872.285747141377;16318.592035199126;16320.183990800471;16328.428505002328;16346.83653163468;15006.174660393674;15048.322825472853;15072.849271507283;15093.849061509381;15102.6979460411;761.3034073822446;902.1024081039375;934.4346670264495;937.4094320578026;939.2345238630528;930.2093220762365;935.0789472369711;938.1790932933683;938.3290946972913;940.3652534539159;986.5659109991581;989.2728844299434;992.5483904823288;992.8461088531253;993.0466751918167;807.0235015631064;962.7593101724569;975.9853602195973;977.1205914676813;977.2572844638055;710.0910834132319;716.9139703235593;717.3042149115349;717.4547344018531;717.7595505505661;14986.10083394989;15014.474493392789;15060.171690557016;15089;15102.169380684058;15265.23673816316;15318.080915145127;15563.533094007198;15667.608309792233;15767.448139315069;12020.158588898781;12139.939300303531;12204.694882627917;12357.073219508573;12371.75256494865;4110.116324990112;4121.8969525762095;4124.670026397881;4126.958730412717;4128.380742888561;57019;57530;57781.711091444275;58107;58120;11595.18833681651;11720.824187637192;11749.29504229749;11973;12203.69490762738;20139.496512587302;20703.58592828135;20737.377878663665;20953.476163096046;20958;8711.60797764102;8926.330525210635;9079.182873541413;9288.164065234161;9310.162085412345;4963.90072198554;5044.924326135111;5103.515166059218;5206.869828254324;5264.15773476242;3556.0220939241917;3603.837827297778;3609.3503169429227;3609.873654422083;3613.223157021253;655.885220086483;663.1677245057422;665.0323778901686;672.6872004517923;708.8617719544742;693.7953303775398;745.3701622129292;753.8023989118338;793.1275596843426;808.6482380164647;9850.162736167505;10324.799312213237;10381.63664271762;10436.686899393031;10498.790024199627;837.7026155714756;846.2190161465268;850.7150104714866;865.4331412924545;868.8392647360132;4680.274557443602;4840.139000906106;4933.112039832865;4937.35814344133;4965.255211718271;65361.67319163374;65843.67078164674;65906.34093659098;66559;72354;54307.45692543103;56783;58765;58991.70504147452;61640.38359616436;54265.1860222097;54477.72761136169;54625.72687136618;54902.17646735222;54995.175072373946;10260.333078349884;10441.686749397226;10550.788984220426;10608.416537090225;10621.575136994434;37852.432213516266;38386.80806595949;40153.598464016155;40412.3938140934;41092;47397.28904066373;50151;50696.49303506918;50749.492505075956;51335.74332128315;13762.793558096437;13841.169529828243;13884.375203115682;14115.858841411866;14231.430742770173;14108.717825643635;14325.140491570539;14535.636609084857;14985.40058397652;15181.16503592313;13353.732925341634;13708.314584270547;13788.655283617589;14104.788428173792;14240.786388203978;13154.868451315364;13359.866401335863;13531.72936541244;13539.526116585872;13935.372908218951;12705.301208433624;12765.74468510606;12792.872071279167;13100.344982751016;13158.539451119164;11121.443927803739;11308.70456368271;11452.484638191469;11687.123465739933;11807.645770626896;10847.728806779895;11520.423978801195;11843.348615825867;11904.880951190376;11969.461374238354 23:25:24 INFO - PROCESS | 25215 | __end_tp_report 23:25:24 INFO - PROCESS | 25215 | __start_cc_report 23:25:24 INFO - PROCESS | 25215 | _x_x_mozilla_cycle_collect,874 23:25:24 INFO - PROCESS | 25215 | __end_cc_report 23:25:24 INFO - PROCESS | 25215 | __startTimestamp1467527124601__endTimestamp 23:25:24 INFO - PROCESS | 25215 | 23:25:24 INFO - PROCESS | 25215 | ------- Summary: start ------- 23:25:24 INFO - PROCESS | 25215 | Number of tests: 6 23:25:24 INFO - PROCESS | 25215 | 23:25:24 INFO - PROCESS | 25215 | [#0] dojo.html Cycles:165 Average:5520.95 Median:5764.71 stddev:607.44 (10.5%) stddev-sans-first:584.09 23:25:24 INFO - PROCESS | 25215 | Values: 3313.4 3359.5 3385.6 3393.3 3413.8 5521.6 5555.8 5565.9 5576.6 5585.8 5506.3 5531.1 5581.0 5591.9 5627.5 4946.6 5012.5 5108.8 5154.1 5187.8 4940.7 4989.0 4993.8 5066.3 5100.1 5047.2 5096.9 5097.4 5109.6 5134.1 5036.5 5047.8 5097.3 5103.8 5109.8 4898.9 4955.4 5042.4 5047.0 5057.2 5431.0 5451.7 5462.5 5462.8 5473.5 5792.8 5893.3 5913.2 5913.4 5917.2 5829.4 5888.5 5944.6 5953.6 5959.3 5578.4 5581.8 5582.2 5585.7 5619.9 5881.1 6045.3 6082.7 6087.2 6121.8 5781.8 5842.7 5846.9 5880.4 5880.7 5876.4 5877.6 5884.3 5887.3 5898.1 5765.0 5833.5 5838.6 5844.9 5854.7 5906.3 5910.4 5913.9 5926.5 5951.0 4504.0 4540.4 4545.3 4546.5 4569.5 3977.4 4005.0 4067.8 4068.3 4107.1 5664.6 5688.1 5693.5 5696.9 5705.2 5960.5 5961.8 5973.0 5974.9 5977.8 5564.4 5663.6 5697.6 5743.8 5759.8 5088.1 5099.2 5110.3 5114.2 5128.8 6120.4 6155.8 6180.2 6180.3 6197.6 5730.0 5823.8 5825.2 5848.3 5850.6 6167.9 6193.1 6195.5 6199.0 6199.7 5667.5 5833.6 5847.2 5866.4 5869.3 5984.5 6044.5 6046.8 6052.7 6091.7 5763.8 5786.2 5802.7 5812.8 5817.1 5609.5 5794.3 5796.4 5796.9 5807.4 5775.5 5781.7 5789.1 5793.5 5830.0 5854.6 5895.9 5897.6 5900.0 5905.0 5621.6 5719.2 5726.4 5764.7 5801.9 23:25:24 INFO - PROCESS | 25215 | 23:25:24 INFO - PROCESS | 25215 | [#1] ext.html Cycles:180 Average:53797.39 Median:37795.31 stddev:99820.56 (264.1%) stddev-sans-first:100020.68 23:25:24 INFO - PROCESS | 25215 | Values: 600.4 651.3 652.4 653.3 671.9 32527.2 40380.6 40916.6 41013.2 41030.4 43908.0 44501.8 44522.1 44574.0 44835.1 8024.9 8873.4 9074.5 9074.7 10402.2 10540.2 10667.8 10674.1 10674.9 10686.9 10668.6 10738.4 10741.1 10744.8 10750.9 10563.3 10631.1 10647.1 10653.7 10662.3 10450.8 10728.5 10869.1 10906.9 10932.3 44742.0 44884.6 45165.5 45186.8 45212.0 3848.5 3932.4 4043.2 4436.8 4594.0 32903.5 33137.5 33229.8 33897.7 34373.0 4560.5 4577.0 4578.6 4582.1 4846.4 256861.7 258850.0 259567.0 259922.0 261610.0 41834.6 64832.0 65332.0 70944.0 70949.3 41374.0 41640.2 41664.8 41673.2 41718.8 17293.1 17589.8 17593.0 17600.5 17610.0 13821.3 14578.9 14955.2 14970.7 15032.5 9588.8 9598.5 9632.0 9669.3 9687.7 3738.6 3807.3 3842.5 3855.8 3871.7 1093.2 1128.9 1140.9 1150.0 1151.2 33722.0 33762.3 33893.8 34002.7 34636.1 1171.3 1178.3 1197.2 1248.0 1323.5 17470.2 17502.1 17560.3 17563.6 17911.5 510219.0 513766.0 516096.0 517645.0 517969.0 63678.0 63937.0 64273.4 64328.7 64389.0 1457.5 1473.5 1490.2 1542.8 1565.1 30648.8 31219.0 33453.7 34581.5 34603.5 49275.3 49683.3 49720.8 49828.8 49885.0 304130.0 305894.0 306747.0 307269.0 307819.0 28348.9 32280.8 32735.8 32768.0 32829.7 49040.3 51744.7 51861.0 52111.0 52465.0 42386.0 42641.6 42800.6 42927.0 43541.1 40671.4 41535.2 41959.0 41996.8 42960.0 43414.3 45570.3 45951.3 46706.8 46930.8 34593.7 36053.3 37721.6 37869.0 39515.0 28965.3 29256.0 29367.3 29422.3 29529.6 23:25:24 INFO - PROCESS | 25215 | 23:25:24 INFO - PROCESS | 25215 | [#2] jquery.html Cycles:180 Average:30222.26 Median:2057.26 stddev:86261.10 (4193.0%) stddev-sans-first:86474.09 23:25:24 INFO - PROCESS | 25215 | Values: 432.7 438.3 439.9 442.4 453.8 18383.8 18462.8 19378.3 19442.8 19508.6 18260.8 18564.8 19118.9 19241.7 19282.8 5820.8 5877.8 5979.0 5984.1 6129.1 5893.0 5905.6 5940.6 5954.4 5973.9 5916.5 5927.3 5973.0 6250.0 6260.7 6098.9 6203.6 6213.7 6246.8 6545.6 5903.7 5931.2 5941.3 5966.9 5968.8 13724.4 14481.9 14492.9 14509.5 23519.3 2419.1 2635.5 2671.3 2856.8 3175.2 10240.6 10337.1 10568.2 13100.3 13322.1 2034.6 2051.4 2063.2 2071.2 2122.2 76921.2 81644.2 81872.0 82931.0 83138.0 11041.1 11184.6 11539.8 11574.4 11695.6 15777.9 15809.7 16019.4 16023.8 16029.5 8891.4 8973.0 9015.6 9103.1 9169.5 9022.6 9034.4 9112.7 9141.8 9260.6 4877.5 4894.2 4910.9 5017.6 5070.1 1949.2 2003.9 2044.1 2074.3 2097.2 962.7 1041.9 1049.4 1099.9 1133.1 19292.6 19898.6 19907.7 20050.2 20050.5 1018.3 1085.5 1088.4 1113.8 1122.3 10166.7 10852.9 10880.2 10917.2 11153.4 515513.0 520098.0 524072.0 525249.0 531731.0 96708.0 100349.5 100866.0 100885.5 102401.5 1132.2 1132.7 1136.8 1163.5 1166.3 16894.9 16960.7 17015.5 17019.8 17125.4 37034.4 37059.4 37731.6 37992.2 38027.4 58602.7 60155.0 60609.4 60659.0 60958.7 9157.5 9245.0 9420.4 9550.0 9588.6 13867.5 13911.9 13966.4 14085.5 14267.9 11861.0 12004.0 12202.9 12552.6 12645.7 11953.8 11955.9 12013.8 12236.3 12362.9 12106.5 12460.8 12498.6 12527.3 12716.6 8658.6 9220.1 9256.7 9270.0 9492.4 8798.5 12175.6 12184.0 12185.4 12347.9 23:25:24 INFO - PROCESS | 25215 | 23:25:24 INFO - PROCESS | 25215 | [#3] mootools.html Cycles:180 Average:5724.68 Median:4789.52 stddev:3142.46 (65.6%) stddev-sans-first:3134.32 23:25:24 INFO - PROCESS | 25215 | Values: 1381.5 1552.0 1562.8 1746.2 1888.4 7891.5 8118.9 8135.9 8170.3 8182.4 8147.8 8367.2 8368.3 8373.1 8415.1 2369.8 2401.0 2408.5 2411.0 2412.1 2357.7 2374.3 2421.5 2436.7 2437.8 2390.9 2399.2 2414.4 2439.1 2440.4 2291.3 2338.7 2352.9 2354.8 2377.7 2366.8 2409.2 2423.3 2423.6 2426.8 7274.4 7400.9 8611.5 8649.3 8681.4 5017.8 5125.5 5129.2 5130.9 5131.7 3226.6 3226.9 3296.3 3409.6 3493.6 1130.8 1150.7 1176.5 1189.9 1203.1 11382.1 11595.9 11624.6 12025.5 12041.7 4501.8 4543.9 4570.4 4598.1 4664.8 10495.5 10518.3 10521.8 10523.7 10523.9 5275.4 5275.5 5286.3 5288.9 5293.2 4758.9 4782.6 4796.5 4797.3 4798.0 3784.8 3962.8 4007.8 4042.0 4049.1 1173.3 1254.0 1256.8 1257.2 1266.8 924.7 1040.3 1043.3 1046.8 1065.0 6025.9 6031.0 6042.7 6069.5 6225.8 1052.8 1058.3 1090.3 1091.4 1092.0 3968.2 4029.4 4039.0 4058.6 4060.7 10123.8 10331.8 10431.7 10543.2 10560.6 10438.6 10551.4 10558.1 10639.0 10695.7 8123.5 8327.3 8335.4 8341.7 8351.8 5914.5 5932.9 6000.6 6046.9 6229.0 9331.6 9351.0 9405.7 9444.4 9494.0 9197.7 9518.4 9609.1 9690.5 9698.6 8074.1 8250.4 8281.8 8489.2 8491.3 8406.4 8443.4 8463.8 8463.9 8466.3 7664.3 7793.1 7810.4 7917.1 7988.8 7208.6 7462.9 7648.5 7665.1 7782.6 6959.2 6970.1 7013.5 7022.0 7027.1 5298.1 5312.0 5391.6 5450.1 5518.4 5139.4 5175.6 5199.7 5241.8 5300.5 23:25:24 INFO - PROCESS | 25215 | 23:25:24 INFO - PROCESS | 25215 | [#4] prototype.html Cycles:180 Average:5518.51 Median:6289.37 stddev:1638.51 (26.1%) stddev-sans-first:1596.77 23:25:24 INFO - PROCESS | 25215 | Values: 363.9 368.9 369.1 374.2 379.1 6179.7 6190.4 6217.1 6223.3 6259.3 5901.1 6036.3 6184.9 6196.2 6225.6 4784.5 4825.5 4829.1 4839.6 4839.8 4819.9 4838.2 4845.9 4850.9 4854.5 4524.2 4664.0 4794.6 4802.4 4809.1 4778.7 4781.8 4795.6 4803.1 4805.5 4254.8 4254.9 4268.5 4270.1 4271.9 5978.6 5981.3 5991.5 5992.1 5997.1 5578.6 5590.3 5606.9 5613.1 5615.9 6410.9 6538.3 6543.3 6545.4 6549.3 4706.5 4715.1 4728.7 4734.9 4738.0 6813.8 6819.5 6821.5 6825.7 6830.3 4743.2 4821.2 4834.7 4836.5 4837.5 4887.8 4901.7 4902.4 4910.3 4914.9 5281.8 5445.7 5445.8 5581.9 5582.2 6531.2 6538.0 6574.9 6578.9 6580.4 1554.0 1629.6 1654.4 1673.8 1674.3 1085.4 1086.2 1087.8 1094.6 1120.3 6291.8 6332.4 6339.0 6345.2 6359.9 6629.8 6646.8 6647.8 6662.6 6669.6 6286.9 6322.7 6323.0 6324.9 6328.7 3572.3 3608.2 3612.2 3616.3 3616.9 6833.1 6968.2 6973.9 7002.5 7010.1 6770.8 6803.1 6807.3 6807.9 6818.5 6941.2 6976.7 6978.2 6979.2 6982.1 6639.3 6655.3 6664.7 6676.0 6676.0 6504.3 6563.0 6583.3 6763.8 6765.7 7128.0 7157.1 7167.0 7179.4 7191.9 4707.0 4767.6 4768.4 4770.1 4773.2 6483.2 6808.0 6814.7 6816.0 6822.4 6465.4 6605.6 6621.8 6626.6 6626.7 6557.5 6596.7 6603.7 6611.4 6621.4 6510.1 6514.2 6521.3 6528.1 6531.3 6535.4 6609.0 6653.9 6661.7 6664.1 6442.5 6460.4 6460.8 6465.1 6467.2 23:25:24 INFO - PROCESS | 25215 | 23:25:24 INFO - PROCESS | 25215 | [#5] yui.html Cycles:180 Average:16142.71 Median:4123.28 stddev:18457.15 (447.6%) stddev-sans-first:18473.31 23:25:24 INFO - PROCESS | 25215 | Values: 874.6 914.9 937.9 944.7 952.2 15872.3 16318.6 16320.2 16328.4 16346.8 15006.2 15048.3 15072.8 15093.8 15102.7 761.3 902.1 934.4 937.4 939.2 930.2 935.1 938.2 938.3 940.4 986.6 989.3 992.5 992.8 993.0 807.0 962.8 976.0 977.1 977.3 710.1 716.9 717.3 717.5 717.8 14986.1 15014.5 15060.2 15089.0 15102.2 15265.2 15318.1 15563.5 15667.6 15767.4 12020.2 12139.9 12204.7 12357.1 12371.8 4110.1 4121.9 4124.7 4127.0 4128.4 57019.0 57530.0 57781.7 58107.0 58120.0 11595.2 11720.8 11749.3 11973.0 12203.7 20139.5 20703.6 20737.4 20953.5 20958.0 8711.6 8926.3 9079.2 9288.2 9310.2 4963.9 5044.9 5103.5 5206.9 5264.2 3556.0 3603.8 3609.4 3609.9 3613.2 655.9 663.2 665.0 672.7 708.9 693.8 745.4 753.8 793.1 808.6 9850.2 10324.8 10381.6 10436.7 10498.8 837.7 846.2 850.7 865.4 868.8 4680.3 4840.1 4933.1 4937.4 4965.3 65361.7 65843.7 65906.3 66559.0 72354.0 54307.5 56783.0 58765.0 58991.7 61640.4 54265.2 54477.7 54625.7 54902.2 54995.2 10260.3 10441.7 10550.8 10608.4 10621.6 37852.4 38386.8 40153.6 40412.4 41092.0 47397.3 50151.0 50696.5 50749.5 51335.7 13762.8 13841.2 13884.4 14115.9 14231.4 14108.7 14325.1 14535.6 14985.4 15181.2 13353.7 13708.3 13788.7 14104.8 14240.8 13154.9 13359.9 13531.7 13539.5 13935.4 12705.3 12765.7 12792.9 13100.3 13158.5 11121.4 11308.7 11452.5 11687.1 11807.6 10847.7 11520.4 11843.3 11904.9 11969.5 23:25:24 INFO - PROCESS | 25215 | -------- Summary: end -------- 23:25:24 INFO - PROCESS | 25215 | 23:25:25 INFO - TEST-INFO | 25215: exit 0 23:25:25 INFO - TEST-OK | dromaeo_css | took 1109902ms 23:25:25 INFO - TEST-START | kraken 23:25:25 INFO - operating with platform_type : linux_ 23:25:25 INFO - Initialising browser for kraken test... 23:25:25 INFO - TEST-INFO | started process 25416 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpi1Wiew/profile http://localhost:48201/getInfo.html) 23:25:28 INFO - PROCESS | 25416 | __metrics Screen width/height:1600/1200 23:25:28 INFO - PROCESS | 25416 | colorDepth:24 23:25:28 INFO - PROCESS | 25416 | Browser inner width/height: 1024/697 23:25:28 INFO - PROCESS | 25416 | __metrics 23:25:29 ERROR - PROCESS | 25416 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 23:25:30 INFO - TEST-INFO | 25416: exit 0 23:25:30 INFO - Browser initialized. 23:25:30 INFO - Running cycle 1/1 for kraken test... 23:25:30 INFO - TEST-INFO | started process 25510 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpi1Wiew/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 23:25:42 INFO - PROCESS | 25510 | RSS: Main: 139599872 23:25:42 INFO - PROCESS | 25510 | 23:25:44 INFO - PROCESS | 25510 | Cycle 1(1): loaded http://localhost:48201/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:48201/tests/kraken/driver.html?testName=audio-beat-detection) 23:25:45 INFO - PROCESS | 25510 | RSS: Main: 198209536 23:25:45 INFO - PROCESS | 25510 | 23:25:48 INFO - PROCESS | 25510 | Cycle 1(1): loaded http://localhost:48201/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:48201/tests/kraken/driver.html?testName=audio-dft) 23:25:48 INFO - PROCESS | 25510 | RSS: Main: 185393152 23:25:48 INFO - PROCESS | 25510 | 23:25:51 INFO - PROCESS | 25510 | Cycle 1(1): loaded http://localhost:48201/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:48201/tests/kraken/driver.html?testName=audio-fft) 23:25:51 INFO - PROCESS | 25510 | RSS: Main: 274731008 23:25:51 INFO - PROCESS | 25510 | 23:25:54 INFO - PROCESS | 25510 | Cycle 1(1): loaded http://localhost:48201/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:48201/tests/kraken/driver.html?testName=audio-oscillator) 23:25:54 INFO - PROCESS | 25510 | RSS: Main: 180793344 23:25:54 INFO - PROCESS | 25510 | 23:25:56 INFO - PROCESS | 25510 | Cycle 1(1): loaded http://localhost:48201/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:48201/tests/kraken/driver.html?testName=imaging-gaussian-blur) 23:25:57 INFO - PROCESS | 25510 | RSS: Main: 179650560 23:25:57 INFO - PROCESS | 25510 | 23:26:00 INFO - PROCESS | 25510 | Cycle 1(1): loaded http://localhost:48201/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:48201/tests/kraken/driver.html?testName=imaging-darkroom) 23:26:00 INFO - PROCESS | 25510 | RSS: Main: 213454848 23:26:00 INFO - PROCESS | 25510 | 23:26:04 INFO - PROCESS | 25510 | Cycle 1(1): loaded http://localhost:48201/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:48201/tests/kraken/driver.html?testName=imaging-desaturate) 23:26:04 INFO - PROCESS | 25510 | RSS: Main: 213803008 23:26:04 INFO - PROCESS | 25510 | 23:26:07 INFO - PROCESS | 25510 | Cycle 1(1): loaded http://localhost:48201/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:48201/tests/kraken/driver.html?testName=json-parse-financial) 23:26:08 INFO - PROCESS | 25510 | RSS: Main: 213504000 23:26:08 INFO - PROCESS | 25510 | 23:26:09 INFO - PROCESS | 25510 | Cycle 1(1): loaded http://localhost:48201/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:48201/tests/kraken/driver.html?testName=json-stringify-tinderbox) 23:26:10 INFO - PROCESS | 25510 | RSS: Main: 193662976 23:26:10 INFO - PROCESS | 25510 | 23:26:11 INFO - PROCESS | 25510 | Cycle 1(1): loaded http://localhost:48201/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:48201/tests/kraken/driver.html?testName=stanford-crypto-aes) 23:26:12 INFO - PROCESS | 25510 | RSS: Main: 195493888 23:26:12 INFO - PROCESS | 25510 | 23:26:14 INFO - PROCESS | 25510 | Cycle 1(1): loaded http://localhost:48201/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:48201/tests/kraken/driver.html?testName=stanford-crypto-ccm) 23:26:15 INFO - PROCESS | 25510 | RSS: Main: 210067456 23:26:15 INFO - PROCESS | 25510 | 23:26:17 INFO - PROCESS | 25510 | Cycle 1(1): loaded http://localhost:48201/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:48201/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 23:26:18 INFO - PROCESS | 25510 | RSS: Main: 218206208 23:26:18 INFO - PROCESS | 25510 | 23:26:20 INFO - PROCESS | 25510 | Cycle 1(1): loaded http://localhost:48201/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:48201/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 23:26:21 INFO - PROCESS | 25510 | RSS: Main: 211955712 23:26:21 INFO - PROCESS | 25510 | 23:26:23 INFO - PROCESS | 25510 | Cycle 1(1): loaded http://localhost:48201/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:48201/tests/kraken/driver.html?testName=ai-astar) 23:26:23 INFO - PROCESS | 25510 | RSS: Main: 272404480 23:26:23 INFO - PROCESS | 25510 | 23:26:23 INFO - PROCESS | 25510 | __start_tp_report 23:26:23 INFO - PROCESS | 25510 | _x_x_mozilla_page_load 23:26:23 INFO - PROCESS | 25510 | _x_x_mozilla_page_load_details 23:26:23 INFO - PROCESS | 25510 | |i|pagename|runs| 23:26:23 INFO - PROCESS | 25510 | |0;ai-astar;110;111;110;110;110;110;106;110;110;109 23:26:23 INFO - PROCESS | 25510 | |1;audio-beat-detection;155;124;153;181;126;150;161;128;186;129 23:26:23 INFO - PROCESS | 25510 | |2;audio-dft;161;161;161;160;161;162;162;161;161;162 23:26:23 INFO - PROCESS | 25510 | |3;audio-fft;83;76;73;185;74;73;74;76;162;77 23:26:23 INFO - PROCESS | 25510 | |4;audio-oscillator;92;92;149;91;93;92;150;92;92;145 23:26:23 INFO - PROCESS | 25510 | |5;imaging-gaussian-blur;117;117;117;116;117;116;117;116;117;116 23:26:23 INFO - PROCESS | 25510 | |6;imaging-darkroom;146;146;145;146;146;145;145;147;147;145 23:26:23 INFO - PROCESS | 25510 | |7;imaging-desaturate;95;94;95;94;94;95;94;94;94;94 23:26:23 INFO - PROCESS | 25510 | |8;json-parse-financial;51;53;52;52;53;52;56;73;51;52 23:26:23 INFO - PROCESS | 25510 | |9;json-stringify-tinderbox;57;59;57;57;57;56;56;56;57;57 23:26:23 INFO - PROCESS | 25510 | |10;stanford-crypto-aes;71;73;73;72;75;73;73;80;73;75 23:26:23 INFO - PROCESS | 25510 | |11;stanford-crypto-ccm;117;119;116;118;115;113;114;114;129;112 23:26:23 INFO - PROCESS | 25510 | |12;stanford-crypto-pbkdf2;161;161;161;157;160;161;159;158;171;159 23:26:23 INFO - PROCESS | 25510 | |13;stanford-crypto-sha256-iterative;67;69;67;66;66;68;67;66;66;64 23:26:23 INFO - PROCESS | 25510 | __end_tp_report 23:26:23 INFO - PROCESS | 25510 | __start_cc_report 23:26:23 INFO - PROCESS | 25510 | _x_x_mozilla_cycle_collect,1600 23:26:23 INFO - PROCESS | 25510 | __end_cc_report 23:26:23 INFO - PROCESS | 25510 | __startTimestamp1467527183416__endTimestamp 23:26:23 INFO - PROCESS | 25510 | 23:26:23 INFO - PROCESS | 25510 | ------- Summary: start ------- 23:26:23 INFO - PROCESS | 25510 | Number of tests: 14 23:26:23 INFO - PROCESS | 25510 | 23:26:23 INFO - PROCESS | 25510 | [#0] ai-astar Cycles:10 Average:109.60 Median:110.00 stddev:1.35 (1.2%) stddev-sans-first:1.42 23:26:23 INFO - PROCESS | 25510 | Values: 110.0 111.0 110.0 110.0 110.0 110.0 106.0 110.0 110.0 109.0 23:26:23 INFO - PROCESS | 25510 | 23:26:23 INFO - PROCESS | 25510 | [#1] audio-beat-detection Cycles:10 Average:149.30 Median:154.00 stddev:22.57 (14.7%) stddev-sans-first:23.84 23:26:23 INFO - PROCESS | 25510 | Values: 155.0 124.0 153.0 181.0 126.0 150.0 161.0 128.0 186.0 129.0 23:26:23 INFO - PROCESS | 25510 | 23:26:23 INFO - PROCESS | 25510 | [#2] audio-dft Cycles:10 Average:161.20 Median:161.00 stddev:0.63 (0.4%) stddev-sans-first:0.67 23:26:23 INFO - PROCESS | 25510 | Values: 161.0 161.0 161.0 160.0 161.0 162.0 162.0 161.0 161.0 162.0 23:26:23 INFO - PROCESS | 25510 | 23:26:23 INFO - PROCESS | 25510 | [#3] audio-fft Cycles:10 Average:95.30 Median:75.00 stddev:41.67 (55.6%) stddev-sans-first:43.96 23:26:23 INFO - PROCESS | 25510 | Values: 83.0 76.0 73.0 185.0 74.0 73.0 74.0 76.0 162.0 77.0 23:26:23 INFO - PROCESS | 25510 | 23:26:23 INFO - PROCESS | 25510 | [#4] audio-oscillator Cycles:10 Average:108.80 Median:92.00 stddev:27.08 (29.4%) stddev-sans-first:28.04 23:26:23 INFO - PROCESS | 25510 | Values: 92.0 92.0 149.0 91.0 93.0 92.0 150.0 92.0 92.0 145.0 23:26:23 INFO - PROCESS | 25510 | 23:26:23 INFO - PROCESS | 25510 | [#5] imaging-gaussian-blur Cycles:10 Average:116.60 Median:117.00 stddev:0.52 (0.4%) stddev-sans-first:0.53 23:26:23 INFO - PROCESS | 25510 | Values: 117.0 117.0 117.0 116.0 117.0 116.0 117.0 116.0 117.0 116.0 23:26:23 INFO - PROCESS | 25510 | 23:26:23 INFO - PROCESS | 25510 | [#6] imaging-darkroom Cycles:10 Average:145.80 Median:146.00 stddev:0.79 (0.5%) stddev-sans-first:0.83 23:26:23 INFO - PROCESS | 25510 | Values: 146.0 146.0 145.0 146.0 146.0 145.0 145.0 147.0 147.0 145.0 23:26:23 INFO - PROCESS | 25510 | 23:26:23 INFO - PROCESS | 25510 | [#7] imaging-desaturate Cycles:10 Average:94.30 Median:94.00 stddev:0.48 (0.5%) stddev-sans-first:0.44 23:26:23 INFO - PROCESS | 25510 | Values: 95.0 94.0 95.0 94.0 94.0 95.0 94.0 94.0 94.0 94.0 23:26:23 INFO - PROCESS | 25510 | 23:26:23 INFO - PROCESS | 25510 | [#8] json-parse-financial Cycles:10 Average:54.50 Median:52.50 stddev:6.65 (12.7%) stddev-sans-first:6.94 23:26:23 INFO - PROCESS | 25510 | Values: 51.0 53.0 52.0 52.0 53.0 52.0 56.0 73.0 51.0 52.0 23:26:23 INFO - PROCESS | 25510 | 23:26:23 INFO - PROCESS | 25510 | [#9] json-stringify-tinderbox Cycles:10 Average:56.90 Median:57.00 stddev:0.88 (1.5%) stddev-sans-first:0.93 23:26:23 INFO - PROCESS | 25510 | Values: 57.0 59.0 57.0 57.0 57.0 56.0 56.0 56.0 57.0 57.0 23:26:23 INFO - PROCESS | 25510 | 23:26:23 INFO - PROCESS | 25510 | [#10] stanford-crypto-aes Cycles:10 Average:73.80 Median:73.00 stddev:2.49 (3.4%) stddev-sans-first:2.42 23:26:23 INFO - PROCESS | 25510 | Values: 71.0 73.0 73.0 72.0 75.0 73.0 73.0 80.0 73.0 75.0 23:26:23 INFO - PROCESS | 25510 | 23:26:23 INFO - PROCESS | 25510 | [#11] stanford-crypto-ccm Cycles:10 Average:116.70 Median:116.50 stddev:4.85 (4.2%) stddev-sans-first:5.15 23:26:23 INFO - PROCESS | 25510 | Values: 117.0 119.0 116.0 118.0 115.0 113.0 114.0 114.0 129.0 112.0 23:26:23 INFO - PROCESS | 25510 | 23:26:23 INFO - PROCESS | 25510 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:160.80 Median:161.00 stddev:3.85 (2.4%) stddev-sans-first:4.09 23:26:23 INFO - PROCESS | 25510 | Values: 161.0 161.0 161.0 157.0 160.0 161.0 159.0 158.0 171.0 159.0 23:26:23 INFO - PROCESS | 25510 | 23:26:23 INFO - PROCESS | 25510 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:66.60 Median:67.00 stddev:1.35 (2.0%) stddev-sans-first:1.42 23:26:23 INFO - PROCESS | 25510 | Values: 67.0 69.0 67.0 66.0 66.0 68.0 67.0 66.0 66.0 64.0 23:26:23 INFO - PROCESS | 25510 | -------- Summary: end -------- 23:26:23 INFO - PROCESS | 25510 | 23:26:24 INFO - TEST-INFO | 25510: exit 0 23:26:24 INFO - TEST-OK | kraken | took 59071ms 23:26:24 INFO - SUITE-END | took 1168s 23:26:24 INFO - Completed test suite (00:19:29) 23:26:24 INFO - javascript benchmark 23:26:24 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3313.403587354276, 3359.4960755886614, 3385.5768028996376, 3393.3043726036135, 3413.829308534574, 5521.585881058922, 5555.777768889239, 5565.94247093052, 5576.5817563682685, 5585.776568937237, 5506.311711036121, 5531.0873705838485, 5580.972095139518, 5591.888162236763, 5627.493525582697, 4946.629002824785, 5012.473690262515, 5108.77010534525, 5154.098032844256, 5187.766550505236, 4940.654154209206, 4988.950110498903, 4993.775280112385, 5066.341375621164, 5100.132977393852, 5047.167217409142, 5096.923546146811, 5097.439281679012, 5109.642325037249, 5134.0758663440565, 5036.471170527078, 5047.823326183566, 5097.3118628984985, 5103.795848166087, 5109.795608175668, 4898.877528061791, 4955.40535135786, 5042.39491261051, 5047.015831912779, 5057.165567681328, 5431.0, 5451.672899626035, 5462.481064298885, 5462.808801691962, 5473.480019398151, 5792.768289268424, 5893.322267939199, 5913.172155898134, 5913.408659134096, 5917.20117784098, 5829.446202610745, 5888.499477544414, 5944.583879128462, 5953.613015154001, 5959.344472108065, 5578.41426650204, 5581.776728930838, 5582.218489411485, 5585.74864131111, 5619.943800562024, 5881.088431293157, 6045.304789949124, 6082.7347434188305, 6087.239095113111, 6121.816345509553, 5781.768729250867, 5842.737076831553, 5846.941530584725, 5880.411958804171, 5880.705964701748, 5876.353601103875, 5877.588568800228, 5884.293884733774, 5887.322957859816, 5898.056310990307, 5765.048766953406, 5833.4749872511675, 5838.562107841929, 5844.9415505845245, 5854.677992710442, 5906.291245050621, 5910.408959104056, 5913.940860591339, 5926.496247818984, 5951.0, 4503.977480112579, 4540.409746732904, 4545.2954792007295, 4546.499885012646, 4569.543045695404, 3977.3636218204947, 4005.0, 4067.7559346439307, 4068.349064149722, 4107.137501124797, 5664.6034777566, 5688.146777983336, 5693.544516438675, 5696.857578560486, 5705.22979397776, 5960.523158147338, 5961.821145365646, 5973.044312909914, 5974.85062873423, 5977.760889564369, 5564.443555644403, 5663.575231857627, 5697.601167918206, 5743.770249190069, 5759.769609215585, 5088.1350170471105, 5099.184130539096, 5110.2590124431745, 5114.156164232934, 5128.8461346159675, 6120.387961203844, 6155.753769849156, 6180.196574445294, 6180.289266734293, 6197.628142311476, 5730.0, 5823.796167134215, 5825.242718446575, 5848.2689663792025, 5850.5904586678525, 6167.907481387693, 6193.071039343954, 6195.473384762346, 6199.039148931923, 6199.659018754011, 5667.5465962722055, 5833.649981001154, 5847.210626565529, 5866.442687944638, 5869.295684517885, 5984.491318237999, 6044.486218671462, 6046.788362407295, 6052.667103309184, 6091.7258723358445, 5763.769449221984, 5786.247787787561, 5802.65184088956, 5812.7674893003805, 5817.0983497557945, 5609.523190528851, 5794.275715535558, 5796.362400135898, 5796.855078623068, 5807.390224026416, 5775.451332123442, 5781.739821707949, 5789.131630255327, 5793.478586927196, 5830.0, 5854.619449735754, 5895.882082358243, 5897.557683173865, 5900.0, 5904.970475147768, 5621.606487545832, 5719.2279042328755, 5726.4273572642405, 5764.711764411846, 5801.883962320646], "value": 5481.903569594934, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [600.4145957691252, 651.3258777165631, 652.4486808646693, 653.2552889705739, 671.8857794174992, 32527.186820329505, 40380.59619403805, 40916.59083409165, 41013.179736405255, 41030.38454423186, 43908.0, 44501.77749111258, 44522.10955780891, 44574.0, 44835.1032979341, 8024.879626805603, 8873.423227490193, 9074.500902450363, 9074.682386116487, 10402.219833512518, 10540.156787457023, 10667.78664426711, 10674.146068314554, 10674.893251067468, 10686.893131068706, 10668.62659806907, 10738.355698658066, 10741.087007604325, 10744.838827417596, 10750.946245268762, 10563.26057175998, 10631.096356809641, 10647.148228141808, 10653.680389588324, 10662.253642245047, 10450.843237351446, 10728.463576821128, 10869.130469562417, 10906.945465272624, 10932.289401188897, 44742.0, 44884.55115448869, 45165.548344516465, 45186.77406612979, 45212.0, 3848.499695039627, 3932.4494570760116, 4043.1913617276664, 4436.844710435152, 4594.0122873582, 32903.506447403306, 33137.50293745596, 33229.83385083059, 33897.66102338969, 34373.0, 4560.452745670541, 4576.977115114403, 4578.610818080434, 4582.1064892346, 4846.442659094214, 256861.71569142223, 258850.0, 259567.0, 259922.0, 261610.0, 41834.581654183676, 64832.0, 65332.0, 70944.0, 70949.2905070953, 41374.0, 41640.1671966559, 41664.791676042034, 41673.166536669094, 41718.79140604277, 17293.13534323279, 17589.824101759074, 17593.0, 17600.471985840446, 17610.0, 13821.308934553434, 14578.927105364617, 14955.177465239516, 14970.70058598822, 15032.473863414947, 9588.76028099303, 9598.520073996273, 9631.951840240754, 9669.323147379757, 9687.70936871895, 3738.5513738351574, 3807.257584770943, 3842.539834862734, 3855.8072096395067, 3871.709621778378, 1093.2292733622776, 1128.9266197697123, 1140.948657310423, 1150.0397168364343, 1151.2229245259416, 33722.0, 33762.32475350529, 33893.83053084719, 34002.65997340044, 34636.13409664728, 1171.2679575265458, 1178.3165763856941, 1197.167968262067, 1248.0, 1323.483841301893, 17470.213840377215, 17502.096896593113, 17560.29758809659, 17563.560910977074, 17911.462656120337, 510219.0, 513766.0, 516096.0, 517645.0, 517969.0, 63678.0, 63937.0, 64273.35726642767, 64328.678356608856, 64389.0, 1457.5117335692662, 1473.462186301992, 1490.180400779567, 1542.7608720648318, 1565.1157096240588, 30648.846755766972, 31219.0, 33453.66546334603, 34581.48127778035, 34603.4809477853, 49275.26087108768, 49683.254751178036, 49720.751396242784, 49828.75085624549, 49885.0, 304130.0, 305894.0, 306747.0, 307269.0, 307819.0, 28348.85825570859, 32280.838595806872, 32735.83632081824, 32768.0, 32829.70192086627, 49040.26439603337, 51744.741276293375, 51861.0, 52111.0, 52465.0, 42386.0, 42641.57358426376, 42800.57199427966, 42927.0, 43541.12917741691, 40671.38992915049, 41535.169296614506, 41959.0, 41996.79001604972, 42960.0, 43414.34878476762, 45570.31644525268, 45951.3107303384, 46706.76646616745, 46930.76534617305, 34593.65406345904, 36053.27893442169, 37721.62278377181, 37869.0, 39515.0, 28965.275868103465, 29256.0, 29367.265818354714, 29422.264443389085, 29529.557056643738], "value": 20054.959450313432, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [432.7035980353458, 438.327167797431, 439.91201759648067, 442.42496711706326, 453.7844523851171, 18383.81616183838, 18462.815371846278, 19378.321758738446, 19442.805571944275, 19508.609827803437, 18260.817391826113, 18564.814351856512, 19118.90440547795, 19241.711374329396, 19282.807171928278, 5820.767169313222, 5877.794277200299, 5979.0, 5984.132300816379, 6129.080637904328, 5893.0, 5905.645661260317, 5940.554458415636, 5954.434328738763, 5973.940260597404, 5916.497097746696, 5927.2887253529425, 5972.9701351493395, 6250.0, 6260.718267677943, 6098.939010609926, 6203.596766210182, 6213.689315534228, 6246.781362652308, 6545.639989800559, 5903.704814759288, 5931.228940237785, 5941.287045554518, 5966.880662386728, 5968.7612495500125, 13724.382402791898, 14481.855181448156, 14492.855071449256, 14509.492167774077, 23519.294421167393, 2419.0565679385054, 2635.5387807133866, 2671.3455203475078, 2856.8000239983207, 3175.237942893712, 10240.641577544824, 10337.121344685711, 10568.207384446121, 13100.344982750825, 13322.134061286082, 2034.5930813837144, 2051.364077136078, 2063.164418410546, 2071.18188315616, 2122.182959560565, 76921.23078769197, 81644.18355816425, 81872.0, 82931.0, 83138.0, 11041.116710663127, 11184.608538701106, 11539.826902596467, 11574.363410012531, 11695.649130526097, 15777.921110394374, 15809.683806323808, 16019.439319623758, 16023.839761602234, 16029.519114426352, 8891.422057566237, 8973.0, 9015.639374424949, 9103.089691030844, 9169.495677737788, 9022.639094436281, 9034.36759426847, 9112.681056163003, 9141.817163656822, 9260.583273752698, 4877.487863774323, 4894.1679914414635, 4910.90178196434, 5017.57350625201, 5070.087384270793, 1949.1618604000132, 2003.8597298188986, 2044.0903797810129, 2074.346580827035, 2097.213544920655, 962.6967505235968, 1041.8903867381214, 1049.4437947887632, 1099.9495481814847, 1133.0991861470152, 19292.61414771725, 19898.60202795965, 19907.701384479245, 20050.197992080153, 20050.498737531678, 1018.3024628129755, 1085.5277954089995, 1088.4394536813547, 1113.7605414835687, 1122.320995797547, 10166.69499914989, 10852.945735271272, 10880.183986200907, 10917.181211409175, 11153.442327883573, 515513.0, 520098.0, 524072.0, 525249.0, 531731.0, 96708.0, 100349.49825250973, 100866.0, 100885.49557252167, 102401.48799255956, 1132.1848269246295, 1132.7224829916559, 1136.8067428537167, 1163.528770847808, 1166.311875993151, 16894.915525422293, 16960.660786784443, 17015.489535313962, 17019.82980170232, 17125.400610978555, 37034.44448333331, 37059.44410833894, 37731.62268377281, 37992.240155197294, 38027.42958855675, 58602.70698646479, 60155.0, 60609.39390606037, 60659.0, 60958.695206523684, 9157.49633770149, 9245.0, 9420.434773913314, 9549.952250238704, 9588.56851441673, 13867.508453665741, 13911.860881391056, 13966.37151328213, 14085.507007254697, 14267.857321426653, 11861.0, 12004.0, 12202.877971220174, 12552.623421297376, 12645.74708505843, 11953.820692689791, 11955.940220298842, 12013.75972480563, 12236.265824050586, 12362.938185309016, 12106.51573937068, 12460.750784984068, 12498.625041248777, 12527.310997895203, 12716.554920577735, 8658.610362533575, 9220.124088211609, 9256.72229833106, 9270.026647202216, 9492.430454172772, 8798.516081615573, 12175.573854915036, 12184.0, 12185.39073046362, 12347.876521234673], "value": 9613.45772998625, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1381.5302797049, 1552.0299812617113, 1562.8202756682979, 1746.205476508189, 1888.3768356442376, 7891.487053341529, 8118.878216826753, 8135.877961830577, 8170.346372290217, 8182.386321025932, 8147.837043259131, 8367.205115514016, 8368.288695460878, 8373.12082231366, 8415.116412776646, 2369.8104151667867, 2400.987995060022, 2408.5303365843665, 2410.95178096438, 2412.1316326122583, 2357.705286839145, 2374.27584586701, 2421.4793819328843, 2436.707595088583, 2437.756224377566, 2390.8685022323766, 2399.196269249803, 2414.420539070628, 2439.134107391868, 2440.4143005678598, 2291.3355127013315, 2338.7193536775612, 2352.8588284702887, 2354.788069073783, 2377.690900182965, 2366.8343215974887, 2409.1929203716777, 2423.333583264616, 2423.5879900416794, 2426.7573242675767, 7274.381677557414, 7400.851982960311, 8611.483311001297, 8649.308055355556, 8681.435706679045, 5017.799288028475, 5125.538701516844, 5129.179331306973, 5130.871728206787, 5131.717755523445, 3226.596675415573, 3226.8870589529256, 3296.2583418730833, 3409.573803274591, 3493.615702272748, 1130.8021096308196, 1150.711203452139, 1176.535268568919, 1189.9464524096436, 1203.0616119426772, 11382.146339024523, 11595.94202028993, 11624.593139240085, 12025.51897924082, 12041.698957525956, 4501.7524036177665, 4543.931841022388, 4570.428696412949, 4598.149342371672, 4664.813407463664, 10495.475226238657, 10518.316309439862, 10521.84217236742, 10523.736906577396, 10523.894761052445, 5275.4460781618145, 5275.4724527547705, 5286.286351342519, 5288.867778305573, 5293.153095504777, 4758.857234282977, 4782.569568738831, 4796.472388037313, 4797.328374027639, 4798.04039192163, 3784.7729136251364, 3962.8018599069933, 4007.779572123561, 4042.0, 4049.088954985105, 1173.266708307308, 1253.9937300313622, 1256.7612153690952, 1257.2393701810272, 1266.8353114095294, 924.653255029364, 1040.256216804988, 1043.3270540501335, 1046.785408991155, 1064.9563427840606, 6025.9397406026255, 6031.004884194059, 6042.728077236447, 6069.514438844882, 6225.8132256032395, 1052.7947050325113, 1058.3226734889677, 1090.2858627598778, 1091.3942761767296, 1092.0, 3968.2460332536725, 4029.3553031515403, 4039.0, 4058.6144316289906, 4060.6548443382053, 10123.797524049478, 10331.793364132674, 10431.68704938853, 10543.209259305582, 10560.630377936735, 10438.582456701646, 10551.366917984791, 10558.102561282223, 10639.0, 10695.732606684895, 8123.512589244546, 8327.333813294921, 8335.374846886507, 8341.66633334672, 8351.832963340821, 5914.526837853047, 5932.911006334994, 6000.639961602144, 6046.909296360646, 6228.968855155696, 9331.580078896603, 9350.95324523373, 9405.683204351533, 9444.433333999981, 9493.952530237304, 9197.678081267124, 9518.428894266366, 9609.135177834029, 9690.515474226402, 9698.563564639468, 8074.071481779671, 8250.38122140854, 8281.83436331282, 8489.193526614961, 8491.320694344315, 8406.369522285975, 8443.408961372645, 8463.830723385374, 8463.873041904499, 8466.322694184328, 7664.3485303747575, 7793.06483222017, 7810.3751699865015, 7917.089534703583, 7988.84022319562, 7208.603526806076, 7462.8507429850015, 7648.541087534766, 7665.118511371264, 7782.610869456617, 6959.164900212007, 6970.059042029261, 7013.509054366145, 7021.964890175516, 7027.086478757728, 5298.072837253542, 5312.0, 5391.568674505952, 5450.127979523258, 5518.365387980433, 5139.408967968731, 5175.585953123817, 5199.688018718889, 5241.842744717665, 5300.549453296513], "value": 4651.126868527273, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [363.90356555512795, 368.87827017084373, 369.06442169101325, 374.2216190324126, 379.12233180187843, 6179.691015449232, 6190.350013248606, 6217.098520714494, 6223.284322302937, 6259.311475737677, 5901.085331773582, 6036.275646922364, 6184.876302473948, 6196.194494715692, 6225.626462412247, 4784.545468180535, 4825.469198388175, 4829.130756463844, 4839.588634966032, 4839.758012099399, 4819.927701084486, 4838.225883858583, 4845.878853028685, 4850.878728031792, 4854.538818812225, 4524.163029839474, 4663.976680116594, 4794.592459640935, 4802.423709154907, 4809.086273608021, 4778.689385189951, 4781.784819683123, 4795.6403269754555, 4803.087413391444, 4805.543473370041, 4254.829806807755, 4254.851080212177, 4268.530461649216, 4270.103278311558, 4271.850485233002, 5978.55160862937, 5981.252343457068, 5991.460768530809, 5992.131140984533, 5997.130416089686, 5578.609497335188, 5590.329160500725, 5606.887862242773, 5613.07384281593, 5615.859603509904, 6410.935890641081, 6538.280789113193, 6543.312952140052, 6545.37818907203, 6549.34506549346, 4706.505816889212, 4715.08055929094, 4728.69263497875, 4734.905301893978, 4737.976310118462, 6813.829654258683, 6819.454443644497, 6821.4542836572955, 6825.726970921207, 6830.316968303229, 4743.193657078305, 4821.216150024514, 4834.734089625034, 4836.540528649773, 4837.516248375135, 4887.828925987574, 4901.656884018084, 4902.3872015998, 4910.312556242129, 4914.8771280718265, 5281.762320695578, 5445.727713614304, 5445.782168713207, 5581.944180558224, 5582.218489411485, 6531.150950376421, 6538.0192971053775, 6574.934250657528, 6578.934210657928, 6580.374864387875, 1554.0, 1629.5518732348698, 1654.3713388912377, 1673.840985106413, 1674.2716918140648, 1085.375908852413, 1086.1528008153653, 1087.8313861351503, 1094.5621751299384, 1120.288616728367, 6291.811245662638, 6332.430081292706, 6339.0, 6345.238571371373, 6359.872802544016, 6629.801105966829, 6646.8005959821285, 6647.800565983028, 6662.633555154416, 6669.566478178903, 6286.937130628727, 6322.747090116436, 6323.0199319104695, 6324.936750632527, 6328.746850125944, 3572.2676851245433, 3608.2061946371755, 3612.187257866959, 3616.3309787689363, 3616.87340943071, 6833.077534532874, 6968.233494315621, 6973.895391569131, 7002.509824312351, 7010.088688470466, 6770.830729231809, 6803.081583986099, 6807.319268073153, 6807.863842723118, 6818.522703410714, 6941.167059952838, 6976.7209311627985, 6978.232394436608, 6979.1973922999505, 6982.1272340957385, 6639.2696803352555, 6655.301193374626, 6664.66676666155, 6676.0, 6676.031975363642, 6504.252011018793, 6563.0, 6583.30875258091, 6763.830904227434, 6765.695543700447, 7128.0, 7157.0695809546505, 7166.964165179141, 7179.425645948207, 7191.9212118182695, 4707.035057813072, 4767.618590512681, 4768.427788665383, 4770.0936822003705, 4773.236282194832, 6483.189601299838, 6807.965960170365, 6814.727410903707, 6816.0, 6822.420094292041, 6465.418112369909, 6605.636689982097, 6621.834454138685, 6626.56927299724, 6626.734930602722, 6557.475401967736, 6596.736130554724, 6603.669816509251, 6611.438027767694, 6621.404073633396, 6510.056041873807, 6514.185726784152, 6521.347865213441, 6528.118703974903, 6531.314212007861, 6535.411812936668, 6609.041688954979, 6653.866922661617, 6661.700223489857, 6664.133662624022, 6442.484601231984, 6460.3862633049785, 6460.806175814733, 6465.094886715958, 6467.223933128054], "value": 4987.378995130022, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [874.59768506487, 914.8993610702821, 937.8874535055794, 944.655200851689, 952.2191802721767, 15872.285747141377, 16318.592035199126, 16320.183990800471, 16328.428505002328, 16346.83653163468, 15006.174660393674, 15048.322825472853, 15072.849271507283, 15093.849061509381, 15102.6979460411, 761.3034073822446, 902.1024081039375, 934.4346670264495, 937.4094320578026, 939.2345238630528, 930.2093220762365, 935.0789472369711, 938.1790932933683, 938.3290946972913, 940.3652534539159, 986.5659109991581, 989.2728844299434, 992.5483904823288, 992.8461088531253, 993.0466751918167, 807.0235015631064, 962.7593101724569, 975.9853602195973, 977.1205914676813, 977.2572844638055, 710.0910834132319, 716.9139703235593, 717.3042149115349, 717.4547344018531, 717.7595505505661, 14986.10083394989, 15014.474493392789, 15060.171690557016, 15089.0, 15102.169380684058, 15265.23673816316, 15318.080915145127, 15563.533094007198, 15667.608309792233, 15767.448139315069, 12020.158588898781, 12139.939300303531, 12204.694882627917, 12357.073219508573, 12371.75256494865, 4110.116324990112, 4121.8969525762095, 4124.670026397881, 4126.958730412717, 4128.380742888561, 57019.0, 57530.0, 57781.711091444275, 58107.0, 58120.0, 11595.18833681651, 11720.824187637192, 11749.29504229749, 11973.0, 12203.69490762738, 20139.496512587302, 20703.58592828135, 20737.377878663665, 20953.476163096046, 20958.0, 8711.60797764102, 8926.330525210635, 9079.182873541413, 9288.164065234161, 9310.162085412345, 4963.90072198554, 5044.924326135111, 5103.515166059218, 5206.869828254324, 5264.15773476242, 3556.0220939241917, 3603.837827297778, 3609.3503169429227, 3609.873654422083, 3613.223157021253, 655.885220086483, 663.1677245057422, 665.0323778901686, 672.6872004517923, 708.8617719544742, 693.7953303775398, 745.3701622129292, 753.8023989118338, 793.1275596843426, 808.6482380164647, 9850.162736167505, 10324.799312213237, 10381.63664271762, 10436.686899393031, 10498.790024199627, 837.7026155714756, 846.2190161465268, 850.7150104714866, 865.4331412924545, 868.8392647360132, 4680.274557443602, 4840.139000906106, 4933.112039832865, 4937.35814344133, 4965.255211718271, 65361.67319163374, 65843.67078164674, 65906.34093659098, 66559.0, 72354.0, 54307.45692543103, 56783.0, 58765.0, 58991.70504147452, 61640.38359616436, 54265.1860222097, 54477.72761136169, 54625.72687136618, 54902.17646735222, 54995.175072373946, 10260.333078349884, 10441.686749397226, 10550.788984220426, 10608.416537090225, 10621.575136994434, 37852.432213516266, 38386.80806595949, 40153.598464016155, 40412.3938140934, 41092.0, 47397.28904066373, 50151.0, 50696.49303506918, 50749.492505075956, 51335.74332128315, 13762.793558096437, 13841.169529828243, 13884.375203115682, 14115.858841411866, 14231.430742770173, 14108.717825643635, 14325.140491570539, 14535.636609084857, 14985.40058397652, 15181.16503592313, 13353.732925341634, 13708.314584270547, 13788.655283617589, 14104.788428173792, 14240.786388203978, 13154.868451315364, 13359.866401335863, 13531.72936541244, 13539.526116585872, 13935.372908218951, 12705.301208433624, 12765.74468510606, 12792.872071279167, 13100.344982751016, 13158.539451119164, 11121.443927803739, 11308.70456368271, 11452.484638191469, 11687.123465739933, 11807.645770626896, 10847.728806779895, 11520.423978801195, 11843.348615825867, 11904.880951190376, 11969.461374238354], "value": 7429.187877097585, "unit": "score"}], "name": "dromaeo_css", "value": 7529.057144753676, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [110.0, 111.0, 110.0, 110.0, 110.0, 110.0, 106.0, 110.0, 110.0, 109.0], "value": 109.6, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [155.0, 124.0, 153.0, 181.0, 126.0, 150.0, 161.0, 128.0, 186.0, 129.0], "value": 149.3, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [161.0, 161.0, 161.0, 160.0, 161.0, 162.0, 162.0, 161.0, 161.0, 162.0], "value": 161.2, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [83.0, 76.0, 73.0, 185.0, 74.0, 73.0, 74.0, 76.0, 162.0, 77.0], "value": 95.3, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [92.0, 92.0, 149.0, 91.0, 93.0, 92.0, 150.0, 92.0, 92.0, 145.0], "value": 108.8, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 117.0, 117.0, 116.0, 117.0, 116.0, 117.0, 116.0, 117.0, 116.0], "value": 116.6, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 146.0, 145.0, 146.0, 146.0, 145.0, 145.0, 147.0, 147.0, 145.0], "value": 145.8, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 94.0, 95.0, 94.0, 94.0, 95.0, 94.0, 94.0, 94.0, 94.0], "value": 94.3, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [51.0, 53.0, 52.0, 52.0, 53.0, 52.0, 56.0, 73.0, 51.0, 52.0], "value": 54.5, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [57.0, 59.0, 57.0, 57.0, 57.0, 56.0, 56.0, 56.0, 57.0, 57.0], "value": 56.9, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [71.0, 73.0, 73.0, 72.0, 75.0, 73.0, 73.0, 80.0, 73.0, 75.0], "value": 73.8, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 119.0, 116.0, 118.0, 115.0, 113.0, 114.0, 114.0, 129.0, 112.0], "value": 116.7, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [161.0, 161.0, 161.0, 157.0, 160.0, 161.0, 159.0, 158.0, 171.0, 159.0], "value": 160.8, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [67.0, 69.0, 67.0, 66.0, 66.0, 68.0, 67.0, 66.0, 66.0, 64.0], "value": 66.6, "unit": "score"}], "name": "kraken", "value": 1510.1999999999998, "alertThreshold": 2.0}]} 23:26:24 INFO - Return code: 0 23:26:24 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 23:26:24 ERROR - # TBPL SUCCESS # 23:26:24 INFO - Running post-action listener: _resource_record_post_action 23:26:24 INFO - Running post-run listener: _resource_record_post_run 23:26:25 INFO - Total resource usage - Wall time: 1184s; CPU: 13.0%; Read bytes: 0; Write bytes: 463400960; Read time: 0; Write time: 304528 23:26:25 INFO - install - Wall time: 14s; CPU: 14.0%; Read bytes: 0; Write bytes: 252796928; Read time: 0; Write time: 193256 23:26:25 INFO - run-tests - Wall time: 1171s; CPU: 13.0%; Read bytes: 0; Write bytes: 210604032; Read time: 0; Write time: 111272 23:26:25 INFO - Running post-run listener: _upload_blobber_files 23:26:25 INFO - Blob upload gear active. 23:26:25 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 23:26:25 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 23:26:25 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Mozilla-Beta', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 23:26:25 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Mozilla-Beta -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 23:26:26 INFO - (blobuploader) - INFO - Open directory for files ... 23:26:26 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 23:26:26 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 23:26:26 INFO - (blobuploader) - INFO - Uploading, attempt #1. 23:26:27 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 23:26:27 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 23:26:27 INFO - (blobuploader) - INFO - Done attempting. 23:26:27 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 23:26:27 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 23:26:27 INFO - (blobuploader) - INFO - Uploading, attempt #1. 23:26:28 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 23:26:28 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 23:26:28 INFO - (blobuploader) - INFO - Done attempting. 23:26:28 INFO - (blobuploader) - INFO - Iteration through files over. 23:26:28 INFO - Return code: 0 23:26:28 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 23:26:28 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 23:26:28 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/14c2df61d8e3442c36e39ac68e485a762178b033e5f6b08ec9e600bd72d4b7b3a033ff60a331d5a6d559a09ce75cafc5625d78b03d0806829caf6cbecdb6faaf", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/add7ac1f68ed71a15f07183a5b886b61410c4a0e44a919669bd39e925b8bd8a9e8c4184a47bd6af706e69086b63f4a504a26f219245a737228ce5bd9a908e6a5"} 23:26:28 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 23:26:28 INFO - Writing to file /builds/slave/test/properties/blobber_files 23:26:28 INFO - Contents: 23:26:28 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/14c2df61d8e3442c36e39ac68e485a762178b033e5f6b08ec9e600bd72d4b7b3a033ff60a331d5a6d559a09ce75cafc5625d78b03d0806829caf6cbecdb6faaf", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/add7ac1f68ed71a15f07183a5b886b61410c4a0e44a919669bd39e925b8bd8a9e8c4184a47bd6af706e69086b63f4a504a26f219245a737228ce5bd9a908e6a5"} 23:26:28 INFO - Running post-run listener: copy_logs_to_upload_dir 23:26:28 INFO - Copying logs to upload dir... 23:26:28 INFO - mkdir: /builds/slave/test/build/upload/logs 23:26:28 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1222.641010 ========= master_lag: 0.03 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 22 secs) (at 2016-07-02 23:26:26.876102) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-07-02 23:26:26.880319) ========= bash -c 'for file in `ls -1`; do cat $file; done' in dir /builds/slave/test/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/properties SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=923d835db2ba3686ebe126b700000192-1467524797.359105-1414661519 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/14c2df61d8e3442c36e39ac68e485a762178b033e5f6b08ec9e600bd72d4b7b3a033ff60a331d5a6d559a09ce75cafc5625d78b03d0806829caf6cbecdb6faaf", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/add7ac1f68ed71a15f07183a5b886b61410c4a0e44a919669bd39e925b8bd8a9e8c4184a47bd6af706e69086b63f4a504a26f219245a737228ce5bd9a908e6a5"} build_url:https://queue.taskcluster.net/v1/task/Aava5bJ9QCOkDkcxZYB98w/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011321 build_url: 'https://queue.taskcluster.net/v1/task/Aava5bJ9QCOkDkcxZYB98w/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/14c2df61d8e3442c36e39ac68e485a762178b033e5f6b08ec9e600bd72d4b7b3a033ff60a331d5a6d559a09ce75cafc5625d78b03d0806829caf6cbecdb6faaf", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/add7ac1f68ed71a15f07183a5b886b61410c4a0e44a919669bd39e925b8bd8a9e8c4184a47bd6af706e69086b63f4a504a26f219245a737228ce5bd9a908e6a5"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-07-02 23:26:26.912937) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-07-02 23:26:26.913539) ========= rm -f oauth.txt in dir /builds/slave/test/. (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 SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=923d835db2ba3686ebe126b700000192-1467524797.359105-1414661519 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004443 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-07-02 23:26:26.993049) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-07-02 23:26:26.993461) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-07-02 23:26:26.993792) ========= ========= Total master_lag: 0.23 =========