builder: mozilla-beta_ubuntu64_hw_test-dromaeojs-e10s-pgo slave: talos-linux64-ix-068 starttime: 1467525960.95 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.953869) ========= 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.954324) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 1 secs) (at 2016-07-02 23:06:00.954616) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 1 secs) (at 2016-07-02 23:06:02.875768) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-02 23:06:02.876073) ========= 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=97facb8ba2ac28944cc45e6b000001d4-1467519811.557221-1149711480 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% 18.2M=0.001s 2016-07-02 23:06:03 (18.2 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.130914 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-02 23:06:03.028842) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-07-02 23:06:03.029315) ========= 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=97facb8ba2ac28944cc45e6b000001d4-1467519811.557221-1149711480 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.022011 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-07-02 23:06:03.082272) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-07-02 23:06:03.082627) ========= 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=97facb8ba2ac28944cc45e6b000001d4-1467519811.557221-1149711480 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-07-02 23:06:03,955 truncating revision to first 12 chars 2016-07-02 23:06:03,955 Setting DEBUG logging. 2016-07-02 23:06:03,955 attempt 1/10 2016-07-02 23:06:03,956 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-beta/5e6976a28642?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-07-02 23:06:04,672 unpacking tar archive at: mozilla-beta-5e6976a28642/testing/mozharness/ program finished with exit code 0 elapsedTime=1.114545 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-07-02 23:06:04.210630) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-07-02 23:06:04.210938) ========= script_repo_revision: 5e6976a28642d4d159071e14fd3251d76b9c46fa ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-07-02 23:06:04.211360) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-07-02 23:06:04.211679) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-07-02 23:06:04.240051) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 47 secs) (at 2016-07-02 23:06:04.240610) ========= /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=97facb8ba2ac28944cc45e6b000001d4-1467519811.557221-1149711480 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 23:06:05 INFO - MultiFileLogger online at 20160702 23:06:05 in /builds/slave/test 23:06:05 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-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:05 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 23:06:05 INFO - {'append_to_log': False, 23:06:05 INFO - 'base_work_dir': '/builds/slave/test', 23:06:05 INFO - 'blob_upload_branch': 'Mozilla-Beta', 23:06:05 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 23:06:05 INFO - 'branch': 'Mozilla-Beta', 23:06:05 INFO - 'buildbot_json_path': 'buildprops.json', 23:06:05 INFO - 'config_files': ('talos/linux_config.py',), 23:06:05 INFO - 'default_actions': ('clobber', 23:06:05 INFO - 'read-buildbot-config', 23:06:05 INFO - 'download-and-extract', 23:06:05 INFO - 'populate-webroot', 23:06:05 INFO - 'create-virtualenv', 23:06:05 INFO - 'install', 23:06:05 INFO - 'run-tests'), 23:06:05 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 23:06:05 INFO - 'download_minidump_stackwalk': True, 23:06:05 INFO - 'download_symbols': 'ondemand', 23:06:05 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 23:06:05 INFO - 'tooltool.py': '/tools/tooltool.py', 23:06:05 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 23:06:05 INFO - '/tools/misc-python/virtualenv.py')}, 23:06:05 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 23:06:05 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 23:06:05 INFO - 'installer_path': 'installer.exe', 23:06:05 INFO - 'log_level': 'info', 23:06:05 INFO - 'log_name': 'talos', 23:06:05 INFO - 'log_to_console': True, 23:06:05 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 23:06:05 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 23:06:05 INFO - 'opt_config_files': (), 23:06:05 INFO - 'pip_index': False, 23:06:05 INFO - 'sps_profile': False, 23:06:05 INFO - 'sps_profile_interval': 0, 23:06:05 INFO - 'suite': 'dromaeojs-e10s', 23:06:05 INFO - 'system_bits': '32', 23:06:05 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 23:06:05 INFO - 'title': 'talos-linux64-ix-068', 23:06:05 INFO - 'tooltool_cache': '/builds/tooltool_cache', 23:06:05 INFO - 'use_talos_json': True, 23:06:05 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 23:06:05 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 23:06:05 INFO - 'work_dir': 'build'} 23:06:05 INFO - ##### 23:06:05 INFO - ##### Running clobber step. 23:06:05 INFO - ##### 23:06:05 INFO - Running pre-action listener: _resource_record_pre_action 23:06:05 INFO - Running main action method: clobber 23:06:05 INFO - rmtree: /builds/slave/test/build 23:06:05 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 23:06:06 INFO - Running post-action listener: _resource_record_post_action 23:06:06 INFO - ##### 23:06:06 INFO - ##### Running read-buildbot-config step. 23:06:06 INFO - ##### 23:06:06 INFO - Running pre-action listener: _resource_record_pre_action 23:06:06 INFO - Running main action method: read_buildbot_config 23:06:06 INFO - Using buildbot properties: 23:06:06 INFO - { 23:06:06 INFO - "project": "", 23:06:06 INFO - "product": "firefox", 23:06:06 INFO - "script_repo_revision": "production", 23:06:06 INFO - "builddir": "mozilla-beta_ubuntu64_hw_test-dromaeojs-e10s", 23:06:06 INFO - "repository": "", 23:06:06 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-beta pgo talos dromaeojs-e10s", 23:06:06 INFO - "buildid": "20160701065031", 23:06:06 INFO - "pgo_build": "True", 23:06:06 INFO - "basedir": "/builds/slave/test", 23:06:06 INFO - "buildnumber": 79, 23:06:06 INFO - "slavename": "talos-linux64-ix-068", 23:06:06 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 23:06:06 INFO - "platform": "ubuntu64_hw", 23:06:06 INFO - "scheduler": "tests-mozilla-beta-linux64-pgo-talos", 23:06:06 INFO - "branch": "mozilla-beta", 23:06:06 INFO - "repo_path": "releases/mozilla-beta", 23:06:06 INFO - "revision": "5e6976a28642d4d159071e14fd3251d76b9c46fa", 23:06:06 INFO - "stage_platform": "linux64-pgo", 23:06:06 INFO - "builduid": "c767f5fb4f57427c8722dbadfbf73505", 23:06:06 INFO - "slavebuilddir": "test" 23:06:06 INFO - } 23:06:06 INFO - Found installer url https://queue.taskcluster.net/v1/task/Aava5bJ9QCOkDkcxZYB98w/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.tar.bz2. 23:06:06 INFO - Running post-action listener: _resource_record_post_action 23:06:06 INFO - ##### 23:06:06 INFO - ##### Running download-and-extract step. 23:06:06 INFO - ##### 23:06:06 INFO - Running pre-action listener: _resource_record_pre_action 23:06:06 INFO - Running main action method: download_and_extract 23:06:06 INFO - mkdir: /builds/slave/test/build/tests 23:06:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 23:06:06 INFO - https://queue.taskcluster.net/v1/task/Aava5bJ9QCOkDkcxZYB98w/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 23:06:06 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Aava5bJ9QCOkDkcxZYB98w/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.test_packages.json 23:06:06 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Aava5bJ9QCOkDkcxZYB98w/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.test_packages.json 23:06:06 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Aava5bJ9QCOkDkcxZYB98w/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-48.0.en-US.linux-x86_64.test_packages.json 23:06:06 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Aava5bJ9QCOkDkcxZYB98w/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-48.0.en-US.linux-x86_64.test_packages.json'}, attempt #1 23:06:10 INFO - Downloaded 1327 bytes. 23:06:10 INFO - Reading from file /builds/slave/test/build/firefox-48.0.en-US.linux-x86_64.test_packages.json 23:06:10 INFO - Using the following test package requirements: 23:06:10 INFO - {u'common': [u'firefox-48.0.en-US.linux-x86_64.common.tests.zip'], 23:06:10 INFO - u'cppunittest': [u'firefox-48.0.en-US.linux-x86_64.common.tests.zip', 23:06:10 INFO - u'firefox-48.0.en-US.linux-x86_64.cppunittest.tests.zip'], 23:06:10 INFO - u'gtest': [u'firefox-48.0.en-US.linux-x86_64.common.tests.zip', 23:06:10 INFO - u'firefox-48.0.en-US.linux-x86_64.gtest.tests.zip'], 23:06:10 INFO - u'jittest': [u'firefox-48.0.en-US.linux-x86_64.common.tests.zip', 23:06:10 INFO - u'jsshell-linux-x86_64.zip'], 23:06:10 INFO - u'mochitest': [u'firefox-48.0.en-US.linux-x86_64.common.tests.zip', 23:06:10 INFO - u'firefox-48.0.en-US.linux-x86_64.mochitest.tests.zip'], 23:06:10 INFO - u'mozbase': [u'firefox-48.0.en-US.linux-x86_64.common.tests.zip'], 23:06:10 INFO - u'reftest': [u'firefox-48.0.en-US.linux-x86_64.common.tests.zip', 23:06:10 INFO - u'firefox-48.0.en-US.linux-x86_64.reftest.tests.zip'], 23:06:10 INFO - u'talos': [u'firefox-48.0.en-US.linux-x86_64.common.tests.zip', 23:06:10 INFO - u'firefox-48.0.en-US.linux-x86_64.talos.tests.zip'], 23:06:10 INFO - u'web-platform': [u'firefox-48.0.en-US.linux-x86_64.common.tests.zip', 23:06:10 INFO - u'firefox-48.0.en-US.linux-x86_64.web-platform.tests.zip'], 23:06:10 INFO - u'xpcshell': [u'firefox-48.0.en-US.linux-x86_64.common.tests.zip', 23:06:10 INFO - u'firefox-48.0.en-US.linux-x86_64.xpcshell.tests.zip']} 23:06:10 INFO - Downloading packages: [u'firefox-48.0.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 23:06:10 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:10 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:10 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:10 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:10 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:10 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:32 INFO - Downloaded 24236612 bytes. 23:06:32 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:32 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:34 INFO - Return code: 0 23:06:34 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:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 23:06:34 INFO - 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:34 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:34 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:34 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:34 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:07:04 WARNING - Timed out accessing 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: timed out 23:07:04 INFO - retry: attempt #1 caught exception: timed out 23:07:04 INFO - retry: Failed, sleeping 30 seconds before retrying 23:07:34 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 #2 23:07:35 INFO - Downloaded 24236612 bytes. 23:07:35 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:07:35 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:07:36 INFO - Return code: 0 23:07:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 23:07:36 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:07:36 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:07:36 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:07:36 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:07:36 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:07:37 INFO - Downloaded 10840145 bytes. 23:07:37 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:07:37 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:07:37 INFO - Return code: 0 23:07: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:07:37 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:07:37 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:07:37 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:07:37 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:07:37 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:07:39 INFO - Downloaded 56023399 bytes. 23:07:39 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:07:39 INFO - mkdir: /builds/slave/test/properties 23:07:39 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 23:07:39 INFO - Writing to file /builds/slave/test/properties/build_url 23:07:39 INFO - Contents: 23:07:39 INFO - build_url:https://queue.taskcluster.net/v1/task/Aava5bJ9QCOkDkcxZYB98w/artifacts/public/build/firefox-48.0.en-US.linux-x86_64.tar.bz2 23:07:40 INFO - Running post-action listener: _resource_record_post_action 23:07:40 INFO - Running post-action listener: set_extra_try_arguments 23:07:40 INFO - ##### 23:07:40 INFO - ##### Running populate-webroot step. 23:07:40 INFO - ##### 23:07:40 INFO - Running pre-action listener: _resource_record_pre_action 23:07:40 INFO - Running main action method: populate_webroot 23:07:40 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 23:07:40 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 23:07:40 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 23:07:40 INFO - '--tppagecycles', 23:07:40 INFO - '7'], 23:07:40 INFO - 'tests': ['tsvgm']}}, 23:07:40 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 23:07:40 INFO - 'tests': ['tresize', 'tcanvasmark']}, 23:07:40 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 23:07:40 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 23:07:40 INFO - 'tests': ['dromaeo_css', 'kraken']}, 23:07:40 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 23:07:40 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 23:07:40 INFO - 'talos_options': ['--disable-e10s'], 23:07:40 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 23:07:40 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 23:07:40 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 23:07:40 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 23:07:40 INFO - 'talos_options': ['--disable-e10s'], 23:07:40 INFO - 'tests': ['damp', 'tps']}, 23:07:40 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 23:07:40 INFO - 'tests': ['damp', 'tps']}, 23:07:40 INFO - 'g3': {'talos_options': ['--disable-e10s'], 23:07:40 INFO - 'tests': ['dromaeo_dom']}, 23:07:40 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 23:07:40 INFO - 'other': {'talos_options': ['--disable-e10s'], 23:07:40 INFO - 'tests': ['a11yr', 23:07:40 INFO - 'ts_paint', 23:07:40 INFO - 'tpaint', 23:07:40 INFO - 'sessionrestore', 23:07:40 INFO - 'sessionrestore_no_auto_restore', 23:07:40 INFO - 'tabpaint']}, 23:07:40 INFO - 'other-e10s': {'tests': ['a11yr', 23:07:40 INFO - 'ts_paint', 23:07:40 INFO - 'tpaint', 23:07:40 INFO - 'sessionrestore', 23:07:40 INFO - 'sessionrestore_no_auto_restore', 23:07:40 INFO - 'tabpaint']}, 23:07:40 INFO - 'other-e10s_l64': {'tests': ['a11yr', 23:07:40 INFO - 'ts_paint', 23:07:40 INFO - 'tpaint', 23:07:40 INFO - 'sessionrestore', 23:07:40 INFO - 'sessionrestore_no_auto_restore', 23:07:40 INFO - 'tabpaint']}, 23:07:40 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 23:07:40 INFO - 'ts_paint', 23:07:40 INFO - 'tpaint', 23:07:40 INFO - 'sessionrestore', 23:07:40 INFO - 'sessionrestore_no_auto_restore', 23:07:40 INFO - 'tabpaint']}, 23:07:40 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 23:07:40 INFO - 'tests': ['a11yr', 23:07:40 INFO - 'ts_paint', 23:07:40 INFO - 'tpaint', 23:07:40 INFO - 'sessionrestore', 23:07:40 INFO - 'sessionrestore_no_auto_restore', 23:07:40 INFO - 'tabpaint']}, 23:07:40 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 23:07:40 INFO - 'tests': ['a11yr', 23:07:40 INFO - 'ts_paint', 23:07:40 INFO - 'tpaint', 23:07:40 INFO - 'sessionrestore', 23:07:40 INFO - 'sessionrestore_no_auto_restore', 23:07:40 INFO - 'tabpaint']}, 23:07:40 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 23:07:40 INFO - 'tests': ['tsvgx', 23:07:40 INFO - 'tsvgr_opacity', 23:07:40 INFO - 'tart', 23:07:40 INFO - 'tscrollx', 23:07:40 INFO - 'cart']}, 23:07:40 INFO - 'svgr-e10s': {'tests': ['tsvgx', 23:07:40 INFO - 'tsvgr_opacity', 23:07:40 INFO - 'tart', 23:07:40 INFO - 'tscrollx', 23:07:40 INFO - 'cart']}, 23:07:40 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 23:07:40 INFO - 'talos_options': ['--disable-e10s'], 23:07:40 INFO - 'tests': ['tp5o']}, 23:07:40 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 23:07:40 INFO - 'tests': ['tp5o']}, 23:07:40 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 23:07:40 INFO - 'talos_options': ['--disable-e10s', 23:07:40 INFO - '--xperf_path', 23:07:40 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 23:07:40 INFO - 'tests': ['tp5n']}, 23:07:40 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 23:07:40 INFO - 'talos_options': ['--xperf_path', 23:07:40 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 23:07:40 INFO - 'tests': ['tp5n']}}, 23:07:40 INFO - 'talos.zip': {'path': '', 23:07:40 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 23:07:40 INFO - Running post-action listener: _resource_record_post_action 23:07:40 INFO - ##### 23:07:40 INFO - ##### Running create-virtualenv step. 23:07:40 INFO - ##### 23:07:40 INFO - Running pre-action listener: _resource_record_pre_action 23:07:40 INFO - Running main action method: create_virtualenv 23:07:40 INFO - Creating virtualenv /builds/slave/test/build/venv 23:07:40 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:07:40 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 23:07:40 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 23:07:40 INFO - Using real prefix '/usr' 23:07:40 INFO - New python executable in /builds/slave/test/build/venv/bin/python 23:07:40 INFO - Installing distribute.............................................................................................................................................................................................done. 23:07:42 INFO - Installing pip.................done. 23:07:42 INFO - Return code: 0 23:07:42 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 23:07:42 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:42 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 23:07:42 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:07:42 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:42 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 23:07:42 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:07:42 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 0x7ff9fbaa9f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x205c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x21275a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21b6410>, '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 0x21b7310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x21b77a0>, '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': '97facb8ba2ac28944cc45e6b000001d4-1467519811.557221-1149711480', '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:07:42 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:07:42 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:07:42 INFO - Using env: {'DISPLAY': ':0', 23:07:42 INFO - 'HOME': '/home/cltbld', 23:07:42 INFO - 'LANG': 'en_US.UTF-8', 23:07:42 INFO - 'LANGUAGE': 'en_US:en', 23:07:42 INFO - 'LOGNAME': 'cltbld', 23:07:42 INFO - 'MAIL': '/var/mail/cltbld', 23:07:42 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:07:42 INFO - 'MOZ_NO_REMOTE': '1', 23:07:42 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 23:07:42 INFO - 'NO_EM_RESTART': '1', 23:07:42 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 23:07:42 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 23:07:42 INFO - 'PWD': '/builds/slave/test', 23:07:42 INFO - 'SHELL': '/bin/bash', 23:07:42 INFO - 'SHLVL': '1', 23:07:42 INFO - 'TERM': 'linux', 23:07:42 INFO - 'TMOUT': '86400', 23:07:42 INFO - 'USER': 'cltbld', 23:07:42 INFO - 'XDG_SESSION_COOKIE': '97facb8ba2ac28944cc45e6b000001d4-1467519811.557221-1149711480', 23:07:42 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:07:42 INFO - '_': '/tools/buildbot/bin/python'} 23:07:42 INFO - Ignoring indexes: https://pypi.python.org/simple/ 23:07:42 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:07:42 INFO - Cleaning up... 23:07:42 INFO - Return code: 0 23:07:42 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 23:07:42 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:42 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 23:07:42 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:07:42 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:42 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 23:07:42 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:07:42 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 0x7ff9fbaa9f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x205c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x21275a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21b6410>, '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 0x21b7310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x21b77a0>, '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': '97facb8ba2ac28944cc45e6b000001d4-1467519811.557221-1149711480', '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:07:42 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:07:42 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:07:42 INFO - Using env: {'DISPLAY': ':0', 23:07:42 INFO - 'HOME': '/home/cltbld', 23:07:42 INFO - 'LANG': 'en_US.UTF-8', 23:07:42 INFO - 'LANGUAGE': 'en_US:en', 23:07:42 INFO - 'LOGNAME': 'cltbld', 23:07:42 INFO - 'MAIL': '/var/mail/cltbld', 23:07:42 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:07:42 INFO - 'MOZ_NO_REMOTE': '1', 23:07:42 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 23:07:42 INFO - 'NO_EM_RESTART': '1', 23:07:42 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 23:07:42 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 23:07:42 INFO - 'PWD': '/builds/slave/test', 23:07:42 INFO - 'SHELL': '/bin/bash', 23:07:42 INFO - 'SHLVL': '1', 23:07:42 INFO - 'TERM': 'linux', 23:07:42 INFO - 'TMOUT': '86400', 23:07:42 INFO - 'USER': 'cltbld', 23:07:42 INFO - 'XDG_SESSION_COOKIE': '97facb8ba2ac28944cc45e6b000001d4-1467519811.557221-1149711480', 23:07:42 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:07:42 INFO - '_': '/tools/buildbot/bin/python'} 23:07:43 INFO - Ignoring indexes: https://pypi.python.org/simple/ 23:07:43 INFO - Downloading/unpacking psutil>=0.7.1 23:07: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:07: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:07: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:07: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:07: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:07: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:07:45 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 23:07:45 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 23:07:45 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 23:07:45 INFO - Installing collected packages: psutil 23:07:45 INFO - Running setup.py install for psutil 23:07:45 INFO - building 'psutil._psutil_linux' extension 23:07:45 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:07:45 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:07:45 INFO - building 'psutil._psutil_posix' extension 23:07:45 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:07:45 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:07:45 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 23:07:45 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 23:07:45 INFO - Successfully installed psutil 23:07:45 INFO - Cleaning up... 23:07:45 INFO - Return code: 0 23:07:45 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 23:07:45 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:45 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 23:07:45 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:07:45 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:45 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 23:07:45 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:07:45 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 0x7ff9fbaa9f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x205c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x21275a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21b6410>, '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 0x21b7310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x21b77a0>, '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': '97facb8ba2ac28944cc45e6b000001d4-1467519811.557221-1149711480', '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:07:45 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:07:45 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:07:45 INFO - Using env: {'DISPLAY': ':0', 23:07:45 INFO - 'HOME': '/home/cltbld', 23:07:45 INFO - 'LANG': 'en_US.UTF-8', 23:07:45 INFO - 'LANGUAGE': 'en_US:en', 23:07:45 INFO - 'LOGNAME': 'cltbld', 23:07:45 INFO - 'MAIL': '/var/mail/cltbld', 23:07:45 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:07:45 INFO - 'MOZ_NO_REMOTE': '1', 23:07:45 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 23:07:45 INFO - 'NO_EM_RESTART': '1', 23:07:45 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 23:07:45 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 23:07:45 INFO - 'PWD': '/builds/slave/test', 23:07:45 INFO - 'SHELL': '/bin/bash', 23:07:45 INFO - 'SHLVL': '1', 23:07:45 INFO - 'TERM': 'linux', 23:07:45 INFO - 'TMOUT': '86400', 23:07:45 INFO - 'USER': 'cltbld', 23:07:45 INFO - 'XDG_SESSION_COOKIE': '97facb8ba2ac28944cc45e6b000001d4-1467519811.557221-1149711480', 23:07:45 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:07:45 INFO - '_': '/tools/buildbot/bin/python'} 23:07:45 INFO - Ignoring indexes: https://pypi.python.org/simple/ 23:07:45 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 23:07: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:07: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:07: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:07: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:07: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:07: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:07:47 INFO - Downloading mozsystemmonitor-0.0.tar.gz 23:07:47 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 23:07:47 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:07:47 INFO - Installing collected packages: mozsystemmonitor 23:07:47 INFO - Running setup.py install for mozsystemmonitor 23:07:47 INFO - Successfully installed mozsystemmonitor 23:07:47 INFO - Cleaning up... 23:07:47 INFO - Return code: 0 23:07:47 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 23:07:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 23:07:47 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 23:07:47 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:07:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 23:07:47 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 23:07:47 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:07:47 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 0x7ff9fbaa9f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x205c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x21275a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21b6410>, '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 0x21b7310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x21b77a0>, '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': '97facb8ba2ac28944cc45e6b000001d4-1467519811.557221-1149711480', '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:07:47 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:07:47 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:07:47 INFO - Using env: {'DISPLAY': ':0', 23:07:47 INFO - 'HOME': '/home/cltbld', 23:07:47 INFO - 'LANG': 'en_US.UTF-8', 23:07:47 INFO - 'LANGUAGE': 'en_US:en', 23:07:47 INFO - 'LOGNAME': 'cltbld', 23:07:47 INFO - 'MAIL': '/var/mail/cltbld', 23:07:47 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:07:47 INFO - 'MOZ_NO_REMOTE': '1', 23:07:47 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 23:07:47 INFO - 'NO_EM_RESTART': '1', 23:07:47 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 23:07:47 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 23:07:47 INFO - 'PWD': '/builds/slave/test', 23:07:47 INFO - 'SHELL': '/bin/bash', 23:07:47 INFO - 'SHLVL': '1', 23:07:47 INFO - 'TERM': 'linux', 23:07:47 INFO - 'TMOUT': '86400', 23:07:47 INFO - 'USER': 'cltbld', 23:07:47 INFO - 'XDG_SESSION_COOKIE': '97facb8ba2ac28944cc45e6b000001d4-1467519811.557221-1149711480', 23:07:47 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:07:47 INFO - '_': '/tools/buildbot/bin/python'} 23:07:48 INFO - Ignoring indexes: https://pypi.python.org/simple/ 23:07:48 INFO - Downloading/unpacking blobuploader==1.2.4 23:07:48 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:07:48 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:07:48 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:07:48 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:07:48 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:07:48 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:07:50 INFO - Downloading blobuploader-1.2.4.tar.gz 23:07:50 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 23:07:50 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 23:07:50 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:07:50 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:07:50 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:07:50 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:07:50 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:07:50 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:07:50 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 23:07:50 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 23:07:50 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:07:50 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:07:50 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:07:50 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:07:50 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:07:50 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:07:50 INFO - Downloading docopt-0.6.1.tar.gz 23:07:50 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 23:07:50 INFO - Installing collected packages: blobuploader, requests, docopt 23:07:50 INFO - Running setup.py install for blobuploader 23:07:50 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 23:07:50 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 23:07:50 INFO - Running setup.py install for requests 23:07:51 INFO - Running setup.py install for docopt 23:07:51 INFO - Successfully installed blobuploader requests docopt 23:07:51 INFO - Cleaning up... 23:07:51 INFO - Return code: 0 23:07:51 INFO - Installing None into virtualenv /builds/slave/test/build/venv 23:07:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 23:07:51 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 23:07:51 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:07:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 23:07:51 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 23:07:51 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:07:51 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 0x7ff9fbaa9f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x205c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x21275a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21b6410>, '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 0x21b7310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x21b77a0>, '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': '97facb8ba2ac28944cc45e6b000001d4-1467519811.557221-1149711480', '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:07:51 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:07:51 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:07:51 INFO - Using env: {'DISPLAY': ':0', 23:07:51 INFO - 'HOME': '/home/cltbld', 23:07:51 INFO - 'LANG': 'en_US.UTF-8', 23:07:51 INFO - 'LANGUAGE': 'en_US:en', 23:07:51 INFO - 'LOGNAME': 'cltbld', 23:07:51 INFO - 'MAIL': '/var/mail/cltbld', 23:07:51 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:07:51 INFO - 'MOZ_NO_REMOTE': '1', 23:07:51 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 23:07:51 INFO - 'NO_EM_RESTART': '1', 23:07:51 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 23:07:51 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 23:07:51 INFO - 'PWD': '/builds/slave/test', 23:07:51 INFO - 'SHELL': '/bin/bash', 23:07:51 INFO - 'SHLVL': '1', 23:07:51 INFO - 'TERM': 'linux', 23:07:51 INFO - 'TMOUT': '86400', 23:07:51 INFO - 'USER': 'cltbld', 23:07:51 INFO - 'XDG_SESSION_COOKIE': '97facb8ba2ac28944cc45e6b000001d4-1467519811.557221-1149711480', 23:07:51 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:07:51 INFO - '_': '/tools/buildbot/bin/python'} 23:07:51 INFO - Ignoring indexes: https://pypi.python.org/simple/ 23:07:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 23:07:51 INFO - Running setup.py (path:/tmp/pip-JXOPyD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 23:07:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 23:07:51 INFO - Running setup.py (path:/tmp/pip-rgcxll-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 23:07:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 23:07:51 INFO - Running setup.py (path:/tmp/pip-hkNBdO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 23:07:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 23:07:51 INFO - Running setup.py (path:/tmp/pip-wTLY4v-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 23:07:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 23:07:51 INFO - Running setup.py (path:/tmp/pip-RPtf8Y-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 23:07:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 23:07:52 INFO - Running setup.py (path:/tmp/pip-qJBWjv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 23:07:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 23:07:52 INFO - Running setup.py (path:/tmp/pip-220_xz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 23:07:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 23:07:52 INFO - Running setup.py (path:/tmp/pip-z9hs6j-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 23:07:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 23:07:52 INFO - Running setup.py (path:/tmp/pip-BRfoy6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 23:07:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 23:07:52 INFO - Running setup.py (path:/tmp/pip-dOB3wd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 23:07:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 23:07:52 INFO - Running setup.py (path:/tmp/pip-rYsH73-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 23:07:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 23:07:52 INFO - Running setup.py (path:/tmp/pip-JqOVb3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 23:07:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 23:07:52 INFO - Running setup.py (path:/tmp/pip-g5xh0V-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 23:07:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 23:07:52 INFO - Running setup.py (path:/tmp/pip-NbQR1D-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 23:07:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 23:07:52 INFO - Running setup.py (path:/tmp/pip-u77hcr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 23:07:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 23:07:52 INFO - Running setup.py (path:/tmp/pip-DiHzgY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 23:07:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 23:07:52 INFO - Running setup.py (path:/tmp/pip-DAWFOC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 23:07:52 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 23:07:52 INFO - Running setup.py install for manifestparser 23:07:53 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 23:07:53 INFO - Running setup.py install for mozcrash 23:07:53 INFO - Running setup.py install for mozdebug 23:07:53 INFO - Running setup.py install for mozdevice 23:07:53 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 23:07:53 INFO - Installing dm script to /builds/slave/test/build/venv/bin 23:07:53 INFO - Running setup.py install for mozfile 23:07:53 INFO - Running setup.py install for mozhttpd 23:07:53 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 23:07:53 INFO - Running setup.py install for mozinfo 23:07:53 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 23:07:53 INFO - Running setup.py install for mozInstall 23:07:53 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 23:07:53 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 23:07:53 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 23:07:53 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 23:07:53 INFO - Running setup.py install for mozleak 23:07:53 INFO - Running setup.py install for mozlog 23:07:53 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 23:07:53 INFO - Running setup.py install for moznetwork 23:07:54 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 23:07:54 INFO - Running setup.py install for mozprocess 23:07:54 INFO - Running setup.py install for mozprofile 23:07:54 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 23:07:54 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 23:07:54 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 23:07:54 INFO - Running setup.py install for mozrunner 23:07:54 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 23:07:54 INFO - Running setup.py install for mozscreenshot 23:07:54 INFO - Running setup.py install for moztest 23:07:54 INFO - Running setup.py install for mozversion 23:07:54 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 23:07:54 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 23:07:54 INFO - Cleaning up... 23:07:54 INFO - Return code: 0 23:07:54 INFO - Installing None into virtualenv /builds/slave/test/build/venv 23:07:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 23:07:54 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 23:07:54 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:07:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 23:07:54 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 23:07:54 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:07:54 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 0x7ff9fbaa9f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x205c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x21275a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21b6410>, '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 0x21b7310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x21b77a0>, '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': '97facb8ba2ac28944cc45e6b000001d4-1467519811.557221-1149711480', '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:07:54 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:07:54 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:07:54 INFO - Using env: {'DISPLAY': ':0', 23:07:54 INFO - 'HOME': '/home/cltbld', 23:07:54 INFO - 'LANG': 'en_US.UTF-8', 23:07:54 INFO - 'LANGUAGE': 'en_US:en', 23:07:54 INFO - 'LOGNAME': 'cltbld', 23:07:54 INFO - 'MAIL': '/var/mail/cltbld', 23:07:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:07:54 INFO - 'MOZ_NO_REMOTE': '1', 23:07:54 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 23:07:54 INFO - 'NO_EM_RESTART': '1', 23:07:54 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 23:07:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 23:07:54 INFO - 'PWD': '/builds/slave/test', 23:07:54 INFO - 'SHELL': '/bin/bash', 23:07:54 INFO - 'SHLVL': '1', 23:07:54 INFO - 'TERM': 'linux', 23:07:54 INFO - 'TMOUT': '86400', 23:07:54 INFO - 'USER': 'cltbld', 23:07:54 INFO - 'XDG_SESSION_COOKIE': '97facb8ba2ac28944cc45e6b000001d4-1467519811.557221-1149711480', 23:07:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:07:54 INFO - '_': '/tools/buildbot/bin/python'} 23:07:54 INFO - Ignoring indexes: https://pypi.python.org/simple/ 23:07:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 23:07:54 INFO - Running setup.py (path:/tmp/pip-XhYTns-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 23:07:54 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:07:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 23:07:54 INFO - Running setup.py (path:/tmp/pip-URYLTA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 23:07:55 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:07:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 23:07:55 INFO - Running setup.py (path:/tmp/pip-wmgyLq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 23:07:55 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:07:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 23:07:55 INFO - Running setup.py (path:/tmp/pip-DEE7fH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 23:07:55 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:07:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 23:07:55 INFO - Running setup.py (path:/tmp/pip-ss59b8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 23:07:55 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:07:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 23:07:55 INFO - Running setup.py (path:/tmp/pip-KOpy_L-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 23:07:55 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:07:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 23:07:55 INFO - Running setup.py (path:/tmp/pip-HtGYzK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 23:07:55 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:07:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 23:07:55 INFO - Running setup.py (path:/tmp/pip-Np8r11-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 23:07:55 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:07:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 23:07:55 INFO - Running setup.py (path:/tmp/pip-eRtg_H-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 23:07:55 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:07:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 23:07:55 INFO - Running setup.py (path:/tmp/pip-kssfaa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 23:07:55 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:07:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 23:07:55 INFO - Running setup.py (path:/tmp/pip-J3p7fD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 23:07:55 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:07:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 23:07:55 INFO - Running setup.py (path:/tmp/pip-atDoXv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 23:07:55 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:07:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 23:07:55 INFO - Running setup.py (path:/tmp/pip-6ftFL7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 23:07:55 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:07:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 23:07:55 INFO - Running setup.py (path:/tmp/pip-rFugIp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 23:07:55 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:07:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 23:07:55 INFO - Running setup.py (path:/tmp/pip-9Bcosl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 23:07:56 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:07:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 23:07:56 INFO - Running setup.py (path:/tmp/pip-DGc43W-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 23:07:56 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:07:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 23:07:56 INFO - Running setup.py (path:/tmp/pip-DIWuW3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 23:07:56 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:07:56 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:07:56 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:07:56 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:07:56 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:07:56 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:07:56 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 23:07:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 23:07:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 23:07:56 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 23:07:56 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 23:07:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 23:07:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 23:07:58 INFO - Downloading blessings-1.6.tar.gz 23:07:58 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 23:07:58 INFO - Installing collected packages: blessings 23:07:58 INFO - Running setup.py install for blessings 23:07:58 INFO - Successfully installed blessings 23:07:58 INFO - Cleaning up... 23:07:58 INFO - Return code: 0 23:07:58 INFO - Done creating virtualenv /builds/slave/test/build/venv. 23:07:58 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 23:07:58 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 23:07:58 INFO - Reading from file tmpfile_stdout 23:07:58 INFO - Current package versions: 23:07:58 INFO - argparse == 1.2.1 23:07:58 INFO - blessings == 1.6 23:07:58 INFO - blobuploader == 1.2.4 23:07:58 INFO - docopt == 0.6.1 23:07:58 INFO - manifestparser == 1.1 23:07:58 INFO - mozInstall == 1.12 23:07:58 INFO - mozcrash == 0.17 23:07:58 INFO - mozdebug == 0.1 23:07:58 INFO - mozdevice == 0.48 23:07:58 INFO - mozfile == 1.2 23:07:58 INFO - mozhttpd == 0.7 23:07:58 INFO - mozinfo == 0.9 23:07:58 INFO - mozleak == 0.1 23:07:58 INFO - mozlog == 3.1 23:07:58 INFO - moznetwork == 0.27 23:07:58 INFO - mozprocess == 0.22 23:07:58 INFO - mozprofile == 0.28 23:07:58 INFO - mozrunner == 6.11 23:07:58 INFO - mozscreenshot == 0.1 23:07:58 INFO - mozsystemmonitor == 0.0 23:07:58 INFO - moztest == 0.7 23:07:58 INFO - mozversion == 1.4 23:07:58 INFO - psutil == 3.1.1 23:07:58 INFO - requests == 1.2.3 23:07:58 INFO - wsgiref == 0.1.2 23:07:58 INFO - Installing None into virtualenv /builds/slave/test/build/venv 23:07:58 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:58 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 23:07:58 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:07:58 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:58 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 23:07:58 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:07:58 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 0x7ff9fbaa9f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x205c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x21275a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21b6410>, '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 0x21b7310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x21b77a0>, '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': '97facb8ba2ac28944cc45e6b000001d4-1467519811.557221-1149711480', '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:07:58 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:07:58 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:07:58 INFO - Using env: {'DISPLAY': ':0', 23:07:58 INFO - 'HOME': '/home/cltbld', 23:07:58 INFO - 'LANG': 'en_US.UTF-8', 23:07:58 INFO - 'LANGUAGE': 'en_US:en', 23:07:58 INFO - 'LOGNAME': 'cltbld', 23:07:58 INFO - 'MAIL': '/var/mail/cltbld', 23:07:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:07:58 INFO - 'MOZ_NO_REMOTE': '1', 23:07:58 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 23:07:58 INFO - 'NO_EM_RESTART': '1', 23:07:58 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 23:07:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 23:07:58 INFO - 'PWD': '/builds/slave/test', 23:07:58 INFO - 'SHELL': '/bin/bash', 23:07:58 INFO - 'SHLVL': '1', 23:07:58 INFO - 'TERM': 'linux', 23:07:58 INFO - 'TMOUT': '86400', 23:07:58 INFO - 'USER': 'cltbld', 23:07:58 INFO - 'XDG_SESSION_COOKIE': '97facb8ba2ac28944cc45e6b000001d4-1467519811.557221-1149711480', 23:07:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:07:58 INFO - '_': '/tools/buildbot/bin/python'} 23:07:58 INFO - Ignoring indexes: https://pypi.python.org/simple/ 23:07:58 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:07:58 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:07:58 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:07:58 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:07:58 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:07:58 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:07:58 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:07:58 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:07:58 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:07:58 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:07:58 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:07:58 INFO - Cleaning up... 23:07:58 INFO - Return code: 0 23:07:58 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 23:07:58 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:58 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 23:07:58 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:07:58 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:58 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 23:07:58 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:07:58 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 0x7ff9fbaa9f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x205c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x21275a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21b6410>, '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 0x21b7310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x21b77a0>, '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': '97facb8ba2ac28944cc45e6b000001d4-1467519811.557221-1149711480', '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:07:58 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:07:58 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:07:58 INFO - Using env: {'DISPLAY': ':0', 23:07:58 INFO - 'HOME': '/home/cltbld', 23:07:58 INFO - 'LANG': 'en_US.UTF-8', 23:07:58 INFO - 'LANGUAGE': 'en_US:en', 23:07:58 INFO - 'LOGNAME': 'cltbld', 23:07:58 INFO - 'MAIL': '/var/mail/cltbld', 23:07:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:07:58 INFO - 'MOZ_NO_REMOTE': '1', 23:07:58 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 23:07:58 INFO - 'NO_EM_RESTART': '1', 23:07:58 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 23:07:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 23:07:58 INFO - 'PWD': '/builds/slave/test', 23:07:58 INFO - 'SHELL': '/bin/bash', 23:07:58 INFO - 'SHLVL': '1', 23:07:58 INFO - 'TERM': 'linux', 23:07:58 INFO - 'TMOUT': '86400', 23:07:58 INFO - 'USER': 'cltbld', 23:07:58 INFO - 'XDG_SESSION_COOKIE': '97facb8ba2ac28944cc45e6b000001d4-1467519811.557221-1149711480', 23:07:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:07:58 INFO - '_': '/tools/buildbot/bin/python'} 23:07:58 INFO - Ignoring indexes: https://pypi.python.org/simple/ 23:07:58 INFO - Downloading/unpacking jsonschema 23:07:58 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:07:58 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:07:58 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:07:58 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:07:58 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:07:58 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:08:00 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 23:08:00 INFO - Downloading/unpacking functools32 (from jsonschema) 23:08:00 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:08:00 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:08:00 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:08:00 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:08:00 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:08:00 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:08:01 INFO - Downloading functools32-3.2.3-2.tar.gz 23:08:01 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 23:08:01 INFO - warning: no files found matching '*.txt' 23:08:01 INFO - no previously-included directories found matching 'build' 23:08:01 INFO - no previously-included directories found matching 'dist' 23:08:01 INFO - no previously-included directories found matching '.git*' 23:08:01 INFO - Installing collected packages: jsonschema, functools32 23:08:01 INFO - Running setup.py install for functools32 23:08:01 INFO - warning: no files found matching '*.txt' 23:08:01 INFO - no previously-included directories found matching 'build' 23:08:01 INFO - no previously-included directories found matching 'dist' 23:08:01 INFO - no previously-included directories found matching '.git*' 23:08:01 INFO - Successfully installed jsonschema functools32 23:08:01 INFO - Cleaning up... 23:08:01 INFO - Return code: 0 23:08:01 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 23:08: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:08:01 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 23:08:01 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:08: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:08:01 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 23:08:01 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:08:01 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 0x7ff9fbaa9f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x205c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x21275a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21b6410>, '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 0x21b7310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x21b77a0>, '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': '97facb8ba2ac28944cc45e6b000001d4-1467519811.557221-1149711480', '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:08:01 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:08:01 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:08:01 INFO - Using env: {'DISPLAY': ':0', 23:08:01 INFO - 'HOME': '/home/cltbld', 23:08:01 INFO - 'LANG': 'en_US.UTF-8', 23:08:01 INFO - 'LANGUAGE': 'en_US:en', 23:08:01 INFO - 'LOGNAME': 'cltbld', 23:08:01 INFO - 'MAIL': '/var/mail/cltbld', 23:08:01 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:08:01 INFO - 'MOZ_NO_REMOTE': '1', 23:08:01 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 23:08:01 INFO - 'NO_EM_RESTART': '1', 23:08:01 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 23:08:01 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 23:08:01 INFO - 'PWD': '/builds/slave/test', 23:08:01 INFO - 'SHELL': '/bin/bash', 23:08:01 INFO - 'SHLVL': '1', 23:08:01 INFO - 'TERM': 'linux', 23:08:01 INFO - 'TMOUT': '86400', 23:08:01 INFO - 'USER': 'cltbld', 23:08:01 INFO - 'XDG_SESSION_COOKIE': '97facb8ba2ac28944cc45e6b000001d4-1467519811.557221-1149711480', 23:08:01 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:08:01 INFO - '_': '/tools/buildbot/bin/python'} 23:08:01 INFO - Ignoring indexes: https://pypi.python.org/simple/ 23:08:01 INFO - Downloading/unpacking flake8 23:08:01 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:08:01 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:08:01 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:08:01 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:08:01 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:08:01 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:08:03 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 23:08:03 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 23:08:03 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:08:03 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:08:03 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:08:03 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:08:03 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:08:03 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:08:03 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 23:08:03 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 23:08:03 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:08:03 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:08:03 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:08:03 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:08:03 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:08:03 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:08:03 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 23:08:03 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:08:03 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:08:03 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:08:03 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:08:03 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:08:03 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:08:04 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 23:08:04 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 23:08:04 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 23:08:04 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 23:08:04 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 23:08:04 INFO - no previously-included directories found matching 'docs/_build' 23:08:04 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 23:08:04 INFO - Running setup.py install for pep8 23:08:04 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 23:08:04 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 23:08:04 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 23:08:04 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 23:08:04 INFO - no previously-included directories found matching 'docs/_build' 23:08:04 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 23:08:04 INFO - Successfully installed flake8 mccabe pyflakes pep8 23:08:04 INFO - Cleaning up... 23:08:04 INFO - Return code: 0 23:08:04 INFO - Running post-action listener: _resource_record_post_action 23:08:04 INFO - Running post-action listener: _start_resource_monitoring 23:08:04 INFO - Starting resource monitoring. 23:08:04 INFO - ##### 23:08:04 INFO - ##### Running install step. 23:08:04 INFO - ##### 23:08:04 INFO - Running pre-action listener: _resource_record_pre_action 23:08:04 INFO - Running main action method: install 23:08:04 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 23:08:04 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 23:08:04 INFO - Reading from file tmpfile_stdout 23:08:04 INFO - Detecting whether we're running mozinstall >=1.0... 23:08:04 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 23:08:04 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 23:08:04 INFO - Reading from file tmpfile_stdout 23:08:04 INFO - Output received: 23:08:04 INFO - Usage: mozinstall [options] installer 23:08:04 INFO - Options: 23:08:04 INFO - -h, --help show this help message and exit 23:08:04 INFO - -d DEST, --destination=DEST 23:08:04 INFO - Directory to install application into. [default: 23:08:04 INFO - "/builds/slave/test"] 23:08:04 INFO - --app=APP Application being installed. [default: firefox] 23:08:04 INFO - mkdir: /builds/slave/test/build/application 23:08:04 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:08:04 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:08:18 INFO - Reading from file tmpfile_stdout 23:08:18 INFO - Output received: 23:08:18 INFO - /builds/slave/test/build/application/firefox/firefox 23:08:18 INFO - Running post-action listener: _resource_record_post_action 23:08:18 INFO - ##### 23:08:18 INFO - ##### Running run-tests step. 23:08:18 INFO - ##### 23:08:18 INFO - Running pre-action listener: _resource_record_pre_action 23:08:18 INFO - Running main action method: run_tests 23:08:18 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 23:08:18 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 23:08:18 INFO - Python 2.7.3 23:08:18 INFO - Return code: 0 23:08:18 INFO - grabbing minidump binary from tooltool 23:08:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 23:08:18 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 0x21b6410>, '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 0x21b7310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x21b77a0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 23:08:18 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:08:18 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:08:18 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 23:08:18 INFO - Return code: 0 23:08:18 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 23:08:18 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 23:08:18 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 23:08:18 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 23:08:18 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 23:08:18 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 23:08:18 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 23:08:19 INFO - Return code: 0 23:08:19 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-068', '--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:08:19 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-068 --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:08:19 INFO - Using env: {'DISPLAY': ':0', 23:08:19 INFO - 'HOME': '/home/cltbld', 23:08:19 INFO - 'LANG': 'en_US.UTF-8', 23:08:19 INFO - 'LANGUAGE': 'en_US:en', 23:08:19 INFO - 'LOGNAME': 'cltbld', 23:08:19 INFO - 'MAIL': '/var/mail/cltbld', 23:08:19 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 23:08:19 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 23:08:19 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:08:19 INFO - 'MOZ_NO_REMOTE': '1', 23:08:19 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 23:08:19 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 23:08:19 INFO - 'NO_EM_RESTART': '1', 23:08:19 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 23:08:19 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 23:08:19 INFO - 'PWD': '/builds/slave/test', 23:08:19 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 23:08:19 INFO - 'SHELL': '/bin/bash', 23:08:19 INFO - 'SHLVL': '1', 23:08:19 INFO - 'TERM': 'linux', 23:08:19 INFO - 'TMOUT': '86400', 23:08:19 INFO - 'USER': 'cltbld', 23:08:19 INFO - 'XDG_SESSION_COOKIE': '97facb8ba2ac28944cc45e6b000001d4-1467519811.557221-1149711480', 23:08:19 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:08:19 INFO - '_': '/tools/buildbot/bin/python'} 23:08:19 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-068', '--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:08:19 INFO - mozversion application_buildid: 20160701065031 23:08:19 INFO - mozversion application_changeset: 5e6976a28642d4d159071e14fd3251d76b9c46fa 23:08:19 INFO - mozversion application_display_name: Firefox 23:08:19 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 23:08:19 INFO - mozversion application_name: Firefox 23:08:19 INFO - mozversion application_remotingname: firefox 23:08:19 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-beta 23:08:19 INFO - mozversion application_vendor: Mozilla 23:08:19 INFO - mozversion application_version: 48.0 23:08:19 INFO - mozversion platform_buildid: 20160701065031 23:08:19 INFO - mozversion platform_changeset: 5e6976a28642d4d159071e14fd3251d76b9c46fa 23:08:19 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-beta 23:08:19 INFO - mozversion platform_version: 48.0 23:08:19 INFO - using testdate: 1467526099 23:08:19 INFO - actual date: 1467526099 23:08:19 INFO - starting webserver on 'localhost:34163' 23:08:19 INFO - SUITE-START | Running 2 tests 23:08:19 INFO - TEST-START | dromaeo_css 23:08:19 INFO - operating with platform_type : linux_ 23:08:19 INFO - Initialising browser for dromaeo_css test... 23:08:19 INFO - TEST-INFO | started process 16628 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmptx3jar/profile http://localhost:34163/getInfo.html) 23:08:23 INFO - PROCESS | 16628 | 23:08:23 INFO - PROCESS | 16628 | (process:16703): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 23:08:23 INFO - PROCESS | 16628 | __metrics Screen width/height:1600/1200 23:08:23 INFO - PROCESS | 16628 | colorDepth:24 23:08:23 INFO - PROCESS | 16628 | Browser inner width/height: 1024/697 23:08:23 INFO - PROCESS | 16628 | __metrics 23:08:24 ERROR - PROCESS | 16628 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2931: TypeError: this.tabs is undefined 23:08:25 INFO - TEST-INFO | 16628: exit 0 23:08:25 INFO - Browser initialized. 23:08:25 INFO - Running cycle 1/1 for dromaeo_css test... 23:08:25 INFO - TEST-INFO | started process 16754 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmptx3jar/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 23:08:27 INFO - PROCESS | 16754 | 23:08:27 INFO - PROCESS | 16754 | (process:16821): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 23:08:37 INFO - PROCESS | 16754 | RSS: Main: 150745088 23:08:37 INFO - PROCESS | 16754 | 23:09:26 INFO - PROCESS | 16754 | 1467526166778 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:11:34 INFO - PROCESS | 16754 | Cycle 1(1): loaded http://localhost:34163/tests/dromaeo/cssquery-dojo.html (next: http://localhost:34163/tests/dromaeo/cssquery-ext.html) 23:11:35 INFO - PROCESS | 16754 | RSS: Main: 154357760 23:11:35 INFO - PROCESS | 16754 | 23:14:37 INFO - PROCESS | 16754 | Cycle 1(1): loaded http://localhost:34163/tests/dromaeo/cssquery-ext.html (next: http://localhost:34163/tests/dromaeo/cssquery-jquery.html) 23:14:37 INFO - PROCESS | 16754 | RSS: Main: 152657920 23:14:37 INFO - PROCESS | 16754 | 23:17:39 INFO - PROCESS | 16754 | Cycle 1(1): loaded http://localhost:34163/tests/dromaeo/cssquery-jquery.html (next: http://localhost:34163/tests/dromaeo/cssquery-mootools.html) 23:17:39 INFO - PROCESS | 16754 | RSS: Main: 152219648 23:17:39 INFO - PROCESS | 16754 | 23:20:41 INFO - PROCESS | 16754 | Cycle 1(1): loaded http://localhost:34163/tests/dromaeo/cssquery-mootools.html (next: http://localhost:34163/tests/dromaeo/cssquery-prototype.html) 23:20:42 INFO - PROCESS | 16754 | RSS: Main: 153432064 23:20:42 INFO - PROCESS | 16754 | 23:23:44 INFO - PROCESS | 16754 | Cycle 1(1): loaded http://localhost:34163/tests/dromaeo/cssquery-prototype.html (next: http://localhost:34163/tests/dromaeo/cssquery-yui.html) 23:23:45 INFO - PROCESS | 16754 | RSS: Main: 152170496 23:23:45 INFO - PROCESS | 16754 | 23:26:47 INFO - PROCESS | 16754 | Cycle 1(1): loaded http://localhost:34163/tests/dromaeo/cssquery-yui.html (next: http://localhost:34163/tests/dromaeo/cssquery-dojo.html) 23:26:47 INFO - PROCESS | 16754 | RSS: Main: 155959296 23:26:47 INFO - PROCESS | 16754 | 23:26:47 INFO - PROCESS | 16754 | __start_tp_report 23:26:47 INFO - PROCESS | 16754 | _x_x_mozilla_page_load 23:26:47 INFO - PROCESS | 16754 | _x_x_mozilla_page_load_details 23:26:47 INFO - PROCESS | 16754 | |i|pagename|runs| 23:26:47 INFO - PROCESS | 16754 | |0;dojo.html;3355.9664403355964;3418.3163367326533;3426.5374174486437;3442.431998720211;3477.4783782432633;5537.612367134302;5593.133064375028;5611.382747897728;5622.381538030819;5630.5495560355175;5580.302462192216;5607.439256074391;5609.5231905288;5637.605367624268;5674.631148975313;5070.492950704936;5089.7964081436885;5138.743062846861;5147.974260128694;5161.303224064741;5021.297018417425;5069.569086627641;5154.793808247684;5197.298364720752;5228.451012643655;5182.844514664566;5196.090684130281;5204.063268611649;5239.476052394749;5252.71110088945;5167.250748641463;5173.224016397514;5174.042802081608;5202.3497062867145;5205.29728486657;4953.281774142729;4989.775460104304;5077.882865769525;5079.593632509391;5118.744062796845;5415.620906536544;5439.646422982533;5441.5102640762525;5457.263269458612;5507.201455788888;5872.911906321408;5904.498117660004;5911.615744976562;5935.910961335583;5944;5962.0921305182355;5970.194023806774;5975.671338076404;6061.66660833654;6121.879793613194;5523.2543606613;5523.613347065667;5551.444855514416;5558.082916318803;5578.553715702775;6031.698415079229;6045.667488288186;6049;6054.606450580698;6089.421504957022;5767.68277744728;5813.505852002542;5830.416958304136;5886.676232807151;5933.288005439289;5915.615484993462;5942.910856337158;5949.315828679671;5961.701914904237;5966.642001479839;5870.148828419855;5906.232189815297;5919.1713160157615;5945.435183657545;5952.791652292149;5851.210086638334;5968.791092311748;6043.697815109227;6068.393160683896;6094.847628809315;4524.932126018112;4535.274356103007;4536.637069034469;4537.410136682276;4584.243599805995;4100.17996400721;4103.9179216415505;4111.444954931106;4111.71218014742;4151.709380343407;5743.765090505562;5793.102069179284;5798.420157984167;5839.591228614041;5876.44173803488;6033.426824451758;6049.909251361233;6059.697015149225;6060.393960603992;6080.543959203077;5637.379888212294;5837.88324233513;5842.620229685057;5846.064629659234;5870.14882841994;5164.974175129176;5170.508801663836;5179.637425380187;5188.377394712658;5214.0875346814155;6189.752409903554;6203.31763506014;6231.813045608639;6245.812625621239;6246.3441338659695;5905.261842269716;6026.879462410815;6034.607750496204;6065.60573562717;6116.847078823065;6249.875002500015;6252.218472690914;6253.218347706536;6257.843553911189;6262.405071518198;5898.144769008384;5915.201447804491;5915.231019967377;5936;5955.5235581154275;5993.101034844808;6025.548083893813;6082.7262773174425;6121.148138557471;6168.475679567107;5867.882642347215;5923.08192230205;5927.525797936241;5932.228810254639;5961.582689211887;5917.704114794157;5920.200772895776;5920.437558431942;5924.11138329254;5925.348211696796;5646.435356464485;5838.678872662044;5905.350411454822;5908.675022873783;5930.495907847709;5956.493698035542;5962.672053037125;5980.9401905980385;6006.8498287541415;6024.548158888013;5749.655020698604;5851.941480585139;5857.648541087548;5867.618604790675;5879.2944846618675 23:26:47 INFO - PROCESS | 16754 | |1;ext.html;665.4742753224953;689.4105539763499;693.4313862632641;731.3235257386916;743.074871784628;40108.799456002715;40339.596604033984;40343.1931361373;40489;40492.39261411081;38546;38997.805010974975;39032.60967390325;39073;39149.21701565967;8869.645214191441;8966.506842123681;9034.503102329369;9056.954715226448;9060.411073280216;8831.64673413066;8944.597493112826;8947.194752472276;8959.28325733943;8963.775905602346;9213.539323033856;9232.907670923305;9247.39891907024;9268.165865072142;9275.814483710321;9157.679481218158;9184.173424391804;9216.769580760467;9225.492597907112;9259.6296148154;9124.27005839538;9217.861732074025;9219.953900230523;9227.123423274777;9236.261099112055;44096.779516102535;44420;44428.555714442766;44561.77719111416;44591.554084459065;3845.557760857509;3909.1204478992286;4001.153414006029;4019.919601607981;4059.7970101494807;33800.15499612505;33960.660393396;34169.316613667834;34653.48019779706;35390;4621.653375996813;4637.489876113625;4678.836240731592;4731.101090792738;4762.28565715142;313098;313805;313922;315950;316490;41002.79498602488;54593.727031365386;55055.17417238664;55228;55340;39186.216275674895;39198;39290;39391;39532.40701389424;17299.481015569552;17516.12419379026;17517.562060948323;17556.561085972953;17562.121893905252;14718.779218311734;14784.408623654934;14794.852051479562;14799;14811.407543698348;9393.295502837314;9484.478353690612;9692.75768105803;9731.464769437749;9792.069753373418;3635.363811333006;3740.2893450244364;3746.4942232798767;3755.080005398695;3760.8871733848027;1057.0011339284456;1082.5615625671617;1121.2151493954264;1158.48447440888;1199.2564609941717;32572;33622;34581.65418345835;35089.47365789515;35207;1168.4391492083848;1170.53763763313;1185.8814118588073;1192.6839387562302;1215.3254943506438;16603.916980415263;17248;17372.913135434494;17502.21240044201;17705.645887082443;503408;519251;537261;539072;541261;63605;64631.67684161549;65290.347096529375;65408.345916540224;65463.34536654573;1469.2580246975422;1541.8072740907387;1542.8225754038428;1562.406285611483;1582.8258891521923;34232.486512701835;34595.30809383748;34607;34886.30227395488;35351;54880.451195487534;55591.16613250886;55647.16529252145;55728.442715572324;55969.16046259228;439974;447061;447357;447835;449776.00447991514;31962.20094497656;32121.678783212803;32408;32424.513632296006;32516.51225231671;52757;52853;53382.19926701025;53915.730421347645;53962;43962.78018609886;44434.33348499711;44463.11073778571;44600.55399445964;45846.77076614596;45128;45176;45610.54389456195;45720.77139614414;45799.313010304206;44821.103577927606;45486;45905.31142032939;46032;46122.308165378214;36620.084497887765;37231.6968906087;37551.43672844964;38175.42736859005;38312.23375532418;29173.70826291795;30032.348220848064;30364.848175759864;30553.847230763702;30658.233544161576 23:26:47 INFO - PROCESS | 16754 | |2;jquery.html;429.6262251840897;437.5580663529835;443.3305708380345;446.6493802365143;449.81332746910033;18770.718439223423;19191.232350705974;19489.41531754048;21214.787852121473;21424.785752142474;19547.315843945464;19918.302859399922;20150.294739684115;20631.999999999964;20644.277450289243;5592.328920529532;5989.341172471025;5991;6001.33985261622;6007.489363404094;3738.439234114891;5892.823215303526;7184.173820010687;7533.209013053633;7566.01641786567;7315.8536829263385;7487.2887075727995;7520.097588289385;7522.887156692654;7560.168381478033;7509.211532789061;7566.243375662445;7575.886361704579;7588.772336829931;7588.810279742996;7157.3916217121605;7274.927250727478;7320.707171713125;7340.376068034224;7365.895115732629;26156.86921565399;26629.46741065168;27719.722802771917;28260.576091358645;28387;2527.42343773265;2759.365345970438;3248.5776849009712;3483.285926385085;3522.2603253316834;15442.845571544365;16060.11669358185;16169.19154042305;16457.753133703005;16874.66250674992;2209.2819833554;2250.268662684634;2278.362058623588;2355.470019245673;2383.9748907969565;95875;96220;97712;98279;98517.50741246248;17808.643827123644;18688.719669204973;18911.81088189128;19092.61814763697;19340.70988935167;35410.82294588562;35465;35599;35951.4607280891;36210.27579448396;8215.219554142346;8514.361422893307;8536.402451828437;8573.356998225034;8651.04838467768;8756.387052906235;8768.912310876809;8775;8818.51498167594;8898.955505222433;4775.832845850378;4792.688475249098;4822.565969062801;4828.396450443694;4837.637177211724;1939.1661585518364;1992.1035534009754;2020.05057622917;2045.764737055228;2053.6303465376077;987.9506024698736;1055.8205105132147;1059.9894001060045;1070.9518071686794;1111.5664890692635;19521;19551.511212219808;19670.213191472467;19704.605907881763;20021.898795566092;1065;1077.5959015369237;1086.4459125845717;1124.662601219631;1179.2983175010854;10848.349099053925;11013.229073964745;11165.274257173258;11183.329000259848;11197.552097916156;492656;496062;509392;571912;575831;94760.52619736995;97999;98114;99044.50477747565;99498.502507487;1101.4162493878257;1125.4654039331415;1138.4364739453858;1156.7455159864817;1157.5254145800182;17116.144192790558;17425.215865286347;17499.38752143669;17512.211950462006;17828.643427131643;40053.19893602053;40458.39312410257;40930.79534602308;41324;41665.1666966665;57110;59475;59851.401485986324;60759;60767.39232607794;8969.596368163318;9133.634654614007;9161.129692679186;9165.77085572866;9285.814283714422;8973.865392019256;10375.325603835727;13597.728045439233;13892.23592702411;13948.651283717989;11225.438728063727;11942.522299107939;11950.282983021047;11979.760404791681;12024.939875300568;11901.404929753651;11919.404029798648;11935.582254621047;12361.876381236432;12467.5012999479;11692.824607631062;11782;11832.171747977904;12332.691682708004;12336;8934.28525717954;9147.908520914973;9167.816643666956;9290.16388525036;9313.580888860153;8789.384743067923;11316.15128865322;11415.429228538374;11447.084233261152;11737.178397512434 23:26:47 INFO - PROCESS | 16754 | |3;mootools.html;1575.5430925031737;1595.7606359046144;1744.5813004878826;1825.735268386085;1863.8229368210032;7342.96328518358;8037.678492860293;8105.797355066119;8305.626246818892;8313.168683131684;8058.63736131874;8096.55468949209;8109.878351824727;8128.349732021439;8144.674213031486;2266.693996310502;2285.759995200505;2287.8627282363113;2288.5766133265315;2290.4044948313476;2256.4922892349173;2268.54629074185;2311.653252012195;2313.768623137681;2314.618088015475;2137.3801597536694;2158.7625361210253;2161;2264.1396269417596;2309.976900230993;2268.875211863347;2270.160040784912;2271.636538153904;2272.863628182314;2279.7606251343536;2295.8048565871923;2321.9071237150492;2323.6398358254496;2328.080408238753;2331.7318508371586;8345.54099524526;8383.245507904317;8388.706395276136;8392.832143357098;8408.663653453854;5037.319961805183;5107.7956881724685;5110.361204849394;5119.155339368999;5130.3074084998425;3113.9532907006414;3248.626407963091;3265.2816380396275;3292.687194716498;3297.76915615907;1088.9401082940435;1093.2238110941241;1129.9152563557684;1133.3879704959313;1152.4986630815622;11602.419879006016;11616.767664646659;11618.360990145538;11631.30212187263;11683.357415342152;4360.411344468456;4434.623057040123;4482.708623939434;4491.393661855673;4578.061497393026;9865.950670246746;9940.807103147525;9984.850227246598;10000.499975001221;10005.44970026641;5161.071007218661;5162.328897243335;5177.042247184283;5208.9739551302755;5218.060749065205;4110.979445102756;4650.395448591661;4709.62323014158;4766.165920963817;4787.473377928425;3908.9804550977633;4005.1388951375593;4029.4560234367987;4037.4953130858644;4085.080856807254;1250.481050364107;1285.3637449462576;1295.5077070713257;1304.4195333076689;1308.5485507500089;1084.0622861224983;1098.5770478365887;1109.8501702270253;1110;1113.1706878375662;5803;6094.085887116879;6103.1455596216565;6133.172021777003;6153.600015998945;431.0947011276295;431.4628287781669;433.43653250773866;1110.2561283939779;1130.361345839598;4114.691398145092;4141.068259641556;4141.52372477169;4145.564715704868;4166.895827604273;10169.135623472088;10414.323069000491;10480.68557943263;10568.841467377995;10569;10231.846522302172;10375;10375.896241037493;10391.688249352532;10406;7972.043354797345;8128.634211460499;8139.959300203461;8167.305779008732;8177.468464549905;5809.82570522885;5857.619254748428;5898.4101589840675;5944.64332140073;6061.636301821904;8846.292296616384;8930.240929520804;9042.638294468148;9060.093990600888;9122.635094596142;8623.913760862311;8837.204651581389;9017.323700722342;9103.954480227556;9214.354995150275;7267.745628902963;7402.407807375289;7409.370203532544;7545.471816972759;7569;8086.757397278091;8091.06952700447;8093.635786389509;8132.512049277062;8133.633986470742;7269.7455589054125;7452.739154129579;7452.776416707507;7493.625318734151;7575.6969721210535;6838.418734407631;6896.793096207121;6911.89632155508;6975.476839236976;6976.302369763186;7010.579365238102;7064.470164737562;7076.32774886385;7080.716771329089;7088.574685518885;5254.7898084076205;5272.604554658339;5354.625176237626;5371.033214021513;5457;5156.484351564814;5339.252504649275;5386.7575959082715;5495.120780675073;5531.585131115263 23:26:47 INFO - PROCESS | 16754 | |4;prototype.html;340.7580617761388;341.99487007694904;356.6237619311625;366.21629712415427;369.39603747872223;6375.776847810327;6410.23077230733;6424.743010279589;6453.8063858084215;6487.870242595145;6527.902081468782;6567.244766851813;6585.275619681843;6603.636799976;6616.1399018127695;4958.256261560768;4976.925346119793;4984.352034235544;4993.825216117437;4994.625403094782;4986.127427700156;4994.575461085794;4998.875028124289;5006.224035274538;5010.599152067844;4888.364512613355;4930.704157750529;4935.950640493603;4938.851834444955;4957.082939656175;4746.240601503743;4887.462379138292;4927.162382395001;4927.704337739729;4930.827421040264;4245.830166793325;4248.277792775236;4256.297710877701;4269.978650106761;4288.399624052604;6300;6354.7458101675875;6355.697082098159;6356.459700925427;6361.618302901795;5575.888482230333;5682.659040457585;5687.03320435527;5692.003899317644;5740.4833564978935;6824.21521525026;6851.246362900077;6855.211650660138;6865.622390768505;6865.828354291133;4743.691660042086;4750.382450281476;4751.477337492873;4755.42934847817;4757.785899634525;7141.8928716068785;7153.89269160963;7179.49743517954;7204.819879503054;7230.566166030002;4882.12121818069;4882.8779280517565;4886.633502487328;4890.388701412324;4894.045661096052;4770.904581908342;4886.53577910098;4890.608751299887;4899.387576552931;4913.287573301923;5616.382197958222;5658.7170641467765;5683.857903552444;5711.600187986801;5717.799877004368;6906.758263460755;6935.167779866449;6936.375726184668;6942.583444993215;6943.375096241362;1710.059467292984;1730.956726081858;1733.9479815605553;1734.5576877896056;1739.3216645508262;1072.5388083124176;1103.3545375954996;1107.5514416661265;1123.719070232442;1129.1869853705318;6633.336666333328;6642.535022548375;6642.535022548472;6646.036324732887;6664.966675166593;7071.681774320168;7074.434045276468;7077.469189810785;7078.504504684623;7081.716731330689;6610.768623098168;6656.334366563305;6662.6668666566475;6671.699773510204;6686.7993960181275;3814.1036856338737;3828.0429892526868;3839.1361943562474;3843.461915331856;3849.2301539692176;7313.341799238094;7330.230325815819;7537.585432801248;7549;7563.810904727426;7381.520201186906;7387.519811212254;7389.371903388164;7392.297731715478;7394.4823862330195;7510.812229694301;7540.849183016309;7542.736004239825;7551.697932082655;7567.356774674105;6959.826004349729;7250.202477727551;7255.455840812066;7260.709571617076;7263.055802745609;7130.037444944866;7141.82145446368;7157.24848890859;7159.821004474929;7173.497855150089;7446.888296675445;7556.622168891424;7557.433192510473;7558.735444259644;7578.658960346687;4810.879728006687;4934.654574179916;4939;4941.209406494943;4955.35580374549;7078.964605176941;7231.204567497466;7244.746433874789;7259.455540834353;7340.816479588053;6970.477214208853;6977.616231107338;6979.895301570379;6991.860162796817;7004.369606735215;6965.5124141309625;6981.930180698128;6988.126484189476;6993.4055605274125;6998.300169982961;6849.486288528281;6860.0738900247825;6867.553609015398;6868.896966545606;6876.312368763083;6835.93164068353;7031.191412987572;7039.54242974205;7043.330883566053;7069.434445244471;6889.379955804002;6897.655117244018;6943.826404339932;6966.616836073862;6986.301369862973 23:26:47 INFO - PROCESS | 16754 | |5;yui.html;843.9493630382176;900.3067637918803;911.8768966189563;915.2586405011937;920.2867777472462;14114.153150810958;14327.928360358184;14365.994380393364;14377.640558986031;14459.92770036151;14160.787588186186;14207.78688319676;14323.212223327739;14401;14437;754.6415452659998;789.0807209600837;790.8181118342785;809.9392545559077;822.2969361196181;897.9281657467419;898.7708134425712;900.1853322742928;904.8280826642949;905.5653286422488;954.3319676226635;954.4750387286999;956.1442508954482;958.2477754962356;961.0725649747992;940.4122423485321;947.3794664494733;949.1694767078806;950.1116456113486;951.5670369981642;697.4315932515035;698.2284575544053;700.5866538742166;702.7575486457164;709.5919846088468;13858.930705346509;13880.652983675387;13899.235542045184;13936;13966.092204006707;14320.498782542561;14380.352884120135;14743.336549855283;15145.621359465991;15380.154091524962;11824.467898944567;12028.51885924562;12136.271823690608;12162.878371216351;12264.080193985397;4063.5123785145674;4136.710430269883;4169.97915010423;4187.685923555715;4276.87169384919;54709.72645136749;54939.175912361345;54971.9999999996;56989.14516282259;57374;11776.52893884252;11818.881811181951;11876.703082423008;11939.044876409866;12062;19754;19802.405927822187;19879.403617891487;19883.900580497295;19899.403017909484;8627.266682331947;8947.731568052968;9118.86321705175;9235.445873247492;9240.630374784932;4930.260460930889;5016.54851063406;5033.194688849767;5043.293938848564;5047;3538.062413460435;3601.3517566838223;3613.530241068697;3613.8012409317216;3618.656227658368;669.2771806449024;680.0954730208811;682.6859644563557;691.1878542712393;695.9025736396909;635.9046143078483;730.8428687832142;735.4226931858466;736.7605528203355;791.9388020053042;9124.498152601538;9679.032096790406;9730.659426920165;9812.901870981199;9936.652217172365;660.2101751790727;687.700850130195;827.3670641958906;841.3731769831514;845.4377838737294;4524.343970124313;4533.101532681891;4576.153411618861;4678.836240731558;4812.085703716282;63486.682566586875;64840;64973;65208.673956629915;65398.34601654018;54976;54982.17526737102;55290;58074.419255806904;58293;51122.233166502534;51592.22611660828;52342;52760.73619631877;52846.47153528415;9473.431594104375;9605.759856003377;9629.951850240985;9758.56086476096;9822.312438129262;38383.42424863685;38715.03212419712;38989.8050509757;39402.60597393989;40318;44475.77762111169;48090.27864582104;48294.79263018312;48577.27134093062;50387.74806125946;11515.916226205263;11833.349165795964;11845.763084738084;11890.583829565923;12000.75998480043;12246.816297755362;12440.066994975594;12696.17474864131;12846.357682116044;13013.21920684762;11861.703457413634;12104.878951210376;12152.453139608915;12309.199902006341;12321.322327271728;12181.69545761363;12726.427310771223;12836.101472896808;12890.613281601567;12936.935315323362;12475.251484910934;12788.616341509769;12810.487580496676;13150.145240559334;13158.210507369206;10943.726406839893;10956.397398143179;11000.449977500934;11577.479013444246;11670.88329116698;10671.306365086555;10961.616343427942;10987.39569323695;11008.504617292081;11123.388213648326 23:26:47 INFO - PROCESS | 16754 | __end_tp_report 23:26:47 INFO - PROCESS | 16754 | __start_cc_report 23:26:47 INFO - PROCESS | 16754 | _x_x_mozilla_cycle_collect,338 23:26:47 INFO - PROCESS | 16754 | __end_cc_report 23:26:47 INFO - PROCESS | 16754 | __startTimestamp1467527207579__endTimestamp 23:26:47 INFO - PROCESS | 16754 | 23:26:47 INFO - PROCESS | 16754 | ------- Summary: start ------- 23:26:47 INFO - PROCESS | 16754 | Number of tests: 6 23:26:47 INFO - PROCESS | 16754 | 23:26:47 INFO - PROCESS | 16754 | [#0] dojo.html Cycles:165 Average:5593.71 Median:5867.62 stddev:615.59 (10.5%) stddev-sans-first:591.92 23:26:47 INFO - PROCESS | 16754 | Values: 3356.0 3418.3 3426.5 3442.4 3477.5 5537.6 5593.1 5611.4 5622.4 5630.5 5580.3 5607.4 5609.5 5637.6 5674.6 5070.5 5089.8 5138.7 5148.0 5161.3 5021.3 5069.6 5154.8 5197.3 5228.5 5182.8 5196.1 5204.1 5239.5 5252.7 5167.3 5173.2 5174.0 5202.3 5205.3 4953.3 4989.8 5077.9 5079.6 5118.7 5415.6 5439.6 5441.5 5457.3 5507.2 5872.9 5904.5 5911.6 5935.9 5944.0 5962.1 5970.2 5975.7 6061.7 6121.9 5523.3 5523.6 5551.4 5558.1 5578.6 6031.7 6045.7 6049.0 6054.6 6089.4 5767.7 5813.5 5830.4 5886.7 5933.3 5915.6 5942.9 5949.3 5961.7 5966.6 5870.1 5906.2 5919.2 5945.4 5952.8 5851.2 5968.8 6043.7 6068.4 6094.8 4524.9 4535.3 4536.6 4537.4 4584.2 4100.2 4103.9 4111.4 4111.7 4151.7 5743.8 5793.1 5798.4 5839.6 5876.4 6033.4 6049.9 6059.7 6060.4 6080.5 5637.4 5837.9 5842.6 5846.1 5870.1 5165.0 5170.5 5179.6 5188.4 5214.1 6189.8 6203.3 6231.8 6245.8 6246.3 5905.3 6026.9 6034.6 6065.6 6116.8 6249.9 6252.2 6253.2 6257.8 6262.4 5898.1 5915.2 5915.2 5936.0 5955.5 5993.1 6025.5 6082.7 6121.1 6168.5 5867.9 5923.1 5927.5 5932.2 5961.6 5917.7 5920.2 5920.4 5924.1 5925.3 5646.4 5838.7 5905.4 5908.7 5930.5 5956.5 5962.7 5980.9 6006.8 6024.5 5749.7 5851.9 5857.6 5867.6 5879.3 23:26:47 INFO - PROCESS | 16754 | 23:26:47 INFO - PROCESS | 16754 | [#1] ext.html Cycles:180 Average:59419.63 Median:42482.79 stddev:116306.90 (273.8%) stddev-sans-first:116549.51 23:26:47 INFO - PROCESS | 16754 | Values: 665.5 689.4 693.4 731.3 743.1 40108.8 40339.6 40343.2 40489.0 40492.4 38546.0 38997.8 39032.6 39073.0 39149.2 8869.6 8966.5 9034.5 9057.0 9060.4 8831.6 8944.6 8947.2 8959.3 8963.8 9213.5 9232.9 9247.4 9268.2 9275.8 9157.7 9184.2 9216.8 9225.5 9259.6 9124.3 9217.9 9220.0 9227.1 9236.3 44096.8 44420.0 44428.6 44561.8 44591.6 3845.6 3909.1 4001.2 4019.9 4059.8 33800.2 33960.7 34169.3 34653.5 35390.0 4621.7 4637.5 4678.8 4731.1 4762.3 313098.0 313805.0 313922.0 315950.0 316490.0 41002.8 54593.7 55055.2 55228.0 55340.0 39186.2 39198.0 39290.0 39391.0 39532.4 17299.5 17516.1 17517.6 17556.6 17562.1 14718.8 14784.4 14794.9 14799.0 14811.4 9393.3 9484.5 9692.8 9731.5 9792.1 3635.4 3740.3 3746.5 3755.1 3760.9 1057.0 1082.6 1121.2 1158.5 1199.3 32572.0 33622.0 34581.7 35089.5 35207.0 1168.4 1170.5 1185.9 1192.7 1215.3 16603.9 17248.0 17372.9 17502.2 17705.6 503408.0 519251.0 537261.0 539072.0 541261.0 63605.0 64631.7 65290.3 65408.3 65463.3 1469.3 1541.8 1542.8 1562.4 1582.8 34232.5 34595.3 34607.0 34886.3 35351.0 54880.5 55591.2 55647.2 55728.4 55969.2 439974.0 447061.0 447357.0 447835.0 449776.0 31962.2 32121.7 32408.0 32424.5 32516.5 52757.0 52853.0 53382.2 53915.7 53962.0 43962.8 44434.3 44463.1 44600.6 45846.8 45128.0 45176.0 45610.5 45720.8 45799.3 44821.1 45486.0 45905.3 46032.0 46122.3 36620.1 37231.7 37551.4 38175.4 38312.2 29173.7 30032.3 30364.8 30553.8 30658.2 23:26:47 INFO - PROCESS | 16754 | 23:26:47 INFO - PROCESS | 16754 | [#2] jquery.html Cycles:180 Average:32130.13 Median:3502.77 stddev:87498.69 (2498.0%) stddev-sans-first:87711.78 23:26:47 INFO - PROCESS | 16754 | Values: 429.6 437.6 443.3 446.6 449.8 18770.7 19191.2 19489.4 21214.8 21424.8 19547.3 19918.3 20150.3 20632.0 20644.3 5592.3 5989.3 5991.0 6001.3 6007.5 3738.4 5892.8 7184.2 7533.2 7566.0 7315.9 7487.3 7520.1 7522.9 7560.2 7509.2 7566.2 7575.9 7588.8 7588.8 7157.4 7274.9 7320.7 7340.4 7365.9 26156.9 26629.5 27719.7 28260.6 28387.0 2527.4 2759.4 3248.6 3483.3 3522.3 15442.8 16060.1 16169.2 16457.8 16874.7 2209.3 2250.3 2278.4 2355.5 2384.0 95875.0 96220.0 97712.0 98279.0 98517.5 17808.6 18688.7 18911.8 19092.6 19340.7 35410.8 35465.0 35599.0 35951.5 36210.3 8215.2 8514.4 8536.4 8573.4 8651.0 8756.4 8768.9 8775.0 8818.5 8899.0 4775.8 4792.7 4822.6 4828.4 4837.6 1939.2 1992.1 2020.1 2045.8 2053.6 988.0 1055.8 1060.0 1071.0 1111.6 19521.0 19551.5 19670.2 19704.6 20021.9 1065.0 1077.6 1086.4 1124.7 1179.3 10848.3 11013.2 11165.3 11183.3 11197.6 492656.0 496062.0 509392.0 571912.0 575831.0 94760.5 97999.0 98114.0 99044.5 99498.5 1101.4 1125.5 1138.4 1156.7 1157.5 17116.1 17425.2 17499.4 17512.2 17828.6 40053.2 40458.4 40930.8 41324.0 41665.2 57110.0 59475.0 59851.4 60759.0 60767.4 8969.6 9133.6 9161.1 9165.8 9285.8 8973.9 10375.3 13597.7 13892.2 13948.7 11225.4 11942.5 11950.3 11979.8 12024.9 11901.4 11919.4 11935.6 12361.9 12467.5 11692.8 11782.0 11832.2 12332.7 12336.0 8934.3 9147.9 9167.8 9290.2 9313.6 8789.4 11316.2 11415.4 11447.1 11737.2 23:26:47 INFO - PROCESS | 16754 | 23:26:47 INFO - PROCESS | 16754 | [#3] mootools.html Cycles:180 Average:5575.73 Median:4776.82 stddev:3056.31 (64.0%) stddev-sans-first:3050.10 23:26:47 INFO - PROCESS | 16754 | Values: 1575.5 1595.8 1744.6 1825.7 1863.8 7343.0 8037.7 8105.8 8305.6 8313.2 8058.6 8096.6 8109.9 8128.3 8144.7 2266.7 2285.8 2287.9 2288.6 2290.4 2256.5 2268.5 2311.7 2313.8 2314.6 2137.4 2158.8 2161.0 2264.1 2310.0 2268.9 2270.2 2271.6 2272.9 2279.8 2295.8 2321.9 2323.6 2328.1 2331.7 8345.5 8383.2 8388.7 8392.8 8408.7 5037.3 5107.8 5110.4 5119.2 5130.3 3114.0 3248.6 3265.3 3292.7 3297.8 1088.9 1093.2 1129.9 1133.4 1152.5 11602.4 11616.8 11618.4 11631.3 11683.4 4360.4 4434.6 4482.7 4491.4 4578.1 9866.0 9940.8 9984.9 10000.5 10005.4 5161.1 5162.3 5177.0 5209.0 5218.1 4111.0 4650.4 4709.6 4766.2 4787.5 3909.0 4005.1 4029.5 4037.5 4085.1 1250.5 1285.4 1295.5 1304.4 1308.5 1084.1 1098.6 1109.9 1110.0 1113.2 5803.0 6094.1 6103.1 6133.2 6153.6 431.1 431.5 433.4 1110.3 1130.4 4114.7 4141.1 4141.5 4145.6 4166.9 10169.1 10414.3 10480.7 10568.8 10569.0 10231.8 10375.0 10375.9 10391.7 10406.0 7972.0 8128.6 8140.0 8167.3 8177.5 5809.8 5857.6 5898.4 5944.6 6061.6 8846.3 8930.2 9042.6 9060.1 9122.6 8623.9 8837.2 9017.3 9104.0 9214.4 7267.7 7402.4 7409.4 7545.5 7569.0 8086.8 8091.1 8093.6 8132.5 8133.6 7269.7 7452.7 7452.8 7493.6 7575.7 6838.4 6896.8 6911.9 6975.5 6976.3 7010.6 7064.5 7076.3 7080.7 7088.6 5254.8 5272.6 5354.6 5371.0 5457.0 5156.5 5339.3 5386.8 5495.1 5531.6 23:26:47 INFO - PROCESS | 16754 | 23:26:47 INFO - PROCESS | 16754 | [#4] prototype.html Cycles:180 Average:5801.53 Median:6624.74 stddev:1781.22 (26.9%) stddev-sans-first:1738.42 23:26:47 INFO - PROCESS | 16754 | Values: 340.8 342.0 356.6 366.2 369.4 6375.8 6410.2 6424.7 6453.8 6487.9 6527.9 6567.2 6585.3 6603.6 6616.1 4958.3 4976.9 4984.4 4993.8 4994.6 4986.1 4994.6 4998.9 5006.2 5010.6 4888.4 4930.7 4936.0 4938.9 4957.1 4746.2 4887.5 4927.2 4927.7 4930.8 4245.8 4248.3 4256.3 4270.0 4288.4 6300.0 6354.7 6355.7 6356.5 6361.6 5575.9 5682.7 5687.0 5692.0 5740.5 6824.2 6851.2 6855.2 6865.6 6865.8 4743.7 4750.4 4751.5 4755.4 4757.8 7141.9 7153.9 7179.5 7204.8 7230.6 4882.1 4882.9 4886.6 4890.4 4894.0 4770.9 4886.5 4890.6 4899.4 4913.3 5616.4 5658.7 5683.9 5711.6 5717.8 6906.8 6935.2 6936.4 6942.6 6943.4 1710.1 1731.0 1733.9 1734.6 1739.3 1072.5 1103.4 1107.6 1123.7 1129.2 6633.3 6642.5 6642.5 6646.0 6665.0 7071.7 7074.4 7077.5 7078.5 7081.7 6610.8 6656.3 6662.7 6671.7 6686.8 3814.1 3828.0 3839.1 3843.5 3849.2 7313.3 7330.2 7537.6 7549.0 7563.8 7381.5 7387.5 7389.4 7392.3 7394.5 7510.8 7540.8 7542.7 7551.7 7567.4 6959.8 7250.2 7255.5 7260.7 7263.1 7130.0 7141.8 7157.2 7159.8 7173.5 7446.9 7556.6 7557.4 7558.7 7578.7 4810.9 4934.7 4939.0 4941.2 4955.4 7079.0 7231.2 7244.7 7259.5 7340.8 6970.5 6977.6 6979.9 6991.9 7004.4 6965.5 6981.9 6988.1 6993.4 6998.3 6849.5 6860.1 6867.6 6868.9 6876.3 6835.9 7031.2 7039.5 7043.3 7069.4 6889.4 6897.7 6943.8 6966.6 6986.3 23:26:47 INFO - PROCESS | 16754 | 23:26:47 INFO - PROCESS | 16754 | [#5] yui.html Cycles:180 Average:15412.23 Median:26451.18 stddev:17819.63 (67.4%) stddev-sans-first:17836.03 23:26:47 INFO - PROCESS | 16754 | Values: 843.9 900.3 911.9 915.3 920.3 14114.2 14327.9 14366.0 14377.6 14459.9 14160.8 14207.8 14323.2 14401.0 14437.0 754.6 789.1 790.8 809.9 822.3 897.9 898.8 900.2 904.8 905.6 954.3 954.5 956.1 958.2 961.1 940.4 947.4 949.2 950.1 951.6 697.4 698.2 700.6 702.8 709.6 13858.9 13880.7 13899.2 13936.0 13966.1 14320.5 14380.4 14743.3 15145.6 15380.2 11824.5 12028.5 12136.3 12162.9 12264.1 4063.5 4136.7 4170.0 4187.7 4276.9 54709.7 54939.2 54972.0 56989.1 57374.0 11776.5 11818.9 11876.7 11939.0 12062.0 19754.0 19802.4 19879.4 19883.9 19899.4 8627.3 8947.7 9118.9 9235.4 9240.6 4930.3 5016.5 5033.2 5043.3 5047.0 3538.1 3601.4 3613.5 3613.8 3618.7 669.3 680.1 682.7 691.2 695.9 635.9 730.8 735.4 736.8 791.9 9124.5 9679.0 9730.7 9812.9 9936.7 660.2 687.7 827.4 841.4 845.4 4524.3 4533.1 4576.2 4678.8 4812.1 63486.7 64840.0 64973.0 65208.7 65398.3 54976.0 54982.2 55290.0 58074.4 58293.0 51122.2 51592.2 52342.0 52760.7 52846.5 9473.4 9605.8 9630.0 9758.6 9822.3 38383.4 38715.0 38989.8 39402.6 40318.0 44475.8 48090.3 48294.8 48577.3 50387.7 11515.9 11833.3 11845.8 11890.6 12000.8 12246.8 12440.1 12696.2 12846.4 13013.2 11861.7 12104.9 12152.5 12309.2 12321.3 12181.7 12726.4 12836.1 12890.6 12936.9 12475.3 12788.6 12810.5 13150.1 13158.2 10943.7 10956.4 11000.4 11577.5 11670.9 10671.3 10961.6 10987.4 11008.5 11123.4 23:26:47 INFO - PROCESS | 16754 | -------- Summary: end -------- 23:26:47 INFO - PROCESS | 16754 | 23:26:48 INFO - TEST-INFO | 16754: exit 0 23:26:48 INFO - TEST-OK | dromaeo_css | took 1108984ms 23:26:48 INFO - TEST-START | kraken 23:26:48 INFO - operating with platform_type : linux_ 23:26:48 INFO - Initialising browser for kraken test... 23:26:48 INFO - TEST-INFO | started process 16995 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpwa982Z/profile http://localhost:34163/getInfo.html) 23:26:51 INFO - PROCESS | 16995 | 23:26:51 INFO - PROCESS | 16995 | (process:17073): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 23:26:52 INFO - PROCESS | 16995 | __metrics Screen width/height:1600/1200 23:26:52 INFO - PROCESS | 16995 | colorDepth:24 23:26:52 INFO - PROCESS | 16995 | Browser inner width/height: 1024/697 23:26:52 INFO - PROCESS | 16995 | __metrics 23:26:53 ERROR - PROCESS | 16995 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2931: TypeError: this.tabs is undefined 23:26:54 INFO - TEST-INFO | 16995: exit 0 23:26:54 INFO - Browser initialized. 23:26:54 INFO - Running cycle 1/1 for kraken test... 23:26:54 INFO - TEST-INFO | started process 17124 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpwa982Z/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 23:26:55 INFO - PROCESS | 17124 | 23:26:55 INFO - PROCESS | 17124 | (process:17197): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 23:27:05 INFO - PROCESS | 17124 | RSS: Main: 150343680 23:27:05 INFO - PROCESS | 17124 | 23:27:08 INFO - PROCESS | 17124 | Cycle 1(1): loaded http://localhost:34163/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:34163/tests/kraken/driver.html?testName=audio-beat-detection) 23:27:09 INFO - PROCESS | 17124 | RSS: Main: 155860992 23:27:09 INFO - PROCESS | 17124 | 23:27:11 INFO - PROCESS | 17124 | Cycle 1(1): loaded http://localhost:34163/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:34163/tests/kraken/driver.html?testName=audio-dft) 23:27:12 INFO - PROCESS | 17124 | RSS: Main: 155975680 23:27:12 INFO - PROCESS | 17124 | 23:27:15 INFO - PROCESS | 17124 | Cycle 1(1): loaded http://localhost:34163/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:34163/tests/kraken/driver.html?testName=audio-fft) 23:27:15 INFO - PROCESS | 17124 | RSS: Main: 156286976 23:27:15 INFO - PROCESS | 17124 | 23:27:18 INFO - PROCESS | 17124 | Cycle 1(1): loaded http://localhost:34163/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:34163/tests/kraken/driver.html?testName=audio-oscillator) 23:27:18 INFO - PROCESS | 17124 | RSS: Main: 155840512 23:27:18 INFO - PROCESS | 17124 | 23:27:20 INFO - PROCESS | 17124 | Cycle 1(1): loaded http://localhost:34163/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:34163/tests/kraken/driver.html?testName=imaging-gaussian-blur) 23:27:21 INFO - PROCESS | 17124 | RSS: Main: 155783168 23:27:21 INFO - PROCESS | 17124 | 23:27:24 INFO - PROCESS | 17124 | Cycle 1(1): loaded http://localhost:34163/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:34163/tests/kraken/driver.html?testName=imaging-darkroom) 23:27:25 INFO - PROCESS | 17124 | RSS: Main: 156475392 23:27:25 INFO - PROCESS | 17124 | 23:27:28 INFO - PROCESS | 17124 | Cycle 1(1): loaded http://localhost:34163/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:34163/tests/kraken/driver.html?testName=imaging-desaturate) 23:27:29 INFO - PROCESS | 17124 | RSS: Main: 156266496 23:27:29 INFO - PROCESS | 17124 | 23:27:31 INFO - PROCESS | 17124 | Cycle 1(1): loaded http://localhost:34163/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:34163/tests/kraken/driver.html?testName=json-parse-financial) 23:27:32 INFO - PROCESS | 17124 | RSS: Main: 156180480 23:27:32 INFO - PROCESS | 17124 | 23:27:33 INFO - PROCESS | 17124 | Cycle 1(1): loaded http://localhost:34163/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:34163/tests/kraken/driver.html?testName=json-stringify-tinderbox) 23:27:34 INFO - PROCESS | 17124 | RSS: Main: 155869184 23:27:34 INFO - PROCESS | 17124 | 23:27:36 INFO - PROCESS | 17124 | Cycle 1(1): loaded http://localhost:34163/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:34163/tests/kraken/driver.html?testName=stanford-crypto-aes) 23:27:36 INFO - PROCESS | 17124 | RSS: Main: 155987968 23:27:36 INFO - PROCESS | 17124 | 23:27:38 INFO - PROCESS | 17124 | Cycle 1(1): loaded http://localhost:34163/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:34163/tests/kraken/driver.html?testName=stanford-crypto-ccm) 23:27:39 INFO - PROCESS | 17124 | RSS: Main: 156364800 23:27:39 INFO - PROCESS | 17124 | 23:27:42 INFO - PROCESS | 17124 | Cycle 1(1): loaded http://localhost:34163/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:34163/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 23:27:42 INFO - PROCESS | 17124 | RSS: Main: 156692480 23:27:42 INFO - PROCESS | 17124 | 23:27:45 INFO - PROCESS | 17124 | Cycle 1(1): loaded http://localhost:34163/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:34163/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 23:27:45 INFO - PROCESS | 17124 | RSS: Main: 156721152 23:27:45 INFO - PROCESS | 17124 | 23:27:47 INFO - PROCESS | 17124 | Cycle 1(1): loaded http://localhost:34163/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:34163/tests/kraken/driver.html?testName=ai-astar) 23:27:47 INFO - PROCESS | 17124 | RSS: Main: 157995008 23:27:47 INFO - PROCESS | 17124 | 23:27:47 INFO - PROCESS | 17124 | __start_tp_report 23:27:47 INFO - PROCESS | 17124 | _x_x_mozilla_page_load 23:27:47 INFO - PROCESS | 17124 | _x_x_mozilla_page_load_details 23:27:47 INFO - PROCESS | 17124 | |i|pagename|runs| 23:27:47 INFO - PROCESS | 17124 | |0;ai-astar;108;111;106;111;112;111;101;110;110;110 23:27:47 INFO - PROCESS | 17124 | |1;audio-beat-detection;163;126;154;170;128;160;161;136;175;134 23:27:47 INFO - PROCESS | 17124 | |2;audio-dft;164;164;162;162;162;162;163;162;161;162 23:27:47 INFO - PROCESS | 17124 | |3;audio-fft;78;76;74;172;77;76;76;74;157;74 23:27:47 INFO - PROCESS | 17124 | |4;audio-oscillator;93;92;152;93;93;92;149;93;92;141 23:27:47 INFO - PROCESS | 17124 | |5;imaging-gaussian-blur;119;117;117;118;118;117;117;117;117;118 23:27:47 INFO - PROCESS | 17124 | |6;imaging-darkroom;147;149;147;147;146;148;147;147;146;147 23:27:47 INFO - PROCESS | 17124 | |7;imaging-desaturate;95;95;95;96;95;95;96;95;96;98 23:27:47 INFO - PROCESS | 17124 | |8;json-parse-financial;54;55;55;54;57;63;61;73;54;53 23:27:47 INFO - PROCESS | 17124 | |9;json-stringify-tinderbox;56;57;57;56;57;56;56;57;56;56 23:27:47 INFO - PROCESS | 17124 | |10;stanford-crypto-aes;75;73;74;75;74;75;75;75;75;74 23:27:47 INFO - PROCESS | 17124 | |11;stanford-crypto-ccm;120;125;115;130;117;126;122;113;134;141 23:27:47 INFO - PROCESS | 17124 | |12;stanford-crypto-pbkdf2;162;166;167;158;161;161;164;159;163;158 23:27:47 INFO - PROCESS | 17124 | |13;stanford-crypto-sha256-iterative;67;70;67;68;67;67;67;68;68;66 23:27:47 INFO - PROCESS | 17124 | __end_tp_report 23:27:47 INFO - PROCESS | 17124 | __start_cc_report 23:27:47 INFO - PROCESS | 17124 | _x_x_mozilla_cycle_collect,852 23:27:47 INFO - PROCESS | 17124 | __end_cc_report 23:27:47 INFO - PROCESS | 17124 | __startTimestamp1467527267892__endTimestamp 23:27:47 INFO - PROCESS | 17124 | 23:27:47 INFO - PROCESS | 17124 | ------- Summary: start ------- 23:27:47 INFO - PROCESS | 17124 | Number of tests: 14 23:27:47 INFO - PROCESS | 17124 | 23:27:47 INFO - PROCESS | 17124 | [#0] ai-astar Cycles:10 Average:109.00 Median:110.50 stddev:3.30 (3.0%) stddev-sans-first:3.48 23:27:47 INFO - PROCESS | 17124 | Values: 108.0 111.0 106.0 111.0 112.0 111.0 101.0 110.0 110.0 110.0 23:27:47 INFO - PROCESS | 17124 | 23:27:47 INFO - PROCESS | 17124 | [#1] audio-beat-detection Cycles:10 Average:150.70 Median:160.50 stddev:18.07 (11.3%) stddev-sans-first:18.61 23:27:47 INFO - PROCESS | 17124 | Values: 163.0 126.0 154.0 170.0 128.0 160.0 161.0 136.0 175.0 134.0 23:27:47 INFO - PROCESS | 17124 | 23:27:47 INFO - PROCESS | 17124 | [#2] audio-dft Cycles:10 Average:162.40 Median:162.00 stddev:0.97 (0.6%) stddev-sans-first:0.83 23:27:47 INFO - PROCESS | 17124 | Values: 164.0 164.0 162.0 162.0 162.0 162.0 163.0 162.0 161.0 162.0 23:27:47 INFO - PROCESS | 17124 | 23:27:47 INFO - PROCESS | 17124 | [#3] audio-fft Cycles:10 Average:93.40 Median:76.00 stddev:37.66 (49.6%) stddev-sans-first:39.53 23:27:47 INFO - PROCESS | 17124 | Values: 78.0 76.0 74.0 172.0 77.0 76.0 76.0 74.0 157.0 74.0 23:27:47 INFO - PROCESS | 17124 | 23:27:47 INFO - PROCESS | 17124 | [#4] audio-oscillator Cycles:10 Average:109.00 Median:92.50 stddev:26.59 (28.7%) stddev-sans-first:27.57 23:27:47 INFO - PROCESS | 17124 | Values: 93.0 92.0 152.0 93.0 93.0 92.0 149.0 93.0 92.0 141.0 23:27:47 INFO - PROCESS | 17124 | 23:27:47 INFO - PROCESS | 17124 | [#5] imaging-gaussian-blur Cycles:10 Average:117.50 Median:117.50 stddev:0.71 (0.6%) stddev-sans-first:0.50 23:27:47 INFO - PROCESS | 17124 | Values: 119.0 117.0 117.0 118.0 118.0 117.0 117.0 117.0 117.0 118.0 23:27:47 INFO - PROCESS | 17124 | 23:27:47 INFO - PROCESS | 17124 | [#6] imaging-darkroom Cycles:10 Average:147.10 Median:147.00 stddev:0.88 (0.6%) stddev-sans-first:0.93 23:27:47 INFO - PROCESS | 17124 | Values: 147.0 149.0 147.0 147.0 146.0 148.0 147.0 147.0 146.0 147.0 23:27:47 INFO - PROCESS | 17124 | 23:27:47 INFO - PROCESS | 17124 | [#7] imaging-desaturate Cycles:10 Average:95.60 Median:95.50 stddev:0.97 (1.0%) stddev-sans-first:1.00 23:27:47 INFO - PROCESS | 17124 | Values: 95.0 95.0 95.0 96.0 95.0 95.0 96.0 95.0 96.0 98.0 23:27:47 INFO - PROCESS | 17124 | 23:27:47 INFO - PROCESS | 17124 | [#8] json-parse-financial Cycles:10 Average:57.90 Median:56.00 stddev:6.24 (11.2%) stddev-sans-first:6.46 23:27:47 INFO - PROCESS | 17124 | Values: 54.0 55.0 55.0 54.0 57.0 63.0 61.0 73.0 54.0 53.0 23:27:47 INFO - PROCESS | 17124 | 23:27:47 INFO - PROCESS | 17124 | [#9] json-stringify-tinderbox Cycles:10 Average:56.40 Median:56.50 stddev:0.52 (0.9%) stddev-sans-first:0.53 23:27:47 INFO - PROCESS | 17124 | Values: 56.0 57.0 57.0 56.0 57.0 56.0 56.0 57.0 56.0 56.0 23:27:47 INFO - PROCESS | 17124 | 23:27:47 INFO - PROCESS | 17124 | [#10] stanford-crypto-aes Cycles:10 Average:74.50 Median:75.00 stddev:0.71 (0.9%) stddev-sans-first:0.73 23:27:47 INFO - PROCESS | 17124 | Values: 75.0 73.0 74.0 75.0 74.0 75.0 75.0 75.0 75.0 74.0 23:27:47 INFO - PROCESS | 17124 | 23:27:47 INFO - PROCESS | 17124 | [#11] stanford-crypto-ccm Cycles:10 Average:124.30 Median:125.50 stddev:8.82 (7.0%) stddev-sans-first:9.22 23:27:47 INFO - PROCESS | 17124 | Values: 120.0 125.0 115.0 130.0 117.0 126.0 122.0 113.0 134.0 141.0 23:27:47 INFO - PROCESS | 17124 | 23:27:47 INFO - PROCESS | 17124 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:161.90 Median:162.50 stddev:3.14 (1.9%) stddev-sans-first:3.33 23:27:47 INFO - PROCESS | 17124 | Values: 162.0 166.0 167.0 158.0 161.0 161.0 164.0 159.0 163.0 158.0 23:27:47 INFO - PROCESS | 17124 | 23:27:47 INFO - PROCESS | 17124 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:67.50 Median:67.50 stddev:1.08 (1.6%) stddev-sans-first:1.13 23:27:47 INFO - PROCESS | 17124 | Values: 67.0 70.0 67.0 68.0 67.0 67.0 67.0 68.0 68.0 66.0 23:27:47 INFO - PROCESS | 17124 | -------- Summary: end -------- 23:27:47 INFO - PROCESS | 17124 | 23:27:48 INFO - TEST-INFO | 17124: exit 0 23:27:48 INFO - TEST-OK | kraken | took 60598ms 23:27:48 INFO - SUITE-END | took 1169s 23:27:49 INFO - Completed test suite (00:19:29) 23:27:49 INFO - javascript benchmark 23:27:49 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3355.9664403355964, 3418.3163367326533, 3426.5374174486437, 3442.431998720211, 3477.4783782432633, 5537.612367134302, 5593.133064375028, 5611.382747897728, 5622.381538030819, 5630.5495560355175, 5580.302462192216, 5607.439256074391, 5609.5231905288, 5637.605367624268, 5674.631148975313, 5070.492950704936, 5089.7964081436885, 5138.743062846861, 5147.974260128694, 5161.303224064741, 5021.297018417425, 5069.569086627641, 5154.793808247684, 5197.298364720752, 5228.451012643655, 5182.844514664566, 5196.090684130281, 5204.063268611649, 5239.476052394749, 5252.71110088945, 5167.250748641463, 5173.224016397514, 5174.042802081608, 5202.3497062867145, 5205.29728486657, 4953.281774142729, 4989.775460104304, 5077.882865769525, 5079.593632509391, 5118.744062796845, 5415.620906536544, 5439.646422982533, 5441.5102640762525, 5457.263269458612, 5507.201455788888, 5872.911906321408, 5904.498117660004, 5911.615744976562, 5935.910961335583, 5944.0, 5962.0921305182355, 5970.194023806774, 5975.671338076404, 6061.66660833654, 6121.879793613194, 5523.2543606613, 5523.613347065667, 5551.444855514416, 5558.082916318803, 5578.553715702775, 6031.698415079229, 6045.667488288186, 6049.0, 6054.606450580698, 6089.421504957022, 5767.68277744728, 5813.505852002542, 5830.416958304136, 5886.676232807151, 5933.288005439289, 5915.615484993462, 5942.910856337158, 5949.315828679671, 5961.701914904237, 5966.642001479839, 5870.148828419855, 5906.232189815297, 5919.1713160157615, 5945.435183657545, 5952.791652292149, 5851.210086638334, 5968.791092311748, 6043.697815109227, 6068.393160683896, 6094.847628809315, 4524.932126018112, 4535.274356103007, 4536.637069034469, 4537.410136682276, 4584.243599805995, 4100.17996400721, 4103.9179216415505, 4111.444954931106, 4111.71218014742, 4151.709380343407, 5743.765090505562, 5793.102069179284, 5798.420157984167, 5839.591228614041, 5876.44173803488, 6033.426824451758, 6049.909251361233, 6059.697015149225, 6060.393960603992, 6080.543959203077, 5637.379888212294, 5837.88324233513, 5842.620229685057, 5846.064629659234, 5870.14882841994, 5164.974175129176, 5170.508801663836, 5179.637425380187, 5188.377394712658, 5214.0875346814155, 6189.752409903554, 6203.31763506014, 6231.813045608639, 6245.812625621239, 6246.3441338659695, 5905.261842269716, 6026.879462410815, 6034.607750496204, 6065.60573562717, 6116.847078823065, 6249.875002500015, 6252.218472690914, 6253.218347706536, 6257.843553911189, 6262.405071518198, 5898.144769008384, 5915.201447804491, 5915.231019967377, 5936.0, 5955.5235581154275, 5993.101034844808, 6025.548083893813, 6082.7262773174425, 6121.148138557471, 6168.475679567107, 5867.882642347215, 5923.08192230205, 5927.525797936241, 5932.228810254639, 5961.582689211887, 5917.704114794157, 5920.200772895776, 5920.437558431942, 5924.11138329254, 5925.348211696796, 5646.435356464485, 5838.678872662044, 5905.350411454822, 5908.675022873783, 5930.495907847709, 5956.493698035542, 5962.672053037125, 5980.9401905980385, 6006.8498287541415, 6024.548158888013, 5749.655020698604, 5851.941480585139, 5857.648541087548, 5867.618604790675, 5879.2944846618675], "value": 5554.17691918911, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [665.4742753224953, 689.4105539763499, 693.4313862632641, 731.3235257386916, 743.074871784628, 40108.799456002715, 40339.596604033984, 40343.1931361373, 40489.0, 40492.39261411081, 38546.0, 38997.805010974975, 39032.60967390325, 39073.0, 39149.21701565967, 8869.645214191441, 8966.506842123681, 9034.503102329369, 9056.954715226448, 9060.411073280216, 8831.64673413066, 8944.597493112826, 8947.194752472276, 8959.28325733943, 8963.775905602346, 9213.539323033856, 9232.907670923305, 9247.39891907024, 9268.165865072142, 9275.814483710321, 9157.679481218158, 9184.173424391804, 9216.769580760467, 9225.492597907112, 9259.6296148154, 9124.27005839538, 9217.861732074025, 9219.953900230523, 9227.123423274777, 9236.261099112055, 44096.779516102535, 44420.0, 44428.555714442766, 44561.77719111416, 44591.554084459065, 3845.557760857509, 3909.1204478992286, 4001.153414006029, 4019.919601607981, 4059.7970101494807, 33800.15499612505, 33960.660393396, 34169.316613667834, 34653.48019779706, 35390.0, 4621.653375996813, 4637.489876113625, 4678.836240731592, 4731.101090792738, 4762.28565715142, 313098.0, 313805.0, 313922.0, 315950.0, 316490.0, 41002.79498602488, 54593.727031365386, 55055.17417238664, 55228.0, 55340.0, 39186.216275674895, 39198.0, 39290.0, 39391.0, 39532.40701389424, 17299.481015569552, 17516.12419379026, 17517.562060948323, 17556.561085972953, 17562.121893905252, 14718.779218311734, 14784.408623654934, 14794.852051479562, 14799.0, 14811.407543698348, 9393.295502837314, 9484.478353690612, 9692.75768105803, 9731.464769437749, 9792.069753373418, 3635.363811333006, 3740.2893450244364, 3746.4942232798767, 3755.080005398695, 3760.8871733848027, 1057.0011339284456, 1082.5615625671617, 1121.2151493954264, 1158.48447440888, 1199.2564609941717, 32572.0, 33622.0, 34581.65418345835, 35089.47365789515, 35207.0, 1168.4391492083848, 1170.53763763313, 1185.8814118588073, 1192.6839387562302, 1215.3254943506438, 16603.916980415263, 17248.0, 17372.913135434494, 17502.21240044201, 17705.645887082443, 503408.0, 519251.0, 537261.0, 539072.0, 541261.0, 63605.0, 64631.67684161549, 65290.347096529375, 65408.345916540224, 65463.34536654573, 1469.2580246975422, 1541.8072740907387, 1542.8225754038428, 1562.406285611483, 1582.8258891521923, 34232.486512701835, 34595.30809383748, 34607.0, 34886.30227395488, 35351.0, 54880.451195487534, 55591.16613250886, 55647.16529252145, 55728.442715572324, 55969.16046259228, 439974.0, 447061.0, 447357.0, 447835.0, 449776.00447991514, 31962.20094497656, 32121.678783212803, 32408.0, 32424.513632296006, 32516.51225231671, 52757.0, 52853.0, 53382.19926701025, 53915.730421347645, 53962.0, 43962.78018609886, 44434.33348499711, 44463.11073778571, 44600.55399445964, 45846.77076614596, 45128.0, 45176.0, 45610.54389456195, 45720.77139614414, 45799.313010304206, 44821.103577927606, 45486.0, 45905.31142032939, 46032.0, 46122.308165378214, 36620.084497887765, 37231.6968906087, 37551.43672844964, 38175.42736859005, 38312.23375532418, 29173.70826291795, 30032.348220848064, 30364.848175759864, 30553.847230763702, 30658.233544161576], "value": 20066.294961566167, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [429.6262251840897, 437.5580663529835, 443.3305708380345, 446.6493802365143, 449.81332746910033, 18770.718439223423, 19191.232350705974, 19489.41531754048, 21214.787852121473, 21424.785752142474, 19547.315843945464, 19918.302859399922, 20150.294739684115, 20631.999999999964, 20644.277450289243, 5592.328920529532, 5989.341172471025, 5991.0, 6001.33985261622, 6007.489363404094, 3738.439234114891, 5892.823215303526, 7184.173820010687, 7533.209013053633, 7566.01641786567, 7315.8536829263385, 7487.2887075727995, 7520.097588289385, 7522.887156692654, 7560.168381478033, 7509.211532789061, 7566.243375662445, 7575.886361704579, 7588.772336829931, 7588.810279742996, 7157.3916217121605, 7274.927250727478, 7320.707171713125, 7340.376068034224, 7365.895115732629, 26156.86921565399, 26629.46741065168, 27719.722802771917, 28260.576091358645, 28387.0, 2527.42343773265, 2759.365345970438, 3248.5776849009712, 3483.285926385085, 3522.2603253316834, 15442.845571544365, 16060.11669358185, 16169.19154042305, 16457.753133703005, 16874.66250674992, 2209.2819833554, 2250.268662684634, 2278.362058623588, 2355.470019245673, 2383.9748907969565, 95875.0, 96220.0, 97712.0, 98279.0, 98517.50741246248, 17808.643827123644, 18688.719669204973, 18911.81088189128, 19092.61814763697, 19340.70988935167, 35410.82294588562, 35465.0, 35599.0, 35951.4607280891, 36210.27579448396, 8215.219554142346, 8514.361422893307, 8536.402451828437, 8573.356998225034, 8651.04838467768, 8756.387052906235, 8768.912310876809, 8775.0, 8818.51498167594, 8898.955505222433, 4775.832845850378, 4792.688475249098, 4822.565969062801, 4828.396450443694, 4837.637177211724, 1939.1661585518364, 1992.1035534009754, 2020.05057622917, 2045.764737055228, 2053.6303465376077, 987.9506024698736, 1055.8205105132147, 1059.9894001060045, 1070.9518071686794, 1111.5664890692635, 19521.0, 19551.511212219808, 19670.213191472467, 19704.605907881763, 20021.898795566092, 1065.0, 1077.5959015369237, 1086.4459125845717, 1124.662601219631, 1179.2983175010854, 10848.349099053925, 11013.229073964745, 11165.274257173258, 11183.329000259848, 11197.552097916156, 492656.0, 496062.0, 509392.0, 571912.0, 575831.0, 94760.52619736995, 97999.0, 98114.0, 99044.50477747565, 99498.502507487, 1101.4162493878257, 1125.4654039331415, 1138.4364739453858, 1156.7455159864817, 1157.5254145800182, 17116.144192790558, 17425.215865286347, 17499.38752143669, 17512.211950462006, 17828.643427131643, 40053.19893602053, 40458.39312410257, 40930.79534602308, 41324.0, 41665.1666966665, 57110.0, 59475.0, 59851.401485986324, 60759.0, 60767.39232607794, 8969.596368163318, 9133.634654614007, 9161.129692679186, 9165.77085572866, 9285.814283714422, 8973.865392019256, 10375.325603835727, 13597.728045439233, 13892.23592702411, 13948.651283717989, 11225.438728063727, 11942.522299107939, 11950.282983021047, 11979.760404791681, 12024.939875300568, 11901.404929753651, 11919.404029798648, 11935.582254621047, 12361.876381236432, 12467.5012999479, 11692.824607631062, 11782.0, 11832.171747977904, 12332.691682708004, 12336.0, 8934.28525717954, 9147.908520914973, 9167.816643666956, 9290.16388525036, 9313.580888860153, 8789.384743067923, 11316.15128865322, 11415.429228538374, 11447.084233261152, 11737.178397512434], "value": 10464.563317443757, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1575.5430925031737, 1595.7606359046144, 1744.5813004878826, 1825.735268386085, 1863.8229368210032, 7342.96328518358, 8037.678492860293, 8105.797355066119, 8305.626246818892, 8313.168683131684, 8058.63736131874, 8096.55468949209, 8109.878351824727, 8128.349732021439, 8144.674213031486, 2266.693996310502, 2285.759995200505, 2287.8627282363113, 2288.5766133265315, 2290.4044948313476, 2256.4922892349173, 2268.54629074185, 2311.653252012195, 2313.768623137681, 2314.618088015475, 2137.3801597536694, 2158.7625361210253, 2161.0, 2264.1396269417596, 2309.976900230993, 2268.875211863347, 2270.160040784912, 2271.636538153904, 2272.863628182314, 2279.7606251343536, 2295.8048565871923, 2321.9071237150492, 2323.6398358254496, 2328.080408238753, 2331.7318508371586, 8345.54099524526, 8383.245507904317, 8388.706395276136, 8392.832143357098, 8408.663653453854, 5037.319961805183, 5107.7956881724685, 5110.361204849394, 5119.155339368999, 5130.3074084998425, 3113.9532907006414, 3248.626407963091, 3265.2816380396275, 3292.687194716498, 3297.76915615907, 1088.9401082940435, 1093.2238110941241, 1129.9152563557684, 1133.3879704959313, 1152.4986630815622, 11602.419879006016, 11616.767664646659, 11618.360990145538, 11631.30212187263, 11683.357415342152, 4360.411344468456, 4434.623057040123, 4482.708623939434, 4491.393661855673, 4578.061497393026, 9865.950670246746, 9940.807103147525, 9984.850227246598, 10000.499975001221, 10005.44970026641, 5161.071007218661, 5162.328897243335, 5177.042247184283, 5208.9739551302755, 5218.060749065205, 4110.979445102756, 4650.395448591661, 4709.62323014158, 4766.165920963817, 4787.473377928425, 3908.9804550977633, 4005.1388951375593, 4029.4560234367987, 4037.4953130858644, 4085.080856807254, 1250.481050364107, 1285.3637449462576, 1295.5077070713257, 1304.4195333076689, 1308.5485507500089, 1084.0622861224983, 1098.5770478365887, 1109.8501702270253, 1110.0, 1113.1706878375662, 5803.0, 6094.085887116879, 6103.1455596216565, 6133.172021777003, 6153.600015998945, 431.0947011276295, 431.4628287781669, 433.43653250773866, 1110.2561283939779, 1130.361345839598, 4114.691398145092, 4141.068259641556, 4141.52372477169, 4145.564715704868, 4166.895827604273, 10169.135623472088, 10414.323069000491, 10480.68557943263, 10568.841467377995, 10569.0, 10231.846522302172, 10375.0, 10375.896241037493, 10391.688249352532, 10406.0, 7972.043354797345, 8128.634211460499, 8139.959300203461, 8167.305779008732, 8177.468464549905, 5809.82570522885, 5857.619254748428, 5898.4101589840675, 5944.64332140073, 6061.636301821904, 8846.292296616384, 8930.240929520804, 9042.638294468148, 9060.093990600888, 9122.635094596142, 8623.913760862311, 8837.204651581389, 9017.323700722342, 9103.954480227556, 9214.354995150275, 7267.745628902963, 7402.407807375289, 7409.370203532544, 7545.471816972759, 7569.0, 8086.757397278091, 8091.06952700447, 8093.635786389509, 8132.512049277062, 8133.633986470742, 7269.7455589054125, 7452.739154129579, 7452.776416707507, 7493.625318734151, 7575.6969721210535, 6838.418734407631, 6896.793096207121, 6911.89632155508, 6975.476839236976, 6976.302369763186, 7010.579365238102, 7064.470164737562, 7076.32774886385, 7080.716771329089, 7088.574685518885, 5254.7898084076205, 5272.604554658339, 5354.625176237626, 5371.033214021513, 5457.0, 5156.484351564814, 5339.252504649275, 5386.7575959082715, 5495.120780675073, 5531.585131115263], "value": 4508.669078614787, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [340.7580617761388, 341.99487007694904, 356.6237619311625, 366.21629712415427, 369.39603747872223, 6375.776847810327, 6410.23077230733, 6424.743010279589, 6453.8063858084215, 6487.870242595145, 6527.902081468782, 6567.244766851813, 6585.275619681843, 6603.636799976, 6616.1399018127695, 4958.256261560768, 4976.925346119793, 4984.352034235544, 4993.825216117437, 4994.625403094782, 4986.127427700156, 4994.575461085794, 4998.875028124289, 5006.224035274538, 5010.599152067844, 4888.364512613355, 4930.704157750529, 4935.950640493603, 4938.851834444955, 4957.082939656175, 4746.240601503743, 4887.462379138292, 4927.162382395001, 4927.704337739729, 4930.827421040264, 4245.830166793325, 4248.277792775236, 4256.297710877701, 4269.978650106761, 4288.399624052604, 6300.0, 6354.7458101675875, 6355.697082098159, 6356.459700925427, 6361.618302901795, 5575.888482230333, 5682.659040457585, 5687.03320435527, 5692.003899317644, 5740.4833564978935, 6824.21521525026, 6851.246362900077, 6855.211650660138, 6865.622390768505, 6865.828354291133, 4743.691660042086, 4750.382450281476, 4751.477337492873, 4755.42934847817, 4757.785899634525, 7141.8928716068785, 7153.89269160963, 7179.49743517954, 7204.819879503054, 7230.566166030002, 4882.12121818069, 4882.8779280517565, 4886.633502487328, 4890.388701412324, 4894.045661096052, 4770.904581908342, 4886.53577910098, 4890.608751299887, 4899.387576552931, 4913.287573301923, 5616.382197958222, 5658.7170641467765, 5683.857903552444, 5711.600187986801, 5717.799877004368, 6906.758263460755, 6935.167779866449, 6936.375726184668, 6942.583444993215, 6943.375096241362, 1710.059467292984, 1730.956726081858, 1733.9479815605553, 1734.5576877896056, 1739.3216645508262, 1072.5388083124176, 1103.3545375954996, 1107.5514416661265, 1123.719070232442, 1129.1869853705318, 6633.336666333328, 6642.535022548375, 6642.535022548472, 6646.036324732887, 6664.966675166593, 7071.681774320168, 7074.434045276468, 7077.469189810785, 7078.504504684623, 7081.716731330689, 6610.768623098168, 6656.334366563305, 6662.6668666566475, 6671.699773510204, 6686.7993960181275, 3814.1036856338737, 3828.0429892526868, 3839.1361943562474, 3843.461915331856, 3849.2301539692176, 7313.341799238094, 7330.230325815819, 7537.585432801248, 7549.0, 7563.810904727426, 7381.520201186906, 7387.519811212254, 7389.371903388164, 7392.297731715478, 7394.4823862330195, 7510.812229694301, 7540.849183016309, 7542.736004239825, 7551.697932082655, 7567.356774674105, 6959.826004349729, 7250.202477727551, 7255.455840812066, 7260.709571617076, 7263.055802745609, 7130.037444944866, 7141.82145446368, 7157.24848890859, 7159.821004474929, 7173.497855150089, 7446.888296675445, 7556.622168891424, 7557.433192510473, 7558.735444259644, 7578.658960346687, 4810.879728006687, 4934.654574179916, 4939.0, 4941.209406494943, 4955.35580374549, 7078.964605176941, 7231.204567497466, 7244.746433874789, 7259.455540834353, 7340.816479588053, 6970.477214208853, 6977.616231107338, 6979.895301570379, 6991.860162796817, 7004.369606735215, 6965.5124141309625, 6981.930180698128, 6988.126484189476, 6993.4055605274125, 6998.300169982961, 6849.486288528281, 6860.0738900247825, 6867.553609015398, 6868.896966545606, 6876.312368763083, 6835.93164068353, 7031.191412987572, 7039.54242974205, 7043.330883566053, 7069.434445244471, 6889.379955804002, 6897.655117244018, 6943.826404339932, 6966.616836073862, 6986.301369862973], "value": 5212.787286265056, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [843.9493630382176, 900.3067637918803, 911.8768966189563, 915.2586405011937, 920.2867777472462, 14114.153150810958, 14327.928360358184, 14365.994380393364, 14377.640558986031, 14459.92770036151, 14160.787588186186, 14207.78688319676, 14323.212223327739, 14401.0, 14437.0, 754.6415452659998, 789.0807209600837, 790.8181118342785, 809.9392545559077, 822.2969361196181, 897.9281657467419, 898.7708134425712, 900.1853322742928, 904.8280826642949, 905.5653286422488, 954.3319676226635, 954.4750387286999, 956.1442508954482, 958.2477754962356, 961.0725649747992, 940.4122423485321, 947.3794664494733, 949.1694767078806, 950.1116456113486, 951.5670369981642, 697.4315932515035, 698.2284575544053, 700.5866538742166, 702.7575486457164, 709.5919846088468, 13858.930705346509, 13880.652983675387, 13899.235542045184, 13936.0, 13966.092204006707, 14320.498782542561, 14380.352884120135, 14743.336549855283, 15145.621359465991, 15380.154091524962, 11824.467898944567, 12028.51885924562, 12136.271823690608, 12162.878371216351, 12264.080193985397, 4063.5123785145674, 4136.710430269883, 4169.97915010423, 4187.685923555715, 4276.87169384919, 54709.72645136749, 54939.175912361345, 54971.9999999996, 56989.14516282259, 57374.0, 11776.52893884252, 11818.881811181951, 11876.703082423008, 11939.044876409866, 12062.0, 19754.0, 19802.405927822187, 19879.403617891487, 19883.900580497295, 19899.403017909484, 8627.266682331947, 8947.731568052968, 9118.86321705175, 9235.445873247492, 9240.630374784932, 4930.260460930889, 5016.54851063406, 5033.194688849767, 5043.293938848564, 5047.0, 3538.062413460435, 3601.3517566838223, 3613.530241068697, 3613.8012409317216, 3618.656227658368, 669.2771806449024, 680.0954730208811, 682.6859644563557, 691.1878542712393, 695.9025736396909, 635.9046143078483, 730.8428687832142, 735.4226931858466, 736.7605528203355, 791.9388020053042, 9124.498152601538, 9679.032096790406, 9730.659426920165, 9812.901870981199, 9936.652217172365, 660.2101751790727, 687.700850130195, 827.3670641958906, 841.3731769831514, 845.4377838737294, 4524.343970124313, 4533.101532681891, 4576.153411618861, 4678.836240731558, 4812.085703716282, 63486.682566586875, 64840.0, 64973.0, 65208.673956629915, 65398.34601654018, 54976.0, 54982.17526737102, 55290.0, 58074.419255806904, 58293.0, 51122.233166502534, 51592.22611660828, 52342.0, 52760.73619631877, 52846.47153528415, 9473.431594104375, 9605.759856003377, 9629.951850240985, 9758.56086476096, 9822.312438129262, 38383.42424863685, 38715.03212419712, 38989.8050509757, 39402.60597393989, 40318.0, 44475.77762111169, 48090.27864582104, 48294.79263018312, 48577.27134093062, 50387.74806125946, 11515.916226205263, 11833.349165795964, 11845.763084738084, 11890.583829565923, 12000.75998480043, 12246.816297755362, 12440.066994975594, 12696.17474864131, 12846.357682116044, 13013.21920684762, 11861.703457413634, 12104.878951210376, 12152.453139608915, 12309.199902006341, 12321.322327271728, 12181.69545761363, 12726.427310771223, 12836.101472896808, 12890.613281601567, 12936.935315323362, 12475.251484910934, 12788.616341509769, 12810.487580496676, 13150.145240559334, 13158.210507369206, 10943.726406839893, 10956.397398143179, 11000.449977500934, 11577.479013444246, 11670.88329116698, 10671.306365086555, 10961.616343427942, 10987.39569323695, 11008.504617292081, 11123.388213648326], "value": 7083.37988883058, "unit": "score"}], "name": "dromaeo_css", "value": 7609.704509707951, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [108.0, 111.0, 106.0, 111.0, 112.0, 111.0, 101.0, 110.0, 110.0, 110.0], "value": 109.0, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [163.0, 126.0, 154.0, 170.0, 128.0, 160.0, 161.0, 136.0, 175.0, 134.0], "value": 150.7, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [164.0, 164.0, 162.0, 162.0, 162.0, 162.0, 163.0, 162.0, 161.0, 162.0], "value": 162.4, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [78.0, 76.0, 74.0, 172.0, 77.0, 76.0, 76.0, 74.0, 157.0, 74.0], "value": 93.4, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [93.0, 92.0, 152.0, 93.0, 93.0, 92.0, 149.0, 93.0, 92.0, 141.0], "value": 109.0, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [119.0, 117.0, 117.0, 118.0, 118.0, 117.0, 117.0, 117.0, 117.0, 118.0], "value": 117.5, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [147.0, 149.0, 147.0, 147.0, 146.0, 148.0, 147.0, 147.0, 146.0, 147.0], "value": 147.1, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 95.0, 95.0, 96.0, 95.0, 95.0, 96.0, 95.0, 96.0, 98.0], "value": 95.6, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [54.0, 55.0, 55.0, 54.0, 57.0, 63.0, 61.0, 73.0, 54.0, 53.0], "value": 57.9, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [56.0, 57.0, 57.0, 56.0, 57.0, 56.0, 56.0, 57.0, 56.0, 56.0], "value": 56.4, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 73.0, 74.0, 75.0, 74.0, 75.0, 75.0, 75.0, 75.0, 74.0], "value": 74.5, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [120.0, 125.0, 115.0, 130.0, 117.0, 126.0, 122.0, 113.0, 134.0, 141.0], "value": 124.3, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [162.0, 166.0, 167.0, 158.0, 161.0, 161.0, 164.0, 159.0, 163.0, 158.0], "value": 161.9, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [67.0, 70.0, 67.0, 68.0, 67.0, 67.0, 67.0, 68.0, 68.0, 66.0], "value": 67.5, "unit": "score"}], "name": "kraken", "value": 1527.2000000000003, "alertThreshold": 2.0}]} 23:27:49 INFO - Return code: 0 23:27:49 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 23:27:49 ERROR - # TBPL SUCCESS # 23:27:49 INFO - Running post-action listener: _resource_record_post_action 23:27:49 INFO - Running post-run listener: _resource_record_post_run 23:27:50 INFO - Total resource usage - Wall time: 1184s; CPU: 13.0%; Read bytes: 32768; Write bytes: 469344256; Read time: 48; Write time: 560844 23:27:50 INFO - install - Wall time: 14s; CPU: 16.0%; Read bytes: 0; Write bytes: 249217024; Read time: 0; Write time: 423532 23:27:50 INFO - run-tests - Wall time: 1171s; CPU: 13.0%; Read bytes: 8192; Write bytes: 219897856; Read time: 36; Write time: 137256 23:27:50 INFO - Running post-run listener: _upload_blobber_files 23:27:50 INFO - Blob upload gear active. 23:27:50 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 23:27:50 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:27:50 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:27:50 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:27:50 INFO - (blobuploader) - INFO - Open directory for files ... 23:27:50 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 23:27:50 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 23:27:50 INFO - (blobuploader) - INFO - Uploading, attempt #1. 23:27:51 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 23:27:51 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 23:27:51 INFO - (blobuploader) - INFO - Done attempting. 23:27:51 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 23:27:51 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 23:27:51 INFO - (blobuploader) - INFO - Uploading, attempt #1. 23:27:52 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 23:27:52 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 23:27:52 INFO - (blobuploader) - INFO - Done attempting. 23:27:52 INFO - (blobuploader) - INFO - Iteration through files over. 23:27:52 INFO - Return code: 0 23:27:52 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 23:27:52 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 23:27:52 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/a1bbd3eee049c9658ab7e8449d207a6babdad64cc9767233dfdd4b9e323b4a41408e96c098bd049a30d0c224b3fe80f82cd3ae740b5f533e736739bd92ac6a1c", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/e7825a93ca735ed66ebfd15ed77b824b6a5656b692798330b81a07b3c46c155abb74efb8f9b59d38ac5841807b720d9848e910e70c352ce6b0e2973e6d4b33e6"} 23:27:52 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 23:27:52 INFO - Writing to file /builds/slave/test/properties/blobber_files 23:27:52 INFO - Contents: 23:27:52 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/a1bbd3eee049c9658ab7e8449d207a6babdad64cc9767233dfdd4b9e323b4a41408e96c098bd049a30d0c224b3fe80f82cd3ae740b5f533e736739bd92ac6a1c", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/e7825a93ca735ed66ebfd15ed77b824b6a5656b692798330b81a07b3c46c155abb74efb8f9b59d38ac5841807b720d9848e910e70c352ce6b0e2973e6d4b33e6"} 23:27:52 INFO - Running post-run listener: copy_logs_to_upload_dir 23:27:52 INFO - Copying logs to upload dir... 23:27:52 INFO - mkdir: /builds/slave/test/build/upload/logs 23:27:52 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1307.122389 ========= master_lag: 0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 47 secs) (at 2016-07-02 23:27:51.369832) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-07-02 23:27:51.372912) ========= 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=97facb8ba2ac28944cc45e6b000001d4-1467519811.557221-1149711480 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/a1bbd3eee049c9658ab7e8449d207a6babdad64cc9767233dfdd4b9e323b4a41408e96c098bd049a30d0c224b3fe80f82cd3ae740b5f533e736739bd92ac6a1c", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/e7825a93ca735ed66ebfd15ed77b824b6a5656b692798330b81a07b3c46c155abb74efb8f9b59d38ac5841807b720d9848e910e70c352ce6b0e2973e6d4b33e6"} 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.011370 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/a1bbd3eee049c9658ab7e8449d207a6babdad64cc9767233dfdd4b9e323b4a41408e96c098bd049a30d0c224b3fe80f82cd3ae740b5f533e736739bd92ac6a1c", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/e7825a93ca735ed66ebfd15ed77b824b6a5656b692798330b81a07b3c46c155abb74efb8f9b59d38ac5841807b720d9848e910e70c352ce6b0e2973e6d4b33e6"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-07-02 23:27:51.402595) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-07-02 23:27:51.403366) ========= 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=97facb8ba2ac28944cc45e6b000001d4-1467519811.557221-1149711480 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004383 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-07-02 23:27:51.486202) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-07-02 23:27:51.486808) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-07-02 23:27:51.487432) ========= ========= Total master_lag: 0.17 =========