builder: mozilla-aurora_ubuntu64_hw_test-dromaeojs-e10s-pgo slave: talos-linux64-ix-026 starttime: 1472850142.36 results: success (0) buildid: 20160902110447 builduid: 0684f3cd04564a4da15011e6a010e5df revision: 3cb50e5df49728e19c6f5bcb4c5b3fe34a9db53c ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-09-02 14:02:22.359795) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-09-02 14:02:22.360379) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-09-02 14:02:22.360704) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-09-02 14:02:22.376188) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-09-02 14:02:22.376865) ========= 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=41bf3e9aed84707956354da8000001c5-1472850127.773110-1745143973 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-09-02 14:02:22-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 42.9M=0s 2016-09-02 14:02:22 (42.9 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.139846 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-09-02 14:02:22.531389) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-09-02 14:02:22.531743) ========= 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=41bf3e9aed84707956354da8000001c5-1472850127.773110-1745143973 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.015358 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-09-02 14:02:22.582170) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-09-02 14:02:22.582555) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev 3cb50e5df49728e19c6f5bcb4c5b3fe34a9db53c --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-aurora --rev 3cb50e5df49728e19c6f5bcb4c5b3fe34a9db53c --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=41bf3e9aed84707956354da8000001c5-1472850127.773110-1745143973 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-09-02 14:02:22,603 truncating revision to first 12 chars 2016-09-02 14:02:22,603 Setting DEBUG logging. 2016-09-02 14:02:22,603 attempt 1/10 2016-09-02 14:02:22,603 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-aurora/3cb50e5df497?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-09-02 14:02:23,782 unpacking tar archive at: mozilla-aurora-3cb50e5df497/testing/mozharness/ program finished with exit code 0 elapsedTime=1.532997 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-09-02 14:02:24.129182) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-09-02 14:02:24.129503) ========= script_repo_revision: 3cb50e5df49728e19c6f5bcb4c5b3fe34a9db53c ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-09-02 14:02:24.129889) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-09-02 14:02:24.130165) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-09-02 14:02:24.138698) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 27 mins, 57 secs) (at 2016-09-02 14:02:24.139048) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Mozilla-Aurora --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Aurora in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs-e10s', '--add-option', '--webServer,localhost', '--branch-name', 'Mozilla-Aurora', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Mozilla-Aurora'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=41bf3e9aed84707956354da8000001c5-1472850127.773110-1745143973 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 14:02:24 INFO - MultiFileLogger online at 20160902 14:02:24 in /builds/slave/test 14:02:24 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Mozilla-Aurora --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Aurora 14:02:24 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 14:02:24 INFO - {'append_to_log': False, 14:02:24 INFO - 'base_work_dir': '/builds/slave/test', 14:02:24 INFO - 'blob_upload_branch': 'Mozilla-Aurora', 14:02:24 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 14:02:24 INFO - 'branch': 'Mozilla-Aurora', 14:02:24 INFO - 'buildbot_json_path': 'buildprops.json', 14:02:24 INFO - 'config_files': ('talos/linux_config.py',), 14:02:24 INFO - 'default_actions': ('clobber', 14:02:24 INFO - 'read-buildbot-config', 14:02:24 INFO - 'download-and-extract', 14:02:24 INFO - 'populate-webroot', 14:02:24 INFO - 'create-virtualenv', 14:02:24 INFO - 'install', 14:02:24 INFO - 'run-tests'), 14:02:24 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 14:02:24 INFO - 'download_minidump_stackwalk': True, 14:02:24 INFO - 'download_symbols': 'ondemand', 14:02:24 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 14:02:24 INFO - 'tooltool.py': '/tools/tooltool.py', 14:02:24 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 14:02:24 INFO - '/tools/misc-python/virtualenv.py')}, 14:02:24 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 14:02:24 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 14:02:24 INFO - 'installer_path': 'installer.exe', 14:02:24 INFO - 'log_level': 'info', 14:02:24 INFO - 'log_name': 'talos', 14:02:24 INFO - 'log_to_console': True, 14:02:24 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 14:02:24 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 14:02:24 INFO - 'opt_config_files': (), 14:02:24 INFO - 'pip_index': False, 14:02:24 INFO - 'sps_profile': False, 14:02:24 INFO - 'sps_profile_interval': 0, 14:02:24 INFO - 'suite': 'dromaeojs-e10s', 14:02:24 INFO - 'system_bits': '32', 14:02:24 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 14:02:24 INFO - 'title': 'talos-linux64-ix-026', 14:02:24 INFO - 'tooltool_cache': '/builds/tooltool_cache', 14:02:24 INFO - 'use_talos_json': True, 14:02:24 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 14:02:24 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 14:02:24 INFO - 'work_dir': 'build'} 14:02:24 INFO - [mozharness: 2016-09-02 21:02:24.250081Z] Running clobber step. 14:02:24 INFO - Running pre-action listener: _resource_record_pre_action 14:02:24 INFO - Running main action method: clobber 14:02:24 INFO - rmtree: /builds/slave/test/build 14:02:24 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 14:02:24 INFO - Running post-action listener: _resource_record_post_action 14:02:24 INFO - [mozharness: 2016-09-02 21:02:24.702604Z] Finished clobber step (success) 14:02:24 INFO - [mozharness: 2016-09-02 21:02:24.702707Z] Running read-buildbot-config step. 14:02:24 INFO - Running pre-action listener: _resource_record_pre_action 14:02:24 INFO - Running main action method: read_buildbot_config 14:02:24 INFO - Using buildbot properties: 14:02:24 INFO - { 14:02:24 INFO - "project": "", 14:02:24 INFO - "product": "firefox", 14:02:24 INFO - "script_repo_revision": "production", 14:02:24 INFO - "builddir": "mozilla-aurora_ubuntu64_hw_test-dromaeojs-e10s", 14:02:24 INFO - "repository": "", 14:02:24 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-aurora pgo talos dromaeojs-e10s", 14:02:24 INFO - "buildid": "20160902110447", 14:02:24 INFO - "pgo_build": "True", 14:02:24 INFO - "basedir": "/builds/slave/test", 14:02:24 INFO - "buildnumber": 539, 14:02:24 INFO - "slavename": "talos-linux64-ix-026", 14:02:24 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 14:02:24 INFO - "platform": "ubuntu64_hw", 14:02:24 INFO - "scheduler": "tests-mozilla-aurora-linux64-pgo-talos", 14:02:24 INFO - "branch": "mozilla-aurora", 14:02:24 INFO - "repo_path": "releases/mozilla-aurora", 14:02:24 INFO - "revision": "3cb50e5df49728e19c6f5bcb4c5b3fe34a9db53c", 14:02:24 INFO - "stage_platform": "linux64-pgo", 14:02:24 INFO - "builduid": "0684f3cd04564a4da15011e6a010e5df", 14:02:24 INFO - "slavebuilddir": "test" 14:02:24 INFO - } 14:02:24 INFO - Found installer url https://queue.taskcluster.net/v1/task/IU2O5TwdSXGE77QTrRrFYw/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.tar.bz2. 14:02:24 INFO - Running post-action listener: _resource_record_post_action 14:02:24 INFO - [mozharness: 2016-09-02 21:02:24.705170Z] Finished read-buildbot-config step (success) 14:02:24 INFO - [mozharness: 2016-09-02 21:02:24.705260Z] Running download-and-extract step. 14:02:24 INFO - Running pre-action listener: _resource_record_pre_action 14:02:24 INFO - Running main action method: download_and_extract 14:02:24 INFO - mkdir: /builds/slave/test/build/tests 14:02:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:02:24 INFO - https://queue.taskcluster.net/v1/task/IU2O5TwdSXGE77QTrRrFYw/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 14:02:24 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/IU2O5TwdSXGE77QTrRrFYw/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.test_packages.json 14:02:24 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/IU2O5TwdSXGE77QTrRrFYw/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.test_packages.json 14:02:24 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/IU2O5TwdSXGE77QTrRrFYw/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-50.0a2.en-US.linux-x86_64.test_packages.json 14:02:24 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/IU2O5TwdSXGE77QTrRrFYw/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-50.0a2.en-US.linux-x86_64.test_packages.json'}, attempt #1 14:02:24 WARNING - Server returned status 404 HTTP Error 404: Not Found for http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/IU2O5TwdSXGE77QTrRrFYw/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.test_packages.json 14:02:24 INFO - retry: attempt #1 caught exception: HTTP Error 404: Not Found 14:02:24 INFO - retry: Failed, sleeping 30 seconds before retrying 14:02:54 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/IU2O5TwdSXGE77QTrRrFYw/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-50.0a2.en-US.linux-x86_64.test_packages.json'}, attempt #2 14:02:54 WARNING - Server returned status 404 HTTP Error 404: Not Found for http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/IU2O5TwdSXGE77QTrRrFYw/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.test_packages.json 14:02:54 INFO - retry: attempt #2 caught exception: HTTP Error 404: Not Found 14:02:54 INFO - retry: Failed, sleeping 60 seconds before retrying 14:03:54 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/IU2O5TwdSXGE77QTrRrFYw/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-50.0a2.en-US.linux-x86_64.test_packages.json'}, attempt #3 14:03:54 WARNING - Server returned status 404 HTTP Error 404: Not Found for http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/IU2O5TwdSXGE77QTrRrFYw/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.test_packages.json 14:03:54 INFO - retry: attempt #3 caught exception: HTTP Error 404: Not Found 14:03:54 INFO - Can't download from http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/IU2O5TwdSXGE77QTrRrFYw/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-50.0a2.en-US.linux-x86_64.test_packages.json! 14:03:54 INFO - Caught exception: HTTP Error 404: Not Found 14:03:54 INFO - Caught exception: HTTP Error 404: Not Found 14:03:54 INFO - Caught exception: HTTP Error 404: Not Found 14:03:54 INFO - trying https://queue.taskcluster.net/v1/task/IU2O5TwdSXGE77QTrRrFYw/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.test_packages.json 14:03:54 INFO - Downloading https://queue.taskcluster.net/v1/task/IU2O5TwdSXGE77QTrRrFYw/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-50.0a2.en-US.linux-x86_64.test_packages.json 14:03:54 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/IU2O5TwdSXGE77QTrRrFYw/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-50.0a2.en-US.linux-x86_64.test_packages.json'}, attempt #1 14:03:55 INFO - Downloaded 1361 bytes. 14:03:55 INFO - Reading from file /builds/slave/test/build/firefox-50.0a2.en-US.linux-x86_64.test_packages.json 14:03:55 INFO - Using the following test package requirements: 14:03:55 INFO - {u'common': [u'firefox-50.0a2.en-US.linux-x86_64.common.tests.zip'], 14:03:55 INFO - u'cppunittest': [u'firefox-50.0a2.en-US.linux-x86_64.common.tests.zip', 14:03:55 INFO - u'firefox-50.0a2.en-US.linux-x86_64.cppunittest.tests.zip'], 14:03:55 INFO - u'gtest': [u'firefox-50.0a2.en-US.linux-x86_64.common.tests.zip', 14:03:55 INFO - u'firefox-50.0a2.en-US.linux-x86_64.gtest.tests.zip'], 14:03:55 INFO - u'jittest': [u'firefox-50.0a2.en-US.linux-x86_64.common.tests.zip', 14:03:55 INFO - u'jsshell-linux-x86_64.zip'], 14:03:55 INFO - u'mochitest': [u'firefox-50.0a2.en-US.linux-x86_64.common.tests.zip', 14:03:55 INFO - u'firefox-50.0a2.en-US.linux-x86_64.mochitest.tests.zip'], 14:03:55 INFO - u'mozbase': [u'firefox-50.0a2.en-US.linux-x86_64.common.tests.zip'], 14:03:55 INFO - u'reftest': [u'firefox-50.0a2.en-US.linux-x86_64.common.tests.zip', 14:03:55 INFO - u'firefox-50.0a2.en-US.linux-x86_64.reftest.tests.zip'], 14:03:55 INFO - u'talos': [u'firefox-50.0a2.en-US.linux-x86_64.common.tests.zip', 14:03:55 INFO - u'firefox-50.0a2.en-US.linux-x86_64.talos.tests.zip'], 14:03:55 INFO - u'web-platform': [u'firefox-50.0a2.en-US.linux-x86_64.common.tests.zip', 14:03:55 INFO - u'firefox-50.0a2.en-US.linux-x86_64.web-platform.tests.zip'], 14:03:55 INFO - u'xpcshell': [u'firefox-50.0a2.en-US.linux-x86_64.common.tests.zip', 14:03:55 INFO - u'firefox-50.0a2.en-US.linux-x86_64.xpcshell.tests.zip']} 14:03:55 INFO - Downloading packages: [u'firefox-50.0a2.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 14:03:55 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')]} 14:03:55 INFO - https://queue.taskcluster.net/v1/task/IU2O5TwdSXGE77QTrRrFYw/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 14:03:55 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/IU2O5TwdSXGE77QTrRrFYw/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip 14:03:55 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/IU2O5TwdSXGE77QTrRrFYw/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip 14:03:55 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/IU2O5TwdSXGE77QTrRrFYw/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip 14:03:55 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/IU2O5TwdSXGE77QTrRrFYw/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip'}, attempt #1 14:03:55 WARNING - Server returned status 404 HTTP Error 404: Not Found for http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/IU2O5TwdSXGE77QTrRrFYw/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip 14:03:55 INFO - retry: attempt #1 caught exception: HTTP Error 404: Not Found 14:03:55 INFO - retry: Failed, sleeping 30 seconds before retrying 14:04:25 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/IU2O5TwdSXGE77QTrRrFYw/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip'}, attempt #2 14:04:25 WARNING - Server returned status 404 HTTP Error 404: Not Found for http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/IU2O5TwdSXGE77QTrRrFYw/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip 14:04:25 INFO - retry: attempt #2 caught exception: HTTP Error 404: Not Found 14:04:25 INFO - retry: Failed, sleeping 60 seconds before retrying 14:05:25 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/IU2O5TwdSXGE77QTrRrFYw/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip'}, attempt #3 14:05:25 WARNING - Server returned status 404 HTTP Error 404: Not Found for http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/IU2O5TwdSXGE77QTrRrFYw/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip 14:05:25 INFO - retry: attempt #3 caught exception: HTTP Error 404: Not Found 14:05:25 INFO - Can't download from http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/IU2O5TwdSXGE77QTrRrFYw/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip! 14:05:25 INFO - Caught exception: HTTP Error 404: Not Found 14:05:25 INFO - Caught exception: HTTP Error 404: Not Found 14:05:25 INFO - Caught exception: HTTP Error 404: Not Found 14:05:25 INFO - trying https://queue.taskcluster.net/v1/task/IU2O5TwdSXGE77QTrRrFYw/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip 14:05:25 INFO - Downloading https://queue.taskcluster.net/v1/task/IU2O5TwdSXGE77QTrRrFYw/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip 14:05:25 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/IU2O5TwdSXGE77QTrRrFYw/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip'}, attempt #1 14:05:26 INFO - Downloaded 21769878 bytes. 14:05:26 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 14:05:26 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 14:05:27 INFO - Return code: 0 14:05:27 INFO - Downloading packages: [u'firefox-50.0a2.en-US.linux-x86_64.common.tests.zip', u'firefox-50.0a2.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 14:05:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:05:27 INFO - https://queue.taskcluster.net/v1/task/IU2O5TwdSXGE77QTrRrFYw/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 14:05:27 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/IU2O5TwdSXGE77QTrRrFYw/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip 14:05:27 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/IU2O5TwdSXGE77QTrRrFYw/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip 14:05:27 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/IU2O5TwdSXGE77QTrRrFYw/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip 14:05:27 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/IU2O5TwdSXGE77QTrRrFYw/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip'}, attempt #1 14:05:27 WARNING - Server returned status 404 HTTP Error 404: Not Found for http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/IU2O5TwdSXGE77QTrRrFYw/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip 14:05:27 INFO - retry: attempt #1 caught exception: HTTP Error 404: Not Found 14:05:27 INFO - retry: Failed, sleeping 30 seconds before retrying 14:05:57 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/IU2O5TwdSXGE77QTrRrFYw/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip'}, attempt #2 14:05:57 WARNING - Server returned status 404 HTTP Error 404: Not Found for http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/IU2O5TwdSXGE77QTrRrFYw/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip 14:05:57 INFO - retry: attempt #2 caught exception: HTTP Error 404: Not Found 14:05:57 INFO - retry: Failed, sleeping 60 seconds before retrying 14:06:57 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/IU2O5TwdSXGE77QTrRrFYw/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip'}, attempt #3 14:06:57 WARNING - Server returned status 404 HTTP Error 404: Not Found for http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/IU2O5TwdSXGE77QTrRrFYw/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip 14:06:57 INFO - retry: attempt #3 caught exception: HTTP Error 404: Not Found 14:06:57 INFO - Can't download from http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/IU2O5TwdSXGE77QTrRrFYw/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip! 14:06:57 INFO - Caught exception: HTTP Error 404: Not Found 14:06:57 INFO - Caught exception: HTTP Error 404: Not Found 14:06:57 INFO - Caught exception: HTTP Error 404: Not Found 14:06:57 INFO - trying https://queue.taskcluster.net/v1/task/IU2O5TwdSXGE77QTrRrFYw/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip 14:06:57 INFO - Downloading https://queue.taskcluster.net/v1/task/IU2O5TwdSXGE77QTrRrFYw/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip 14:06:57 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/IU2O5TwdSXGE77QTrRrFYw/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip'}, attempt #1 14:06:58 INFO - Downloaded 21769878 bytes. 14:06:58 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 14:06:58 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-50.0a2.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 14:06:59 INFO - Return code: 0 14:06:59 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')]} 14:06:59 INFO - https://queue.taskcluster.net/v1/task/IU2O5TwdSXGE77QTrRrFYw/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 14:06:59 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/IU2O5TwdSXGE77QTrRrFYw/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.talos.tests.zip 14:06:59 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/IU2O5TwdSXGE77QTrRrFYw/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.talos.tests.zip 14:06:59 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/IU2O5TwdSXGE77QTrRrFYw/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test/build/firefox-50.0a2.en-US.linux-x86_64.talos.tests.zip 14:06:59 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/IU2O5TwdSXGE77QTrRrFYw/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-50.0a2.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 14:06:59 WARNING - Server returned status 404 HTTP Error 404: Not Found for http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/IU2O5TwdSXGE77QTrRrFYw/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.talos.tests.zip 14:06:59 INFO - retry: attempt #1 caught exception: HTTP Error 404: Not Found 14:06:59 INFO - retry: Failed, sleeping 30 seconds before retrying 14:07:29 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/IU2O5TwdSXGE77QTrRrFYw/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-50.0a2.en-US.linux-x86_64.talos.tests.zip'}, attempt #2 14:07:29 WARNING - Server returned status 404 HTTP Error 404: Not Found for http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/IU2O5TwdSXGE77QTrRrFYw/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.talos.tests.zip 14:07:29 INFO - retry: attempt #2 caught exception: HTTP Error 404: Not Found 14:07:29 INFO - retry: Failed, sleeping 60 seconds before retrying 14:08:29 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/IU2O5TwdSXGE77QTrRrFYw/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-50.0a2.en-US.linux-x86_64.talos.tests.zip'}, attempt #3 14:08:29 WARNING - Server returned status 404 HTTP Error 404: Not Found for http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/IU2O5TwdSXGE77QTrRrFYw/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.talos.tests.zip 14:08:29 INFO - retry: attempt #3 caught exception: HTTP Error 404: Not Found 14:08:29 INFO - Can't download from http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/IU2O5TwdSXGE77QTrRrFYw/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test/build/firefox-50.0a2.en-US.linux-x86_64.talos.tests.zip! 14:08:29 INFO - Caught exception: HTTP Error 404: Not Found 14:08:29 INFO - Caught exception: HTTP Error 404: Not Found 14:08:29 INFO - Caught exception: HTTP Error 404: Not Found 14:08:29 INFO - trying https://queue.taskcluster.net/v1/task/IU2O5TwdSXGE77QTrRrFYw/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.talos.tests.zip 14:08:29 INFO - Downloading https://queue.taskcluster.net/v1/task/IU2O5TwdSXGE77QTrRrFYw/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test/build/firefox-50.0a2.en-US.linux-x86_64.talos.tests.zip 14:08:29 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/IU2O5TwdSXGE77QTrRrFYw/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-50.0a2.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 14:08:30 INFO - Downloaded 14413740 bytes. 14:08:30 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-50.0a2.en-US.linux-x86_64.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 14:08:30 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-50.0a2.en-US.linux-x86_64.talos.tests.zip -d /builds/slave/test/build/tests 14:08:30 INFO - Return code: 0 14:08:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:08:30 INFO - https://queue.taskcluster.net/v1/task/IU2O5TwdSXGE77QTrRrFYw/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 14:08:30 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/IU2O5TwdSXGE77QTrRrFYw/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.tar.bz2 14:08:30 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/IU2O5TwdSXGE77QTrRrFYw/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.tar.bz2 14:08:30 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/IU2O5TwdSXGE77QTrRrFYw/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-50.0a2.en-US.linux-x86_64.tar.bz2 14:08:30 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/IU2O5TwdSXGE77QTrRrFYw/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-50.0a2.en-US.linux-x86_64.tar.bz2'}, attempt #1 14:08:30 WARNING - Server returned status 404 HTTP Error 404: Not Found for http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/IU2O5TwdSXGE77QTrRrFYw/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.tar.bz2 14:08:30 INFO - retry: attempt #1 caught exception: HTTP Error 404: Not Found 14:08:30 INFO - retry: Failed, sleeping 30 seconds before retrying 14:09:01 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/IU2O5TwdSXGE77QTrRrFYw/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-50.0a2.en-US.linux-x86_64.tar.bz2'}, attempt #2 14:09:01 WARNING - Server returned status 404 HTTP Error 404: Not Found for http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/IU2O5TwdSXGE77QTrRrFYw/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.tar.bz2 14:09:01 INFO - retry: attempt #2 caught exception: HTTP Error 404: Not Found 14:09:01 INFO - retry: Failed, sleeping 60 seconds before retrying 14:10:01 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/IU2O5TwdSXGE77QTrRrFYw/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-50.0a2.en-US.linux-x86_64.tar.bz2'}, attempt #3 14:10:01 WARNING - Server returned status 404 HTTP Error 404: Not Found for http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/IU2O5TwdSXGE77QTrRrFYw/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.tar.bz2 14:10:01 INFO - retry: attempt #3 caught exception: HTTP Error 404: Not Found 14:10:01 INFO - Can't download from http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/IU2O5TwdSXGE77QTrRrFYw/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-50.0a2.en-US.linux-x86_64.tar.bz2! 14:10:01 INFO - Caught exception: HTTP Error 404: Not Found 14:10:01 INFO - Caught exception: HTTP Error 404: Not Found 14:10:01 INFO - Caught exception: HTTP Error 404: Not Found 14:10:01 INFO - trying https://queue.taskcluster.net/v1/task/IU2O5TwdSXGE77QTrRrFYw/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.tar.bz2 14:10:01 INFO - Downloading https://queue.taskcluster.net/v1/task/IU2O5TwdSXGE77QTrRrFYw/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-50.0a2.en-US.linux-x86_64.tar.bz2 14:10:01 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/IU2O5TwdSXGE77QTrRrFYw/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-50.0a2.en-US.linux-x86_64.tar.bz2'}, attempt #1 14:10:02 INFO - Downloaded 63876320 bytes. 14:10:02 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/IU2O5TwdSXGE77QTrRrFYw/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.tar.bz2 14:10:02 INFO - mkdir: /builds/slave/test/properties 14:10:02 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 14:10:02 INFO - Writing to file /builds/slave/test/properties/build_url 14:10:02 INFO - Contents: 14:10:02 INFO - build_url:https://queue.taskcluster.net/v1/task/IU2O5TwdSXGE77QTrRrFYw/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.tar.bz2 14:10:02 INFO - Running post-action listener: _resource_record_post_action 14:10:02 INFO - Running post-action listener: set_extra_try_arguments 14:10:02 INFO - [mozharness: 2016-09-02 21:10:02.967268Z] Finished download-and-extract step (success) 14:10:02 INFO - [mozharness: 2016-09-02 21:10:02.967503Z] Running populate-webroot step. 14:10:02 INFO - Running pre-action listener: _resource_record_pre_action 14:10:02 INFO - Running main action method: populate_webroot 14:10:02 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 14:10:02 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 14:10:02 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 14:10:02 INFO - '--tppagecycles', 14:10:02 INFO - '7'], 14:10:02 INFO - 'tests': ['tsvgm']}}, 14:10:02 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 14:10:02 INFO - 'tests': ['tresize', 'tcanvasmark']}, 14:10:02 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 14:10:02 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 14:10:02 INFO - 'tests': ['dromaeo_css', 'kraken']}, 14:10:02 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 14:10:02 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:10:02 INFO - 'talos_options': ['--disable-e10s'], 14:10:02 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 14:10:02 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:10:02 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 14:10:02 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:10:02 INFO - 'talos_options': ['--disable-e10s'], 14:10:02 INFO - 'tests': ['damp', 'tps']}, 14:10:02 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:10:02 INFO - 'tests': ['damp', 'tps']}, 14:10:02 INFO - 'g3': {'talos_options': ['--disable-e10s'], 14:10:02 INFO - 'tests': ['dromaeo_dom']}, 14:10:02 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 14:10:02 INFO - 'g4': {'talos_options': ['--disable-e10s'], 14:10:02 INFO - 'tests': ['basic_compositor_video']}, 14:10:02 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 14:10:02 INFO - 'other': {'talos_options': ['--disable-e10s'], 14:10:02 INFO - 'tests': ['a11yr', 14:10:02 INFO - 'ts_paint', 14:10:02 INFO - 'tpaint', 14:10:02 INFO - 'sessionrestore', 14:10:02 INFO - 'sessionrestore_no_auto_restore', 14:10:02 INFO - 'tabpaint']}, 14:10:02 INFO - 'other-e10s': {'tests': ['a11yr', 14:10:02 INFO - 'ts_paint', 14:10:02 INFO - 'tpaint', 14:10:02 INFO - 'sessionrestore', 14:10:02 INFO - 'sessionrestore_no_auto_restore', 14:10:02 INFO - 'tabpaint']}, 14:10:02 INFO - 'other-e10s_l64': {'tests': ['a11yr', 14:10:02 INFO - 'ts_paint', 14:10:02 INFO - 'tpaint', 14:10:02 INFO - 'sessionrestore', 14:10:02 INFO - 'sessionrestore_no_auto_restore', 14:10:02 INFO - 'tabpaint']}, 14:10:02 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 14:10:02 INFO - 'ts_paint', 14:10:02 INFO - 'tpaint', 14:10:02 INFO - 'sessionrestore', 14:10:02 INFO - 'sessionrestore_no_auto_restore', 14:10:02 INFO - 'tabpaint']}, 14:10:02 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 14:10:02 INFO - 'tests': ['a11yr', 14:10:02 INFO - 'ts_paint', 14:10:02 INFO - 'tpaint', 14:10:02 INFO - 'sessionrestore', 14:10:02 INFO - 'sessionrestore_no_auto_restore', 14:10:02 INFO - 'tabpaint']}, 14:10:02 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 14:10:02 INFO - 'tests': ['a11yr', 14:10:02 INFO - 'ts_paint', 14:10:02 INFO - 'tpaint', 14:10:02 INFO - 'sessionrestore', 14:10:02 INFO - 'sessionrestore_no_auto_restore', 14:10:02 INFO - 'tabpaint']}, 14:10:02 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 14:10:02 INFO - 'tests': ['tsvgx', 14:10:02 INFO - 'tsvgr_opacity', 14:10:02 INFO - 'tart', 14:10:02 INFO - 'tscrollx', 14:10:02 INFO - 'cart']}, 14:10:02 INFO - 'svgr-e10s': {'tests': ['tsvgx', 14:10:02 INFO - 'tsvgr_opacity', 14:10:02 INFO - 'tart', 14:10:02 INFO - 'tscrollx', 14:10:02 INFO - 'cart']}, 14:10:02 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:10:02 INFO - 'talos_options': ['--disable-e10s'], 14:10:02 INFO - 'tests': ['tp5o']}, 14:10:02 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:10:02 INFO - 'tests': ['tp5o']}, 14:10:02 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:10:02 INFO - 'talos_options': ['--disable-e10s', 14:10:02 INFO - '--xperf_path', 14:10:02 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 14:10:02 INFO - 'tests': ['tp5n']}, 14:10:02 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:10:02 INFO - 'talos_options': ['--xperf_path', 14:10:02 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 14:10:02 INFO - 'tests': ['tp5n']}}, 14:10:02 INFO - 'talos.zip': {'path': '', 14:10:02 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 14:10:02 INFO - Running post-action listener: _resource_record_post_action 14:10:02 INFO - [mozharness: 2016-09-02 21:10:02.984578Z] Finished populate-webroot step (success) 14:10:02 INFO - [mozharness: 2016-09-02 21:10:02.984669Z] Running create-virtualenv step. 14:10:02 INFO - Running pre-action listener: _resource_record_pre_action 14:10:02 INFO - Running main action method: create_virtualenv 14:10:02 INFO - Creating virtualenv /builds/slave/test/build/venv 14:10:02 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 14:10:02 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 14:10:03 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 14:10:03 INFO - Using real prefix '/usr' 14:10:03 INFO - New python executable in /builds/slave/test/build/venv/bin/python 14:10:03 INFO - Installing distribute.............................................................................................................................................................................................done. 14:10:05 INFO - Installing pip.................done. 14:10:05 INFO - Return code: 0 14:10:05 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 14:10:05 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')]} 14:10:05 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:10:05 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:10:05 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')]} 14:10:05 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:10:05 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:10:05 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 0xe9c030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xfff8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10cb400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x115a570>, '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 0x115b470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x115b900>, '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': '41bf3e9aed84707956354da8000001c5-1472850127.773110-1745143973', '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 14:10:05 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 14:10:05 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 14:10:05 INFO - Using env: {'DISPLAY': ':0', 14:10:05 INFO - 'HOME': '/home/cltbld', 14:10:05 INFO - 'LANG': 'en_US.UTF-8', 14:10:05 INFO - 'LANGUAGE': 'en_US:en', 14:10:05 INFO - 'LOGNAME': 'cltbld', 14:10:05 INFO - 'MAIL': '/var/mail/cltbld', 14:10:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:10:05 INFO - 'MOZ_NO_REMOTE': '1', 14:10:05 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:10:05 INFO - 'NO_EM_RESTART': '1', 14:10:05 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:10:05 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:10:05 INFO - 'PWD': '/builds/slave/test', 14:10:05 INFO - 'SHELL': '/bin/bash', 14:10:05 INFO - 'SHLVL': '1', 14:10:05 INFO - 'TERM': 'linux', 14:10:05 INFO - 'TMOUT': '86400', 14:10:05 INFO - 'USER': 'cltbld', 14:10:05 INFO - 'XDG_SESSION_COOKIE': '41bf3e9aed84707956354da8000001c5-1472850127.773110-1745143973', 14:10:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:10:05 INFO - '_': '/tools/buildbot/bin/python'} 14:10:05 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:10:05 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 14:10:05 INFO - Cleaning up... 14:10:05 INFO - Return code: 0 14:10:05 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 14:10:05 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')]} 14:10:05 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:10:05 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:10:05 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')]} 14:10:05 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:10:05 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:10:05 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>=3.1.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xe9c030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xfff8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10cb400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x115a570>, '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 0x115b470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x115b900>, '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': '41bf3e9aed84707956354da8000001c5-1472850127.773110-1745143973', '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 14:10:05 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>=3.1.1'] in /builds/slave/test/build 14:10:05 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>=3.1.1 14:10:05 INFO - Using env: {'DISPLAY': ':0', 14:10:05 INFO - 'HOME': '/home/cltbld', 14:10:05 INFO - 'LANG': 'en_US.UTF-8', 14:10:05 INFO - 'LANGUAGE': 'en_US:en', 14:10:05 INFO - 'LOGNAME': 'cltbld', 14:10:05 INFO - 'MAIL': '/var/mail/cltbld', 14:10:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:10:05 INFO - 'MOZ_NO_REMOTE': '1', 14:10:05 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:10:05 INFO - 'NO_EM_RESTART': '1', 14:10:05 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:10:05 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:10:05 INFO - 'PWD': '/builds/slave/test', 14:10:05 INFO - 'SHELL': '/bin/bash', 14:10:05 INFO - 'SHLVL': '1', 14:10:05 INFO - 'TERM': 'linux', 14:10:05 INFO - 'TMOUT': '86400', 14:10:05 INFO - 'USER': 'cltbld', 14:10:05 INFO - 'XDG_SESSION_COOKIE': '41bf3e9aed84707956354da8000001c5-1472850127.773110-1745143973', 14:10:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:10:05 INFO - '_': '/tools/buildbot/bin/python'} 14:10:05 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:10:05 INFO - Downloading/unpacking psutil>=3.1.1 14:10:05 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 14:10:05 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 14:10:05 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 14:10:05 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 14:10:05 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 14:10:05 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 14:10:07 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 14:10:07 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 14:10:07 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 14:10:07 INFO - Installing collected packages: psutil 14:10:07 INFO - Running setup.py install for psutil 14:10:08 INFO - building 'psutil._psutil_linux' extension 14:10:08 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 14:10:08 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 14:10:08 INFO - building 'psutil._psutil_posix' extension 14:10:08 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 14:10:08 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 14:10:08 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 14:10:08 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 14:10:08 INFO - Successfully installed psutil 14:10:08 INFO - Cleaning up... 14:10:08 INFO - Return code: 0 14:10:08 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 14:10:08 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')]} 14:10:08 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:10:08 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:10:08 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')]} 14:10:08 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:10:08 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:10:08 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.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xe9c030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xfff8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10cb400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x115a570>, '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 0x115b470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x115b900>, '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': '41bf3e9aed84707956354da8000001c5-1472850127.773110-1745143973', '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 14:10:08 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.3'] in /builds/slave/test/build 14:10:08 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.3 14:10:08 INFO - Using env: {'DISPLAY': ':0', 14:10:08 INFO - 'HOME': '/home/cltbld', 14:10:08 INFO - 'LANG': 'en_US.UTF-8', 14:10:08 INFO - 'LANGUAGE': 'en_US:en', 14:10:08 INFO - 'LOGNAME': 'cltbld', 14:10:08 INFO - 'MAIL': '/var/mail/cltbld', 14:10:08 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:10:08 INFO - 'MOZ_NO_REMOTE': '1', 14:10:08 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:10:08 INFO - 'NO_EM_RESTART': '1', 14:10:08 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:10:08 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:10:08 INFO - 'PWD': '/builds/slave/test', 14:10:08 INFO - 'SHELL': '/bin/bash', 14:10:08 INFO - 'SHLVL': '1', 14:10:08 INFO - 'TERM': 'linux', 14:10:08 INFO - 'TMOUT': '86400', 14:10:08 INFO - 'USER': 'cltbld', 14:10:08 INFO - 'XDG_SESSION_COOKIE': '41bf3e9aed84707956354da8000001c5-1472850127.773110-1745143973', 14:10:08 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:10:08 INFO - '_': '/tools/buildbot/bin/python'} 14:10:08 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:10:08 INFO - Downloading/unpacking mozsystemmonitor==0.3 14:10:08 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 14:10:08 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 14:10:08 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 14:10:08 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 14:10:08 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 14:10:08 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 14:10:10 INFO - Downloading mozsystemmonitor-0.3.tar.gz 14:10:10 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 14:10:10 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 14:10:10 INFO - Installing collected packages: mozsystemmonitor 14:10:10 INFO - Running setup.py install for mozsystemmonitor 14:10:10 INFO - Successfully installed mozsystemmonitor 14:10:10 INFO - Cleaning up... 14:10:10 INFO - Return code: 0 14:10:10 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 14:10: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')]} 14:10:10 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:10:10 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:10: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')]} 14:10:10 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:10:10 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:10:10 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==2.5.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xe9c030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xfff8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10cb400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x115a570>, '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 0x115b470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x115b900>, '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': '41bf3e9aed84707956354da8000001c5-1472850127.773110-1745143973', '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 14:10:10 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==2.5.1'] in /builds/slave/test/build 14:10:10 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==2.5.1 14:10:10 INFO - Using env: {'DISPLAY': ':0', 14:10:10 INFO - 'HOME': '/home/cltbld', 14:10:10 INFO - 'LANG': 'en_US.UTF-8', 14:10:10 INFO - 'LANGUAGE': 'en_US:en', 14:10:10 INFO - 'LOGNAME': 'cltbld', 14:10:10 INFO - 'MAIL': '/var/mail/cltbld', 14:10:10 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:10:10 INFO - 'MOZ_NO_REMOTE': '1', 14:10:10 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:10:10 INFO - 'NO_EM_RESTART': '1', 14:10:10 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:10:10 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:10:10 INFO - 'PWD': '/builds/slave/test', 14:10:10 INFO - 'SHELL': '/bin/bash', 14:10:10 INFO - 'SHLVL': '1', 14:10:10 INFO - 'TERM': 'linux', 14:10:10 INFO - 'TMOUT': '86400', 14:10:10 INFO - 'USER': 'cltbld', 14:10:10 INFO - 'XDG_SESSION_COOKIE': '41bf3e9aed84707956354da8000001c5-1472850127.773110-1745143973', 14:10:10 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:10:10 INFO - '_': '/tools/buildbot/bin/python'} 14:10:11 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:10:11 INFO - Downloading/unpacking jsonschema==2.5.1 14:10:11 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 14:10:11 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 14:10:11 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 14:10:11 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 14:10:11 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 14:10:11 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 14:10:12 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 14:10:12 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 14:10:12 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 14:10:12 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 14:10:12 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 14:10:12 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 14:10:12 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 14:10:12 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 14:10:13 INFO - Downloading functools32-3.2.3-2.tar.gz 14:10:13 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 14:10:13 INFO - warning: no files found matching '*.txt' 14:10:13 INFO - no previously-included directories found matching 'build' 14:10:13 INFO - no previously-included directories found matching 'dist' 14:10:13 INFO - no previously-included directories found matching '.git*' 14:10:13 INFO - Installing collected packages: jsonschema, functools32 14:10:13 INFO - Running setup.py install for functools32 14:10:13 INFO - warning: no files found matching '*.txt' 14:10:13 INFO - no previously-included directories found matching 'build' 14:10:13 INFO - no previously-included directories found matching 'dist' 14:10:13 INFO - no previously-included directories found matching '.git*' 14:10:13 INFO - Successfully installed jsonschema functools32 14:10:13 INFO - Cleaning up... 14:10:13 INFO - Return code: 0 14:10:13 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 14:10:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:10:13 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:10:13 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:10:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:10:13 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:10:13 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:10:13 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', 'functools32==3.2.3-2']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xe9c030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xfff8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10cb400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x115a570>, '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 0x115b470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x115b900>, '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': '41bf3e9aed84707956354da8000001c5-1472850127.773110-1745143973', '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 14:10:13 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', 'functools32==3.2.3-2'] in /builds/slave/test/build 14:10:13 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 functools32==3.2.3-2 14:10:13 INFO - Using env: {'DISPLAY': ':0', 14:10:13 INFO - 'HOME': '/home/cltbld', 14:10:13 INFO - 'LANG': 'en_US.UTF-8', 14:10:13 INFO - 'LANGUAGE': 'en_US:en', 14:10:13 INFO - 'LOGNAME': 'cltbld', 14:10:13 INFO - 'MAIL': '/var/mail/cltbld', 14:10:13 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:10:13 INFO - 'MOZ_NO_REMOTE': '1', 14:10:13 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:10:13 INFO - 'NO_EM_RESTART': '1', 14:10:13 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:10:13 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:10:13 INFO - 'PWD': '/builds/slave/test', 14:10:13 INFO - 'SHELL': '/bin/bash', 14:10:13 INFO - 'SHLVL': '1', 14:10:13 INFO - 'TERM': 'linux', 14:10:13 INFO - 'TMOUT': '86400', 14:10:13 INFO - 'USER': 'cltbld', 14:10:13 INFO - 'XDG_SESSION_COOKIE': '41bf3e9aed84707956354da8000001c5-1472850127.773110-1745143973', 14:10:13 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:10:13 INFO - '_': '/tools/buildbot/bin/python'} 14:10:13 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:10:13 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 14:10:13 INFO - Cleaning up... 14:10:13 INFO - Return code: 0 14:10:13 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 14:10:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:10:13 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:10:13 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:10:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:10:13 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:10:13 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:10:13 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 0xe9c030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xfff8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10cb400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x115a570>, '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 0x115b470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x115b900>, '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': '41bf3e9aed84707956354da8000001c5-1472850127.773110-1745143973', '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 14:10:13 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 14:10:13 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 14:10:13 INFO - Using env: {'DISPLAY': ':0', 14:10:13 INFO - 'HOME': '/home/cltbld', 14:10:13 INFO - 'LANG': 'en_US.UTF-8', 14:10:13 INFO - 'LANGUAGE': 'en_US:en', 14:10:13 INFO - 'LOGNAME': 'cltbld', 14:10:13 INFO - 'MAIL': '/var/mail/cltbld', 14:10:13 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:10:13 INFO - 'MOZ_NO_REMOTE': '1', 14:10:13 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:10:13 INFO - 'NO_EM_RESTART': '1', 14:10:13 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:10:13 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:10:13 INFO - 'PWD': '/builds/slave/test', 14:10:13 INFO - 'SHELL': '/bin/bash', 14:10:13 INFO - 'SHLVL': '1', 14:10:13 INFO - 'TERM': 'linux', 14:10:13 INFO - 'TMOUT': '86400', 14:10:13 INFO - 'USER': 'cltbld', 14:10:13 INFO - 'XDG_SESSION_COOKIE': '41bf3e9aed84707956354da8000001c5-1472850127.773110-1745143973', 14:10:13 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:10:13 INFO - '_': '/tools/buildbot/bin/python'} 14:10:13 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:10:13 INFO - Downloading/unpacking blobuploader==1.2.4 14:10:13 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 14:10:13 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 14:10:13 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 14:10:13 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 14:10:13 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 14:10:13 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 14:10:15 INFO - Downloading blobuploader-1.2.4.tar.gz 14:10:15 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 14:10:15 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 14:10:15 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 14:10:15 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 14:10:15 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 14:10:15 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 14:10:15 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 14:10:15 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 14:10:16 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 14:10:16 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 14:10:16 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 14:10:16 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 14:10:16 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 14:10:16 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 14:10:16 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 14:10:16 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 14:10:16 INFO - Downloading docopt-0.6.1.tar.gz 14:10:16 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 14:10:16 INFO - Installing collected packages: blobuploader, requests, docopt 14:10:16 INFO - Running setup.py install for blobuploader 14:10:16 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 14:10:16 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 14:10:16 INFO - Running setup.py install for requests 14:10:16 INFO - Running setup.py install for docopt 14:10:17 INFO - Successfully installed blobuploader requests docopt 14:10:17 INFO - Cleaning up... 14:10:17 INFO - Return code: 0 14:10:17 INFO - Installing None into virtualenv /builds/slave/test/build/venv 14:10:17 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')]} 14:10:17 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:10:17 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:10:17 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')]} 14:10:17 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:10:17 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:10:17 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 0xe9c030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xfff8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10cb400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x115a570>, '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 0x115b470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x115b900>, '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': '41bf3e9aed84707956354da8000001c5-1472850127.773110-1745143973', '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 14:10:17 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 14:10:17 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 14:10:17 INFO - Using env: {'DISPLAY': ':0', 14:10:17 INFO - 'HOME': '/home/cltbld', 14:10:17 INFO - 'LANG': 'en_US.UTF-8', 14:10:17 INFO - 'LANGUAGE': 'en_US:en', 14:10:17 INFO - 'LOGNAME': 'cltbld', 14:10:17 INFO - 'MAIL': '/var/mail/cltbld', 14:10:17 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:10:17 INFO - 'MOZ_NO_REMOTE': '1', 14:10:17 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:10:17 INFO - 'NO_EM_RESTART': '1', 14:10:17 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:10:17 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:10:17 INFO - 'PWD': '/builds/slave/test', 14:10:17 INFO - 'SHELL': '/bin/bash', 14:10:17 INFO - 'SHLVL': '1', 14:10:17 INFO - 'TERM': 'linux', 14:10:17 INFO - 'TMOUT': '86400', 14:10:17 INFO - 'USER': 'cltbld', 14:10:17 INFO - 'XDG_SESSION_COOKIE': '41bf3e9aed84707956354da8000001c5-1472850127.773110-1745143973', 14:10:17 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:10:17 INFO - '_': '/tools/buildbot/bin/python'} 14:10:17 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:10:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 14:10:17 INFO - Running setup.py (path:/tmp/pip-00Cpuj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 14:10:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 14:10:17 INFO - Running setup.py (path:/tmp/pip-upxr6C-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 14:10:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 14:10:17 INFO - Running setup.py (path:/tmp/pip-J5tVsR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 14:10:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 14:10:17 INFO - Running setup.py (path:/tmp/pip-6gihP8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 14:10:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 14:10:17 INFO - Running setup.py (path:/tmp/pip-om6d4z-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 14:10:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 14:10:17 INFO - Running setup.py (path:/tmp/pip-FDqItM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 14:10:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 14:10:17 INFO - Running setup.py (path:/tmp/pip-5V6mHZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 14:10:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 14:10:17 INFO - Running setup.py (path:/tmp/pip-Px0yNt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 14:10:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 14:10:17 INFO - Running setup.py (path:/tmp/pip-MqNqlO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 14:10:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 14:10:17 INFO - Running setup.py (path:/tmp/pip-fWy1uo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 14:10:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 14:10:18 INFO - Running setup.py (path:/tmp/pip-gRIS0y-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 14:10:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 14:10:18 INFO - Running setup.py (path:/tmp/pip-isSPY5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 14:10:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 14:10:18 INFO - Running setup.py (path:/tmp/pip-S0RkDo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 14:10:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 14:10:18 INFO - Running setup.py (path:/tmp/pip-vp9K06-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 14:10:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 14:10:18 INFO - Running setup.py (path:/tmp/pip-Wt7oxb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 14:10:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 14:10:18 INFO - Running setup.py (path:/tmp/pip-GYPiaE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 14:10:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 14:10:18 INFO - Running setup.py (path:/tmp/pip-t5H_tu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 14:10:18 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 14:10:18 INFO - Running setup.py install for manifestparser 14:10:18 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 14:10:18 INFO - Running setup.py install for mozcrash 14:10:18 INFO - Running setup.py install for mozdebug 14:10:18 INFO - Running setup.py install for mozdevice 14:10:18 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 14:10:18 INFO - Installing dm script to /builds/slave/test/build/venv/bin 14:10:18 INFO - Running setup.py install for mozfile 14:10:19 INFO - Running setup.py install for mozhttpd 14:10:19 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 14:10:19 INFO - Running setup.py install for mozinfo 14:10:19 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 14:10:19 INFO - Running setup.py install for mozInstall 14:10:19 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 14:10:19 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 14:10:19 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 14:10:19 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 14:10:19 INFO - Running setup.py install for mozleak 14:10:19 INFO - Running setup.py install for mozlog 14:10:19 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 14:10:19 INFO - Running setup.py install for moznetwork 14:10:19 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 14:10:19 INFO - Running setup.py install for mozprocess 14:10:19 INFO - Running setup.py install for mozprofile 14:10:19 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 14:10:19 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 14:10:19 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 14:10:19 INFO - Running setup.py install for mozrunner 14:10:19 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 14:10:20 INFO - Running setup.py install for mozscreenshot 14:10:20 INFO - Running setup.py install for moztest 14:10:20 INFO - Running setup.py install for mozversion 14:10:20 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 14:10:20 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 14:10:20 INFO - Cleaning up... 14:10:20 INFO - Return code: 0 14:10:20 INFO - Installing None into virtualenv /builds/slave/test/build/venv 14:10:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:10:20 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:10:20 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:10:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:10:20 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:10:20 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:10:20 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 0xe9c030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xfff8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10cb400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x115a570>, '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 0x115b470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x115b900>, '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': '41bf3e9aed84707956354da8000001c5-1472850127.773110-1745143973', '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 14:10:20 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 14:10:20 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 14:10:20 INFO - Using env: {'DISPLAY': ':0', 14:10:20 INFO - 'HOME': '/home/cltbld', 14:10:20 INFO - 'LANG': 'en_US.UTF-8', 14:10:20 INFO - 'LANGUAGE': 'en_US:en', 14:10:20 INFO - 'LOGNAME': 'cltbld', 14:10:20 INFO - 'MAIL': '/var/mail/cltbld', 14:10:20 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:10:20 INFO - 'MOZ_NO_REMOTE': '1', 14:10:20 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:10:20 INFO - 'NO_EM_RESTART': '1', 14:10:20 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:10:20 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:10:20 INFO - 'PWD': '/builds/slave/test', 14:10:20 INFO - 'SHELL': '/bin/bash', 14:10:20 INFO - 'SHLVL': '1', 14:10:20 INFO - 'TERM': 'linux', 14:10:20 INFO - 'TMOUT': '86400', 14:10:20 INFO - 'USER': 'cltbld', 14:10:20 INFO - 'XDG_SESSION_COOKIE': '41bf3e9aed84707956354da8000001c5-1472850127.773110-1745143973', 14:10:20 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:10:20 INFO - '_': '/tools/buildbot/bin/python'} 14:10:20 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:10:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 14:10:20 INFO - Running setup.py (path:/tmp/pip-Mejuxp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 14:10:20 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)) 14:10:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 14:10:20 INFO - Running setup.py (path:/tmp/pip-X7pEls-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 14:10:20 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)) 14:10:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 14:10:20 INFO - Running setup.py (path:/tmp/pip-Ek5Hyo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 14:10:20 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)) 14:10:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 14:10:20 INFO - Running setup.py (path:/tmp/pip-JTUg2I-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 14:10:20 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)) 14:10:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 14:10:20 INFO - Running setup.py (path:/tmp/pip-R_ioj5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 14:10:20 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)) 14:10:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 14:10:20 INFO - Running setup.py (path:/tmp/pip-9gcsZq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 14:10:20 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)) 14:10:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 14:10:20 INFO - Running setup.py (path:/tmp/pip-XlUDQA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 14:10:21 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)) 14:10:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 14:10:21 INFO - Running setup.py (path:/tmp/pip-2kxbiv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 14:10:21 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)) 14:10:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 14:10:21 INFO - Running setup.py (path:/tmp/pip-J1dS_E-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 14:10:21 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)) 14:10:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 14:10:21 INFO - Running setup.py (path:/tmp/pip-ONxp14-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 14:10:21 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.3 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)) 14:10:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 14:10:21 INFO - Running setup.py (path:/tmp/pip-nCaXma-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 14:10:21 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)) 14:10:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 14:10:21 INFO - Running setup.py (path:/tmp/pip-m8HHMA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 14:10:21 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.23 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)) 14:10:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 14:10:21 INFO - Running setup.py (path:/tmp/pip-OxDQfs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 14:10:21 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)) 14:10:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 14:10:21 INFO - Running setup.py (path:/tmp/pip-WztAkT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 14:10:21 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.12 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)) 14:10:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 14:10:21 INFO - Running setup.py (path:/tmp/pip-vEzPRW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 14:10:21 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)) 14:10:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 14:10:21 INFO - Running setup.py (path:/tmp/pip-uDUc9K-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 14:10:21 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)) 14:10:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 14:10:21 INFO - Running setup.py (path:/tmp/pip-6U_QXm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 14:10:21 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)) 14:10:21 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)) 14:10:21 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)) 14:10:21 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)) 14:10:21 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)) 14:10:21 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)) 14:10:21 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.3->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 14:10:21 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 14:10:21 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 14:10:21 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 14:10:21 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 14:10:21 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 14:10:21 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 14:10:23 INFO - Downloading blessings-1.6.tar.gz 14:10:23 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 14:10:23 INFO - Installing collected packages: blessings 14:10:23 INFO - Running setup.py install for blessings 14:10:23 INFO - Successfully installed blessings 14:10:23 INFO - Cleaning up... 14:10:23 INFO - Return code: 0 14:10:23 INFO - Done creating virtualenv /builds/slave/test/build/venv. 14:10:23 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 14:10:23 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 14:10:24 INFO - Reading from file tmpfile_stdout 14:10:24 INFO - Current package versions: 14:10:24 INFO - argparse == 1.2.1 14:10:24 INFO - blessings == 1.6 14:10:24 INFO - blobuploader == 1.2.4 14:10:24 INFO - docopt == 0.6.1 14:10:24 INFO - functools32 == 3.2.3-2 14:10:24 INFO - jsonschema == 2.5.1 14:10:24 INFO - manifestparser == 1.1 14:10:24 INFO - mozInstall == 1.12 14:10:24 INFO - mozcrash == 0.17 14:10:24 INFO - mozdebug == 0.1 14:10:24 INFO - mozdevice == 0.48 14:10:24 INFO - mozfile == 1.2 14:10:24 INFO - mozhttpd == 0.7 14:10:24 INFO - mozinfo == 0.9 14:10:24 INFO - mozleak == 0.1 14:10:24 INFO - mozlog == 3.3 14:10:24 INFO - moznetwork == 0.27 14:10:24 INFO - mozprocess == 0.23 14:10:24 INFO - mozprofile == 0.28 14:10:24 INFO - mozrunner == 6.12 14:10:24 INFO - mozscreenshot == 0.1 14:10:24 INFO - mozsystemmonitor == 0.3 14:10:24 INFO - moztest == 0.7 14:10:24 INFO - mozversion == 1.4 14:10:24 INFO - psutil == 3.1.1 14:10:24 INFO - requests == 1.2.3 14:10:24 INFO - wsgiref == 0.1.2 14:10:24 INFO - Installing None into virtualenv /builds/slave/test/build/venv 14:10:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:10:24 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:10:24 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:10:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:10:24 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:10:24 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:10:24 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 0xe9c030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xfff8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10cb400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x115a570>, '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 0x115b470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x115b900>, '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': '41bf3e9aed84707956354da8000001c5-1472850127.773110-1745143973', '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 14:10:24 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 14:10:24 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 14:10:24 INFO - Using env: {'DISPLAY': ':0', 14:10:24 INFO - 'HOME': '/home/cltbld', 14:10:24 INFO - 'LANG': 'en_US.UTF-8', 14:10:24 INFO - 'LANGUAGE': 'en_US:en', 14:10:24 INFO - 'LOGNAME': 'cltbld', 14:10:24 INFO - 'MAIL': '/var/mail/cltbld', 14:10:24 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:10:24 INFO - 'MOZ_NO_REMOTE': '1', 14:10:24 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:10:24 INFO - 'NO_EM_RESTART': '1', 14:10:24 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:10:24 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:10:24 INFO - 'PWD': '/builds/slave/test', 14:10:24 INFO - 'SHELL': '/bin/bash', 14:10:24 INFO - 'SHLVL': '1', 14:10:24 INFO - 'TERM': 'linux', 14:10:24 INFO - 'TMOUT': '86400', 14:10:24 INFO - 'USER': 'cltbld', 14:10:24 INFO - 'XDG_SESSION_COOKIE': '41bf3e9aed84707956354da8000001c5-1472850127.773110-1745143973', 14:10:24 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:10:24 INFO - '_': '/tools/buildbot/bin/python'} 14:10:24 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:10:24 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)) 14:10:24 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)) 14:10:24 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)) 14:10:24 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)) 14:10:24 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)) 14:10:24 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)) 14:10:24 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)) 14:10:24 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)) 14:10:24 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)) 14:10:24 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)) 14:10:24 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)) 14:10:24 INFO - Cleaning up... 14:10:24 INFO - Return code: 0 14:10:24 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 14:10:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:10:24 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:10:24 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:10:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:10:24 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:10:24 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:10:24 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xe9c030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xfff8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10cb400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x115a570>, '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 0x115b470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x115b900>, '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': '41bf3e9aed84707956354da8000001c5-1472850127.773110-1745143973', '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 14:10:24 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 14:10:24 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 14:10:24 INFO - Using env: {'DISPLAY': ':0', 14:10:24 INFO - 'HOME': '/home/cltbld', 14:10:24 INFO - 'LANG': 'en_US.UTF-8', 14:10:24 INFO - 'LANGUAGE': 'en_US:en', 14:10:24 INFO - 'LOGNAME': 'cltbld', 14:10:24 INFO - 'MAIL': '/var/mail/cltbld', 14:10:24 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:10:24 INFO - 'MOZ_NO_REMOTE': '1', 14:10:24 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:10:24 INFO - 'NO_EM_RESTART': '1', 14:10:24 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:10:24 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:10:24 INFO - 'PWD': '/builds/slave/test', 14:10:24 INFO - 'SHELL': '/bin/bash', 14:10:24 INFO - 'SHLVL': '1', 14:10:24 INFO - 'TERM': 'linux', 14:10:24 INFO - 'TMOUT': '86400', 14:10:24 INFO - 'USER': 'cltbld', 14:10:24 INFO - 'XDG_SESSION_COOKIE': '41bf3e9aed84707956354da8000001c5-1472850127.773110-1745143973', 14:10:24 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:10:24 INFO - '_': '/tools/buildbot/bin/python'} 14:10:24 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:10:24 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 14:10:24 INFO - Cleaning up... 14:10:24 INFO - Return code: 0 14:10:24 INFO - Running post-action listener: _resource_record_post_action 14:10:24 INFO - Running post-action listener: _start_resource_monitoring 14:10:24 INFO - Starting resource monitoring. 14:10:24 INFO - [mozharness: 2016-09-02 21:10:24.616537Z] Finished create-virtualenv step (success) 14:10:24 INFO - [mozharness: 2016-09-02 21:10:24.616962Z] Running install step. 14:10:24 INFO - Running pre-action listener: _resource_record_pre_action 14:10:24 INFO - Running main action method: install 14:10:24 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 14:10:24 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 14:10:24 INFO - Reading from file tmpfile_stdout 14:10:24 INFO - Detecting whether we're running mozinstall >=1.0... 14:10:24 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 14:10:24 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 14:10:24 INFO - Reading from file tmpfile_stdout 14:10:24 INFO - Output received: 14:10:24 INFO - Usage: mozinstall [options] installer 14:10:24 INFO - Options: 14:10:24 INFO - -h, --help show this help message and exit 14:10:24 INFO - -d DEST, --destination=DEST 14:10:24 INFO - Directory to install application into. [default: 14:10:24 INFO - "/builds/slave/test"] 14:10:24 INFO - --app=APP Application being installed. [default: firefox] 14:10:24 INFO - mkdir: /builds/slave/test/build/application 14:10:24 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-50.0a2.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 14:10:24 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-50.0a2.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 14:10:41 INFO - Reading from file tmpfile_stdout 14:10:41 INFO - Output received: 14:10:41 INFO - /builds/slave/test/build/application/firefox/firefox 14:10:41 INFO - Running post-action listener: _resource_record_post_action 14:10:41 INFO - [mozharness: 2016-09-02 21:10:41.580880Z] Finished install step (success) 14:10:41 INFO - [mozharness: 2016-09-02 21:10:41.581133Z] Running run-tests step. 14:10:41 INFO - Running pre-action listener: _resource_record_pre_action 14:10:41 INFO - Running main action method: run_tests 14:10:41 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 14:10:41 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 14:10:41 INFO - Python 2.7.3 14:10:41 INFO - Return code: 0 14:10:41 INFO - grabbing minidump binary from tooltool 14:10:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:10:41 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: {'output_timeout': 600, 'error_list': [{'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x115a570>, '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 0x115b470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x115b900>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 14:10:41 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 14:10:41 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 14:10:41 INFO - Calling ['/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'] with output_timeout 600 14:10:41 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 14:10:41 INFO - Return code: 0 14:10:41 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 14:10:41 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 14:10:41 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 14:10:41 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 14:10:41 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 14:10:41 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Aurora', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/IU2O5TwdSXGE77QTrRrFYw/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-026', '--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 14:10:41 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Mozilla-Aurora --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/IU2O5TwdSXGE77QTrRrFYw/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-026 --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 14:10:41 INFO - Using env: {'DISPLAY': ':0', 14:10:41 INFO - 'HOME': '/home/cltbld', 14:10:41 INFO - 'LANG': 'en_US.UTF-8', 14:10:41 INFO - 'LANGUAGE': 'en_US:en', 14:10:41 INFO - 'LOGNAME': 'cltbld', 14:10:41 INFO - 'MAIL': '/var/mail/cltbld', 14:10:41 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 14:10:41 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 14:10:41 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:10:41 INFO - 'MOZ_NO_REMOTE': '1', 14:10:41 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 14:10:41 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:10:41 INFO - 'NO_EM_RESTART': '1', 14:10:41 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:10:41 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:10:41 INFO - 'PWD': '/builds/slave/test', 14:10:41 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 14:10:41 INFO - 'SHELL': '/bin/bash', 14:10:41 INFO - 'SHLVL': '1', 14:10:41 INFO - 'TERM': 'linux', 14:10:41 INFO - 'TMOUT': '86400', 14:10:41 INFO - 'USER': 'cltbld', 14:10:41 INFO - 'XDG_SESSION_COOKIE': '41bf3e9aed84707956354da8000001c5-1472850127.773110-1745143973', 14:10:41 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:10:41 INFO - '_': '/tools/buildbot/bin/python'} 14:10:41 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Aurora', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/IU2O5TwdSXGE77QTrRrFYw/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-026', '--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 14:10:41 INFO - mozversion application_buildid: 20160902110447 14:10:41 INFO - mozversion application_changeset: 3cb50e5df49728e19c6f5bcb4c5b3fe34a9db53c 14:10:41 INFO - mozversion application_display_name: FirefoxDeveloperEdition 14:10:41 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 14:10:41 INFO - mozversion application_name: Firefox 14:10:41 INFO - mozversion application_remotingname: firefox-dev 14:10:41 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-aurora 14:10:41 INFO - mozversion application_vendor: Mozilla 14:10:41 INFO - mozversion application_version: 50.0a2 14:10:41 INFO - mozversion platform_buildid: 20160902110447 14:10:41 INFO - mozversion platform_changeset: 3cb50e5df49728e19c6f5bcb4c5b3fe34a9db53c 14:10:41 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-aurora 14:10:41 INFO - mozversion platform_version: 50.0a2 14:10:41 INFO - using testdate: 1472850641 14:10:41 INFO - actual date: 1472850641 14:10:41 INFO - starting webserver on 'localhost:49200' 14:10:41 INFO - SUITE-START | Running 2 tests 14:10:41 INFO - TEST-START | dromaeo_css 14:10:41 INFO - operating with platform_type : linux_ 14:10:41 INFO - Initialising browser for dromaeo_css test... 14:10:41 INFO - TEST-INFO | started process 5574 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpB0SNX3/profile http://localhost:49200/getInfo.html) 14:10:46 INFO - PROCESS | 5574 | __metrics Screen width/height:1600/1200 14:10:46 INFO - PROCESS | 5574 | colorDepth:24 14:10:46 INFO - PROCESS | 5574 | Browser inner width/height: 1024/697 14:10:46 INFO - PROCESS | 5574 | __metrics 14:10:46 ERROR - PROCESS | 5574 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2967: TypeError: this.tabs is undefined 14:10:47 INFO - TEST-INFO | 5574: exit 0 14:10:47 INFO - Browser initialized. 14:10:47 INFO - Running cycle 1/1 for dromaeo_css test... 14:10:47 INFO - TEST-INFO | started process 5701 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpB0SNX3/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 14:10:59 INFO - PROCESS | 5701 | RSS: Main: 152588288 14:10:59 INFO - PROCESS | 5701 | 14:11:48 INFO - PROCESS | 5701 | 1472850708974 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] 14:13:57 INFO - PROCESS | 5701 | Cycle 1(1): loaded http://localhost:49200/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49200/tests/dromaeo/cssquery-ext.html) 14:13:58 INFO - PROCESS | 5701 | RSS: Main: 157478912 14:13:58 INFO - PROCESS | 5701 | 14:17:00 INFO - PROCESS | 5701 | Cycle 1(1): loaded http://localhost:49200/tests/dromaeo/cssquery-ext.html (next: http://localhost:49200/tests/dromaeo/cssquery-jquery.html) 14:17:01 INFO - PROCESS | 5701 | RSS: Main: 154009600 14:17:01 INFO - PROCESS | 5701 | 14:20:02 INFO - PROCESS | 5701 | Cycle 1(1): loaded http://localhost:49200/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49200/tests/dromaeo/cssquery-mootools.html) 14:20:03 INFO - PROCESS | 5701 | RSS: Main: 154685440 14:20:03 INFO - PROCESS | 5701 | 14:23:05 INFO - PROCESS | 5701 | Cycle 1(1): loaded http://localhost:49200/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49200/tests/dromaeo/cssquery-prototype.html) 14:23:05 INFO - PROCESS | 5701 | RSS: Main: 153075712 14:23:05 INFO - PROCESS | 5701 | 14:26:08 INFO - PROCESS | 5701 | Cycle 1(1): loaded http://localhost:49200/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49200/tests/dromaeo/cssquery-yui.html) 14:26:08 INFO - PROCESS | 5701 | RSS: Main: 155521024 14:26:08 INFO - PROCESS | 5701 | 14:29:11 INFO - PROCESS | 5701 | Cycle 1(1): loaded http://localhost:49200/tests/dromaeo/cssquery-yui.html (next: http://localhost:49200/tests/dromaeo/cssquery-dojo.html) 14:29:11 INFO - PROCESS | 5701 | RSS: Main: 155488256 14:29:11 INFO - PROCESS | 5701 | 14:29:11 INFO - PROCESS | 5701 | __start_tp_report 14:29:11 INFO - PROCESS | 5701 | _x_x_mozilla_page_load 14:29:11 INFO - PROCESS | 5701 | _x_x_mozilla_page_load_details 14:29:11 INFO - PROCESS | 5701 | |i|pagename|runs| 14:29:11 INFO - PROCESS | 5701 | |0;dojo.html;3285.063756829304;3294.6480671497757;3306.3387322535496;3316.2704205074892;3317.2038710709407;5631.436856314372;5705.286839145107;5727.3699893011735;5736.684482353469;5751.827445176641;5723.055695810197;5743.54051675866;5765.769369225226;5782.132680097988;5824.534037277018;5184.922226166601;5265.526102650761;5266.4733526647415;5329.653572517794;5334.306540149794;5069.746512674352;5131.3842338919385;5138.177891537355;5146.485351464842;5267.236250743659;5264.789408423659;5286.762095705683;5292.497212764801;5334.226537152111;5334.226537152111;5311.070562651521;5343.09167441532;5354.678719276836;5356.38401583817;5381.165919282517;5007.874803129915;5009.298698182258;5066.949330506684;5072.087024335655;5224.817131400383;5624.91562626561;5661.886762264731;5681.630694004918;5744.885102297931;5748.19525266463;6077.726502307407;6099.45104940553;6136.7852125175405;6154.107654390088;6178.41305076017;6012.338642749294;6114.694265286718;6125.41859352575;6133.457080270857;6189.907151392733;5762.078067509178;5772.682502462363;5779.624324418899;5782.797602083949;5788.18965344852;6332.4934005279465;6338.049292606053;6338.239411270677;6343.714532846033;6369.840753981095;5876.647401155944;5949.702514874239;5987.401259873977;6011.218541589566;6058.242719660043;6124.724387402578;6136.764169924325;6143.170671959318;6144.969275153596;6152.446279834837;6044.33512313654;6097.847553811191;6113.480354169946;6115.510759139258;6116.082587611894;5945.464908158287;6073.210482637317;6079.331273559905;6097.908531372033;6120.08198770188;4695.295705644181;4701.717896926127;4725.4565724941385;4729.385179926588;4748.335233067373;4183.937240941388;4188.497380314382;4199.4120823084795;4200.05498762782;4226.936595951063;5881.470667639933;5903.498202652737;5905.852353691193;5975.103734439869;5982.880342393128;6210.596311239755;6212.47193988516;6218.098375735493;6218.129461875341;6232;5920.209769642198;5965.806838632291;5974.492168165754;5982.820515384546;5997.250343707036;5013;5102.132637451642;5153.458886816905;5157.149070403417;5176.223566464985;6365.840853978688;6386.680665966776;6390.648514331757;6402.903956440658;6408.839779005469;5972.372900845348;6145.72344244519;6198.411150940653;6203.782867599793;6209.906851397142;6296.212973378328;6322.968385158045;6331.27190373113;6395.968020159869;6430.292667806444;6106.297775755845;6141.662208578392;6143.293521244936;6143.324234334309;6156.199694039746;5916.645001299936;6241.96879015602;6253.499720022296;6259.217597800275;6262.718177681924;5893.02765043763;5925.496332811586;5955.166276721176;6003.099535069599;6034.034554471264;5907.3797251288;5955.880882382415;5957.880842383041;5958.046712525975;5962.25471816023;5778.162166485752;5832.066869300891;5866.413358664099;5889.38161493037;5969.940300597113;5851.707414629337;5860.589758716849;5988.910166347596;6020.187274717857;6081.756729730938;5880.147378629989;5888.17565540816;5901;5902.852428689145;5912.645241285364 14:29:11 INFO - PROCESS | 5701 | |1;ext.html;599.7121381736766;624.581530374649;631.8199313195737;662.1788981662739;706.9469789765762;40616.79691601542;45416.09167816642;45631.31553026707;45662.315065274044;45778.99999999992;45412.31881521772;46027.30959035609;46431.535684643146;46460.30309545359;46685.533144668625;8978;9058.365914385995;9069.773255668628;9071.818563628723;9079.727608171765;9018.233450156744;9055.728328150166;9095.818083638324;9116.908830911672;9140.588673509676;9074.092590740938;9138.954305228464;9156.130167634097;9170.174684278414;9210.815783684322;9080.409773364743;9136.314776391731;9160.496172710531;9170.816583668322;9183.90816091844;9081.273498120134;9116.908830911672;9131.863022054675;9132.178103970607;9155.404898681565;44010.11979760419;44083;44086.33870491945;44527.55472445299;44556.3316550252;3681.1526378938656;3730.1047748540427;3805.6194380561724;3862.575116737157;4497.527759585262;34747.305053899036;34929.47605785915;35099.64900350989;35146;35389.823050884836;4132.442120313749;4391.6267117295065;4395.560443955611;4529.320601909707;4549.749763762991;371814;374770;375686;375846;379835;64080.679596601716;64482;64489.677551611945;64568.354316457175;65286;39018.41472377917;39753.60246397499;39946.600533994286;41548.169036619096;72544.2745572548;19670.803291967182;19837.504062398555;19980.3006894758;19998.400047998584;20115.597688046157;15189.240537973057;15356.923215384075;15465.149416782186;15467.613309667347;15469.149196794284;20867.1653133876;21140.682889756667;21255.149794008066;21463.67804482934;21473.463163420725;7581.3934885209055;7627.275408836152;7643.464957453036;7773.766786996399;7935.603219838985;1051.81593221186;1060.3478860500736;1088.6244245735209;1106.4246591772394;1114.09509668611;34306.828465857514;34423.65576344255;34432.311353773286;34547;35030.47454288188;1159;1160.7736491384098;1196.8144937534696;1242.0932719115096;1248.4694005048;17226.741598876026;17812.643747125243;18010.36963706264;18171.72742408865;18242.908785455988;604008;609751;614849;618246;622408;66606.66696666583;66849;66981.33018669751;66999.33000669931;67216.32783672199;1431.8997670163196;1465.4870795221586;1478.6746915678534;1506.3823832228734;1510.9244537773068;33362.499562507066;33581.83209083939;33599.496007560396;33714.494282586274;33894.83052584721;50998.49001509937;51320.74339628278;51321;58380.4161958375;58481.70759146177;463999;464764;467159;467259;470446;31708.20729481689;31952.201194970312;32002.51996220105;32172.83913580417;32278.031659050266;53754.462455374945;53987;54357;54368.72815636055;54434;44838.55161448344;45258.547414525434;46166;46653.53346466492;48113.27830082621;42612;46005.76997114993;46428;46708.299375508715;47839;37883;42961.57038429576;45052.09895802131;46404;46445.76777116093;38962.80518597389;39393.21213575655;40023.79988100041;40323.79838100791;41186.17627647371;30422.695773041985;30563.694363056973;30620.84689576538;30750.231244219074;31009.14605368379 14:29:11 INFO - PROCESS | 5701 | |2;jquery.html;407.5313389601959;415.33338990919555;424.60299619855425;432.07967030225615;441.7857339190492;18922.90538547307;20652.07065682044;20666.896665516688;21036;21688.783112168872;19980.70028949563;20075;20501.17995280187;20894.686579701316;21053.26313579025;5704.3154821421485;5886.823395298148;5910.497607703351;5916.408359164092;5926.229590153295;5822.417758224165;5829.562782791287;5839.153322768196;5839.4160583941475;5848.41515848416;5661.264035675356;5768.192453056576;5775.1337299405;5809.506191973687;5820.796272130477;5680.602357834953;5699.974004679156;5702.8289151325525;5735.0823868181305;5771.682557459338;5155.046316431472;5162.483751624845;5162.948370516285;5174.301469301634;5174.990876779029;24038.759612404003;24390.878045609836;24655.50688986228;24865.875670621714;25035.87482062578;2656.8273062251087;2696.8381897086238;2727.754502094821;2953.3650265193087;3025.9243518911985;15206.695866082617;15441.996270242398;15782.447614333443;15815.209239537977;15923.761143582855;2074.6991686205565;2088.7075809386697;2098.9370318890456;2126.213301078611;2261.0955617752866;82048;84536.57731711364;86382.56808715979;87584.68622970724;88544.55727721384;11000.394978276112;11408.88591114095;11423.828642570368;11610.477528511237;12276.693082672826;16269.51191464258;16294.34822607106;16302.266398012118;16306.347746090023;16331.673366532841;9034.412763170505;9052.23056040244;9117.452952822852;9218.44689318643;9290.349675522784;8905.955470222607;8993.865092023625;9033.141851524226;9135.223506002065;9215.677451289306;4874.0495603357;5007.724575148329;5048.974755126201;5067.315912351785;5099.082165210223;2005.8395328373695;2027.341114137911;2080.4382816639422;2107.262458139639;2146.989265053665;984.8079624473302;1006.572206812102;1021.8773747150241;1055.063957637728;1101.6529793115144;20400.26597739209;20587;20875.58248835045;21102.366928992156;21282.78717212808;1003.6136087606178;1019.3985548526257;1046.6284469013542;1076.0530732954949;1093.9343639381664;8375.706850260212;10953.34279943206;11545.422728863523;11587.652370428901;11616.535338586362;446936;450666;451002;454860;488935;92310.53844730867;94910;96817;98231.50884245677;102276.48861755643;1017.0592202212923;1019.3323373190424;1051.0855555666467;1051.784384201237;1056.0231785598291;15387.61530961735;16415.783869177507;17432.389866354617;18075.367362142788;18399.908000459913;39254.80372598119;41730;42980;43933.340999884385;44377.77811110924;55341.723291383285;58816.70591647014;60152;60514.39485605264;62896;8817.426867253864;8842.95578522129;8875.289976801969;8888.688895888612;9067.229285510806;9864.654737084167;13263.933680331536;13736.587902362946;13761;14099.365528551445;11817.82273265919;11876.228045177037;11979.520819167135;12147.939260303996;12199.75600488003;12024.519019239133;12092.274463532216;12158.148929574845;12289.815652765394;12353.3823308836;11997.520099196283;12087.609924858754;12220.694482638006;12274.447649855956;12809.295488747835;7782.92217077822;8759.781005474913;8883.466991980502;8978.820423591622;9104.817903642022;9914.851277230991;10132.290739648153;10763.623273185714;11501.769964600828;11692.240004399688 14:29:11 INFO - PROCESS | 5701 | |3;mootools.html;1504.2403586188977;1550.1629120275052;1705.7356109802977;1853.416173905219;1872.1762424533197;8436.578171091436;9068.138526839948;9278.443293402384;9795.167410770084;9859.161971232445;9337.813243735121;9615.615375384976;9682.225421966243;9700.854487182698;9708.029197080288;2486.3784053986506;2519.1686743374644;2526.494701059786;2527.721950585443;2529.6837895263093;2460.876956152194;2461.384653836541;2462.3105530451503;2464.494778570389;2470.8393954392996;2483.1805504183576;2483.3046746910804;2490.5766019776684;2503.949921001579;2504.787093097089;2358.7641235876445;2376.0495801679294;2384;2440.133752517866;2457.8525288482747;2446.5351583199313;2454.447749256421;2458.864762438065;2463.802895768334;2464.728879823218;9718.465484398355;9766.951165244129;9780.657676981342;9818.067283608047;9851.458169800659;5543.390227075059;5587.7485513152005;5646.40712725162;5646.6894320812335;5648.830535083954;3465.5148279240925;3530.6292839252023;3592.263585964871;3643.0163855758797;3646.5441819772527;1154.5208738373565;1180.9173357864868;1200.2198570928879;1202.5069721414266;1207.076586411396;13181.209127452383;13244.20534767917;13247.271400072992;13266.535671251557;13298.335083245896;4837.782299796518;4892.559669629751;4936.802527898915;4995.150824359867;5068.6451948363265;11420.486078126503;11429.199956003165;11444.885551144382;11466.08271338291;11473.254238474472;5718.771249149988;5719.513841323451;5723.914141287884;5732.34078081026;5764.913526297109;4648.0239149778245;5077.466865979019;5182.067227899014;5216.26972223889;5270.1040823060175;4178.7283826551175;4243.533211346749;4373.497047839475;4408.889777755582;4529.38853254813;1299.3762993762857;1307.1503522710125;1336.5121730568467;1349.6828245362333;1387.6808334083216;1094.852194953671;1099.9450027498754;1101.5208384352673;1104.0560320925654;1120.910327173824;6564.67176641166;6660.333966603398;6689.2307384651385;6741.1236539249585;6766.560173588701;484.394506866417;488.71898658271635;492.889099952515;493.9259111133287;497.7237633113584;4213.747175169438;4304.698671092993;4309.159713855831;4313.590208930146;4321.69748117635;11722.70693232659;11991.820122698167;12056.87943120575;12076.818847717292;12156.756864862653;12002;12015.639530814089;12015.699607509707;12026.4588093536;12052.216605920587;8478.152184781473;8781.385303028726;8782.42914210587;8927.196552310323;9059.81880362389;6610.107635469342;6659.766908158192;6753.189617245962;6900.137482814648;6910.792676219721;10909.127269818555;10934.945325273322;10969.396683182182;11037.558497660004;11145.442727863736;11209;11329.603463878724;11413.828792567952;11454.312741235553;11501.53993840237;7958.64186111638;8395.664173433239;8570.78573035679;8696.869546956927;8744.78138046554;9618.470984095662;9630.27772917048;9655.372400793925;9683.564239609093;9694.418334899929;7914.16901225363;8057.153998830273;8346.207110324509;8366.205210504992;8449.619767110371;8236.258736713724;8243.216894395262;8262.42163048581;8308.418410711434;8349.54077525742;7301.890471642823;7453.180150183584;7551.471397002157;7570.356519695888;7605.6577454013595;5697.8860422790485;5711.857203569778;5753;5776.335721392094;6040.184575082308;5813.651180929158;5912.379200184091;5979.162917191684;6003.939960600338;6044.425779550936 14:29:11 INFO - PROCESS | 5701 | |4;prototype.html;352.60156023693224;353.61102786934373;355.22029146024477;355.3372959430661;357.2640360856636;5745.506168396221;5917.112433135032;5928.110783382494;5930.436608522195;5960.403959604048;5778;5781.62419442737;5785.971070144654;5790.536757059435;5830.242068531085;4321.654267658596;4489.730616163024;4519.706219095749;4523.525029871866;4547.658925580578;4490.775461226942;4518.1415531049;4532.9320060199125;4546.954530454686;4549;4485.618722408599;4527.909441811162;4540.727556346614;4542.273236282195;4549.431321084864;4417.337399390101;4440.800163992628;4475.1049790042125;4481.081378317437;4492.348609451611;3945.546262179829;3961.881143565669;3976.184882099192;3978.701597380179;3983.1635356575152;5623.353314368818;5650.660960342351;5666;5707.714614269312;5717.514011309044;5078.9937974500235;5102.744862756847;5142.845714628567;5172.27588137661;5172.767225474862;6079.39206079393;6118.724657390384;6120.479759220471;6125.724342404603;6154.26148862135;4254.681048874859;4388.319810429389;4393.758343291118;4394.384786129945;4397.714148580332;5909.940900590982;6132.6013809102715;6349.365063493614;6358.904616430757;6387.1377364055725;4399.406080179199;4430.977845110754;4437.378766972626;4450.332450132506;4461.152381047591;4454.77726113693;4467.329900514948;4482.439695038121;4487.169873573399;4491.630052833917;4942.678725882806;5002.499750025041;5113.8721531961255;5149.845504634867;5172.456892026283;6037.607555508966;6046.697665116727;6066.786642671395;6078.939210607838;6137.693115344215;1528.663693987321;1546.95359139226;1560.9609759756097;1562.0861795849328;1574.7637854321943;956.636478138303;999.3604093380243;1008.1481148429565;1010.7466741240809;1014.9545967653329;5223.477652234822;5325.4940780625775;5343.583950253186;5348.679079255257;5378.78484860609;5493.697846618395;5529.668219906818;5560.193771903051;5576.386597474275;5576.97211513948;5300.12547929595;5331.226972089025;5535.750891209825;6017.759289628453;6044.727987240584;3332.7668762557523;3365.528825964367;3386.779859309137;3388.8644454221553;3394.185395505061;6191.473724733358;6458.418742313214;6609.702563384659;6618.205815302194;6620;6401.743930242831;6467.611943283418;6470.288268290485;6523.18460192476;6523.934760652428;6325.7785977491485;6559.934400656028;6577.868442631217;6606.8017959461295;6661;6283.528735344776;6306.46395056407;6307.571584939739;6307.621542707452;6329.97440818952;6240.157578726814;6275.090111933835;6277.309495955533;6281.780137695158;6290.528210384148;6047.304559975483;6248.500839529878;6391.9041214380895;6411.96794016027;6447.6131432114225;4370.322599997005;4431.7562534060935;4460.710053846489;4474.932876006797;4489.753063581535;6181.598196117238;6265.27949285838;6294.622322660655;6319.8104056878365;6418.550701450854;6077.361877003028;6081.422264884829;6129.785457508966;6140.293866205265;6157.199564056644;5946.940530594638;6109.633421994695;6134.263888333428;6143.907841382294;6144.078388241799;5962.701864906824;5979.820605381846;6005.90991135142;6043.8186854394435;6073.845969265825;6103.359147289649;6147.44672979434;6150.200473938359;6177.289611694712;6197.225346831646;5805.622634528742;5956.702164891824;5989.730462129128;6004.39956004396;6008.24896887889 14:29:11 INFO - PROCESS | 5701 | |5;yui.html;791.7110254757015;812.9187081291872;822.2229992656934;842.0653075086657;881.3169793410109;16301.184940752973;16613.750793738072;17025.233864476097;17327.826721732778;17629.911850440763;15629.452969146083;15965.361385544564;16036.599085022852;16105.27526261318;16120.75818862718;865.355310293832;886.4769785826361;897.9371443998923;898.0839543665458;898.4609234459305;905.3933864310927;909.4361495872569;911.6581282019242;912.8539433690611;913.2785099771173;947.313197931501;949.5821838391121;950.0309684122191;952.1906379577339;952.6951375559823;939.1500691873831;942.9245660347156;943.4905151218403;944.475815922163;945.0502245243555;695.6695569604398;696.5959743348845;697.1146643762444;697.8778713725078;698.0401947322432;16946.661066778597;17016.149192540324;17021;17021.404250851283;17083.65832683352;14236.715265694731;14341.856581434156;14512.201828899406;14833.258337083103;14949.551513454613;14194.645133871632;14367.78448323276;14517.128972261698;14597.416103355854;14819.481318153812;4906.215005599122;4940.209566469383;4966.255061740731;4966.776495057731;4973.602111831045;83016.16983830144;83980.58009709913;85375.5731221346;86137;86681;12187.756244875052;12259.908063113431;12355.505779768708;12471.189372690746;12553.874461255271;22178.889105554368;22415.775842241695;22560.88719556392;22620.321390358316;22648.207312743976;8639.78400539979;8722.389432739647;8964.462132272085;9019.458832470073;9087.363884528151;5158.494390661578;5160.880525615823;5271.288376069258;5302.522772950453;5390;3778.4899038629433;3898.2398432305995;3936.075022369741;3936.842526298973;3937.842486300573;653.6208998780696;666.5134451850176;674.7739507265023;676.8409423785406;693.4071368979551;709.6558169287891;759.6391713935836;768.5081547809407;780.0950896959499;808.0182578167554;10912.181586381053;11078.944605276922;11139.777204455866;11415.714607134889;11514.654560363202;665.6006396162264;696.9512134150663;782.2607635784243;795.2802713544252;870.9477431354139;4718.8584342469785;4806.2310030394965;4973.825916092919;5057.519535644108;5091.0581542414775;87406;113704.43147784208;115709.4214528922;115745;116036.41981790206;58967.115493267636;61153;62163.689181553804;62292.68853655794;104558;53164.73417632964;90469.54765226132;92329.53835230916;92744;93532;10101.79796404053;10106.191504679755;10175.185985121025;10178.796424071328;10194.184465242615;45058.54941450543;50885;51392.45822625327;51924.74037629788;52432.737836310574;72423;73582.63208683922;79709;79808.20191798007;80887;12878.549250776177;12893.93553032229;12997.610071697864;13019.414126364525;13166.539171128965;13815.654608634864;14230.217338046506;14311.856881431053;14713.411463541339;14985.325660345528;13752.106113102616;13906.58280251594;13984.300784960915;14154.858451415766;14952.925235373754;13893.930530347283;14174.716505669623;14408.927955360155;14829.703405932038;14873.884458665427;13153.408096635483;13202.933985330012;13508.932455337661;13645.926065916872;13757.518486852912;11039.282446640942;11297;11441.542338306375;11784.410779461165;11853.5851245206;10975.396353200651;11661.183717139718;11806.704832379259;11847.822282665938;12053.457594408448 14:29:11 INFO - PROCESS | 5701 | __end_tp_report 14:29:11 INFO - PROCESS | 5701 | __start_cc_report 14:29:11 INFO - PROCESS | 5701 | _x_x_mozilla_cycle_collect,310 14:29:11 INFO - PROCESS | 5701 | __end_cc_report 14:29:11 INFO - PROCESS | 5701 | __startTimestamp1472851751390__endTimestamp 14:29:11 INFO - PROCESS | 5701 | 14:29:11 INFO - PROCESS | 5701 | ------- Summary: start ------- 14:29:11 INFO - PROCESS | 5701 | Number of tests: 6 14:29:11 INFO - PROCESS | 5701 | 14:29:11 INFO - PROCESS | 5701 | [#0] dojo.html Cycles:165 Average:5705.51 Median:5916.65 stddev:654.71 (11.1%) stddev-sans-first:628.58 14:29:11 INFO - PROCESS | 5701 | Values: 3285.1 3294.6 3306.3 3316.3 3317.2 5631.4 5705.3 5727.4 5736.7 5751.8 5723.1 5743.5 5765.8 5782.1 5824.5 5184.9 5265.5 5266.5 5329.7 5334.3 5069.7 5131.4 5138.2 5146.5 5267.2 5264.8 5286.8 5292.5 5334.2 5334.2 5311.1 5343.1 5354.7 5356.4 5381.2 5007.9 5009.3 5066.9 5072.1 5224.8 5624.9 5661.9 5681.6 5744.9 5748.2 6077.7 6099.5 6136.8 6154.1 6178.4 6012.3 6114.7 6125.4 6133.5 6189.9 5762.1 5772.7 5779.6 5782.8 5788.2 6332.5 6338.0 6338.2 6343.7 6369.8 5876.6 5949.7 5987.4 6011.2 6058.2 6124.7 6136.8 6143.2 6145.0 6152.4 6044.3 6097.8 6113.5 6115.5 6116.1 5945.5 6073.2 6079.3 6097.9 6120.1 4695.3 4701.7 4725.5 4729.4 4748.3 4183.9 4188.5 4199.4 4200.1 4226.9 5881.5 5903.5 5905.9 5975.1 5982.9 6210.6 6212.5 6218.1 6218.1 6232.0 5920.2 5965.8 5974.5 5982.8 5997.3 5013.0 5102.1 5153.5 5157.1 5176.2 6365.8 6386.7 6390.6 6402.9 6408.8 5972.4 6145.7 6198.4 6203.8 6209.9 6296.2 6323.0 6331.3 6396.0 6430.3 6106.3 6141.7 6143.3 6143.3 6156.2 5916.6 6242.0 6253.5 6259.2 6262.7 5893.0 5925.5 5955.2 6003.1 6034.0 5907.4 5955.9 5957.9 5958.0 5962.3 5778.2 5832.1 5866.4 5889.4 5969.9 5851.7 5860.6 5988.9 6020.2 6081.8 5880.1 5888.2 5901.0 5902.9 5912.6 14:29:11 INFO - PROCESS | 5701 | 14:29:11 INFO - PROCESS | 5701 | [#1] ext.html Cycles:180 Average:65550.72 Median:24668.04 stddev:131519.16 (533.2%) stddev-sans-first:131797.70 14:29:11 INFO - PROCESS | 5701 | Values: 599.7 624.6 631.8 662.2 706.9 40616.8 45416.1 45631.3 45662.3 45779.0 45412.3 46027.3 46431.5 46460.3 46685.5 8978.0 9058.4 9069.8 9071.8 9079.7 9018.2 9055.7 9095.8 9116.9 9140.6 9074.1 9139.0 9156.1 9170.2 9210.8 9080.4 9136.3 9160.5 9170.8 9183.9 9081.3 9116.9 9131.9 9132.2 9155.4 44010.1 44083.0 44086.3 44527.6 44556.3 3681.2 3730.1 3805.6 3862.6 4497.5 34747.3 34929.5 35099.6 35146.0 35389.8 4132.4 4391.6 4395.6 4529.3 4549.7 371814.0 374770.0 375686.0 375846.0 379835.0 64080.7 64482.0 64489.7 64568.4 65286.0 39018.4 39753.6 39946.6 41548.2 72544.3 19670.8 19837.5 19980.3 19998.4 20115.6 15189.2 15356.9 15465.1 15467.6 15469.1 20867.2 21140.7 21255.1 21463.7 21473.5 7581.4 7627.3 7643.5 7773.8 7935.6 1051.8 1060.3 1088.6 1106.4 1114.1 34306.8 34423.7 34432.3 34547.0 35030.5 1159.0 1160.8 1196.8 1242.1 1248.5 17226.7 17812.6 18010.4 18171.7 18242.9 604008.0 609751.0 614849.0 618246.0 622408.0 66606.7 66849.0 66981.3 66999.3 67216.3 1431.9 1465.5 1478.7 1506.4 1510.9 33362.5 33581.8 33599.5 33714.5 33894.8 50998.5 51320.7 51321.0 58380.4 58481.7 463999.0 464764.0 467159.0 467259.0 470446.0 31708.2 31952.2 32002.5 32172.8 32278.0 53754.5 53987.0 54357.0 54368.7 54434.0 44838.6 45258.5 46166.0 46653.5 48113.3 42612.0 46005.8 46428.0 46708.3 47839.0 37883.0 42961.6 45052.1 46404.0 46445.8 38962.8 39393.2 40023.8 40323.8 41186.2 30422.7 30563.7 30620.8 30750.2 31009.1 14:29:11 INFO - PROCESS | 5701 | 14:29:11 INFO - PROCESS | 5701 | [#2] jquery.html Cycles:180 Average:28920.36 Median:24950.88 stddev:75978.31 (304.5%) stddev-sans-first:76161.29 14:29:11 INFO - PROCESS | 5701 | Values: 407.5 415.3 424.6 432.1 441.8 18922.9 20652.1 20666.9 21036.0 21688.8 19980.7 20075.0 20501.2 20894.7 21053.3 5704.3 5886.8 5910.5 5916.4 5926.2 5822.4 5829.6 5839.2 5839.4 5848.4 5661.3 5768.2 5775.1 5809.5 5820.8 5680.6 5700.0 5702.8 5735.1 5771.7 5155.0 5162.5 5162.9 5174.3 5175.0 24038.8 24390.9 24655.5 24865.9 25035.9 2656.8 2696.8 2727.8 2953.4 3025.9 15206.7 15442.0 15782.4 15815.2 15923.8 2074.7 2088.7 2098.9 2126.2 2261.1 82048.0 84536.6 86382.6 87584.7 88544.6 11000.4 11408.9 11423.8 11610.5 12276.7 16269.5 16294.3 16302.3 16306.3 16331.7 9034.4 9052.2 9117.5 9218.4 9290.3 8906.0 8993.9 9033.1 9135.2 9215.7 4874.0 5007.7 5049.0 5067.3 5099.1 2005.8 2027.3 2080.4 2107.3 2147.0 984.8 1006.6 1021.9 1055.1 1101.7 20400.3 20587.0 20875.6 21102.4 21282.8 1003.6 1019.4 1046.6 1076.1 1093.9 8375.7 10953.3 11545.4 11587.7 11616.5 446936.0 450666.0 451002.0 454860.0 488935.0 92310.5 94910.0 96817.0 98231.5 102276.5 1017.1 1019.3 1051.1 1051.8 1056.0 15387.6 16415.8 17432.4 18075.4 18399.9 39254.8 41730.0 42980.0 43933.3 44377.8 55341.7 58816.7 60152.0 60514.4 62896.0 8817.4 8843.0 8875.3 8888.7 9067.2 9864.7 13263.9 13736.6 13761.0 14099.4 11817.8 11876.2 11979.5 12147.9 12199.8 12024.5 12092.3 12158.1 12289.8 12353.4 11997.5 12087.6 12220.7 12274.4 12809.3 7782.9 8759.8 8883.5 8978.8 9104.8 9914.9 10132.3 10763.6 11501.8 11692.2 14:29:11 INFO - PROCESS | 5701 | 14:29:11 INFO - PROCESS | 5701 | [#3] mootools.html Cycles:180 Average:6323.87 Median:4742.90 stddev:3654.73 (77.1%) stddev-sans-first:3647.04 14:29:11 INFO - PROCESS | 5701 | Values: 1504.2 1550.2 1705.7 1853.4 1872.2 8436.6 9068.1 9278.4 9795.2 9859.2 9337.8 9615.6 9682.2 9700.9 9708.0 2486.4 2519.2 2526.5 2527.7 2529.7 2460.9 2461.4 2462.3 2464.5 2470.8 2483.2 2483.3 2490.6 2503.9 2504.8 2358.8 2376.0 2384.0 2440.1 2457.9 2446.5 2454.4 2458.9 2463.8 2464.7 9718.5 9767.0 9780.7 9818.1 9851.5 5543.4 5587.7 5646.4 5646.7 5648.8 3465.5 3530.6 3592.3 3643.0 3646.5 1154.5 1180.9 1200.2 1202.5 1207.1 13181.2 13244.2 13247.3 13266.5 13298.3 4837.8 4892.6 4936.8 4995.2 5068.6 11420.5 11429.2 11444.9 11466.1 11473.3 5718.8 5719.5 5723.9 5732.3 5764.9 4648.0 5077.5 5182.1 5216.3 5270.1 4178.7 4243.5 4373.5 4408.9 4529.4 1299.4 1307.2 1336.5 1349.7 1387.7 1094.9 1099.9 1101.5 1104.1 1120.9 6564.7 6660.3 6689.2 6741.1 6766.6 484.4 488.7 492.9 493.9 497.7 4213.7 4304.7 4309.2 4313.6 4321.7 11722.7 11991.8 12056.9 12076.8 12156.8 12002.0 12015.6 12015.7 12026.5 12052.2 8478.2 8781.4 8782.4 8927.2 9059.8 6610.1 6659.8 6753.2 6900.1 6910.8 10909.1 10934.9 10969.4 11037.6 11145.4 11209.0 11329.6 11413.8 11454.3 11501.5 7958.6 8395.7 8570.8 8696.9 8744.8 9618.5 9630.3 9655.4 9683.6 9694.4 7914.2 8057.2 8346.2 8366.2 8449.6 8236.3 8243.2 8262.4 8308.4 8349.5 7301.9 7453.2 7551.5 7570.4 7605.7 5697.9 5711.9 5753.0 5776.3 6040.2 5813.7 5912.4 5979.2 6003.9 6044.4 14:29:11 INFO - PROCESS | 5701 | 14:29:11 INFO - PROCESS | 5701 | [#4] prototype.html Cycles:180 Average:5097.95 Median:5731.51 stddev:1507.00 (26.3%) stddev-sans-first:1468.54 14:29:11 INFO - PROCESS | 5701 | Values: 352.6 353.6 355.2 355.3 357.3 5745.5 5917.1 5928.1 5930.4 5960.4 5778.0 5781.6 5786.0 5790.5 5830.2 4321.7 4489.7 4519.7 4523.5 4547.7 4490.8 4518.1 4532.9 4547.0 4549.0 4485.6 4527.9 4540.7 4542.3 4549.4 4417.3 4440.8 4475.1 4481.1 4492.3 3945.5 3961.9 3976.2 3978.7 3983.2 5623.4 5650.7 5666.0 5707.7 5717.5 5079.0 5102.7 5142.8 5172.3 5172.8 6079.4 6118.7 6120.5 6125.7 6154.3 4254.7 4388.3 4393.8 4394.4 4397.7 5909.9 6132.6 6349.4 6358.9 6387.1 4399.4 4431.0 4437.4 4450.3 4461.2 4454.8 4467.3 4482.4 4487.2 4491.6 4942.7 5002.5 5113.9 5149.8 5172.5 6037.6 6046.7 6066.8 6078.9 6137.7 1528.7 1547.0 1561.0 1562.1 1574.8 956.6 999.4 1008.1 1010.7 1015.0 5223.5 5325.5 5343.6 5348.7 5378.8 5493.7 5529.7 5560.2 5576.4 5577.0 5300.1 5331.2 5535.8 6017.8 6044.7 3332.8 3365.5 3386.8 3388.9 3394.2 6191.5 6458.4 6609.7 6618.2 6620.0 6401.7 6467.6 6470.3 6523.2 6523.9 6325.8 6559.9 6577.9 6606.8 6661.0 6283.5 6306.5 6307.6 6307.6 6330.0 6240.2 6275.1 6277.3 6281.8 6290.5 6047.3 6248.5 6391.9 6412.0 6447.6 4370.3 4431.8 4460.7 4474.9 4489.8 6181.6 6265.3 6294.6 6319.8 6418.6 6077.4 6081.4 6129.8 6140.3 6157.2 5946.9 6109.6 6134.3 6143.9 6144.1 5962.7 5979.8 6005.9 6043.8 6073.8 6103.4 6147.4 6150.2 6177.3 6197.2 5805.6 5956.7 5989.7 6004.4 6008.2 14:29:11 INFO - PROCESS | 5701 | 14:29:11 INFO - PROCESS | 5701 | [#5] yui.html Cycles:180 Average:20551.31 Median:24888.70 stddev:28377.69 (114.0%) stddev-sans-first:28418.51 14:29:11 INFO - PROCESS | 5701 | Values: 791.7 812.9 822.2 842.1 881.3 16301.2 16613.8 17025.2 17327.8 17629.9 15629.5 15965.4 16036.6 16105.3 16120.8 865.4 886.5 897.9 898.1 898.5 905.4 909.4 911.7 912.9 913.3 947.3 949.6 950.0 952.2 952.7 939.2 942.9 943.5 944.5 945.1 695.7 696.6 697.1 697.9 698.0 16946.7 17016.1 17021.0 17021.4 17083.7 14236.7 14341.9 14512.2 14833.3 14949.6 14194.6 14367.8 14517.1 14597.4 14819.5 4906.2 4940.2 4966.3 4966.8 4973.6 83016.2 83980.6 85375.6 86137.0 86681.0 12187.8 12259.9 12355.5 12471.2 12553.9 22178.9 22415.8 22560.9 22620.3 22648.2 8639.8 8722.4 8964.5 9019.5 9087.4 5158.5 5160.9 5271.3 5302.5 5390.0 3778.5 3898.2 3936.1 3936.8 3937.8 653.6 666.5 674.8 676.8 693.4 709.7 759.6 768.5 780.1 808.0 10912.2 11078.9 11139.8 11415.7 11514.7 665.6 697.0 782.3 795.3 870.9 4718.9 4806.2 4973.8 5057.5 5091.1 87406.0 113704.4 115709.4 115745.0 116036.4 58967.1 61153.0 62163.7 62292.7 104558.0 53164.7 90469.5 92329.5 92744.0 93532.0 10101.8 10106.2 10175.2 10178.8 10194.2 45058.5 50885.0 51392.5 51924.7 52432.7 72423.0 73582.6 79709.0 79808.2 80887.0 12878.5 12893.9 12997.6 13019.4 13166.5 13815.7 14230.2 14311.9 14713.4 14985.3 13752.1 13906.6 13984.3 14154.9 14952.9 13893.9 14174.7 14408.9 14829.7 14873.9 13153.4 13202.9 13508.9 13645.9 13757.5 11039.3 11297.0 11441.5 11784.4 11853.6 10975.4 11661.2 11806.7 11847.8 12053.5 14:29:11 INFO - PROCESS | 5701 | -------- Summary: end -------- 14:29:11 INFO - PROCESS | 5701 | 14:29:12 INFO - TEST-INFO | 5701: exit 0 14:29:12 INFO - TEST-OK | dromaeo_css | took 1110276ms 14:29:12 INFO - TEST-START | kraken 14:29:12 INFO - operating with platform_type : linux_ 14:29:12 INFO - Initialising browser for kraken test... 14:29:12 INFO - TEST-INFO | started process 5971 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpvSuXZV/profile http://localhost:49200/getInfo.html) 14:29:16 INFO - PROCESS | 5971 | __metrics Screen width/height:1600/1200 14:29:16 INFO - PROCESS | 5971 | colorDepth:24 14:29:16 INFO - PROCESS | 5971 | Browser inner width/height: 1024/697 14:29:16 INFO - PROCESS | 5971 | __metrics 14:29:17 ERROR - PROCESS | 5971 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2967: TypeError: this.tabs is undefined 14:29:17 INFO - TEST-INFO | 5971: exit 0 14:29:17 INFO - Browser initialized. 14:29:17 INFO - Running cycle 1/1 for kraken test... 14:29:17 INFO - TEST-INFO | started process 6096 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpvSuXZV/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 14:29:29 INFO - PROCESS | 6096 | RSS: Main: 152363008 14:29:29 INFO - PROCESS | 6096 | 14:29:32 INFO - PROCESS | 6096 | Cycle 1(1): loaded http://localhost:49200/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49200/tests/kraken/driver.html?testName=audio-beat-detection) 14:29:33 INFO - PROCESS | 6096 | RSS: Main: 157638656 14:29:33 INFO - PROCESS | 6096 | 14:29:35 INFO - PROCESS | 6096 | Cycle 1(1): loaded http://localhost:49200/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49200/tests/kraken/driver.html?testName=audio-dft) 14:29:36 INFO - PROCESS | 6096 | RSS: Main: 156684288 14:29:36 INFO - PROCESS | 6096 | 14:29:39 INFO - PROCESS | 6096 | Cycle 1(1): loaded http://localhost:49200/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49200/tests/kraken/driver.html?testName=audio-fft) 14:29:39 INFO - PROCESS | 6096 | RSS: Main: 157020160 14:29:39 INFO - PROCESS | 6096 | 14:29:41 INFO - PROCESS | 6096 | Cycle 1(1): loaded http://localhost:49200/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49200/tests/kraken/driver.html?testName=audio-oscillator) 14:29:42 INFO - PROCESS | 6096 | RSS: Main: 157057024 14:29:42 INFO - PROCESS | 6096 | 14:29:44 INFO - PROCESS | 6096 | Cycle 1(1): loaded http://localhost:49200/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49200/tests/kraken/driver.html?testName=imaging-gaussian-blur) 14:29:45 INFO - PROCESS | 6096 | RSS: Main: 156581888 14:29:45 INFO - PROCESS | 6096 | 14:29:48 INFO - PROCESS | 6096 | Cycle 1(1): loaded http://localhost:49200/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49200/tests/kraken/driver.html?testName=imaging-darkroom) 14:29:48 INFO - PROCESS | 6096 | RSS: Main: 156663808 14:29:48 INFO - PROCESS | 6096 | 14:29:52 INFO - PROCESS | 6096 | Cycle 1(1): loaded http://localhost:49200/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49200/tests/kraken/driver.html?testName=imaging-desaturate) 14:29:53 INFO - PROCESS | 6096 | RSS: Main: 155025408 14:29:53 INFO - PROCESS | 6096 | 14:29:55 INFO - PROCESS | 6096 | Cycle 1(1): loaded http://localhost:49200/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49200/tests/kraken/driver.html?testName=json-parse-financial) 14:29:56 INFO - PROCESS | 6096 | RSS: Main: 156225536 14:29:56 INFO - PROCESS | 6096 | 14:29:58 INFO - PROCESS | 6096 | Cycle 1(1): loaded http://localhost:49200/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49200/tests/kraken/driver.html?testName=json-stringify-tinderbox) 14:29:58 INFO - PROCESS | 6096 | RSS: Main: 156422144 14:29:58 INFO - PROCESS | 6096 | 14:30:00 INFO - PROCESS | 6096 | Cycle 1(1): loaded http://localhost:49200/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49200/tests/kraken/driver.html?testName=stanford-crypto-aes) 14:30:01 INFO - PROCESS | 6096 | RSS: Main: 156536832 14:30:01 INFO - PROCESS | 6096 | 14:30:03 INFO - PROCESS | 6096 | Cycle 1(1): loaded http://localhost:49200/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49200/tests/kraken/driver.html?testName=stanford-crypto-ccm) 14:30:03 INFO - PROCESS | 6096 | RSS: Main: 157818880 14:30:03 INFO - PROCESS | 6096 | 14:30:06 INFO - PROCESS | 6096 | Cycle 1(1): loaded http://localhost:49200/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49200/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 14:30:06 INFO - PROCESS | 6096 | RSS: Main: 157003776 14:30:06 INFO - PROCESS | 6096 | 14:30:09 INFO - PROCESS | 6096 | Cycle 1(1): loaded http://localhost:49200/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49200/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 14:30:10 INFO - PROCESS | 6096 | RSS: Main: 157130752 14:30:10 INFO - PROCESS | 6096 | 14:30:11 INFO - PROCESS | 6096 | Cycle 1(1): loaded http://localhost:49200/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49200/tests/kraken/driver.html?testName=ai-astar) 14:30:12 INFO - PROCESS | 6096 | RSS: Main: 158277632 14:30:12 INFO - PROCESS | 6096 | 14:30:12 INFO - PROCESS | 6096 | __start_tp_report 14:30:12 INFO - PROCESS | 6096 | _x_x_mozilla_page_load 14:30:12 INFO - PROCESS | 6096 | _x_x_mozilla_page_load_details 14:30:12 INFO - PROCESS | 6096 | |i|pagename|runs| 14:30:12 INFO - PROCESS | 6096 | |0;ai-astar;101;111;104;111;111;111;109;112;110;109 14:30:12 INFO - PROCESS | 6096 | |1;audio-beat-detection;149;116;150;175;118;153;148;118;168;123 14:30:12 INFO - PROCESS | 6096 | |2;audio-dft;161;162;163;161;162;163;162;161;161;160 14:30:12 INFO - PROCESS | 6096 | |3;audio-fft;74;76;74;178;75;74;77;76;172;76 14:30:12 INFO - PROCESS | 6096 | |4;audio-oscillator;84;84;159;83;83;83;146;84;84;139 14:30:12 INFO - PROCESS | 6096 | |5;imaging-gaussian-blur;118;118;117;117;117;117;118;117;118;117 14:30:12 INFO - PROCESS | 6096 | |6;imaging-darkroom;147;148;147;148;146;147;148;148;148;147 14:30:12 INFO - PROCESS | 6096 | |7;imaging-desaturate;99;95;95;95;96;95;95;96;95;95 14:30:12 INFO - PROCESS | 6096 | |8;json-parse-financial;53;54;54;51;52;52;56;52;53;58 14:30:12 INFO - PROCESS | 6096 | |9;json-stringify-tinderbox;63;61;60;60;60;60;60;61;60;59 14:30:12 INFO - PROCESS | 6096 | |10;stanford-crypto-aes;73;75;83;74;73;74;78;74;73;72 14:30:12 INFO - PROCESS | 6096 | |11;stanford-crypto-ccm;139;118;127;117;119;131;119;119;153;131 14:30:12 INFO - PROCESS | 6096 | |12;stanford-crypto-pbkdf2;151;152;155;154;158;151;153;153;152;154 14:30:12 INFO - PROCESS | 6096 | |13;stanford-crypto-sha256-iterative;62;65;63;63;63;66;61;61;60;61 14:30:12 INFO - PROCESS | 6096 | __end_tp_report 14:30:12 INFO - PROCESS | 6096 | __start_cc_report 14:30:12 INFO - PROCESS | 6096 | _x_x_mozilla_cycle_collect,884 14:30:12 INFO - PROCESS | 6096 | __end_cc_report 14:30:12 INFO - PROCESS | 6096 | __startTimestamp1472851812157__endTimestamp 14:30:12 INFO - PROCESS | 6096 | 14:30:12 INFO - PROCESS | 6096 | ------- Summary: start ------- 14:30:12 INFO - PROCESS | 6096 | Number of tests: 14 14:30:12 INFO - PROCESS | 6096 | 14:30:12 INFO - PROCESS | 6096 | [#0] ai-astar Cycles:10 Average:108.90 Median:111.00 stddev:3.57 (3.2%) stddev-sans-first:2.39 14:30:12 INFO - PROCESS | 6096 | Values: 101.0 111.0 104.0 111.0 111.0 111.0 109.0 112.0 110.0 109.0 14:30:12 INFO - PROCESS | 6096 | 14:30:12 INFO - PROCESS | 6096 | [#1] audio-beat-detection Cycles:10 Average:141.80 Median:149.50 stddev:21.66 (14.5%) stddev-sans-first:22.82 14:30:12 INFO - PROCESS | 6096 | Values: 149.0 116.0 150.0 175.0 118.0 153.0 148.0 118.0 168.0 123.0 14:30:12 INFO - PROCESS | 6096 | 14:30:12 INFO - PROCESS | 6096 | [#2] audio-dft Cycles:10 Average:161.60 Median:162.00 stddev:0.97 (0.6%) stddev-sans-first:1.00 14:30:12 INFO - PROCESS | 6096 | Values: 161.0 162.0 163.0 161.0 162.0 163.0 162.0 161.0 161.0 160.0 14:30:12 INFO - PROCESS | 6096 | 14:30:12 INFO - PROCESS | 6096 | [#3] audio-fft Cycles:10 Average:95.20 Median:75.50 stddev:42.09 (55.8%) stddev-sans-first:43.94 14:30:12 INFO - PROCESS | 6096 | Values: 74.0 76.0 74.0 178.0 75.0 74.0 77.0 76.0 172.0 76.0 14:30:12 INFO - PROCESS | 6096 | 14:30:12 INFO - PROCESS | 6096 | [#4] audio-oscillator Cycles:10 Average:102.90 Median:83.50 stddev:31.49 (37.7%) stddev-sans-first:32.65 14:30:12 INFO - PROCESS | 6096 | Values: 84.0 84.0 159.0 83.0 83.0 83.0 146.0 84.0 84.0 139.0 14:30:12 INFO - PROCESS | 6096 | 14:30:12 INFO - PROCESS | 6096 | [#5] imaging-gaussian-blur Cycles:10 Average:117.40 Median:117.50 stddev:0.52 (0.4%) stddev-sans-first:0.50 14:30:12 INFO - PROCESS | 6096 | Values: 118.0 118.0 117.0 117.0 117.0 117.0 118.0 117.0 118.0 117.0 14:30:12 INFO - PROCESS | 6096 | 14:30:12 INFO - PROCESS | 6096 | [#6] imaging-darkroom Cycles:10 Average:147.40 Median:148.00 stddev:0.70 (0.5%) stddev-sans-first:0.73 14:30:12 INFO - PROCESS | 6096 | Values: 147.0 148.0 147.0 148.0 146.0 147.0 148.0 148.0 148.0 147.0 14:30:12 INFO - PROCESS | 6096 | 14:30:12 INFO - PROCESS | 6096 | [#7] imaging-desaturate Cycles:10 Average:95.60 Median:95.00 stddev:1.26 (1.3%) stddev-sans-first:0.44 14:30:12 INFO - PROCESS | 6096 | Values: 99.0 95.0 95.0 95.0 96.0 95.0 95.0 96.0 95.0 95.0 14:30:12 INFO - PROCESS | 6096 | 14:30:12 INFO - PROCESS | 6096 | [#8] json-parse-financial Cycles:10 Average:53.50 Median:53.50 stddev:2.12 (4.0%) stddev-sans-first:2.24 14:30:12 INFO - PROCESS | 6096 | Values: 53.0 54.0 54.0 51.0 52.0 52.0 56.0 52.0 53.0 58.0 14:30:12 INFO - PROCESS | 6096 | 14:30:12 INFO - PROCESS | 6096 | [#9] json-stringify-tinderbox Cycles:10 Average:60.40 Median:60.00 stddev:1.07 (1.8%) stddev-sans-first:0.60 14:30:12 INFO - PROCESS | 6096 | Values: 63.0 61.0 60.0 60.0 60.0 60.0 60.0 61.0 60.0 59.0 14:30:12 INFO - PROCESS | 6096 | 14:30:12 INFO - PROCESS | 6096 | [#10] stanford-crypto-aes Cycles:10 Average:74.90 Median:74.00 stddev:3.28 (4.4%) stddev-sans-first:3.41 14:30:12 INFO - PROCESS | 6096 | Values: 73.0 75.0 83.0 74.0 73.0 74.0 78.0 74.0 73.0 72.0 14:30:12 INFO - PROCESS | 6096 | 14:30:12 INFO - PROCESS | 6096 | [#11] stanford-crypto-ccm Cycles:10 Average:127.30 Median:129.00 stddev:11.66 (9.0%) stddev-sans-first:11.58 14:30:12 INFO - PROCESS | 6096 | Values: 139.0 118.0 127.0 117.0 119.0 131.0 119.0 119.0 153.0 131.0 14:30:12 INFO - PROCESS | 6096 | 14:30:12 INFO - PROCESS | 6096 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:153.30 Median:153.50 stddev:2.11 (1.4%) stddev-sans-first:2.07 14:30:12 INFO - PROCESS | 6096 | Values: 151.0 152.0 155.0 154.0 158.0 151.0 153.0 153.0 152.0 154.0 14:30:12 INFO - PROCESS | 6096 | 14:30:12 INFO - PROCESS | 6096 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:62.50 Median:63.00 stddev:1.90 (3.0%) stddev-sans-first:2.01 14:30:12 INFO - PROCESS | 6096 | Values: 62.0 65.0 63.0 63.0 63.0 66.0 61.0 61.0 60.0 61.0 14:30:12 INFO - PROCESS | 6096 | -------- Summary: end -------- 14:30:12 INFO - PROCESS | 6096 | 14:30:13 INFO - TEST-INFO | 6096: exit 0 14:30:13 INFO - TEST-OK | kraken | took 60981ms 14:30:13 INFO - SUITE-END | took 1171s 14:30:13 INFO - Completed test suite (00:19:31) 14:30:13 INFO - javascript benchmark 14:30:13 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7747.69662994048, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3285.063756829304, 3294.6480671497757, 3306.3387322535496, 3316.2704205074892, 3317.2038710709407, 5631.436856314372, 5705.286839145107, 5727.3699893011735, 5736.684482353469, 5751.827445176641, 5723.055695810197, 5743.54051675866, 5765.769369225226, 5782.132680097988, 5824.534037277018, 5184.922226166601, 5265.526102650761, 5266.4733526647415, 5329.653572517794, 5334.306540149794, 5069.746512674352, 5131.3842338919385, 5138.177891537355, 5146.485351464842, 5267.236250743659, 5264.789408423659, 5286.762095705683, 5292.497212764801, 5334.226537152111, 5334.226537152111, 5311.070562651521, 5343.09167441532, 5354.678719276836, 5356.38401583817, 5381.165919282517, 5007.874803129915, 5009.298698182258, 5066.949330506684, 5072.087024335655, 5224.817131400383, 5624.91562626561, 5661.886762264731, 5681.630694004918, 5744.885102297931, 5748.19525266463, 6077.726502307407, 6099.45104940553, 6136.7852125175405, 6154.107654390088, 6178.41305076017, 6012.338642749294, 6114.694265286718, 6125.41859352575, 6133.457080270857, 6189.907151392733, 5762.078067509178, 5772.682502462363, 5779.624324418899, 5782.797602083949, 5788.18965344852, 6332.4934005279465, 6338.049292606053, 6338.239411270677, 6343.714532846033, 6369.840753981095, 5876.647401155944, 5949.702514874239, 5987.401259873977, 6011.218541589566, 6058.242719660043, 6124.724387402578, 6136.764169924325, 6143.170671959318, 6144.969275153596, 6152.446279834837, 6044.33512313654, 6097.847553811191, 6113.480354169946, 6115.510759139258, 6116.082587611894, 5945.464908158287, 6073.210482637317, 6079.331273559905, 6097.908531372033, 6120.08198770188, 4695.295705644181, 4701.717896926127, 4725.4565724941385, 4729.385179926588, 4748.335233067373, 4183.937240941388, 4188.497380314382, 4199.4120823084795, 4200.05498762782, 4226.936595951063, 5881.470667639933, 5903.498202652737, 5905.852353691193, 5975.103734439869, 5982.880342393128, 6210.596311239755, 6212.47193988516, 6218.098375735493, 6218.129461875341, 6232.0, 5920.209769642198, 5965.806838632291, 5974.492168165754, 5982.820515384546, 5997.250343707036, 5013.0, 5102.132637451642, 5153.458886816905, 5157.149070403417, 5176.223566464985, 6365.840853978688, 6386.680665966776, 6390.648514331757, 6402.903956440658, 6408.839779005469, 5972.372900845348, 6145.72344244519, 6198.411150940653, 6203.782867599793, 6209.906851397142, 6296.212973378328, 6322.968385158045, 6331.27190373113, 6395.968020159869, 6430.292667806444, 6106.297775755845, 6141.662208578392, 6143.293521244936, 6143.324234334309, 6156.199694039746, 5916.645001299936, 6241.96879015602, 6253.499720022296, 6259.217597800275, 6262.718177681924, 5893.02765043763, 5925.496332811586, 5955.166276721176, 6003.099535069599, 6034.034554471264, 5907.3797251288, 5955.880882382415, 5957.880842383041, 5958.046712525975, 5962.25471816023, 5778.162166485752, 5832.066869300891, 5866.413358664099, 5889.38161493037, 5969.940300597113, 5851.707414629337, 5860.589758716849, 5988.910166347596, 6020.187274717857, 6081.756729730938, 5880.147378629989, 5888.17565540816, 5901.0, 5902.852428689145, 5912.645241285364], "value": 5660.780104222138, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [599.7121381736766, 624.581530374649, 631.8199313195737, 662.1788981662739, 706.9469789765762, 40616.79691601542, 45416.09167816642, 45631.31553026707, 45662.315065274044, 45778.99999999992, 45412.31881521772, 46027.30959035609, 46431.535684643146, 46460.30309545359, 46685.533144668625, 8978.0, 9058.365914385995, 9069.773255668628, 9071.818563628723, 9079.727608171765, 9018.233450156744, 9055.728328150166, 9095.818083638324, 9116.908830911672, 9140.588673509676, 9074.092590740938, 9138.954305228464, 9156.130167634097, 9170.174684278414, 9210.815783684322, 9080.409773364743, 9136.314776391731, 9160.496172710531, 9170.816583668322, 9183.90816091844, 9081.273498120134, 9116.908830911672, 9131.863022054675, 9132.178103970607, 9155.404898681565, 44010.11979760419, 44083.0, 44086.33870491945, 44527.55472445299, 44556.3316550252, 3681.1526378938656, 3730.1047748540427, 3805.6194380561724, 3862.575116737157, 4497.527759585262, 34747.305053899036, 34929.47605785915, 35099.64900350989, 35146.0, 35389.823050884836, 4132.442120313749, 4391.6267117295065, 4395.560443955611, 4529.320601909707, 4549.749763762991, 371814.0, 374770.0, 375686.0, 375846.0, 379835.0, 64080.679596601716, 64482.0, 64489.677551611945, 64568.354316457175, 65286.0, 39018.41472377917, 39753.60246397499, 39946.600533994286, 41548.169036619096, 72544.2745572548, 19670.803291967182, 19837.504062398555, 19980.3006894758, 19998.400047998584, 20115.597688046157, 15189.240537973057, 15356.923215384075, 15465.149416782186, 15467.613309667347, 15469.149196794284, 20867.1653133876, 21140.682889756667, 21255.149794008066, 21463.67804482934, 21473.463163420725, 7581.3934885209055, 7627.275408836152, 7643.464957453036, 7773.766786996399, 7935.603219838985, 1051.81593221186, 1060.3478860500736, 1088.6244245735209, 1106.4246591772394, 1114.09509668611, 34306.828465857514, 34423.65576344255, 34432.311353773286, 34547.0, 35030.47454288188, 1159.0, 1160.7736491384098, 1196.8144937534696, 1242.0932719115096, 1248.4694005048, 17226.741598876026, 17812.643747125243, 18010.36963706264, 18171.72742408865, 18242.908785455988, 604008.0, 609751.0, 614849.0, 618246.0, 622408.0, 66606.66696666583, 66849.0, 66981.33018669751, 66999.33000669931, 67216.32783672199, 1431.8997670163196, 1465.4870795221586, 1478.6746915678534, 1506.3823832228734, 1510.9244537773068, 33362.499562507066, 33581.83209083939, 33599.496007560396, 33714.494282586274, 33894.83052584721, 50998.49001509937, 51320.74339628278, 51321.0, 58380.4161958375, 58481.70759146177, 463999.0, 464764.0, 467159.0, 467259.0, 470446.0, 31708.20729481689, 31952.201194970312, 32002.51996220105, 32172.83913580417, 32278.031659050266, 53754.462455374945, 53987.0, 54357.0, 54368.72815636055, 54434.0, 44838.55161448344, 45258.547414525434, 46166.0, 46653.53346466492, 48113.27830082621, 42612.0, 46005.76997114993, 46428.0, 46708.299375508715, 47839.0, 37883.0, 42961.57038429576, 45052.09895802131, 46404.0, 46445.76777116093, 38962.80518597389, 39393.21213575655, 40023.79988100041, 40323.79838100791, 41186.17627647371, 30422.695773041985, 30563.694363056973, 30620.84689576538, 30750.231244219074, 31009.14605368379], "value": 21569.480172672782, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [407.5313389601959, 415.33338990919555, 424.60299619855425, 432.07967030225615, 441.7857339190492, 18922.90538547307, 20652.07065682044, 20666.896665516688, 21036.0, 21688.783112168872, 19980.70028949563, 20075.0, 20501.17995280187, 20894.686579701316, 21053.26313579025, 5704.3154821421485, 5886.823395298148, 5910.497607703351, 5916.408359164092, 5926.229590153295, 5822.417758224165, 5829.562782791287, 5839.153322768196, 5839.4160583941475, 5848.41515848416, 5661.264035675356, 5768.192453056576, 5775.1337299405, 5809.506191973687, 5820.796272130477, 5680.602357834953, 5699.974004679156, 5702.8289151325525, 5735.0823868181305, 5771.682557459338, 5155.046316431472, 5162.483751624845, 5162.948370516285, 5174.301469301634, 5174.990876779029, 24038.759612404003, 24390.878045609836, 24655.50688986228, 24865.875670621714, 25035.87482062578, 2656.8273062251087, 2696.8381897086238, 2727.754502094821, 2953.3650265193087, 3025.9243518911985, 15206.695866082617, 15441.996270242398, 15782.447614333443, 15815.209239537977, 15923.761143582855, 2074.6991686205565, 2088.7075809386697, 2098.9370318890456, 2126.213301078611, 2261.0955617752866, 82048.0, 84536.57731711364, 86382.56808715979, 87584.68622970724, 88544.55727721384, 11000.394978276112, 11408.88591114095, 11423.828642570368, 11610.477528511237, 12276.693082672826, 16269.51191464258, 16294.34822607106, 16302.266398012118, 16306.347746090023, 16331.673366532841, 9034.412763170505, 9052.23056040244, 9117.452952822852, 9218.44689318643, 9290.349675522784, 8905.955470222607, 8993.865092023625, 9033.141851524226, 9135.223506002065, 9215.677451289306, 4874.0495603357, 5007.724575148329, 5048.974755126201, 5067.315912351785, 5099.082165210223, 2005.8395328373695, 2027.341114137911, 2080.4382816639422, 2107.262458139639, 2146.989265053665, 984.8079624473302, 1006.572206812102, 1021.8773747150241, 1055.063957637728, 1101.6529793115144, 20400.26597739209, 20587.0, 20875.58248835045, 21102.366928992156, 21282.78717212808, 1003.6136087606178, 1019.3985548526257, 1046.6284469013542, 1076.0530732954949, 1093.9343639381664, 8375.706850260212, 10953.34279943206, 11545.422728863523, 11587.652370428901, 11616.535338586362, 446936.0, 450666.0, 451002.0, 454860.0, 488935.0, 92310.53844730867, 94910.0, 96817.0, 98231.50884245677, 102276.48861755643, 1017.0592202212923, 1019.3323373190424, 1051.0855555666467, 1051.784384201237, 1056.0231785598291, 15387.61530961735, 16415.783869177507, 17432.389866354617, 18075.367362142788, 18399.908000459913, 39254.80372598119, 41730.0, 42980.0, 43933.340999884385, 44377.77811110924, 55341.723291383285, 58816.70591647014, 60152.0, 60514.39485605264, 62896.0, 8817.426867253864, 8842.95578522129, 8875.289976801969, 8888.688895888612, 9067.229285510806, 9864.654737084167, 13263.933680331536, 13736.587902362946, 13761.0, 14099.365528551445, 11817.82273265919, 11876.228045177037, 11979.520819167135, 12147.939260303996, 12199.75600488003, 12024.519019239133, 12092.274463532216, 12158.148929574845, 12289.815652765394, 12353.3823308836, 11997.520099196283, 12087.609924858754, 12220.694482638006, 12274.447649855956, 12809.295488747835, 7782.92217077822, 8759.781005474913, 8883.466991980502, 8978.820423591622, 9104.817903642022, 9914.851277230991, 10132.290739648153, 10763.623273185714, 11501.769964600828, 11692.240004399688], "value": 9688.541553849203, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1504.2403586188977, 1550.1629120275052, 1705.7356109802977, 1853.416173905219, 1872.1762424533197, 8436.578171091436, 9068.138526839948, 9278.443293402384, 9795.167410770084, 9859.161971232445, 9337.813243735121, 9615.615375384976, 9682.225421966243, 9700.854487182698, 9708.029197080288, 2486.3784053986506, 2519.1686743374644, 2526.494701059786, 2527.721950585443, 2529.6837895263093, 2460.876956152194, 2461.384653836541, 2462.3105530451503, 2464.494778570389, 2470.8393954392996, 2483.1805504183576, 2483.3046746910804, 2490.5766019776684, 2503.949921001579, 2504.787093097089, 2358.7641235876445, 2376.0495801679294, 2384.0, 2440.133752517866, 2457.8525288482747, 2446.5351583199313, 2454.447749256421, 2458.864762438065, 2463.802895768334, 2464.728879823218, 9718.465484398355, 9766.951165244129, 9780.657676981342, 9818.067283608047, 9851.458169800659, 5543.390227075059, 5587.7485513152005, 5646.40712725162, 5646.6894320812335, 5648.830535083954, 3465.5148279240925, 3530.6292839252023, 3592.263585964871, 3643.0163855758797, 3646.5441819772527, 1154.5208738373565, 1180.9173357864868, 1200.2198570928879, 1202.5069721414266, 1207.076586411396, 13181.209127452383, 13244.20534767917, 13247.271400072992, 13266.535671251557, 13298.335083245896, 4837.782299796518, 4892.559669629751, 4936.802527898915, 4995.150824359867, 5068.6451948363265, 11420.486078126503, 11429.199956003165, 11444.885551144382, 11466.08271338291, 11473.254238474472, 5718.771249149988, 5719.513841323451, 5723.914141287884, 5732.34078081026, 5764.913526297109, 4648.0239149778245, 5077.466865979019, 5182.067227899014, 5216.26972223889, 5270.1040823060175, 4178.7283826551175, 4243.533211346749, 4373.497047839475, 4408.889777755582, 4529.38853254813, 1299.3762993762857, 1307.1503522710125, 1336.5121730568467, 1349.6828245362333, 1387.6808334083216, 1094.852194953671, 1099.9450027498754, 1101.5208384352673, 1104.0560320925654, 1120.910327173824, 6564.67176641166, 6660.333966603398, 6689.2307384651385, 6741.1236539249585, 6766.560173588701, 484.394506866417, 488.71898658271635, 492.889099952515, 493.9259111133287, 497.7237633113584, 4213.747175169438, 4304.698671092993, 4309.159713855831, 4313.590208930146, 4321.69748117635, 11722.70693232659, 11991.820122698167, 12056.87943120575, 12076.818847717292, 12156.756864862653, 12002.0, 12015.639530814089, 12015.699607509707, 12026.4588093536, 12052.216605920587, 8478.152184781473, 8781.385303028726, 8782.42914210587, 8927.196552310323, 9059.81880362389, 6610.107635469342, 6659.766908158192, 6753.189617245962, 6900.137482814648, 6910.792676219721, 10909.127269818555, 10934.945325273322, 10969.396683182182, 11037.558497660004, 11145.442727863736, 11209.0, 11329.603463878724, 11413.828792567952, 11454.312741235553, 11501.53993840237, 7958.64186111638, 8395.664173433239, 8570.78573035679, 8696.869546956927, 8744.78138046554, 9618.470984095662, 9630.27772917048, 9655.372400793925, 9683.564239609093, 9694.418334899929, 7914.16901225363, 8057.153998830273, 8346.207110324509, 8366.205210504992, 8449.619767110371, 8236.258736713724, 8243.216894395262, 8262.42163048581, 8308.418410711434, 8349.54077525742, 7301.890471642823, 7453.180150183584, 7551.471397002157, 7570.356519695888, 7605.6577454013595, 5697.8860422790485, 5711.857203569778, 5753.0, 5776.335721392094, 6040.184575082308, 5813.651180929158, 5912.379200184091, 5979.162917191684, 6003.939960600338, 6044.425779550936], "value": 4947.3027093967185, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [352.60156023693224, 353.61102786934373, 355.22029146024477, 355.3372959430661, 357.2640360856636, 5745.506168396221, 5917.112433135032, 5928.110783382494, 5930.436608522195, 5960.403959604048, 5778.0, 5781.62419442737, 5785.971070144654, 5790.536757059435, 5830.242068531085, 4321.654267658596, 4489.730616163024, 4519.706219095749, 4523.525029871866, 4547.658925580578, 4490.775461226942, 4518.1415531049, 4532.9320060199125, 4546.954530454686, 4549.0, 4485.618722408599, 4527.909441811162, 4540.727556346614, 4542.273236282195, 4549.431321084864, 4417.337399390101, 4440.800163992628, 4475.1049790042125, 4481.081378317437, 4492.348609451611, 3945.546262179829, 3961.881143565669, 3976.184882099192, 3978.701597380179, 3983.1635356575152, 5623.353314368818, 5650.660960342351, 5666.0, 5707.714614269312, 5717.514011309044, 5078.9937974500235, 5102.744862756847, 5142.845714628567, 5172.27588137661, 5172.767225474862, 6079.39206079393, 6118.724657390384, 6120.479759220471, 6125.724342404603, 6154.26148862135, 4254.681048874859, 4388.319810429389, 4393.758343291118, 4394.384786129945, 4397.714148580332, 5909.940900590982, 6132.6013809102715, 6349.365063493614, 6358.904616430757, 6387.1377364055725, 4399.406080179199, 4430.977845110754, 4437.378766972626, 4450.332450132506, 4461.152381047591, 4454.77726113693, 4467.329900514948, 4482.439695038121, 4487.169873573399, 4491.630052833917, 4942.678725882806, 5002.499750025041, 5113.8721531961255, 5149.845504634867, 5172.456892026283, 6037.607555508966, 6046.697665116727, 6066.786642671395, 6078.939210607838, 6137.693115344215, 1528.663693987321, 1546.95359139226, 1560.9609759756097, 1562.0861795849328, 1574.7637854321943, 956.636478138303, 999.3604093380243, 1008.1481148429565, 1010.7466741240809, 1014.9545967653329, 5223.477652234822, 5325.4940780625775, 5343.583950253186, 5348.679079255257, 5378.78484860609, 5493.697846618395, 5529.668219906818, 5560.193771903051, 5576.386597474275, 5576.97211513948, 5300.12547929595, 5331.226972089025, 5535.750891209825, 6017.759289628453, 6044.727987240584, 3332.7668762557523, 3365.528825964367, 3386.779859309137, 3388.8644454221553, 3394.185395505061, 6191.473724733358, 6458.418742313214, 6609.702563384659, 6618.205815302194, 6620.0, 6401.743930242831, 6467.611943283418, 6470.288268290485, 6523.18460192476, 6523.934760652428, 6325.7785977491485, 6559.934400656028, 6577.868442631217, 6606.8017959461295, 6661.0, 6283.528735344776, 6306.46395056407, 6307.571584939739, 6307.621542707452, 6329.97440818952, 6240.157578726814, 6275.090111933835, 6277.309495955533, 6281.780137695158, 6290.528210384148, 6047.304559975483, 6248.500839529878, 6391.9041214380895, 6411.96794016027, 6447.6131432114225, 4370.322599997005, 4431.7562534060935, 4460.710053846489, 4474.932876006797, 4489.753063581535, 6181.598196117238, 6265.27949285838, 6294.622322660655, 6319.8104056878365, 6418.550701450854, 6077.361877003028, 6081.422264884829, 6129.785457508966, 6140.293866205265, 6157.199564056644, 5946.940530594638, 6109.633421994695, 6134.263888333428, 6143.907841382294, 6144.078388241799, 5962.701864906824, 5979.820605381846, 6005.90991135142, 6043.8186854394435, 6073.845969265825, 6103.359147289649, 6147.44672979434, 6150.200473938359, 6177.289611694712, 6197.225346831646, 5805.622634528742, 5956.702164891824, 5989.730462129128, 6004.39956004396, 6008.24896887889], "value": 4614.510643932116, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [791.7110254757015, 812.9187081291872, 822.2229992656934, 842.0653075086657, 881.3169793410109, 16301.184940752973, 16613.750793738072, 17025.233864476097, 17327.826721732778, 17629.911850440763, 15629.452969146083, 15965.361385544564, 16036.599085022852, 16105.27526261318, 16120.75818862718, 865.355310293832, 886.4769785826361, 897.9371443998923, 898.0839543665458, 898.4609234459305, 905.3933864310927, 909.4361495872569, 911.6581282019242, 912.8539433690611, 913.2785099771173, 947.313197931501, 949.5821838391121, 950.0309684122191, 952.1906379577339, 952.6951375559823, 939.1500691873831, 942.9245660347156, 943.4905151218403, 944.475815922163, 945.0502245243555, 695.6695569604398, 696.5959743348845, 697.1146643762444, 697.8778713725078, 698.0401947322432, 16946.661066778597, 17016.149192540324, 17021.0, 17021.404250851283, 17083.65832683352, 14236.715265694731, 14341.856581434156, 14512.201828899406, 14833.258337083103, 14949.551513454613, 14194.645133871632, 14367.78448323276, 14517.128972261698, 14597.416103355854, 14819.481318153812, 4906.215005599122, 4940.209566469383, 4966.255061740731, 4966.776495057731, 4973.602111831045, 83016.16983830144, 83980.58009709913, 85375.5731221346, 86137.0, 86681.0, 12187.756244875052, 12259.908063113431, 12355.505779768708, 12471.189372690746, 12553.874461255271, 22178.889105554368, 22415.775842241695, 22560.88719556392, 22620.321390358316, 22648.207312743976, 8639.78400539979, 8722.389432739647, 8964.462132272085, 9019.458832470073, 9087.363884528151, 5158.494390661578, 5160.880525615823, 5271.288376069258, 5302.522772950453, 5390.0, 3778.4899038629433, 3898.2398432305995, 3936.075022369741, 3936.842526298973, 3937.842486300573, 653.6208998780696, 666.5134451850176, 674.7739507265023, 676.8409423785406, 693.4071368979551, 709.6558169287891, 759.6391713935836, 768.5081547809407, 780.0950896959499, 808.0182578167554, 10912.181586381053, 11078.944605276922, 11139.777204455866, 11415.714607134889, 11514.654560363202, 665.6006396162264, 696.9512134150663, 782.2607635784243, 795.2802713544252, 870.9477431354139, 4718.8584342469785, 4806.2310030394965, 4973.825916092919, 5057.519535644108, 5091.0581542414775, 87406.0, 113704.43147784208, 115709.4214528922, 115745.0, 116036.41981790206, 58967.115493267636, 61153.0, 62163.689181553804, 62292.68853655794, 104558.0, 53164.73417632964, 90469.54765226132, 92329.53835230916, 92744.0, 93532.0, 10101.79796404053, 10106.191504679755, 10175.185985121025, 10178.796424071328, 10194.184465242615, 45058.54941450543, 50885.0, 51392.45822625327, 51924.74037629788, 52432.737836310574, 72423.0, 73582.63208683922, 79709.0, 79808.20191798007, 80887.0, 12878.549250776177, 12893.93553032229, 12997.610071697864, 13019.414126364525, 13166.539171128965, 13815.654608634864, 14230.217338046506, 14311.856881431053, 14713.411463541339, 14985.325660345528, 13752.106113102616, 13906.58280251594, 13984.300784960915, 14154.858451415766, 14952.925235373754, 13893.930530347283, 14174.716505669623, 14408.927955360155, 14829.703405932038, 14873.884458665427, 13153.408096635483, 13202.933985330012, 13508.932455337661, 13645.926065916872, 13757.518486852912, 11039.282446640942, 11297.0, 11441.542338306375, 11784.410779461165, 11853.5851245206, 10975.396353200651, 11661.183717139718, 11806.704832379259, 11847.822282665938, 12053.457594408448], "value": 8008.029475683054, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1502.7, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [101.0, 111.0, 104.0, 111.0, 111.0, 111.0, 109.0, 112.0, 110.0, 109.0], "value": 108.9, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [149.0, 116.0, 150.0, 175.0, 118.0, 153.0, 148.0, 118.0, 168.0, 123.0], "value": 141.8, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [161.0, 162.0, 163.0, 161.0, 162.0, 163.0, 162.0, 161.0, 161.0, 160.0], "value": 161.6, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [74.0, 76.0, 74.0, 178.0, 75.0, 74.0, 77.0, 76.0, 172.0, 76.0], "value": 95.2, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 84.0, 159.0, 83.0, 83.0, 83.0, 146.0, 84.0, 84.0, 139.0], "value": 102.9, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [118.0, 118.0, 117.0, 117.0, 117.0, 117.0, 118.0, 117.0, 118.0, 117.0], "value": 117.4, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [147.0, 148.0, 147.0, 148.0, 146.0, 147.0, 148.0, 148.0, 148.0, 147.0], "value": 147.4, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [99.0, 95.0, 95.0, 95.0, 96.0, 95.0, 95.0, 96.0, 95.0, 95.0], "value": 95.6, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [53.0, 54.0, 54.0, 51.0, 52.0, 52.0, 56.0, 52.0, 53.0, 58.0], "value": 53.5, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [63.0, 61.0, 60.0, 60.0, 60.0, 60.0, 60.0, 61.0, 60.0, 59.0], "value": 60.4, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [73.0, 75.0, 83.0, 74.0, 73.0, 74.0, 78.0, 74.0, 73.0, 72.0], "value": 74.9, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [139.0, 118.0, 127.0, 117.0, 119.0, 131.0, 119.0, 119.0, 153.0, 131.0], "value": 127.3, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [151.0, 152.0, 155.0, 154.0, 158.0, 151.0, 153.0, 153.0, 152.0, 154.0], "value": 153.3, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [62.0, 65.0, 63.0, 63.0, 63.0, 66.0, 61.0, 61.0, 60.0, 61.0], "value": 62.5, "unit": "score"}]}]} 14:30:13 INFO - Return code: 0 14:30:13 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 14:30:13 ERROR - # TBPL SUCCESS # 14:30:13 INFO - Running post-action listener: _resource_record_post_action 14:30:13 INFO - [mozharness: 2016-09-02 21:30:13.463623Z] Finished run-tests step (success) 14:30:13 INFO - Running post-run listener: _resource_record_post_run 14:30:13 INFO - Total resource usage - Wall time: 1188s; CPU: 13.0%; Read bytes: 266240; Write bytes: 328572928; Read time: 176; Write time: 184840 14:30:13 INFO - TinderboxPrint: CPU usage
13.2% 14:30:13 INFO - TinderboxPrint: I/O read bytes / time
266,240 / 176 14:30:13 INFO - TinderboxPrint: I/O write bytes / time
328,572,928 / 184,840 14:30:13 INFO - TinderboxPrint: CPU idle
8,225.6 (86.8%) 14:30:13 INFO - TinderboxPrint: CPU user
1,197.0 (12.6%) 14:30:13 INFO - TinderboxPrint: Swap in / out
0 / 0 14:30:13 INFO - install - Wall time: 17s; CPU: 13.0%; Read bytes: 0; Write bytes: 77168640; Read time: 0; Write time: 61704 14:30:13 INFO - run-tests - Wall time: 1172s; CPU: 13.0%; Read bytes: 266240; Write bytes: 248979456; Read time: 176; Write time: 122916 14:30:14 INFO - Running post-run listener: _upload_blobber_files 14:30:14 INFO - Blob upload gear active. 14:30:14 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 14:30:14 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 14:30:14 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-Aurora', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 14:30:14 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-Aurora -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 14:30:14 INFO - (blobuploader) - INFO - Open directory for files ... 14:30:14 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 14:30:14 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 14:30:14 INFO - (blobuploader) - INFO - Uploading, attempt #1. 14:30:15 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 14:30:15 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 14:30:15 INFO - (blobuploader) - INFO - Done attempting. 14:30:15 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 14:30:15 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 14:30:15 INFO - (blobuploader) - INFO - Uploading, attempt #1. 14:30:16 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 14:30:16 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 14:30:16 INFO - (blobuploader) - INFO - Done attempting. 14:30:16 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 14:30:16 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 14:30:16 INFO - (blobuploader) - INFO - Uploading, attempt #1. 14:30:21 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 14:30:21 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 14:30:21 INFO - (blobuploader) - INFO - Done attempting. 14:30:21 INFO - (blobuploader) - INFO - Iteration through files over. 14:30:21 INFO - Return code: 0 14:30:21 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 14:30:21 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 14:30:21 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/9b1c20718d989b23df37b5387d1d65c3e146a3ad49783899107833cdf45b67e59b1a3dc89317d77c86b982a80148bce3af26f663473ea4894f1b000bc2ef2bf0", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/43e0fb55dffe6631a31cb9967946b37b0b46ffc43bbed1abd3401fb4525831994d60193e3c7af49784058d062b603a2b40b6494d422c241969dc7d8c0d942352", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/816e849e6e18e5a4b96619c1ee3ccf00ea6ae8e1ff8826ced0d4aee1531aaeb1d0fe9bebbd8851925d9ca614d465699abc84614d87031dc6bcc7776bfb9980aa"} 14:30:21 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 14:30:21 INFO - Writing to file /builds/slave/test/properties/blobber_files 14:30:21 INFO - Contents: 14:30:21 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/9b1c20718d989b23df37b5387d1d65c3e146a3ad49783899107833cdf45b67e59b1a3dc89317d77c86b982a80148bce3af26f663473ea4894f1b000bc2ef2bf0", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/43e0fb55dffe6631a31cb9967946b37b0b46ffc43bbed1abd3401fb4525831994d60193e3c7af49784058d062b603a2b40b6494d422c241969dc7d8c0d942352", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/816e849e6e18e5a4b96619c1ee3ccf00ea6ae8e1ff8826ced0d4aee1531aaeb1d0fe9bebbd8851925d9ca614d465699abc84614d87031dc6bcc7776bfb9980aa"} 14:30:21 INFO - Running post-run listener: copy_logs_to_upload_dir 14:30:21 INFO - Copying logs to upload dir... 14:30:21 INFO - mkdir: /builds/slave/test/build/upload/logs 14:30:21 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1677.218545 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 27 mins, 57 secs) (at 2016-09-02 14:30:21.374298) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-09-02 14:30:21.377472) ========= 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=41bf3e9aed84707956354da8000001c5-1472850127.773110-1745143973 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-Aurora/sha512/9b1c20718d989b23df37b5387d1d65c3e146a3ad49783899107833cdf45b67e59b1a3dc89317d77c86b982a80148bce3af26f663473ea4894f1b000bc2ef2bf0", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/43e0fb55dffe6631a31cb9967946b37b0b46ffc43bbed1abd3401fb4525831994d60193e3c7af49784058d062b603a2b40b6494d422c241969dc7d8c0d942352", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/816e849e6e18e5a4b96619c1ee3ccf00ea6ae8e1ff8826ced0d4aee1531aaeb1d0fe9bebbd8851925d9ca614d465699abc84614d87031dc6bcc7776bfb9980aa"} build_url:https://queue.taskcluster.net/v1/task/IU2O5TwdSXGE77QTrRrFYw/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011145 build_url: 'https://queue.taskcluster.net/v1/task/IU2O5TwdSXGE77QTrRrFYw/artifacts/public/build/firefox-50.0a2.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/9b1c20718d989b23df37b5387d1d65c3e146a3ad49783899107833cdf45b67e59b1a3dc89317d77c86b982a80148bce3af26f663473ea4894f1b000bc2ef2bf0", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/43e0fb55dffe6631a31cb9967946b37b0b46ffc43bbed1abd3401fb4525831994d60193e3c7af49784058d062b603a2b40b6494d422c241969dc7d8c0d942352", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/816e849e6e18e5a4b96619c1ee3ccf00ea6ae8e1ff8826ced0d4aee1531aaeb1d0fe9bebbd8851925d9ca614d465699abc84614d87031dc6bcc7776bfb9980aa"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-09-02 14:30:21.406217) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-09-02 14:30:21.406852) ========= 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=41bf3e9aed84707956354da8000001c5-1472850127.773110-1745143973 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004523 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-09-02 14:30:21.492406) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-09-02 14:30:21.493241) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-09-02 14:30:21.493941) ========= ========= Total master_lag: 0.18 =========