builder: fx-team_ubuntu64_hw_test-dromaeojs slave: talos-linux64-ix-023 starttime: 1467769095.44 results: success (0) buildid: 20160705173822 builduid: ce2a18d89db54e60ab2431cac6d65760 revision: d8fa10d0a52eb52ee1fc46f88c37662c71af37a6 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-07-05 18:38:15.443067) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-07-05 18:38:15.443485) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-07-05 18:38:15.443758) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-07-05 18:38:15.475996) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-05 18:38:15.476300) ========= 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=6d15e502d8e29d5d2676d664000001c3-1467768580.869301-24592832 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-07-05 18:38:15-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 218M=0s 2016-07-05 18:38:15 (218 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.181795 ========= master_lag: 0.12 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-05 18:38:15.775780) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-07-05 18:38:15.776102) ========= rm -rf scripts properties in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['rm', '-rf', 'scripts', 'properties'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=6d15e502d8e29d5d2676d664000001c3-1467768580.869301-24592832 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.176199 ========= master_lag: 0.01 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-07-05 18:38:15.964447) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-07-05 18:38:15.964779) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev d8fa10d0a52eb52ee1fc46f88c37662c71af37a6 --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 d8fa10d0a52eb52ee1fc46f88c37662c71af37a6 --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=6d15e502d8e29d5d2676d664000001c3-1467768580.869301-24592832 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-07-05 18:38:16,030 truncating revision to first 12 chars 2016-07-05 18:38:16,030 Setting DEBUG logging. 2016-07-05 18:38:16,030 attempt 1/10 2016-07-05 18:38:16,030 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/d8fa10d0a52e?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-07-05 18:38:16,750 unpacking tar archive at: fx-team-d8fa10d0a52e/testing/mozharness/ program finished with exit code 0 elapsedTime=1.145283 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-07-05 18:38:17.125386) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-07-05 18:38:17.125687) ========= script_repo_revision: d8fa10d0a52eb52ee1fc46f88c37662c71af37a6 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-07-05 18:38:17.126079) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-07-05 18:38:17.126344) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-07-05 18:38:17.136822) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 50 secs) (at 2016-07-05 18:38:17.137100) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team-Non-PGO --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', '--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=6d15e502d8e29d5d2676d664000001c3-1467768580.869301-24592832 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 18:38:17 INFO - MultiFileLogger online at 20160705 18:38:17 in /builds/slave/test 18:38:17 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team-Non-PGO 18:38:17 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 18:38:17 INFO - {'append_to_log': False, 18:38:17 INFO - 'base_work_dir': '/builds/slave/test', 18:38:17 INFO - 'blob_upload_branch': 'Fx-Team-Non-PGO', 18:38:17 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 18:38:17 INFO - 'branch': 'Fx-Team-Non-PGO', 18:38:17 INFO - 'buildbot_json_path': 'buildprops.json', 18:38:17 INFO - 'config_files': ('talos/linux_config.py',), 18:38:17 INFO - 'default_actions': ('clobber', 18:38:17 INFO - 'read-buildbot-config', 18:38:17 INFO - 'download-and-extract', 18:38:17 INFO - 'populate-webroot', 18:38:17 INFO - 'create-virtualenv', 18:38:17 INFO - 'install', 18:38:17 INFO - 'run-tests'), 18:38:17 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 18:38:17 INFO - 'download_minidump_stackwalk': True, 18:38:17 INFO - 'download_symbols': 'ondemand', 18:38:17 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 18:38:17 INFO - 'tooltool.py': '/tools/tooltool.py', 18:38:17 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 18:38:17 INFO - '/tools/misc-python/virtualenv.py')}, 18:38:17 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 18:38:17 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 18:38:17 INFO - 'installer_path': 'installer.exe', 18:38:17 INFO - 'log_level': 'info', 18:38:17 INFO - 'log_name': 'talos', 18:38:17 INFO - 'log_to_console': True, 18:38:17 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 18:38:17 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 18:38:17 INFO - 'opt_config_files': (), 18:38:17 INFO - 'pip_index': False, 18:38:17 INFO - 'sps_profile': False, 18:38:17 INFO - 'sps_profile_interval': 0, 18:38:17 INFO - 'suite': 'dromaeojs', 18:38:17 INFO - 'system_bits': '32', 18:38:17 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 18:38:17 INFO - 'title': 'talos-linux64-ix-023', 18:38:17 INFO - 'tooltool_cache': '/builds/tooltool_cache', 18:38:17 INFO - 'use_talos_json': True, 18:38:17 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 18:38:17 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 18:38:17 INFO - 'work_dir': 'build'} 18:38:17 INFO - ##### 18:38:17 INFO - ##### Running clobber step. 18:38:17 INFO - ##### 18:38:17 INFO - Running pre-action listener: _resource_record_pre_action 18:38:17 INFO - Running main action method: clobber 18:38:17 INFO - rmtree: /builds/slave/test/build 18:38:17 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 18:38:19 INFO - Running post-action listener: _resource_record_post_action 18:38:19 INFO - ##### 18:38:19 INFO - ##### Finished clobber step (success) 18:38:19 INFO - ##### 18:38:19 INFO - ##### 18:38:19 INFO - ##### Running read-buildbot-config step. 18:38:19 INFO - ##### 18:38:19 INFO - Running pre-action listener: _resource_record_pre_action 18:38:19 INFO - Running main action method: read_buildbot_config 18:38:19 INFO - Using buildbot properties: 18:38:19 INFO - { 18:38:19 INFO - "project": "", 18:38:19 INFO - "product": "firefox", 18:38:19 INFO - "script_repo_revision": "production", 18:38:19 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs", 18:38:19 INFO - "repository": "", 18:38:19 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team talos dromaeojs", 18:38:19 INFO - "buildid": "20160705173822", 18:38:19 INFO - "pgo_build": "False", 18:38:19 INFO - "basedir": "/builds/slave/test", 18:38:19 INFO - "buildnumber": 3132, 18:38:19 INFO - "slavename": "talos-linux64-ix-023", 18:38:19 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 18:38:19 INFO - "platform": "ubuntu64_hw", 18:38:19 INFO - "scheduler": "tests-fx-team-linux64-talos", 18:38:19 INFO - "branch": "fx-team", 18:38:19 INFO - "repo_path": "integration/fx-team", 18:38:19 INFO - "revision": "d8fa10d0a52eb52ee1fc46f88c37662c71af37a6", 18:38:19 INFO - "stage_platform": "linux64", 18:38:19 INFO - "builduid": "ce2a18d89db54e60ab2431cac6d65760", 18:38:19 INFO - "slavebuilddir": "test" 18:38:19 INFO - } 18:38:19 INFO - Found installer url https://queue.taskcluster.net/v1/task/B-gyM-4sT3yUj5JL-ILAVA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2. 18:38:19 INFO - Running post-action listener: _resource_record_post_action 18:38:19 INFO - ##### 18:38:19 INFO - ##### Finished read-buildbot-config step (success) 18:38:19 INFO - ##### 18:38:19 INFO - ##### 18:38:19 INFO - ##### Running download-and-extract step. 18:38:19 INFO - ##### 18:38:19 INFO - Running pre-action listener: _resource_record_pre_action 18:38:19 INFO - Running main action method: download_and_extract 18:38:19 INFO - mkdir: /builds/slave/test/build/tests 18:38:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:38:19 INFO - https://queue.taskcluster.net/v1/task/B-gyM-4sT3yUj5JL-ILAVA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 18:38:19 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/B-gyM-4sT3yUj5JL-ILAVA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 18:38:19 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/B-gyM-4sT3yUj5JL-ILAVA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 18:38:19 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/B-gyM-4sT3yUj5JL-ILAVA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 18:38:19 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/B-gyM-4sT3yUj5JL-ILAVA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json'}, attempt #1 18:38:20 INFO - Downloaded 1361 bytes. 18:38:20 INFO - Reading from file /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 18:38:20 INFO - Using the following test package requirements: 18:38:20 INFO - {u'common': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 18:38:20 INFO - u'cppunittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 18:38:20 INFO - u'firefox-50.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 18:38:20 INFO - u'gtest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 18:38:20 INFO - u'firefox-50.0a1.en-US.linux-x86_64.gtest.tests.zip'], 18:38:20 INFO - u'jittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 18:38:20 INFO - u'jsshell-linux-x86_64.zip'], 18:38:20 INFO - u'mochitest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 18:38:20 INFO - u'firefox-50.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 18:38:20 INFO - u'mozbase': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 18:38:20 INFO - u'reftest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 18:38:20 INFO - u'firefox-50.0a1.en-US.linux-x86_64.reftest.tests.zip'], 18:38:20 INFO - u'talos': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 18:38:20 INFO - u'firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip'], 18:38:20 INFO - u'web-platform': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 18:38:20 INFO - u'firefox-50.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 18:38:20 INFO - u'xpcshell': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 18:38:20 INFO - u'firefox-50.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 18:38:20 INFO - Downloading packages: [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 18:38:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:38:20 INFO - https://queue.taskcluster.net/v1/task/B-gyM-4sT3yUj5JL-ILAVA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 18:38:20 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/B-gyM-4sT3yUj5JL-ILAVA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 18:38:20 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/B-gyM-4sT3yUj5JL-ILAVA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 18:38:20 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/B-gyM-4sT3yUj5JL-ILAVA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 18:38:20 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/B-gyM-4sT3yUj5JL-ILAVA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 18:38:23 INFO - Downloaded 22730934 bytes. 18:38:23 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 18:38:23 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 18:38:24 INFO - Return code: 0 18:38:24 INFO - Downloading packages: [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', u'firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 18:38:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:38:24 INFO - https://queue.taskcluster.net/v1/task/B-gyM-4sT3yUj5JL-ILAVA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 18:38:24 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/B-gyM-4sT3yUj5JL-ILAVA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 18:38:24 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/B-gyM-4sT3yUj5JL-ILAVA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 18:38:24 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/B-gyM-4sT3yUj5JL-ILAVA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 18:38:24 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/B-gyM-4sT3yUj5JL-ILAVA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 18:38:29 INFO - Downloaded 22730934 bytes. 18:38:29 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 18:38:29 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 18:38:31 INFO - Return code: 0 18:38:31 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')]} 18:38:31 INFO - https://queue.taskcluster.net/v1/task/B-gyM-4sT3yUj5JL-ILAVA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 18:38:31 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/B-gyM-4sT3yUj5JL-ILAVA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 18:38:31 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/B-gyM-4sT3yUj5JL-ILAVA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 18:38:31 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/B-gyM-4sT3yUj5JL-ILAVA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 18:38:31 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/B-gyM-4sT3yUj5JL-ILAVA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 18:38:32 INFO - Downloaded 14403333 bytes. 18:38:32 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 18:38:32 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip -d /builds/slave/test/build/tests 18:38:32 INFO - Return code: 0 18:38:32 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')]} 18:38:32 INFO - https://queue.taskcluster.net/v1/task/B-gyM-4sT3yUj5JL-ILAVA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 18:38:32 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/B-gyM-4sT3yUj5JL-ILAVA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 18:38:32 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/B-gyM-4sT3yUj5JL-ILAVA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 18:38:32 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/B-gyM-4sT3yUj5JL-ILAVA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 18:38:32 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/B-gyM-4sT3yUj5JL-ILAVA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2'}, attempt #1 18:38:34 INFO - Downloaded 56468772 bytes. 18:38:34 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/B-gyM-4sT3yUj5JL-ILAVA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 18:38:34 INFO - mkdir: /builds/slave/test/properties 18:38:34 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 18:38:34 INFO - Writing to file /builds/slave/test/properties/build_url 18:38:34 INFO - Contents: 18:38:34 INFO - build_url:https://queue.taskcluster.net/v1/task/B-gyM-4sT3yUj5JL-ILAVA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 18:38:35 INFO - Running post-action listener: _resource_record_post_action 18:38:35 INFO - Running post-action listener: set_extra_try_arguments 18:38:35 INFO - ##### 18:38:35 INFO - ##### Finished download-and-extract step (success) 18:38:35 INFO - ##### 18:38:35 INFO - ##### 18:38:35 INFO - ##### Running populate-webroot step. 18:38:35 INFO - ##### 18:38:35 INFO - Running pre-action listener: _resource_record_pre_action 18:38:35 INFO - Running main action method: populate_webroot 18:38:35 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 18:38:35 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 18:38:35 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 18:38:35 INFO - '--tppagecycles', 18:38:35 INFO - '7'], 18:38:35 INFO - 'tests': ['tsvgm']}}, 18:38:35 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 18:38:35 INFO - 'tests': ['tresize', 'tcanvasmark']}, 18:38:35 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 18:38:35 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 18:38:35 INFO - 'tests': ['dromaeo_css', 'kraken']}, 18:38:35 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 18:38:35 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:38:35 INFO - 'talos_options': ['--disable-e10s'], 18:38:35 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 18:38:35 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:38:35 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 18:38:35 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:38:35 INFO - 'talos_options': ['--disable-e10s'], 18:38:35 INFO - 'tests': ['damp', 'tps']}, 18:38:35 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:38:35 INFO - 'tests': ['damp', 'tps']}, 18:38:35 INFO - 'g3': {'talos_options': ['--disable-e10s'], 18:38:35 INFO - 'tests': ['dromaeo_dom']}, 18:38:35 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 18:38:35 INFO - 'g4': {'talos_options': ['--disable-e10s'], 18:38:35 INFO - 'tests': ['basic_compositor_video']}, 18:38:35 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 18:38:35 INFO - 'other': {'talos_options': ['--disable-e10s'], 18:38:35 INFO - 'tests': ['a11yr', 18:38:35 INFO - 'ts_paint', 18:38:35 INFO - 'tpaint', 18:38:35 INFO - 'sessionrestore', 18:38:35 INFO - 'sessionrestore_no_auto_restore', 18:38:35 INFO - 'tabpaint']}, 18:38:35 INFO - 'other-e10s': {'tests': ['a11yr', 18:38:35 INFO - 'ts_paint', 18:38:35 INFO - 'tpaint', 18:38:35 INFO - 'sessionrestore', 18:38:35 INFO - 'sessionrestore_no_auto_restore', 18:38:35 INFO - 'tabpaint']}, 18:38:35 INFO - 'other-e10s_l64': {'tests': ['a11yr', 18:38:35 INFO - 'ts_paint', 18:38:35 INFO - 'tpaint', 18:38:35 INFO - 'sessionrestore', 18:38:35 INFO - 'sessionrestore_no_auto_restore', 18:38:35 INFO - 'tabpaint']}, 18:38:35 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 18:38:35 INFO - 'ts_paint', 18:38:35 INFO - 'tpaint', 18:38:35 INFO - 'sessionrestore', 18:38:35 INFO - 'sessionrestore_no_auto_restore', 18:38:35 INFO - 'tabpaint']}, 18:38:35 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 18:38:35 INFO - 'tests': ['a11yr', 18:38:35 INFO - 'ts_paint', 18:38:35 INFO - 'tpaint', 18:38:35 INFO - 'sessionrestore', 18:38:35 INFO - 'sessionrestore_no_auto_restore', 18:38:35 INFO - 'tabpaint']}, 18:38:35 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 18:38:35 INFO - 'tests': ['a11yr', 18:38:35 INFO - 'ts_paint', 18:38:35 INFO - 'tpaint', 18:38:35 INFO - 'sessionrestore', 18:38:35 INFO - 'sessionrestore_no_auto_restore', 18:38:35 INFO - 'tabpaint']}, 18:38:35 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 18:38:35 INFO - 'tests': ['tsvgx', 18:38:35 INFO - 'tsvgr_opacity', 18:38:35 INFO - 'tart', 18:38:35 INFO - 'tscrollx', 18:38:35 INFO - 'cart']}, 18:38:35 INFO - 'svgr-e10s': {'tests': ['tsvgx', 18:38:35 INFO - 'tsvgr_opacity', 18:38:35 INFO - 'tart', 18:38:35 INFO - 'tscrollx', 18:38:35 INFO - 'cart']}, 18:38:35 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:38:35 INFO - 'talos_options': ['--disable-e10s'], 18:38:35 INFO - 'tests': ['tp5o']}, 18:38:35 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:38:35 INFO - 'tests': ['tp5o']}, 18:38:35 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:38:35 INFO - 'talos_options': ['--disable-e10s', 18:38:35 INFO - '--xperf_path', 18:38:35 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 18:38:35 INFO - 'tests': ['tp5n']}, 18:38:35 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:38:35 INFO - 'talos_options': ['--xperf_path', 18:38:35 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 18:38:35 INFO - 'tests': ['tp5n']}}, 18:38:35 INFO - 'talos.zip': {'path': '', 18:38:35 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 18:38:35 INFO - Running post-action listener: _resource_record_post_action 18:38:35 INFO - ##### 18:38:35 INFO - ##### Finished populate-webroot step (success) 18:38:35 INFO - ##### 18:38:35 INFO - ##### 18:38:35 INFO - ##### Running create-virtualenv step. 18:38:35 INFO - ##### 18:38:35 INFO - Running pre-action listener: _resource_record_pre_action 18:38:35 INFO - Running main action method: create_virtualenv 18:38:35 INFO - Creating virtualenv /builds/slave/test/build/venv 18:38:35 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 18:38:35 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 18:38:35 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 18:38:35 INFO - Using real prefix '/usr' 18:38:35 INFO - New python executable in /builds/slave/test/build/venv/bin/python 18:38:35 INFO - Installing distribute.............................................................................................................................................................................................done. 18:38:37 INFO - Installing pip.................done. 18:38:37 INFO - Return code: 0 18:38:37 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 18:38:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:38:37 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:38:37 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:38:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:38:37 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:38:37 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:38:37 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1d48030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1eab8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2009180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20073b0>, '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 0x20082b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2008740>, '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': '6d15e502d8e29d5d2676d664000001c3-1467768580.869301-24592832', '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 18:38:37 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 18:38:37 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 18:38:37 INFO - Using env: {'DISPLAY': ':0', 18:38:37 INFO - 'HOME': '/home/cltbld', 18:38:37 INFO - 'LANG': 'en_US.UTF-8', 18:38:37 INFO - 'LANGUAGE': 'en_US:en', 18:38:37 INFO - 'LOGNAME': 'cltbld', 18:38:37 INFO - 'MAIL': '/var/mail/cltbld', 18:38:37 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:38:37 INFO - 'MOZ_NO_REMOTE': '1', 18:38:37 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:38:37 INFO - 'NO_EM_RESTART': '1', 18:38:37 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:38:37 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:38:37 INFO - 'PWD': '/builds/slave/test', 18:38:37 INFO - 'SHELL': '/bin/bash', 18:38:37 INFO - 'SHLVL': '1', 18:38:37 INFO - 'TERM': 'linux', 18:38:37 INFO - 'TMOUT': '86400', 18:38:37 INFO - 'USER': 'cltbld', 18:38:37 INFO - 'XDG_SESSION_COOKIE': '6d15e502d8e29d5d2676d664000001c3-1467768580.869301-24592832', 18:38:37 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:38:37 INFO - '_': '/tools/buildbot/bin/python'} 18:38:38 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:38:38 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 18:38:38 INFO - Cleaning up... 18:38:38 INFO - Return code: 0 18:38:38 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 18:38:38 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')]} 18:38:38 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:38:38 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:38:38 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')]} 18:38:38 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:38:38 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:38:38 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1d48030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1eab8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2009180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20073b0>, '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 0x20082b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2008740>, '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': '6d15e502d8e29d5d2676d664000001c3-1467768580.869301-24592832', '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 18:38:38 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 18:38:38 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 18:38:38 INFO - Using env: {'DISPLAY': ':0', 18:38:38 INFO - 'HOME': '/home/cltbld', 18:38:38 INFO - 'LANG': 'en_US.UTF-8', 18:38:38 INFO - 'LANGUAGE': 'en_US:en', 18:38:38 INFO - 'LOGNAME': 'cltbld', 18:38:38 INFO - 'MAIL': '/var/mail/cltbld', 18:38:38 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:38:38 INFO - 'MOZ_NO_REMOTE': '1', 18:38:38 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:38:38 INFO - 'NO_EM_RESTART': '1', 18:38:38 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:38:38 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:38:38 INFO - 'PWD': '/builds/slave/test', 18:38:38 INFO - 'SHELL': '/bin/bash', 18:38:38 INFO - 'SHLVL': '1', 18:38:38 INFO - 'TERM': 'linux', 18:38:38 INFO - 'TMOUT': '86400', 18:38:38 INFO - 'USER': 'cltbld', 18:38:38 INFO - 'XDG_SESSION_COOKIE': '6d15e502d8e29d5d2676d664000001c3-1467768580.869301-24592832', 18:38:38 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:38:38 INFO - '_': '/tools/buildbot/bin/python'} 18:38:38 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:38:38 INFO - Downloading/unpacking psutil>=3.1.1 18:38:38 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:38:38 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:38:38 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:38:38 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:38:38 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:38:38 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:38:40 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 18:38:40 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 18:38:40 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 18:38:40 INFO - Installing collected packages: psutil 18:38:40 INFO - Running setup.py install for psutil 18:38:40 INFO - building 'psutil._psutil_linux' extension 18:38:40 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 18:38:41 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 18:38:41 INFO - building 'psutil._psutil_posix' extension 18:38:41 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 18:38:41 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 18:38:42 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 18:38:42 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 18:38:42 INFO - Successfully installed psutil 18:38:42 INFO - Cleaning up... 18:38:42 INFO - Return code: 0 18:38:42 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 18:38:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:38:42 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:38:42 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:38:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:38:42 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:38:42 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:38:42 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1d48030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1eab8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2009180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20073b0>, '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 0x20082b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2008740>, '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': '6d15e502d8e29d5d2676d664000001c3-1467768580.869301-24592832', '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 18:38:42 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 18:38:42 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 18:38:42 INFO - Using env: {'DISPLAY': ':0', 18:38:42 INFO - 'HOME': '/home/cltbld', 18:38:42 INFO - 'LANG': 'en_US.UTF-8', 18:38:42 INFO - 'LANGUAGE': 'en_US:en', 18:38:42 INFO - 'LOGNAME': 'cltbld', 18:38:42 INFO - 'MAIL': '/var/mail/cltbld', 18:38:42 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:38:42 INFO - 'MOZ_NO_REMOTE': '1', 18:38:42 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:38:42 INFO - 'NO_EM_RESTART': '1', 18:38:42 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:38:42 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:38:42 INFO - 'PWD': '/builds/slave/test', 18:38:42 INFO - 'SHELL': '/bin/bash', 18:38:42 INFO - 'SHLVL': '1', 18:38:42 INFO - 'TERM': 'linux', 18:38:42 INFO - 'TMOUT': '86400', 18:38:42 INFO - 'USER': 'cltbld', 18:38:42 INFO - 'XDG_SESSION_COOKIE': '6d15e502d8e29d5d2676d664000001c3-1467768580.869301-24592832', 18:38:42 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:38:42 INFO - '_': '/tools/buildbot/bin/python'} 18:38:42 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:38:42 INFO - Downloading/unpacking mozsystemmonitor==0.3 18:38:42 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 18:38:42 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 18:38:42 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 18:38:42 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 18:38:42 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 18:38:42 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 18:38:44 INFO - Downloading mozsystemmonitor-0.3.tar.gz 18:38:44 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 18:38:44 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 18:38:44 INFO - Installing collected packages: mozsystemmonitor 18:38:44 INFO - Running setup.py install for mozsystemmonitor 18:38:44 INFO - Successfully installed mozsystemmonitor 18:38:44 INFO - Cleaning up... 18:38:44 INFO - Return code: 0 18:38:44 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 18:38: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')]} 18:38:44 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:38:44 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:38: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')]} 18:38:44 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:38:44 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:38:44 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1d48030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1eab8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2009180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20073b0>, '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 0x20082b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2008740>, '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': '6d15e502d8e29d5d2676d664000001c3-1467768580.869301-24592832', '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 18:38:44 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 18:38:44 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 18:38:44 INFO - Using env: {'DISPLAY': ':0', 18:38:44 INFO - 'HOME': '/home/cltbld', 18:38:44 INFO - 'LANG': 'en_US.UTF-8', 18:38:44 INFO - 'LANGUAGE': 'en_US:en', 18:38:44 INFO - 'LOGNAME': 'cltbld', 18:38:44 INFO - 'MAIL': '/var/mail/cltbld', 18:38:44 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:38:44 INFO - 'MOZ_NO_REMOTE': '1', 18:38:44 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:38:44 INFO - 'NO_EM_RESTART': '1', 18:38:44 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:38:44 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:38:44 INFO - 'PWD': '/builds/slave/test', 18:38:44 INFO - 'SHELL': '/bin/bash', 18:38:44 INFO - 'SHLVL': '1', 18:38:44 INFO - 'TERM': 'linux', 18:38:44 INFO - 'TMOUT': '86400', 18:38:44 INFO - 'USER': 'cltbld', 18:38:44 INFO - 'XDG_SESSION_COOKIE': '6d15e502d8e29d5d2676d664000001c3-1467768580.869301-24592832', 18:38:44 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:38:44 INFO - '_': '/tools/buildbot/bin/python'} 18:38:44 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:38:44 INFO - Downloading/unpacking jsonschema==2.5.1 18:38:44 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 18:38:44 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 18:38:44 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 18:38:44 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 18:38:44 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 18:38:44 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 18:38:46 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 18:38:46 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 18:38:46 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:38:46 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:38:46 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:38:46 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:38:46 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:38:46 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:38:46 INFO - Downloading functools32-3.2.3-2.tar.gz 18:38:46 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 18:38:46 INFO - warning: no files found matching '*.txt' 18:38:46 INFO - no previously-included directories found matching 'build' 18:38:46 INFO - no previously-included directories found matching 'dist' 18:38:46 INFO - no previously-included directories found matching '.git*' 18:38:46 INFO - Installing collected packages: jsonschema, functools32 18:38:46 INFO - Running setup.py install for functools32 18:38:46 INFO - warning: no files found matching '*.txt' 18:38:46 INFO - no previously-included directories found matching 'build' 18:38:46 INFO - no previously-included directories found matching 'dist' 18:38:46 INFO - no previously-included directories found matching '.git*' 18:38:46 INFO - Successfully installed jsonschema functools32 18:38:46 INFO - Cleaning up... 18:38:47 INFO - Return code: 0 18:38:47 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 18:38:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:38:47 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:38:47 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:38:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:38:47 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:38:47 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:38:47 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1d48030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1eab8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2009180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20073b0>, '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 0x20082b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2008740>, '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': '6d15e502d8e29d5d2676d664000001c3-1467768580.869301-24592832', '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 18:38:47 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 18:38:47 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 18:38:47 INFO - Using env: {'DISPLAY': ':0', 18:38:47 INFO - 'HOME': '/home/cltbld', 18:38:47 INFO - 'LANG': 'en_US.UTF-8', 18:38:47 INFO - 'LANGUAGE': 'en_US:en', 18:38:47 INFO - 'LOGNAME': 'cltbld', 18:38:47 INFO - 'MAIL': '/var/mail/cltbld', 18:38:47 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:38:47 INFO - 'MOZ_NO_REMOTE': '1', 18:38:47 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:38:47 INFO - 'NO_EM_RESTART': '1', 18:38:47 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:38:47 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:38:47 INFO - 'PWD': '/builds/slave/test', 18:38:47 INFO - 'SHELL': '/bin/bash', 18:38:47 INFO - 'SHLVL': '1', 18:38:47 INFO - 'TERM': 'linux', 18:38:47 INFO - 'TMOUT': '86400', 18:38:47 INFO - 'USER': 'cltbld', 18:38:47 INFO - 'XDG_SESSION_COOKIE': '6d15e502d8e29d5d2676d664000001c3-1467768580.869301-24592832', 18:38:47 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:38:47 INFO - '_': '/tools/buildbot/bin/python'} 18:38:47 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:38:47 INFO - Downloading/unpacking blobuploader==1.2.4 18:38:47 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 18:38:47 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 18:38:47 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 18:38:47 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 18:38:47 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 18:38:47 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 18:38:50 INFO - Downloading blobuploader-1.2.4.tar.gz 18:38:50 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 18:38:50 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 18:38:50 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:38:50 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:38:50 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:38:50 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:38:50 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:38:50 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:38:50 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 18:38:51 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 18:38:51 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 18:38:51 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 18:38:51 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 18:38:51 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 18:38:51 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 18:38:51 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 18:38:51 INFO - Downloading docopt-0.6.1.tar.gz 18:38:51 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 18:38:51 INFO - Installing collected packages: blobuploader, requests, docopt 18:38:51 INFO - Running setup.py install for blobuploader 18:38:51 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 18:38:51 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 18:38:51 INFO - Running setup.py install for requests 18:38:51 INFO - Running setup.py install for docopt 18:38:51 INFO - Successfully installed blobuploader requests docopt 18:38:51 INFO - Cleaning up... 18:38:51 INFO - Return code: 0 18:38:51 INFO - Installing None into virtualenv /builds/slave/test/build/venv 18:38:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:38:51 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:38:51 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:38:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:38:51 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:38:51 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:38:51 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1d48030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1eab8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2009180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20073b0>, '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 0x20082b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2008740>, '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': '6d15e502d8e29d5d2676d664000001c3-1467768580.869301-24592832', '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 18:38:51 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 18:38:51 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 18:38:51 INFO - Using env: {'DISPLAY': ':0', 18:38:51 INFO - 'HOME': '/home/cltbld', 18:38:51 INFO - 'LANG': 'en_US.UTF-8', 18:38:51 INFO - 'LANGUAGE': 'en_US:en', 18:38:51 INFO - 'LOGNAME': 'cltbld', 18:38:51 INFO - 'MAIL': '/var/mail/cltbld', 18:38:51 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:38:51 INFO - 'MOZ_NO_REMOTE': '1', 18:38:51 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:38:51 INFO - 'NO_EM_RESTART': '1', 18:38:51 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:38:51 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:38:51 INFO - 'PWD': '/builds/slave/test', 18:38:51 INFO - 'SHELL': '/bin/bash', 18:38:51 INFO - 'SHLVL': '1', 18:38:51 INFO - 'TERM': 'linux', 18:38:51 INFO - 'TMOUT': '86400', 18:38:51 INFO - 'USER': 'cltbld', 18:38:51 INFO - 'XDG_SESSION_COOKIE': '6d15e502d8e29d5d2676d664000001c3-1467768580.869301-24592832', 18:38:51 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:38:51 INFO - '_': '/tools/buildbot/bin/python'} 18:38:52 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:38:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 18:38:52 INFO - Running setup.py (path:/tmp/pip-686UGu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 18:38:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 18:38:52 INFO - Running setup.py (path:/tmp/pip-VSbvEz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 18:38:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 18:38:52 INFO - Running setup.py (path:/tmp/pip-E8M2wB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 18:38:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 18:38:52 INFO - Running setup.py (path:/tmp/pip-nPDMrp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 18:38:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 18:38:52 INFO - Running setup.py (path:/tmp/pip-0J3Uhx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 18:38:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 18:38:52 INFO - Running setup.py (path:/tmp/pip-C4IJsB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 18:38:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 18:38:52 INFO - Running setup.py (path:/tmp/pip-qu8k8K-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 18:38:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 18:38:52 INFO - Running setup.py (path:/tmp/pip-wjVUPb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 18:38:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 18:38:52 INFO - Running setup.py (path:/tmp/pip-40V3eB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 18:38:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 18:38:52 INFO - Running setup.py (path:/tmp/pip-jbaemO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 18:38:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 18:38:52 INFO - Running setup.py (path:/tmp/pip-5g6hjW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 18:38:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 18:38:52 INFO - Running setup.py (path:/tmp/pip-iTGu5d-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 18:38:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 18:38:52 INFO - Running setup.py (path:/tmp/pip-aeBMiz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 18:38:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 18:38:53 INFO - Running setup.py (path:/tmp/pip-5xJHzS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 18:38:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 18:38:53 INFO - Running setup.py (path:/tmp/pip-Y7f6fC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 18:38:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 18:38:53 INFO - Running setup.py (path:/tmp/pip-5JvH_a-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 18:38:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 18:38:53 INFO - Running setup.py (path:/tmp/pip-a8kgi7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 18:38:53 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 18:38:53 INFO - Running setup.py install for manifestparser 18:38:53 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 18:38:53 INFO - Running setup.py install for mozcrash 18:38:53 INFO - Running setup.py install for mozdebug 18:38:53 INFO - Running setup.py install for mozdevice 18:38:53 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 18:38:53 INFO - Installing dm script to /builds/slave/test/build/venv/bin 18:38:53 INFO - Running setup.py install for mozfile 18:38:53 INFO - Running setup.py install for mozhttpd 18:38:53 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 18:38:53 INFO - Running setup.py install for mozinfo 18:38:54 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 18:38:54 INFO - Running setup.py install for mozInstall 18:38:54 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 18:38:54 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 18:38:54 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 18:38:54 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 18:38:54 INFO - Running setup.py install for mozleak 18:38:54 INFO - Running setup.py install for mozlog 18:38:54 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 18:38:54 INFO - Running setup.py install for moznetwork 18:38:54 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 18:38:54 INFO - Running setup.py install for mozprocess 18:38:54 INFO - Running setup.py install for mozprofile 18:38:54 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 18:38:54 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 18:38:54 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 18:38:54 INFO - Running setup.py install for mozrunner 18:38:54 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 18:38:54 INFO - Running setup.py install for mozscreenshot 18:38:54 INFO - Running setup.py install for moztest 18:38:55 INFO - Running setup.py install for mozversion 18:38:55 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 18:38:55 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 18:38:55 INFO - Cleaning up... 18:38:55 INFO - Return code: 0 18:38:55 INFO - Installing None into virtualenv /builds/slave/test/build/venv 18:38:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:38:55 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:38:55 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:38:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:38:55 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:38:55 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:38:55 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1d48030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1eab8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2009180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20073b0>, '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 0x20082b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2008740>, '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': '6d15e502d8e29d5d2676d664000001c3-1467768580.869301-24592832', '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 18:38:55 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 18:38:55 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 18:38:55 INFO - Using env: {'DISPLAY': ':0', 18:38:55 INFO - 'HOME': '/home/cltbld', 18:38:55 INFO - 'LANG': 'en_US.UTF-8', 18:38:55 INFO - 'LANGUAGE': 'en_US:en', 18:38:55 INFO - 'LOGNAME': 'cltbld', 18:38:55 INFO - 'MAIL': '/var/mail/cltbld', 18:38:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:38:55 INFO - 'MOZ_NO_REMOTE': '1', 18:38:55 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:38:55 INFO - 'NO_EM_RESTART': '1', 18:38:55 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:38:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:38:55 INFO - 'PWD': '/builds/slave/test', 18:38:55 INFO - 'SHELL': '/bin/bash', 18:38:55 INFO - 'SHLVL': '1', 18:38:55 INFO - 'TERM': 'linux', 18:38:55 INFO - 'TMOUT': '86400', 18:38:55 INFO - 'USER': 'cltbld', 18:38:55 INFO - 'XDG_SESSION_COOKIE': '6d15e502d8e29d5d2676d664000001c3-1467768580.869301-24592832', 18:38:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:38:55 INFO - '_': '/tools/buildbot/bin/python'} 18:38:55 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:38:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 18:38:55 INFO - Running setup.py (path:/tmp/pip-2p7m3V-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 18:38:55 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)) 18:38:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 18:38:55 INFO - Running setup.py (path:/tmp/pip-e1J2ex-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 18:38:55 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.17 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 18:38:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 18:38:55 INFO - Running setup.py (path:/tmp/pip-G63Rho-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 18:38:55 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 18:38:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 18:38:55 INFO - Running setup.py (path:/tmp/pip-uySTYL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 18:38:55 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.48 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 18:38:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 18:38:55 INFO - Running setup.py (path:/tmp/pip-nopKgZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 18:38:55 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 18:38:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 18:38:55 INFO - Running setup.py (path:/tmp/pip-wwyN6z-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 18:38:55 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 18:38:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 18:38:55 INFO - Running setup.py (path:/tmp/pip-LymJCH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 18:38:55 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 18:38:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 18:38:55 INFO - Running setup.py (path:/tmp/pip-LNhXaM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 18:38:55 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 18:38:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 18:38:55 INFO - Running setup.py (path:/tmp/pip-QURKmB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 18:38:55 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 18:38:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 18:38:56 INFO - Running setup.py (path:/tmp/pip-EpmIVg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 18:38:56 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.2 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)) 18:38:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 18:38:56 INFO - Running setup.py (path:/tmp/pip-fC0tV9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 18:38:56 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)) 18:38:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 18:38:56 INFO - Running setup.py (path:/tmp/pip-6JAirr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 18:38:56 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)) 18:38:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 18:38:56 INFO - Running setup.py (path:/tmp/pip-EHWmXS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 18:38:56 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)) 18:38:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 18:38:56 INFO - Running setup.py (path:/tmp/pip-oqRR0q-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 18:38:56 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)) 18:38:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 18:38:56 INFO - Running setup.py (path:/tmp/pip-XzSOzM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 18:38:56 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 18:38:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 18:38:56 INFO - Running setup.py (path:/tmp/pip-SWP4_7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 18:38:56 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 18:38:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 18:38:56 INFO - Running setup.py (path:/tmp/pip-KyaEqB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 18:38:56 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 18:38:56 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 18:38:56 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 18:38:56 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 18:38:56 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 18:38:56 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 18:38:56 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.2->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 18:38: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 18:38: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 18:38: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 18:38: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 18:38: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 18:38: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 18:38:58 INFO - Downloading blessings-1.6.tar.gz 18:38:58 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 18:38:58 INFO - Installing collected packages: blessings 18:38:58 INFO - Running setup.py install for blessings 18:38:58 INFO - Successfully installed blessings 18:38:58 INFO - Cleaning up... 18:38:58 INFO - Return code: 0 18:38:58 INFO - Done creating virtualenv /builds/slave/test/build/venv. 18:38:58 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 18:38:58 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 18:38:59 INFO - Reading from file tmpfile_stdout 18:38:59 INFO - Current package versions: 18:38:59 INFO - argparse == 1.2.1 18:38:59 INFO - blessings == 1.6 18:38:59 INFO - blobuploader == 1.2.4 18:38:59 INFO - docopt == 0.6.1 18:38:59 INFO - functools32 == 3.2.3-2 18:38:59 INFO - jsonschema == 2.5.1 18:38:59 INFO - manifestparser == 1.1 18:38:59 INFO - mozInstall == 1.12 18:38:59 INFO - mozcrash == 0.17 18:38:59 INFO - mozdebug == 0.1 18:38:59 INFO - mozdevice == 0.48 18:38:59 INFO - mozfile == 1.2 18:38:59 INFO - mozhttpd == 0.7 18:38:59 INFO - mozinfo == 0.9 18:38:59 INFO - mozleak == 0.1 18:38:59 INFO - mozlog == 3.2 18:38:59 INFO - moznetwork == 0.27 18:38:59 INFO - mozprocess == 0.22 18:38:59 INFO - mozprofile == 0.28 18:38:59 INFO - mozrunner == 6.11 18:38:59 INFO - mozscreenshot == 0.1 18:38:59 INFO - mozsystemmonitor == 0.3 18:38:59 INFO - moztest == 0.7 18:38:59 INFO - mozversion == 1.4 18:38:59 INFO - psutil == 3.1.1 18:38:59 INFO - requests == 1.2.3 18:38:59 INFO - wsgiref == 0.1.2 18:38:59 INFO - Installing None into virtualenv /builds/slave/test/build/venv 18:38:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:38:59 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:38:59 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:38:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:38:59 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:38:59 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:38:59 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1d48030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1eab8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2009180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20073b0>, '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 0x20082b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2008740>, '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': '6d15e502d8e29d5d2676d664000001c3-1467768580.869301-24592832', '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 18:38:59 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 18:38:59 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 18:38:59 INFO - Using env: {'DISPLAY': ':0', 18:38:59 INFO - 'HOME': '/home/cltbld', 18:38:59 INFO - 'LANG': 'en_US.UTF-8', 18:38:59 INFO - 'LANGUAGE': 'en_US:en', 18:38:59 INFO - 'LOGNAME': 'cltbld', 18:38:59 INFO - 'MAIL': '/var/mail/cltbld', 18:38:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:38:59 INFO - 'MOZ_NO_REMOTE': '1', 18:38:59 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:38:59 INFO - 'NO_EM_RESTART': '1', 18:38:59 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:38:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:38:59 INFO - 'PWD': '/builds/slave/test', 18:38:59 INFO - 'SHELL': '/bin/bash', 18:38:59 INFO - 'SHLVL': '1', 18:38:59 INFO - 'TERM': 'linux', 18:38:59 INFO - 'TMOUT': '86400', 18:38:59 INFO - 'USER': 'cltbld', 18:38:59 INFO - 'XDG_SESSION_COOKIE': '6d15e502d8e29d5d2676d664000001c3-1467768580.869301-24592832', 18:38:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:38:59 INFO - '_': '/tools/buildbot/bin/python'} 18:38:59 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:38:59 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)) 18:38:59 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)) 18:38:59 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)) 18:38:59 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)) 18:38:59 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)) 18:38:59 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)) 18:38:59 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)) 18:38:59 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)) 18:38:59 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)) 18:38:59 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)) 18:38:59 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)) 18:38:59 INFO - Cleaning up... 18:38:59 INFO - Return code: 0 18:38:59 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 18:38:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:38:59 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:38:59 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:38:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:38:59 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:38:59 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:38:59 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1d48030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1eab8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2009180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20073b0>, '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 0x20082b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2008740>, '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': '6d15e502d8e29d5d2676d664000001c3-1467768580.869301-24592832', '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 18:38:59 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 18:38:59 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 18:38:59 INFO - Using env: {'DISPLAY': ':0', 18:38:59 INFO - 'HOME': '/home/cltbld', 18:38:59 INFO - 'LANG': 'en_US.UTF-8', 18:38:59 INFO - 'LANGUAGE': 'en_US:en', 18:38:59 INFO - 'LOGNAME': 'cltbld', 18:38:59 INFO - 'MAIL': '/var/mail/cltbld', 18:38:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:38:59 INFO - 'MOZ_NO_REMOTE': '1', 18:38:59 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:38:59 INFO - 'NO_EM_RESTART': '1', 18:38:59 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:38:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:38:59 INFO - 'PWD': '/builds/slave/test', 18:38:59 INFO - 'SHELL': '/bin/bash', 18:38:59 INFO - 'SHLVL': '1', 18:38:59 INFO - 'TERM': 'linux', 18:38:59 INFO - 'TMOUT': '86400', 18:38:59 INFO - 'USER': 'cltbld', 18:38:59 INFO - 'XDG_SESSION_COOKIE': '6d15e502d8e29d5d2676d664000001c3-1467768580.869301-24592832', 18:38:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:38:59 INFO - '_': '/tools/buildbot/bin/python'} 18:38:59 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:38:59 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 18:38:59 INFO - Cleaning up... 18:38:59 INFO - Return code: 0 18:38:59 INFO - Running post-action listener: _resource_record_post_action 18:38:59 INFO - Running post-action listener: _start_resource_monitoring 18:38:59 INFO - Starting resource monitoring. 18:38:59 INFO - ##### 18:38:59 INFO - ##### Finished create-virtualenv step (success) 18:38:59 INFO - ##### 18:38:59 INFO - ##### 18:38:59 INFO - ##### Running install step. 18:38:59 INFO - ##### 18:38:59 INFO - Running pre-action listener: _resource_record_pre_action 18:38:59 INFO - Running main action method: install 18:38:59 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 18:38:59 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 18:38:59 INFO - Reading from file tmpfile_stdout 18:38:59 INFO - Detecting whether we're running mozinstall >=1.0... 18:38:59 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 18:38:59 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 18:38:59 INFO - Reading from file tmpfile_stdout 18:38:59 INFO - Output received: 18:38:59 INFO - Usage: mozinstall [options] installer 18:38:59 INFO - Options: 18:38:59 INFO - -h, --help show this help message and exit 18:38:59 INFO - -d DEST, --destination=DEST 18:38:59 INFO - Directory to install application into. [default: 18:38:59 INFO - "/builds/slave/test"] 18:38:59 INFO - --app=APP Application being installed. [default: firefox] 18:38:59 INFO - mkdir: /builds/slave/test/build/application 18:38:59 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 18:38:59 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 18:39:16 INFO - Reading from file tmpfile_stdout 18:39:16 INFO - Output received: 18:39:16 INFO - /builds/slave/test/build/application/firefox/firefox 18:39:16 INFO - Running post-action listener: _resource_record_post_action 18:39:16 INFO - ##### 18:39:16 INFO - ##### Finished install step (success) 18:39:16 INFO - ##### 18:39:16 INFO - ##### 18:39:16 INFO - ##### Running run-tests step. 18:39:16 INFO - ##### 18:39:16 INFO - Running pre-action listener: _resource_record_pre_action 18:39:16 INFO - Running main action method: run_tests 18:39:16 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 18:39:16 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 18:39:16 INFO - Python 2.7.3 18:39:16 INFO - Return code: 0 18:39:16 INFO - grabbing minidump binary from tooltool 18:39:16 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')]} 18:39:16 INFO - retry: Calling run_command with args: (['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'],), kwargs: {'output_timeout': 600, 'error_list': [{'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20073b0>, '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 0x20082b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2008740>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 18:39:16 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 18:39:16 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 18:39:16 INFO - Calling ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] with output_timeout 600 18:39:16 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 18:39:16 INFO - Return code: 0 18:39:16 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 18:39:16 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 18:39:16 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 18:39:16 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 18:39:16 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 18:39:16 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/B-gyM-4sT3yUj5JL-ILAVA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-023', '--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 18:39:16 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/B-gyM-4sT3yUj5JL-ILAVA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-023 --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 18:39:16 INFO - Using env: {'DISPLAY': ':0', 18:39:16 INFO - 'HOME': '/home/cltbld', 18:39:16 INFO - 'LANG': 'en_US.UTF-8', 18:39:16 INFO - 'LANGUAGE': 'en_US:en', 18:39:16 INFO - 'LOGNAME': 'cltbld', 18:39:16 INFO - 'MAIL': '/var/mail/cltbld', 18:39:16 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 18:39:16 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 18:39:16 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:39:16 INFO - 'MOZ_NO_REMOTE': '1', 18:39:16 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 18:39:16 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:39:16 INFO - 'NO_EM_RESTART': '1', 18:39:16 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:39:16 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:39:16 INFO - 'PWD': '/builds/slave/test', 18:39:16 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 18:39:16 INFO - 'SHELL': '/bin/bash', 18:39:16 INFO - 'SHLVL': '1', 18:39:16 INFO - 'TERM': 'linux', 18:39:16 INFO - 'TMOUT': '86400', 18:39:16 INFO - 'USER': 'cltbld', 18:39:16 INFO - 'XDG_SESSION_COOKIE': '6d15e502d8e29d5d2676d664000001c3-1467768580.869301-24592832', 18:39:16 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:39:16 INFO - '_': '/tools/buildbot/bin/python'} 18:39:16 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/B-gyM-4sT3yUj5JL-ILAVA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-023', '--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 18:39:16 INFO - mozversion application_buildid: 20160705173822 18:39:16 INFO - mozversion application_changeset: d8fa10d0a52eb52ee1fc46f88c37662c71af37a6 18:39:16 INFO - mozversion application_display_name: Nightly 18:39:16 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 18:39:16 INFO - mozversion application_name: Firefox 18:39:16 INFO - mozversion application_remotingname: firefox 18:39:16 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 18:39:16 INFO - mozversion application_vendor: Mozilla 18:39:16 INFO - mozversion application_version: 50.0a1 18:39:16 INFO - mozversion platform_buildid: 20160705173822 18:39:16 INFO - mozversion platform_changeset: d8fa10d0a52eb52ee1fc46f88c37662c71af37a6 18:39:16 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 18:39:16 INFO - mozversion platform_version: 50.0a1 18:39:16 INFO - using testdate: 1467769156 18:39:16 INFO - actual date: 1467769156 18:39:16 INFO - starting webserver on 'localhost:57913' 18:39:16 INFO - SUITE-START | Running 2 tests 18:39:16 INFO - TEST-START | dromaeo_css 18:39:16 INFO - operating with platform_type : linux_ 18:39:16 INFO - Initialising browser for dromaeo_css test... 18:39:16 INFO - TEST-INFO | started process 3288 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpb6gIN6/profile http://localhost:57913/getInfo.html) 18:39:22 INFO - PROCESS | 3288 | __metrics Screen width/height:1600/1200 18:39:22 INFO - PROCESS | 3288 | colorDepth:24 18:39:22 INFO - PROCESS | 3288 | Browser inner width/height: 1024/697 18:39:22 INFO - PROCESS | 3288 | __metrics 18:39:23 INFO - PROCESS | 3288 | JavaScript error: resource://app/modules/CaptivePortalWatcher.jsm, line 60: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 18:39:24 INFO - TEST-INFO | 3288: exit 0 18:39:24 INFO - Browser initialized. 18:39:24 INFO - Running cycle 1/1 for dromaeo_css test... 18:39:24 INFO - TEST-INFO | started process 3373 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpb6gIN6/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 18:39:36 INFO - PROCESS | 3373 | RSS: Main: 159338496 18:39:36 INFO - PROCESS | 3373 | 18:40:28 INFO - PROCESS | 3373 | 1467769228276 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] 18:42:40 INFO - PROCESS | 3373 | Cycle 1(1): loaded http://localhost:57913/tests/dromaeo/cssquery-dojo.html (next: http://localhost:57913/tests/dromaeo/cssquery-ext.html) 18:42:41 INFO - PROCESS | 3373 | RSS: Main: 266002432 18:42:41 INFO - PROCESS | 3373 | 18:45:44 INFO - PROCESS | 3373 | Cycle 1(1): loaded http://localhost:57913/tests/dromaeo/cssquery-ext.html (next: http://localhost:57913/tests/dromaeo/cssquery-jquery.html) 18:45:45 INFO - PROCESS | 3373 | RSS: Main: 240234496 18:45:45 INFO - PROCESS | 3373 | 18:48:47 INFO - PROCESS | 3373 | Cycle 1(1): loaded http://localhost:57913/tests/dromaeo/cssquery-jquery.html (next: http://localhost:57913/tests/dromaeo/cssquery-mootools.html) 18:48:47 INFO - PROCESS | 3373 | RSS: Main: 235479040 18:48:47 INFO - PROCESS | 3373 | 18:51:50 INFO - PROCESS | 3373 | Cycle 1(1): loaded http://localhost:57913/tests/dromaeo/cssquery-mootools.html (next: http://localhost:57913/tests/dromaeo/cssquery-prototype.html) 18:51:50 INFO - PROCESS | 3373 | RSS: Main: 235106304 18:51:50 INFO - PROCESS | 3373 | 18:54:53 INFO - PROCESS | 3373 | Cycle 1(1): loaded http://localhost:57913/tests/dromaeo/cssquery-prototype.html (next: http://localhost:57913/tests/dromaeo/cssquery-yui.html) 18:54:54 INFO - PROCESS | 3373 | RSS: Main: 217161728 18:54:54 INFO - PROCESS | 3373 | 18:57:57 INFO - PROCESS | 3373 | Cycle 1(1): loaded http://localhost:57913/tests/dromaeo/cssquery-yui.html (next: http://localhost:57913/tests/dromaeo/cssquery-dojo.html) 18:57:57 INFO - PROCESS | 3373 | RSS: Main: 287563776 18:57:57 INFO - PROCESS | 3373 | 18:57:57 INFO - PROCESS | 3373 | __start_tp_report 18:57:57 INFO - PROCESS | 3373 | _x_x_mozilla_page_load 18:57:57 INFO - PROCESS | 3373 | _x_x_mozilla_page_load_details 18:57:57 INFO - PROCESS | 3373 | |i|pagename|runs| 18:57:57 INFO - PROCESS | 3373 | |0;dojo.html;2594.053170592734;2627.3431642089477;2645.7883369330457;2650.09896635144;2652.7214642462545;4670.416197975253;4740.0519896020805;4747.145513807513;4756.334113224147;4766.761661916899;4780.426348838136;4782.3782908221965;4786.593139583139;4819.638527110472;4857.271409288608;4353.25994580922;4372.73763574185;4412.139632771611;4469.776511174445;4470.642348612119;4474.127545128701;4513.50351461339;4529.8641040768825;4537.954620453786;4552.97723511382;4299;4346.8043938022865;4351.28203846365;4399.5820397062225;4417.867463976054;4325.956740432618;4371.366151907987;4373.081652852905;4392.560743925614;4395.230834603932;4346.543612920661;4347.391365208873;4387.846425375128;4394.560543945612;4443.289073748185;4797.352357431737;4823.9035219295765;4844.224924012176;4848.393950756155;4859.611231101539;4967.82612608557;5057.5448209660935;5117.82087626935;5138;5150.948490515084;5156.484351564851;5157.252198431206;5202.791888324463;5214.5306922376785;5223.686578805284;4679.040796636681;4852.611791056707;4853.39332583427;4867.7322747249245;4868.732219727949;5161.458046905021;5274.129768588216;5282.841514754564;5284.524392804666;5353.0899747043095;4981.850544483671;4985.027919555724;5021.071101846097;5030.798768049311;5037.5214354636255;4983.6760610560195;5008.624353173526;5080.085584594734;5126.1798112302595;5127.794888204505;5021.824236151717;5034.89930201394;5048.62135339851;5052.974735126374;5106.46382129871;5013.197888337849;5025.346704928336;5029.823956161516;5033.6224783141415;5080.74596270185;4155.023569461174;4187.560306167808;4194.496660400771;4218.430511880857;4266.807993640294;3690.095926498025;3701.574318953301;3727.0682329417646;3746.9437958430644;3780.3006443807985;4377.1683380157665;4397.868063958086;4399.978000109979;4436.112777444524;4441.911161776747;4950.950490495049;5001.399832020181;5082.74586270685;5085.7202853842655;5148.665336753099;4417.116576684676;4430.4683437987005;4435.778211089432;4451.154280686659;4466.665000125004;4545.136424079415;4561.156186105581;4561.361409402686;4561.612262957619;4597.057603191338;4716.976415117902;4725.078609671081;4773.928391074067;4860.659753817199;4864.635152363587;5034;5058.266551350107;5062.594992400673;5073.416557095981;5098.9490105098475;4771.165046116985;4781.019890922422;4788.233882578771;4795.664303498722;4823.03539292136;4899.485554016777;4920.261960705922;4969.105560999054;4989.650724449254;5013.924791128063;5049.141645920129;5074.137396642506;5074.644774865724;5075.7969681212335;5106.642535022513;4879.34128892595;4884.4871288515615;4889.706617602813;4902.7058376497525;4946.455889852042;4775.164346239464;4892.094962431962;4944.208926571731;4959.553640172402;4971.055499455092;4847.854564363075;4880.804767809248;4887.731174785279;4936.901261974812;4951.183054795918;4855.295982082649;5016.72408017548;5023.723695196799;5027.446980832178;5039.974800125976;4756.738379389167;4779.569838714532;4804.927926081042;4816.470188279216;4861.951380486292 18:57:57 INFO - PROCESS | 3373 | |1;ext.html;555.0182495054896;592.2212290837551;595.1637948682101;600.3936024615138;606.3269770554687;27677.861610691943;30280.697193028063;30300.242493937607;30305.84847075767;30338;30046.54930176049;44775;46249.53750462495;46447.76776116123;46608.76695616517;7704.768856934287;7787.532748035136;7826.295633392993;7835.138134805167;7835.177306382833;7686.385089192851;7706.422018348619;7782.143964163965;10131.088202061814;10416.218783591223;10447.373157610567;10509.15926725864;10529;10532.736681582983;10538.315009524395;10281.897181028206;10332.535035923327;10338.483075846178;10344.844827327595;10345.431001294926;7645.885311720329;9995.800083998352;10365.378077315385;10367.63713270032;10377.325473844252;35068.473972890424;35848;35879.4618080729;39981.60018399808;39991.20017599632;2734.781217502595;2795.972040279612;2874.3389020525187;2998.055612482061;3201.2157021529874;28369.00603998126;30575.541366879515;30618.436639359385;30849.69150308513;31082.222944426343;3243.4810430331268;3252.1299055205345;3281.0812972367776;3372.971243770649;3379.3410284994434;254604;254727;254934.99999999814;256067;256825;32797;33748.325033499685;33752.32495350079;35133.64866351355;58691.41308586945;31799.205019874225;34355.65644343574;34494;34535;34561.48157777635;13757.931210344084;14075;14076.788848167285;14125.081869678437;14125.364358603887;9489.952550237344;11419.657410277705;11490.712732181762;11511.597094101666;11526.538938442369;7846.882296765439;8073.071596766447;8097.635606397726;8124.146964568753;8214.096449390563;3154.242981684425;3156.4949608062598;3179.300553878143;3191.2660088179387;3210.775245732776;817.7669364231166;883.8099808541194;907.3195103672246;926.8702381666573;935.0462528221176;28307;28865.56701649477;28922.42155156927;29170.270743231165;29435.85282073576;958.3435346787472;968.7965527239359;989.9059589339001;1014.1683819268129;1042.890496497872;14797.334119964627;15232.543023709306;15400.229988500754;15504.379824807107;15733.68532629341;415000;418495;420546;421771;422469;51081.233781493305;51554.22668659973;51567.48432515627;51607.741961289954;51725.741371292905;1077.1329080090602;1111.1888321525332;1186.1532322426247;1229.2685851918095;1242.589945318043;27105.59341609838;29425.85287073551;29956;30311.090667280016;30478.542821857245;42001.36997944972;42232.57767422286;42526.57473425226;42536;42548.36177457403;303226;305578;305656;306634;307920;21439;23728;25613.615795762707;26042.73957260479;27529.44941101207;41552;41660;42029.1594168121;42792;42964.570354297306;36675;36747.26505469822;37086;37157.442638359906;37187;35631.643683562834;35880.64119358877;36220.63779362278;36347.81826090958;36490.81754591316;37143.44284835675;38161.80919095498;38662.80668596752;39876.2024759509;40320.596794032856;32004.5199322015;34300;34529;34595.72873735482;35080;26252.343691407867;26381.20856374312;26557.867210663822;26616.866915665298;26895 18:57:57 INFO - PROCESS | 3373 | |2;jquery.html;371.69892387166396;381.32695791927244;383.13793963581924;390.2799335226506;395.7664977663178;17019;17242.74135887961;17244.568885777862;17814.64370712585;17826.910865445687;16520.42178523749;16745.66508669826;17104.230309636067;17116.82883171168;18103.366382176628;5192.8701782455555;5355.0628639988045;5391.272178255925;5394.109971854639;5400.054990376688;3710.5361829771277;3924;6021.759129634809;6331.683415829213;6332.05019247112;6289.87420251597;6376.202974628171;6419.5506314558;6425.325340839191;6425.742970281207;6151.630902145863;6249.781257656005;6263.937360626381;6304.243490781113;6307.369263073701;3409.1136304560746;3552.342816578941;3589.174489867345;4523.5024147343765;5499.615026948115;19844.900775496175;20978.37064888056;20999.5800083999;21624.351269461942;21871.343859684235;1916.9616607667908;1926.1139875657213;1958.4418440744319;1968.2422267427;2172.7935846094756;9407.623695052258;9409.76475588109;9546.093121153479;9808.754781130458;10019.248556358303;1704.2245778170902;1767.2047578589686;1804.179098510188;1812.2207450796152;1835.614520950602;67092;72104.63947680229;73127;74002.99999999946;75024.62487687527;10244.743881403025;10336.0697537222;10450.68647940563;10518.579256829795;10592.258541901992;14186.290685465685;14259.643508912153;14313.141211527342;14329.85670143306;14333.211673357857;7430.96284518574;7734.497257678233;7754.18581048993;7757.185495522889;7833.216678332121;7344.632768361561;7469.414037347092;7497.400207983348;7606.695732170651;7687.884681729778;4068.1253530491085;4500.977495112569;4552.635789136861;4562.24722920721;4579.7252164870215;1773.911304434773;1785.098525244743;1882.1812511557516;1898.6677331466938;1903.448000079989;857.7469646454311;862.7023676831483;884.4428010353565;897.7755561109592;914.721010091915;17038.403655872233;17198.755974205284;17541.824581754274;17672.734908976374;17892.821071789374;871.9912800872037;879.4986857491168;882.1178821178821;923.9491827949392;940.3652534539295;9423.539351400545;9967.152792012615;9999.450030248261;10005.699829005142;10013.949930250303;356186;358174;374284;393376;394242;78957;79409.60295198487;83747.58126209452;84060.15939840645;84453.57773211095;881.6517475597232;899.3075331994328;912.9680461183959;916.6929078758557;916.8303863785221;14528.83032121007;15680.686386271982;15779.921100394424;15903.52289431319;16176.595585109995;37993.810030949666;38265;39021.6097839018;39987.40018899661;40536.3919541213;48640.5135948636;49098;52202;53523.732381337846;59491.702541487015;7754.34088102495;7912.84174316522;7979.9202007979175;7991.880121798062;8115.9188408117525;11432.714182145513;12337.259764414164;12392.256464612152;12620.873791261969;12634.620961371174;10703.732406689895;10712.517936692711;10750.8387374191;10788.190885683449;11055.0603198729;10068.093871551595;10707.571697132027;10763.300385474919;10842.837357439803;11007.284526505751;10230.59077636916;10404.480645658148;10544.367337959748;11038;11052.944735276273;7689.8462030757955;7856.410769192447;7900.802479938047;7915.485493442908;8019.318357939407;8949.686760963335;10475.214358922958;10748.731281718019;10777.730556736144;10902.40036797952 18:57:57 INFO - PROCESS | 3373 | |3;mootools.html;1340.4169186403915;1408.4014293925081;1465.4065103633031;1652.9421470248544;1683.663267346531;6897.999790030442;7140.464465165121;7513.0233069701;8029.317508011819;8031.959840200798;7522;7790.337821285198;7812.726554570591;7966.123726390107;8032.277095061443;2189.9890500547513;2205.900734466953;2212.778722127782;2217.5010622609866;2217.6230040893006;1870.943871683845;1934.5453818352676;1934.9903250483728;1946.6301402733436;2200.3948914048683;2141.9250326238584;2209.0169874405815;2213.092632020872;2221.3002904085242;2226.6214743493647;2213.2917466410754;2232.754397016327;2236.575050740354;2236.709227800384;2274.4882401459704;2226.376614547929;2230.565039817236;2233.8994745236505;2236.306744909067;2236.5079682469996;8004.439689221756;8101;8107.756767296932;8120.106788253346;8121.18788121189;4525.683202175849;4674.018456124218;4689.249720044811;4699.835505757316;4700.2949557566635;2830.6320178376677;2881.178864023764;2960.008397186945;2965.273507990556;2967.302683869289;870.9825803483894;884.2881480408269;893.3523195683143;913.7943962608426;917.5458148216609;10953.671389858317;10954.068904143158;10964.780704385868;10967.616133435291;10968.945155274172;4138.461999939988;4327.415798867176;4407.493138289074;4409.581089796464;4409.757463339483;9242.12199841014;9301.488418136933;9342.486163261086;9345.112214339626;9348.4858332791;4782.139214941344;4800.207965685692;4801.639877009238;4802.495737947465;4804.615630749532;4312.568743125662;4358.934615980763;4360.803763830635;4364.869053928387;4393.099414620059;3372.915677108043;3470.444728843373;3483.808390538494;3692.833822477995;3819.2743378757946;1093.7101668057812;1151.867535233459;1165.7493638867684;1169.8830116988233;1192.9403529823649;687.220005293985;712.398023669998;785.9468312461215;788.9763307100797;798.9932684817172;4899.902001959941;4951.257311403318;4999.900001999939;5008.949910500921;5066.189409694432;826.0899389496988;832.5795473285951;875.4528419737663;877.440567266313;885.6501681835767;3312.8840490582716;3316.35331110436;3347.698707116371;3401.149712571857;3436.621971583124;9475.905240947503;9502.714918552454;9683.951580242054;9791.069848364394;9793.853092203623;9581.233501319877;9684.128428441474;9690.660826871026;9706.75733106664;9718.271129665303;7233.746818861315;7270.272972702687;7349.853002939912;7525.473216874876;7526.548407095483;4992.5756310714;5008;5040.193569028937;5049.9495005049475;5072.315237442898;8645.913540864762;8708.608112635073;8892.86660700103;8909.376343655882;9040.231580315483;9017.098290171192;9127.22418594427;9135.817283654422;9202.067565810987;9590.808183836145;7575.393968482618;7651.846963060819;7682.078150621737;7744.148143704076;7747.380209583107;7285.125784905633;7527.360174385239;7549.584772837547;7620.085589729268;7779.338756205786;5399.541039011571;6844.041834143323;6992.0910281663055;7009;7131.037309963296;6889.793306200822;6901.1718593769065;7020.824479388056;7026.508144430045;7088.362047415757;6164.414380634012;6183.81448556544;6209.534284928739;6234.220722409699;6239.126522286792;4352.717073390219;4535.070310586388;4586.243269860435;4662.487126416024;4667.346571479928;4487.596116349544;4496.842610508616;4531.750753708578;4570.611498022706;4588.426446694163 18:57:57 INFO - PROCESS | 3373 | |4;prototype.html;301.2558979321077;303.6053130929791;307.4036369443281;308.19099862859997;311.2793882162794;4842.661013729036;4876.707397556149;4893.657443978918;4907.362042934418;4931.137051016067;4824.879378015551;4830.661853670235;4843.39457567804;4851.393575803025;4853.5874450671645;3674.7243956703287;3720.5907350191455;3754.3054534910993;3821.675157611606;3843.26977874203;3791.6587507124354;3822.2546603412347;3834.5206849143856;3835.213781174866;3838.3495097108234;3608.2963822054708;3801.9049523761987;3805.847766089353;3806.029462487062;3806.200697853454;3639.290338384016;3783.786484906333;3791.8007555617673;3791.829367678461;3795.905102372435;3357.4628059510605;3367.276035652322;3378.476336167898;3384.627690953993;3390.304987477561;4754.690945088558;4766.547178018118;4768.833090841838;4772.0174890693315;4772.2125849234835;4237.7669228192435;4332.631726303236;4353.978230108861;4362.105768317488;4372.23485889968;4998.275594919747;5016;5048.712578292512;5049.520295571915;5084.110280700863;3675.467057276707;3691.778493290411;3695.595673644025;3708.962910370916;3718.163413232001;5137.820176293849;5229.450907654679;5248.396434410053;5292.994331077121;5294.947050529484;3748.538070152643;3753.7560058596105;3754.6808521276;3760.2479504099288;3772.830222639933;3815.694744420495;3821.732478726518;3825.827837747308;3825.9426108608395;3830.3296923038356;4332.978335108304;4341.5007274163245;4343.807301633297;4358.215521206213;4360.781960902005;4826.7827947742435;4990.80036798524;5012.147934851084;5020.47285035066;5047.545720885138;1299.571141523295;1319.182107093608;1320.8904520202884;1323.5367621332457;1325.5493132335052;864.2049314630555;867.4689173608585;890.9599068041954;897.2328658996595;897.5960817632092;4298.183345164409;4356;4499.617532509773;4517.102816816945;4534;5186.196139598368;5194.3766747990485;5205.453427390145;5229.4770522948165;5244.344456942882;4285.61429471349;4468.798904049326;4475.843345482893;4484.775761211927;4541.613962813131;2755.9448811023667;2758.3793646429795;2769.127724766692;2772.9584056239173;2792.274008757697;4918.458969513351;4939.333190019373;4943.555080042814;4949.430815456197;4951.752412379366;5053.494650534991;5313.229581710708;5328.387235467971;5369.677819330775;5386;4911.894823664718;4928.654994150446;4961.156603377362;4981.32752078472;4984.750762461862;5243.853687787449;5260.684358938476;5275.525202731773;5312.36251649789;5314.946850531445;4923.32606913651;5169.4830516948;5206.088934436534;5208.140656791738;5212.296339994053;4940.777665005012;4981.1283025469675;4981.6014718823135;4995.850124496271;5016.648834581544;3728.161163738137;3747.4191500317493;3775.7923314217983;3786.413105968579;3796.620337966181;5116.641835071509;5274.334337635307;5284.682919024871;5288;5357.651752636066;5060.873478163076;5077.6741234491465;5078.796848126181;5084.186530155157;5101.285819985279;5057.69653820772;5058.3929928408825;5068.518490743373;5071.290019397361;5083.161278389024;4744.833930812405;4854.417171817465;4906.2640603909695;4974.925376119433;4981.750912454435;4947.45577986414;5075.593952483866;5111.412187598325;5114.948850511447;5121.692698438105;4988.376452943382;5011.599072074298;5013.348264725562;5016.0186726243655;5020.6234532410945 18:57:57 INFO - PROCESS | 3373 | |5;yui.html;558.3885645218486;607.8419610901167;609.1563184988789;617.6818938246804;634.9238091429029;11350.545978160873;11997.34014629195;12090.455929483172;12281.263124212532;12302.507899684013;11984.10119241056;12215.572454964056;12231.204971676834;12235;12235.388230588458;623.8689875126229;761.9657115429819;771.0939645916068;797.5414136871293;801.1747899663357;787.1538096546207;788.1173086143527;793.6388943030936;793.9523628582275;794.6741835847304;830.1449507007792;834.6035633074301;834.845553572591;835.0146826744439;835.1648351648352;647.6696884588894;782.3780094824572;830.3564737328559;830.9875351869697;831.8003679116969;606.9514438844882;609.4849851875158;612.4916319454842;613.0589545048374;613.1722175063672;11497.712557186054;11512.021478174365;11513.366764827932;11525.19323647345;11532.654020379403;11028.393438360887;11233.21367504275;11432.885671143265;11928.165028447926;12647.304398258093;10161.339512931636;10410.167186625053;11798.46906889192;11876.10929180315;11883.108766842435;3215.678432156789;3247.7564182686156;3258.8696452141885;3354.1446931032674;3386.508956201362;61989.38010619881;62274;63186.36813631851;65369.34630653728;66036.66981665109;9694.90305096954;9892.25808064398;10077.899221007843;10272.178225741924;10582.682519524427;18028.909855450638;18497.167627456798;18544.629107417775;18562.164702588416;18629.81370186308;6527.8694426111215;6632.801015969529;6657.167854018247;6879.759208427781;6946.097007389007;3624.836882340301;3697.9445308320396;3763.8682646107804;3805.1248212911187;3893.1045859452483;2705.905293314764;2826.830390176596;2837.858107094637;2844.160972513072;2847.8718457669456;508.4915084915085;516.3468212710924;516.770037333383;562.6624025584698;595.2559300873908;517.9689218646894;524.5410266017235;557.8744782424003;559.6809818403552;612.8621060261405;7874.803129921798;8068.47554908929;8389;8439.70461033861;8450.61972211252;466.80160931603933;519.9922001169986;587.006661981177;597.9820605381846;604.7792555717132;3766.133789228493;4011.5587285398583;4061.329880569732;4095.89760255996;4107.979460102681;78909.21090789018;97420.51289743507;99440.50839237418;100400.497997511;100843;48140.27789583159;48141;48566;57814.71092644594;85025;61810.38189618136;64004.67997659982;76088.61955690297;76470;79002.86481378692;8345.499270043816;8571;8855.468671879707;8894.644214231359;8948;44046.77976610096;44456;46416.76791616021;46520.7673961628;46814.76592617015;36647.701706846514;37605.623943761304;37613.623863761015;50338.49661503338;66692;11376;11530.365829879438;11639.53441862316;11670.88329116698;12178.695532611755;12232.75534489323;12793.360331983178;12833.871661283267;12957.611271661488;13168.868311317148;8239.340852731886;9900.851487227841;12111.878881211074;12138.575149869712;13488.662783430493;12373.326411006543;12412.193207441487;12505.499780008699;12929.870701292866;12941.352932353533;12007.640594378774;12101.69745756363;12147;12509.710188228191;12742.044346674222;9615.9038409615;9653.806923861624;9670.56482458277;9706.660266890625;9924.255680823822;10514.069585536237;10538.736531586772;10598.629047983284;10651.840222396515;10685.432625456486 18:57:57 INFO - PROCESS | 3373 | __end_tp_report 18:57:57 INFO - PROCESS | 3373 | __start_cc_report 18:57:57 INFO - PROCESS | 3373 | _x_x_mozilla_cycle_collect,1091 18:57:57 INFO - PROCESS | 3373 | __end_cc_report 18:57:57 INFO - PROCESS | 3373 | __startTimestamp1467770277681__endTimestamp 18:57:57 INFO - PROCESS | 3373 | 18:57:57 INFO - PROCESS | 3373 | ------- Summary: start ------- 18:57:57 INFO - PROCESS | 3373 | Number of tests: 6 18:57:57 INFO - PROCESS | 3373 | 18:57:57 INFO - PROCESS | 3373 | [#0] dojo.html Cycles:165 Average:4702.88 Median:4848.39 stddev:495.48 (10.2%) stddev-sans-first:468.56 18:57:57 INFO - PROCESS | 3373 | Values: 2594.1 2627.3 2645.8 2650.1 2652.7 4670.4 4740.1 4747.1 4756.3 4766.8 4780.4 4782.4 4786.6 4819.6 4857.3 4353.3 4372.7 4412.1 4469.8 4470.6 4474.1 4513.5 4529.9 4538.0 4553.0 4299.0 4346.8 4351.3 4399.6 4417.9 4326.0 4371.4 4373.1 4392.6 4395.2 4346.5 4347.4 4387.8 4394.6 4443.3 4797.4 4823.9 4844.2 4848.4 4859.6 4967.8 5057.5 5117.8 5138.0 5150.9 5156.5 5157.3 5202.8 5214.5 5223.7 4679.0 4852.6 4853.4 4867.7 4868.7 5161.5 5274.1 5282.8 5284.5 5353.1 4981.9 4985.0 5021.1 5030.8 5037.5 4983.7 5008.6 5080.1 5126.2 5127.8 5021.8 5034.9 5048.6 5053.0 5106.5 5013.2 5025.3 5029.8 5033.6 5080.7 4155.0 4187.6 4194.5 4218.4 4266.8 3690.1 3701.6 3727.1 3746.9 3780.3 4377.2 4397.9 4400.0 4436.1 4441.9 4951.0 5001.4 5082.7 5085.7 5148.7 4417.1 4430.5 4435.8 4451.2 4466.7 4545.1 4561.2 4561.4 4561.6 4597.1 4717.0 4725.1 4773.9 4860.7 4864.6 5034.0 5058.3 5062.6 5073.4 5098.9 4771.2 4781.0 4788.2 4795.7 4823.0 4899.5 4920.3 4969.1 4989.7 5013.9 5049.1 5074.1 5074.6 5075.8 5106.6 4879.3 4884.5 4889.7 4902.7 4946.5 4775.2 4892.1 4944.2 4959.6 4971.1 4847.9 4880.8 4887.7 4936.9 4951.2 4855.3 5016.7 5023.7 5027.4 5040.0 4756.7 4779.6 4804.9 4816.5 4862.0 18:57:57 INFO - PROCESS | 3373 | 18:57:57 INFO - PROCESS | 3373 | [#1] ext.html Cycles:180 Average:47070.43 Median:18024.56 stddev:88228.50 (489.5%) stddev-sans-first:88406.88 18:57:57 INFO - PROCESS | 3373 | Values: 555.0 592.2 595.2 600.4 606.3 27677.9 30280.7 30300.2 30305.8 30338.0 30046.5 44775.0 46249.5 46447.8 46608.8 7704.8 7787.5 7826.3 7835.1 7835.2 7686.4 7706.4 7782.1 10131.1 10416.2 10447.4 10509.2 10529.0 10532.7 10538.3 10281.9 10332.5 10338.5 10344.8 10345.4 7645.9 9995.8 10365.4 10367.6 10377.3 35068.5 35848.0 35879.5 39981.6 39991.2 2734.8 2796.0 2874.3 2998.1 3201.2 28369.0 30575.5 30618.4 30849.7 31082.2 3243.5 3252.1 3281.1 3373.0 3379.3 254604.0 254727.0 254935.0 256067.0 256825.0 32797.0 33748.3 33752.3 35133.6 58691.4 31799.2 34355.7 34494.0 34535.0 34561.5 13757.9 14075.0 14076.8 14125.1 14125.4 9490.0 11419.7 11490.7 11511.6 11526.5 7846.9 8073.1 8097.6 8124.1 8214.1 3154.2 3156.5 3179.3 3191.3 3210.8 817.8 883.8 907.3 926.9 935.0 28307.0 28865.6 28922.4 29170.3 29435.9 958.3 968.8 989.9 1014.2 1042.9 14797.3 15232.5 15400.2 15504.4 15733.7 415000.0 418495.0 420546.0 421771.0 422469.0 51081.2 51554.2 51567.5 51607.7 51725.7 1077.1 1111.2 1186.2 1229.3 1242.6 27105.6 29425.9 29956.0 30311.1 30478.5 42001.4 42232.6 42526.6 42536.0 42548.4 303226.0 305578.0 305656.0 306634.0 307920.0 21439.0 23728.0 25613.6 26042.7 27529.4 41552.0 41660.0 42029.2 42792.0 42964.6 36675.0 36747.3 37086.0 37157.4 37187.0 35631.6 35880.6 36220.6 36347.8 36490.8 37143.4 38161.8 38662.8 39876.2 40320.6 32004.5 34300.0 34529.0 34595.7 35080.0 26252.3 26381.2 26557.9 26616.9 26895.0 18:57:57 INFO - PROCESS | 3373 | 18:57:57 INFO - PROCESS | 3373 | [#2] jquery.html Cycles:180 Average:24463.39 Median:21472.80 stddev:62302.85 (290.1%) stddev-sans-first:62451.37 18:57:57 INFO - PROCESS | 3373 | Values: 371.7 381.3 383.1 390.3 395.8 17019.0 17242.7 17244.6 17814.6 17826.9 16520.4 16745.7 17104.2 17116.8 18103.4 5192.9 5355.1 5391.3 5394.1 5400.1 3710.5 3924.0 6021.8 6331.7 6332.1 6289.9 6376.2 6419.6 6425.3 6425.7 6151.6 6249.8 6263.9 6304.2 6307.4 3409.1 3552.3 3589.2 4523.5 5499.6 19844.9 20978.4 20999.6 21624.4 21871.3 1917.0 1926.1 1958.4 1968.2 2172.8 9407.6 9409.8 9546.1 9808.8 10019.2 1704.2 1767.2 1804.2 1812.2 1835.6 67092.0 72104.6 73127.0 74003.0 75024.6 10244.7 10336.1 10450.7 10518.6 10592.3 14186.3 14259.6 14313.1 14329.9 14333.2 7431.0 7734.5 7754.2 7757.2 7833.2 7344.6 7469.4 7497.4 7606.7 7687.9 4068.1 4501.0 4552.6 4562.2 4579.7 1773.9 1785.1 1882.2 1898.7 1903.4 857.7 862.7 884.4 897.8 914.7 17038.4 17198.8 17541.8 17672.7 17892.8 872.0 879.5 882.1 923.9 940.4 9423.5 9967.2 9999.5 10005.7 10013.9 356186.0 358174.0 374284.0 393376.0 394242.0 78957.0 79409.6 83747.6 84060.2 84453.6 881.7 899.3 913.0 916.7 916.8 14528.8 15680.7 15779.9 15903.5 16176.6 37993.8 38265.0 39021.6 39987.4 40536.4 48640.5 49098.0 52202.0 53523.7 59491.7 7754.3 7912.8 7979.9 7991.9 8115.9 11432.7 12337.3 12392.3 12620.9 12634.6 10703.7 10712.5 10750.8 10788.2 11055.1 10068.1 10707.6 10763.3 10842.8 11007.3 10230.6 10404.5 10544.4 11038.0 11052.9 7689.8 7856.4 7900.8 7915.5 8019.3 8949.7 10475.2 10748.7 10777.7 10902.4 18:57:57 INFO - PROCESS | 3373 | 18:57:57 INFO - PROCESS | 3373 | [#3] mootools.html Cycles:180 Average:5186.92 Median:5024.57 stddev:2946.19 (58.6%) stddev-sans-first:2940.27 18:57:57 INFO - PROCESS | 3373 | Values: 1340.4 1408.4 1465.4 1652.9 1683.7 6898.0 7140.5 7513.0 8029.3 8032.0 7522.0 7790.3 7812.7 7966.1 8032.3 2190.0 2205.9 2212.8 2217.5 2217.6 1870.9 1934.5 1935.0 1946.6 2200.4 2141.9 2209.0 2213.1 2221.3 2226.6 2213.3 2232.8 2236.6 2236.7 2274.5 2226.4 2230.6 2233.9 2236.3 2236.5 8004.4 8101.0 8107.8 8120.1 8121.2 4525.7 4674.0 4689.2 4699.8 4700.3 2830.6 2881.2 2960.0 2965.3 2967.3 871.0 884.3 893.4 913.8 917.5 10953.7 10954.1 10964.8 10967.6 10968.9 4138.5 4327.4 4407.5 4409.6 4409.8 9242.1 9301.5 9342.5 9345.1 9348.5 4782.1 4800.2 4801.6 4802.5 4804.6 4312.6 4358.9 4360.8 4364.9 4393.1 3372.9 3470.4 3483.8 3692.8 3819.3 1093.7 1151.9 1165.7 1169.9 1192.9 687.2 712.4 785.9 789.0 799.0 4899.9 4951.3 4999.9 5008.9 5066.2 826.1 832.6 875.5 877.4 885.7 3312.9 3316.4 3347.7 3401.1 3436.6 9475.9 9502.7 9684.0 9791.1 9793.9 9581.2 9684.1 9690.7 9706.8 9718.3 7233.7 7270.3 7349.9 7525.5 7526.5 4992.6 5008.0 5040.2 5049.9 5072.3 8645.9 8708.6 8892.9 8909.4 9040.2 9017.1 9127.2 9135.8 9202.1 9590.8 7575.4 7651.8 7682.1 7744.1 7747.4 7285.1 7527.4 7549.6 7620.1 7779.3 5399.5 6844.0 6992.1 7009.0 7131.0 6889.8 6901.2 7020.8 7026.5 7088.4 6164.4 6183.8 6209.5 6234.2 6239.1 4352.7 4535.1 4586.2 4662.5 4667.3 4487.6 4496.8 4531.8 4570.6 4588.4 18:57:57 INFO - PROCESS | 3373 | 18:57:57 INFO - PROCESS | 3373 | [#4] prototype.html Cycles:180 Average:4231.56 Median:4847.39 stddev:1217.53 (25.1%) stddev-sans-first:1184.67 18:57:57 INFO - PROCESS | 3373 | Values: 301.3 303.6 307.4 308.2 311.3 4842.7 4876.7 4893.7 4907.4 4931.1 4824.9 4830.7 4843.4 4851.4 4853.6 3674.7 3720.6 3754.3 3821.7 3843.3 3791.7 3822.3 3834.5 3835.2 3838.3 3608.3 3801.9 3805.8 3806.0 3806.2 3639.3 3783.8 3791.8 3791.8 3795.9 3357.5 3367.3 3378.5 3384.6 3390.3 4754.7 4766.5 4768.8 4772.0 4772.2 4237.8 4332.6 4354.0 4362.1 4372.2 4998.3 5016.0 5048.7 5049.5 5084.1 3675.5 3691.8 3695.6 3709.0 3718.2 5137.8 5229.5 5248.4 5293.0 5294.9 3748.5 3753.8 3754.7 3760.2 3772.8 3815.7 3821.7 3825.8 3825.9 3830.3 4333.0 4341.5 4343.8 4358.2 4360.8 4826.8 4990.8 5012.1 5020.5 5047.5 1299.6 1319.2 1320.9 1323.5 1325.5 864.2 867.5 891.0 897.2 897.6 4298.2 4356.0 4499.6 4517.1 4534.0 5186.2 5194.4 5205.5 5229.5 5244.3 4285.6 4468.8 4475.8 4484.8 4541.6 2755.9 2758.4 2769.1 2773.0 2792.3 4918.5 4939.3 4943.6 4949.4 4951.8 5053.5 5313.2 5328.4 5369.7 5386.0 4911.9 4928.7 4961.2 4981.3 4984.8 5243.9 5260.7 5275.5 5312.4 5314.9 4923.3 5169.5 5206.1 5208.1 5212.3 4940.8 4981.1 4981.6 4995.9 5016.6 3728.2 3747.4 3775.8 3786.4 3796.6 5116.6 5274.3 5284.7 5288.0 5357.7 5060.9 5077.7 5078.8 5084.2 5101.3 5057.7 5058.4 5068.5 5071.3 5083.2 4744.8 4854.4 4906.3 4974.9 4981.8 4947.5 5075.6 5111.4 5114.9 5121.7 4988.4 5011.6 5013.3 5016.0 5020.6 18:57:57 INFO - PROCESS | 3373 | 18:57:57 INFO - PROCESS | 3373 | [#5] yui.html Cycles:180 Average:16423.53 Median:23640.78 stddev:22939.26 (97.0%) stddev-sans-first:22972.67 18:57:57 INFO - PROCESS | 3373 | Values: 558.4 607.8 609.2 617.7 634.9 11350.5 11997.3 12090.5 12281.3 12302.5 11984.1 12215.6 12231.2 12235.0 12235.4 623.9 762.0 771.1 797.5 801.2 787.2 788.1 793.6 794.0 794.7 830.1 834.6 834.8 835.0 835.2 647.7 782.4 830.4 831.0 831.8 607.0 609.5 612.5 613.1 613.2 11497.7 11512.0 11513.4 11525.2 11532.7 11028.4 11233.2 11432.9 11928.2 12647.3 10161.3 10410.2 11798.5 11876.1 11883.1 3215.7 3247.8 3258.9 3354.1 3386.5 61989.4 62274.0 63186.4 65369.3 66036.7 9694.9 9892.3 10077.9 10272.2 10582.7 18028.9 18497.2 18544.6 18562.2 18629.8 6527.9 6632.8 6657.2 6879.8 6946.1 3624.8 3697.9 3763.9 3805.1 3893.1 2705.9 2826.8 2837.9 2844.2 2847.9 508.5 516.3 516.8 562.7 595.3 518.0 524.5 557.9 559.7 612.9 7874.8 8068.5 8389.0 8439.7 8450.6 466.8 520.0 587.0 598.0 604.8 3766.1 4011.6 4061.3 4095.9 4108.0 78909.2 97420.5 99440.5 100400.5 100843.0 48140.3 48141.0 48566.0 57814.7 85025.0 61810.4 64004.7 76088.6 76470.0 79002.9 8345.5 8571.0 8855.5 8894.6 8948.0 44046.8 44456.0 46416.8 46520.8 46814.8 36647.7 37605.6 37613.6 50338.5 66692.0 11376.0 11530.4 11639.5 11670.9 12178.7 12232.8 12793.4 12833.9 12957.6 13168.9 8239.3 9900.9 12111.9 12138.6 13488.7 12373.3 12412.2 12505.5 12929.9 12941.4 12007.6 12101.7 12147.0 12509.7 12742.0 9615.9 9653.8 9670.6 9706.7 9924.3 10514.1 10538.7 10598.6 10651.8 10685.4 18:57:57 INFO - PROCESS | 3373 | -------- Summary: end -------- 18:57:57 INFO - PROCESS | 3373 | 18:57:58 INFO - TEST-INFO | 3373: exit 0 18:57:58 INFO - TEST-OK | dromaeo_css | took 1121977ms 18:57:58 INFO - TEST-START | kraken 18:57:58 INFO - operating with platform_type : linux_ 18:57:58 INFO - Initialising browser for kraken test... 18:57:58 INFO - TEST-INFO | started process 3560 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpeYaRtk/profile http://localhost:57913/getInfo.html) 18:58:02 INFO - PROCESS | 3560 | __metrics Screen width/height:1600/1200 18:58:02 INFO - PROCESS | 3560 | colorDepth:24 18:58:02 INFO - PROCESS | 3560 | Browser inner width/height: 1024/697 18:58:02 INFO - PROCESS | 3560 | __metrics 18:58:03 INFO - PROCESS | 3560 | JavaScript error: resource://app/modules/CaptivePortalWatcher.jsm, line 60: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 18:58:04 INFO - TEST-INFO | 3560: exit 0 18:58:04 INFO - Browser initialized. 18:58:04 INFO - Running cycle 1/1 for kraken test... 18:58:04 INFO - TEST-INFO | started process 3639 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpeYaRtk/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 18:58:16 INFO - PROCESS | 3639 | RSS: Main: 158306304 18:58:16 INFO - PROCESS | 3639 | 18:58:19 INFO - PROCESS | 3639 | Cycle 1(1): loaded http://localhost:57913/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:57913/tests/kraken/driver.html?testName=audio-beat-detection) 18:58:20 INFO - PROCESS | 3639 | RSS: Main: 216567808 18:58:20 INFO - PROCESS | 3639 | 18:58:22 INFO - PROCESS | 3639 | Cycle 1(1): loaded http://localhost:57913/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:57913/tests/kraken/driver.html?testName=audio-dft) 18:58:23 INFO - PROCESS | 3639 | RSS: Main: 205787136 18:58:23 INFO - PROCESS | 3639 | 18:58:26 INFO - PROCESS | 3639 | Cycle 1(1): loaded http://localhost:57913/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:57913/tests/kraken/driver.html?testName=audio-fft) 18:58:27 INFO - PROCESS | 3639 | RSS: Main: 271147008 18:58:27 INFO - PROCESS | 3639 | 18:58:29 INFO - PROCESS | 3639 | Cycle 1(1): loaded http://localhost:57913/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:57913/tests/kraken/driver.html?testName=audio-oscillator) 18:58:30 INFO - PROCESS | 3639 | RSS: Main: 181862400 18:58:30 INFO - PROCESS | 3639 | 18:58:32 INFO - PROCESS | 3639 | Cycle 1(1): loaded http://localhost:57913/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:57913/tests/kraken/driver.html?testName=imaging-gaussian-blur) 18:58:32 INFO - PROCESS | 3639 | RSS: Main: 185683968 18:58:32 INFO - PROCESS | 3639 | 18:58:36 INFO - PROCESS | 3639 | Cycle 1(1): loaded http://localhost:57913/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:57913/tests/kraken/driver.html?testName=imaging-darkroom) 18:58:36 INFO - PROCESS | 3639 | RSS: Main: 222343168 18:58:36 INFO - PROCESS | 3639 | 18:58:40 INFO - PROCESS | 3639 | Cycle 1(1): loaded http://localhost:57913/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:57913/tests/kraken/driver.html?testName=imaging-desaturate) 18:58:40 INFO - PROCESS | 3639 | RSS: Main: 222781440 18:58:40 INFO - PROCESS | 3639 | 18:58:43 INFO - PROCESS | 3639 | Cycle 1(1): loaded http://localhost:57913/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:57913/tests/kraken/driver.html?testName=json-parse-financial) 18:58:44 INFO - PROCESS | 3639 | RSS: Main: 222736384 18:58:44 INFO - PROCESS | 3639 | 18:58:45 INFO - PROCESS | 3639 | Cycle 1(1): loaded http://localhost:57913/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:57913/tests/kraken/driver.html?testName=json-stringify-tinderbox) 18:58:46 INFO - PROCESS | 3639 | RSS: Main: 210608128 18:58:46 INFO - PROCESS | 3639 | 18:58:48 INFO - PROCESS | 3639 | Cycle 1(1): loaded http://localhost:57913/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:57913/tests/kraken/driver.html?testName=stanford-crypto-aes) 18:58:49 INFO - PROCESS | 3639 | RSS: Main: 215568384 18:58:49 INFO - PROCESS | 3639 | 18:58:51 INFO - PROCESS | 3639 | Cycle 1(1): loaded http://localhost:57913/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:57913/tests/kraken/driver.html?testName=stanford-crypto-ccm) 18:58:51 INFO - PROCESS | 3639 | RSS: Main: 213463040 18:58:51 INFO - PROCESS | 3639 | 18:58:54 INFO - PROCESS | 3639 | Cycle 1(1): loaded http://localhost:57913/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:57913/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 18:58:55 INFO - PROCESS | 3639 | RSS: Main: 228466688 18:58:55 INFO - PROCESS | 3639 | 18:58:58 INFO - PROCESS | 3639 | Cycle 1(1): loaded http://localhost:57913/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:57913/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 18:58:58 INFO - PROCESS | 3639 | RSS: Main: 226942976 18:58:58 INFO - PROCESS | 3639 | 18:59:00 INFO - PROCESS | 3639 | Cycle 1(1): loaded http://localhost:57913/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:57913/tests/kraken/driver.html?testName=ai-astar) 18:59:00 INFO - PROCESS | 3639 | RSS: Main: 268754944 18:59:00 INFO - PROCESS | 3639 | 18:59:00 INFO - PROCESS | 3639 | __start_tp_report 18:59:00 INFO - PROCESS | 3639 | _x_x_mozilla_page_load 18:59:00 INFO - PROCESS | 3639 | _x_x_mozilla_page_load_details 18:59:00 INFO - PROCESS | 3639 | |i|pagename|runs| 18:59:00 INFO - PROCESS | 3639 | |0;ai-astar;101;112;112;111;113;112;112;114;111;111 18:59:00 INFO - PROCESS | 3639 | |1;audio-beat-detection;146;125;123;177;122;123;143;121;157;121 18:59:00 INFO - PROCESS | 3639 | |2;audio-dft;173;161;158;161;160;161;160;163;161;159 18:59:00 INFO - PROCESS | 3639 | |3;audio-fft;77;75;77;108;77;77;75;75;101;76 18:59:00 INFO - PROCESS | 3639 | |4;audio-oscillator;87;86;120;85;84;86;124;85;85;139 18:59:00 INFO - PROCESS | 3639 | |5;imaging-gaussian-blur;117;116;117;117;117;117;117;118;117;117 18:59:00 INFO - PROCESS | 3639 | |6;imaging-darkroom;146;147;146;147;147;148;146;147;146;148 18:59:00 INFO - PROCESS | 3639 | |7;imaging-desaturate;96;95;95;96;96;95;95;96;95;95 18:59:00 INFO - PROCESS | 3639 | |8;json-parse-financial;63;63;62;63;62;64;64;63;63;62 18:59:00 INFO - PROCESS | 3639 | |9;json-stringify-tinderbox;65;64;65;65;65;65;64;65;65;64 18:59:00 INFO - PROCESS | 3639 | |10;stanford-crypto-aes;79;77;78;78;78;78;87;81;78;79 18:59:00 INFO - PROCESS | 3639 | |11;stanford-crypto-ccm;139;126;128;129;128;128;127;128;163;129 18:59:00 INFO - PROCESS | 3639 | |12;stanford-crypto-pbkdf2;165;167;165;164;165;166;168;170;162;165 18:59:00 INFO - PROCESS | 3639 | |13;stanford-crypto-sha256-iterative;67;70;67;70;66;67;67;67;68;68 18:59:00 INFO - PROCESS | 3639 | __end_tp_report 18:59:00 INFO - PROCESS | 3639 | __start_cc_report 18:59:00 INFO - PROCESS | 3639 | _x_x_mozilla_cycle_collect,1940 18:59:00 INFO - PROCESS | 3639 | __end_cc_report 18:59:00 INFO - PROCESS | 3639 | __startTimestamp1467770340686__endTimestamp 18:59:00 INFO - PROCESS | 3639 | 18:59:00 INFO - PROCESS | 3639 | ------- Summary: start ------- 18:59:00 INFO - PROCESS | 3639 | Number of tests: 14 18:59:00 INFO - PROCESS | 3639 | 18:59:00 INFO - PROCESS | 3639 | [#0] ai-astar Cycles:10 Average:110.90 Median:112.00 stddev:3.60 (3.2%) stddev-sans-first:1.00 18:59:00 INFO - PROCESS | 3639 | Values: 101.0 112.0 112.0 111.0 113.0 112.0 112.0 114.0 111.0 111.0 18:59:00 INFO - PROCESS | 3639 | 18:59:00 INFO - PROCESS | 3639 | [#1] audio-beat-detection Cycles:10 Average:135.80 Median:134.00 stddev:19.37 (14.5%) stddev-sans-first:20.19 18:59:00 INFO - PROCESS | 3639 | Values: 146.0 125.0 123.0 177.0 122.0 123.0 143.0 121.0 157.0 121.0 18:59:00 INFO - PROCESS | 3639 | 18:59:00 INFO - PROCESS | 3639 | [#2] audio-dft Cycles:10 Average:161.70 Median:161.00 stddev:4.19 (2.6%) stddev-sans-first:1.42 18:59:00 INFO - PROCESS | 3639 | Values: 173.0 161.0 158.0 161.0 160.0 161.0 160.0 163.0 161.0 159.0 18:59:00 INFO - PROCESS | 3639 | 18:59:00 INFO - PROCESS | 3639 | [#3] audio-fft Cycles:10 Average:81.80 Median:76.50 stddev:12.11 (15.8%) stddev-sans-first:12.72 18:59:00 INFO - PROCESS | 3639 | Values: 77.0 75.0 77.0 108.0 77.0 77.0 75.0 75.0 101.0 76.0 18:59:00 INFO - PROCESS | 3639 | 18:59:00 INFO - PROCESS | 3639 | [#4] audio-oscillator Cycles:10 Average:98.10 Median:85.00 stddev:20.96 (24.7%) stddev-sans-first:21.84 18:59:00 INFO - PROCESS | 3639 | Values: 87.0 86.0 120.0 85.0 84.0 86.0 124.0 85.0 85.0 139.0 18:59:00 INFO - PROCESS | 3639 | 18:59:00 INFO - PROCESS | 3639 | [#5] imaging-gaussian-blur Cycles:10 Average:117.00 Median:117.00 stddev:0.47 (0.4%) stddev-sans-first:0.50 18:59:00 INFO - PROCESS | 3639 | Values: 117.0 116.0 117.0 117.0 117.0 117.0 117.0 118.0 117.0 117.0 18:59:00 INFO - PROCESS | 3639 | 18:59:00 INFO - PROCESS | 3639 | [#6] imaging-darkroom Cycles:10 Average:146.80 Median:147.00 stddev:0.79 (0.5%) stddev-sans-first:0.78 18:59:00 INFO - PROCESS | 3639 | Values: 146.0 147.0 146.0 147.0 147.0 148.0 146.0 147.0 146.0 148.0 18:59:00 INFO - PROCESS | 3639 | 18:59:00 INFO - PROCESS | 3639 | [#7] imaging-desaturate Cycles:10 Average:95.40 Median:95.50 stddev:0.52 (0.5%) stddev-sans-first:0.50 18:59:00 INFO - PROCESS | 3639 | Values: 96.0 95.0 95.0 96.0 96.0 95.0 95.0 96.0 95.0 95.0 18:59:00 INFO - PROCESS | 3639 | 18:59:00 INFO - PROCESS | 3639 | [#8] json-parse-financial Cycles:10 Average:62.90 Median:63.00 stddev:0.74 (1.2%) stddev-sans-first:0.78 18:59:00 INFO - PROCESS | 3639 | Values: 63.0 63.0 62.0 63.0 62.0 64.0 64.0 63.0 63.0 62.0 18:59:00 INFO - PROCESS | 3639 | 18:59:00 INFO - PROCESS | 3639 | [#9] json-stringify-tinderbox Cycles:10 Average:64.70 Median:65.00 stddev:0.48 (0.7%) stddev-sans-first:0.50 18:59:00 INFO - PROCESS | 3639 | Values: 65.0 64.0 65.0 65.0 65.0 65.0 64.0 65.0 65.0 64.0 18:59:00 INFO - PROCESS | 3639 | 18:59:00 INFO - PROCESS | 3639 | [#10] stanford-crypto-aes Cycles:10 Average:79.30 Median:78.50 stddev:2.91 (3.7%) stddev-sans-first:3.08 18:59:00 INFO - PROCESS | 3639 | Values: 79.0 77.0 78.0 78.0 78.0 78.0 87.0 81.0 78.0 79.0 18:59:00 INFO - PROCESS | 3639 | 18:59:00 INFO - PROCESS | 3639 | [#11] stanford-crypto-ccm Cycles:10 Average:132.50 Median:128.50 stddev:11.31 (8.8%) stddev-sans-first:11.74 18:59:00 INFO - PROCESS | 3639 | Values: 139.0 126.0 128.0 129.0 128.0 128.0 127.0 128.0 163.0 129.0 18:59:00 INFO - PROCESS | 3639 | 18:59:00 INFO - PROCESS | 3639 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:165.70 Median:165.50 stddev:2.21 (1.3%) stddev-sans-first:2.33 18:59:00 INFO - PROCESS | 3639 | Values: 165.0 167.0 165.0 164.0 165.0 166.0 168.0 170.0 162.0 165.0 18:59:00 INFO - PROCESS | 3639 | 18:59:00 INFO - PROCESS | 3639 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:67.70 Median:67.50 stddev:1.34 (2.0%) stddev-sans-first:1.39 18:59:00 INFO - PROCESS | 3639 | Values: 67.0 70.0 67.0 70.0 66.0 67.0 67.0 67.0 68.0 68.0 18:59:00 INFO - PROCESS | 3639 | -------- Summary: end -------- 18:59:00 INFO - PROCESS | 3639 | 18:59:01 INFO - TEST-INFO | 3639: exit 0 18:59:01 INFO - TEST-OK | kraken | took 63343ms 18:59:01 INFO - SUITE-END | took 1185s 18:59:01 INFO - Completed test suite (00:19:45) 18:59:01 INFO - javascript benchmark 18:59:01 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2594.053170592734, 2627.3431642089477, 2645.7883369330457, 2650.09896635144, 2652.7214642462545, 4670.416197975253, 4740.0519896020805, 4747.145513807513, 4756.334113224147, 4766.761661916899, 4780.426348838136, 4782.3782908221965, 4786.593139583139, 4819.638527110472, 4857.271409288608, 4353.25994580922, 4372.73763574185, 4412.139632771611, 4469.776511174445, 4470.642348612119, 4474.127545128701, 4513.50351461339, 4529.8641040768825, 4537.954620453786, 4552.97723511382, 4299.0, 4346.8043938022865, 4351.28203846365, 4399.5820397062225, 4417.867463976054, 4325.956740432618, 4371.366151907987, 4373.081652852905, 4392.560743925614, 4395.230834603932, 4346.543612920661, 4347.391365208873, 4387.846425375128, 4394.560543945612, 4443.289073748185, 4797.352357431737, 4823.9035219295765, 4844.224924012176, 4848.393950756155, 4859.611231101539, 4967.82612608557, 5057.5448209660935, 5117.82087626935, 5138.0, 5150.948490515084, 5156.484351564851, 5157.252198431206, 5202.791888324463, 5214.5306922376785, 5223.686578805284, 4679.040796636681, 4852.611791056707, 4853.39332583427, 4867.7322747249245, 4868.732219727949, 5161.458046905021, 5274.129768588216, 5282.841514754564, 5284.524392804666, 5353.0899747043095, 4981.850544483671, 4985.027919555724, 5021.071101846097, 5030.798768049311, 5037.5214354636255, 4983.6760610560195, 5008.624353173526, 5080.085584594734, 5126.1798112302595, 5127.794888204505, 5021.824236151717, 5034.89930201394, 5048.62135339851, 5052.974735126374, 5106.46382129871, 5013.197888337849, 5025.346704928336, 5029.823956161516, 5033.6224783141415, 5080.74596270185, 4155.023569461174, 4187.560306167808, 4194.496660400771, 4218.430511880857, 4266.807993640294, 3690.095926498025, 3701.574318953301, 3727.0682329417646, 3746.9437958430644, 3780.3006443807985, 4377.1683380157665, 4397.868063958086, 4399.978000109979, 4436.112777444524, 4441.911161776747, 4950.950490495049, 5001.399832020181, 5082.74586270685, 5085.7202853842655, 5148.665336753099, 4417.116576684676, 4430.4683437987005, 4435.778211089432, 4451.154280686659, 4466.665000125004, 4545.136424079415, 4561.156186105581, 4561.361409402686, 4561.612262957619, 4597.057603191338, 4716.976415117902, 4725.078609671081, 4773.928391074067, 4860.659753817199, 4864.635152363587, 5034.0, 5058.266551350107, 5062.594992400673, 5073.416557095981, 5098.9490105098475, 4771.165046116985, 4781.019890922422, 4788.233882578771, 4795.664303498722, 4823.03539292136, 4899.485554016777, 4920.261960705922, 4969.105560999054, 4989.650724449254, 5013.924791128063, 5049.141645920129, 5074.137396642506, 5074.644774865724, 5075.7969681212335, 5106.642535022513, 4879.34128892595, 4884.4871288515615, 4889.706617602813, 4902.7058376497525, 4946.455889852042, 4775.164346239464, 4892.094962431962, 4944.208926571731, 4959.553640172402, 4971.055499455092, 4847.854564363075, 4880.804767809248, 4887.731174785279, 4936.901261974812, 4951.183054795918, 4855.295982082649, 5016.72408017548, 5023.723695196799, 5027.446980832178, 5039.974800125976, 4756.738379389167, 4779.569838714532, 4804.927926081042, 4816.470188279216, 4861.951380486292], "value": 4670.780864408703, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [555.0182495054896, 592.2212290837551, 595.1637948682101, 600.3936024615138, 606.3269770554687, 27677.861610691943, 30280.697193028063, 30300.242493937607, 30305.84847075767, 30338.0, 30046.54930176049, 44775.0, 46249.53750462495, 46447.76776116123, 46608.76695616517, 7704.768856934287, 7787.532748035136, 7826.295633392993, 7835.138134805167, 7835.177306382833, 7686.385089192851, 7706.422018348619, 7782.143964163965, 10131.088202061814, 10416.218783591223, 10447.373157610567, 10509.15926725864, 10529.0, 10532.736681582983, 10538.315009524395, 10281.897181028206, 10332.535035923327, 10338.483075846178, 10344.844827327595, 10345.431001294926, 7645.885311720329, 9995.800083998352, 10365.378077315385, 10367.63713270032, 10377.325473844252, 35068.473972890424, 35848.0, 35879.4618080729, 39981.60018399808, 39991.20017599632, 2734.781217502595, 2795.972040279612, 2874.3389020525187, 2998.055612482061, 3201.2157021529874, 28369.00603998126, 30575.541366879515, 30618.436639359385, 30849.69150308513, 31082.222944426343, 3243.4810430331268, 3252.1299055205345, 3281.0812972367776, 3372.971243770649, 3379.3410284994434, 254604.0, 254727.0, 254934.99999999814, 256067.0, 256825.0, 32797.0, 33748.325033499685, 33752.32495350079, 35133.64866351355, 58691.41308586945, 31799.205019874225, 34355.65644343574, 34494.0, 34535.0, 34561.48157777635, 13757.931210344084, 14075.0, 14076.788848167285, 14125.081869678437, 14125.364358603887, 9489.952550237344, 11419.657410277705, 11490.712732181762, 11511.597094101666, 11526.538938442369, 7846.882296765439, 8073.071596766447, 8097.635606397726, 8124.146964568753, 8214.096449390563, 3154.242981684425, 3156.4949608062598, 3179.300553878143, 3191.2660088179387, 3210.775245732776, 817.7669364231166, 883.8099808541194, 907.3195103672246, 926.8702381666573, 935.0462528221176, 28307.0, 28865.56701649477, 28922.42155156927, 29170.270743231165, 29435.85282073576, 958.3435346787472, 968.7965527239359, 989.9059589339001, 1014.1683819268129, 1042.890496497872, 14797.334119964627, 15232.543023709306, 15400.229988500754, 15504.379824807107, 15733.68532629341, 415000.0, 418495.0, 420546.0, 421771.0, 422469.0, 51081.233781493305, 51554.22668659973, 51567.48432515627, 51607.741961289954, 51725.741371292905, 1077.1329080090602, 1111.1888321525332, 1186.1532322426247, 1229.2685851918095, 1242.589945318043, 27105.59341609838, 29425.85287073551, 29956.0, 30311.090667280016, 30478.542821857245, 42001.36997944972, 42232.57767422286, 42526.57473425226, 42536.0, 42548.36177457403, 303226.0, 305578.0, 305656.0, 306634.0, 307920.0, 21439.0, 23728.0, 25613.615795762707, 26042.73957260479, 27529.44941101207, 41552.0, 41660.0, 42029.1594168121, 42792.0, 42964.570354297306, 36675.0, 36747.26505469822, 37086.0, 37157.442638359906, 37187.0, 35631.643683562834, 35880.64119358877, 36220.63779362278, 36347.81826090958, 36490.81754591316, 37143.44284835675, 38161.80919095498, 38662.80668596752, 39876.2024759509, 40320.596794032856, 32004.5199322015, 34300.0, 34529.0, 34595.72873735482, 35080.0, 26252.343691407867, 26381.20856374312, 26557.867210663822, 26616.866915665298, 26895.0], "value": 16870.746329873105, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [371.69892387166396, 381.32695791927244, 383.13793963581924, 390.2799335226506, 395.7664977663178, 17019.0, 17242.74135887961, 17244.568885777862, 17814.64370712585, 17826.910865445687, 16520.42178523749, 16745.66508669826, 17104.230309636067, 17116.82883171168, 18103.366382176628, 5192.8701782455555, 5355.0628639988045, 5391.272178255925, 5394.109971854639, 5400.054990376688, 3710.5361829771277, 3924.0, 6021.759129634809, 6331.683415829213, 6332.05019247112, 6289.87420251597, 6376.202974628171, 6419.5506314558, 6425.325340839191, 6425.742970281207, 6151.630902145863, 6249.781257656005, 6263.937360626381, 6304.243490781113, 6307.369263073701, 3409.1136304560746, 3552.342816578941, 3589.174489867345, 4523.5024147343765, 5499.615026948115, 19844.900775496175, 20978.37064888056, 20999.5800083999, 21624.351269461942, 21871.343859684235, 1916.9616607667908, 1926.1139875657213, 1958.4418440744319, 1968.2422267427, 2172.7935846094756, 9407.623695052258, 9409.76475588109, 9546.093121153479, 9808.754781130458, 10019.248556358303, 1704.2245778170902, 1767.2047578589686, 1804.179098510188, 1812.2207450796152, 1835.614520950602, 67092.0, 72104.63947680229, 73127.0, 74002.99999999946, 75024.62487687527, 10244.743881403025, 10336.0697537222, 10450.68647940563, 10518.579256829795, 10592.258541901992, 14186.290685465685, 14259.643508912153, 14313.141211527342, 14329.85670143306, 14333.211673357857, 7430.96284518574, 7734.497257678233, 7754.18581048993, 7757.185495522889, 7833.216678332121, 7344.632768361561, 7469.414037347092, 7497.400207983348, 7606.695732170651, 7687.884681729778, 4068.1253530491085, 4500.977495112569, 4552.635789136861, 4562.24722920721, 4579.7252164870215, 1773.911304434773, 1785.098525244743, 1882.1812511557516, 1898.6677331466938, 1903.448000079989, 857.7469646454311, 862.7023676831483, 884.4428010353565, 897.7755561109592, 914.721010091915, 17038.403655872233, 17198.755974205284, 17541.824581754274, 17672.734908976374, 17892.821071789374, 871.9912800872037, 879.4986857491168, 882.1178821178821, 923.9491827949392, 940.3652534539295, 9423.539351400545, 9967.152792012615, 9999.450030248261, 10005.699829005142, 10013.949930250303, 356186.0, 358174.0, 374284.0, 393376.0, 394242.0, 78957.0, 79409.60295198487, 83747.58126209452, 84060.15939840645, 84453.57773211095, 881.6517475597232, 899.3075331994328, 912.9680461183959, 916.6929078758557, 916.8303863785221, 14528.83032121007, 15680.686386271982, 15779.921100394424, 15903.52289431319, 16176.595585109995, 37993.810030949666, 38265.0, 39021.6097839018, 39987.40018899661, 40536.3919541213, 48640.5135948636, 49098.0, 52202.0, 53523.732381337846, 59491.702541487015, 7754.34088102495, 7912.84174316522, 7979.9202007979175, 7991.880121798062, 8115.9188408117525, 11432.714182145513, 12337.259764414164, 12392.256464612152, 12620.873791261969, 12634.620961371174, 10703.732406689895, 10712.517936692711, 10750.8387374191, 10788.190885683449, 11055.0603198729, 10068.093871551595, 10707.571697132027, 10763.300385474919, 10842.837357439803, 11007.284526505751, 10230.59077636916, 10404.480645658148, 10544.367337959748, 11038.0, 11052.944735276273, 7689.8462030757955, 7856.410769192447, 7900.802479938047, 7915.485493442908, 8019.318357939407, 8949.686760963335, 10475.214358922958, 10748.731281718019, 10777.730556736144, 10902.40036797952], "value": 8455.656206666732, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1340.4169186403915, 1408.4014293925081, 1465.4065103633031, 1652.9421470248544, 1683.663267346531, 6897.999790030442, 7140.464465165121, 7513.0233069701, 8029.317508011819, 8031.959840200798, 7522.0, 7790.337821285198, 7812.726554570591, 7966.123726390107, 8032.277095061443, 2189.9890500547513, 2205.900734466953, 2212.778722127782, 2217.5010622609866, 2217.6230040893006, 1870.943871683845, 1934.5453818352676, 1934.9903250483728, 1946.6301402733436, 2200.3948914048683, 2141.9250326238584, 2209.0169874405815, 2213.092632020872, 2221.3002904085242, 2226.6214743493647, 2213.2917466410754, 2232.754397016327, 2236.575050740354, 2236.709227800384, 2274.4882401459704, 2226.376614547929, 2230.565039817236, 2233.8994745236505, 2236.306744909067, 2236.5079682469996, 8004.439689221756, 8101.0, 8107.756767296932, 8120.106788253346, 8121.18788121189, 4525.683202175849, 4674.018456124218, 4689.249720044811, 4699.835505757316, 4700.2949557566635, 2830.6320178376677, 2881.178864023764, 2960.008397186945, 2965.273507990556, 2967.302683869289, 870.9825803483894, 884.2881480408269, 893.3523195683143, 913.7943962608426, 917.5458148216609, 10953.671389858317, 10954.068904143158, 10964.780704385868, 10967.616133435291, 10968.945155274172, 4138.461999939988, 4327.415798867176, 4407.493138289074, 4409.581089796464, 4409.757463339483, 9242.12199841014, 9301.488418136933, 9342.486163261086, 9345.112214339626, 9348.4858332791, 4782.139214941344, 4800.207965685692, 4801.639877009238, 4802.495737947465, 4804.615630749532, 4312.568743125662, 4358.934615980763, 4360.803763830635, 4364.869053928387, 4393.099414620059, 3372.915677108043, 3470.444728843373, 3483.808390538494, 3692.833822477995, 3819.2743378757946, 1093.7101668057812, 1151.867535233459, 1165.7493638867684, 1169.8830116988233, 1192.9403529823649, 687.220005293985, 712.398023669998, 785.9468312461215, 788.9763307100797, 798.9932684817172, 4899.902001959941, 4951.257311403318, 4999.900001999939, 5008.949910500921, 5066.189409694432, 826.0899389496988, 832.5795473285951, 875.4528419737663, 877.440567266313, 885.6501681835767, 3312.8840490582716, 3316.35331110436, 3347.698707116371, 3401.149712571857, 3436.621971583124, 9475.905240947503, 9502.714918552454, 9683.951580242054, 9791.069848364394, 9793.853092203623, 9581.233501319877, 9684.128428441474, 9690.660826871026, 9706.75733106664, 9718.271129665303, 7233.746818861315, 7270.272972702687, 7349.853002939912, 7525.473216874876, 7526.548407095483, 4992.5756310714, 5008.0, 5040.193569028937, 5049.9495005049475, 5072.315237442898, 8645.913540864762, 8708.608112635073, 8892.86660700103, 8909.376343655882, 9040.231580315483, 9017.098290171192, 9127.22418594427, 9135.817283654422, 9202.067565810987, 9590.808183836145, 7575.393968482618, 7651.846963060819, 7682.078150621737, 7744.148143704076, 7747.380209583107, 7285.125784905633, 7527.360174385239, 7549.584772837547, 7620.085589729268, 7779.338756205786, 5399.541039011571, 6844.041834143323, 6992.0910281663055, 7009.0, 7131.037309963296, 6889.793306200822, 6901.1718593769065, 7020.824479388056, 7026.508144430045, 7088.362047415757, 6164.414380634012, 6183.81448556544, 6209.534284928739, 6234.220722409699, 6239.126522286792, 4352.717073390219, 4535.070310586388, 4586.243269860435, 4662.487126416024, 4667.346571479928, 4487.596116349544, 4496.842610508616, 4531.750753708578, 4570.611498022706, 4588.426446694163], "value": 4146.356599599937, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [301.2558979321077, 303.6053130929791, 307.4036369443281, 308.19099862859997, 311.2793882162794, 4842.661013729036, 4876.707397556149, 4893.657443978918, 4907.362042934418, 4931.137051016067, 4824.879378015551, 4830.661853670235, 4843.39457567804, 4851.393575803025, 4853.5874450671645, 3674.7243956703287, 3720.5907350191455, 3754.3054534910993, 3821.675157611606, 3843.26977874203, 3791.6587507124354, 3822.2546603412347, 3834.5206849143856, 3835.213781174866, 3838.3495097108234, 3608.2963822054708, 3801.9049523761987, 3805.847766089353, 3806.029462487062, 3806.200697853454, 3639.290338384016, 3783.786484906333, 3791.8007555617673, 3791.829367678461, 3795.905102372435, 3357.4628059510605, 3367.276035652322, 3378.476336167898, 3384.627690953993, 3390.304987477561, 4754.690945088558, 4766.547178018118, 4768.833090841838, 4772.0174890693315, 4772.2125849234835, 4237.7669228192435, 4332.631726303236, 4353.978230108861, 4362.105768317488, 4372.23485889968, 4998.275594919747, 5016.0, 5048.712578292512, 5049.520295571915, 5084.110280700863, 3675.467057276707, 3691.778493290411, 3695.595673644025, 3708.962910370916, 3718.163413232001, 5137.820176293849, 5229.450907654679, 5248.396434410053, 5292.994331077121, 5294.947050529484, 3748.538070152643, 3753.7560058596105, 3754.6808521276, 3760.2479504099288, 3772.830222639933, 3815.694744420495, 3821.732478726518, 3825.827837747308, 3825.9426108608395, 3830.3296923038356, 4332.978335108304, 4341.5007274163245, 4343.807301633297, 4358.215521206213, 4360.781960902005, 4826.7827947742435, 4990.80036798524, 5012.147934851084, 5020.47285035066, 5047.545720885138, 1299.571141523295, 1319.182107093608, 1320.8904520202884, 1323.5367621332457, 1325.5493132335052, 864.2049314630555, 867.4689173608585, 890.9599068041954, 897.2328658996595, 897.5960817632092, 4298.183345164409, 4356.0, 4499.617532509773, 4517.102816816945, 4534.0, 5186.196139598368, 5194.3766747990485, 5205.453427390145, 5229.4770522948165, 5244.344456942882, 4285.61429471349, 4468.798904049326, 4475.843345482893, 4484.775761211927, 4541.613962813131, 2755.9448811023667, 2758.3793646429795, 2769.127724766692, 2772.9584056239173, 2792.274008757697, 4918.458969513351, 4939.333190019373, 4943.555080042814, 4949.430815456197, 4951.752412379366, 5053.494650534991, 5313.229581710708, 5328.387235467971, 5369.677819330775, 5386.0, 4911.894823664718, 4928.654994150446, 4961.156603377362, 4981.32752078472, 4984.750762461862, 5243.853687787449, 5260.684358938476, 5275.525202731773, 5312.36251649789, 5314.946850531445, 4923.32606913651, 5169.4830516948, 5206.088934436534, 5208.140656791738, 5212.296339994053, 4940.777665005012, 4981.1283025469675, 4981.6014718823135, 4995.850124496271, 5016.648834581544, 3728.161163738137, 3747.4191500317493, 3775.7923314217983, 3786.413105968579, 3796.620337966181, 5116.641835071509, 5274.334337635307, 5284.682919024871, 5288.0, 5357.651752636066, 5060.873478163076, 5077.6741234491465, 5078.796848126181, 5084.186530155157, 5101.285819985279, 5057.69653820772, 5058.3929928408825, 5068.518490743373, 5071.290019397361, 5083.161278389024, 4744.833930812405, 4854.417171817465, 4906.2640603909695, 4974.925376119433, 4981.750912454435, 4947.45577986414, 5075.593952483866, 5111.412187598325, 5114.948850511447, 5121.692698438105, 4988.376452943382, 5011.599072074298, 5013.348264725562, 5016.0186726243655, 5020.6234532410945], "value": 3847.1134059876285, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [558.3885645218486, 607.8419610901167, 609.1563184988789, 617.6818938246804, 634.9238091429029, 11350.545978160873, 11997.34014629195, 12090.455929483172, 12281.263124212532, 12302.507899684013, 11984.10119241056, 12215.572454964056, 12231.204971676834, 12235.0, 12235.388230588458, 623.8689875126229, 761.9657115429819, 771.0939645916068, 797.5414136871293, 801.1747899663357, 787.1538096546207, 788.1173086143527, 793.6388943030936, 793.9523628582275, 794.6741835847304, 830.1449507007792, 834.6035633074301, 834.845553572591, 835.0146826744439, 835.1648351648352, 647.6696884588894, 782.3780094824572, 830.3564737328559, 830.9875351869697, 831.8003679116969, 606.9514438844882, 609.4849851875158, 612.4916319454842, 613.0589545048374, 613.1722175063672, 11497.712557186054, 11512.021478174365, 11513.366764827932, 11525.19323647345, 11532.654020379403, 11028.393438360887, 11233.21367504275, 11432.885671143265, 11928.165028447926, 12647.304398258093, 10161.339512931636, 10410.167186625053, 11798.46906889192, 11876.10929180315, 11883.108766842435, 3215.678432156789, 3247.7564182686156, 3258.8696452141885, 3354.1446931032674, 3386.508956201362, 61989.38010619881, 62274.0, 63186.36813631851, 65369.34630653728, 66036.66981665109, 9694.90305096954, 9892.25808064398, 10077.899221007843, 10272.178225741924, 10582.682519524427, 18028.909855450638, 18497.167627456798, 18544.629107417775, 18562.164702588416, 18629.81370186308, 6527.8694426111215, 6632.801015969529, 6657.167854018247, 6879.759208427781, 6946.097007389007, 3624.836882340301, 3697.9445308320396, 3763.8682646107804, 3805.1248212911187, 3893.1045859452483, 2705.905293314764, 2826.830390176596, 2837.858107094637, 2844.160972513072, 2847.8718457669456, 508.4915084915085, 516.3468212710924, 516.770037333383, 562.6624025584698, 595.2559300873908, 517.9689218646894, 524.5410266017235, 557.8744782424003, 559.6809818403552, 612.8621060261405, 7874.803129921798, 8068.47554908929, 8389.0, 8439.70461033861, 8450.61972211252, 466.80160931603933, 519.9922001169986, 587.006661981177, 597.9820605381846, 604.7792555717132, 3766.133789228493, 4011.5587285398583, 4061.329880569732, 4095.89760255996, 4107.979460102681, 78909.21090789018, 97420.51289743507, 99440.50839237418, 100400.497997511, 100843.0, 48140.27789583159, 48141.0, 48566.0, 57814.71092644594, 85025.0, 61810.38189618136, 64004.67997659982, 76088.61955690297, 76470.0, 79002.86481378692, 8345.499270043816, 8571.0, 8855.468671879707, 8894.644214231359, 8948.0, 44046.77976610096, 44456.0, 46416.76791616021, 46520.7673961628, 46814.76592617015, 36647.701706846514, 37605.623943761304, 37613.623863761015, 50338.49661503338, 66692.0, 11376.0, 11530.365829879438, 11639.53441862316, 11670.88329116698, 12178.695532611755, 12232.75534489323, 12793.360331983178, 12833.871661283267, 12957.611271661488, 13168.868311317148, 8239.340852731886, 9900.851487227841, 12111.878881211074, 12138.575149869712, 13488.662783430493, 12373.326411006543, 12412.193207441487, 12505.499780008699, 12929.870701292866, 12941.352932353533, 12007.640594378774, 12101.69745756363, 12147.0, 12509.710188228191, 12742.044346674222, 9615.9038409615, 9653.806923861624, 9670.56482458277, 9706.660266890625, 9924.255680823822, 10514.069585536237, 10538.736531586772, 10598.629047983284, 10651.840222396515, 10685.432625456486], "value": 6379.329571472177, "unit": "score"}], "name": "dromaeo_css", "value": 6385.808896557029, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [101.0, 112.0, 112.0, 111.0, 113.0, 112.0, 112.0, 114.0, 111.0, 111.0], "value": 110.9, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 125.0, 123.0, 177.0, 122.0, 123.0, 143.0, 121.0, 157.0, 121.0], "value": 135.8, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [173.0, 161.0, 158.0, 161.0, 160.0, 161.0, 160.0, 163.0, 161.0, 159.0], "value": 161.7, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [77.0, 75.0, 77.0, 108.0, 77.0, 77.0, 75.0, 75.0, 101.0, 76.0], "value": 81.8, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [87.0, 86.0, 120.0, 85.0, 84.0, 86.0, 124.0, 85.0, 85.0, 139.0], "value": 98.1, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 116.0, 117.0, 117.0, 117.0, 117.0, 117.0, 118.0, 117.0, 117.0], "value": 117.0, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 147.0, 146.0, 147.0, 147.0, 148.0, 146.0, 147.0, 146.0, 148.0], "value": 146.8, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [96.0, 95.0, 95.0, 96.0, 96.0, 95.0, 95.0, 96.0, 95.0, 95.0], "value": 95.4, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [63.0, 63.0, 62.0, 63.0, 62.0, 64.0, 64.0, 63.0, 63.0, 62.0], "value": 62.9, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [65.0, 64.0, 65.0, 65.0, 65.0, 65.0, 64.0, 65.0, 65.0, 64.0], "value": 64.7, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [79.0, 77.0, 78.0, 78.0, 78.0, 78.0, 87.0, 81.0, 78.0, 79.0], "value": 79.3, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [139.0, 126.0, 128.0, 129.0, 128.0, 128.0, 127.0, 128.0, 163.0, 129.0], "value": 132.5, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [165.0, 167.0, 165.0, 164.0, 165.0, 166.0, 168.0, 170.0, 162.0, 165.0], "value": 165.7, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [67.0, 70.0, 67.0, 70.0, 66.0, 67.0, 67.0, 67.0, 68.0, 68.0], "value": 67.7, "unit": "score"}], "name": "kraken", "value": 1520.3, "alertThreshold": 2.0}]} 18:59:01 INFO - Return code: 0 18:59:01 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 18:59:01 INFO - # TBPL SUCCESS # 18:59:01 INFO - Running post-action listener: _resource_record_post_action 18:59:01 INFO - ##### 18:59:01 INFO - ##### Finished run-tests step (success) 18:59:01 INFO - ##### 18:59:01 INFO - Running post-run listener: _resource_record_post_run 18:59:02 INFO - Total resource usage - Wall time: 1202s; CPU: 13.0%; Read bytes: 7782400; Write bytes: 440238080; Read time: 1820; Write time: 369544 18:59:02 INFO - TinderboxPrint: CPU usage
12.9% 18:59:02 INFO - TinderboxPrint: I/O read bytes / time
7,782,400 / 1,820 18:59:02 INFO - TinderboxPrint: I/O write bytes / time
440,238,080 / 369,544 18:59:02 INFO - TinderboxPrint: CPU idle
8,350.8 (87.0%) 18:59:02 INFO - TinderboxPrint: CPU user
1,199.9 (12.5%) 18:59:02 INFO - TinderboxPrint: Swap in / out
0 / 0 18:59:02 INFO - install - Wall time: 17s; CPU: 13.0%; Read bytes: 4096; Write bytes: 125411328; Read time: 80; Write time: 152328 18:59:02 INFO - run-tests - Wall time: 1186s; CPU: 13.0%; Read bytes: 5562368; Write bytes: 314826752; Read time: 1556; Write time: 217216 18:59:02 INFO - Running post-run listener: _upload_blobber_files 18:59:02 INFO - Blob upload gear active. 18:59:02 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 18:59:02 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 18:59:02 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'] 18:59:02 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 18:59:03 INFO - (blobuploader) - INFO - Open directory for files ... 18:59:03 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 18:59:03 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 18:59:03 INFO - (blobuploader) - INFO - Uploading, attempt #1. 18:59:03 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 18:59:03 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 18:59:03 INFO - (blobuploader) - INFO - Done attempting. 18:59:03 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 18:59:03 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 18:59:03 INFO - (blobuploader) - INFO - Uploading, attempt #1. 18:59:04 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 18:59:04 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 18:59:04 INFO - (blobuploader) - INFO - Done attempting. 18:59:04 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 18:59:04 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 18:59:04 INFO - (blobuploader) - INFO - Uploading, attempt #1. 18:59:07 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 18:59:07 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 18:59:07 INFO - (blobuploader) - INFO - Done attempting. 18:59:07 INFO - (blobuploader) - INFO - Iteration through files over. 18:59:07 INFO - Return code: 0 18:59:07 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 18:59:07 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 18:59:07 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/6b9945d004d33f5ae6830b919e3f937bcc60e82c0c1c62ed90dda935cc21f296d4f0fe472475ca368caad352b4319de9d6fd95ff1244fa082376a31fccd5d576", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/c01ea19e3905a665fa63d13d5f3bfd27ed1b1af900e1a6b01934122996743cdaddc4ae7f80fd27504b5793d134be07c76f024ebad36827f6f07463177b5bec32", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/0dc43dde42ede243d04554961df23111c5351909c663903a47ab5f9c0e6dff54322be7a9f86c117fb78e89e7ecb8f55b14172ade3fa4c3632b3d1ecc44ab2766"} 18:59:07 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 18:59:07 INFO - Writing to file /builds/slave/test/properties/blobber_files 18:59:07 INFO - Contents: 18:59:07 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/6b9945d004d33f5ae6830b919e3f937bcc60e82c0c1c62ed90dda935cc21f296d4f0fe472475ca368caad352b4319de9d6fd95ff1244fa082376a31fccd5d576", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/c01ea19e3905a665fa63d13d5f3bfd27ed1b1af900e1a6b01934122996743cdaddc4ae7f80fd27504b5793d134be07c76f024ebad36827f6f07463177b5bec32", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/0dc43dde42ede243d04554961df23111c5351909c663903a47ab5f9c0e6dff54322be7a9f86c117fb78e89e7ecb8f55b14172ade3fa4c3632b3d1ecc44ab2766"} 18:59:07 INFO - Running post-run listener: copy_logs_to_upload_dir 18:59:07 INFO - Copying logs to upload dir... 18:59:07 INFO - mkdir: /builds/slave/test/build/upload/logs 18:59:07 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1250.698699 ========= master_lag: 0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 50 secs) (at 2016-07-05 18:59:07.841150) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-07-05 18:59:07.846520) ========= 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=6d15e502d8e29d5d2676d664000001c3-1467768580.869301-24592832 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/6b9945d004d33f5ae6830b919e3f937bcc60e82c0c1c62ed90dda935cc21f296d4f0fe472475ca368caad352b4319de9d6fd95ff1244fa082376a31fccd5d576", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/c01ea19e3905a665fa63d13d5f3bfd27ed1b1af900e1a6b01934122996743cdaddc4ae7f80fd27504b5793d134be07c76f024ebad36827f6f07463177b5bec32", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/0dc43dde42ede243d04554961df23111c5351909c663903a47ab5f9c0e6dff54322be7a9f86c117fb78e89e7ecb8f55b14172ade3fa4c3632b3d1ecc44ab2766"} build_url:https://queue.taskcluster.net/v1/task/B-gyM-4sT3yUj5JL-ILAVA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011156 build_url: 'https://queue.taskcluster.net/v1/task/B-gyM-4sT3yUj5JL-ILAVA/artifacts/public/build/firefox-50.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/6b9945d004d33f5ae6830b919e3f937bcc60e82c0c1c62ed90dda935cc21f296d4f0fe472475ca368caad352b4319de9d6fd95ff1244fa082376a31fccd5d576", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/c01ea19e3905a665fa63d13d5f3bfd27ed1b1af900e1a6b01934122996743cdaddc4ae7f80fd27504b5793d134be07c76f024ebad36827f6f07463177b5bec32", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/0dc43dde42ede243d04554961df23111c5351909c663903a47ab5f9c0e6dff54322be7a9f86c117fb78e89e7ecb8f55b14172ade3fa4c3632b3d1ecc44ab2766"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-07-05 18:59:07.872150) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-07-05 18:59:07.872461) ========= 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=6d15e502d8e29d5d2676d664000001c3-1467768580.869301-24592832 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004393 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-07-05 18:59:07.955999) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-07-05 18:59:07.956328) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-07-05 18:59:07.956609) ========= ========= Total master_lag: 0.24 =========