builder: mozilla-beta_ubuntu64_hw_test-dromaeojs-e10s-pgo slave: talos-linux64-ix-021 starttime: 1467525960.78 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.781329) ========= 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.781776) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 2 secs) (at 2016-07-02 23:06:00.782047) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 2 secs) (at 2016-07-02 23:06:02.870313) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-02 23:06:02.870638) ========= 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=df17445c3590ff7897617a0e00000225-1467524809.598142-20049566 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-07-02 23:06:03-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 46.5M=0s 2016-07-02 23:06:03 (46.5 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.127393 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-02 23:06:03.014747) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-07-02 23:06:03.015090) ========= 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=df17445c3590ff7897617a0e00000225-1467524809.598142-20049566 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.016843 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-07-02 23:06:03.070309) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-02 23:06:03.070665) ========= 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=df17445c3590ff7897617a0e00000225-1467524809.598142-20049566 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-07-02 23:06:03,385 truncating revision to first 12 chars 2016-07-02 23:06:03,385 Setting DEBUG logging. 2016-07-02 23:06:03,385 attempt 1/10 2016-07-02 23:06:03,385 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:03,916 unpacking tar archive at: mozilla-beta-5e6976a28642/testing/mozharness/ program finished with exit code 0 elapsedTime=0.968053 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-02 23:06:04.054751) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-07-02 23:06:04.055058) ========= script_repo_revision: 5e6976a28642d4d159071e14fd3251d76b9c46fa ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-07-02 23:06:04.055483) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-07-02 23:06:04.055823) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-07-02 23:06:04.087103) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 33 secs) (at 2016-07-02 23:06:04.087759) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --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-e10s', '--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=df17445c3590ff7897617a0e00000225-1467524809.598142-20049566 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 23:06:04 INFO - MultiFileLogger online at 20160702 23:06:04 in /builds/slave/test 23:06:04 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --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:04 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 23:06:04 INFO - {'append_to_log': False, 23:06:04 INFO - 'base_work_dir': '/builds/slave/test', 23:06:04 INFO - 'blob_upload_branch': 'Mozilla-Beta', 23:06:04 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 23:06:04 INFO - 'branch': 'Mozilla-Beta', 23:06:04 INFO - 'buildbot_json_path': 'buildprops.json', 23:06:04 INFO - 'config_files': ('talos/linux_config.py',), 23:06:04 INFO - 'default_actions': ('clobber', 23:06:04 INFO - 'read-buildbot-config', 23:06:04 INFO - 'download-and-extract', 23:06:04 INFO - 'populate-webroot', 23:06:04 INFO - 'create-virtualenv', 23:06:04 INFO - 'install', 23:06:04 INFO - 'run-tests'), 23:06:04 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 23:06:04 INFO - 'download_minidump_stackwalk': True, 23:06:04 INFO - 'download_symbols': 'ondemand', 23:06:04 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 23:06:04 INFO - 'tooltool.py': '/tools/tooltool.py', 23:06:04 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 23:06:04 INFO - '/tools/misc-python/virtualenv.py')}, 23:06:04 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 23:06:04 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 23:06:04 INFO - 'installer_path': 'installer.exe', 23:06:04 INFO - 'log_level': 'info', 23:06:04 INFO - 'log_name': 'talos', 23:06:04 INFO - 'log_to_console': True, 23:06:04 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 23:06:04 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 23:06:04 INFO - 'opt_config_files': (), 23:06:04 INFO - 'pip_index': False, 23:06:04 INFO - 'sps_profile': False, 23:06:04 INFO - 'sps_profile_interval': 0, 23:06:04 INFO - 'suite': 'dromaeojs-e10s', 23:06:04 INFO - 'system_bits': '32', 23:06:04 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 23:06:04 INFO - 'title': 'talos-linux64-ix-021', 23:06:04 INFO - 'tooltool_cache': '/builds/tooltool_cache', 23:06:04 INFO - 'use_talos_json': True, 23:06:04 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 23:06:04 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 23:06:04 INFO - 'work_dir': 'build'} 23:06:04 INFO - ##### 23:06:04 INFO - ##### Running clobber step. 23:06:04 INFO - ##### 23:06:04 INFO - Running pre-action listener: _resource_record_pre_action 23:06:04 INFO - Running main action method: clobber 23:06:04 INFO - rmtree: /builds/slave/test/build 23:06:04 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 23:06:04 INFO - Running post-action listener: _resource_record_post_action 23:06:04 INFO - ##### 23:06:04 INFO - ##### Running read-buildbot-config step. 23:06:04 INFO - ##### 23:06:04 INFO - Running pre-action listener: _resource_record_pre_action 23:06:04 INFO - Running main action method: read_buildbot_config 23:06:04 INFO - Using buildbot properties: 23:06:04 INFO - { 23:06:04 INFO - "project": "", 23:06:04 INFO - "product": "firefox", 23:06:04 INFO - "script_repo_revision": "production", 23:06:04 INFO - "builddir": "mozilla-beta_ubuntu64_hw_test-dromaeojs-e10s", 23:06:04 INFO - "repository": "", 23:06:04 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-beta pgo talos dromaeojs-e10s", 23:06:04 INFO - "buildid": "20160701065031", 23:06:04 INFO - "pgo_build": "True", 23:06:04 INFO - "basedir": "/builds/slave/test", 23:06:04 INFO - "buildnumber": 78, 23:06:04 INFO - "slavename": "talos-linux64-ix-021", 23:06:04 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 23:06:04 INFO - "platform": "ubuntu64_hw", 23:06:04 INFO - "scheduler": "tests-mozilla-beta-linux64-pgo-talos", 23:06:04 INFO - "branch": "mozilla-beta", 23:06:04 INFO - "repo_path": "releases/mozilla-beta", 23:06:04 INFO - "revision": "5e6976a28642d4d159071e14fd3251d76b9c46fa", 23:06:04 INFO - "stage_platform": "linux64-pgo", 23:06:04 INFO - "builduid": "c767f5fb4f57427c8722dbadfbf73505", 23:06:04 INFO - "slavebuilddir": "test" 23:06:04 INFO - } 23:06:04 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:04 INFO - Running post-action listener: _resource_record_post_action 23:06:04 INFO - ##### 23:06:04 INFO - ##### Running download-and-extract step. 23:06:04 INFO - ##### 23:06:04 INFO - Running pre-action listener: _resource_record_pre_action 23:06:04 INFO - Running main action method: download_and_extract 23:06:04 INFO - mkdir: /builds/slave/test/build/tests 23:06:04 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:04 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:04 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:04 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:04 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:04 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:13 INFO - Downloaded 1327 bytes. 23:06:13 INFO - Reading from file /builds/slave/test/build/firefox-48.0.en-US.linux-x86_64.test_packages.json 23:06:13 INFO - Using the following test package requirements: 23:06:13 INFO - {u'common': [u'firefox-48.0.en-US.linux-x86_64.common.tests.zip'], 23:06:13 INFO - u'cppunittest': [u'firefox-48.0.en-US.linux-x86_64.common.tests.zip', 23:06:13 INFO - u'firefox-48.0.en-US.linux-x86_64.cppunittest.tests.zip'], 23:06:13 INFO - u'gtest': [u'firefox-48.0.en-US.linux-x86_64.common.tests.zip', 23:06:13 INFO - u'firefox-48.0.en-US.linux-x86_64.gtest.tests.zip'], 23:06:13 INFO - u'jittest': [u'firefox-48.0.en-US.linux-x86_64.common.tests.zip', 23:06:13 INFO - u'jsshell-linux-x86_64.zip'], 23:06:13 INFO - u'mochitest': [u'firefox-48.0.en-US.linux-x86_64.common.tests.zip', 23:06:13 INFO - u'firefox-48.0.en-US.linux-x86_64.mochitest.tests.zip'], 23:06:13 INFO - u'mozbase': [u'firefox-48.0.en-US.linux-x86_64.common.tests.zip'], 23:06:13 INFO - u'reftest': [u'firefox-48.0.en-US.linux-x86_64.common.tests.zip', 23:06:13 INFO - u'firefox-48.0.en-US.linux-x86_64.reftest.tests.zip'], 23:06:13 INFO - u'talos': [u'firefox-48.0.en-US.linux-x86_64.common.tests.zip', 23:06:13 INFO - u'firefox-48.0.en-US.linux-x86_64.talos.tests.zip'], 23:06:13 INFO - u'web-platform': [u'firefox-48.0.en-US.linux-x86_64.common.tests.zip', 23:06:13 INFO - u'firefox-48.0.en-US.linux-x86_64.web-platform.tests.zip'], 23:06:13 INFO - u'xpcshell': [u'firefox-48.0.en-US.linux-x86_64.common.tests.zip', 23:06:13 INFO - u'firefox-48.0.en-US.linux-x86_64.xpcshell.tests.zip']} 23:06:13 INFO - Downloading packages: [u'firefox-48.0.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 23:06:13 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:13 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:13 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:13 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:13 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:13 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:14 INFO - Downloaded 24236612 bytes. 23:06:14 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:14 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:15 INFO - Return code: 0 23:06:15 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:15 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:15 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:15 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:15 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:15 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:15 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:17 INFO - Downloaded 24236612 bytes. 23:06:17 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:17 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:19 INFO - Return code: 0 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 - 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:19 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:19 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:19 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:19 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:20 INFO - Downloaded 10840145 bytes. 23:06:20 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:20 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:20 INFO - Return code: 0 23:06:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 23:06:20 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:20 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:20 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:20 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:20 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:21 INFO - Downloaded 56023399 bytes. 23:06:21 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:21 INFO - mkdir: /builds/slave/test/properties 23:06:21 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 23:06:21 INFO - Writing to file /builds/slave/test/properties/build_url 23:06:21 INFO - Contents: 23:06:21 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:22 INFO - Running post-action listener: _resource_record_post_action 23:06:22 INFO - Running post-action listener: set_extra_try_arguments 23:06:22 INFO - ##### 23:06:22 INFO - ##### Running populate-webroot step. 23:06:22 INFO - ##### 23:06:22 INFO - Running pre-action listener: _resource_record_pre_action 23:06:22 INFO - Running main action method: populate_webroot 23:06:22 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 23:06:22 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 23:06:22 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 23:06:22 INFO - '--tppagecycles', 23:06:22 INFO - '7'], 23:06:22 INFO - 'tests': ['tsvgm']}}, 23:06:22 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 23:06:22 INFO - 'tests': ['tresize', 'tcanvasmark']}, 23:06:22 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 23:06:22 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 23:06:22 INFO - 'tests': ['dromaeo_css', 'kraken']}, 23:06:22 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 23:06:22 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 23:06:22 INFO - 'talos_options': ['--disable-e10s'], 23:06:22 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 23:06:22 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 23:06:22 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 23:06:22 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 23:06:22 INFO - 'talos_options': ['--disable-e10s'], 23:06:22 INFO - 'tests': ['damp', 'tps']}, 23:06:22 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 23:06:22 INFO - 'tests': ['damp', 'tps']}, 23:06:22 INFO - 'g3': {'talos_options': ['--disable-e10s'], 23:06:22 INFO - 'tests': ['dromaeo_dom']}, 23:06:22 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 23:06:22 INFO - 'other': {'talos_options': ['--disable-e10s'], 23:06:22 INFO - 'tests': ['a11yr', 23:06:22 INFO - 'ts_paint', 23:06:22 INFO - 'tpaint', 23:06:22 INFO - 'sessionrestore', 23:06:22 INFO - 'sessionrestore_no_auto_restore', 23:06:22 INFO - 'tabpaint']}, 23:06:22 INFO - 'other-e10s': {'tests': ['a11yr', 23:06:22 INFO - 'ts_paint', 23:06:22 INFO - 'tpaint', 23:06:22 INFO - 'sessionrestore', 23:06:22 INFO - 'sessionrestore_no_auto_restore', 23:06:22 INFO - 'tabpaint']}, 23:06:22 INFO - 'other-e10s_l64': {'tests': ['a11yr', 23:06:22 INFO - 'ts_paint', 23:06:22 INFO - 'tpaint', 23:06:22 INFO - 'sessionrestore', 23:06:22 INFO - 'sessionrestore_no_auto_restore', 23:06:22 INFO - 'tabpaint']}, 23:06:22 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 23:06:22 INFO - 'ts_paint', 23:06:22 INFO - 'tpaint', 23:06:22 INFO - 'sessionrestore', 23:06:22 INFO - 'sessionrestore_no_auto_restore', 23:06:22 INFO - 'tabpaint']}, 23:06:22 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 23:06:22 INFO - 'tests': ['a11yr', 23:06:22 INFO - 'ts_paint', 23:06:22 INFO - 'tpaint', 23:06:22 INFO - 'sessionrestore', 23:06:22 INFO - 'sessionrestore_no_auto_restore', 23:06:22 INFO - 'tabpaint']}, 23:06:22 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 23:06:22 INFO - 'tests': ['a11yr', 23:06:22 INFO - 'ts_paint', 23:06:22 INFO - 'tpaint', 23:06:22 INFO - 'sessionrestore', 23:06:22 INFO - 'sessionrestore_no_auto_restore', 23:06:22 INFO - 'tabpaint']}, 23:06:22 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 23:06:22 INFO - 'tests': ['tsvgx', 23:06:22 INFO - 'tsvgr_opacity', 23:06:22 INFO - 'tart', 23:06:22 INFO - 'tscrollx', 23:06:22 INFO - 'cart']}, 23:06:22 INFO - 'svgr-e10s': {'tests': ['tsvgx', 23:06:22 INFO - 'tsvgr_opacity', 23:06:22 INFO - 'tart', 23:06:22 INFO - 'tscrollx', 23:06:22 INFO - 'cart']}, 23:06:22 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 23:06:22 INFO - 'talos_options': ['--disable-e10s'], 23:06:22 INFO - 'tests': ['tp5o']}, 23:06:22 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 23:06:22 INFO - 'tests': ['tp5o']}, 23:06:22 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 23:06:22 INFO - 'talos_options': ['--disable-e10s', 23:06:22 INFO - '--xperf_path', 23:06:22 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 23:06:22 INFO - 'tests': ['tp5n']}, 23:06:22 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 23:06:22 INFO - 'talos_options': ['--xperf_path', 23:06:22 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 23:06:22 INFO - 'tests': ['tp5n']}}, 23:06:22 INFO - 'talos.zip': {'path': '', 23:06:22 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 23:06:22 INFO - Running post-action listener: _resource_record_post_action 23:06:22 INFO - ##### 23:06:22 INFO - ##### Running create-virtualenv step. 23:06:22 INFO - ##### 23:06:22 INFO - Running pre-action listener: _resource_record_pre_action 23:06:22 INFO - Running main action method: create_virtualenv 23:06:22 INFO - Creating virtualenv /builds/slave/test/build/venv 23:06:22 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:22 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 23:06:22 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 23:06:22 INFO - Using real prefix '/usr' 23:06:22 INFO - New python executable in /builds/slave/test/build/venv/bin/python 23:06:22 INFO - Installing distribute.............................................................................................................................................................................................done. 23:06:25 INFO - Installing pip.................done. 23:06:25 INFO - Return code: 0 23:06:25 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 23:06:25 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:25 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 23:06:25 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:06:25 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:25 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 23:06:25 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:06:25 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 0x7f3d17217f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19728a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1a3e7d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1acd640>, '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 0x1ace540>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1ace9d0>, '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': 'df17445c3590ff7897617a0e00000225-1467524809.598142-20049566', '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:25 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:25 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:25 INFO - Using env: {'DISPLAY': ':0', 23:06:25 INFO - 'HOME': '/home/cltbld', 23:06:25 INFO - 'LANG': 'en_US.UTF-8', 23:06:25 INFO - 'LANGUAGE': 'en_US:en', 23:06:25 INFO - 'LOGNAME': 'cltbld', 23:06:25 INFO - 'MAIL': '/var/mail/cltbld', 23:06:25 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:06:25 INFO - 'MOZ_NO_REMOTE': '1', 23:06:25 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 23:06:25 INFO - 'NO_EM_RESTART': '1', 23:06:25 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 23:06:25 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 23:06:25 INFO - 'PWD': '/builds/slave/test', 23:06:25 INFO - 'SHELL': '/bin/bash', 23:06:25 INFO - 'SHLVL': '1', 23:06:25 INFO - 'TERM': 'linux', 23:06:25 INFO - 'TMOUT': '86400', 23:06:25 INFO - 'USER': 'cltbld', 23:06:25 INFO - 'XDG_SESSION_COOKIE': 'df17445c3590ff7897617a0e00000225-1467524809.598142-20049566', 23:06:25 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:06:25 INFO - '_': '/tools/buildbot/bin/python'} 23:06:25 INFO - Ignoring indexes: https://pypi.python.org/simple/ 23:06:25 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:25 INFO - Cleaning up... 23:06:25 INFO - Return code: 0 23:06:25 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 23:06:25 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:25 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 23:06:25 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:06:25 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:25 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 23:06:25 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:06:25 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 0x7f3d17217f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19728a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1a3e7d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1acd640>, '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 0x1ace540>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1ace9d0>, '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': 'df17445c3590ff7897617a0e00000225-1467524809.598142-20049566', '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:25 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:25 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:25 INFO - Using env: {'DISPLAY': ':0', 23:06:25 INFO - 'HOME': '/home/cltbld', 23:06:25 INFO - 'LANG': 'en_US.UTF-8', 23:06:25 INFO - 'LANGUAGE': 'en_US:en', 23:06:25 INFO - 'LOGNAME': 'cltbld', 23:06:25 INFO - 'MAIL': '/var/mail/cltbld', 23:06:25 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:06:25 INFO - 'MOZ_NO_REMOTE': '1', 23:06:25 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 23:06:25 INFO - 'NO_EM_RESTART': '1', 23:06:25 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 23:06:25 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 23:06:25 INFO - 'PWD': '/builds/slave/test', 23:06:25 INFO - 'SHELL': '/bin/bash', 23:06:25 INFO - 'SHLVL': '1', 23:06:25 INFO - 'TERM': 'linux', 23:06:25 INFO - 'TMOUT': '86400', 23:06:25 INFO - 'USER': 'cltbld', 23:06:25 INFO - 'XDG_SESSION_COOKIE': 'df17445c3590ff7897617a0e00000225-1467524809.598142-20049566', 23:06:25 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:06:25 INFO - '_': '/tools/buildbot/bin/python'} 23:06:25 INFO - Ignoring indexes: https://pypi.python.org/simple/ 23:06:25 INFO - Downloading/unpacking psutil>=0.7.1 23:06:25 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:25 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:25 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:25 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:25 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:25 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:27 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 23:06:27 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 23:06:27 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 23:06:27 INFO - Installing collected packages: psutil 23:06:27 INFO - Running setup.py install for psutil 23:06:27 INFO - building 'psutil._psutil_linux' extension 23:06:27 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:27 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:27 INFO - building 'psutil._psutil_posix' extension 23:06:27 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:27 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:27 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 23:06:27 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 23:06:27 INFO - Successfully installed psutil 23:06:27 INFO - Cleaning up... 23:06:28 INFO - Return code: 0 23:06:28 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 23:06:28 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:28 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 23:06:28 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:06:28 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:28 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 23:06:28 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:06:28 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 0x7f3d17217f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19728a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1a3e7d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1acd640>, '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 0x1ace540>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1ace9d0>, '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': 'df17445c3590ff7897617a0e00000225-1467524809.598142-20049566', '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:28 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:28 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:28 INFO - Using env: {'DISPLAY': ':0', 23:06:28 INFO - 'HOME': '/home/cltbld', 23:06:28 INFO - 'LANG': 'en_US.UTF-8', 23:06:28 INFO - 'LANGUAGE': 'en_US:en', 23:06:28 INFO - 'LOGNAME': 'cltbld', 23:06:28 INFO - 'MAIL': '/var/mail/cltbld', 23:06:28 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:06:28 INFO - 'MOZ_NO_REMOTE': '1', 23:06:28 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 23:06:28 INFO - 'NO_EM_RESTART': '1', 23:06:28 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 23:06:28 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 23:06:28 INFO - 'PWD': '/builds/slave/test', 23:06:28 INFO - 'SHELL': '/bin/bash', 23:06:28 INFO - 'SHLVL': '1', 23:06:28 INFO - 'TERM': 'linux', 23:06:28 INFO - 'TMOUT': '86400', 23:06:28 INFO - 'USER': 'cltbld', 23:06:28 INFO - 'XDG_SESSION_COOKIE': 'df17445c3590ff7897617a0e00000225-1467524809.598142-20049566', 23:06:28 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:06:28 INFO - '_': '/tools/buildbot/bin/python'} 23:06:28 INFO - Ignoring indexes: https://pypi.python.org/simple/ 23:06:28 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 23:06:28 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:28 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:28 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:28 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:28 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:28 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:30 INFO - Downloading mozsystemmonitor-0.0.tar.gz 23:06:30 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 23:06:30 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:30 INFO - Installing collected packages: mozsystemmonitor 23:06:30 INFO - Running setup.py install for mozsystemmonitor 23:06:30 INFO - Successfully installed mozsystemmonitor 23:06:30 INFO - Cleaning up... 23:06:30 INFO - Return code: 0 23:06:30 INFO - Installing blobuploader==1.2.4 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', '--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 0x7f3d17217f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19728a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1a3e7d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1acd640>, '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 0x1ace540>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1ace9d0>, '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': 'df17445c3590ff7897617a0e00000225-1467524809.598142-20049566', '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', '--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:30 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: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': 'df17445c3590ff7897617a0e00000225-1467524809.598142-20049566', 23:06:30 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:06:30 INFO - '_': '/tools/buildbot/bin/python'} 23:06:30 INFO - Ignoring indexes: https://pypi.python.org/simple/ 23:06:30 INFO - Downloading/unpacking blobuploader==1.2.4 23:06:30 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:30 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:30 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:30 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:30 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:30 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 - Downloading blobuploader-1.2.4.tar.gz 23:06:32 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 23:06:32 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 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:32 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 23:06:32 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 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:33 INFO - Downloading docopt-0.6.1.tar.gz 23:06:33 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 23:06:33 INFO - Installing collected packages: blobuploader, requests, docopt 23:06:33 INFO - Running setup.py install for blobuploader 23:06:33 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 23:06:33 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 23:06:33 INFO - Running setup.py install for requests 23:06:33 INFO - Running setup.py install for docopt 23:06:33 INFO - Successfully installed blobuploader requests docopt 23:06:33 INFO - Cleaning up... 23:06:33 INFO - Return code: 0 23:06:33 INFO - Installing None into virtualenv /builds/slave/test/build/venv 23:06:33 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:33 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 23:06:33 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:06:33 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:33 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 23:06:33 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:06:33 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 0x7f3d17217f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19728a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1a3e7d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1acd640>, '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 0x1ace540>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1ace9d0>, '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': 'df17445c3590ff7897617a0e00000225-1467524809.598142-20049566', '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:33 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:33 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:33 INFO - Using env: {'DISPLAY': ':0', 23:06:33 INFO - 'HOME': '/home/cltbld', 23:06:33 INFO - 'LANG': 'en_US.UTF-8', 23:06:33 INFO - 'LANGUAGE': 'en_US:en', 23:06:33 INFO - 'LOGNAME': 'cltbld', 23:06:33 INFO - 'MAIL': '/var/mail/cltbld', 23:06:33 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:06:33 INFO - 'MOZ_NO_REMOTE': '1', 23:06:33 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 23:06:33 INFO - 'NO_EM_RESTART': '1', 23:06:33 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 23:06:33 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 23:06:33 INFO - 'PWD': '/builds/slave/test', 23:06:33 INFO - 'SHELL': '/bin/bash', 23:06:33 INFO - 'SHLVL': '1', 23:06:33 INFO - 'TERM': 'linux', 23:06:33 INFO - 'TMOUT': '86400', 23:06:33 INFO - 'USER': 'cltbld', 23:06:33 INFO - 'XDG_SESSION_COOKIE': 'df17445c3590ff7897617a0e00000225-1467524809.598142-20049566', 23:06:33 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:06:33 INFO - '_': '/tools/buildbot/bin/python'} 23:06:34 INFO - Ignoring indexes: https://pypi.python.org/simple/ 23:06:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 23:06:34 INFO - Running setup.py (path:/tmp/pip-Bv9aA7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 23:06:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 23:06:34 INFO - Running setup.py (path:/tmp/pip-E55HPH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 23:06:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 23:06:34 INFO - Running setup.py (path:/tmp/pip-tFfTmG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 23:06:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 23:06:34 INFO - Running setup.py (path:/tmp/pip-ZKUIuE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 23:06:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 23:06:34 INFO - Running setup.py (path:/tmp/pip-OyUDKC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 23:06:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 23:06:34 INFO - Running setup.py (path:/tmp/pip-Zb5opJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 23:06:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 23:06:34 INFO - Running setup.py (path:/tmp/pip-_DGEUD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 23:06:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 23:06:34 INFO - Running setup.py (path:/tmp/pip-he5nIV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 23:06:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 23:06:34 INFO - Running setup.py (path:/tmp/pip-sZBKSW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 23:06:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 23:06:34 INFO - Running setup.py (path:/tmp/pip-JIM7l1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 23:06:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 23:06:34 INFO - Running setup.py (path:/tmp/pip-0b9yiG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 23:06:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 23:06:34 INFO - Running setup.py (path:/tmp/pip-3MKOVm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 23:06:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 23:06:34 INFO - Running setup.py (path:/tmp/pip-PTDJM4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 23:06:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 23:06:34 INFO - Running setup.py (path:/tmp/pip-18AoDK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 23:06:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 23:06:35 INFO - Running setup.py (path:/tmp/pip-IOFSwl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 23:06:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 23:06:35 INFO - Running setup.py (path:/tmp/pip-7TGwK3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 23:06:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 23:06:35 INFO - Running setup.py (path:/tmp/pip-KEaR3m-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 23:06:35 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 23:06:35 INFO - Running setup.py install for manifestparser 23:06:35 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 23:06:35 INFO - Running setup.py install for mozcrash 23:06:35 INFO - Running setup.py install for mozdebug 23:06:35 INFO - Running setup.py install for mozdevice 23:06:35 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 23:06:35 INFO - Installing dm script to /builds/slave/test/build/venv/bin 23:06:35 INFO - Running setup.py install for mozfile 23:06:35 INFO - Running setup.py install for mozhttpd 23:06:35 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 23:06:35 INFO - Running setup.py install for mozinfo 23:06:35 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 23:06:35 INFO - Running setup.py install for mozInstall 23:06:36 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 23:06:36 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 23:06:36 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 23:06:36 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 23:06:36 INFO - Running setup.py install for mozleak 23:06:36 INFO - Running setup.py install for mozlog 23:06:36 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 23:06:36 INFO - Running setup.py install for moznetwork 23:06:36 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 23:06:36 INFO - Running setup.py install for mozprocess 23:06:36 INFO - Running setup.py install for mozprofile 23:06:36 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 23:06:36 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 23:06:36 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 23:06:36 INFO - Running setup.py install for mozrunner 23:06:36 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 23:06:36 INFO - Running setup.py install for mozscreenshot 23:06:36 INFO - Running setup.py install for moztest 23:06:36 INFO - Running setup.py install for mozversion 23:06:37 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 23:06:37 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 23:06:37 INFO - Cleaning up... 23:06:37 INFO - Return code: 0 23:06:37 INFO - Installing None 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', '-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 0x7f3d17217f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19728a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1a3e7d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1acd640>, '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 0x1ace540>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1ace9d0>, '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': 'df17445c3590ff7897617a0e00000225-1467524809.598142-20049566', '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', '-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:37 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: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': 'df17445c3590ff7897617a0e00000225-1467524809.598142-20049566', 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 - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 23:06:37 INFO - Running setup.py (path:/tmp/pip-T4xv31-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 23:06:37 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:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 23:06:37 INFO - Running setup.py (path:/tmp/pip-qHjrG3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 23:06:37 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:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 23:06:37 INFO - Running setup.py (path:/tmp/pip-s_5tg9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 23:06:37 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:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 23:06:37 INFO - Running setup.py (path:/tmp/pip-DGzJ16-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 23:06:37 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:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 23:06:37 INFO - Running setup.py (path:/tmp/pip-JtEnlF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 23:06:37 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:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 23:06:37 INFO - Running setup.py (path:/tmp/pip-OvijA3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 23:06:37 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:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 23:06:37 INFO - Running setup.py (path:/tmp/pip-EKFTfO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 23:06:37 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:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 23:06:37 INFO - Running setup.py (path:/tmp/pip-HXfejJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 23:06:37 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:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 23:06:37 INFO - Running setup.py (path:/tmp/pip-htpiVL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 23:06:37 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:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 23:06:37 INFO - Running setup.py (path:/tmp/pip-TMdTO0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 23:06:37 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:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 23:06:37 INFO - Running setup.py (path:/tmp/pip-6c0Fml-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 23:06:38 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:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 23:06:38 INFO - Running setup.py (path:/tmp/pip-8QlwTM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 23:06:38 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:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 23:06:38 INFO - Running setup.py (path:/tmp/pip-QkREZj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 23:06:38 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:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 23:06:38 INFO - Running setup.py (path:/tmp/pip-9fqLJl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 23:06:38 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:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 23:06:38 INFO - Running setup.py (path:/tmp/pip-dPcHkF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 23:06:38 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:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 23:06:38 INFO - Running setup.py (path:/tmp/pip-iIEZZh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 23:06:38 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:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 23:06:38 INFO - Running setup.py (path:/tmp/pip-gtKlnh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 23:06:38 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:38 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:38 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:38 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:38 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:38 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:38 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 23:06:38 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:38 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:38 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:38 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:38 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:38 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 blessings-1.6.tar.gz 23:06:40 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 23:06:40 INFO - Installing collected packages: blessings 23:06:40 INFO - Running setup.py install for blessings 23:06:40 INFO - Successfully installed blessings 23:06:40 INFO - Cleaning up... 23:06:40 INFO - Return code: 0 23:06:40 INFO - Done creating virtualenv /builds/slave/test/build/venv. 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 - Current package versions: 23:06:40 INFO - argparse == 1.2.1 23:06:40 INFO - blessings == 1.6 23:06:40 INFO - blobuploader == 1.2.4 23:06:40 INFO - docopt == 0.6.1 23:06:40 INFO - manifestparser == 1.1 23:06:40 INFO - mozInstall == 1.12 23:06:40 INFO - mozcrash == 0.17 23:06:40 INFO - mozdebug == 0.1 23:06:40 INFO - mozdevice == 0.48 23:06:40 INFO - mozfile == 1.2 23:06:40 INFO - mozhttpd == 0.7 23:06:40 INFO - mozinfo == 0.9 23:06:40 INFO - mozleak == 0.1 23:06:40 INFO - mozlog == 3.1 23:06:40 INFO - moznetwork == 0.27 23:06:40 INFO - mozprocess == 0.22 23:06:40 INFO - mozprofile == 0.28 23:06:40 INFO - mozrunner == 6.11 23:06:40 INFO - mozscreenshot == 0.1 23:06:40 INFO - mozsystemmonitor == 0.0 23:06:40 INFO - moztest == 0.7 23:06:40 INFO - mozversion == 1.4 23:06:40 INFO - psutil == 3.1.1 23:06:40 INFO - requests == 1.2.3 23:06:40 INFO - wsgiref == 0.1.2 23:06:40 INFO - Installing None into virtualenv /builds/slave/test/build/venv 23:06:40 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:40 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 23:06:40 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:06:40 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:40 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 23:06:40 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:06:40 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 0x7f3d17217f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19728a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1a3e7d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1acd640>, '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 0x1ace540>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1ace9d0>, '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': 'df17445c3590ff7897617a0e00000225-1467524809.598142-20049566', '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:40 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:40 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:40 INFO - Using env: {'DISPLAY': ':0', 23:06:40 INFO - 'HOME': '/home/cltbld', 23:06:40 INFO - 'LANG': 'en_US.UTF-8', 23:06:40 INFO - 'LANGUAGE': 'en_US:en', 23:06:40 INFO - 'LOGNAME': 'cltbld', 23:06:40 INFO - 'MAIL': '/var/mail/cltbld', 23:06:40 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:06:40 INFO - 'MOZ_NO_REMOTE': '1', 23:06:40 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 23:06:40 INFO - 'NO_EM_RESTART': '1', 23:06:40 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 23:06:40 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 23:06:40 INFO - 'PWD': '/builds/slave/test', 23:06:40 INFO - 'SHELL': '/bin/bash', 23:06:40 INFO - 'SHLVL': '1', 23:06:40 INFO - 'TERM': 'linux', 23:06:40 INFO - 'TMOUT': '86400', 23:06:40 INFO - 'USER': 'cltbld', 23:06:40 INFO - 'XDG_SESSION_COOKIE': 'df17445c3590ff7897617a0e00000225-1467524809.598142-20049566', 23:06:40 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:06:40 INFO - '_': '/tools/buildbot/bin/python'} 23:06:40 INFO - Ignoring indexes: https://pypi.python.org/simple/ 23:06:41 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:41 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:41 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:41 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:41 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:41 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:41 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:41 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:41 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:41 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:41 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:41 INFO - Cleaning up... 23:06:41 INFO - Return code: 0 23:06:41 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 23:06:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 23:06:41 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 23:06:41 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:06:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 23:06:41 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 23:06:41 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:06:41 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 0x7f3d17217f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19728a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1a3e7d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1acd640>, '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 0x1ace540>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1ace9d0>, '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': 'df17445c3590ff7897617a0e00000225-1467524809.598142-20049566', '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:41 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:41 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:41 INFO - Using env: {'DISPLAY': ':0', 23:06:41 INFO - 'HOME': '/home/cltbld', 23:06:41 INFO - 'LANG': 'en_US.UTF-8', 23:06:41 INFO - 'LANGUAGE': 'en_US:en', 23:06:41 INFO - 'LOGNAME': 'cltbld', 23:06:41 INFO - 'MAIL': '/var/mail/cltbld', 23:06:41 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:06:41 INFO - 'MOZ_NO_REMOTE': '1', 23:06:41 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 23:06:41 INFO - 'NO_EM_RESTART': '1', 23:06:41 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 23:06:41 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 23:06:41 INFO - 'PWD': '/builds/slave/test', 23:06:41 INFO - 'SHELL': '/bin/bash', 23:06:41 INFO - 'SHLVL': '1', 23:06:41 INFO - 'TERM': 'linux', 23:06:41 INFO - 'TMOUT': '86400', 23:06:41 INFO - 'USER': 'cltbld', 23:06:41 INFO - 'XDG_SESSION_COOKIE': 'df17445c3590ff7897617a0e00000225-1467524809.598142-20049566', 23:06:41 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:06:41 INFO - '_': '/tools/buildbot/bin/python'} 23:06:41 INFO - Ignoring indexes: https://pypi.python.org/simple/ 23:06:41 INFO - Downloading/unpacking jsonschema 23:06:41 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 23:06:41 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 23:06:41 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 23:06:41 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 23:06:41 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 23:06:41 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 23:06:43 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 23:06:43 INFO - Downloading/unpacking functools32 (from jsonschema) 23:06:43 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 23:06:43 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 23:06:43 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 23:06:43 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 23:06:43 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 23:06:43 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 23:06:43 INFO - Downloading functools32-3.2.3-2.tar.gz 23:06:43 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 23:06:43 INFO - warning: no files found matching '*.txt' 23:06:43 INFO - no previously-included directories found matching 'build' 23:06:43 INFO - no previously-included directories found matching 'dist' 23:06:43 INFO - no previously-included directories found matching '.git*' 23:06:43 INFO - Installing collected packages: jsonschema, functools32 23:06:43 INFO - Running setup.py install for functools32 23:06:43 INFO - warning: no files found matching '*.txt' 23:06:43 INFO - no previously-included directories found matching 'build' 23:06:43 INFO - no previously-included directories found matching 'dist' 23:06:43 INFO - no previously-included directories found matching '.git*' 23:06:43 INFO - Successfully installed jsonschema functools32 23:06:43 INFO - Cleaning up... 23:06:43 INFO - Return code: 0 23:06:43 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 23:06:43 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:43 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 23:06:43 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:06:43 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:43 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 23:06:43 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:06:43 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 0x7f3d17217f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19728a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1a3e7d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1acd640>, '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 0x1ace540>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1ace9d0>, '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': 'df17445c3590ff7897617a0e00000225-1467524809.598142-20049566', '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:43 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:43 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:43 INFO - Using env: {'DISPLAY': ':0', 23:06:43 INFO - 'HOME': '/home/cltbld', 23:06:43 INFO - 'LANG': 'en_US.UTF-8', 23:06:43 INFO - 'LANGUAGE': 'en_US:en', 23:06:43 INFO - 'LOGNAME': 'cltbld', 23:06:43 INFO - 'MAIL': '/var/mail/cltbld', 23:06:43 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:06:43 INFO - 'MOZ_NO_REMOTE': '1', 23:06:43 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 23:06:43 INFO - 'NO_EM_RESTART': '1', 23:06:43 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 23:06:43 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 23:06:43 INFO - 'PWD': '/builds/slave/test', 23:06:43 INFO - 'SHELL': '/bin/bash', 23:06:43 INFO - 'SHLVL': '1', 23:06:43 INFO - 'TERM': 'linux', 23:06:43 INFO - 'TMOUT': '86400', 23:06:43 INFO - 'USER': 'cltbld', 23:06:43 INFO - 'XDG_SESSION_COOKIE': 'df17445c3590ff7897617a0e00000225-1467524809.598142-20049566', 23:06:43 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:06:43 INFO - '_': '/tools/buildbot/bin/python'} 23:06:43 INFO - Ignoring indexes: https://pypi.python.org/simple/ 23:06:43 INFO - Downloading/unpacking flake8 23:06:43 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 23:06:43 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 23:06:43 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 23:06:43 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 23:06:43 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 23:06:43 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 23:06:45 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 23:06:45 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 23:06:45 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:45 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:45 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:45 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:45 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:45 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:45 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 23:06:45 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 23:06:45 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:45 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:45 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:45 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:45 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:45 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:46 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 23:06:46 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:46 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:46 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:46 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:46 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:46 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:46 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 23:06:46 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 23:06:46 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 23:06:46 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 23:06:46 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 23:06:46 INFO - no previously-included directories found matching 'docs/_build' 23:06:46 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 23:06:46 INFO - Running setup.py install for pep8 23:06:46 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 23:06:46 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 23:06:46 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 23:06:46 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 23:06:46 INFO - no previously-included directories found matching 'docs/_build' 23:06:46 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 23:06:46 INFO - Successfully installed flake8 mccabe pyflakes pep8 23:06:46 INFO - Cleaning up... 23:06:46 INFO - Return code: 0 23:06:46 INFO - Running post-action listener: _resource_record_post_action 23:06:46 INFO - Running post-action listener: _start_resource_monitoring 23:06:46 INFO - Starting resource monitoring. 23:06:46 INFO - ##### 23:06:46 INFO - ##### Running install step. 23:06:46 INFO - ##### 23:06:46 INFO - Running pre-action listener: _resource_record_pre_action 23:06:46 INFO - Running main action method: install 23:06:46 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 23:06:46 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 23:06:46 INFO - Reading from file tmpfile_stdout 23:06:46 INFO - Detecting whether we're running mozinstall >=1.0... 23:06:46 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 23:06:46 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 23:06:46 INFO - Reading from file tmpfile_stdout 23:06:46 INFO - Output received: 23:06:46 INFO - Usage: mozinstall [options] installer 23:06:46 INFO - Options: 23:06:46 INFO - -h, --help show this help message and exit 23:06:46 INFO - -d DEST, --destination=DEST 23:06:46 INFO - Directory to install application into. [default: 23:06:46 INFO - "/builds/slave/test"] 23:06:46 INFO - --app=APP Application being installed. [default: firefox] 23:06:46 INFO - mkdir: /builds/slave/test/build/application 23:06:46 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:46 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:07:01 INFO - Reading from file tmpfile_stdout 23:07:01 INFO - Output received: 23:07:01 INFO - /builds/slave/test/build/application/firefox/firefox 23:07:01 INFO - Running post-action listener: _resource_record_post_action 23:07:01 INFO - ##### 23:07:01 INFO - ##### Running run-tests step. 23:07:01 INFO - ##### 23:07:01 INFO - Running pre-action listener: _resource_record_pre_action 23:07:01 INFO - Running main action method: run_tests 23:07:01 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 23:07:01 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 23:07:01 INFO - Python 2.7.3 23:07:01 INFO - Return code: 0 23:07:01 INFO - grabbing minidump binary from tooltool 23:07:01 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:07:01 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 0x1acd640>, '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 0x1ace540>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1ace9d0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 23:07:01 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:07:01 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:07:01 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 23:07:01 INFO - Return code: 0 23:07:01 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 23:07:01 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 23:07:01 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 23:07:01 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 23:07:01 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 23:07:01 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 23:07:01 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 23:07:02 INFO - Return code: 0 23:07:02 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-e10s', '--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-021', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] in /builds/slave/test/build 23:07:02 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-e10s --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-021 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log 23:07:02 INFO - Using env: {'DISPLAY': ':0', 23:07:02 INFO - 'HOME': '/home/cltbld', 23:07:02 INFO - 'LANG': 'en_US.UTF-8', 23:07:02 INFO - 'LANGUAGE': 'en_US:en', 23:07:02 INFO - 'LOGNAME': 'cltbld', 23:07:02 INFO - 'MAIL': '/var/mail/cltbld', 23:07:02 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 23:07:02 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 23:07:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:07:02 INFO - 'MOZ_NO_REMOTE': '1', 23:07:02 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 23:07:02 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 23:07:02 INFO - 'NO_EM_RESTART': '1', 23:07:02 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 23:07:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 23:07:02 INFO - 'PWD': '/builds/slave/test', 23:07:02 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 23:07:02 INFO - 'SHELL': '/bin/bash', 23:07:02 INFO - 'SHLVL': '1', 23:07:02 INFO - 'TERM': 'linux', 23:07:02 INFO - 'TMOUT': '86400', 23:07:02 INFO - 'USER': 'cltbld', 23:07:02 INFO - 'XDG_SESSION_COOKIE': 'df17445c3590ff7897617a0e00000225-1467524809.598142-20049566', 23:07:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:07:02 INFO - '_': '/tools/buildbot/bin/python'} 23:07:02 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Beta', '--suite', 'dromaeojs-e10s', '--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-021', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] with output_timeout 3600 23:07:02 INFO - mozversion application_buildid: 20160701065031 23:07:02 INFO - mozversion application_changeset: 5e6976a28642d4d159071e14fd3251d76b9c46fa 23:07:02 INFO - mozversion application_display_name: Firefox 23:07:02 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 23:07:02 INFO - mozversion application_name: Firefox 23:07:02 INFO - mozversion application_remotingname: firefox 23:07:02 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-beta 23:07:02 INFO - mozversion application_vendor: Mozilla 23:07:02 INFO - mozversion application_version: 48.0 23:07:02 INFO - mozversion platform_buildid: 20160701065031 23:07:02 INFO - mozversion platform_changeset: 5e6976a28642d4d159071e14fd3251d76b9c46fa 23:07:02 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-beta 23:07:02 INFO - mozversion platform_version: 48.0 23:07:02 INFO - using testdate: 1467526022 23:07:02 INFO - actual date: 1467526022 23:07:02 INFO - starting webserver on 'localhost:46816' 23:07:02 INFO - SUITE-START | Running 2 tests 23:07:02 INFO - TEST-START | dromaeo_css 23:07:02 INFO - operating with platform_type : linux_ 23:07:02 INFO - Initialising browser for dromaeo_css test... 23:07:02 INFO - TEST-INFO | started process 9248 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpKjXzNW/profile http://localhost:46816/getInfo.html) 23:07:07 INFO - PROCESS | 9248 | 23:07:07 INFO - PROCESS | 9248 | (process:9325): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 23:07:08 INFO - PROCESS | 9248 | __metrics Screen width/height:1600/1200 23:07:08 INFO - PROCESS | 9248 | colorDepth:24 23:07:08 INFO - PROCESS | 9248 | Browser inner width/height: 1024/697 23:07:08 INFO - PROCESS | 9248 | __metrics 23:07:09 ERROR - PROCESS | 9248 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2931: TypeError: this.tabs is undefined 23:07:10 INFO - TEST-INFO | 9248: exit 0 23:07:10 INFO - Browser initialized. 23:07:10 INFO - Running cycle 1/1 for dromaeo_css test... 23:07:10 INFO - TEST-INFO | started process 9376 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpKjXzNW/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 23:07:11 INFO - PROCESS | 9376 | 23:07:11 INFO - PROCESS | 9376 | (process:9444): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 23:07:21 INFO - PROCESS | 9376 | RSS: Main: 150716416 23:07:21 INFO - PROCESS | 9376 | 23:08:11 INFO - PROCESS | 9376 | 1467526091531 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:19 INFO - PROCESS | 9376 | Cycle 1(1): loaded http://localhost:46816/tests/dromaeo/cssquery-dojo.html (next: http://localhost:46816/tests/dromaeo/cssquery-ext.html) 23:10:20 INFO - PROCESS | 9376 | RSS: Main: 155033600 23:10:20 INFO - PROCESS | 9376 | 23:13:21 INFO - PROCESS | 9376 | Cycle 1(1): loaded http://localhost:46816/tests/dromaeo/cssquery-ext.html (next: http://localhost:46816/tests/dromaeo/cssquery-jquery.html) 23:13:22 INFO - PROCESS | 9376 | RSS: Main: 152670208 23:13:22 INFO - PROCESS | 9376 | 23:16:24 INFO - PROCESS | 9376 | Cycle 1(1): loaded http://localhost:46816/tests/dromaeo/cssquery-jquery.html (next: http://localhost:46816/tests/dromaeo/cssquery-mootools.html) 23:16:24 INFO - PROCESS | 9376 | RSS: Main: 152219648 23:16:24 INFO - PROCESS | 9376 | 23:19:26 INFO - PROCESS | 9376 | Cycle 1(1): loaded http://localhost:46816/tests/dromaeo/cssquery-mootools.html (next: http://localhost:46816/tests/dromaeo/cssquery-prototype.html) 23:19:26 INFO - PROCESS | 9376 | RSS: Main: 153649152 23:19:26 INFO - PROCESS | 9376 | 23:22:29 INFO - PROCESS | 9376 | Cycle 1(1): loaded http://localhost:46816/tests/dromaeo/cssquery-prototype.html (next: http://localhost:46816/tests/dromaeo/cssquery-yui.html) 23:22:29 INFO - PROCESS | 9376 | RSS: Main: 152264704 23:22:29 INFO - PROCESS | 9376 | 23:25:31 INFO - PROCESS | 9376 | Cycle 1(1): loaded http://localhost:46816/tests/dromaeo/cssquery-yui.html (next: http://localhost:46816/tests/dromaeo/cssquery-dojo.html) 23:25:32 INFO - PROCESS | 9376 | RSS: Main: 155865088 23:25:32 INFO - PROCESS | 9376 | 23:25:32 INFO - PROCESS | 9376 | __start_tp_report 23:25:32 INFO - PROCESS | 9376 | _x_x_mozilla_page_load 23:25:32 INFO - PROCESS | 9376 | _x_x_mozilla_page_load_details 23:25:32 INFO - PROCESS | 9376 | |i|pagename|runs| 23:25:32 INFO - PROCESS | 9376 | |0;dojo.html;3360.1431634933087;3427.5886893572774;3428.02301344117;3464.428369319061;3466.0468371197935;5618.438156184385;5632.211490391343;5637.633553818999;5649.435056494349;5649.802256921009;5663.745131469083;5679.744411501482;5686.63036902601;5686.829395118143;5690.57320700947;5088.77100530477;5154.639175257734;5163.044836705221;5165.044466773659;5178.197379406198;5094.592432605383;5137.588992880561;5285.947140528603;5286.127788914843;5301.973490132563;5169.793208271664;5176.482351764831;5181.222816577525;5182.093133701587;5236.528712415882;5099.311592934943;5099.413567439737;5105.489451054902;5115.309433226504;5126.820561280338;4984.975075124601;5019.64862459628;5105.719185444799;5114.33513643224;5143.8456846294675;5360.3567571891235;5395.406505284415;5409.702466364349;5444.727763611843;5452.972735136299;5853.50245229156;5891.05743081105;5898.439648233411;5900.704964751788;5913.733881975321;5958.344582095966;5963.910541341883;5970.432808883149;5978.940210597882;5990.97004514979;5594.804181853657;5629.831105066854;5644.774209031675;5662.858428539278;5665.461781130786;6212.658303793335;6218.067289906459;6227.875442491125;6238.968805156036;6254.781082662085;5944.910826337608;5985.551083668743;6000.519958403317;6001.759929602855;6025.246844144482;6017.458428741435;6025.0661147522205;6026.246719160105;6037.758489660452;6075.635461872302;5996.490298324604;6006.909896351558;6014.218151640259;6018.488428483541;6027;5785.739641716133;5960.880782384328;5986.610870293417;6016.398360164036;6043.576949613484;4620.422447194101;4630.791614377361;4633.620689655216;4636.11913736389;4665.6034237090225;4171.895702607399;4194.454720886265;4206.516250631155;4213.747175169438;4242.384854196124;5706.657600543981;5714.457126572969;5721.256236689203;5732.111522713986;5770.221020162225;5966.373530779292;6043.909341359883;6061.575689701678;6072.332043475214;6128.356522565066;5666.518345940642;5820.592558520948;5891.823245302648;5897.233359663216;5901.203337549462;5115.360579927509;5116.513931176532;5135.15269980449;5169.017886601534;5175.45657705943;6250.093736408196;6251.374862513712;6254.562180647311;6257.655828929453;6259.436650701458;5982.4316689914385;6000.459958603659;6017.428344307284;6020.729067192075;6073.605215660968;6380.617162970237;6391.58454700443;6426.518011149089;6432.388923052303;6437;6041.69791510414;6050.364711705208;6050.697465126814;6055.091736239423;6059.151718759289;5931.258592675916;6023.397660233942;6061.060535616986;6086.269647642312;6111.297200821962;5853.180554722428;5857.736401861841;5857.824265272048;5866.090755932837;5872.618279811799;5805.448482394166;5848.122781582797;5850.53195744348;5854.326752423526;5864.912026319694;5669.31968163823;5759.308882934075;5803.216565763568;5818.709064546841;5911.527077833677;5909.172715819875;5941.970290148522;5965.463108320098;5972.611780234271;5975.984082705863;5807.303123625023;5807.796727114531;5842.561807864512;5843.444872737083;5849.678267695318 23:25:32 INFO - PROCESS | 9376 | |1;ext.html;648.8248172993292;674.1135406939875;675.2133764164748;728.1007955175354;739.2607392607391;39648.405273920915;40688.59311406885;40730.59269407305;40738.38892416612;40738.592614073925;40093;40649.39025914614;40696.59303406965;40831.79584102075;41009.17981640365;8642.956785216065;8793.164649358301;8831.293496520262;8841.911580884173;8845.380823342368;8828.779280518007;8941.865872011926;8946.284297256203;9146.085391460867;9177.770555736126;9113.908860911406;9177.816443671123;9218.677346292881;9224.40041397307;9257.722268331961;9054.547272636375;9055.366124371296;9068.410553314014;9110.316726245492;9164.26685865136;8922.598483068277;9018.729438116867;9102.77243068922;9106.499142547158;9124.81750364989;44273.33589996152;44843.775781121214;45083.323750143776;45100.77449612731;45109;3861.4823333465506;3950.7036972227197;4087.9386809197886;4236.364545318196;4587.977060114678;33626.6637333626;33856.32287354239;34069.82965085183;34089.31821363559;34288.14279643004;4329.870103896888;4382.715123516961;4389.341598760179;4399;4404.823807047746;322237;323451;324195;324246;327975;61466;61613;62013;62081.37918620846;62115.68942155351;69951;71738.64130679418;72053.639731801;72105.2789472109;72323.63838180776;19132.904335478233;19486.5128371789;19509.414717558495;19515.804841951398;19538.413847584594;14940.32768525419;14954.177520236492;14985.925070374797;14986.700265994838;15058.924705376403;20168.89915550413;20488.282910098074;20569.897150514153;20641.17435302571;21534.353969380943;7788.805279868048;8019.278264956182;8041.959790201128;8050.959745201237;8059.677612895536;1089.6404186618397;1100.0154861399003;1186.3830807979803;1205.138326096845;1221.0719852911673;32558.186045348582;32658.346833063206;32916.1770955728;32993.3401331972;33943.83028084844;1186.288227063755;1236.6537369536545;1283.865194154619;1294.5727909789935;1322.444573279225;17075.573110672332;17211.31154753796;17436.564085897953;17442.04068776204;17471.38850140239;521083;540616;547027;548124;817312;63273.05090423647;64167;64272.357276427574;64468.355316446236;64472.677636611515;1370.1984339161702;1386.8751812336736;1392.116006335984;1403.1581051368894;1548.5664014076076;31612.367752645278;33025.669743303224;33081;33335.83332083324;33857.3228535423;53359;59750.70124649349;61751.691241545304;61801.38198618136;61810.38189618226;317511;320479;322712;323510;326876;42581.78709106435;42651.3602295972;43063.13873722571;43085.56914430941;45587.54412455966;43986;48901.75549122231;49471.752641238;49712.25431618456;50394.49605503898;41285.38071928863;41575.58424415838;41800;41917;42991.785041074596;40393.798031009654;40672.38991415072;41749.165016700106;42239;43050.13899722051;41835.58164418317;42943;42946.35580466358;43092;43102.35346469868;34698.65301347055;35218.47172292469;35466.8226658865;35945;36412.635873640924;28029.439411212068;28607.141785746462;28696.426071478036;28981.42037159287;29155.85422072876 23:25:32 INFO - PROCESS | 9376 | |2;jquery.html;428.63565968926434;430.2578052858821;432.92856678648025;433.60108699996;437.840188331259;18903.24387024519;19311.613767724637;19428;19611.31360402386;19846.404607861787;19008.334708285212;19059.809401905975;19063.61872762544;19523.12145953432;19533.12100955457;5442.945570544303;5723;5726.284214473191;5742.253507044078;5909.143174239733;3914.178022615254;5636.7181640918;5673.886522269552;5709.685967271798;5901.085331773582;5830.212921255618;5834.6790926499025;5857.062869940811;5888.205092312526;5894;5779.971100144515;5855.560832937525;6380.138681278037;6407.87184256317;6407.935920640827;5634.492895639371;5662.745176467069;5711.05767548354;5718.428157184248;5729.713514324309;13865.4453821847;14732.705345893022;14735.410583576644;14741.484048058266;14766.704665906622;2409.120670955106;2474.9752502475103;2505.9749402506104;2578.651881995925;2603.7005744339453;9899.653512127114;9939.50302484873;10172.694819155364;10233.64182253625;10340.965903409675;2015.4054553906633;2035;2051.0257627626906;2100.306898723418;2119.7774233705395;76130.61934690291;77364.22635773626;78939;80036;80354.99999999942;10470.16238700902;10801.83797243042;10811.18916081297;11113;11158.776824463464;15028.924855375872;15083.849161508244;15153;15231.847681523042;15242.923785381225;8575.699850505202;8582.141785821368;8664;8769.736907892646;8916.108389161032;8321.833563328699;8404.36967227448;8416.410851240476;8512.97844258693;8530.146985301544;4561.7262964222255;4655.767211639404;4694.718316900997;4719.362886010414;4778.116048531033;1927.595205006936;1963.8232559069752;1967.813057759539;2003.238769267698;2082.843786715972;983.9262055345878;1075.3547871277171;1130.2992144870234;1133.2124173699365;1173.038108750833;18631.90684046598;19335.90332048359;19368.4189474316;19761.60476790485;19936.401907942785;1061.2200032975757;1083.6207327435334;1131.281636161027;1157.0801213035656;1162.6628277799343;10878.292910960763;10888.61889833852;11088.501017454233;11096.889031109748;11125.554977800797;512151;519342;541808;546079;546278;87360.12639873647;90329;91478;91519.0848091524;108594.45702771594;1152.423788105947;1162.7209469727204;1174.9588764393204;1210.9697257568455;1223.3699644682995;16993.91503042477;17359.7396039057;17452.127393630522;17496.65006699884;17580.91209543995;40743;40992.59007409888;41790.37314440225;41861.372079419445;42102.15795684008;57075.42924570867;60162;60656.69671651613;60755.39244607498;60864.69567652133;9149.176574108362;9256;9261.981182070102;9331.300152488455;9381.953090234505;13038.348082596021;13073.215607063607;13222.867771322164;13904.652383690489;14125.509177646878;11541.596044138414;12533.686657833627;12678.112532122663;12752;12867.549635762703;12519;12573.559925402567;12617.242965422103;12881.291528965998;13166.736665266833;12272.502336833959;12878.549250776177;12888.291143987171;12920.483180672667;13133.60599182026;8826.42628229163;8848.64605415802;8945.37382383227;9078.500682462529;9114.726558203265;12268.754624907273;12712.237265764084;12750.681232968878;12941.09412341127;12943.5469758558 23:25:32 INFO - PROCESS | 9376 | |3;mootools.html;1601.7917670702811;1609.7746315515826;1839.9724004139941;1921.4139687395339;1954.3257576136236;7292.67182976766;8034.076081250643;8092.91907080929;8271.296939760112;8356.955380577429;8182.754517364474;8230.09468958414;8251.504909705407;8293.751187464371;8293.958530207341;2276.658501224813;2278.9886050569726;2293.1859189987563;2299.1033496936125;2301.689271948282;2299.4826164113024;2316.7104111986;2340.941476463085;2349.95300093998;2365.2076554354226;2319.1071437496603;2328.3131476214558;2334.323046316566;2341.0167729553627;2362.2795047510504;2315.8378913476063;2320.269115228706;2330.2659662206433;2332.7783860533223;2346.5658853112227;2351.882405879699;2364.9881750591308;2369.940751481227;2374.7031621047367;2380.8690522021284;8404.369672274543;8479.406441549032;8480.957595212047;8488.575571221476;8503.82992340156;5022.121128802445;5167.819126330598;5170.870728231786;5174.793008279665;5177.430482646906;3360.512725654766;3382.424987752088;3412.215190506173;3439.638837922007;3483.3381657484997;1154.5381847261078;1168.5290718724698;1194.7013246688327;1229.8708635593223;1233.7655845389438;11834.940825295818;11993.940030299967;12057.698557536043;12077.57728479499;12083.879161208364;4353.69524133314;4426.667999900021;4445.955540444619;4472.664550158751;4482.731036137842;10240.897591024144;10249.84625230622;10262.179025677928;10271.7432064199;10273.126784223425;5136.512031357015;5160.870978225575;5166.250893620404;5198.818041368534;5201.609879258995;4603.171429142786;4746.976265118652;4752.619790416758;4769.236922092448;4787.0904528139545;3765.8305376258136;3805.257974694963;3813.523309586302;3856.151646637735;3879.3599056155417;1203.2299328429813;1210.140800031987;1212.442276552778;1215.604928398274;1225.2709637765515;971.9757006074764;1098.4452851310036;1103.7406209540752;1108.1744100645071;1109.073923274059;5892.793752218738;6019.638821670714;6144.201253837062;6150.323464418911;6168.9691551542855;429.6541284266196;430.31364972868226;432.7749570223529;434.32679347012004;441.8188542697479;4152.833886644561;4197.916041679149;4201.34879093741;4204.180184863983;4263.55232700562;10241.129503992244;10285.331453455501;10440.947795260976;10534.52594633228;10548.156147508182;10185.694429166988;10293.073623373783;10331.535080921376;10331.741706457398;10340.844887326695;7956.9602151988865;8071.677132914618;8113.675452981933;8227.341812655093;8250.917490825135;5892.823215303548;5981.252343457068;6026.035834266497;6026.517878569792;6075.453209211192;9106.590203440728;9194.632214711337;9196.172344489029;9369.578368973549;9415;8746.51894145828;9505.334626576074;9530.237580993642;9551.044895510393;9688.951555242178;7322.63386830667;7488.213737557696;7547.018887544584;7559.20628334039;7571.46999710015;8111.229433203836;8125.959370203112;8171.182881711781;8201.71294004707;8213.95893020531;7254.5647261164495;7398.519096258726;7469.88795168062;7538.509996850187;7561.168271490022;7111.573305601681;7145.214026456982;7178.641067946686;7281.453890958093;7281.927180728337;6740.696668650021;6939.375456208965;6992.720291188295;7042.577445353295;7049.048378468841;5183.92224116631;5221.973890130677;5299.602529810202;5340.626156169031;5392.649477784088;5339.973300133474;5362.088444964287;5373.167159090191;5495.560355171497;5520.972395138159 23:25:32 INFO - PROCESS | 9376 | |4;prototype.html;351.4534898233248;365.7348422393764;369.064421691013;369.76335145506863;372.33538134430046;6562.278149403568;6612.669366531678;6635.834104147399;6643.069970204176;6663.4336081433075;6488.059231411443;6504.382083702052;6508.186476690402;6511.3163117872655;6522.054302126189;4800.687955282913;4932.80268789248;4988.152014157584;4994.150994330954;5001.999999999991;4922.80308787648;4940.036692844897;4941.234108713155;4963.553280204781;4969.378827646544;4854.732989685566;4878.512148785128;4893.779779909894;4899.142650036247;4917.778699958492;4888.535589119028;4890.535399137077;4900.6569540132205;4909.582685471739;4924.581410580105;4293.506246781629;4299.419578356913;4301.075268817188;4305.20353734557;4305.677074219446;6275;6280.623162610258;6286.402791734824;6290.496760259169;6301.87396252077;5641.68970706611;5641.80385970869;5720.342160651537;5727.99760041991;5731.885362292731;6790.694418751168;6810.250872404032;6813.080234168373;6817.5227734058635;6818.318168183192;4731.124741922721;4739.668223224376;4740.644451666139;4741.786619602126;4756.167670657621;7121.786346409616;7189.604571748552;7194.640267986632;7199.89200161998;7215.747448839318;4852.781624826891;4855.174620314555;4855.980244148768;4865.829695960695;4869.586085182799;4735.550122738335;4879.414470263591;4892.828750993698;4894.8042078317185;4900.436449808318;5625.493705566437;5710.200571919934;5726.599138060295;5737.799177028784;5745.1669507921115;6950.061741664912;6956.5478243913985;6956.930430695628;6967.338102880219;6977.89533157003;1698.142438068792;1741.573314537921;1742.3988723890238;1743.224265201973;1749.7462867884085;1072.619220176826;1104.745908441063;1120.2998126171144;1122.820348744197;1130.9264897781618;6710.463162946952;6731.899021514681;6732.899006514906;6738.696758645872;6751.25736169021;7182.964085179645;7183.173934997438;7186.425085993108;7188.849784034529;7189.712411503586;6590.176227971504;6724.798256052326;6736.730530778812;6770.390664840188;6794.558353706993;3887.378019516864;3891.8637847675195;3900.414937759302;3902.726809123334;3906.570277269498;7619.619019049136;7649.120351159577;7653;7662;7668.923310766932;7311.561306321638;7345.485815992936;7374.1151061872915;7374.705011799575;7392.889106663404;7473.4021278297605;7542.358899493494;7609.162992070867;7625.542467451971;7631.809204769926;7167.820804479929;7192.100987376578;7204.675789589586;7205.243449437943;7206.4234861209925;7022.2275549688475;7055;7090.4327653788605;7110.644467776694;7110.680019399243;7587.279208475186;7607.315341619281;7620.733274335372;7624.656890440055;7639.656215470428;4760.6191504678845;4920.5571498565305;4932;4932.728699921395;4940.184869496493;7183.20984691694;7205.88308812135;7208.531445456028;7216.89174662391;7234.6020968847215;6993.965030174817;6995.020697102512;6997.510174287954;7004.754833581004;7008.859822803617;6961.095057642474;6981.930180698128;6990.126234220723;7001.859962800817;7014.508984371249;6739.460843132636;6859.142607174103;6864.21061577925;6867.07294515234;6888.793336199922;6928.099347084847;6975.407090397373;7012.50912436145;7020.929790702027;7021;6818.386345228755;6821.522493425413;6826.453883689393;6837.453003759787;6852.931470685229 23:25:32 INFO - PROCESS | 9376 | |5;yui.html;933.4912472702376;934.9205317548012;948.9098535639114;949.1931857920764;958.2573505533215;14243.430262789489;14287.571372858805;14374.92812535937;14384.280785960686;14425.062370945894;13044.021698372637;13326.200427974329;14092.154470731763;14202.218877961708;14244.643883902907;896.1352295035273;906.1074841281365;912.4160537256162;919.3334832246635;919.5126582911067;912.6851236323457;914.2594498456272;914.4558987402485;915.9404638698496;916.3906002508324;959.827231098402;964.4020707161569;966.0146650416606;966.2221911361352;971.2133172130561;958.2860768727273;958.4345236310576;958.7363475044384;963.889152747429;970.4710932541782;707.508281744188;708.1891234536427;710.350029722803;711.5695004522292;712.3802292005936;13561.932190339085;13817.447302107903;13875.653108672263;13946.651333716636;13970.952178586647;13327.866721332759;13379.197248165141;13400.731985360335;13459;13612.591622251348;10836.837447438294;11009.339439633568;11129.554817807279;11440.141989350748;11478.885211147865;3911.7362075337733;3934.075492259317;3964.5837187095517;3970.1067259866586;4004.599540046001;55380.44619553834;55642.44357556413;55896.44103558994;56406.43593564094;57187;11643.359615221074;11643.76712465746;11830.408479575986;11830.467628956718;12021.09841761854;20090.69863952042;20165.899170504348;20189.394318170478;20237.190512379635;20286;8594;8603.397762156714;8856.424332418372;8954.149355811187;8977.775555611162;4956.355673762388;5134.255532947776;5144.15121504955;5199.090159222121;5278.234655974862;3377.4427219509;3436.226848958964;3445.7415693823064;3451.0854623524788;3464.2205503761957;670.5942904542682;678.4979115454528;692.8164036530324;697.0206859362604;699.384541603396;720.1646090534954;762.5424745152864;793.6269953122023;832.5337810825836;837.0327190111071;10028.949855250678;10370.740731481774;10410.895891040993;10438.217133715001;10532.473376331152;724.9021382113452;760.3688938181297;770.603139383218;847.220557087481;867.9652813887374;4477.843275485342;4793;4814.903701925942;4860.416749990024;4874.977067973038;58827.70586147042;60671.78656426847;60808.08787868186;60847.69576152091;65614;47532.5246747535;49261.261081083816;51697.48302517002;53398.73300633472;63557;51739.48260517346;54238.72880635651;54493.455065449634;54544;54846.451535484935;10178.13485853681;10274.178065754872;10462.895371046192;10485.318454300446;10570.154387649123;38024.80987595155;38585.2282954345;40264;40316.1936761269;41158.588414115475;44599.77700111479;46982.76508617435;51177;51339;52404.73797630987;12874.613761587167;12902.290374029142;12909.289989050692;12953.935230323788;13076.411561479947;13896.72206555843;14252.429902803771;14328.49850255236;14398.352074156897;14402.567922962327;12710.110292279453;12830.10189286741;12882.806757898452;12902.032347573782;12943.676408089874;13304.068715189844;13409.262490563113;13650.385732641857;13687.931560342135;14006.229657368942;12858.357082146042;13219.471221151047;13304.733905321646;13397.464101435833;13573.38919748594;11245.550177992789;11406.600768973047;11578.94210528942;11582.536698532302;11638.243514171552;11497.2526785762;11654.809156494104;11692.47383867711;11795.587154449897;11834.704132396759 23:25:32 INFO - PROCESS | 9376 | __end_tp_report 23:25:32 INFO - PROCESS | 9376 | __start_cc_report 23:25:32 INFO - PROCESS | 9376 | _x_x_mozilla_cycle_collect,316 23:25:32 INFO - PROCESS | 9376 | __end_cc_report 23:25:32 INFO - PROCESS | 9376 | __startTimestamp1467527132237__endTimestamp 23:25:32 INFO - PROCESS | 9376 | 23:25:32 INFO - PROCESS | 9376 | ------- Summary: start ------- 23:25:32 INFO - PROCESS | 9376 | Number of tests: 6 23:25:32 INFO - PROCESS | 9376 | 23:25:32 INFO - PROCESS | 9376 | [#0] dojo.html Cycles:165 Average:5615.30 Median:5848.12 stddev:616.48 (10.5%) stddev-sans-first:592.44 23:25:32 INFO - PROCESS | 9376 | Values: 3360.1 3427.6 3428.0 3464.4 3466.0 5618.4 5632.2 5637.6 5649.4 5649.8 5663.7 5679.7 5686.6 5686.8 5690.6 5088.8 5154.6 5163.0 5165.0 5178.2 5094.6 5137.6 5285.9 5286.1 5302.0 5169.8 5176.5 5181.2 5182.1 5236.5 5099.3 5099.4 5105.5 5115.3 5126.8 4985.0 5019.6 5105.7 5114.3 5143.8 5360.4 5395.4 5409.7 5444.7 5453.0 5853.5 5891.1 5898.4 5900.7 5913.7 5958.3 5963.9 5970.4 5978.9 5991.0 5594.8 5629.8 5644.8 5662.9 5665.5 6212.7 6218.1 6227.9 6239.0 6254.8 5944.9 5985.6 6000.5 6001.8 6025.2 6017.5 6025.1 6026.2 6037.8 6075.6 5996.5 6006.9 6014.2 6018.5 6027.0 5785.7 5960.9 5986.6 6016.4 6043.6 4620.4 4630.8 4633.6 4636.1 4665.6 4171.9 4194.5 4206.5 4213.7 4242.4 5706.7 5714.5 5721.3 5732.1 5770.2 5966.4 6043.9 6061.6 6072.3 6128.4 5666.5 5820.6 5891.8 5897.2 5901.2 5115.4 5116.5 5135.2 5169.0 5175.5 6250.1 6251.4 6254.6 6257.7 6259.4 5982.4 6000.5 6017.4 6020.7 6073.6 6380.6 6391.6 6426.5 6432.4 6437.0 6041.7 6050.4 6050.7 6055.1 6059.2 5931.3 6023.4 6061.1 6086.3 6111.3 5853.2 5857.7 5857.8 5866.1 5872.6 5805.4 5848.1 5850.5 5854.3 5864.9 5669.3 5759.3 5803.2 5818.7 5911.5 5909.2 5942.0 5965.5 5972.6 5976.0 5807.3 5807.8 5842.6 5843.4 5849.7 23:25:32 INFO - PROCESS | 9376 | 23:25:32 INFO - PROCESS | 9376 | [#1] ext.html Cycles:180 Average:59608.21 Median:42078.00 stddev:116543.50 (277.0%) stddev-sans-first:116786.36 23:25:32 INFO - PROCESS | 9376 | Values: 648.8 674.1 675.2 728.1 739.3 39648.4 40688.6 40730.6 40738.4 40738.6 40093.0 40649.4 40696.6 40831.8 41009.2 8643.0 8793.2 8831.3 8841.9 8845.4 8828.8 8941.9 8946.3 9146.1 9177.8 9113.9 9177.8 9218.7 9224.4 9257.7 9054.5 9055.4 9068.4 9110.3 9164.3 8922.6 9018.7 9102.8 9106.5 9124.8 44273.3 44843.8 45083.3 45100.8 45109.0 3861.5 3950.7 4087.9 4236.4 4588.0 33626.7 33856.3 34069.8 34089.3 34288.1 4329.9 4382.7 4389.3 4399.0 4404.8 322237.0 323451.0 324195.0 324246.0 327975.0 61466.0 61613.0 62013.0 62081.4 62115.7 69951.0 71738.6 72053.6 72105.3 72323.6 19132.9 19486.5 19509.4 19515.8 19538.4 14940.3 14954.2 14985.9 14986.7 15058.9 20168.9 20488.3 20569.9 20641.2 21534.4 7788.8 8019.3 8042.0 8051.0 8059.7 1089.6 1100.0 1186.4 1205.1 1221.1 32558.2 32658.3 32916.2 32993.3 33943.8 1186.3 1236.7 1283.9 1294.6 1322.4 17075.6 17211.3 17436.6 17442.0 17471.4 521083.0 540616.0 547027.0 548124.0 817312.0 63273.1 64167.0 64272.4 64468.4 64472.7 1370.2 1386.9 1392.1 1403.2 1548.6 31612.4 33025.7 33081.0 33335.8 33857.3 53359.0 59750.7 61751.7 61801.4 61810.4 317511.0 320479.0 322712.0 323510.0 326876.0 42581.8 42651.4 43063.1 43085.6 45587.5 43986.0 48901.8 49471.8 49712.3 50394.5 41285.4 41575.6 41800.0 41917.0 42991.8 40393.8 40672.4 41749.2 42239.0 43050.1 41835.6 42943.0 42946.4 43092.0 43102.4 34698.7 35218.5 35466.8 35945.0 36412.6 28029.4 28607.1 28696.4 28981.4 29155.9 23:25:32 INFO - PROCESS | 9376 | 23:25:32 INFO - PROCESS | 9376 | [#2] jquery.html Cycles:180 Average:30211.48 Median:2091.58 stddev:87722.70 (4194.1%) stddev-sans-first:87940.28 23:25:32 INFO - PROCESS | 9376 | Values: 428.6 430.3 432.9 433.6 437.8 18903.2 19311.6 19428.0 19611.3 19846.4 19008.3 19059.8 19063.6 19523.1 19533.1 5442.9 5723.0 5726.3 5742.3 5909.1 3914.2 5636.7 5673.9 5709.7 5901.1 5830.2 5834.7 5857.1 5888.2 5894.0 5780.0 5855.6 6380.1 6407.9 6407.9 5634.5 5662.7 5711.1 5718.4 5729.7 13865.4 14732.7 14735.4 14741.5 14766.7 2409.1 2475.0 2506.0 2578.7 2603.7 9899.7 9939.5 10172.7 10233.6 10341.0 2015.4 2035.0 2051.0 2100.3 2119.8 76130.6 77364.2 78939.0 80036.0 80355.0 10470.2 10801.8 10811.2 11113.0 11158.8 15028.9 15083.8 15153.0 15231.8 15242.9 8575.7 8582.1 8664.0 8769.7 8916.1 8321.8 8404.4 8416.4 8513.0 8530.1 4561.7 4655.8 4694.7 4719.4 4778.1 1927.6 1963.8 1967.8 2003.2 2082.8 983.9 1075.4 1130.3 1133.2 1173.0 18631.9 19335.9 19368.4 19761.6 19936.4 1061.2 1083.6 1131.3 1157.1 1162.7 10878.3 10888.6 11088.5 11096.9 11125.6 512151.0 519342.0 541808.0 546079.0 546278.0 87360.1 90329.0 91478.0 91519.1 108594.5 1152.4 1162.7 1175.0 1211.0 1223.4 16993.9 17359.7 17452.1 17496.7 17580.9 40743.0 40992.6 41790.4 41861.4 42102.2 57075.4 60162.0 60656.7 60755.4 60864.7 9149.2 9256.0 9262.0 9331.3 9382.0 13038.3 13073.2 13222.9 13904.7 14125.5 11541.6 12533.7 12678.1 12752.0 12867.5 12519.0 12573.6 12617.2 12881.3 13166.7 12272.5 12878.5 12888.3 12920.5 13133.6 8826.4 8848.6 8945.4 9078.5 9114.7 12268.8 12712.2 12750.7 12941.1 12943.5 23:25:32 INFO - PROCESS | 9376 | 23:25:32 INFO - PROCESS | 9376 | [#3] mootools.html Cycles:180 Average:5634.08 Median:4749.80 stddev:3118.92 (65.7%) stddev-sans-first:3112.95 23:25:32 INFO - PROCESS | 9376 | Values: 1601.8 1609.8 1840.0 1921.4 1954.3 7292.7 8034.1 8092.9 8271.3 8357.0 8182.8 8230.1 8251.5 8293.8 8294.0 2276.7 2279.0 2293.2 2299.1 2301.7 2299.5 2316.7 2340.9 2350.0 2365.2 2319.1 2328.3 2334.3 2341.0 2362.3 2315.8 2320.3 2330.3 2332.8 2346.6 2351.9 2365.0 2369.9 2374.7 2380.9 8404.4 8479.4 8481.0 8488.6 8503.8 5022.1 5167.8 5170.9 5174.8 5177.4 3360.5 3382.4 3412.2 3439.6 3483.3 1154.5 1168.5 1194.7 1229.9 1233.8 11834.9 11993.9 12057.7 12077.6 12083.9 4353.7 4426.7 4446.0 4472.7 4482.7 10240.9 10249.8 10262.2 10271.7 10273.1 5136.5 5160.9 5166.3 5198.8 5201.6 4603.2 4747.0 4752.6 4769.2 4787.1 3765.8 3805.3 3813.5 3856.2 3879.4 1203.2 1210.1 1212.4 1215.6 1225.3 972.0 1098.4 1103.7 1108.2 1109.1 5892.8 6019.6 6144.2 6150.3 6169.0 429.7 430.3 432.8 434.3 441.8 4152.8 4197.9 4201.3 4204.2 4263.6 10241.1 10285.3 10440.9 10534.5 10548.2 10185.7 10293.1 10331.5 10331.7 10340.8 7957.0 8071.7 8113.7 8227.3 8250.9 5892.8 5981.3 6026.0 6026.5 6075.5 9106.6 9194.6 9196.2 9369.6 9415.0 8746.5 9505.3 9530.2 9551.0 9689.0 7322.6 7488.2 7547.0 7559.2 7571.5 8111.2 8126.0 8171.2 8201.7 8214.0 7254.6 7398.5 7469.9 7538.5 7561.2 7111.6 7145.2 7178.6 7281.5 7281.9 6740.7 6939.4 6992.7 7042.6 7049.0 5183.9 5222.0 5299.6 5340.6 5392.6 5340.0 5362.1 5373.2 5495.6 5521.0 23:25:32 INFO - PROCESS | 9376 | 23:25:32 INFO - PROCESS | 9376 | [#4] prototype.html Cycles:180 Average:5811.43 Median:6686.95 stddev:1787.75 (26.7%) stddev-sans-first:1745.16 23:25:32 INFO - PROCESS | 9376 | Values: 351.5 365.7 369.1 369.8 372.3 6562.3 6612.7 6635.8 6643.1 6663.4 6488.1 6504.4 6508.2 6511.3 6522.1 4800.7 4932.8 4988.2 4994.2 5002.0 4922.8 4940.0 4941.2 4963.6 4969.4 4854.7 4878.5 4893.8 4899.1 4917.8 4888.5 4890.5 4900.7 4909.6 4924.6 4293.5 4299.4 4301.1 4305.2 4305.7 6275.0 6280.6 6286.4 6290.5 6301.9 5641.7 5641.8 5720.3 5728.0 5731.9 6790.7 6810.3 6813.1 6817.5 6818.3 4731.1 4739.7 4740.6 4741.8 4756.2 7121.8 7189.6 7194.6 7199.9 7215.7 4852.8 4855.2 4856.0 4865.8 4869.6 4735.6 4879.4 4892.8 4894.8 4900.4 5625.5 5710.2 5726.6 5737.8 5745.2 6950.1 6956.5 6956.9 6967.3 6977.9 1698.1 1741.6 1742.4 1743.2 1749.7 1072.6 1104.7 1120.3 1122.8 1130.9 6710.5 6731.9 6732.9 6738.7 6751.3 7183.0 7183.2 7186.4 7188.8 7189.7 6590.2 6724.8 6736.7 6770.4 6794.6 3887.4 3891.9 3900.4 3902.7 3906.6 7619.6 7649.1 7653.0 7662.0 7668.9 7311.6 7345.5 7374.1 7374.7 7392.9 7473.4 7542.4 7609.2 7625.5 7631.8 7167.8 7192.1 7204.7 7205.2 7206.4 7022.2 7055.0 7090.4 7110.6 7110.7 7587.3 7607.3 7620.7 7624.7 7639.7 4760.6 4920.6 4932.0 4932.7 4940.2 7183.2 7205.9 7208.5 7216.9 7234.6 6994.0 6995.0 6997.5 7004.8 7008.9 6961.1 6981.9 6990.1 7001.9 7014.5 6739.5 6859.1 6864.2 6867.1 6888.8 6928.1 6975.4 7012.5 7020.9 7021.0 6818.4 6821.5 6826.5 6837.5 6852.9 23:25:32 INFO - PROCESS | 9376 | 23:25:32 INFO - PROCESS | 9376 | [#5] yui.html Cycles:180 Average:15463.78 Median:3987.35 stddev:17584.34 (441.0%) stddev-sans-first:17599.81 23:25:32 INFO - PROCESS | 9376 | Values: 933.5 934.9 948.9 949.2 958.3 14243.4 14287.6 14374.9 14384.3 14425.1 13044.0 13326.2 14092.2 14202.2 14244.6 896.1 906.1 912.4 919.3 919.5 912.7 914.3 914.5 915.9 916.4 959.8 964.4 966.0 966.2 971.2 958.3 958.4 958.7 963.9 970.5 707.5 708.2 710.4 711.6 712.4 13561.9 13817.4 13875.7 13946.7 13971.0 13327.9 13379.2 13400.7 13459.0 13612.6 10836.8 11009.3 11129.6 11440.1 11478.9 3911.7 3934.1 3964.6 3970.1 4004.6 55380.4 55642.4 55896.4 56406.4 57187.0 11643.4 11643.8 11830.4 11830.5 12021.1 20090.7 20165.9 20189.4 20237.2 20286.0 8594.0 8603.4 8856.4 8954.1 8977.8 4956.4 5134.3 5144.2 5199.1 5278.2 3377.4 3436.2 3445.7 3451.1 3464.2 670.6 678.5 692.8 697.0 699.4 720.2 762.5 793.6 832.5 837.0 10028.9 10370.7 10410.9 10438.2 10532.5 724.9 760.4 770.6 847.2 868.0 4477.8 4793.0 4814.9 4860.4 4875.0 58827.7 60671.8 60808.1 60847.7 65614.0 47532.5 49261.3 51697.5 53398.7 63557.0 51739.5 54238.7 54493.5 54544.0 54846.5 10178.1 10274.2 10462.9 10485.3 10570.2 38024.8 38585.2 40264.0 40316.2 41158.6 44599.8 46982.8 51177.0 51339.0 52404.7 12874.6 12902.3 12909.3 12953.9 13076.4 13896.7 14252.4 14328.5 14398.4 14402.6 12710.1 12830.1 12882.8 12902.0 12943.7 13304.1 13409.3 13650.4 13687.9 14006.2 12858.4 13219.5 13304.7 13397.5 13573.4 11245.6 11406.6 11578.9 11582.5 11638.2 11497.3 11654.8 11692.5 11795.6 11834.7 23:25:32 INFO - PROCESS | 9376 | -------- Summary: end -------- 23:25:32 INFO - PROCESS | 9376 | 23:25:32 INFO - TEST-INFO | 9376: exit 0 23:25:32 INFO - TEST-OK | dromaeo_css | took 1110083ms 23:25:32 INFO - TEST-START | kraken 23:25:32 INFO - operating with platform_type : linux_ 23:25:32 INFO - Initialising browser for kraken test... 23:25:32 INFO - TEST-INFO | started process 9620 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpMpjQze/profile http://localhost:46816/getInfo.html) 23:25:37 INFO - PROCESS | 9620 | 23:25:37 INFO - PROCESS | 9620 | (process:9699): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 23:25:38 INFO - PROCESS | 9620 | __metrics Screen width/height:1600/1200 23:25:38 INFO - PROCESS | 9620 | colorDepth:24 23:25:38 INFO - PROCESS | 9620 | Browser inner width/height: 1024/697 23:25:38 INFO - PROCESS | 9620 | __metrics 23:25:39 ERROR - PROCESS | 9620 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2931: TypeError: this.tabs is undefined 23:25:39 INFO - TEST-INFO | 9620: exit 0 23:25:39 INFO - Browser initialized. 23:25:39 INFO - Running cycle 1/1 for kraken test... 23:25:39 INFO - TEST-INFO | started process 9749 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpMpjQze/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 23:25:41 INFO - PROCESS | 9749 | 23:25:41 INFO - PROCESS | 9749 | (process:9815): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 23:25:51 INFO - PROCESS | 9749 | RSS: Main: 150437888 23:25:51 INFO - PROCESS | 9749 | 23:25:54 INFO - PROCESS | 9749 | Cycle 1(1): loaded http://localhost:46816/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:46816/tests/kraken/driver.html?testName=audio-beat-detection) 23:25:54 INFO - PROCESS | 9749 | RSS: Main: 156188672 23:25:54 INFO - PROCESS | 9749 | 23:25:57 INFO - PROCESS | 9749 | Cycle 1(1): loaded http://localhost:46816/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:46816/tests/kraken/driver.html?testName=audio-dft) 23:25:58 INFO - PROCESS | 9749 | RSS: Main: 156327936 23:25:58 INFO - PROCESS | 9749 | 23:26:01 INFO - PROCESS | 9749 | Cycle 1(1): loaded http://localhost:46816/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:46816/tests/kraken/driver.html?testName=audio-fft) 23:26:01 INFO - PROCESS | 9749 | RSS: Main: 156319744 23:26:01 INFO - PROCESS | 9749 | 23:26:03 INFO - PROCESS | 9749 | Cycle 1(1): loaded http://localhost:46816/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:46816/tests/kraken/driver.html?testName=audio-oscillator) 23:26:04 INFO - PROCESS | 9749 | RSS: Main: 156102656 23:26:04 INFO - PROCESS | 9749 | 23:26:06 INFO - PROCESS | 9749 | Cycle 1(1): loaded http://localhost:46816/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:46816/tests/kraken/driver.html?testName=imaging-gaussian-blur) 23:26:07 INFO - PROCESS | 9749 | RSS: Main: 156254208 23:26:07 INFO - PROCESS | 9749 | 23:26:10 INFO - PROCESS | 9749 | Cycle 1(1): loaded http://localhost:46816/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:46816/tests/kraken/driver.html?testName=imaging-darkroom) 23:26:10 INFO - PROCESS | 9749 | RSS: Main: 156733440 23:26:10 INFO - PROCESS | 9749 | 23:26:14 INFO - PROCESS | 9749 | Cycle 1(1): loaded http://localhost:46816/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:46816/tests/kraken/driver.html?testName=imaging-desaturate) 23:26:14 INFO - PROCESS | 9749 | RSS: Main: 156545024 23:26:14 INFO - PROCESS | 9749 | 23:26:17 INFO - PROCESS | 9749 | Cycle 1(1): loaded http://localhost:46816/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:46816/tests/kraken/driver.html?testName=json-parse-financial) 23:26:18 INFO - PROCESS | 9749 | RSS: Main: 156389376 23:26:18 INFO - PROCESS | 9749 | 23:26:19 INFO - PROCESS | 9749 | Cycle 1(1): loaded http://localhost:46816/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:46816/tests/kraken/driver.html?testName=json-stringify-tinderbox) 23:26:20 INFO - PROCESS | 9749 | RSS: Main: 156819456 23:26:20 INFO - PROCESS | 9749 | 23:26:22 INFO - PROCESS | 9749 | Cycle 1(1): loaded http://localhost:46816/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:46816/tests/kraken/driver.html?testName=stanford-crypto-aes) 23:26:22 INFO - PROCESS | 9749 | RSS: Main: 156557312 23:26:22 INFO - PROCESS | 9749 | 23:26:24 INFO - PROCESS | 9749 | Cycle 1(1): loaded http://localhost:46816/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:46816/tests/kraken/driver.html?testName=stanford-crypto-ccm) 23:26:25 INFO - PROCESS | 9749 | RSS: Main: 156794880 23:26:25 INFO - PROCESS | 9749 | 23:26:27 INFO - PROCESS | 9749 | Cycle 1(1): loaded http://localhost:46816/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:46816/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 23:26:28 INFO - PROCESS | 9749 | RSS: Main: 157310976 23:26:28 INFO - PROCESS | 9749 | 23:26:31 INFO - PROCESS | 9749 | Cycle 1(1): loaded http://localhost:46816/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:46816/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 23:26:31 INFO - PROCESS | 9749 | RSS: Main: 157114368 23:26:31 INFO - PROCESS | 9749 | 23:26:33 INFO - PROCESS | 9749 | Cycle 1(1): loaded http://localhost:46816/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:46816/tests/kraken/driver.html?testName=ai-astar) 23:26:33 INFO - PROCESS | 9749 | RSS: Main: 158199808 23:26:33 INFO - PROCESS | 9749 | 23:26:33 INFO - PROCESS | 9749 | __start_tp_report 23:26:33 INFO - PROCESS | 9749 | _x_x_mozilla_page_load 23:26:33 INFO - PROCESS | 9749 | _x_x_mozilla_page_load_details 23:26:33 INFO - PROCESS | 9749 | |i|pagename|runs| 23:26:33 INFO - PROCESS | 9749 | |0;ai-astar;107;112;105;108;112;111;103;110;109;110 23:26:33 INFO - PROCESS | 9749 | |1;audio-beat-detection;162;131;156;186;131;157;157;131;197;128 23:26:33 INFO - PROCESS | 9749 | |2;audio-dft;163;163;162;162;163;163;161;162;163;162 23:26:33 INFO - PROCESS | 9749 | |3;audio-fft;76;75;77;167;73;73;76;74;167;77 23:26:33 INFO - PROCESS | 9749 | |4;audio-oscillator;93;90;151;92;92;92;143;91;92;149 23:26:33 INFO - PROCESS | 9749 | |5;imaging-gaussian-blur;117;118;117;117;117;117;117;117;116;118 23:26:33 INFO - PROCESS | 9749 | |6;imaging-darkroom;147;148;146;146;148;147;147;146;146;146 23:26:33 INFO - PROCESS | 9749 | |7;imaging-desaturate;101;95;95;97;95;98;95;94;95;95 23:26:33 INFO - PROCESS | 9749 | |8;json-parse-financial;55;56;55;55;54;56;60;71;62;58 23:26:33 INFO - PROCESS | 9749 | |9;json-stringify-tinderbox;56;57;57;56;58;57;57;57;56;57 23:26:33 INFO - PROCESS | 9749 | |10;stanford-crypto-aes;81;73;73;76;74;75;75;82;73;73 23:26:33 INFO - PROCESS | 9749 | |11;stanford-crypto-ccm;110;123;116;122;130;117;113;112;126;139 23:26:33 INFO - PROCESS | 9749 | |12;stanford-crypto-pbkdf2;164;162;159;162;169;161;162;161;163;157 23:26:33 INFO - PROCESS | 9749 | |13;stanford-crypto-sha256-iterative;66;68;68;74;66;67;67;68;67;67 23:26:33 INFO - PROCESS | 9749 | __end_tp_report 23:26:33 INFO - PROCESS | 9749 | __start_cc_report 23:26:33 INFO - PROCESS | 9749 | _x_x_mozilla_cycle_collect,861 23:26:33 INFO - PROCESS | 9749 | __end_cc_report 23:26:33 INFO - PROCESS | 9749 | __startTimestamp1467527193690__endTimestamp 23:26:33 INFO - PROCESS | 9749 | 23:26:33 INFO - PROCESS | 9749 | ------- Summary: start ------- 23:26:33 INFO - PROCESS | 9749 | Number of tests: 14 23:26:33 INFO - PROCESS | 9749 | 23:26:33 INFO - PROCESS | 9749 | [#0] ai-astar Cycles:10 Average:108.70 Median:110.00 stddev:2.98 (2.7%) stddev-sans-first:3.10 23:26:33 INFO - PROCESS | 9749 | Values: 107.0 112.0 105.0 108.0 112.0 111.0 103.0 110.0 109.0 110.0 23:26:33 INFO - PROCESS | 9749 | 23:26:33 INFO - PROCESS | 9749 | [#1] audio-beat-detection Cycles:10 Average:153.60 Median:157.00 stddev:24.08 (15.3%) stddev-sans-first:25.35 23:26:33 INFO - PROCESS | 9749 | Values: 162.0 131.0 156.0 186.0 131.0 157.0 157.0 131.0 197.0 128.0 23:26:33 INFO - PROCESS | 9749 | 23:26:33 INFO - PROCESS | 9749 | [#2] audio-dft Cycles:10 Average:162.40 Median:163.00 stddev:0.70 (0.4%) stddev-sans-first:0.71 23:26:33 INFO - PROCESS | 9749 | Values: 163.0 163.0 162.0 162.0 163.0 163.0 161.0 162.0 163.0 162.0 23:26:33 INFO - PROCESS | 9749 | 23:26:33 INFO - PROCESS | 9749 | [#3] audio-fft Cycles:10 Average:93.50 Median:75.50 stddev:38.76 (51.3%) stddev-sans-first:40.60 23:26:33 INFO - PROCESS | 9749 | Values: 76.0 75.0 77.0 167.0 73.0 73.0 76.0 74.0 167.0 77.0 23:26:33 INFO - PROCESS | 9749 | 23:26:33 INFO - PROCESS | 9749 | [#4] audio-oscillator Cycles:10 Average:108.50 Median:92.00 stddev:27.11 (29.5%) stddev-sans-first:28.17 23:26:33 INFO - PROCESS | 9749 | Values: 93.0 90.0 151.0 92.0 92.0 92.0 143.0 91.0 92.0 149.0 23:26:33 INFO - PROCESS | 9749 | 23:26:33 INFO - PROCESS | 9749 | [#5] imaging-gaussian-blur Cycles:10 Average:117.10 Median:117.00 stddev:0.57 (0.5%) stddev-sans-first:0.60 23:26:33 INFO - PROCESS | 9749 | Values: 117.0 118.0 117.0 117.0 117.0 117.0 117.0 117.0 116.0 118.0 23:26:33 INFO - PROCESS | 9749 | 23:26:33 INFO - PROCESS | 9749 | [#6] imaging-darkroom Cycles:10 Average:146.70 Median:147.00 stddev:0.82 (0.6%) stddev-sans-first:0.87 23:26:33 INFO - PROCESS | 9749 | Values: 147.0 148.0 146.0 146.0 148.0 147.0 147.0 146.0 146.0 146.0 23:26:33 INFO - PROCESS | 9749 | 23:26:33 INFO - PROCESS | 9749 | [#7] imaging-desaturate Cycles:10 Average:96.00 Median:95.00 stddev:2.11 (2.2%) stddev-sans-first:1.24 23:26:33 INFO - PROCESS | 9749 | Values: 101.0 95.0 95.0 97.0 95.0 98.0 95.0 94.0 95.0 95.0 23:26:33 INFO - PROCESS | 9749 | 23:26:33 INFO - PROCESS | 9749 | [#8] json-parse-financial Cycles:10 Average:58.20 Median:57.00 stddev:5.16 (9.1%) stddev-sans-first:5.34 23:26:33 INFO - PROCESS | 9749 | Values: 55.0 56.0 55.0 55.0 54.0 56.0 60.0 71.0 62.0 58.0 23:26:33 INFO - PROCESS | 9749 | 23:26:33 INFO - PROCESS | 9749 | [#9] json-stringify-tinderbox Cycles:10 Average:56.80 Median:57.00 stddev:0.63 (1.1%) stddev-sans-first:0.60 23:26:33 INFO - PROCESS | 9749 | Values: 56.0 57.0 57.0 56.0 58.0 57.0 57.0 57.0 56.0 57.0 23:26:33 INFO - PROCESS | 9749 | 23:26:33 INFO - PROCESS | 9749 | [#10] stanford-crypto-aes Cycles:10 Average:75.50 Median:75.00 stddev:3.34 (4.5%) stddev-sans-first:2.89 23:26:33 INFO - PROCESS | 9749 | Values: 81.0 73.0 73.0 76.0 74.0 75.0 75.0 82.0 73.0 73.0 23:26:33 INFO - PROCESS | 9749 | 23:26:33 INFO - PROCESS | 9749 | [#11] stanford-crypto-ccm Cycles:10 Average:120.80 Median:122.50 stddev:9.08 (7.4%) stddev-sans-first:8.75 23:26:33 INFO - PROCESS | 9749 | Values: 110.0 123.0 116.0 122.0 130.0 117.0 113.0 112.0 126.0 139.0 23:26:33 INFO - PROCESS | 9749 | 23:26:33 INFO - PROCESS | 9749 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:162.00 Median:162.00 stddev:3.16 (2.0%) stddev-sans-first:3.27 23:26:33 INFO - PROCESS | 9749 | Values: 164.0 162.0 159.0 162.0 169.0 161.0 162.0 161.0 163.0 157.0 23:26:33 INFO - PROCESS | 9749 | 23:26:33 INFO - PROCESS | 9749 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:67.80 Median:67.50 stddev:2.30 (3.4%) stddev-sans-first:2.35 23:26:33 INFO - PROCESS | 9749 | Values: 66.0 68.0 68.0 74.0 66.0 67.0 67.0 68.0 67.0 67.0 23:26:33 INFO - PROCESS | 9749 | -------- Summary: end -------- 23:26:33 INFO - PROCESS | 9749 | 23:26:34 INFO - TEST-INFO | 9749: exit 0 23:26:34 INFO - TEST-OK | kraken | took 61728ms 23:26:34 INFO - SUITE-END | took 1171s 23:26:34 INFO - Completed test suite (00:19:32) 23:26:34 INFO - javascript benchmark 23:26:34 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3360.1431634933087, 3427.5886893572774, 3428.02301344117, 3464.428369319061, 3466.0468371197935, 5618.438156184385, 5632.211490391343, 5637.633553818999, 5649.435056494349, 5649.802256921009, 5663.745131469083, 5679.744411501482, 5686.63036902601, 5686.829395118143, 5690.57320700947, 5088.77100530477, 5154.639175257734, 5163.044836705221, 5165.044466773659, 5178.197379406198, 5094.592432605383, 5137.588992880561, 5285.947140528603, 5286.127788914843, 5301.973490132563, 5169.793208271664, 5176.482351764831, 5181.222816577525, 5182.093133701587, 5236.528712415882, 5099.311592934943, 5099.413567439737, 5105.489451054902, 5115.309433226504, 5126.820561280338, 4984.975075124601, 5019.64862459628, 5105.719185444799, 5114.33513643224, 5143.8456846294675, 5360.3567571891235, 5395.406505284415, 5409.702466364349, 5444.727763611843, 5452.972735136299, 5853.50245229156, 5891.05743081105, 5898.439648233411, 5900.704964751788, 5913.733881975321, 5958.344582095966, 5963.910541341883, 5970.432808883149, 5978.940210597882, 5990.97004514979, 5594.804181853657, 5629.831105066854, 5644.774209031675, 5662.858428539278, 5665.461781130786, 6212.658303793335, 6218.067289906459, 6227.875442491125, 6238.968805156036, 6254.781082662085, 5944.910826337608, 5985.551083668743, 6000.519958403317, 6001.759929602855, 6025.246844144482, 6017.458428741435, 6025.0661147522205, 6026.246719160105, 6037.758489660452, 6075.635461872302, 5996.490298324604, 6006.909896351558, 6014.218151640259, 6018.488428483541, 6027.0, 5785.739641716133, 5960.880782384328, 5986.610870293417, 6016.398360164036, 6043.576949613484, 4620.422447194101, 4630.791614377361, 4633.620689655216, 4636.11913736389, 4665.6034237090225, 4171.895702607399, 4194.454720886265, 4206.516250631155, 4213.747175169438, 4242.384854196124, 5706.657600543981, 5714.457126572969, 5721.256236689203, 5732.111522713986, 5770.221020162225, 5966.373530779292, 6043.909341359883, 6061.575689701678, 6072.332043475214, 6128.356522565066, 5666.518345940642, 5820.592558520948, 5891.823245302648, 5897.233359663216, 5901.203337549462, 5115.360579927509, 5116.513931176532, 5135.15269980449, 5169.017886601534, 5175.45657705943, 6250.093736408196, 6251.374862513712, 6254.562180647311, 6257.655828929453, 6259.436650701458, 5982.4316689914385, 6000.459958603659, 6017.428344307284, 6020.729067192075, 6073.605215660968, 6380.617162970237, 6391.58454700443, 6426.518011149089, 6432.388923052303, 6437.0, 6041.69791510414, 6050.364711705208, 6050.697465126814, 6055.091736239423, 6059.151718759289, 5931.258592675916, 6023.397660233942, 6061.060535616986, 6086.269647642312, 6111.297200821962, 5853.180554722428, 5857.736401861841, 5857.824265272048, 5866.090755932837, 5872.618279811799, 5805.448482394166, 5848.122781582797, 5850.53195744348, 5854.326752423526, 5864.912026319694, 5669.31968163823, 5759.308882934075, 5803.216565763568, 5818.709064546841, 5911.527077833677, 5909.172715819875, 5941.970290148522, 5965.463108320098, 5972.611780234271, 5975.984082705863, 5807.303123625023, 5807.796727114531, 5842.561807864512, 5843.444872737083, 5849.678267695318], "value": 5576.011076064677, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [648.8248172993292, 674.1135406939875, 675.2133764164748, 728.1007955175354, 739.2607392607391, 39648.405273920915, 40688.59311406885, 40730.59269407305, 40738.38892416612, 40738.592614073925, 40093.0, 40649.39025914614, 40696.59303406965, 40831.79584102075, 41009.17981640365, 8642.956785216065, 8793.164649358301, 8831.293496520262, 8841.911580884173, 8845.380823342368, 8828.779280518007, 8941.865872011926, 8946.284297256203, 9146.085391460867, 9177.770555736126, 9113.908860911406, 9177.816443671123, 9218.677346292881, 9224.40041397307, 9257.722268331961, 9054.547272636375, 9055.366124371296, 9068.410553314014, 9110.316726245492, 9164.26685865136, 8922.598483068277, 9018.729438116867, 9102.77243068922, 9106.499142547158, 9124.81750364989, 44273.33589996152, 44843.775781121214, 45083.323750143776, 45100.77449612731, 45109.0, 3861.4823333465506, 3950.7036972227197, 4087.9386809197886, 4236.364545318196, 4587.977060114678, 33626.6637333626, 33856.32287354239, 34069.82965085183, 34089.31821363559, 34288.14279643004, 4329.870103896888, 4382.715123516961, 4389.341598760179, 4399.0, 4404.823807047746, 322237.0, 323451.0, 324195.0, 324246.0, 327975.0, 61466.0, 61613.0, 62013.0, 62081.37918620846, 62115.68942155351, 69951.0, 71738.64130679418, 72053.639731801, 72105.2789472109, 72323.63838180776, 19132.904335478233, 19486.5128371789, 19509.414717558495, 19515.804841951398, 19538.413847584594, 14940.32768525419, 14954.177520236492, 14985.925070374797, 14986.700265994838, 15058.924705376403, 20168.89915550413, 20488.282910098074, 20569.897150514153, 20641.17435302571, 21534.353969380943, 7788.805279868048, 8019.278264956182, 8041.959790201128, 8050.959745201237, 8059.677612895536, 1089.6404186618397, 1100.0154861399003, 1186.3830807979803, 1205.138326096845, 1221.0719852911673, 32558.186045348582, 32658.346833063206, 32916.1770955728, 32993.3401331972, 33943.83028084844, 1186.288227063755, 1236.6537369536545, 1283.865194154619, 1294.5727909789935, 1322.444573279225, 17075.573110672332, 17211.31154753796, 17436.564085897953, 17442.04068776204, 17471.38850140239, 521083.0, 540616.0, 547027.0, 548124.0, 817312.0, 63273.05090423647, 64167.0, 64272.357276427574, 64468.355316446236, 64472.677636611515, 1370.1984339161702, 1386.8751812336736, 1392.116006335984, 1403.1581051368894, 1548.5664014076076, 31612.367752645278, 33025.669743303224, 33081.0, 33335.83332083324, 33857.3228535423, 53359.0, 59750.70124649349, 61751.691241545304, 61801.38198618136, 61810.38189618226, 317511.0, 320479.0, 322712.0, 323510.0, 326876.0, 42581.78709106435, 42651.3602295972, 43063.13873722571, 43085.56914430941, 45587.54412455966, 43986.0, 48901.75549122231, 49471.752641238, 49712.25431618456, 50394.49605503898, 41285.38071928863, 41575.58424415838, 41800.0, 41917.0, 42991.785041074596, 40393.798031009654, 40672.38991415072, 41749.165016700106, 42239.0, 43050.13899722051, 41835.58164418317, 42943.0, 42946.35580466358, 43092.0, 43102.35346469868, 34698.65301347055, 35218.47172292469, 35466.8226658865, 35945.0, 36412.635873640924, 28029.439411212068, 28607.141785746462, 28696.426071478036, 28981.42037159287, 29155.85422072876], "value": 21249.495395380072, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [428.63565968926434, 430.2578052858821, 432.92856678648025, 433.60108699996, 437.840188331259, 18903.24387024519, 19311.613767724637, 19428.0, 19611.31360402386, 19846.404607861787, 19008.334708285212, 19059.809401905975, 19063.61872762544, 19523.12145953432, 19533.12100955457, 5442.945570544303, 5723.0, 5726.284214473191, 5742.253507044078, 5909.143174239733, 3914.178022615254, 5636.7181640918, 5673.886522269552, 5709.685967271798, 5901.085331773582, 5830.212921255618, 5834.6790926499025, 5857.062869940811, 5888.205092312526, 5894.0, 5779.971100144515, 5855.560832937525, 6380.138681278037, 6407.87184256317, 6407.935920640827, 5634.492895639371, 5662.745176467069, 5711.05767548354, 5718.428157184248, 5729.713514324309, 13865.4453821847, 14732.705345893022, 14735.410583576644, 14741.484048058266, 14766.704665906622, 2409.120670955106, 2474.9752502475103, 2505.9749402506104, 2578.651881995925, 2603.7005744339453, 9899.653512127114, 9939.50302484873, 10172.694819155364, 10233.64182253625, 10340.965903409675, 2015.4054553906633, 2035.0, 2051.0257627626906, 2100.306898723418, 2119.7774233705395, 76130.61934690291, 77364.22635773626, 78939.0, 80036.0, 80354.99999999942, 10470.16238700902, 10801.83797243042, 10811.18916081297, 11113.0, 11158.776824463464, 15028.924855375872, 15083.849161508244, 15153.0, 15231.847681523042, 15242.923785381225, 8575.699850505202, 8582.141785821368, 8664.0, 8769.736907892646, 8916.108389161032, 8321.833563328699, 8404.36967227448, 8416.410851240476, 8512.97844258693, 8530.146985301544, 4561.7262964222255, 4655.767211639404, 4694.718316900997, 4719.362886010414, 4778.116048531033, 1927.595205006936, 1963.8232559069752, 1967.813057759539, 2003.238769267698, 2082.843786715972, 983.9262055345878, 1075.3547871277171, 1130.2992144870234, 1133.2124173699365, 1173.038108750833, 18631.90684046598, 19335.90332048359, 19368.4189474316, 19761.60476790485, 19936.401907942785, 1061.2200032975757, 1083.6207327435334, 1131.281636161027, 1157.0801213035656, 1162.6628277799343, 10878.292910960763, 10888.61889833852, 11088.501017454233, 11096.889031109748, 11125.554977800797, 512151.0, 519342.0, 541808.0, 546079.0, 546278.0, 87360.12639873647, 90329.0, 91478.0, 91519.0848091524, 108594.45702771594, 1152.423788105947, 1162.7209469727204, 1174.9588764393204, 1210.9697257568455, 1223.3699644682995, 16993.91503042477, 17359.7396039057, 17452.127393630522, 17496.65006699884, 17580.91209543995, 40743.0, 40992.59007409888, 41790.37314440225, 41861.372079419445, 42102.15795684008, 57075.42924570867, 60162.0, 60656.69671651613, 60755.39244607498, 60864.69567652133, 9149.176574108362, 9256.0, 9261.981182070102, 9331.300152488455, 9381.953090234505, 13038.348082596021, 13073.215607063607, 13222.867771322164, 13904.652383690489, 14125.509177646878, 11541.596044138414, 12533.686657833627, 12678.112532122663, 12752.0, 12867.549635762703, 12519.0, 12573.559925402567, 12617.242965422103, 12881.291528965998, 13166.736665266833, 12272.502336833959, 12878.549250776177, 12888.291143987171, 12920.483180672667, 13133.60599182026, 8826.42628229163, 8848.64605415802, 8945.37382383227, 9078.500682462529, 9114.726558203265, 12268.754624907273, 12712.237265764084, 12750.681232968878, 12941.09412341127, 12943.5469758558], "value": 9460.13860171222, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1601.7917670702811, 1609.7746315515826, 1839.9724004139941, 1921.4139687395339, 1954.3257576136236, 7292.67182976766, 8034.076081250643, 8092.91907080929, 8271.296939760112, 8356.955380577429, 8182.754517364474, 8230.09468958414, 8251.504909705407, 8293.751187464371, 8293.958530207341, 2276.658501224813, 2278.9886050569726, 2293.1859189987563, 2299.1033496936125, 2301.689271948282, 2299.4826164113024, 2316.7104111986, 2340.941476463085, 2349.95300093998, 2365.2076554354226, 2319.1071437496603, 2328.3131476214558, 2334.323046316566, 2341.0167729553627, 2362.2795047510504, 2315.8378913476063, 2320.269115228706, 2330.2659662206433, 2332.7783860533223, 2346.5658853112227, 2351.882405879699, 2364.9881750591308, 2369.940751481227, 2374.7031621047367, 2380.8690522021284, 8404.369672274543, 8479.406441549032, 8480.957595212047, 8488.575571221476, 8503.82992340156, 5022.121128802445, 5167.819126330598, 5170.870728231786, 5174.793008279665, 5177.430482646906, 3360.512725654766, 3382.424987752088, 3412.215190506173, 3439.638837922007, 3483.3381657484997, 1154.5381847261078, 1168.5290718724698, 1194.7013246688327, 1229.8708635593223, 1233.7655845389438, 11834.940825295818, 11993.940030299967, 12057.698557536043, 12077.57728479499, 12083.879161208364, 4353.69524133314, 4426.667999900021, 4445.955540444619, 4472.664550158751, 4482.731036137842, 10240.897591024144, 10249.84625230622, 10262.179025677928, 10271.7432064199, 10273.126784223425, 5136.512031357015, 5160.870978225575, 5166.250893620404, 5198.818041368534, 5201.609879258995, 4603.171429142786, 4746.976265118652, 4752.619790416758, 4769.236922092448, 4787.0904528139545, 3765.8305376258136, 3805.257974694963, 3813.523309586302, 3856.151646637735, 3879.3599056155417, 1203.2299328429813, 1210.140800031987, 1212.442276552778, 1215.604928398274, 1225.2709637765515, 971.9757006074764, 1098.4452851310036, 1103.7406209540752, 1108.1744100645071, 1109.073923274059, 5892.793752218738, 6019.638821670714, 6144.201253837062, 6150.323464418911, 6168.9691551542855, 429.6541284266196, 430.31364972868226, 432.7749570223529, 434.32679347012004, 441.8188542697479, 4152.833886644561, 4197.916041679149, 4201.34879093741, 4204.180184863983, 4263.55232700562, 10241.129503992244, 10285.331453455501, 10440.947795260976, 10534.52594633228, 10548.156147508182, 10185.694429166988, 10293.073623373783, 10331.535080921376, 10331.741706457398, 10340.844887326695, 7956.9602151988865, 8071.677132914618, 8113.675452981933, 8227.341812655093, 8250.917490825135, 5892.823215303548, 5981.252343457068, 6026.035834266497, 6026.517878569792, 6075.453209211192, 9106.590203440728, 9194.632214711337, 9196.172344489029, 9369.578368973549, 9415.0, 8746.51894145828, 9505.334626576074, 9530.237580993642, 9551.044895510393, 9688.951555242178, 7322.63386830667, 7488.213737557696, 7547.018887544584, 7559.20628334039, 7571.46999710015, 8111.229433203836, 8125.959370203112, 8171.182881711781, 8201.71294004707, 8213.95893020531, 7254.5647261164495, 7398.519096258726, 7469.88795168062, 7538.509996850187, 7561.168271490022, 7111.573305601681, 7145.214026456982, 7178.641067946686, 7281.453890958093, 7281.927180728337, 6740.696668650021, 6939.375456208965, 6992.720291188295, 7042.577445353295, 7049.048378468841, 5183.92224116631, 5221.973890130677, 5299.602529810202, 5340.626156169031, 5392.649477784088, 5339.973300133474, 5362.088444964287, 5373.167159090191, 5495.560355171497, 5520.972395138159], "value": 4497.098755083967, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [351.4534898233248, 365.7348422393764, 369.064421691013, 369.76335145506863, 372.33538134430046, 6562.278149403568, 6612.669366531678, 6635.834104147399, 6643.069970204176, 6663.4336081433075, 6488.059231411443, 6504.382083702052, 6508.186476690402, 6511.3163117872655, 6522.054302126189, 4800.687955282913, 4932.80268789248, 4988.152014157584, 4994.150994330954, 5001.999999999991, 4922.80308787648, 4940.036692844897, 4941.234108713155, 4963.553280204781, 4969.378827646544, 4854.732989685566, 4878.512148785128, 4893.779779909894, 4899.142650036247, 4917.778699958492, 4888.535589119028, 4890.535399137077, 4900.6569540132205, 4909.582685471739, 4924.581410580105, 4293.506246781629, 4299.419578356913, 4301.075268817188, 4305.20353734557, 4305.677074219446, 6275.0, 6280.623162610258, 6286.402791734824, 6290.496760259169, 6301.87396252077, 5641.68970706611, 5641.80385970869, 5720.342160651537, 5727.99760041991, 5731.885362292731, 6790.694418751168, 6810.250872404032, 6813.080234168373, 6817.5227734058635, 6818.318168183192, 4731.124741922721, 4739.668223224376, 4740.644451666139, 4741.786619602126, 4756.167670657621, 7121.786346409616, 7189.604571748552, 7194.640267986632, 7199.89200161998, 7215.747448839318, 4852.781624826891, 4855.174620314555, 4855.980244148768, 4865.829695960695, 4869.586085182799, 4735.550122738335, 4879.414470263591, 4892.828750993698, 4894.8042078317185, 4900.436449808318, 5625.493705566437, 5710.200571919934, 5726.599138060295, 5737.799177028784, 5745.1669507921115, 6950.061741664912, 6956.5478243913985, 6956.930430695628, 6967.338102880219, 6977.89533157003, 1698.142438068792, 1741.573314537921, 1742.3988723890238, 1743.224265201973, 1749.7462867884085, 1072.619220176826, 1104.745908441063, 1120.2998126171144, 1122.820348744197, 1130.9264897781618, 6710.463162946952, 6731.899021514681, 6732.899006514906, 6738.696758645872, 6751.25736169021, 7182.964085179645, 7183.173934997438, 7186.425085993108, 7188.849784034529, 7189.712411503586, 6590.176227971504, 6724.798256052326, 6736.730530778812, 6770.390664840188, 6794.558353706993, 3887.378019516864, 3891.8637847675195, 3900.414937759302, 3902.726809123334, 3906.570277269498, 7619.619019049136, 7649.120351159577, 7653.0, 7662.0, 7668.923310766932, 7311.561306321638, 7345.485815992936, 7374.1151061872915, 7374.705011799575, 7392.889106663404, 7473.4021278297605, 7542.358899493494, 7609.162992070867, 7625.542467451971, 7631.809204769926, 7167.820804479929, 7192.100987376578, 7204.675789589586, 7205.243449437943, 7206.4234861209925, 7022.2275549688475, 7055.0, 7090.4327653788605, 7110.644467776694, 7110.680019399243, 7587.279208475186, 7607.315341619281, 7620.733274335372, 7624.656890440055, 7639.656215470428, 4760.6191504678845, 4920.5571498565305, 4932.0, 4932.728699921395, 4940.184869496493, 7183.20984691694, 7205.88308812135, 7208.531445456028, 7216.89174662391, 7234.6020968847215, 6993.965030174817, 6995.020697102512, 6997.510174287954, 7004.754833581004, 7008.859822803617, 6961.095057642474, 6981.930180698128, 6990.126234220723, 7001.859962800817, 7014.508984371249, 6739.460843132636, 6859.142607174103, 6864.21061577925, 6867.07294515234, 6888.793336199922, 6928.099347084847, 6975.407090397373, 7012.50912436145, 7020.929790702027, 7021.0, 6818.386345228755, 6821.522493425413, 6826.453883689393, 6837.453003759787, 6852.931470685229], "value": 5224.824546682258, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [933.4912472702376, 934.9205317548012, 948.9098535639114, 949.1931857920764, 958.2573505533215, 14243.430262789489, 14287.571372858805, 14374.92812535937, 14384.280785960686, 14425.062370945894, 13044.021698372637, 13326.200427974329, 14092.154470731763, 14202.218877961708, 14244.643883902907, 896.1352295035273, 906.1074841281365, 912.4160537256162, 919.3334832246635, 919.5126582911067, 912.6851236323457, 914.2594498456272, 914.4558987402485, 915.9404638698496, 916.3906002508324, 959.827231098402, 964.4020707161569, 966.0146650416606, 966.2221911361352, 971.2133172130561, 958.2860768727273, 958.4345236310576, 958.7363475044384, 963.889152747429, 970.4710932541782, 707.508281744188, 708.1891234536427, 710.350029722803, 711.5695004522292, 712.3802292005936, 13561.932190339085, 13817.447302107903, 13875.653108672263, 13946.651333716636, 13970.952178586647, 13327.866721332759, 13379.197248165141, 13400.731985360335, 13459.0, 13612.591622251348, 10836.837447438294, 11009.339439633568, 11129.554817807279, 11440.141989350748, 11478.885211147865, 3911.7362075337733, 3934.075492259317, 3964.5837187095517, 3970.1067259866586, 4004.599540046001, 55380.44619553834, 55642.44357556413, 55896.44103558994, 56406.43593564094, 57187.0, 11643.359615221074, 11643.76712465746, 11830.408479575986, 11830.467628956718, 12021.09841761854, 20090.69863952042, 20165.899170504348, 20189.394318170478, 20237.190512379635, 20286.0, 8594.0, 8603.397762156714, 8856.424332418372, 8954.149355811187, 8977.775555611162, 4956.355673762388, 5134.255532947776, 5144.15121504955, 5199.090159222121, 5278.234655974862, 3377.4427219509, 3436.226848958964, 3445.7415693823064, 3451.0854623524788, 3464.2205503761957, 670.5942904542682, 678.4979115454528, 692.8164036530324, 697.0206859362604, 699.384541603396, 720.1646090534954, 762.5424745152864, 793.6269953122023, 832.5337810825836, 837.0327190111071, 10028.949855250678, 10370.740731481774, 10410.895891040993, 10438.217133715001, 10532.473376331152, 724.9021382113452, 760.3688938181297, 770.603139383218, 847.220557087481, 867.9652813887374, 4477.843275485342, 4793.0, 4814.903701925942, 4860.416749990024, 4874.977067973038, 58827.70586147042, 60671.78656426847, 60808.08787868186, 60847.69576152091, 65614.0, 47532.5246747535, 49261.261081083816, 51697.48302517002, 53398.73300633472, 63557.0, 51739.48260517346, 54238.72880635651, 54493.455065449634, 54544.0, 54846.451535484935, 10178.13485853681, 10274.178065754872, 10462.895371046192, 10485.318454300446, 10570.154387649123, 38024.80987595155, 38585.2282954345, 40264.0, 40316.1936761269, 41158.588414115475, 44599.77700111479, 46982.76508617435, 51177.0, 51339.0, 52404.73797630987, 12874.613761587167, 12902.290374029142, 12909.289989050692, 12953.935230323788, 13076.411561479947, 13896.72206555843, 14252.429902803771, 14328.49850255236, 14398.352074156897, 14402.567922962327, 12710.110292279453, 12830.10189286741, 12882.806757898452, 12902.032347573782, 12943.676408089874, 13304.068715189844, 13409.262490563113, 13650.385732641857, 13687.931560342135, 14006.229657368942, 12858.357082146042, 13219.471221151047, 13304.733905321646, 13397.464101435833, 13573.38919748594, 11245.550177992789, 11406.600768973047, 11578.94210528942, 11582.536698532302, 11638.243514171552, 11497.2526785762, 11654.809156494104, 11692.47383867711, 11795.587154449897, 11834.704132396759], "value": 7211.097044331324, "unit": "score"}], "name": "dromaeo_css", "value": 7581.74684774281, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [107.0, 112.0, 105.0, 108.0, 112.0, 111.0, 103.0, 110.0, 109.0, 110.0], "value": 108.7, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [162.0, 131.0, 156.0, 186.0, 131.0, 157.0, 157.0, 131.0, 197.0, 128.0], "value": 153.6, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [163.0, 163.0, 162.0, 162.0, 163.0, 163.0, 161.0, 162.0, 163.0, 162.0], "value": 162.4, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [76.0, 75.0, 77.0, 167.0, 73.0, 73.0, 76.0, 74.0, 167.0, 77.0], "value": 93.5, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [93.0, 90.0, 151.0, 92.0, 92.0, 92.0, 143.0, 91.0, 92.0, 149.0], "value": 108.5, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 118.0, 117.0, 117.0, 117.0, 117.0, 117.0, 117.0, 116.0, 118.0], "value": 117.1, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [147.0, 148.0, 146.0, 146.0, 148.0, 147.0, 147.0, 146.0, 146.0, 146.0], "value": 146.7, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [101.0, 95.0, 95.0, 97.0, 95.0, 98.0, 95.0, 94.0, 95.0, 95.0], "value": 96.0, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [55.0, 56.0, 55.0, 55.0, 54.0, 56.0, 60.0, 71.0, 62.0, 58.0], "value": 58.2, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [56.0, 57.0, 57.0, 56.0, 58.0, 57.0, 57.0, 57.0, 56.0, 57.0], "value": 56.8, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [81.0, 73.0, 73.0, 76.0, 74.0, 75.0, 75.0, 82.0, 73.0, 73.0], "value": 75.5, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [110.0, 123.0, 116.0, 122.0, 130.0, 117.0, 113.0, 112.0, 126.0, 139.0], "value": 120.8, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [164.0, 162.0, 159.0, 162.0, 169.0, 161.0, 162.0, 161.0, 163.0, 157.0], "value": 162.0, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [66.0, 68.0, 68.0, 74.0, 66.0, 67.0, 67.0, 68.0, 67.0, 67.0], "value": 67.8, "unit": "score"}], "name": "kraken", "value": 1527.6, "alertThreshold": 2.0}]} 23:26:34 INFO - Return code: 0 23:26:34 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 23:26:34 ERROR - # TBPL SUCCESS # 23:26:34 INFO - Running post-action listener: _resource_record_post_action 23:26:34 INFO - Running post-run listener: _resource_record_post_run 23:26:36 INFO - Total resource usage - Wall time: 1188s; CPU: 13.0%; Read bytes: 98304; Write bytes: 462331904; Read time: 620; Write time: 1346648 23:26:36 INFO - install - Wall time: 15s; CPU: 20.0%; Read bytes: 36864; Write bytes: 243146752; Read time: 272; Write time: 1084020 23:26:36 INFO - run-tests - Wall time: 1173s; CPU: 13.0%; Read bytes: 61440; Write bytes: 218705920; Read time: 348; Write time: 262576 23:26:36 INFO - Running post-run listener: _upload_blobber_files 23:26:36 INFO - Blob upload gear active. 23:26:36 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 23:26:36 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:36 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:36 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:36 INFO - (blobuploader) - INFO - Open directory for files ... 23:26:36 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 23:26:36 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 23:26:36 INFO - (blobuploader) - INFO - Uploading, attempt #1. 23:26:37 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 23:26:37 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 23:26:37 INFO - (blobuploader) - INFO - Done attempting. 23:26:37 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 23:26:37 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 23:26:37 INFO - (blobuploader) - INFO - Uploading, attempt #1. 23:26:38 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 23:26:38 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 23:26:38 INFO - (blobuploader) - INFO - Done attempting. 23:26:38 INFO - (blobuploader) - INFO - Iteration through files over. 23:26:38 INFO - Return code: 0 23:26:38 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 23:26:38 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 23:26:38 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/eb39ce4ce01b9208c3e45c7772cfc2330ade1b35e0b59c1e87da780ae0f87f1aab2a1a419b9dc258be3110d5fd31f30c2732d3a9c4e1a546d429f51fbcaaed8f", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/4f5d3ecf2077990c9feb0da5bb2f39cfd434f2d9ff1bd9d42aac53ca1af96a253249771ef1d3e01acdaedbaf8ddc2390f8fa26a6a421246904a6fc9817e09c12"} 23:26:38 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 23:26:38 INFO - Writing to file /builds/slave/test/properties/blobber_files 23:26:38 INFO - Contents: 23:26:38 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/eb39ce4ce01b9208c3e45c7772cfc2330ade1b35e0b59c1e87da780ae0f87f1aab2a1a419b9dc258be3110d5fd31f30c2732d3a9c4e1a546d429f51fbcaaed8f", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/4f5d3ecf2077990c9feb0da5bb2f39cfd434f2d9ff1bd9d42aac53ca1af96a253249771ef1d3e01acdaedbaf8ddc2390f8fa26a6a421246904a6fc9817e09c12"} 23:26:38 INFO - Running post-run listener: copy_logs_to_upload_dir 23:26:38 INFO - Copying logs to upload dir... 23:26:38 INFO - mkdir: /builds/slave/test/build/upload/logs 23:26:38 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1233.763611 ========= master_lag: 0.03 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 33 secs) (at 2016-07-02 23:26:37.879650) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-07-02 23:26:37.882933) ========= 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=df17445c3590ff7897617a0e00000225-1467524809.598142-20049566 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/eb39ce4ce01b9208c3e45c7772cfc2330ade1b35e0b59c1e87da780ae0f87f1aab2a1a419b9dc258be3110d5fd31f30c2732d3a9c4e1a546d429f51fbcaaed8f", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/4f5d3ecf2077990c9feb0da5bb2f39cfd434f2d9ff1bd9d42aac53ca1af96a253249771ef1d3e01acdaedbaf8ddc2390f8fa26a6a421246904a6fc9817e09c12"} 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.011349 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-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/eb39ce4ce01b9208c3e45c7772cfc2330ade1b35e0b59c1e87da780ae0f87f1aab2a1a419b9dc258be3110d5fd31f30c2732d3a9c4e1a546d429f51fbcaaed8f", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/4f5d3ecf2077990c9feb0da5bb2f39cfd434f2d9ff1bd9d42aac53ca1af96a253249771ef1d3e01acdaedbaf8ddc2390f8fa26a6a421246904a6fc9817e09c12"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-07-02 23:26:37.914665) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-07-02 23:26:37.915007) ========= 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=df17445c3590ff7897617a0e00000225-1467524809.598142-20049566 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004538 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-07-02 23:26:37.996416) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-07-02 23:26:37.999819) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-07-02 23:26:38.000151) ========= ========= Total master_lag: 0.20 =========