builder: fx-team_ubuntu64_hw_test-dromaeojs slave: talos-linux64-ix-002 starttime: 1450842924.67 results: success (0) buildid: 20151222192828 builduid: 66bcc1a022e84291a8f4f93e5cdb3c0f revision: dd26de01e3d255d6f62e679a58a0113ac1128183 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2015-12-22 19:55:24.665752) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2015-12-22 19:55:24.666253) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2015-12-22 19:55:24.666594) ========= bash -c pwd in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', 'pwd'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=dd132779db58144225c4cf24000001c8-1450840648.905810-1207728089 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False /builds/slave/test program finished with exit code 0 elapsedTime=0.006421 basedir: '/builds/slave/test' ========= master_lag: 0.02 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2015-12-22 19:55:24.691787) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-12-22 19:55:24.692181) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-12-22 19:55:24.712407) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-12-22 19:55:24.712826) ========= rm -rf properties in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['rm', '-rf', 'properties'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=dd132779db58144225c4cf24000001c8-1450840648.905810-1207728089 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004635 ========= master_lag: 0.05 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-12-22 19:55:24.764030) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-12-22 19:55:24.764353) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-12-22 19:55:24.764758) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-12-22 19:55:24.765097) ========= 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=dd132779db58144225c4cf24000001c8-1450840648.905810-1207728089 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2015-12-22 19:55:25-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 43.6M=0s 2015-12-22 19:55:25 (43.6 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.111089 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-12-22 19:55:24.891076) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-12-22 19:55:24.891464) ========= rm -rf scripts in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['rm', '-rf', 'scripts'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=dd132779db58144225c4cf24000001c8-1450840648.905810-1207728089 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.022544 ========= master_lag: 0.05 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-12-22 19:55:24.965038) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 3 secs) (at 2015-12-22 19:55:24.965424) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev dd26de01e3d255d6f62e679a58a0113ac1128183 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo integration/fx-team --rev dd26de01e3d255d6f62e679a58a0113ac1128183 --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=dd132779db58144225c4cf24000001c8-1450840648.905810-1207728089 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2015-12-22 19:55:25,293 truncating revision to first 12 chars 2015-12-22 19:55:25,293 Setting DEBUG logging. 2015-12-22 19:55:25,293 attempt 1/10 2015-12-22 19:55:25,293 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/dd26de01e3d2?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2015-12-22 19:55:28,533 unpacking tar archive at: fx-team-dd26de01e3d2/testing/mozharness/ program finished with exit code 0 elapsedTime=3.519877 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 3 secs) (at 2015-12-22 19:55:28.504173) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-12-22 19:55:28.504548) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-12-22 19:55:28.512226) ========= ========= Started tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-12-22 19:55:28.512542) ========= TinderboxPrint: script_revlink: https://hg.mozilla.org/build/mozharness/rev/production ========= Finished tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-12-22 19:55:28.513004) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 20 secs) (at 2015-12-22 19:55:28.513339) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team-Non-PGO --system-bits 64 --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team-Non-PGO in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Fx-Team-Non-PGO', '--system-bits', '64', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Fx-Team-Non-PGO'] 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=dd132779db58144225c4cf24000001c8-1450840648.905810-1207728089 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 19:55:28 INFO - MultiFileLogger online at 20151222 19:55:28 in /builds/slave/test 19:55:28 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team-Non-PGO --system-bits 64 --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team-Non-PGO 19:55:28 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 19:55:28 INFO - {'append_to_log': False, 19:55:28 INFO - 'base_work_dir': '/builds/slave/test', 19:55:28 INFO - 'blob_upload_branch': 'Fx-Team-Non-PGO', 19:55:28 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 19:55:28 INFO - 'branch': 'Fx-Team-Non-PGO', 19:55:28 INFO - 'buildbot_json_path': 'buildprops.json', 19:55:28 INFO - 'config_files': ('talos/linux_config.py',), 19:55:28 INFO - 'default_actions': ('clobber', 19:55:28 INFO - 'read-buildbot-config', 19:55:28 INFO - 'download-and-extract', 19:55:28 INFO - 'populate-webroot', 19:55:28 INFO - 'create-virtualenv', 19:55:28 INFO - 'install', 19:55:28 INFO - 'run-tests'), 19:55:28 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 19:55:28 INFO - 'download_minidump_stackwalk': True, 19:55:28 INFO - 'download_symbols': 'ondemand', 19:55:28 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 19:55:28 INFO - 'tooltool.py': '/tools/tooltool.py', 19:55:28 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 19:55:28 INFO - '/tools/misc-python/virtualenv.py')}, 19:55:28 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 19:55:28 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 19:55:28 INFO - 'installer_path': 'installer.exe', 19:55:28 INFO - 'log_level': 'info', 19:55:28 INFO - 'log_name': 'talos', 19:55:28 INFO - 'log_to_console': True, 19:55:28 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 19:55:28 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 19:55:28 INFO - 'opt_config_files': (), 19:55:28 INFO - 'pip_index': False, 19:55:28 INFO - 'sps_profile': False, 19:55:28 INFO - 'sps_profile_interval': 0, 19:55:28 INFO - 'suite': 'dromaeojs', 19:55:28 INFO - 'system_bits': '64', 19:55:28 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 19:55:28 INFO - 'title': 'talos-linux64-ix-002', 19:55:28 INFO - 'tooltool_cache': '/builds/tooltool_cache', 19:55:28 INFO - 'use_talos_json': True, 19:55:28 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 19:55:28 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 19:55:28 INFO - 'work_dir': 'build'} 19:55:28 INFO - ##### 19:55:28 INFO - ##### Running clobber step. 19:55:28 INFO - ##### 19:55:28 INFO - Running pre-action listener: _resource_record_pre_action 19:55:28 INFO - Running main action method: clobber 19:55:28 INFO - rmtree: /builds/slave/test/build 19:55:28 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 19:55:29 INFO - Running post-action listener: _resource_record_post_action 19:55:29 INFO - ##### 19:55:29 INFO - ##### Running read-buildbot-config step. 19:55:29 INFO - ##### 19:55:29 INFO - Running pre-action listener: _resource_record_pre_action 19:55:29 INFO - Running main action method: read_buildbot_config 19:55:29 INFO - Using buildbot properties: 19:55:29 INFO - { 19:55:29 INFO - "project": "", 19:55:29 INFO - "product": "firefox", 19:55:29 INFO - "script_repo_revision": "production", 19:55:29 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs", 19:55:29 INFO - "repository": "", 19:55:29 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team talos dromaeojs", 19:55:29 INFO - "buildid": "20151222192828", 19:55:29 INFO - "pgo_build": "False", 19:55:29 INFO - "basedir": "/builds/slave/test", 19:55:29 INFO - "buildnumber": 2247, 19:55:29 INFO - "slavename": "talos-linux64-ix-002", 19:55:29 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 19:55:29 INFO - "platform": "ubuntu64_hw", 19:55:29 INFO - "scheduler": "tests-fx-team-linux64-talos", 19:55:29 INFO - "branch": "fx-team", 19:55:29 INFO - "repo_path": "integration/fx-team", 19:55:29 INFO - "revision": "dd26de01e3d255d6f62e679a58a0113ac1128183", 19:55:29 INFO - "stage_platform": "linux64", 19:55:29 INFO - "builduid": "66bcc1a022e84291a8f4f93e5cdb3c0f", 19:55:29 INFO - "slavebuilddir": "test" 19:55:29 INFO - } 19:55:29 INFO - Found installer url https://queue.taskcluster.net/v1/task/zfdtHl0HRRusmlzyLqS4XQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2. 19:55:29 INFO - Running post-action listener: _resource_record_post_action 19:55:29 INFO - ##### 19:55:29 INFO - ##### Running download-and-extract step. 19:55:29 INFO - ##### 19:55:29 INFO - Running pre-action listener: _resource_record_pre_action 19:55:29 INFO - Running main action method: download_and_extract 19:55:29 INFO - mkdir: /builds/slave/test/build/tests 19:55:29 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')]} 19:55:29 INFO - https://queue.taskcluster.net/v1/task/zfdtHl0HRRusmlzyLqS4XQ/artifacts/public/build/test_packages.json matches https://queue.taskcluster.net 19:55:29 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/zfdtHl0HRRusmlzyLqS4XQ/artifacts/public/build/test_packages.json 19:55:29 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/zfdtHl0HRRusmlzyLqS4XQ/artifacts/public/build/test_packages.json 19:55:29 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/zfdtHl0HRRusmlzyLqS4XQ/artifacts/public/build/test_packages.json to /builds/slave/test/build/test_packages.json 19:55:29 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/zfdtHl0HRRusmlzyLqS4XQ/artifacts/public/build/test_packages.json', 'file_name': '/builds/slave/test/build/test_packages.json'}, attempt #1 19:55:30 INFO - Downloaded 1302 bytes. 19:55:30 INFO - Reading from file /builds/slave/test/build/test_packages.json 19:55:30 INFO - Using the following test package requirements: 19:55:30 INFO - {u'common': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'], 19:55:30 INFO - u'cppunittest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 19:55:30 INFO - u'firefox-46.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 19:55:30 INFO - u'jittest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 19:55:30 INFO - u'jsshell-linux-x86_64.zip'], 19:55:30 INFO - u'mochitest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 19:55:30 INFO - u'firefox-46.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 19:55:30 INFO - u'mozbase': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'], 19:55:30 INFO - u'reftest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 19:55:30 INFO - u'firefox-46.0a1.en-US.linux-x86_64.reftest.tests.zip'], 19:55:30 INFO - u'talos': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 19:55:30 INFO - u'firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip'], 19:55:30 INFO - u'web-platform': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 19:55:30 INFO - u'firefox-46.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 19:55:30 INFO - u'webapprt': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'], 19:55:30 INFO - u'xpcshell': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 19:55:30 INFO - u'firefox-46.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 19:55:30 INFO - Downloading packages: [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 19:55: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')]} 19:55:30 INFO - https://queue.taskcluster.net/v1/task/zfdtHl0HRRusmlzyLqS4XQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 19:55:30 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/zfdtHl0HRRusmlzyLqS4XQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 19:55:30 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/zfdtHl0HRRusmlzyLqS4XQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 19:55:30 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/zfdtHl0HRRusmlzyLqS4XQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 19:55:30 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/zfdtHl0HRRusmlzyLqS4XQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 19:55:35 INFO - Downloaded 21926924 bytes. 19:55:35 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'] in /builds/slave/test/build/tests 19:55:35 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 19:55:35 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'] with output_timeout 1760 19:55:36 INFO - Return code: 0 19:55:36 INFO - Downloading packages: [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', u'firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 19:55:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:55:36 INFO - https://queue.taskcluster.net/v1/task/zfdtHl0HRRusmlzyLqS4XQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 19:55:36 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/zfdtHl0HRRusmlzyLqS4XQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 19:55:36 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/zfdtHl0HRRusmlzyLqS4XQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 19:55:36 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/zfdtHl0HRRusmlzyLqS4XQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 19:55:36 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/zfdtHl0HRRusmlzyLqS4XQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 19:55:43 INFO - Downloaded 21926924 bytes. 19:55:43 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'] in /builds/slave/test/build/tests 19:55:43 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 19:55:43 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'] with output_timeout 1760 19:55:44 INFO - Return code: 0 19:55:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:55:44 INFO - https://queue.taskcluster.net/v1/task/zfdtHl0HRRusmlzyLqS4XQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 19:55:44 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/zfdtHl0HRRusmlzyLqS4XQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip 19:55:44 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/zfdtHl0HRRusmlzyLqS4XQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip 19:55:44 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/zfdtHl0HRRusmlzyLqS4XQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip 19:55:44 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/zfdtHl0HRRusmlzyLqS4XQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 19:55:45 INFO - Downloaded 11132277 bytes. 19:55:45 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip'] in /builds/slave/test/build/tests 19:55:45 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip 19:55:45 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip'] with output_timeout 1760 19:55:45 INFO - Return code: 0 19:55:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:55:45 INFO - https://queue.taskcluster.net/v1/task/zfdtHl0HRRusmlzyLqS4XQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 19:55:45 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/zfdtHl0HRRusmlzyLqS4XQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 19:55:45 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/zfdtHl0HRRusmlzyLqS4XQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 19:55:45 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/zfdtHl0HRRusmlzyLqS4XQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 19:55:45 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/zfdtHl0HRRusmlzyLqS4XQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2'}, attempt #1 19:55:46 INFO - Downloaded 53326767 bytes. 19:55:46 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/zfdtHl0HRRusmlzyLqS4XQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 19:55:46 INFO - mkdir: /builds/slave/test/properties 19:55:46 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 19:55:46 INFO - Writing to file /builds/slave/test/properties/build_url 19:55:46 INFO - Contents: 19:55:46 INFO - build_url:https://queue.taskcluster.net/v1/task/zfdtHl0HRRusmlzyLqS4XQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 19:55:46 INFO - Running post-action listener: _resource_record_post_action 19:55:46 INFO - Running post-action listener: set_extra_try_arguments 19:55:46 INFO - ##### 19:55:46 INFO - ##### Running populate-webroot step. 19:55:46 INFO - ##### 19:55:46 INFO - Running pre-action listener: _resource_record_pre_action 19:55:46 INFO - Running main action method: populate_webroot 19:55:46 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 19:55:46 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 19:55:46 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 19:55:46 INFO - '--tppagecycles', 19:55:46 INFO - '7'], 19:55:46 INFO - 'tests': ['tsvgm']}}, 19:55:46 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 19:55:46 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 19:55:46 INFO - 'tests': ['tresize', 'tcanvasmark']}, 19:55:46 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 19:55:46 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 19:55:46 INFO - 'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 19:55:46 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:55:46 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 19:55:46 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:55:46 INFO - 'talos_options': ['--e10s'], 19:55:46 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 19:55:46 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:55:46 INFO - 'tests': ['damp', 'tps']}, 19:55:46 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:55:46 INFO - 'talos_options': ['--e10s'], 19:55:46 INFO - 'tests': ['damp', 'tps']}, 19:55:46 INFO - 'g3': {'tests': ['dromaeo_dom']}, 19:55:46 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 19:55:46 INFO - 'other': {'tests': ['a11yr', 19:55:46 INFO - 'ts_paint', 19:55:46 INFO - 'tpaint', 19:55:46 INFO - 'sessionrestore', 19:55:46 INFO - 'sessionrestore_no_auto_restore']}, 19:55:46 INFO - 'other-e10s': {'talos_options': ['--e10s'], 19:55:46 INFO - 'tests': ['a11yr', 19:55:46 INFO - 'ts_paint', 19:55:46 INFO - 'tpaint', 19:55:46 INFO - 'sessionrestore', 19:55:46 INFO - 'sessionrestore_no_auto_restore']}, 19:55:46 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 19:55:46 INFO - 'tests': ['a11yr', 19:55:46 INFO - 'ts_paint', 19:55:46 INFO - 'tpaint', 19:55:46 INFO - 'sessionrestore', 19:55:46 INFO - 'sessionrestore_no_auto_restore']}, 19:55:46 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 19:55:46 INFO - 'tests': ['a11yr', 19:55:46 INFO - 'ts_paint', 19:55:46 INFO - 'tpaint', 19:55:46 INFO - 'sessionrestore', 19:55:46 INFO - 'sessionrestore_no_auto_restore']}, 19:55:46 INFO - 'other_l64': {'tests': ['a11yr', 19:55:46 INFO - 'ts_paint', 19:55:46 INFO - 'tpaint', 19:55:46 INFO - 'sessionrestore', 19:55:46 INFO - 'sessionrestore_no_auto_restore']}, 19:55:46 INFO - 'other_nol64': {'tests': ['a11yr', 19:55:46 INFO - 'ts_paint', 19:55:46 INFO - 'tpaint', 19:55:46 INFO - 'sessionrestore', 19:55:46 INFO - 'sessionrestore_no_auto_restore']}, 19:55:46 INFO - 'svgr': {'tests': ['tsvgx', 19:55:46 INFO - 'tsvgr_opacity', 19:55:46 INFO - 'tart', 19:55:46 INFO - 'tscrollx', 19:55:46 INFO - 'cart']}, 19:55:46 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 19:55:46 INFO - 'tests': ['tsvgx', 19:55:46 INFO - 'tsvgr_opacity', 19:55:46 INFO - 'tart', 19:55:46 INFO - 'tscrollx', 19:55:46 INFO - 'cart']}, 19:55:46 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:55:46 INFO - 'tests': ['tp5o']}, 19:55:46 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:55:46 INFO - 'talos_options': ['--e10s'], 19:55:46 INFO - 'tests': ['tp5o']}, 19:55:46 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:55:46 INFO - 'talos_options': ['--xperf_path', 19:55:46 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 19:55:46 INFO - 'tests': ['tp5n']}, 19:55:46 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:55:46 INFO - 'talos_options': ['--e10s', 19:55:46 INFO - '--xperf_path', 19:55:46 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 19:55:46 INFO - 'tests': ['tp5n']}}, 19:55:46 INFO - 'talos.zip': {'path': '', 19:55:46 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 19:55:46 INFO - Running post-action listener: _resource_record_post_action 19:55:46 INFO - ##### 19:55:46 INFO - ##### Running create-virtualenv step. 19:55:46 INFO - ##### 19:55:46 INFO - Running pre-action listener: _resource_record_pre_action 19:55:46 INFO - Running main action method: create_virtualenv 19:55:46 INFO - Creating virtualenv /builds/slave/test/build/venv 19:55:46 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 19:55:46 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 19:55:46 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 19:55:46 INFO - Using real prefix '/usr' 19:55:46 INFO - New python executable in /builds/slave/test/build/venv/bin/python 19:55:47 INFO - Installing distribute.............................................................................................................................................................................................done. 19:55:49 INFO - Installing pip.................done. 19:55:49 INFO - Return code: 0 19:55:49 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 19:55:49 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')]} 19:55:49 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:55:49 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:55:49 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')]} 19:55:49 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:55:49 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:55:49 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--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 0x7fc6e0fa6f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25d08a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x269fdd0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27323d0>, '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 0x269ded0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x269e360>, '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': 'dd132779db58144225c4cf24000001c8-1450840648.905810-1207728089', '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 19:55:49 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--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 19:55:49 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --download-cache /builds/slave/test/build/venv/cache --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 19:55:49 INFO - Using env: {'DISPLAY': ':0', 19:55:49 INFO - 'HOME': '/home/cltbld', 19:55:49 INFO - 'LANG': 'en_US.UTF-8', 19:55:49 INFO - 'LANGUAGE': 'en_US:en', 19:55:49 INFO - 'LOGNAME': 'cltbld', 19:55:49 INFO - 'MAIL': '/var/mail/cltbld', 19:55:49 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:55:49 INFO - 'MOZ_NO_REMOTE': '1', 19:55:49 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:55:49 INFO - 'NO_EM_RESTART': '1', 19:55:49 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:55:49 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:55:49 INFO - 'PWD': '/builds/slave/test', 19:55:49 INFO - 'SHELL': '/bin/bash', 19:55:49 INFO - 'SHLVL': '1', 19:55:49 INFO - 'TERM': 'linux', 19:55:49 INFO - 'TMOUT': '86400', 19:55:49 INFO - 'USER': 'cltbld', 19:55:49 INFO - 'XDG_SESSION_COOKIE': 'dd132779db58144225c4cf24000001c8-1450840648.905810-1207728089', 19:55:49 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:55:49 INFO - '_': '/tools/buildbot/bin/python'} 19:55:49 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:55:49 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 19:55:49 INFO - Cleaning up... 19:55:49 INFO - Return code: 0 19:55:49 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 19:55:49 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')]} 19:55:49 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:55:49 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:55:49 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')]} 19:55:49 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:55:49 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:55:49 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=0.7.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc6e0fa6f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25d08a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x269fdd0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27323d0>, '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 0x269ded0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x269e360>, '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': 'dd132779db58144225c4cf24000001c8-1450840648.905810-1207728089', '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 19:55:49 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=0.7.1'] in /builds/slave/test/build 19:55:49 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --download-cache /builds/slave/test/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=0.7.1 19:55:49 INFO - Using env: {'DISPLAY': ':0', 19:55:49 INFO - 'HOME': '/home/cltbld', 19:55:49 INFO - 'LANG': 'en_US.UTF-8', 19:55:49 INFO - 'LANGUAGE': 'en_US:en', 19:55:49 INFO - 'LOGNAME': 'cltbld', 19:55:49 INFO - 'MAIL': '/var/mail/cltbld', 19:55:49 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:55:49 INFO - 'MOZ_NO_REMOTE': '1', 19:55:49 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:55:49 INFO - 'NO_EM_RESTART': '1', 19:55:49 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:55:49 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:55:49 INFO - 'PWD': '/builds/slave/test', 19:55:49 INFO - 'SHELL': '/bin/bash', 19:55:49 INFO - 'SHLVL': '1', 19:55:49 INFO - 'TERM': 'linux', 19:55:49 INFO - 'TMOUT': '86400', 19:55:49 INFO - 'USER': 'cltbld', 19:55:49 INFO - 'XDG_SESSION_COOKIE': 'dd132779db58144225c4cf24000001c8-1450840648.905810-1207728089', 19:55:49 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:55:49 INFO - '_': '/tools/buildbot/bin/python'} 19:55:49 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:55:49 INFO - Downloading/unpacking psutil>=0.7.1 19:55:49 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:55:49 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:55:49 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:55:49 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:55:49 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:55:49 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:55:51 INFO - Creating supposed download cache at /builds/slave/test/build/venv/cache 19:55:51 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpsutil-3.1.1.tar.gz 19:55:51 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 19:55:51 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 19:55:51 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 19:55:51 INFO - Installing collected packages: psutil 19:55:51 INFO - Running setup.py install for psutil 19:55:51 INFO - building 'psutil._psutil_linux' extension 19:55:51 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 19:55:51 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 19:55:51 INFO - building 'psutil._psutil_posix' extension 19:55:51 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 19:55:51 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 19:55:52 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 19:55:52 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 19:55:52 INFO - Successfully installed psutil 19:55:52 INFO - Cleaning up... 19:55:52 INFO - Return code: 0 19:55:52 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 19:55:52 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')]} 19:55:52 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:55:52 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:55:52 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')]} 19:55:52 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:55:52 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:55:52 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.0.0']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc6e0fa6f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25d08a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x269fdd0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27323d0>, '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 0x269ded0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x269e360>, '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': 'dd132779db58144225c4cf24000001c8-1450840648.905810-1207728089', '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 19:55:52 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.0.0'] in /builds/slave/test/build 19:55:52 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --download-cache /builds/slave/test/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.0.0 19:55:52 INFO - Using env: {'DISPLAY': ':0', 19:55:52 INFO - 'HOME': '/home/cltbld', 19:55:52 INFO - 'LANG': 'en_US.UTF-8', 19:55:52 INFO - 'LANGUAGE': 'en_US:en', 19:55:52 INFO - 'LOGNAME': 'cltbld', 19:55:52 INFO - 'MAIL': '/var/mail/cltbld', 19:55:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:55:52 INFO - 'MOZ_NO_REMOTE': '1', 19:55:52 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:55:52 INFO - 'NO_EM_RESTART': '1', 19:55:52 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:55:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:55:52 INFO - 'PWD': '/builds/slave/test', 19:55:52 INFO - 'SHELL': '/bin/bash', 19:55:52 INFO - 'SHLVL': '1', 19:55:52 INFO - 'TERM': 'linux', 19:55:52 INFO - 'TMOUT': '86400', 19:55:52 INFO - 'USER': 'cltbld', 19:55:52 INFO - 'XDG_SESSION_COOKIE': 'dd132779db58144225c4cf24000001c8-1450840648.905810-1207728089', 19:55:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:55:52 INFO - '_': '/tools/buildbot/bin/python'} 19:55:52 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:55:52 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 19:55:52 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 19:55:52 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 19:55:52 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 19:55:52 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 19:55:52 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 19:55:52 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 19:55:53 INFO - Downloading mozsystemmonitor-0.0.tar.gz 19:55:53 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fmozsystemmonitor-0.0.tar.gz 19:55:53 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 19:55:54 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 19:55:54 INFO - Installing collected packages: mozsystemmonitor 19:55:54 INFO - Running setup.py install for mozsystemmonitor 19:55:54 INFO - Successfully installed mozsystemmonitor 19:55:54 INFO - Cleaning up... 19:55:54 INFO - Return code: 0 19:55:54 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 19:55:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:55:54 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:55:54 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:55:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:55:54 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:55:54 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:55:54 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--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 0x7fc6e0fa6f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25d08a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x269fdd0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27323d0>, '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 0x269ded0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x269e360>, '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': 'dd132779db58144225c4cf24000001c8-1450840648.905810-1207728089', '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 19:55:54 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--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 19:55:54 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --download-cache /builds/slave/test/build/venv/cache --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 19:55:54 INFO - Using env: {'DISPLAY': ':0', 19:55:54 INFO - 'HOME': '/home/cltbld', 19:55:54 INFO - 'LANG': 'en_US.UTF-8', 19:55:54 INFO - 'LANGUAGE': 'en_US:en', 19:55:54 INFO - 'LOGNAME': 'cltbld', 19:55:54 INFO - 'MAIL': '/var/mail/cltbld', 19:55:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:55:54 INFO - 'MOZ_NO_REMOTE': '1', 19:55:54 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:55:54 INFO - 'NO_EM_RESTART': '1', 19:55:54 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:55:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:55:54 INFO - 'PWD': '/builds/slave/test', 19:55:54 INFO - 'SHELL': '/bin/bash', 19:55:54 INFO - 'SHLVL': '1', 19:55:54 INFO - 'TERM': 'linux', 19:55:54 INFO - 'TMOUT': '86400', 19:55:54 INFO - 'USER': 'cltbld', 19:55:54 INFO - 'XDG_SESSION_COOKIE': 'dd132779db58144225c4cf24000001c8-1450840648.905810-1207728089', 19:55:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:55:54 INFO - '_': '/tools/buildbot/bin/python'} 19:55:54 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:55:54 INFO - Downloading/unpacking blobuploader==1.2.4 19:55:54 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:55:54 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:55:54 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:55:54 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:55:54 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:55:54 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:55:56 INFO - Downloading blobuploader-1.2.4.tar.gz 19:55:56 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fblobuploader-1.2.4.tar.gz 19:55:56 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 19:55:56 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 19:55:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:55:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:55:56 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:55:56 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:55:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:55:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:55:56 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Frequests-1.2.3.tar.gz 19:55:56 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 19:55:56 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 19:55:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:55:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:55:56 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:55:56 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:55:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:55:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:55:56 INFO - Downloading docopt-0.6.1.tar.gz 19:55:56 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fdocopt-0.6.1.tar.gz 19:55:56 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 19:55:56 INFO - Installing collected packages: blobuploader, requests, docopt 19:55:56 INFO - Running setup.py install for blobuploader 19:55:56 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 19:55:56 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 19:55:56 INFO - Running setup.py install for requests 19:55:57 INFO - Running setup.py install for docopt 19:55:57 INFO - Successfully installed blobuploader requests docopt 19:55:57 INFO - Cleaning up... 19:55:57 INFO - Return code: 0 19:55:57 INFO - Installing None into virtualenv /builds/slave/test/build/venv 19:55:57 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')]} 19:55:57 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:55:57 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:55:57 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')]} 19:55:57 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:55:57 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:55:57 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--download-cache', '/builds/slave/test/build/venv/cache', '--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 0x7fc6e0fa6f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25d08a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x269fdd0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27323d0>, '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 0x269ded0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x269e360>, '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': 'dd132779db58144225c4cf24000001c8-1450840648.905810-1207728089', '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 19:55:57 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--download-cache', '/builds/slave/test/build/venv/cache', '--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 19:55:57 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --download-cache /builds/slave/test/build/venv/cache --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 19:55:57 INFO - Using env: {'DISPLAY': ':0', 19:55:57 INFO - 'HOME': '/home/cltbld', 19:55:57 INFO - 'LANG': 'en_US.UTF-8', 19:55:57 INFO - 'LANGUAGE': 'en_US:en', 19:55:57 INFO - 'LOGNAME': 'cltbld', 19:55:57 INFO - 'MAIL': '/var/mail/cltbld', 19:55:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:55:57 INFO - 'MOZ_NO_REMOTE': '1', 19:55:57 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:55:57 INFO - 'NO_EM_RESTART': '1', 19:55:57 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:55:57 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:55:57 INFO - 'PWD': '/builds/slave/test', 19:55:57 INFO - 'SHELL': '/bin/bash', 19:55:57 INFO - 'SHLVL': '1', 19:55:57 INFO - 'TERM': 'linux', 19:55:57 INFO - 'TMOUT': '86400', 19:55:57 INFO - 'USER': 'cltbld', 19:55:57 INFO - 'XDG_SESSION_COOKIE': 'dd132779db58144225c4cf24000001c8-1450840648.905810-1207728089', 19:55:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:55:57 INFO - '_': '/tools/buildbot/bin/python'} 19:55:57 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:55:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 19:55:57 INFO - Running setup.py (path:/tmp/pip-bupFuh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 19:55:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 19:55:57 INFO - Running setup.py (path:/tmp/pip-lpSB5r-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 19:55:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 19:55:57 INFO - Running setup.py (path:/tmp/pip-xlffmI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 19:55:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 19:55:57 INFO - Running setup.py (path:/tmp/pip-Z7gU2c-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 19:55:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 19:55:57 INFO - Running setup.py (path:/tmp/pip-gfvtWv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 19:55:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 19:55:57 INFO - Running setup.py (path:/tmp/pip-AVUq7D-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 19:55:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 19:55:58 INFO - Running setup.py (path:/tmp/pip-PH3xZk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 19:55:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 19:55:58 INFO - Running setup.py (path:/tmp/pip-G49nbu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 19:55:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 19:55:58 INFO - Running setup.py (path:/tmp/pip-fiX61_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 19:55:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 19:55:58 INFO - Running setup.py (path:/tmp/pip-plAoot-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 19:55:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 19:55:58 INFO - Running setup.py (path:/tmp/pip-xo2tqe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 19:55:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 19:55:58 INFO - Running setup.py (path:/tmp/pip-mrfO5g-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 19:55:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 19:55:58 INFO - Running setup.py (path:/tmp/pip-lU0HdO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 19:55:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 19:55:58 INFO - Running setup.py (path:/tmp/pip-88FZIb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 19:55:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 19:55:58 INFO - Running setup.py (path:/tmp/pip-FLe7J3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 19:55:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 19:55:58 INFO - Running setup.py (path:/tmp/pip-1fs6Lq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 19:55:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 19:55:58 INFO - Running setup.py (path:/tmp/pip-q6ykFt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 19:55:58 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 19:55:58 INFO - Running setup.py install for manifestparser 19:55:58 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 19:55:58 INFO - Running setup.py install for mozcrash 19:55:59 INFO - Running setup.py install for mozdebug 19:55:59 INFO - Running setup.py install for mozdevice 19:55:59 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 19:55:59 INFO - Installing dm script to /builds/slave/test/build/venv/bin 19:55:59 INFO - Running setup.py install for mozfile 19:55:59 INFO - Running setup.py install for mozhttpd 19:55:59 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 19:55:59 INFO - Running setup.py install for mozinfo 19:55:59 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 19:55:59 INFO - Running setup.py install for mozInstall 19:55:59 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 19:55:59 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 19:55:59 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 19:55:59 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 19:55:59 INFO - Running setup.py install for mozleak 19:55:59 INFO - Running setup.py install for mozlog 19:55:59 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 19:55:59 INFO - Running setup.py install for moznetwork 19:55:59 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 19:55:59 INFO - Running setup.py install for mozprocess 19:56:00 INFO - Running setup.py install for mozprofile 19:56:00 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 19:56:00 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 19:56:00 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 19:56:00 INFO - Running setup.py install for mozrunner 19:56:00 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 19:56:00 INFO - Running setup.py install for mozscreenshot 19:56:00 INFO - Running setup.py install for moztest 19:56:00 INFO - Running setup.py install for mozversion 19:56:00 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 19:56:00 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 19:56:00 INFO - Cleaning up... 19:56:00 INFO - Return code: 0 19:56:00 INFO - Installing None into virtualenv /builds/slave/test/build/venv 19:56:00 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')]} 19:56:00 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:56:00 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:56:00 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')]} 19:56:00 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:56:00 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:56:00 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--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 0x7fc6e0fa6f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25d08a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x269fdd0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27323d0>, '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 0x269ded0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x269e360>, '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': 'dd132779db58144225c4cf24000001c8-1450840648.905810-1207728089', '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 19:56:00 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--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 19:56:00 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --download-cache /builds/slave/test/build/venv/cache --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 19:56:00 INFO - Using env: {'DISPLAY': ':0', 19:56:00 INFO - 'HOME': '/home/cltbld', 19:56:00 INFO - 'LANG': 'en_US.UTF-8', 19:56:00 INFO - 'LANGUAGE': 'en_US:en', 19:56:00 INFO - 'LOGNAME': 'cltbld', 19:56:00 INFO - 'MAIL': '/var/mail/cltbld', 19:56:00 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:56:00 INFO - 'MOZ_NO_REMOTE': '1', 19:56:00 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:56:00 INFO - 'NO_EM_RESTART': '1', 19:56:00 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:56:00 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:56:00 INFO - 'PWD': '/builds/slave/test', 19:56:00 INFO - 'SHELL': '/bin/bash', 19:56:00 INFO - 'SHLVL': '1', 19:56:00 INFO - 'TERM': 'linux', 19:56:00 INFO - 'TMOUT': '86400', 19:56:00 INFO - 'USER': 'cltbld', 19:56:00 INFO - 'XDG_SESSION_COOKIE': 'dd132779db58144225c4cf24000001c8-1450840648.905810-1207728089', 19:56:00 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:56:00 INFO - '_': '/tools/buildbot/bin/python'} 19:56:00 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:56:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 19:56:00 INFO - Running setup.py (path:/tmp/pip-_5ghFK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 19:56:00 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)) 19:56:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 19:56:00 INFO - Running setup.py (path:/tmp/pip-ARSlj2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 19:56:00 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.16 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)) 19:56:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 19:56:01 INFO - Running setup.py (path:/tmp/pip-IWKhHq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 19:56:01 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)) 19:56:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 19:56:01 INFO - Running setup.py (path:/tmp/pip-usQwiq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 19:56:01 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.47 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)) 19:56:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 19:56:01 INFO - Running setup.py (path:/tmp/pip-LiftLe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 19:56:01 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)) 19:56:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 19:56:01 INFO - Running setup.py (path:/tmp/pip-u1B359-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 19:56:01 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)) 19:56:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 19:56:01 INFO - Running setup.py (path:/tmp/pip-q5P5zg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 19:56:01 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)) 19:56:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 19:56:01 INFO - Running setup.py (path:/tmp/pip-8al6dc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 19:56:01 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)) 19:56:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 19:56:01 INFO - Running setup.py (path:/tmp/pip-2qlZH3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 19:56:01 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)) 19:56:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 19:56:01 INFO - Running setup.py (path:/tmp/pip-RrWaZC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 19:56:01 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.1 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 19:56:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 19:56:01 INFO - Running setup.py (path:/tmp/pip-yiZzvj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 19:56:01 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)) 19:56:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 19:56:01 INFO - Running setup.py (path:/tmp/pip-Ez0Y0J-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 19:56:01 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.22 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 19:56:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 19:56:01 INFO - Running setup.py (path:/tmp/pip-bAOFn0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 19:56:01 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)) 19:56:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 19:56:01 INFO - Running setup.py (path:/tmp/pip-5xzWu5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 19:56:01 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.11 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 19:56:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 19:56:01 INFO - Running setup.py (path:/tmp/pip-GcGBg7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 19:56:01 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)) 19:56:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 19:56:01 INFO - Running setup.py (path:/tmp/pip-5oERDj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 19:56:02 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)) 19:56:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 19:56:02 INFO - Running setup.py (path:/tmp/pip-kNS8nb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 19:56:02 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)) 19:56:02 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.16->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 19:56:02 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.16->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 19:56:02 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)) 19:56:02 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.47->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 19:56:02 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.47->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 19:56:02 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 19:56:02 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 19:56:02 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 19:56:02 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 19:56:02 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 19:56:02 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 19:56:02 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 19:56:03 INFO - Downloading blessings-1.5.1.tar.gz 19:56:03 INFO - Storing download in cache at /builds/slave/test/build/venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fblessings-1.5.1.tar.gz 19:56:03 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 19:56:03 INFO - Installing collected packages: blessings 19:56:03 INFO - Running setup.py install for blessings 19:56:03 INFO - Successfully installed blessings 19:56:03 INFO - Cleaning up... 19:56:04 INFO - Return code: 0 19:56:04 INFO - Done creating virtualenv /builds/slave/test/build/venv. 19:56:04 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 19:56:04 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 19:56:04 INFO - Reading from file tmpfile_stdout 19:56:04 INFO - Current package versions: 19:56:04 INFO - argparse == 1.2.1 19:56:04 INFO - blessings == 1.5.1 19:56:04 INFO - blobuploader == 1.2.4 19:56:04 INFO - docopt == 0.6.1 19:56:04 INFO - manifestparser == 1.1 19:56:04 INFO - mozInstall == 1.12 19:56:04 INFO - mozcrash == 0.16 19:56:04 INFO - mozdebug == 0.1 19:56:04 INFO - mozdevice == 0.47 19:56:04 INFO - mozfile == 1.2 19:56:04 INFO - mozhttpd == 0.7 19:56:04 INFO - mozinfo == 0.9 19:56:04 INFO - mozleak == 0.1 19:56:04 INFO - mozlog == 3.1 19:56:04 INFO - moznetwork == 0.27 19:56:04 INFO - mozprocess == 0.22 19:56:04 INFO - mozprofile == 0.28 19:56:04 INFO - mozrunner == 6.11 19:56:04 INFO - mozscreenshot == 0.1 19:56:04 INFO - mozsystemmonitor == 0.0 19:56:04 INFO - moztest == 0.7 19:56:04 INFO - mozversion == 1.4 19:56:04 INFO - psutil == 3.1.1 19:56:04 INFO - requests == 1.2.3 19:56:04 INFO - wsgiref == 0.1.2 19:56:04 INFO - Installing None into virtualenv /builds/slave/test/build/venv 19:56:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:56:04 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:56:04 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:56:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:56:04 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:56:04 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:56:04 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--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 0x7fc6e0fa6f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25d08a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x269fdd0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27323d0>, '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 0x269ded0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x269e360>, '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': 'dd132779db58144225c4cf24000001c8-1450840648.905810-1207728089', '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 19:56:04 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--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 19:56:04 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --download-cache /builds/slave/test/build/venv/cache --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 19:56:04 INFO - Using env: {'DISPLAY': ':0', 19:56:04 INFO - 'HOME': '/home/cltbld', 19:56:04 INFO - 'LANG': 'en_US.UTF-8', 19:56:04 INFO - 'LANGUAGE': 'en_US:en', 19:56:04 INFO - 'LOGNAME': 'cltbld', 19:56:04 INFO - 'MAIL': '/var/mail/cltbld', 19:56:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:56:04 INFO - 'MOZ_NO_REMOTE': '1', 19:56:04 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:56:04 INFO - 'NO_EM_RESTART': '1', 19:56:04 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:56:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:56:04 INFO - 'PWD': '/builds/slave/test', 19:56:04 INFO - 'SHELL': '/bin/bash', 19:56:04 INFO - 'SHLVL': '1', 19:56:04 INFO - 'TERM': 'linux', 19:56:04 INFO - 'TMOUT': '86400', 19:56:04 INFO - 'USER': 'cltbld', 19:56:04 INFO - 'XDG_SESSION_COOKIE': 'dd132779db58144225c4cf24000001c8-1450840648.905810-1207728089', 19:56:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:56:04 INFO - '_': '/tools/buildbot/bin/python'} 19:56:04 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:56:04 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)) 19:56:04 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)) 19:56:04 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)) 19:56:04 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)) 19:56:04 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)) 19:56:04 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)) 19:56:04 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)) 19:56:04 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)) 19:56:04 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)) 19:56:04 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)) 19:56:04 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)) 19:56:04 INFO - Cleaning up... 19:56:04 INFO - Return code: 0 19:56:04 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 19:56:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:56:04 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:56:04 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:56:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:56:04 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:56:04 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:56:04 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--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 0x7fc6e0fa6f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25d08a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x269fdd0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27323d0>, '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 0x269ded0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x269e360>, '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': 'dd132779db58144225c4cf24000001c8-1450840648.905810-1207728089', '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 19:56:04 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--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 19:56:04 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --download-cache /builds/slave/test/build/venv/cache --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 19:56:04 INFO - Using env: {'DISPLAY': ':0', 19:56:04 INFO - 'HOME': '/home/cltbld', 19:56:04 INFO - 'LANG': 'en_US.UTF-8', 19:56:04 INFO - 'LANGUAGE': 'en_US:en', 19:56:04 INFO - 'LOGNAME': 'cltbld', 19:56:04 INFO - 'MAIL': '/var/mail/cltbld', 19:56:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:56:04 INFO - 'MOZ_NO_REMOTE': '1', 19:56:04 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:56:04 INFO - 'NO_EM_RESTART': '1', 19:56:04 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:56:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:56:04 INFO - 'PWD': '/builds/slave/test', 19:56:04 INFO - 'SHELL': '/bin/bash', 19:56:04 INFO - 'SHLVL': '1', 19:56:04 INFO - 'TERM': 'linux', 19:56:04 INFO - 'TMOUT': '86400', 19:56:04 INFO - 'USER': 'cltbld', 19:56:04 INFO - 'XDG_SESSION_COOKIE': 'dd132779db58144225c4cf24000001c8-1450840648.905810-1207728089', 19:56:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:56:04 INFO - '_': '/tools/buildbot/bin/python'} 19:56:04 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:56:04 INFO - Downloading/unpacking jsonschema 19:56:04 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 19:56:04 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 19:56:04 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 19:56:04 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 19:56:04 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 19:56:04 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 19:56:06 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 19:56:06 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fjsonschema-2.5.1-py2.py3-none-any.whl 19:56:06 INFO - Downloading/unpacking functools32 (from jsonschema) 19:56:06 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 19:56:06 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 19:56:06 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 19:56:06 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 19:56:06 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 19:56:06 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 19:56:06 INFO - Downloading functools32-3.2.3-2.tar.gz 19:56:06 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Ffunctools32-3.2.3-2.tar.gz 19:56:06 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 19:56:06 INFO - warning: no files found matching '*.txt' 19:56:06 INFO - no previously-included directories found matching 'build' 19:56:06 INFO - no previously-included directories found matching 'dist' 19:56:06 INFO - no previously-included directories found matching '.git*' 19:56:06 INFO - Installing collected packages: jsonschema, functools32 19:56:06 INFO - Running setup.py install for functools32 19:56:06 INFO - warning: no files found matching '*.txt' 19:56:06 INFO - no previously-included directories found matching 'build' 19:56:06 INFO - no previously-included directories found matching 'dist' 19:56:06 INFO - no previously-included directories found matching '.git*' 19:56:06 INFO - Successfully installed jsonschema functools32 19:56:06 INFO - Cleaning up... 19:56:06 INFO - Return code: 0 19:56:06 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 19:56:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:56:06 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:56:06 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:56:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:56:06 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:56:06 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:56:06 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc6e0fa6f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25d08a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x269fdd0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27323d0>, '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 0x269ded0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x269e360>, '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': 'dd132779db58144225c4cf24000001c8-1450840648.905810-1207728089', '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 19:56:06 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8'] in /builds/slave/test/build 19:56:06 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --download-cache /builds/slave/test/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub flake8 19:56:06 INFO - Using env: {'DISPLAY': ':0', 19:56:06 INFO - 'HOME': '/home/cltbld', 19:56:06 INFO - 'LANG': 'en_US.UTF-8', 19:56:06 INFO - 'LANGUAGE': 'en_US:en', 19:56:06 INFO - 'LOGNAME': 'cltbld', 19:56:06 INFO - 'MAIL': '/var/mail/cltbld', 19:56:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:56:06 INFO - 'MOZ_NO_REMOTE': '1', 19:56:06 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:56:06 INFO - 'NO_EM_RESTART': '1', 19:56:06 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:56:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:56:06 INFO - 'PWD': '/builds/slave/test', 19:56:06 INFO - 'SHELL': '/bin/bash', 19:56:06 INFO - 'SHLVL': '1', 19:56:06 INFO - 'TERM': 'linux', 19:56:06 INFO - 'TMOUT': '86400', 19:56:06 INFO - 'USER': 'cltbld', 19:56:06 INFO - 'XDG_SESSION_COOKIE': 'dd132779db58144225c4cf24000001c8-1450840648.905810-1207728089', 19:56:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:56:06 INFO - '_': '/tools/buildbot/bin/python'} 19:56:07 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:56:07 INFO - Downloading/unpacking flake8 19:56:07 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 19:56:07 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 19:56:07 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 19:56:07 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 19:56:07 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 19:56:07 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 19:56:08 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 19:56:08 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fflake8-2.5.0-py2.py3-none-any.whl 19:56:08 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 19:56: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 19:56: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 19:56: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 19:56: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 19:56: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 19:56: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 19:56:08 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 19:56:08 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fmccabe-0.3.1-py2.py3-none-any.whl 19:56:08 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 19:56: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 19:56: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 19:56: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 19:56: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 19:56: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 19:56: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 19:56:09 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpyflakes-1.0.0-py2.py3-none-any.whl 19:56:09 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 19:56:09 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 19:56:09 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 19:56:09 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 19:56:09 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 19:56:09 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 19:56:09 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 19:56:09 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpep8-1.5.7.tar.gz 19:56:09 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 19:56:09 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 19:56:09 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 19:56:09 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 19:56:09 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 19:56:09 INFO - no previously-included directories found matching 'docs/_build' 19:56:09 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 19:56:09 INFO - Running setup.py install for pep8 19:56:09 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 19:56:09 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 19:56:09 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 19:56:09 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 19:56:09 INFO - no previously-included directories found matching 'docs/_build' 19:56:09 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 19:56:09 INFO - Successfully installed flake8 mccabe pyflakes pep8 19:56:09 INFO - Cleaning up... 19:56:09 INFO - Return code: 0 19:56:09 INFO - Running post-action listener: _resource_record_post_action 19:56:09 INFO - Running post-action listener: _start_resource_monitoring 19:56:09 INFO - Starting resource monitoring. 19:56:09 INFO - ##### 19:56:09 INFO - ##### Running install step. 19:56:09 INFO - ##### 19:56:09 INFO - Running pre-action listener: _resource_record_pre_action 19:56:09 INFO - Running main action method: install 19:56:09 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 19:56:09 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 19:56:09 INFO - Reading from file tmpfile_stdout 19:56:09 INFO - Detecting whether we're running mozinstall >=1.0... 19:56:09 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 19:56:09 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 19:56:09 INFO - Reading from file tmpfile_stdout 19:56:09 INFO - Output received: 19:56:09 INFO - Usage: mozinstall [options] installer 19:56:09 INFO - Options: 19:56:09 INFO - -h, --help show this help message and exit 19:56:09 INFO - -d DEST, --destination=DEST 19:56:09 INFO - Directory to install application into. [default: 19:56:09 INFO - "/builds/slave/test"] 19:56:09 INFO - --app=APP Application being installed. [default: firefox] 19:56:09 INFO - mkdir: /builds/slave/test/build/application 19:56:09 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 19:56:09 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 19:56:25 INFO - Reading from file tmpfile_stdout 19:56:25 INFO - Output received: 19:56:25 INFO - /builds/slave/test/build/application/firefox/firefox 19:56:25 INFO - Running post-action listener: _resource_record_post_action 19:56:25 INFO - ##### 19:56:25 INFO - ##### Running run-tests step. 19:56:25 INFO - ##### 19:56:25 INFO - Running pre-action listener: _resource_record_pre_action 19:56:25 INFO - Running main action method: run_tests 19:56:25 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 19:56:25 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 19:56:25 INFO - Python 2.7.3 19:56:25 INFO - Return code: 0 19:56:25 INFO - grabbing minidump binary from tooltool 19:56:25 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:56:25 INFO - retry: Calling run_command with args: (['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'],), kwargs: {'error_list': [{'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27323d0>, '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 0x269ded0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x269e360>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 19:56:25 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 19:56:25 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 19:56:25 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 19:56:25 INFO - Return code: 0 19:56:25 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 19:56:25 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 19:56:25 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 19:56:25 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 19:56:25 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 19:56:25 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 19:56:25 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 19:56:26 INFO - Return code: 0 19:56:26 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team-Non-PGO', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/zfdtHl0HRRusmlzyLqS4XQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-002', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] in /builds/slave/test/build 19:56:26 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Fx-Team-Non-PGO --suite dromaeojs --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/zfdtHl0HRRusmlzyLqS4XQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-002 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log 19:56:26 INFO - Using env: {'DISPLAY': ':0', 19:56:26 INFO - 'HOME': '/home/cltbld', 19:56:26 INFO - 'LANG': 'en_US.UTF-8', 19:56:26 INFO - 'LANGUAGE': 'en_US:en', 19:56:26 INFO - 'LOGNAME': 'cltbld', 19:56:26 INFO - 'MAIL': '/var/mail/cltbld', 19:56:26 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 19:56:26 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 19:56:26 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:56:26 INFO - 'MOZ_NO_REMOTE': '1', 19:56:26 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 19:56:26 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:56:26 INFO - 'NO_EM_RESTART': '1', 19:56:26 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:56:26 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:56:26 INFO - 'PWD': '/builds/slave/test', 19:56:26 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 19:56:26 INFO - 'SHELL': '/bin/bash', 19:56:26 INFO - 'SHLVL': '1', 19:56:26 INFO - 'TERM': 'linux', 19:56:26 INFO - 'TMOUT': '86400', 19:56:26 INFO - 'USER': 'cltbld', 19:56:26 INFO - 'XDG_SESSION_COOKIE': 'dd132779db58144225c4cf24000001c8-1450840648.905810-1207728089', 19:56:26 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:56:26 INFO - '_': '/tools/buildbot/bin/python'} 19:56:26 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team-Non-PGO', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/zfdtHl0HRRusmlzyLqS4XQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-002', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] with output_timeout 3600 19:56:26 INFO - mozversion application_buildid: 20151222192828 19:56:26 INFO - mozversion application_changeset: dd26de01e3d255d6f62e679a58a0113ac1128183 19:56:26 INFO - mozversion application_display_name: Nightly 19:56:26 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 19:56:26 INFO - mozversion application_name: Firefox 19:56:26 INFO - mozversion application_remotingname: firefox 19:56:26 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 19:56:26 INFO - mozversion application_vendor: Mozilla 19:56:26 INFO - mozversion application_version: 46.0a1 19:56:26 INFO - mozversion platform_buildid: 20151222192828 19:56:26 INFO - mozversion platform_changeset: dd26de01e3d255d6f62e679a58a0113ac1128183 19:56:26 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 19:56:26 INFO - mozversion platform_version: 46.0a1 19:56:26 INFO - using testdate: 1450842986 19:56:26 INFO - actual date: 1450842986 19:56:26 INFO - starting webserver on 'localhost:34655' 19:56:26 INFO - SUITE-START | Running 3 tests 19:56:26 INFO - TEST-START | dromaeo_css 19:56:26 INFO - operating with platform_type : linux_ 19:56:26 INFO - Initialising browser for dromaeo_css test... 19:56:26 INFO - TEST-INFO | started process 26881 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp3I29RJ/profile http://localhost:34655/getInfo.html) 19:56:31 INFO - PROCESS | 26881 | __metrics Screen width/height:1600/1200 19:56:31 INFO - PROCESS | 26881 | colorDepth:24 19:56:31 INFO - PROCESS | 26881 | Browser inner width/height: 1024/697 19:56:31 INFO - PROCESS | 26881 | __metrics 19:56:31 INFO - PROCESS | 26881 | JavaScript error: resource://gre/modules/PerformanceStats.jsm, line 211: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIPerformanceStatsService.isMonitoringJank] 19:56:31 INFO - PROCESS | 26881 | JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 19:56:31 ERROR - PROCESS | 26881 | JavaScript error: chrome://browser/content/tab-content.js, line 408: TypeError: content is null 19:56:32 INFO - TEST-INFO | 26881: exit 0 19:56:32 INFO - Browser initialized. 19:56:32 INFO - Running cycle 1/1 for dromaeo_css test... 19:56:32 INFO - TEST-INFO | started process 26973 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp3I29RJ/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 19:56:44 INFO - PROCESS | 26973 | RSS: Main: 150306816 19:56:44 INFO - PROCESS | 26973 | 19:57:35 INFO - PROCESS | 26973 | 1450843055234 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] 19:59:48 INFO - PROCESS | 26973 | Cycle 1(1): loaded http://localhost:34655/tests/dromaeo/cssquery-dojo.html (next: http://localhost:34655/tests/dromaeo/cssquery-ext.html) 19:59:49 INFO - PROCESS | 26973 | RSS: Main: 231915520 19:59:49 INFO - PROCESS | 26973 | 20:02:52 INFO - PROCESS | 26973 | Cycle 1(1): loaded http://localhost:34655/tests/dromaeo/cssquery-ext.html (next: http://localhost:34655/tests/dromaeo/cssquery-jquery.html) 20:02:52 INFO - PROCESS | 26973 | RSS: Main: 226660352 20:02:52 INFO - PROCESS | 26973 | 20:05:54 INFO - PROCESS | 26973 | Cycle 1(1): loaded http://localhost:34655/tests/dromaeo/cssquery-jquery.html (next: http://localhost:34655/tests/dromaeo/cssquery-mootools.html) 20:05:55 INFO - PROCESS | 26973 | RSS: Main: 222531584 20:05:55 INFO - PROCESS | 26973 | 20:08:57 INFO - PROCESS | 26973 | Cycle 1(1): loaded http://localhost:34655/tests/dromaeo/cssquery-mootools.html (next: http://localhost:34655/tests/dromaeo/cssquery-prototype.html) 20:08:57 INFO - PROCESS | 26973 | RSS: Main: 211283968 20:08:57 INFO - PROCESS | 26973 | 20:12:00 INFO - PROCESS | 26973 | Cycle 1(1): loaded http://localhost:34655/tests/dromaeo/cssquery-prototype.html (next: http://localhost:34655/tests/dromaeo/cssquery-yui.html) 20:12:01 INFO - PROCESS | 26973 | RSS: Main: 214704128 20:12:01 INFO - PROCESS | 26973 | 20:15:03 INFO - PROCESS | 26973 | Cycle 1(1): loaded http://localhost:34655/tests/dromaeo/cssquery-yui.html (next: http://localhost:34655/tests/dromaeo/cssquery-dojo.html) 20:15:03 INFO - PROCESS | 26973 | RSS: Main: 259452928 20:15:03 INFO - PROCESS | 26973 | 20:15:03 INFO - PROCESS | 26973 | __start_tp_report 20:15:03 INFO - PROCESS | 26973 | _x_x_mozilla_page_load 20:15:03 INFO - PROCESS | 26973 | _x_x_mozilla_page_load_details 20:15:03 INFO - PROCESS | 26973 | |i|pagename|runs| 20:15:03 INFO - PROCESS | 26973 | |0;dojo.html;2594.5200137974475;2688.271036641502;2689.905853295135;2697.460507898421;2711.389937264116;4366.214081465343;4480.596746292833;4645.814167433303;4668.789904454299;4677.415323084619;4486.842960496383;4544.477385100715;4565.360849481067;4602.493725690179;4744.596709279706;4065.5527891931865;4217.051163488221;4226.725262857904;4237.766922819236;4332.442129744661;4291.871243862704;4354.368616550598;4359.978200108995;4360.585744354281;4421.491528474218;4123.835046598132;4160.9375859362135;4254.085371645111;4254.319308910591;4272.2950713132295;4289.1850548395705;4317.633001194871;4320.17916595849;4329.220740266751;4336.176126535979;4302.204092242945;4307.181635489247;4321.24378233811;4325.091730736549;4338.240807858644;4414.602685758297;4510.932336014962;4513.9843535204645;4529.796159172845;4669.509701481364;4926.211806111005;4970.2793095001025;4975.577075948549;4976.4277108132665;5017.197248440232;4991.126552853236;5000.774965126578;5002.049610573979;5002.624803139779;5006.899862002776;4345.261305578059;4454.688171828006;4457.955420445754;4531.229690952546;4667.13657973276;5093.719845408464;5133.4096578893905;5141.2288156776785;5142.202958541432;5173.456787037307;4927.063857866994;4929.408470983505;4937.703737775673;4973.801047958041;4980.8754781130765;4791.5687588117235;4834.661573689808;4919.3604831371695;4921.729304888266;4925.950740492549;4877.658563900563;4932.284818701268;4935.605151587936;4945.406551213878;4958.132326842788;4910.484399138039;4928.236123400879;4928.950710492921;4935.975320123376;4966.205407134841;3963.920721585552;4030.1939612077117;4150.045489537423;4160.979195104005;4202.789860506962;3541.734369922266;3602.657747513982;3624.873129440457;3626.5104210931186;3652.3060618482405;4329.913401732011;4335.328024156261;4348.217320882209;4371.519132895442;4383.123375324948;4736.407949006374;5003.199488081962;5003.499650034967;5005.399352077774;5012.8496145115705;4225.598568136023;4268.189044081614;4283.164782867373;4283.764392958417;4342.240107981091;4381.3427985801745;4401.933970990438;4402.977985110054;4439.134368798053;4440.555944405533;4661.906761864811;4724.763761811896;4766.189747742961;4771.95228047729;4810.4708482067645;4754.952450475451;4871.293662418859;4874.8537543873745;4996.075725990703;5028.874278143076;4633.30500424939;4732.361131247238;4734.360861283682;4734.8342808002935;4777.8088876445945;4933.309336692794;4941.481144479778;4977.800887964441;4980.228064649985;4983.127952608352;4738.194506933761;4834.178189707688;4884.609231261562;5052.621053421081;5078.4667609900425;4632.745199013952;4738.881527961691;4746.73892935878;4772.49888761675;4773.522647735199;4831.589314908272;4857.077155340474;4859.854204373874;4869.099216644932;4901.534354236342;4617.422822147231;4758.238681811032;4760.952390476051;4762.047590481987;4778.092162489116;4749.786259618395;4825.155597770306;4843.128236917248;4845.442774080885;4847.587955023721;4725.6219502439035;4734.857954261378;4735;4753.096911586787;4780.856574302777 20:15:03 INFO - PROCESS | 26973 | |1;ext.html;557.3924422379608;560.3332034878495;565.1212364772776;565.9575531835111;568.9687067211303;26838.86580567097;35463;36074.639253607456;36085.278294434094;36162;38878.41682374767;39411.21177576447;39458.60541394585;39465.605343946554;39530.20939581214;6854.34883686049;6962.651867406635;7828.412869034831;8011.158828323029;8012.63943122558;10147.391156530632;10436.373817570931;10446.477676116163;10448.63429779958;10452.895471045269;10148.84776728346;10237.385756854575;10251.538680759384;10254.282200245985;10259.692209233697;7187.856242875139;7369.410447164214;7373.77878663641;7374.336309732096;10083.899161008407;10263.281570290083;10565.471726413725;10575.524101415454;10579.153667706565;10580.788384232272;37214;37719.24561508782;37823;37919.810400948096;37946;2675.103840213531;2815.000674760451;3121.6566177720433;3310.0543397276147;3671.1923376857317;28853.278668033257;29089.563656545168;29437.85281073581;29543.409131817243;30211.848940755375;3327.6505966873374;3370.1911541230174;3420.572428446444;3459.377312083824;3567.518385018015;209532;210750;211194;211229;211242;56677.43322566721;57111;57124.42875571274;57126.42873571294;57172;59742;60064.399356006754;60072.69963650154;60214.69892650509;60258;13973.441062357391;14222.502212422722;14264.42942282318;14307;14335.85664143366;10691.893081069245;10825.242233043611;10825.458727063773;10829;10832.891671083189;19043.430456294445;19470.8052919469;19474.610507789766;19499.90250048769;19527.90236048839;7011.26381729911;7277.19950805411;7344.779656610311;7379.446541509408;7389.963050184822;815.8327542853701;834.1200033964104;897.4794619120894;901.193431878465;947.1475671895212;22979.885100574724;23221.651675224886;23892.641610375857;25010.624840627406;25122.24633261005;827.9379046571531;931.1154403316876;939.2251392601131;963.1428029054148;1016.7356487313203;12755.617331479885;13119.278439685719;13137.408816603276;13150.60548183556;13172;254623;260878;261196;261341;261517;38804.80597597051;39335;39341;39343.40984885229;39352.409713854315;1197.1859135787747;1219.4085868354018;1230.7292395672937;1231.2920070959235;1234.7839128152536;23416.414589635395;26012.609810852475;27213.814300705955;27482.862585686944;27551.586726198722;41074.58925410708;41338.379924301764;41359.586404135574;41487.170256594094;41489.37765933574;200763;201910;202108;202250;202389;24318.148864789648;24413.51172976495;28236.71763282423;28327.858360708065;28445.715542844307;34008.14979625529;34563;34798.82600586981;34818.65181348255;35054.29891402107;31081.222969425944;31748.365032698755;32723.34553308873;33273;33357.499637504974;32037.519437207993;32388.35223295568;32693.509597356533;32814.34371312608;32999;32203.51694724628;32683.34633307368;32876.835615821765;32912.17719556935;32966.34067318688;28936.855315723285;29469.26326841846;29971.004130918092;30275.697243027287;32216;23094.884525577938;23132;23239;23511.41221469477;24574.13990510395 20:15:03 INFO - PROCESS | 26973 | |2;jquery.html;331.47130327128224;335.7448339262161;336.45662255457427;337.1268414805653;338.93899098162336;12537.49850006001;12790.616281511546;15864.603384915383;16103.83896161038;16836.74744878826;12277.324747138904;12956.481740730384;14572.854271457281;15021.399144034225;15489.070655760663;4728.17256980028;4906.460289368167;4911.926321105187;4913.041956818422;4913.31213630092;3759.285735710206;4915.139850526144;4951.702897826142;4953.331300274453;4956.578690811268;4345.391645169679;5655.095184770437;5662.688552129631;5676.744546495397;5684.630499017571;5477.260569823063;5614.691191984439;5637.436256374371;5637.520810731093;5648.971755141239;5058.064258112224;5074.112030394666;5080.491950804927;5080.695158290478;5081.060003899291;18769.812301876944;18897.33859314931;19223.231070757152;19268.325608603773;19688.31090911811;1882.990585047066;1901.7717873855088;1953.345629214215;1974.99012504938;1981.8315443187346;12668.68328291791;12769.48922043117;12838.293893835835;13085.345732713326;13161.802572961413;1720.096949101719;1763.8853474524115;1764.682357175708;1779.359430604981;1809.8733088683798;53141;55346;55683;55892.720536397464;56218.71890640521;9168.404053736485;9285.62857485693;9400.529973501434;9407.811843763086;9442.433453992782;11972.580959666544;12003.459844306852;12012.63962081139;12054.638360849189;12094.153409261267;6974.895376569356;7038;7150.10623672041;7169.820754481179;7225.205227424979;6796.320367963164;6846;6849.1438570178725;6884.65576721162;6892.689828957709;5694.231278777394;5738.053221218453;5786.681732504669;5802.535797136304;5819.679917604572;1564.2726132348512;1631.8541118429227;1665.4087798831483;1668.2909763350528;1669.6410271791624;767.6353731977266;835.3859912963967;1005.969820905374;1010.9898901011043;1017.5421060522795;15943.282552285174;16435.342586296414;16472.917635411985;16758.413455528997;16804.243809028623;737.4027038099157;828.5443006346485;870.6473878079388;882.4572887674034;901.977450563728;8867.73396798097;9062.326430214982;9270.67552635668;9303.58133883977;9342.2526197904;314400.4279978631;442573;447552;448684;484271;66085;66535.33464665388;67047;67955;68701;440.8368903505659;451.74702166786705;452.0506935435559;453.4581175495317;453.94325709287;9654.131128198496;9662.565184566853;9923.206143508358;10011.649592264235;14014.579562613138;29983.100506984825;30351.696483034888;31338.373232535676;31778.52332215065;32075.518867216542;37568.060798479164;40929;43139.13721725611;43411.782941086356;46313.53686463227;8780.517071561126;8961.83496145497;9078.319126065704;9089.500077495537;9095.590698418455;16293.67412651764;16382.098984555963;16393;16756.58108547296;16987.745183822004;13372.598822035354;13969.603039696356;14221.857781422053;14293.213873236657;14300.157602069296;13535.729285414434;13769.387255269598;13871.375788089763;14078.507252246121;14106.435742570593;10547.57809687604;13168.47326106945;13420.731585368434;14050.718985620435;14806.111633302036;8755.343349248958;8777.51723655205;8838.823223535364;8849.867251991354;8860.734177974671;9260.53697315118;9339.346245762732;9383.953080234554;11778.174382970654;13467.528636497676 20:15:03 INFO - PROCESS | 26973 | |3;mootools.html;1440.4526280013592;1506.7815166800815;1516.590520559449;1561.882858785591;1635.9591010224747;5681.034224181889;6754.696038678259;6989.825254368637;6990.650467476618;7004.229534751174;6858.794236172923;6980.05769221155;6996.265392133829;6998;7015.263397343269;2027.7668068172165;2057.722207501983;2058.207590077816;2059.042545216474;2059.155746144081;2044.0290861840656;2067.7105205271273;2075.553755942472;2086.7600225974056;2088.926887558936;2017.677171652536;2063.8968051597435;2092.0272073485826;2092.8430367722403;2093.037202886674;2069.2964392106683;2089.780573039824;2093.602215579035;2096.6854971754283;2098.6117568249924;2021.272341956909;2045.6113338465643;2048.1295449433933;2049.692546118094;2073.0360382422095;6973.651317434108;7063.187733410672;7066.222715501291;7066.787996360117;7069.328413800681;4090.836366545335;4170.833166673329;4187.790610469495;4187.853425130136;4190.350495673176;2684.073994471904;2701.446203528272;2733.330334068146;2771.584262360642;2773.084881988939;880.665347168072;901.8061116859907;902.5261737587754;922.2391526990193;932.1563984593953;9266.16604505591;9277.211437027861;9290.860637090449;9348.57931393089;9352;3782.3002744492355;3813.6758375537834;3824;3828.885133446001;3878.340682083996;8100.311473524698;8126.9593652032545;8127.146649601825;8128.187181281943;8137.674493020331;4160.83356665736;4166.83332666696;4181.226473102486;4184.958150418518;4188.308929026676;3199.760017998613;3269.869205231764;3800.733948623625;3808.3906574947873;3814.6757525610633;3380.6281309055985;3380.645032271625;3383.154211447138;3402.6937575617817;3431.811250381203;1068.4016950507742;1070.68414817629;1075.3547871277171;1075.8063548561177;1098.0392156862745;1128.6839684888243;1136.0003197186422;1150.2121047082608;1151.476078384333;1183.4556104192168;6598.538102332886;6670.833229169212;6677.933220667731;6689.096971908827;6709;454.5204808926614;457.1223251357402;458.07240338315177;461.3610149942287;462.1750175935938;5216.895662086737;5262.2632831403635;5266.368035835724;5271.077561426735;5273.2617433559335;8191.262786349138;8212.260896519341;8332.708355207538;8396.748097557083;8474.279686226617;8294.8341033179;8312.584370781437;8315.542645154575;8318.750437486886;8330.166983301742;6534.542582019308;6554.9672251639395;6595.406413422719;6613.140291762136;6620.602763834186;6373.6175829450385;6397.680115994275;6409.359064093554;6411.102445657519;6418;7313.195548489768;7442;7452.590107543921;7522.924770752223;7530.811729706801;7522.247775222653;7555.9244407555225;7662.540247585162;7708.884366734392;7743.883841742266;5181.326427564392;5297.443768404262;5302.072137376021;6263.96868015657;6333.524985626004;5347.304850369427;5573.972130139324;6360.872782544416;6509.316521765147;6516.185476815398;6206.348333425106;6228.906566401417;6295.811125666238;6333.081703153109;6380.361963803768;5853.64878107315;5885.205497257815;5910.349861515144;5965.433283838029;5994.130851026664;6285.214348206474;6333.050042493663;6342.207224096988;6344.968275158594;6348.555601107878;5679.176519404746;5708.743106560298;5709.20071190042;5711.057675483498;5721.370649228665;5531.557475401878;5548.278723765885;5577.27495425592;5675.77296908119;5684.8294551163535 20:15:03 INFO - PROCESS | 26973 | |4;prototype.html;302.8606840853207;305.7401208972374;315.5881574545218;317.2196396863715;318.71793462785445;5193.221016847475;5262.342207224097;5280.762365693543;5303.337082864642;5307.442718514559;5232.764525596348;5249.790008399669;5251.816186433475;5252.658577192489;5253.7373131343475;3919.03983524037;4059.8782036538805;4136.33818589025;4139.3583994480905;4143.295639741236;4040.2929487339743;4091.89770255743;4116.6912481564;4119.237940980928;4123.9381409278885;4062.2687916175078;4076.4700588923397;4078.1028173801715;4079.2663118174805;4079.3473044312914;3857.42138679199;3941.192055628589;3971.801409929492;4074;4083.3670781028986;3622.492851000862;3623.691986181178;3631.110377957391;3641.817909104534;3647.927041459156;5047.520485553867;5056.089903817311;5057.241413787924;5057.645964782467;5063.443021267658;4707.693999890031;4714.316424118518;4720.976395118037;4725.385699859031;4728.905421891543;5352.946470535284;5503.6147469677135;5506.063969125258;5518.475744804237;5519.199716041152;3866.3620502617036;3876.9612303877166;3878.6897048236074;3881.3207688654375;3890.8054597270307;5732.5127364174095;5792.333881603628;5808.244928159313;5815.127730840408;5816.360200377955;4001.559828418872;4005.6995725320717;4008.8797336079965;4010.5387880393546;4012.6990475713856;3957.0700885291935;4066.837326506966;4068.6745060395097;4075.612816782401;4092.6930480214105;4660.673752837337;4661.603763680057;4665.0903073900945;4666.160091183551;4668.836590719308;5553.416891226363;5553.8333849984565;5560.471755183332;5564;5566.888662226814;1413.1732936232213;1437.374741987218;1438.9352479138463;1439.4314245873031;1440.7838824176458;965.4400447740294;965.4496936746128;974.4250891973769;998.0568362897138;1000.7948370584013;4925.926111108336;4935.432425271139;4936.7284799336385;4937.333459982857;4938.802447902115;5746.396628354046;5756.856078598069;5763.7982670606325;5765.625234359753;5765.913511297334;4889;4917.336159618477;4932.4081110267;4933;4937.802487900443;2864.427114577093;2982.4035192961496;3063.7702172336717;3070.309180434429;3091.180837078176;5487.972560137174;5494.066008778517;5494.09347457673;5495.862603434866;5498.230247765316;5882.117682347682;5921.052631578927;5923.259592550931;5929.450336355322;5935.109733540004;5475.0418676731415;5480.205370221295;5481.890362192734;5485.259489968803;5490.258815060076;5562.5549956002615;5767.8558036049435;5783.103618939072;5794.333651629948;5798.362180160263;5645.661260324394;5650.26546548946;5653.604247702621;5653.773849046157;5660.320761508646;5488.4785945335125;5495.120780675233;5497.092979658471;5499.092649712913;5506.1190209566275;3906.511686039245;3952.9209415810947;4020.3768415895584;4020.6783457323927;4022.1955608878925;5776.335721392094;5786.479216870502;5787.768489260551;5793.91309130355;5795.420457954171;5576.888462230814;5584.46947539983;5587.217789509391;5587.832365029056;5591.245181900392;5545.833624991256;5576.944230557642;5581.804636837691;5584.413636568264;5591.329040515164;5350.117230656898;5390.00284947286;5468;5468.808591699271;5471.316085489314;5599.916001259903;5611.719414029364;5613.522850557748;5619.100943848965;5623;5231.503007214308;5403.0544654686055;5411.512963833274;5411.648242864201;5416.593755468277 20:15:03 INFO - PROCESS | 26973 | |5;yui.html;698.1308271202354;767.4244316762428;768.3660979691753;783.4750717019598;808.3977436809578;12015;12285.324307163102;12309;12318.137730358878;12321.63035108946;11781.469833857476;13352.599422017354;13571.457141714343;13572.932135339333;13581.592552223448;650.1677852348977;652.3672038123013;817.3910436724649;826.5123577089516;834.7704381295132;776.2276534847806;814.6008455856647;822.3873214455209;830.6179157587487;830.7258604660448;830.2403300979596;868.2663149638545;875.3172525430175;875.483464755794;877.0484024833032;671.7480944645757;672.525869262169;850.090403268503;859.5873980489338;863.365426411587;608.9451949324582;618.4403115180723;635.6662752055162;636.8280564247627;638.9488840892717;12451.066170037284;12472.126951113425;12550.74898502025;12559.623211303675;12648.936755316257;11601.709957251052;11689.415529223505;11944.761104777856;12055.578054768128;12566.120371573994;9652.855207171899;9812.411255324632;9884.604615815359;9977.451240181786;10087.89912100877;3208.1177676139014;3240.54632351471;3314.436545787222;3324.883629072971;3429.262708517656;41053.384199237036;41077.38383924244;41315.58684413177;41342.37986430206;41369;9765.267604929517;9782.315237933419;9944.35361701487;9953.104220620178;9970.102690757867;17426;17463.82536174622;17482.912585437247;17500;17510.474685759447;6444.548881578245;6483.189601299838;6551.8362040948405;6552.8361790955605;6745.898811517831;3756.6806821420487;3793.1465420280215;3810.0855794609647;3836.7889766063136;3905.1018265799025;2761.351082495612;2764.8064635475725;2786.024891288033;2786.4705705915812;2793.0782841662203;495.22002845518455;495.774422637699;502.3494574525998;503.22754571732213;506.80488012114864;483.89838133992254;568.7383803450376;573.1975234671494;584.6703026265378;596.6927032578226;7444.292792184842;7565.962170189114;7686.154523002465;7750.844983100306;7786.338161256243;453.33359960857484;466.160910361355;527.3776943207052;590.1383979390052;604.474107526446;3484.111551554388;3561.1453251219523;3624.800635965047;3639.70882329413;3694.8522059117336;46287.83409493162;50361.496385036415;50725;51255.74372128116;51324.74337628288;45064.54935450669;45085;45946.5405345949;46127;46831.765841171255;40348.79825600853;41533.584664153575;42202.15595688069;42329.1534169321;42404;7498.287662672037;7826.569538675428;7910.090339610788;7984.8003799903145;8157.143499932659;30128.3974320508;31933.840330798197;32294.515582265816;32316.83841580871;32353.676463235068;41066.38400424056;41110.588894110675;41129.588704113776;41406.37890431706;41557.58442415658;9655.227581793299;9759.316847820584;9814.607415703578;9973.152282056106;10283.94858025705;10746.785064298827;10785.352878827296;10830.837537436788;10837.945810271214;11019.83470247963;9609.375390599589;9635.903640963501;9822;9892.060254275832;10110.89889101129;10114.089731924161;10119.898801011896;10479.10927571165;10495;10615.522301496605;9824.673191226657;9901.504924753877;10086.546105425126;10367.533460994424;10387.68836934893;8768.736937891874;9084.40951338161;9195.54022298869;9472.33693641466;9678.85481717789;8446.619902104298;9075.319351048829;9260.629574817202;9363.578638961128;9483.905160948578 20:15:03 INFO - PROCESS | 26973 | __end_tp_report 20:15:03 INFO - PROCESS | 26973 | __start_cc_report 20:15:03 INFO - PROCESS | 26973 | _x_x_mozilla_cycle_collect,1010 20:15:03 INFO - PROCESS | 26973 | __end_cc_report 20:15:03 INFO - PROCESS | 26973 | __startTimestamp1450844103918__endTimestamp 20:15:03 INFO - PROCESS | 26973 | 20:15:03 INFO - PROCESS | 26973 | ------- Summary: start ------- 20:15:03 INFO - PROCESS | 26973 | Number of tests: 6 20:15:03 INFO - PROCESS | 26973 | 20:15:03 INFO - PROCESS | 26973 | [#0] dojo.html Cycles:165 Average:4574.10 Median:4734.83 stddev:476.09 (10.1%) stddev-sans-first:451.51 20:15:03 INFO - PROCESS | 26973 | Values: 2594.5 2688.3 2689.9 2697.5 2711.4 4366.2 4480.6 4645.8 4668.8 4677.4 4486.8 4544.5 4565.4 4602.5 4744.6 4065.6 4217.1 4226.7 4237.8 4332.4 4291.9 4354.4 4360.0 4360.6 4421.5 4123.8 4160.9 4254.1 4254.3 4272.3 4289.2 4317.6 4320.2 4329.2 4336.2 4302.2 4307.2 4321.2 4325.1 4338.2 4414.6 4510.9 4514.0 4529.8 4669.5 4926.2 4970.3 4975.6 4976.4 5017.2 4991.1 5000.8 5002.0 5002.6 5006.9 4345.3 4454.7 4458.0 4531.2 4667.1 5093.7 5133.4 5141.2 5142.2 5173.5 4927.1 4929.4 4937.7 4973.8 4980.9 4791.6 4834.7 4919.4 4921.7 4926.0 4877.7 4932.3 4935.6 4945.4 4958.1 4910.5 4928.2 4929.0 4936.0 4966.2 3963.9 4030.2 4150.0 4161.0 4202.8 3541.7 3602.7 3624.9 3626.5 3652.3 4329.9 4335.3 4348.2 4371.5 4383.1 4736.4 5003.2 5003.5 5005.4 5012.8 4225.6 4268.2 4283.2 4283.8 4342.2 4381.3 4401.9 4403.0 4439.1 4440.6 4661.9 4724.8 4766.2 4772.0 4810.5 4755.0 4871.3 4874.9 4996.1 5028.9 4633.3 4732.4 4734.4 4734.8 4777.8 4933.3 4941.5 4977.8 4980.2 4983.1 4738.2 4834.2 4884.6 5052.6 5078.5 4632.7 4738.9 4746.7 4772.5 4773.5 4831.6 4857.1 4859.9 4869.1 4901.5 4617.4 4758.2 4761.0 4762.0 4778.1 4749.8 4825.2 4843.1 4845.4 4847.6 4725.6 4734.9 4735.0 4753.1 4780.9 20:15:03 INFO - PROCESS | 26973 | 20:15:03 INFO - PROCESS | 26973 | [#1] ext.html Cycles:180 Average:38766.20 Median:17435.01 stddev:58617.71 (336.2%) stddev-sans-first:58711.94 20:15:03 INFO - PROCESS | 26973 | Values: 557.4 560.3 565.1 566.0 569.0 26838.9 35463.0 36074.6 36085.3 36162.0 38878.4 39411.2 39458.6 39465.6 39530.2 6854.3 6962.7 7828.4 8011.2 8012.6 10147.4 10436.4 10446.5 10448.6 10452.9 10148.8 10237.4 10251.5 10254.3 10259.7 7187.9 7369.4 7373.8 7374.3 10083.9 10263.3 10565.5 10575.5 10579.2 10580.8 37214.0 37719.2 37823.0 37919.8 37946.0 2675.1 2815.0 3121.7 3310.1 3671.2 28853.3 29089.6 29437.9 29543.4 30211.8 3327.7 3370.2 3420.6 3459.4 3567.5 209532.0 210750.0 211194.0 211229.0 211242.0 56677.4 57111.0 57124.4 57126.4 57172.0 59742.0 60064.4 60072.7 60214.7 60258.0 13973.4 14222.5 14264.4 14307.0 14335.9 10691.9 10825.2 10825.5 10829.0 10832.9 19043.4 19470.8 19474.6 19499.9 19527.9 7011.3 7277.2 7344.8 7379.4 7390.0 815.8 834.1 897.5 901.2 947.1 22979.9 23221.7 23892.6 25010.6 25122.2 827.9 931.1 939.2 963.1 1016.7 12755.6 13119.3 13137.4 13150.6 13172.0 254623.0 260878.0 261196.0 261341.0 261517.0 38804.8 39335.0 39341.0 39343.4 39352.4 1197.2 1219.4 1230.7 1231.3 1234.8 23416.4 26012.6 27213.8 27482.9 27551.6 41074.6 41338.4 41359.6 41487.2 41489.4 200763.0 201910.0 202108.0 202250.0 202389.0 24318.1 24413.5 28236.7 28327.9 28445.7 34008.1 34563.0 34798.8 34818.7 35054.3 31081.2 31748.4 32723.3 33273.0 33357.5 32037.5 32388.4 32693.5 32814.3 32999.0 32203.5 32683.3 32876.8 32912.2 32966.3 28936.9 29469.3 29971.0 30275.7 32216.0 23094.9 23132.0 23239.0 23511.4 24574.1 20:15:03 INFO - PROCESS | 26973 | 20:15:03 INFO - PROCESS | 26973 | [#2] jquery.html Cycles:180 Average:24485.12 Median:445062.50 stddev:70509.53 (15.8%) stddev-sans-first:70684.01 20:15:03 INFO - PROCESS | 26973 | Values: 331.5 335.7 336.5 337.1 338.9 12537.5 12790.6 15864.6 16103.8 16836.7 12277.3 12956.5 14572.9 15021.4 15489.1 4728.2 4906.5 4911.9 4913.0 4913.3 3759.3 4915.1 4951.7 4953.3 4956.6 4345.4 5655.1 5662.7 5676.7 5684.6 5477.3 5614.7 5637.4 5637.5 5649.0 5058.1 5074.1 5080.5 5080.7 5081.1 18769.8 18897.3 19223.2 19268.3 19688.3 1883.0 1901.8 1953.3 1975.0 1981.8 12668.7 12769.5 12838.3 13085.3 13161.8 1720.1 1763.9 1764.7 1779.4 1809.9 53141.0 55346.0 55683.0 55892.7 56218.7 9168.4 9285.6 9400.5 9407.8 9442.4 11972.6 12003.5 12012.6 12054.6 12094.2 6974.9 7038.0 7150.1 7169.8 7225.2 6796.3 6846.0 6849.1 6884.7 6892.7 5694.2 5738.1 5786.7 5802.5 5819.7 1564.3 1631.9 1665.4 1668.3 1669.6 767.6 835.4 1006.0 1011.0 1017.5 15943.3 16435.3 16472.9 16758.4 16804.2 737.4 828.5 870.6 882.5 902.0 8867.7 9062.3 9270.7 9303.6 9342.3 314400.4 442573.0 447552.0 448684.0 484271.0 66085.0 66535.3 67047.0 67955.0 68701.0 440.8 451.7 452.1 453.5 453.9 9654.1 9662.6 9923.2 10011.6 14014.6 29983.1 30351.7 31338.4 31778.5 32075.5 37568.1 40929.0 43139.1 43411.8 46313.5 8780.5 8961.8 9078.3 9089.5 9095.6 16293.7 16382.1 16393.0 16756.6 16987.7 13372.6 13969.6 14221.9 14293.2 14300.2 13535.7 13769.4 13871.4 14078.5 14106.4 10547.6 13168.5 13420.7 14050.7 14806.1 8755.3 8777.5 8838.8 8849.9 8860.7 9260.5 9339.3 9384.0 11778.2 13467.5 20:15:03 INFO - PROCESS | 26973 | 20:15:03 INFO - PROCESS | 26973 | [#3] mootools.html Cycles:180 Average:4824.87 Median:5682.93 stddev:2496.81 (43.9%) stddev-sans-first:2490.85 20:15:03 INFO - PROCESS | 26973 | Values: 1440.5 1506.8 1516.6 1561.9 1636.0 5681.0 6754.7 6989.8 6990.7 7004.2 6858.8 6980.1 6996.3 6998.0 7015.3 2027.8 2057.7 2058.2 2059.0 2059.2 2044.0 2067.7 2075.6 2086.8 2088.9 2017.7 2063.9 2092.0 2092.8 2093.0 2069.3 2089.8 2093.6 2096.7 2098.6 2021.3 2045.6 2048.1 2049.7 2073.0 6973.7 7063.2 7066.2 7066.8 7069.3 4090.8 4170.8 4187.8 4187.9 4190.4 2684.1 2701.4 2733.3 2771.6 2773.1 880.7 901.8 902.5 922.2 932.2 9266.2 9277.2 9290.9 9348.6 9352.0 3782.3 3813.7 3824.0 3828.9 3878.3 8100.3 8127.0 8127.1 8128.2 8137.7 4160.8 4166.8 4181.2 4185.0 4188.3 3199.8 3269.9 3800.7 3808.4 3814.7 3380.6 3380.6 3383.2 3402.7 3431.8 1068.4 1070.7 1075.4 1075.8 1098.0 1128.7 1136.0 1150.2 1151.5 1183.5 6598.5 6670.8 6677.9 6689.1 6709.0 454.5 457.1 458.1 461.4 462.2 5216.9 5262.3 5266.4 5271.1 5273.3 8191.3 8212.3 8332.7 8396.7 8474.3 8294.8 8312.6 8315.5 8318.8 8330.2 6534.5 6555.0 6595.4 6613.1 6620.6 6373.6 6397.7 6409.4 6411.1 6418.0 7313.2 7442.0 7452.6 7522.9 7530.8 7522.2 7555.9 7662.5 7708.9 7743.9 5181.3 5297.4 5302.1 6264.0 6333.5 5347.3 5574.0 6360.9 6509.3 6516.2 6206.3 6228.9 6295.8 6333.1 6380.4 5853.6 5885.2 5910.3 5965.4 5994.1 6285.2 6333.1 6342.2 6345.0 6348.6 5679.2 5708.7 5709.2 5711.1 5721.4 5531.6 5548.3 5577.3 5675.8 5684.8 20:15:03 INFO - PROCESS | 26973 | 20:15:03 INFO - PROCESS | 26973 | [#4] prototype.html Cycles:180 Average:4613.81 Median:5252.24 stddev:1354.53 (25.8%) stddev-sans-first:1319.12 20:15:03 INFO - PROCESS | 26973 | Values: 302.9 305.7 315.6 317.2 318.7 5193.2 5262.3 5280.8 5303.3 5307.4 5232.8 5249.8 5251.8 5252.7 5253.7 3919.0 4059.9 4136.3 4139.4 4143.3 4040.3 4091.9 4116.7 4119.2 4123.9 4062.3 4076.5 4078.1 4079.3 4079.3 3857.4 3941.2 3971.8 4074.0 4083.4 3622.5 3623.7 3631.1 3641.8 3647.9 5047.5 5056.1 5057.2 5057.6 5063.4 4707.7 4714.3 4721.0 4725.4 4728.9 5352.9 5503.6 5506.1 5518.5 5519.2 3866.4 3877.0 3878.7 3881.3 3890.8 5732.5 5792.3 5808.2 5815.1 5816.4 4001.6 4005.7 4008.9 4010.5 4012.7 3957.1 4066.8 4068.7 4075.6 4092.7 4660.7 4661.6 4665.1 4666.2 4668.8 5553.4 5553.8 5560.5 5564.0 5566.9 1413.2 1437.4 1438.9 1439.4 1440.8 965.4 965.4 974.4 998.1 1000.8 4925.9 4935.4 4936.7 4937.3 4938.8 5746.4 5756.9 5763.8 5765.6 5765.9 4889.0 4917.3 4932.4 4933.0 4937.8 2864.4 2982.4 3063.8 3070.3 3091.2 5488.0 5494.1 5494.1 5495.9 5498.2 5882.1 5921.1 5923.3 5929.5 5935.1 5475.0 5480.2 5481.9 5485.3 5490.3 5562.6 5767.9 5783.1 5794.3 5798.4 5645.7 5650.3 5653.6 5653.8 5660.3 5488.5 5495.1 5497.1 5499.1 5506.1 3906.5 3952.9 4020.4 4020.7 4022.2 5776.3 5786.5 5787.8 5793.9 5795.4 5576.9 5584.5 5587.2 5587.8 5591.2 5545.8 5576.9 5581.8 5584.4 5591.3 5350.1 5390.0 5468.0 5468.8 5471.3 5599.9 5611.7 5613.5 5619.1 5623.0 5231.5 5403.1 5411.5 5411.6 5416.6 20:15:03 INFO - PROCESS | 26973 | 20:15:03 INFO - PROCESS | 26973 | [#5] yui.html Cycles:180 Average:12505.92 Median:495.50 stddev:14142.98 (2854.3%) stddev-sans-first:14154.86 20:15:03 INFO - PROCESS | 26973 | Values: 698.1 767.4 768.4 783.5 808.4 12015.0 12285.3 12309.0 12318.1 12321.6 11781.5 13352.6 13571.5 13572.9 13581.6 650.2 652.4 817.4 826.5 834.8 776.2 814.6 822.4 830.6 830.7 830.2 868.3 875.3 875.5 877.0 671.7 672.5 850.1 859.6 863.4 608.9 618.4 635.7 636.8 638.9 12451.1 12472.1 12550.7 12559.6 12648.9 11601.7 11689.4 11944.8 12055.6 12566.1 9652.9 9812.4 9884.6 9977.5 10087.9 3208.1 3240.5 3314.4 3324.9 3429.3 41053.4 41077.4 41315.6 41342.4 41369.0 9765.3 9782.3 9944.4 9953.1 9970.1 17426.0 17463.8 17482.9 17500.0 17510.5 6444.5 6483.2 6551.8 6552.8 6745.9 3756.7 3793.1 3810.1 3836.8 3905.1 2761.4 2764.8 2786.0 2786.5 2793.1 495.2 495.8 502.3 503.2 506.8 483.9 568.7 573.2 584.7 596.7 7444.3 7566.0 7686.2 7750.8 7786.3 453.3 466.2 527.4 590.1 604.5 3484.1 3561.1 3624.8 3639.7 3694.9 46287.8 50361.5 50725.0 51255.7 51324.7 45064.5 45085.0 45946.5 46127.0 46831.8 40348.8 41533.6 42202.2 42329.2 42404.0 7498.3 7826.6 7910.1 7984.8 8157.1 30128.4 31933.8 32294.5 32316.8 32353.7 41066.4 41110.6 41129.6 41406.4 41557.6 9655.2 9759.3 9814.6 9973.2 10283.9 10746.8 10785.4 10830.8 10837.9 11019.8 9609.4 9635.9 9822.0 9892.1 10110.9 10114.1 10119.9 10479.1 10495.0 10615.5 9824.7 9901.5 10086.5 10367.5 10387.7 8768.7 9084.4 9195.5 9472.3 9678.9 8446.6 9075.3 9260.6 9363.6 9483.9 20:15:03 INFO - PROCESS | 26973 | -------- Summary: end -------- 20:15:03 INFO - PROCESS | 26973 | 20:15:04 INFO - TEST-INFO | 26973: exit 0 20:15:04 INFO - TEST-OK | dromaeo_css | took 1118092ms 20:15:04 INFO - TEST-START | kraken 20:15:04 INFO - operating with platform_type : linux_ 20:15:04 INFO - Initialising browser for kraken test... 20:15:04 INFO - TEST-INFO | started process 27162 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp3JdQoz/profile http://localhost:34655/getInfo.html) 20:15:09 INFO - PROCESS | 27162 | __metrics Screen width/height:1600/1200 20:15:09 INFO - PROCESS | 27162 | colorDepth:24 20:15:09 INFO - PROCESS | 27162 | Browser inner width/height: 1024/697 20:15:09 INFO - PROCESS | 27162 | __metrics 20:15:09 INFO - PROCESS | 27162 | JavaScript error: resource://gre/modules/PerformanceStats.jsm, line 211: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIPerformanceStatsService.isMonitoringJank] 20:15:09 INFO - PROCESS | 27162 | JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 20:15:09 ERROR - PROCESS | 27162 | JavaScript error: chrome://browser/content/tab-content.js, line 408: TypeError: content is null 20:15:10 INFO - TEST-INFO | 27162: exit 0 20:15:10 INFO - Browser initialized. 20:15:10 INFO - Running cycle 1/1 for kraken test... 20:15:10 INFO - TEST-INFO | started process 27242 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp3JdQoz/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 20:15:22 INFO - PROCESS | 27242 | RSS: Main: 150491136 20:15:22 INFO - PROCESS | 27242 | 20:15:24 INFO - PROCESS | 27242 | Cycle 1(1): loaded http://localhost:34655/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:34655/tests/kraken/driver.html?testName=audio-beat-detection) 20:15:25 INFO - PROCESS | 27242 | RSS: Main: 186658816 20:15:25 INFO - PROCESS | 27242 | 20:15:28 INFO - PROCESS | 27242 | Cycle 1(1): loaded http://localhost:34655/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:34655/tests/kraken/driver.html?testName=audio-dft) 20:15:28 INFO - PROCESS | 27242 | RSS: Main: 176422912 20:15:28 INFO - PROCESS | 27242 | 20:15:31 INFO - PROCESS | 27242 | Cycle 1(1): loaded http://localhost:34655/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:34655/tests/kraken/driver.html?testName=audio-fft) 20:15:32 INFO - PROCESS | 27242 | RSS: Main: 161366016 20:15:32 INFO - PROCESS | 27242 | 20:15:34 INFO - PROCESS | 27242 | Cycle 1(1): loaded http://localhost:34655/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:34655/tests/kraken/driver.html?testName=audio-oscillator) 20:15:34 INFO - PROCESS | 27242 | RSS: Main: 162934784 20:15:34 INFO - PROCESS | 27242 | 20:15:37 INFO - PROCESS | 27242 | Cycle 1(1): loaded http://localhost:34655/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:34655/tests/kraken/driver.html?testName=imaging-gaussian-blur) 20:15:37 INFO - PROCESS | 27242 | RSS: Main: 166232064 20:15:37 INFO - PROCESS | 27242 | 20:15:40 INFO - PROCESS | 27242 | Cycle 1(1): loaded http://localhost:34655/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:34655/tests/kraken/driver.html?testName=imaging-darkroom) 20:15:41 INFO - PROCESS | 27242 | RSS: Main: 166236160 20:15:41 INFO - PROCESS | 27242 | 20:15:44 INFO - PROCESS | 27242 | Cycle 1(1): loaded http://localhost:34655/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:34655/tests/kraken/driver.html?testName=imaging-desaturate) 20:15:45 INFO - PROCESS | 27242 | RSS: Main: 167370752 20:15:45 INFO - PROCESS | 27242 | 20:15:48 INFO - PROCESS | 27242 | Cycle 1(1): loaded http://localhost:34655/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:34655/tests/kraken/driver.html?testName=json-parse-financial) 20:15:48 INFO - PROCESS | 27242 | RSS: Main: 167116800 20:15:48 INFO - PROCESS | 27242 | 20:15:50 INFO - PROCESS | 27242 | Cycle 1(1): loaded http://localhost:34655/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:34655/tests/kraken/driver.html?testName=json-stringify-tinderbox) 20:15:51 INFO - PROCESS | 27242 | RSS: Main: 178196480 20:15:51 INFO - PROCESS | 27242 | 20:15:52 INFO - PROCESS | 27242 | Cycle 1(1): loaded http://localhost:34655/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:34655/tests/kraken/driver.html?testName=stanford-crypto-aes) 20:15:53 INFO - PROCESS | 27242 | RSS: Main: 176840704 20:15:53 INFO - PROCESS | 27242 | 20:15:55 INFO - PROCESS | 27242 | Cycle 1(1): loaded http://localhost:34655/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:34655/tests/kraken/driver.html?testName=stanford-crypto-ccm) 20:15:56 INFO - PROCESS | 27242 | RSS: Main: 189984768 20:15:56 INFO - PROCESS | 27242 | 20:15:58 INFO - PROCESS | 27242 | Cycle 1(1): loaded http://localhost:34655/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:34655/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 20:15:59 INFO - PROCESS | 27242 | RSS: Main: 197398528 20:15:59 INFO - PROCESS | 27242 | 20:16:01 INFO - PROCESS | 27242 | Cycle 1(1): loaded http://localhost:34655/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:34655/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 20:16:02 INFO - PROCESS | 27242 | RSS: Main: 193806336 20:16:02 INFO - PROCESS | 27242 | 20:16:04 INFO - PROCESS | 27242 | Cycle 1(1): loaded http://localhost:34655/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:34655/tests/kraken/driver.html?testName=ai-astar) 20:16:04 INFO - PROCESS | 27242 | RSS: Main: 252301312 20:16:04 INFO - PROCESS | 27242 | 20:16:04 INFO - PROCESS | 27242 | __start_tp_report 20:16:04 INFO - PROCESS | 27242 | _x_x_mozilla_page_load 20:16:04 INFO - PROCESS | 27242 | _x_x_mozilla_page_load_details 20:16:04 INFO - PROCESS | 27242 | |i|pagename|runs| 20:16:04 INFO - PROCESS | 27242 | |0;ai-astar;112;113;109;113;115;114;104;112;112;121 20:16:04 INFO - PROCESS | 27242 | |1;audio-beat-detection;152;134;154;174;131;162;151;129;168;135 20:16:04 INFO - PROCESS | 27242 | |2;audio-dft;160;162;159;160;161;160;162;163;160;161 20:16:04 INFO - PROCESS | 27242 | |3;audio-fft;75;73;82;104;72;73;72;104;88;74 20:16:04 INFO - PROCESS | 27242 | |4;audio-oscillator;95;95;133;94;95;95;135;95;95;133 20:16:04 INFO - PROCESS | 27242 | |5;imaging-gaussian-blur;109;109;109;110;109;109;110;109;110;110 20:16:04 INFO - PROCESS | 27242 | |6;imaging-darkroom;146;146;146;145;147;146;146;146;146;147 20:16:04 INFO - PROCESS | 27242 | |7;imaging-desaturate;95;95;95;95;95;95;95;96;95;95 20:16:04 INFO - PROCESS | 27242 | |8;json-parse-financial;70;70;70;70;70;71;70;70;72;69 20:16:04 INFO - PROCESS | 27242 | |9;json-stringify-tinderbox;67;68;67;68;67;68;69;68;68;68 20:16:04 INFO - PROCESS | 27242 | |10;stanford-crypto-aes;85;85;85;85;92;87;86;84;83;85 20:16:04 INFO - PROCESS | 27242 | |11;stanford-crypto-ccm;130;127;124;118;124;117;127;121;130;125 20:16:04 INFO - PROCESS | 27242 | |12;stanford-crypto-pbkdf2;139;138;151;150;147;139;142;149;147;138 20:16:04 INFO - PROCESS | 27242 | |13;stanford-crypto-sha256-iterative;71;69;71;72;70;69;70;68;70;68 20:16:04 INFO - PROCESS | 27242 | __end_tp_report 20:16:04 INFO - PROCESS | 27242 | __start_cc_report 20:16:04 INFO - PROCESS | 27242 | _x_x_mozilla_cycle_collect,979 20:16:04 INFO - PROCESS | 27242 | __end_cc_report 20:16:04 INFO - PROCESS | 27242 | __startTimestamp1450844164515__endTimestamp 20:16:04 INFO - PROCESS | 27242 | 20:16:04 INFO - PROCESS | 27242 | ------- Summary: start ------- 20:16:04 INFO - PROCESS | 27242 | Number of tests: 14 20:16:04 INFO - PROCESS | 27242 | 20:16:04 INFO - PROCESS | 27242 | [#0] ai-astar Cycles:10 Average:112.50 Median:113.00 stddev:4.30 (3.8%) stddev-sans-first:4.56 20:16:04 INFO - PROCESS | 27242 | Values: 112.0 113.0 109.0 113.0 115.0 114.0 104.0 112.0 112.0 121.0 20:16:04 INFO - PROCESS | 27242 | 20:16:04 INFO - PROCESS | 27242 | [#1] audio-beat-detection Cycles:10 Average:149.00 Median:153.00 stddev:16.12 (10.5%) stddev-sans-first:17.06 20:16:04 INFO - PROCESS | 27242 | Values: 152.0 134.0 154.0 174.0 131.0 162.0 151.0 129.0 168.0 135.0 20:16:04 INFO - PROCESS | 27242 | 20:16:04 INFO - PROCESS | 27242 | [#2] audio-dft Cycles:10 Average:160.80 Median:161.00 stddev:1.23 (0.8%) stddev-sans-first:1.27 20:16:04 INFO - PROCESS | 27242 | Values: 160.0 162.0 159.0 160.0 161.0 160.0 162.0 163.0 160.0 161.0 20:16:04 INFO - PROCESS | 27242 | 20:16:04 INFO - PROCESS | 27242 | [#3] audio-fft Cycles:10 Average:81.70 Median:73.50 stddev:12.82 (17.4%) stddev-sans-first:13.36 20:16:04 INFO - PROCESS | 27242 | Values: 75.0 73.0 82.0 104.0 72.0 73.0 72.0 104.0 88.0 74.0 20:16:04 INFO - PROCESS | 27242 | 20:16:04 INFO - PROCESS | 27242 | [#4] audio-oscillator Cycles:10 Average:106.50 Median:95.00 stddev:18.76 (19.7%) stddev-sans-first:19.43 20:16:04 INFO - PROCESS | 27242 | Values: 95.0 95.0 133.0 94.0 95.0 95.0 135.0 95.0 95.0 133.0 20:16:04 INFO - PROCESS | 27242 | 20:16:04 INFO - PROCESS | 27242 | [#5] imaging-gaussian-blur Cycles:10 Average:109.40 Median:109.50 stddev:0.52 (0.5%) stddev-sans-first:0.53 20:16:04 INFO - PROCESS | 27242 | Values: 109.0 109.0 109.0 110.0 109.0 109.0 110.0 109.0 110.0 110.0 20:16:04 INFO - PROCESS | 27242 | 20:16:04 INFO - PROCESS | 27242 | [#6] imaging-darkroom Cycles:10 Average:146.10 Median:146.00 stddev:0.57 (0.4%) stddev-sans-first:0.60 20:16:04 INFO - PROCESS | 27242 | Values: 146.0 146.0 146.0 145.0 147.0 146.0 146.0 146.0 146.0 147.0 20:16:04 INFO - PROCESS | 27242 | 20:16:04 INFO - PROCESS | 27242 | [#7] imaging-desaturate Cycles:10 Average:95.10 Median:95.00 stddev:0.32 (0.3%) stddev-sans-first:0.33 20:16:04 INFO - PROCESS | 27242 | Values: 95.0 95.0 95.0 95.0 95.0 95.0 95.0 96.0 95.0 95.0 20:16:04 INFO - PROCESS | 27242 | 20:16:04 INFO - PROCESS | 27242 | [#8] json-parse-financial Cycles:10 Average:70.20 Median:70.00 stddev:0.79 (1.1%) stddev-sans-first:0.83 20:16:04 INFO - PROCESS | 27242 | Values: 70.0 70.0 70.0 70.0 70.0 71.0 70.0 70.0 72.0 69.0 20:16:04 INFO - PROCESS | 27242 | 20:16:04 INFO - PROCESS | 27242 | [#9] json-stringify-tinderbox Cycles:10 Average:67.80 Median:68.00 stddev:0.63 (0.9%) stddev-sans-first:0.60 20:16:04 INFO - PROCESS | 27242 | Values: 67.0 68.0 67.0 68.0 67.0 68.0 69.0 68.0 68.0 68.0 20:16:04 INFO - PROCESS | 27242 | 20:16:04 INFO - PROCESS | 27242 | [#10] stanford-crypto-aes Cycles:10 Average:85.70 Median:85.00 stddev:2.45 (2.9%) stddev-sans-first:2.59 20:16:04 INFO - PROCESS | 27242 | Values: 85.0 85.0 85.0 85.0 92.0 87.0 86.0 84.0 83.0 85.0 20:16:04 INFO - PROCESS | 27242 | 20:16:04 INFO - PROCESS | 27242 | [#11] stanford-crypto-ccm Cycles:10 Average:124.30 Median:126.00 stddev:4.52 (3.6%) stddev-sans-first:4.30 20:16:04 INFO - PROCESS | 27242 | Values: 130.0 127.0 124.0 118.0 124.0 117.0 127.0 121.0 130.0 125.0 20:16:04 INFO - PROCESS | 27242 | 20:16:04 INFO - PROCESS | 27242 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:144.00 Median:147.00 stddev:5.31 (3.6%) stddev-sans-first:5.32 20:16:04 INFO - PROCESS | 27242 | Values: 139.0 138.0 151.0 150.0 147.0 139.0 142.0 149.0 147.0 138.0 20:16:04 INFO - PROCESS | 27242 | 20:16:04 INFO - PROCESS | 27242 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:69.80 Median:70.00 stddev:1.32 (1.9%) stddev-sans-first:1.32 20:16:04 INFO - PROCESS | 27242 | Values: 71.0 69.0 71.0 72.0 70.0 69.0 70.0 68.0 70.0 68.0 20:16:04 INFO - PROCESS | 27242 | -------- Summary: end -------- 20:16:04 INFO - PROCESS | 27242 | 20:16:05 INFO - TEST-INFO | 27242: exit 0 20:16:05 INFO - TEST-OK | kraken | took 60760ms 20:16:05 INFO - TEST-START | v8_7 20:16:05 INFO - operating with platform_type : linux_ 20:16:05 INFO - Initialising browser for v8_7 test... 20:16:05 INFO - TEST-INFO | started process 27491 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpO8hv7Q/profile http://localhost:34655/getInfo.html) 20:16:09 INFO - PROCESS | 27491 | __metrics Screen width/height:1600/1200 20:16:09 INFO - PROCESS | 27491 | colorDepth:24 20:16:09 INFO - PROCESS | 27491 | Browser inner width/height: 1024/697 20:16:09 INFO - PROCESS | 27491 | __metrics 20:16:09 INFO - PROCESS | 27491 | JavaScript error: resource://gre/modules/PerformanceStats.jsm, line 211: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIPerformanceStatsService.isMonitoringJank] 20:16:10 INFO - PROCESS | 27491 | JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 20:16:11 INFO - TEST-INFO | 27491: exit 0 20:16:11 INFO - Browser initialized. 20:16:11 INFO - Running cycle 1/1 for v8_7 test... 20:16:11 INFO - TEST-INFO | started process 27570 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpO8hv7Q/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/v8_7/v8.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 20:16:22 INFO - PROCESS | 27570 | RSS: Main: 150306816 20:16:22 INFO - PROCESS | 27570 | 20:16:44 INFO - PROCESS | 27570 | Cycle 1(1): loaded http://localhost:34655/tests/v8_7/run.html (next: http://localhost:34655/tests/v8_7/run.html) 20:16:44 INFO - PROCESS | 27570 | RSS: Main: 451977216 20:16:44 INFO - PROCESS | 27570 | 20:16:44 INFO - PROCESS | 27570 | __start_tp_report 20:16:44 INFO - PROCESS | 27570 | _x_x_mozilla_page_load 20:16:44 INFO - PROCESS | 27570 | _x_x_mozilla_page_load_details 20:16:44 INFO - PROCESS | 27570 | |i|pagename|runs| 20:16:44 INFO - PROCESS | 27570 | |0;Richards;168.66250632484397 20:16:44 INFO - PROCESS | 27570 | |1;DeltaBlue;185.7700167193015 20:16:44 INFO - PROCESS | 27570 | |2;Encrypt;278.31895352073474 20:16:44 INFO - PROCESS | 27570 | |3;Decrypt;5186.5284974093265 20:16:44 INFO - PROCESS | 27570 | |4;RayTrace;2053.388090349076 20:16:44 INFO - PROCESS | 27570 | |5;Earley;791.1392405063291 20:16:44 INFO - PROCESS | 27570 | |6;Boyer;12256.09756097561 20:16:44 INFO - PROCESS | 27570 | |7;RegExp;26921.052631578947 20:16:44 INFO - PROCESS | 27570 | |8;Splay;600.1199040767386 20:16:44 INFO - PROCESS | 27570 | |9;NavierStokes;4835.748792270531 20:16:44 INFO - PROCESS | 27570 | __end_tp_report 20:16:44 INFO - PROCESS | 27570 | __startTimestamp1450844204617__endTimestamp 20:16:44 INFO - PROCESS | 27570 | 20:16:44 INFO - PROCESS | 27570 | ------- Summary: start ------- 20:16:44 INFO - PROCESS | 27570 | Number of tests: 10 20:16:44 INFO - PROCESS | 27570 | 20:16:44 INFO - PROCESS | 27570 | [#0] Richards Cycles:1 Average:168.66 Median:168.66 stddev:0.00 (0.0%) 20:16:44 INFO - PROCESS | 27570 | Values: 168.7 20:16:44 INFO - PROCESS | 27570 | 20:16:44 INFO - PROCESS | 27570 | [#1] DeltaBlue Cycles:1 Average:185.77 Median:185.77 stddev:0.00 (0.0%) 20:16:44 INFO - PROCESS | 27570 | Values: 185.8 20:16:44 INFO - PROCESS | 27570 | 20:16:44 INFO - PROCESS | 27570 | [#2] Encrypt Cycles:1 Average:278.32 Median:278.32 stddev:0.00 (0.0%) 20:16:44 INFO - PROCESS | 27570 | Values: 278.3 20:16:44 INFO - PROCESS | 27570 | 20:16:44 INFO - PROCESS | 27570 | [#3] Decrypt Cycles:1 Average:5186.53 Median:5186.53 stddev:0.00 (0.0%) 20:16:44 INFO - PROCESS | 27570 | Values: 5186.5 20:16:44 INFO - PROCESS | 27570 | 20:16:44 INFO - PROCESS | 27570 | [#4] RayTrace Cycles:1 Average:2053.39 Median:2053.39 stddev:0.00 (0.0%) 20:16:44 INFO - PROCESS | 27570 | Values: 2053.4 20:16:44 INFO - PROCESS | 27570 | 20:16:44 INFO - PROCESS | 27570 | [#5] Earley Cycles:1 Average:791.14 Median:791.14 stddev:0.00 (0.0%) 20:16:44 INFO - PROCESS | 27570 | Values: 791.1 20:16:44 INFO - PROCESS | 27570 | 20:16:44 INFO - PROCESS | 27570 | [#6] Boyer Cycles:1 Average:12256.10 Median:12256.10 stddev:0.00 (0.0%) 20:16:44 INFO - PROCESS | 27570 | Values: 12256.1 20:16:44 INFO - PROCESS | 27570 | 20:16:44 INFO - PROCESS | 27570 | [#7] RegExp Cycles:1 Average:26921.05 Median:26921.05 stddev:0.00 (0.0%) 20:16:44 INFO - PROCESS | 27570 | Values: 26921.1 20:16:44 INFO - PROCESS | 27570 | 20:16:44 INFO - PROCESS | 27570 | [#8] Splay Cycles:1 Average:600.12 Median:600.12 stddev:0.00 (0.0%) 20:16:44 INFO - PROCESS | 27570 | Values: 600.1 20:16:44 INFO - PROCESS | 27570 | 20:16:44 INFO - PROCESS | 27570 | [#9] NavierStokes Cycles:1 Average:4835.75 Median:4835.75 stddev:0.00 (0.0%) 20:16:44 INFO - PROCESS | 27570 | Values: 4835.7 20:16:44 INFO - PROCESS | 27570 | -------- Summary: end -------- 20:16:44 INFO - PROCESS | 27570 | 20:16:45 INFO - TEST-INFO | 27570: exit 0 20:16:45 INFO - TEST-OK | v8_7 | took 40066ms 20:16:45 INFO - SUITE-END | took 1218s 20:16:45 INFO - Completed test suite (00:20:19) 20:16:45 INFO - Working with test: dromaeo_css 20:16:45 INFO - Generating results file: dromaeo_css 20:16:45 INFO - Working with test: kraken 20:16:45 INFO - Generating results file: kraken 20:16:45 INFO - javascript benchmark 20:16:45 INFO - Working with test: v8_7 20:16:45 INFO - Generating results file: v8_7 20:16:45 INFO - Posting result 0 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 20:16:45 INFO - process_Request line: dromaeo_css graph.html#tests=[[72,132,35]] 20:16:45 INFO - process_Request line: dromaeo_css 6240.03 graph.html#tests=[[72,132,35]] 20:16:45 INFO - Posting result 1 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 20:16:45 INFO - process_Request line: kraken 1522.90 graph.html#tests=[[232,132,35]] 20:16:45 INFO - Posting result 2 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 20:16:45 INFO - process_Request line: v8_7 19710.82 graph.html#tests=[[230,132,35]] 20:16:45 INFO - RETURN: dromaeo_css: 6240.03 20:16:45 INFO - RETURN: kraken: 1522.90 20:16:45 INFO - RETURN: v8_7: 19710.82 20:16:45 INFO - javascript benchmark 20:16:46 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [2594.5200137974475, 2688.271036641502, 2689.905853295135, 2697.460507898421, 2711.389937264116, 4366.214081465343, 4480.596746292833, 4645.814167433303, 4668.789904454299, 4677.415323084619, 4486.842960496383, 4544.477385100715, 4565.360849481067, 4602.493725690179, 4744.596709279706, 4065.5527891931865, 4217.051163488221, 4226.725262857904, 4237.766922819236, 4332.442129744661, 4291.871243862704, 4354.368616550598, 4359.978200108995, 4360.585744354281, 4421.491528474218, 4123.835046598132, 4160.9375859362135, 4254.085371645111, 4254.319308910591, 4272.2950713132295, 4289.1850548395705, 4317.633001194871, 4320.17916595849, 4329.220740266751, 4336.176126535979, 4302.204092242945, 4307.181635489247, 4321.24378233811, 4325.091730736549, 4338.240807858644, 4414.602685758297, 4510.932336014962, 4513.9843535204645, 4529.796159172845, 4669.509701481364, 4926.211806111005, 4970.2793095001025, 4975.577075948549, 4976.4277108132665, 5017.197248440232, 4991.126552853236, 5000.774965126578, 5002.049610573979, 5002.624803139779, 5006.899862002776, 4345.261305578059, 4454.688171828006, 4457.955420445754, 4531.229690952546, 4667.13657973276, 5093.719845408464, 5133.4096578893905, 5141.2288156776785, 5142.202958541432, 5173.456787037307, 4927.063857866994, 4929.408470983505, 4937.703737775673, 4973.801047958041, 4980.8754781130765, 4791.5687588117235, 4834.661573689808, 4919.3604831371695, 4921.729304888266, 4925.950740492549, 4877.658563900563, 4932.284818701268, 4935.605151587936, 4945.406551213878, 4958.132326842788, 4910.484399138039, 4928.236123400879, 4928.950710492921, 4935.975320123376, 4966.205407134841, 3963.920721585552, 4030.1939612077117, 4150.045489537423, 4160.979195104005, 4202.789860506962, 3541.734369922266, 3602.657747513982, 3624.873129440457, 3626.5104210931186, 3652.3060618482405, 4329.913401732011, 4335.328024156261, 4348.217320882209, 4371.519132895442, 4383.123375324948, 4736.407949006374, 5003.199488081962, 5003.499650034967, 5005.399352077774, 5012.8496145115705, 4225.598568136023, 4268.189044081614, 4283.164782867373, 4283.764392958417, 4342.240107981091, 4381.3427985801745, 4401.933970990438, 4402.977985110054, 4439.134368798053, 4440.555944405533, 4661.906761864811, 4724.763761811896, 4766.189747742961, 4771.95228047729, 4810.4708482067645, 4754.952450475451, 4871.293662418859, 4874.8537543873745, 4996.075725990703, 5028.874278143076, 4633.30500424939, 4732.361131247238, 4734.360861283682, 4734.8342808002935, 4777.8088876445945, 4933.309336692794, 4941.481144479778, 4977.800887964441, 4980.228064649985, 4983.127952608352, 4738.194506933761, 4834.178189707688, 4884.609231261562, 5052.621053421081, 5078.4667609900425, 4632.745199013952, 4738.881527961691, 4746.73892935878, 4772.49888761675, 4773.522647735199, 4831.589314908272, 4857.077155340474, 4859.854204373874, 4869.099216644932, 4901.534354236342, 4617.422822147231, 4758.238681811032, 4760.952390476051, 4762.047590481987, 4778.092162489116, 4749.786259618395, 4825.155597770306, 4843.128236917248, 4845.442774080885, 4847.587955023721, 4725.6219502439035, 4734.857954261378, 4735.0, 4753.096911586787, 4780.856574302777], "unit": "score", "name": "dojo.html", "value": 4544.814601610513}, {"lowerIsBetter": false, "replicates": [557.3924422379608, 560.3332034878495, 565.1212364772776, 565.9575531835111, 568.9687067211303, 26838.86580567097, 35463.0, 36074.639253607456, 36085.278294434094, 36162.0, 38878.41682374767, 39411.21177576447, 39458.60541394585, 39465.605343946554, 39530.20939581214, 6854.34883686049, 6962.651867406635, 7828.412869034831, 8011.158828323029, 8012.63943122558, 10147.391156530632, 10436.373817570931, 10446.477676116163, 10448.63429779958, 10452.895471045269, 10148.84776728346, 10237.385756854575, 10251.538680759384, 10254.282200245985, 10259.692209233697, 7187.856242875139, 7369.410447164214, 7373.77878663641, 7374.336309732096, 10083.899161008407, 10263.281570290083, 10565.471726413725, 10575.524101415454, 10579.153667706565, 10580.788384232272, 37214.0, 37719.24561508782, 37823.0, 37919.810400948096, 37946.0, 2675.103840213531, 2815.000674760451, 3121.6566177720433, 3310.0543397276147, 3671.1923376857317, 28853.278668033257, 29089.563656545168, 29437.85281073581, 29543.409131817243, 30211.848940755375, 3327.6505966873374, 3370.1911541230174, 3420.572428446444, 3459.377312083824, 3567.518385018015, 209532.0, 210750.0, 211194.0, 211229.0, 211242.0, 56677.43322566721, 57111.0, 57124.42875571274, 57126.42873571294, 57172.0, 59742.0, 60064.399356006754, 60072.69963650154, 60214.69892650509, 60258.0, 13973.441062357391, 14222.502212422722, 14264.42942282318, 14307.0, 14335.85664143366, 10691.893081069245, 10825.242233043611, 10825.458727063773, 10829.0, 10832.891671083189, 19043.430456294445, 19470.8052919469, 19474.610507789766, 19499.90250048769, 19527.90236048839, 7011.26381729911, 7277.19950805411, 7344.779656610311, 7379.446541509408, 7389.963050184822, 815.8327542853701, 834.1200033964104, 897.4794619120894, 901.193431878465, 947.1475671895212, 22979.885100574724, 23221.651675224886, 23892.641610375857, 25010.624840627406, 25122.24633261005, 827.9379046571531, 931.1154403316876, 939.2251392601131, 963.1428029054148, 1016.7356487313203, 12755.617331479885, 13119.278439685719, 13137.408816603276, 13150.60548183556, 13172.0, 254623.0, 260878.0, 261196.0, 261341.0, 261517.0, 38804.80597597051, 39335.0, 39341.0, 39343.40984885229, 39352.409713854315, 1197.1859135787747, 1219.4085868354018, 1230.7292395672937, 1231.2920070959235, 1234.7839128152536, 23416.414589635395, 26012.609810852475, 27213.814300705955, 27482.862585686944, 27551.586726198722, 41074.58925410708, 41338.379924301764, 41359.586404135574, 41487.170256594094, 41489.37765933574, 200763.0, 201910.0, 202108.0, 202250.0, 202389.0, 24318.148864789648, 24413.51172976495, 28236.71763282423, 28327.858360708065, 28445.715542844307, 34008.14979625529, 34563.0, 34798.82600586981, 34818.65181348255, 35054.29891402107, 31081.222969425944, 31748.365032698755, 32723.34553308873, 33273.0, 33357.499637504974, 32037.519437207993, 32388.35223295568, 32693.509597356533, 32814.34371312608, 32999.0, 32203.51694724628, 32683.34633307368, 32876.835615821765, 32912.17719556935, 32966.34067318688, 28936.855315723285, 29469.26326841846, 29971.004130918092, 30275.697243027287, 32216.0, 23094.884525577938, 23132.0, 23239.0, 23511.41221469477, 24574.13990510395], "unit": "score", "name": "ext.html", "value": 16873.428870869822}, {"lowerIsBetter": false, "replicates": [331.47130327128224, 335.7448339262161, 336.45662255457427, 337.1268414805653, 338.93899098162336, 12537.49850006001, 12790.616281511546, 15864.603384915383, 16103.83896161038, 16836.74744878826, 12277.324747138904, 12956.481740730384, 14572.854271457281, 15021.399144034225, 15489.070655760663, 4728.17256980028, 4906.460289368167, 4911.926321105187, 4913.041956818422, 4913.31213630092, 3759.285735710206, 4915.139850526144, 4951.702897826142, 4953.331300274453, 4956.578690811268, 4345.391645169679, 5655.095184770437, 5662.688552129631, 5676.744546495397, 5684.630499017571, 5477.260569823063, 5614.691191984439, 5637.436256374371, 5637.520810731093, 5648.971755141239, 5058.064258112224, 5074.112030394666, 5080.491950804927, 5080.695158290478, 5081.060003899291, 18769.812301876944, 18897.33859314931, 19223.231070757152, 19268.325608603773, 19688.31090911811, 1882.990585047066, 1901.7717873855088, 1953.345629214215, 1974.99012504938, 1981.8315443187346, 12668.68328291791, 12769.48922043117, 12838.293893835835, 13085.345732713326, 13161.802572961413, 1720.096949101719, 1763.8853474524115, 1764.682357175708, 1779.359430604981, 1809.8733088683798, 53141.0, 55346.0, 55683.0, 55892.720536397464, 56218.71890640521, 9168.404053736485, 9285.62857485693, 9400.529973501434, 9407.811843763086, 9442.433453992782, 11972.580959666544, 12003.459844306852, 12012.63962081139, 12054.638360849189, 12094.153409261267, 6974.895376569356, 7038.0, 7150.10623672041, 7169.820754481179, 7225.205227424979, 6796.320367963164, 6846.0, 6849.1438570178725, 6884.65576721162, 6892.689828957709, 5694.231278777394, 5738.053221218453, 5786.681732504669, 5802.535797136304, 5819.679917604572, 1564.2726132348512, 1631.8541118429227, 1665.4087798831483, 1668.2909763350528, 1669.6410271791624, 767.6353731977266, 835.3859912963967, 1005.969820905374, 1010.9898901011043, 1017.5421060522795, 15943.282552285174, 16435.342586296414, 16472.917635411985, 16758.413455528997, 16804.243809028623, 737.4027038099157, 828.5443006346485, 870.6473878079388, 882.4572887674034, 901.977450563728, 8867.73396798097, 9062.326430214982, 9270.67552635668, 9303.58133883977, 9342.2526197904, 314400.4279978631, 442573.0, 447552.0, 448684.0, 484271.0, 66085.0, 66535.33464665388, 67047.0, 67955.0, 68701.0, 440.8368903505659, 451.74702166786705, 452.0506935435559, 453.4581175495317, 453.94325709287, 9654.131128198496, 9662.565184566853, 9923.206143508358, 10011.649592264235, 14014.579562613138, 29983.100506984825, 30351.696483034888, 31338.373232535676, 31778.52332215065, 32075.518867216542, 37568.060798479164, 40929.0, 43139.13721725611, 43411.782941086356, 46313.53686463227, 8780.517071561126, 8961.83496145497, 9078.319126065704, 9089.500077495537, 9095.590698418455, 16293.67412651764, 16382.098984555963, 16393.0, 16756.58108547296, 16987.745183822004, 13372.598822035354, 13969.603039696356, 14221.857781422053, 14293.213873236657, 14300.157602069296, 13535.729285414434, 13769.387255269598, 13871.375788089763, 14078.507252246121, 14106.435742570593, 10547.57809687604, 13168.47326106945, 13420.731585368434, 14050.718985620435, 14806.111633302036, 8755.343349248958, 8777.51723655205, 8838.823223535364, 8849.867251991354, 8860.734177974671, 9260.53697315118, 9339.346245762732, 9383.953080234554, 11778.174382970654, 13467.528636497676], "unit": "score", "name": "jquery.html", "value": 8080.906262934649}, {"lowerIsBetter": false, "replicates": [1440.4526280013592, 1506.7815166800815, 1516.590520559449, 1561.882858785591, 1635.9591010224747, 5681.034224181889, 6754.696038678259, 6989.825254368637, 6990.650467476618, 7004.229534751174, 6858.794236172923, 6980.05769221155, 6996.265392133829, 6998.0, 7015.263397343269, 2027.7668068172165, 2057.722207501983, 2058.207590077816, 2059.042545216474, 2059.155746144081, 2044.0290861840656, 2067.7105205271273, 2075.553755942472, 2086.7600225974056, 2088.926887558936, 2017.677171652536, 2063.8968051597435, 2092.0272073485826, 2092.8430367722403, 2093.037202886674, 2069.2964392106683, 2089.780573039824, 2093.602215579035, 2096.6854971754283, 2098.6117568249924, 2021.272341956909, 2045.6113338465643, 2048.1295449433933, 2049.692546118094, 2073.0360382422095, 6973.651317434108, 7063.187733410672, 7066.222715501291, 7066.787996360117, 7069.328413800681, 4090.836366545335, 4170.833166673329, 4187.790610469495, 4187.853425130136, 4190.350495673176, 2684.073994471904, 2701.446203528272, 2733.330334068146, 2771.584262360642, 2773.084881988939, 880.665347168072, 901.8061116859907, 902.5261737587754, 922.2391526990193, 932.1563984593953, 9266.16604505591, 9277.211437027861, 9290.860637090449, 9348.57931393089, 9352.0, 3782.3002744492355, 3813.6758375537834, 3824.0, 3828.885133446001, 3878.340682083996, 8100.311473524698, 8126.9593652032545, 8127.146649601825, 8128.187181281943, 8137.674493020331, 4160.83356665736, 4166.83332666696, 4181.226473102486, 4184.958150418518, 4188.308929026676, 3199.760017998613, 3269.869205231764, 3800.733948623625, 3808.3906574947873, 3814.6757525610633, 3380.6281309055985, 3380.645032271625, 3383.154211447138, 3402.6937575617817, 3431.811250381203, 1068.4016950507742, 1070.68414817629, 1075.3547871277171, 1075.8063548561177, 1098.0392156862745, 1128.6839684888243, 1136.0003197186422, 1150.2121047082608, 1151.476078384333, 1183.4556104192168, 6598.538102332886, 6670.833229169212, 6677.933220667731, 6689.096971908827, 6709.0, 454.5204808926614, 457.1223251357402, 458.07240338315177, 461.3610149942287, 462.1750175935938, 5216.895662086737, 5262.2632831403635, 5266.368035835724, 5271.077561426735, 5273.2617433559335, 8191.262786349138, 8212.260896519341, 8332.708355207538, 8396.748097557083, 8474.279686226617, 8294.8341033179, 8312.584370781437, 8315.542645154575, 8318.750437486886, 8330.166983301742, 6534.542582019308, 6554.9672251639395, 6595.406413422719, 6613.140291762136, 6620.602763834186, 6373.6175829450385, 6397.680115994275, 6409.359064093554, 6411.102445657519, 6418.0, 7313.195548489768, 7442.0, 7452.590107543921, 7522.924770752223, 7530.811729706801, 7522.247775222653, 7555.9244407555225, 7662.540247585162, 7708.884366734392, 7743.883841742266, 5181.326427564392, 5297.443768404262, 5302.072137376021, 6263.96868015657, 6333.524985626004, 5347.304850369427, 5573.972130139324, 6360.872782544416, 6509.316521765147, 6516.185476815398, 6206.348333425106, 6228.906566401417, 6295.811125666238, 6333.081703153109, 6380.361963803768, 5853.64878107315, 5885.205497257815, 5910.349861515144, 5965.433283838029, 5994.130851026664, 6285.214348206474, 6333.050042493663, 6342.207224096988, 6344.968275158594, 6348.555601107878, 5679.176519404746, 5708.743106560298, 5709.20071190042, 5711.057675483498, 5721.370649228665, 5531.557475401878, 5548.278723765885, 5577.27495425592, 5675.77296908119, 5684.8294551163535], "unit": "score", "name": "mootools.html", "value": 3929.0218393599353}, {"lowerIsBetter": false, "replicates": [302.8606840853207, 305.7401208972374, 315.5881574545218, 317.2196396863715, 318.71793462785445, 5193.221016847475, 5262.342207224097, 5280.762365693543, 5303.337082864642, 5307.442718514559, 5232.764525596348, 5249.790008399669, 5251.816186433475, 5252.658577192489, 5253.7373131343475, 3919.03983524037, 4059.8782036538805, 4136.33818589025, 4139.3583994480905, 4143.295639741236, 4040.2929487339743, 4091.89770255743, 4116.6912481564, 4119.237940980928, 4123.9381409278885, 4062.2687916175078, 4076.4700588923397, 4078.1028173801715, 4079.2663118174805, 4079.3473044312914, 3857.42138679199, 3941.192055628589, 3971.801409929492, 4074.0, 4083.3670781028986, 3622.492851000862, 3623.691986181178, 3631.110377957391, 3641.817909104534, 3647.927041459156, 5047.520485553867, 5056.089903817311, 5057.241413787924, 5057.645964782467, 5063.443021267658, 4707.693999890031, 4714.316424118518, 4720.976395118037, 4725.385699859031, 4728.905421891543, 5352.946470535284, 5503.6147469677135, 5506.063969125258, 5518.475744804237, 5519.199716041152, 3866.3620502617036, 3876.9612303877166, 3878.6897048236074, 3881.3207688654375, 3890.8054597270307, 5732.5127364174095, 5792.333881603628, 5808.244928159313, 5815.127730840408, 5816.360200377955, 4001.559828418872, 4005.6995725320717, 4008.8797336079965, 4010.5387880393546, 4012.6990475713856, 3957.0700885291935, 4066.837326506966, 4068.6745060395097, 4075.612816782401, 4092.6930480214105, 4660.673752837337, 4661.603763680057, 4665.0903073900945, 4666.160091183551, 4668.836590719308, 5553.416891226363, 5553.8333849984565, 5560.471755183332, 5564.0, 5566.888662226814, 1413.1732936232213, 1437.374741987218, 1438.9352479138463, 1439.4314245873031, 1440.7838824176458, 965.4400447740294, 965.4496936746128, 974.4250891973769, 998.0568362897138, 1000.7948370584013, 4925.926111108336, 4935.432425271139, 4936.7284799336385, 4937.333459982857, 4938.802447902115, 5746.396628354046, 5756.856078598069, 5763.7982670606325, 5765.625234359753, 5765.913511297334, 4889.0, 4917.336159618477, 4932.4081110267, 4933.0, 4937.802487900443, 2864.427114577093, 2982.4035192961496, 3063.7702172336717, 3070.309180434429, 3091.180837078176, 5487.972560137174, 5494.066008778517, 5494.09347457673, 5495.862603434866, 5498.230247765316, 5882.117682347682, 5921.052631578927, 5923.259592550931, 5929.450336355322, 5935.109733540004, 5475.0418676731415, 5480.205370221295, 5481.890362192734, 5485.259489968803, 5490.258815060076, 5562.5549956002615, 5767.8558036049435, 5783.103618939072, 5794.333651629948, 5798.362180160263, 5645.661260324394, 5650.26546548946, 5653.604247702621, 5653.773849046157, 5660.320761508646, 5488.4785945335125, 5495.120780675233, 5497.092979658471, 5499.092649712913, 5506.1190209566275, 3906.511686039245, 3952.9209415810947, 4020.3768415895584, 4020.6783457323927, 4022.1955608878925, 5776.335721392094, 5786.479216870502, 5787.768489260551, 5793.91309130355, 5795.420457954171, 5576.888462230814, 5584.46947539983, 5587.217789509391, 5587.832365029056, 5591.245181900392, 5545.833624991256, 5576.944230557642, 5581.804636837691, 5584.413636568264, 5591.329040515164, 5350.117230656898, 5390.00284947286, 5468.0, 5468.808591699271, 5471.316085489314, 5599.916001259903, 5611.719414029364, 5613.522850557748, 5619.100943848965, 5623.0, 5231.503007214308, 5403.0544654686055, 5411.512963833274, 5411.648242864201, 5416.593755468277], "unit": "score", "name": "prototype.html", "value": 4182.141067876985}, {"lowerIsBetter": false, "replicates": [698.1308271202354, 767.4244316762428, 768.3660979691753, 783.4750717019598, 808.3977436809578, 12015.0, 12285.324307163102, 12309.0, 12318.137730358878, 12321.63035108946, 11781.469833857476, 13352.599422017354, 13571.457141714343, 13572.932135339333, 13581.592552223448, 650.1677852348977, 652.3672038123013, 817.3910436724649, 826.5123577089516, 834.7704381295132, 776.2276534847806, 814.6008455856647, 822.3873214455209, 830.6179157587487, 830.7258604660448, 830.2403300979596, 868.2663149638545, 875.3172525430175, 875.483464755794, 877.0484024833032, 671.7480944645757, 672.525869262169, 850.090403268503, 859.5873980489338, 863.365426411587, 608.9451949324582, 618.4403115180723, 635.6662752055162, 636.8280564247627, 638.9488840892717, 12451.066170037284, 12472.126951113425, 12550.74898502025, 12559.623211303675, 12648.936755316257, 11601.709957251052, 11689.415529223505, 11944.761104777856, 12055.578054768128, 12566.120371573994, 9652.855207171899, 9812.411255324632, 9884.604615815359, 9977.451240181786, 10087.89912100877, 3208.1177676139014, 3240.54632351471, 3314.436545787222, 3324.883629072971, 3429.262708517656, 41053.384199237036, 41077.38383924244, 41315.58684413177, 41342.37986430206, 41369.0, 9765.267604929517, 9782.315237933419, 9944.35361701487, 9953.104220620178, 9970.102690757867, 17426.0, 17463.82536174622, 17482.912585437247, 17500.0, 17510.474685759447, 6444.548881578245, 6483.189601299838, 6551.8362040948405, 6552.8361790955605, 6745.898811517831, 3756.6806821420487, 3793.1465420280215, 3810.0855794609647, 3836.7889766063136, 3905.1018265799025, 2761.351082495612, 2764.8064635475725, 2786.024891288033, 2786.4705705915812, 2793.0782841662203, 495.22002845518455, 495.774422637699, 502.3494574525998, 503.22754571732213, 506.80488012114864, 483.89838133992254, 568.7383803450376, 573.1975234671494, 584.6703026265378, 596.6927032578226, 7444.292792184842, 7565.962170189114, 7686.154523002465, 7750.844983100306, 7786.338161256243, 453.33359960857484, 466.160910361355, 527.3776943207052, 590.1383979390052, 604.474107526446, 3484.111551554388, 3561.1453251219523, 3624.800635965047, 3639.70882329413, 3694.8522059117336, 46287.83409493162, 50361.496385036415, 50725.0, 51255.74372128116, 51324.74337628288, 45064.54935450669, 45085.0, 45946.5405345949, 46127.0, 46831.765841171255, 40348.79825600853, 41533.584664153575, 42202.15595688069, 42329.1534169321, 42404.0, 7498.287662672037, 7826.569538675428, 7910.090339610788, 7984.8003799903145, 8157.143499932659, 30128.3974320508, 31933.840330798197, 32294.515582265816, 32316.83841580871, 32353.676463235068, 41066.38400424056, 41110.588894110675, 41129.588704113776, 41406.37890431706, 41557.58442415658, 9655.227581793299, 9759.316847820584, 9814.607415703578, 9973.152282056106, 10283.94858025705, 10746.785064298827, 10785.352878827296, 10830.837537436788, 10837.945810271214, 11019.83470247963, 9609.375390599589, 9635.903640963501, 9822.0, 9892.060254275832, 10110.89889101129, 10114.089731924161, 10119.898801011896, 10479.10927571165, 10495.0, 10615.522301496605, 9824.673191226657, 9901.504924753877, 10086.546105425126, 10367.533460994424, 10387.68836934893, 8768.736937891874, 9084.40951338161, 9195.54022298869, 9472.33693641466, 9678.85481717789, 8446.619902104298, 9075.319351048829, 9260.629574817202, 9363.578638961128, 9483.905160948578], "unit": "score", "name": "yui.html", "value": 5797.084810286198}], "name": "dromaeo_css", "value": 6240.027671415377}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [112.0, 113.0, 109.0, 113.0, 115.0, 114.0, 104.0, 112.0, 112.0, 121.0], "unit": "score", "name": "ai-astar", "value": 112.5}, {"lowerIsBetter": true, "replicates": [152.0, 134.0, 154.0, 174.0, 131.0, 162.0, 151.0, 129.0, 168.0, 135.0], "unit": "score", "name": "audio-beat-detection", "value": 149.0}, {"lowerIsBetter": true, "replicates": [160.0, 162.0, 159.0, 160.0, 161.0, 160.0, 162.0, 163.0, 160.0, 161.0], "unit": "score", "name": "audio-dft", "value": 160.8}, {"lowerIsBetter": true, "replicates": [75.0, 73.0, 82.0, 104.0, 72.0, 73.0, 72.0, 104.0, 88.0, 74.0], "unit": "score", "name": "audio-fft", "value": 81.7}, {"lowerIsBetter": true, "replicates": [95.0, 95.0, 133.0, 94.0, 95.0, 95.0, 135.0, 95.0, 95.0, 133.0], "unit": "score", "name": "audio-oscillator", "value": 106.5}, {"lowerIsBetter": true, "replicates": [109.0, 109.0, 109.0, 110.0, 109.0, 109.0, 110.0, 109.0, 110.0, 110.0], "unit": "score", "name": "imaging-gaussian-blur", "value": 109.4}, {"lowerIsBetter": true, "replicates": [146.0, 146.0, 146.0, 145.0, 147.0, 146.0, 146.0, 146.0, 146.0, 147.0], "unit": "score", "name": "imaging-darkroom", "value": 146.1}, {"lowerIsBetter": true, "replicates": [95.0, 95.0, 95.0, 95.0, 95.0, 95.0, 95.0, 96.0, 95.0, 95.0], "unit": "score", "name": "imaging-desaturate", "value": 95.1}, {"lowerIsBetter": true, "replicates": [70.0, 70.0, 70.0, 70.0, 70.0, 71.0, 70.0, 70.0, 72.0, 69.0], "unit": "score", "name": "json-parse-financial", "value": 70.2}, {"lowerIsBetter": true, "replicates": [67.0, 68.0, 67.0, 68.0, 67.0, 68.0, 69.0, 68.0, 68.0, 68.0], "unit": "score", "name": "json-stringify-tinderbox", "value": 67.8}, {"lowerIsBetter": true, "replicates": [85.0, 85.0, 85.0, 85.0, 92.0, 87.0, 86.0, 84.0, 83.0, 85.0], "unit": "score", "name": "stanford-crypto-aes", "value": 85.7}, {"lowerIsBetter": true, "replicates": [130.0, 127.0, 124.0, 118.0, 124.0, 117.0, 127.0, 121.0, 130.0, 125.0], "unit": "score", "name": "stanford-crypto-ccm", "value": 124.3}, {"lowerIsBetter": true, "replicates": [139.0, 138.0, 151.0, 150.0, 147.0, 139.0, 142.0, 149.0, 147.0, 138.0], "unit": "score", "name": "stanford-crypto-pbkdf2", "value": 144.0}, {"lowerIsBetter": true, "replicates": [71.0, 69.0, 71.0, 72.0, 70.0, 69.0, 70.0, 68.0, 70.0, 68.0], "unit": "score", "name": "stanford-crypto-sha256-iterative", "value": 69.8}], "name": "kraken", "value": 1522.8999999999999}, {"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [168.66250632484397], "unit": "score", "name": "Richards", "value": 209.30555800000002}, {"lowerIsBetter": false, "replicates": [185.7700167193015], "unit": "score", "name": "DeltaBlue", "value": 355.9131939999999}, {"lowerIsBetter": false, "replicates": [278.31895352073474], "unit": "score", "name": "Encrypt", "value": 956.3883330000003}, {"lowerIsBetter": false, "replicates": [5186.5284974093265], "unit": "score", "name": "Decrypt", "value": 51.32161138861136}, {"lowerIsBetter": false, "replicates": [2053.388090349076], "unit": "score", "name": "RayTrace", "value": 360.37464300000005}, {"lowerIsBetter": false, "replicates": [791.1392405063291], "unit": "score", "name": "Earley", "value": 842.4092320000002}, {"lowerIsBetter": false, "replicates": [12256.09756097561], "unit": "score", "name": "Boyer", "value": 54.378075621890574}, {"lowerIsBetter": false, "replicates": [26921.052631578947], "unit": "score", "name": "RegExp", "value": 33.83913000977518}, {"lowerIsBetter": false, "replicates": [600.1199040767386], "unit": "score", "name": "Splay", "value": 135.7911968031968}, {"lowerIsBetter": false, "replicates": [4835.748792270531], "unit": "score", "name": "NavierStokes", "value": 306.881118881119}], "name": "v8_7", "value": 19710.82213332183}]} 20:16:46 INFO - TinderboxPrint: TalosResult: {"graphserver": {"v8_7": {"url": "http://graphs.mozilla.org/graph.html#tests=[[230,132,35]]", "result": "19710.82"}, "kraken": {"url": "http://graphs.mozilla.org/graph.html#tests=[[232,132,35]]", "result": "1522.90"}, "dromaeo_css": {"url": "http://graphs.mozilla.org/graph.html#tests=[[72,132,35]]", "result": "6240.03"}}} 20:16:46 INFO - Return code: 0 20:16:46 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 20:16:46 ERROR - # TBPL SUCCESS # 20:16:46 INFO - Running post-action listener: _resource_record_post_action 20:16:46 INFO - Running post-run listener: _resource_record_post_run 20:16:47 INFO - Total resource usage - Wall time: 1236s; CPU: 13.0%; Read bytes: 16384; Write bytes: 547569664; Read time: 392; Write time: 477996 20:16:47 INFO - install - Wall time: 16s; CPU: 13.0%; Read bytes: 4096; Write bytes: 227282944; Read time: 240; Write time: 204316 20:16:47 INFO - run-tests - Wall time: 1221s; CPU: 13.0%; Read bytes: 12288; Write bytes: 319967232; Read time: 152; Write time: 273648 20:16:47 INFO - Running post-run listener: _upload_blobber_files 20:16:47 INFO - Blob upload gear active. 20:16:47 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 20:16:47 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 20:16:47 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', 'Fx-Team-Non-PGO', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 20:16:47 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 Fx-Team-Non-PGO -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 20:16:47 INFO - (blobuploader) - INFO - Open directory for files ... 20:16:47 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 20:16:47 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 20:16:47 INFO - (blobuploader) - INFO - Uploading, attempt #1. 20:16:48 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 20:16:48 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 20:16:48 INFO - (blobuploader) - INFO - Done attempting. 20:16:48 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 20:16:48 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 20:16:48 INFO - (blobuploader) - INFO - Uploading, attempt #1. 20:16:49 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 20:16:49 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 20:16:49 INFO - (blobuploader) - INFO - Done attempting. 20:16:49 INFO - (blobuploader) - INFO - Iteration through files over. 20:16:49 INFO - Return code: 0 20:16:49 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 20:16:49 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 20:16:49 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/65c984e4dae2595ff7abbb279396e013421fdd1f58bcaaefe1c966b0a00bb1a0f7498ec7c089609b2f5a3f341546b4a16928a89062ea80164214e6911e430933", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/4a7bc3b54918eb314131527ec7786c24e1778f4a92c944a21aaab20267b74ef01306de60198da3964e271fe0d2d46a4ba87d4558d382353d4c7d6d1de6fad2c4"} 20:16:49 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 20:16:49 INFO - Writing to file /builds/slave/test/properties/blobber_files 20:16:49 INFO - Contents: 20:16:49 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/65c984e4dae2595ff7abbb279396e013421fdd1f58bcaaefe1c966b0a00bb1a0f7498ec7c089609b2f5a3f341546b4a16928a89062ea80164214e6911e430933", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/4a7bc3b54918eb314131527ec7786c24e1778f4a92c944a21aaab20267b74ef01306de60198da3964e271fe0d2d46a4ba87d4558d382353d4c7d6d1de6fad2c4"} 20:16:49 INFO - Copying logs to upload dir... 20:16:49 INFO - mkdir: /builds/slave/test/build/upload/logs program finished with exit code 0 elapsedTime=1280.434552 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 20 secs) (at 2015-12-22 20:16:48.964817) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2015-12-22 20:16:48.968437) ========= 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=dd132779db58144225c4cf24000001c8-1450840648.905810-1207728089 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/65c984e4dae2595ff7abbb279396e013421fdd1f58bcaaefe1c966b0a00bb1a0f7498ec7c089609b2f5a3f341546b4a16928a89062ea80164214e6911e430933", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/4a7bc3b54918eb314131527ec7786c24e1778f4a92c944a21aaab20267b74ef01306de60198da3964e271fe0d2d46a4ba87d4558d382353d4c7d6d1de6fad2c4"} build_url:https://queue.taskcluster.net/v1/task/zfdtHl0HRRusmlzyLqS4XQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011195 build_url: 'https://queue.taskcluster.net/v1/task/zfdtHl0HRRusmlzyLqS4XQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/65c984e4dae2595ff7abbb279396e013421fdd1f58bcaaefe1c966b0a00bb1a0f7498ec7c089609b2f5a3f341546b4a16928a89062ea80164214e6911e430933", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/4a7bc3b54918eb314131527ec7786c24e1778f4a92c944a21aaab20267b74ef01306de60198da3964e271fe0d2d46a4ba87d4558d382353d4c7d6d1de6fad2c4"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2015-12-22 20:16:48.992954) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-12-22 20:16:48.993292) ========= 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=dd132779db58144225c4cf24000001c8-1450840648.905810-1207728089 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004559 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-12-22 20:16:49.074892) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2015-12-22 20:16:49.075219) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2015-12-22 20:16:49.075512) ========= ========= Total master_lag: 0.26 =========