builder: fx-team_ubuntu64_hw_test-dromaeojs slave: talos-linux64-ix-026 starttime: 1469044382.0 results: success (0) buildid: 20160720121920 builduid: cf9ab99d8a63429bb500783705727c6a revision: c050984325e379286c1456a261b0cdc92dab89c1 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-07-20 12:53:02.001084) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-07-20 12:53:02.001557) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-07-20 12:53:02.001875) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-07-20 12:53:02.019777) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-20 12:53:02.020111) ========= bash -c 'wget -Oarchiver_client.py --no-check-certificate --tries=10 --waitretry=3 https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', 'wget -Oarchiver_client.py --no-check-certificate --tries=10 --waitretry=3 https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=41bf3e9aed84707956354da8000001c5-1469044380.585708-1980824796 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-07-20 12:53:02-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 46.8M=0s 2016-07-20 12:53:02 (46.8 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.086855 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-20 12:53:02.124367) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-07-20 12:53:02.124757) ========= rm -rf scripts properties in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['rm', '-rf', 'scripts', 'properties'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=41bf3e9aed84707956354da8000001c5-1469044380.585708-1980824796 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.014234 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-07-20 12:53:02.175263) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-20 12:53:02.175654) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev c050984325e379286c1456a261b0cdc92dab89c1 --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 c050984325e379286c1456a261b0cdc92dab89c1 --destination scripts --debug'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=41bf3e9aed84707956354da8000001c5-1469044380.585708-1980824796 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-07-20 12:53:02,317 truncating revision to first 12 chars 2016-07-20 12:53:02,317 Setting DEBUG logging. 2016-07-20 12:53:02,317 attempt 1/10 2016-07-20 12:53:02,317 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/c050984325e3?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-07-20 12:53:02,635 unpacking tar archive at: fx-team-c050984325e3/testing/mozharness/ program finished with exit code 0 elapsedTime=0.634040 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-20 12:53:02.829955) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-07-20 12:53:02.830312) ========= script_repo_revision: c050984325e379286c1456a261b0cdc92dab89c1 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-07-20 12:53:02.830764) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-07-20 12:53:02.831090) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-07-20 12:53:02.843434) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 49 secs) (at 2016-07-20 12:53:02.843741) ========= /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=41bf3e9aed84707956354da8000001c5-1469044380.585708-1980824796 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 12:53:03 INFO - MultiFileLogger online at 20160720 12:53:03 in /builds/slave/test 12:53:03 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 12:53:03 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 12:53:03 INFO - {'append_to_log': False, 12:53:03 INFO - 'base_work_dir': '/builds/slave/test', 12:53:03 INFO - 'blob_upload_branch': 'Fx-Team-Non-PGO', 12:53:03 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 12:53:03 INFO - 'branch': 'Fx-Team-Non-PGO', 12:53:03 INFO - 'buildbot_json_path': 'buildprops.json', 12:53:03 INFO - 'config_files': ('talos/linux_config.py',), 12:53:03 INFO - 'default_actions': ('clobber', 12:53:03 INFO - 'read-buildbot-config', 12:53:03 INFO - 'download-and-extract', 12:53:03 INFO - 'populate-webroot', 12:53:03 INFO - 'create-virtualenv', 12:53:03 INFO - 'install', 12:53:03 INFO - 'run-tests'), 12:53:03 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 12:53:03 INFO - 'download_minidump_stackwalk': True, 12:53:03 INFO - 'download_symbols': 'ondemand', 12:53:03 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 12:53:03 INFO - 'tooltool.py': '/tools/tooltool.py', 12:53:03 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 12:53:03 INFO - '/tools/misc-python/virtualenv.py')}, 12:53:03 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 12:53:03 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 12:53:03 INFO - 'installer_path': 'installer.exe', 12:53:03 INFO - 'log_level': 'info', 12:53:03 INFO - 'log_name': 'talos', 12:53:03 INFO - 'log_to_console': True, 12:53:03 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 12:53:03 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 12:53:03 INFO - 'opt_config_files': (), 12:53:03 INFO - 'pip_index': False, 12:53:03 INFO - 'sps_profile': False, 12:53:03 INFO - 'sps_profile_interval': 0, 12:53:03 INFO - 'suite': 'dromaeojs', 12:53:03 INFO - 'system_bits': '32', 12:53:03 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 12:53:03 INFO - 'title': 'talos-linux64-ix-026', 12:53:03 INFO - 'tooltool_cache': '/builds/tooltool_cache', 12:53:03 INFO - 'use_talos_json': True, 12:53:03 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 12:53:03 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 12:53:03 INFO - 'work_dir': 'build'} 12:53:03 INFO - [mozharness: 2016-07-20 19:53:03.074760Z] Running clobber step. 12:53:03 INFO - Running pre-action listener: _resource_record_pre_action 12:53:03 INFO - Running main action method: clobber 12:53:03 INFO - rmtree: /builds/slave/test/build 12:53:03 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 12:53:03 INFO - Running post-action listener: _resource_record_post_action 12:53:03 INFO - [mozharness: 2016-07-20 19:53:03.541247Z] Finished clobber step (success) 12:53:03 INFO - [mozharness: 2016-07-20 19:53:03.541365Z] Running read-buildbot-config step. 12:53:03 INFO - Running pre-action listener: _resource_record_pre_action 12:53:03 INFO - Running main action method: read_buildbot_config 12:53:03 INFO - Using buildbot properties: 12:53:03 INFO - { 12:53:03 INFO - "project": "", 12:53:03 INFO - "product": "firefox", 12:53:03 INFO - "script_repo_revision": "production", 12:53:03 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs", 12:53:03 INFO - "repository": "", 12:53:03 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team talos dromaeojs", 12:53:03 INFO - "buildid": "20160720121920", 12:53:03 INFO - "pgo_build": "False", 12:53:03 INFO - "basedir": "/builds/slave/test", 12:53:03 INFO - "buildnumber": 1813, 12:53:03 INFO - "slavename": "talos-linux64-ix-026", 12:53:03 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 12:53:03 INFO - "platform": "ubuntu64_hw", 12:53:03 INFO - "scheduler": "tests-fx-team-linux64-talos", 12:53:03 INFO - "branch": "fx-team", 12:53:03 INFO - "repo_path": "integration/fx-team", 12:53:03 INFO - "revision": "c050984325e379286c1456a261b0cdc92dab89c1", 12:53:03 INFO - "stage_platform": "linux64", 12:53:03 INFO - "builduid": "cf9ab99d8a63429bb500783705727c6a", 12:53:03 INFO - "slavebuilddir": "test" 12:53:03 INFO - } 12:53:03 INFO - Found installer url https://queue.taskcluster.net/v1/task/Ss6DX1adQNKwmG9dXJ2qBA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2. 12:53:03 INFO - Running post-action listener: _resource_record_post_action 12:53:03 INFO - [mozharness: 2016-07-20 19:53:03.543808Z] Finished read-buildbot-config step (success) 12:53:03 INFO - [mozharness: 2016-07-20 19:53:03.543898Z] Running download-and-extract step. 12:53:03 INFO - Running pre-action listener: _resource_record_pre_action 12:53:03 INFO - Running main action method: download_and_extract 12:53:03 INFO - mkdir: /builds/slave/test/build/tests 12:53:03 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')]} 12:53:03 INFO - https://queue.taskcluster.net/v1/task/Ss6DX1adQNKwmG9dXJ2qBA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 12:53:03 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Ss6DX1adQNKwmG9dXJ2qBA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 12:53:03 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Ss6DX1adQNKwmG9dXJ2qBA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 12:53:03 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Ss6DX1adQNKwmG9dXJ2qBA/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 12:53:03 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Ss6DX1adQNKwmG9dXJ2qBA/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 12:53:04 INFO - Downloaded 1361 bytes. 12:53:04 INFO - Reading from file /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 12:53:04 INFO - Using the following test package requirements: 12:53:04 INFO - {u'common': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 12:53:04 INFO - u'cppunittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 12:53:04 INFO - u'firefox-50.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 12:53:04 INFO - u'gtest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 12:53:04 INFO - u'firefox-50.0a1.en-US.linux-x86_64.gtest.tests.zip'], 12:53:04 INFO - u'jittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 12:53:04 INFO - u'jsshell-linux-x86_64.zip'], 12:53:04 INFO - u'mochitest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 12:53:04 INFO - u'firefox-50.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 12:53:04 INFO - u'mozbase': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 12:53:04 INFO - u'reftest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 12:53:04 INFO - u'firefox-50.0a1.en-US.linux-x86_64.reftest.tests.zip'], 12:53:04 INFO - u'talos': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 12:53:04 INFO - u'firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip'], 12:53:04 INFO - u'web-platform': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 12:53:04 INFO - u'firefox-50.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 12:53:04 INFO - u'xpcshell': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 12:53:04 INFO - u'firefox-50.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 12:53:04 INFO - Downloading packages: [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 12:53:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:53:04 INFO - https://queue.taskcluster.net/v1/task/Ss6DX1adQNKwmG9dXJ2qBA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 12:53:04 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Ss6DX1adQNKwmG9dXJ2qBA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 12:53:04 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Ss6DX1adQNKwmG9dXJ2qBA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 12:53:04 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Ss6DX1adQNKwmG9dXJ2qBA/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 12:53:04 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Ss6DX1adQNKwmG9dXJ2qBA/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 12:53:05 INFO - Downloaded 22771994 bytes. 12:53:05 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'] 12:53:05 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 12:53:06 INFO - Return code: 0 12:53:06 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 12:53:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:53:06 INFO - https://queue.taskcluster.net/v1/task/Ss6DX1adQNKwmG9dXJ2qBA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 12:53:06 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Ss6DX1adQNKwmG9dXJ2qBA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 12:53:06 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Ss6DX1adQNKwmG9dXJ2qBA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 12:53:06 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Ss6DX1adQNKwmG9dXJ2qBA/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 12:53:06 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Ss6DX1adQNKwmG9dXJ2qBA/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 12:53:07 INFO - Downloaded 22771994 bytes. 12:53:07 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'] 12:53:07 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 12:53:08 INFO - Return code: 0 12:53:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:53:08 INFO - https://queue.taskcluster.net/v1/task/Ss6DX1adQNKwmG9dXJ2qBA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 12:53:08 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Ss6DX1adQNKwmG9dXJ2qBA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 12:53:08 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Ss6DX1adQNKwmG9dXJ2qBA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 12:53:08 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Ss6DX1adQNKwmG9dXJ2qBA/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 12:53:08 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Ss6DX1adQNKwmG9dXJ2qBA/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 12:53:09 INFO - Downloaded 14403317 bytes. 12:53:09 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'] 12:53:09 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 12:53:09 INFO - Return code: 0 12:53:09 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')]} 12:53:09 INFO - https://queue.taskcluster.net/v1/task/Ss6DX1adQNKwmG9dXJ2qBA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 12:53:09 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Ss6DX1adQNKwmG9dXJ2qBA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 12:53:09 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Ss6DX1adQNKwmG9dXJ2qBA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 12:53:09 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Ss6DX1adQNKwmG9dXJ2qBA/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 12:53:09 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Ss6DX1adQNKwmG9dXJ2qBA/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 12:53:11 INFO - Downloaded 57115898 bytes. 12:53:11 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/Ss6DX1adQNKwmG9dXJ2qBA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 12:53:11 INFO - mkdir: /builds/slave/test/properties 12:53:11 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 12:53:11 INFO - Writing to file /builds/slave/test/properties/build_url 12:53:11 INFO - Contents: 12:53:11 INFO - build_url:https://queue.taskcluster.net/v1/task/Ss6DX1adQNKwmG9dXJ2qBA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 12:53:11 INFO - Running post-action listener: _resource_record_post_action 12:53:11 INFO - Running post-action listener: set_extra_try_arguments 12:53:11 INFO - [mozharness: 2016-07-20 19:53:11.860269Z] Finished download-and-extract step (success) 12:53:11 INFO - [mozharness: 2016-07-20 19:53:11.860504Z] Running populate-webroot step. 12:53:11 INFO - Running pre-action listener: _resource_record_pre_action 12:53:11 INFO - Running main action method: populate_webroot 12:53:11 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 12:53:11 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 12:53:11 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 12:53:11 INFO - '--tppagecycles', 12:53:11 INFO - '7'], 12:53:11 INFO - 'tests': ['tsvgm']}}, 12:53:11 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 12:53:11 INFO - 'tests': ['tresize', 'tcanvasmark']}, 12:53:11 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 12:53:11 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 12:53:11 INFO - 'tests': ['dromaeo_css', 'kraken']}, 12:53:11 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 12:53:11 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:53:11 INFO - 'talos_options': ['--disable-e10s'], 12:53:11 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 12:53:11 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:53:11 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 12:53:11 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:53:11 INFO - 'talos_options': ['--disable-e10s'], 12:53:11 INFO - 'tests': ['damp', 'tps']}, 12:53:11 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:53:11 INFO - 'tests': ['damp', 'tps']}, 12:53:11 INFO - 'g3': {'talos_options': ['--disable-e10s'], 12:53:11 INFO - 'tests': ['dromaeo_dom']}, 12:53:11 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 12:53:11 INFO - 'g4': {'talos_options': ['--disable-e10s'], 12:53:11 INFO - 'tests': ['basic_compositor_video']}, 12:53:11 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 12:53:11 INFO - 'other': {'talos_options': ['--disable-e10s'], 12:53:11 INFO - 'tests': ['a11yr', 12:53:11 INFO - 'ts_paint', 12:53:11 INFO - 'tpaint', 12:53:11 INFO - 'sessionrestore', 12:53:11 INFO - 'sessionrestore_no_auto_restore', 12:53:11 INFO - 'tabpaint']}, 12:53:11 INFO - 'other-e10s': {'tests': ['a11yr', 12:53:11 INFO - 'ts_paint', 12:53:11 INFO - 'tpaint', 12:53:11 INFO - 'sessionrestore', 12:53:11 INFO - 'sessionrestore_no_auto_restore', 12:53:11 INFO - 'tabpaint']}, 12:53:11 INFO - 'other-e10s_l64': {'tests': ['a11yr', 12:53:11 INFO - 'ts_paint', 12:53:11 INFO - 'tpaint', 12:53:11 INFO - 'sessionrestore', 12:53:11 INFO - 'sessionrestore_no_auto_restore', 12:53:11 INFO - 'tabpaint']}, 12:53:11 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 12:53:11 INFO - 'ts_paint', 12:53:11 INFO - 'tpaint', 12:53:11 INFO - 'sessionrestore', 12:53:11 INFO - 'sessionrestore_no_auto_restore', 12:53:11 INFO - 'tabpaint']}, 12:53:11 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 12:53:11 INFO - 'tests': ['a11yr', 12:53:11 INFO - 'ts_paint', 12:53:11 INFO - 'tpaint', 12:53:11 INFO - 'sessionrestore', 12:53:11 INFO - 'sessionrestore_no_auto_restore', 12:53:11 INFO - 'tabpaint']}, 12:53:11 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 12:53:11 INFO - 'tests': ['a11yr', 12:53:11 INFO - 'ts_paint', 12:53:11 INFO - 'tpaint', 12:53:11 INFO - 'sessionrestore', 12:53:11 INFO - 'sessionrestore_no_auto_restore', 12:53:11 INFO - 'tabpaint']}, 12:53:11 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 12:53:11 INFO - 'tests': ['tsvgx', 12:53:11 INFO - 'tsvgr_opacity', 12:53:11 INFO - 'tart', 12:53:11 INFO - 'tscrollx', 12:53:11 INFO - 'cart']}, 12:53:11 INFO - 'svgr-e10s': {'tests': ['tsvgx', 12:53:11 INFO - 'tsvgr_opacity', 12:53:11 INFO - 'tart', 12:53:11 INFO - 'tscrollx', 12:53:11 INFO - 'cart']}, 12:53:11 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:53:11 INFO - 'talos_options': ['--disable-e10s'], 12:53:11 INFO - 'tests': ['tp5o']}, 12:53:11 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:53:11 INFO - 'tests': ['tp5o']}, 12:53:11 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:53:11 INFO - 'talos_options': ['--disable-e10s', 12:53:11 INFO - '--xperf_path', 12:53:11 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 12:53:11 INFO - 'tests': ['tp5n']}, 12:53:11 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:53:11 INFO - 'talos_options': ['--xperf_path', 12:53:11 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 12:53:11 INFO - 'tests': ['tp5n']}}, 12:53:11 INFO - 'talos.zip': {'path': '', 12:53:11 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 12:53:11 INFO - Running post-action listener: _resource_record_post_action 12:53:11 INFO - [mozharness: 2016-07-20 19:53:11.879718Z] Finished populate-webroot step (success) 12:53:11 INFO - [mozharness: 2016-07-20 19:53:11.879808Z] Running create-virtualenv step. 12:53:11 INFO - Running pre-action listener: _resource_record_pre_action 12:53:11 INFO - Running main action method: create_virtualenv 12:53:11 INFO - Creating virtualenv /builds/slave/test/build/venv 12:53:11 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 12:53:11 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 12:53:11 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 12:53:11 INFO - Using real prefix '/usr' 12:53:11 INFO - New python executable in /builds/slave/test/build/venv/bin/python 12:53:12 INFO - Installing distribute.............................................................................................................................................................................................done. 12:53:14 INFO - Installing pip.................done. 12:53:14 INFO - Return code: 0 12:53:14 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 12:53:14 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')]} 12:53:14 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:53:14 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:53:14 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')]} 12:53:14 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:53:14 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:53:14 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 0x16da030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x183d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x199b180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19993b0>, '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 0x199a2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x199a740>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '41bf3e9aed84707956354da8000001c5-1469044380.585708-1980824796', '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 12:53:14 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 12:53:14 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 12:53:14 INFO - Using env: {'DISPLAY': ':0', 12:53:14 INFO - 'HOME': '/home/cltbld', 12:53:14 INFO - 'LANG': 'en_US.UTF-8', 12:53:14 INFO - 'LANGUAGE': 'en_US:en', 12:53:14 INFO - 'LOGNAME': 'cltbld', 12:53:14 INFO - 'MAIL': '/var/mail/cltbld', 12:53:14 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:53:14 INFO - 'MOZ_NO_REMOTE': '1', 12:53:14 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:53:14 INFO - 'NO_EM_RESTART': '1', 12:53:14 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:53:14 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:53:14 INFO - 'PWD': '/builds/slave/test', 12:53:14 INFO - 'SHELL': '/bin/bash', 12:53:14 INFO - 'SHLVL': '1', 12:53:14 INFO - 'TERM': 'linux', 12:53:14 INFO - 'TMOUT': '86400', 12:53:14 INFO - 'USER': 'cltbld', 12:53:14 INFO - 'XDG_SESSION_COOKIE': '41bf3e9aed84707956354da8000001c5-1469044380.585708-1980824796', 12:53:14 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:53:14 INFO - '_': '/tools/buildbot/bin/python'} 12:53:14 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:53:14 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 12:53:14 INFO - Cleaning up... 12:53:14 INFO - Return code: 0 12:53:14 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 12:53:14 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')]} 12:53:14 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:53:14 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:53:14 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')]} 12:53:14 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:53:14 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:53:14 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 0x16da030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x183d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x199b180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19993b0>, '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 0x199a2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x199a740>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '41bf3e9aed84707956354da8000001c5-1469044380.585708-1980824796', '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 12:53:14 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 12:53:14 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 12:53:14 INFO - Using env: {'DISPLAY': ':0', 12:53:14 INFO - 'HOME': '/home/cltbld', 12:53:14 INFO - 'LANG': 'en_US.UTF-8', 12:53:14 INFO - 'LANGUAGE': 'en_US:en', 12:53:14 INFO - 'LOGNAME': 'cltbld', 12:53:14 INFO - 'MAIL': '/var/mail/cltbld', 12:53:14 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:53:14 INFO - 'MOZ_NO_REMOTE': '1', 12:53:14 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:53:14 INFO - 'NO_EM_RESTART': '1', 12:53:14 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:53:14 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:53:14 INFO - 'PWD': '/builds/slave/test', 12:53:14 INFO - 'SHELL': '/bin/bash', 12:53:14 INFO - 'SHLVL': '1', 12:53:14 INFO - 'TERM': 'linux', 12:53:14 INFO - 'TMOUT': '86400', 12:53:14 INFO - 'USER': 'cltbld', 12:53:14 INFO - 'XDG_SESSION_COOKIE': '41bf3e9aed84707956354da8000001c5-1469044380.585708-1980824796', 12:53:14 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:53:14 INFO - '_': '/tools/buildbot/bin/python'} 12:53:14 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:53:14 INFO - Downloading/unpacking psutil>=3.1.1 12:53:14 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 12:53:14 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 12:53:14 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 12:53:14 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 12:53:14 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 12:53:14 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 12:53:16 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 12:53:16 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 12:53:16 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 12:53:16 INFO - Installing collected packages: psutil 12:53:16 INFO - Running setup.py install for psutil 12:53:17 INFO - building 'psutil._psutil_linux' extension 12:53:17 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 12:53:17 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 12:53:17 INFO - building 'psutil._psutil_posix' extension 12:53:17 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 12:53:17 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 12:53:17 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 12:53:17 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 12:53:17 INFO - Successfully installed psutil 12:53:17 INFO - Cleaning up... 12:53:17 INFO - Return code: 0 12:53:17 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 12:53:17 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:53:17 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:53:17 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:53:17 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:53:17 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:53:17 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:53:17 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 0x16da030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x183d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x199b180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19993b0>, '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 0x199a2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x199a740>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '41bf3e9aed84707956354da8000001c5-1469044380.585708-1980824796', '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 12:53:17 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 12:53:17 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 12:53:17 INFO - Using env: {'DISPLAY': ':0', 12:53:17 INFO - 'HOME': '/home/cltbld', 12:53:17 INFO - 'LANG': 'en_US.UTF-8', 12:53:17 INFO - 'LANGUAGE': 'en_US:en', 12:53:17 INFO - 'LOGNAME': 'cltbld', 12:53:17 INFO - 'MAIL': '/var/mail/cltbld', 12:53:17 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:53:17 INFO - 'MOZ_NO_REMOTE': '1', 12:53:17 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:53:17 INFO - 'NO_EM_RESTART': '1', 12:53:17 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:53:17 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:53:17 INFO - 'PWD': '/builds/slave/test', 12:53:17 INFO - 'SHELL': '/bin/bash', 12:53:17 INFO - 'SHLVL': '1', 12:53:17 INFO - 'TERM': 'linux', 12:53:17 INFO - 'TMOUT': '86400', 12:53:17 INFO - 'USER': 'cltbld', 12:53:17 INFO - 'XDG_SESSION_COOKIE': '41bf3e9aed84707956354da8000001c5-1469044380.585708-1980824796', 12:53:17 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:53:17 INFO - '_': '/tools/buildbot/bin/python'} 12:53:17 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:53:17 INFO - Downloading/unpacking mozsystemmonitor==0.3 12:53:17 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 12:53:17 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 12:53:17 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 12:53:17 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 12:53:17 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 12:53:17 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 12:53:19 INFO - Downloading mozsystemmonitor-0.3.tar.gz 12:53:19 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 12:53:19 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 12:53:19 INFO - Installing collected packages: mozsystemmonitor 12:53:19 INFO - Running setup.py install for mozsystemmonitor 12:53:19 INFO - Successfully installed mozsystemmonitor 12:53:19 INFO - Cleaning up... 12:53:19 INFO - Return code: 0 12:53:19 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 12:53: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')]} 12:53:19 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:53:19 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:53: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')]} 12:53:19 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:53:19 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:53:19 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 0x16da030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x183d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x199b180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19993b0>, '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 0x199a2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x199a740>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '41bf3e9aed84707956354da8000001c5-1469044380.585708-1980824796', '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 12:53:19 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 12:53:19 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 12:53:19 INFO - Using env: {'DISPLAY': ':0', 12:53:19 INFO - 'HOME': '/home/cltbld', 12:53:19 INFO - 'LANG': 'en_US.UTF-8', 12:53:19 INFO - 'LANGUAGE': 'en_US:en', 12:53:19 INFO - 'LOGNAME': 'cltbld', 12:53:19 INFO - 'MAIL': '/var/mail/cltbld', 12:53:19 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:53:19 INFO - 'MOZ_NO_REMOTE': '1', 12:53:19 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:53:19 INFO - 'NO_EM_RESTART': '1', 12:53:19 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:53:19 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:53:19 INFO - 'PWD': '/builds/slave/test', 12:53:19 INFO - 'SHELL': '/bin/bash', 12:53:19 INFO - 'SHLVL': '1', 12:53:19 INFO - 'TERM': 'linux', 12:53:19 INFO - 'TMOUT': '86400', 12:53:19 INFO - 'USER': 'cltbld', 12:53:19 INFO - 'XDG_SESSION_COOKIE': '41bf3e9aed84707956354da8000001c5-1469044380.585708-1980824796', 12:53:19 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:53:19 INFO - '_': '/tools/buildbot/bin/python'} 12:53:20 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:53:20 INFO - Downloading/unpacking jsonschema==2.5.1 12:53:20 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 12:53:20 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 12:53:20 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 12:53:20 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 12:53:20 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 12:53:20 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 12:53:21 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 12:53:21 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 12:53:21 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:53:21 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:53:21 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:53:21 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:53:21 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:53:21 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:53:22 INFO - Downloading functools32-3.2.3-2.tar.gz 12:53:22 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 12:53:22 INFO - warning: no files found matching '*.txt' 12:53:22 INFO - no previously-included directories found matching 'build' 12:53:22 INFO - no previously-included directories found matching 'dist' 12:53:22 INFO - no previously-included directories found matching '.git*' 12:53:22 INFO - Installing collected packages: jsonschema, functools32 12:53:22 INFO - Running setup.py install for functools32 12:53:22 INFO - warning: no files found matching '*.txt' 12:53:22 INFO - no previously-included directories found matching 'build' 12:53:22 INFO - no previously-included directories found matching 'dist' 12:53:22 INFO - no previously-included directories found matching '.git*' 12:53:22 INFO - Successfully installed jsonschema functools32 12:53:22 INFO - Cleaning up... 12:53:22 INFO - Return code: 0 12:53:22 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 12:53:22 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')]} 12:53:22 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:53:22 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:53:22 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')]} 12:53:22 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:53:22 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:53:22 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 0x16da030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x183d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x199b180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19993b0>, '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 0x199a2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x199a740>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '41bf3e9aed84707956354da8000001c5-1469044380.585708-1980824796', '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 12:53:22 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 12:53:22 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 12:53:22 INFO - Using env: {'DISPLAY': ':0', 12:53:22 INFO - 'HOME': '/home/cltbld', 12:53:22 INFO - 'LANG': 'en_US.UTF-8', 12:53:22 INFO - 'LANGUAGE': 'en_US:en', 12:53:22 INFO - 'LOGNAME': 'cltbld', 12:53:22 INFO - 'MAIL': '/var/mail/cltbld', 12:53:22 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:53:22 INFO - 'MOZ_NO_REMOTE': '1', 12:53:22 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:53:22 INFO - 'NO_EM_RESTART': '1', 12:53:22 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:53:22 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:53:22 INFO - 'PWD': '/builds/slave/test', 12:53:22 INFO - 'SHELL': '/bin/bash', 12:53:22 INFO - 'SHLVL': '1', 12:53:22 INFO - 'TERM': 'linux', 12:53:22 INFO - 'TMOUT': '86400', 12:53:22 INFO - 'USER': 'cltbld', 12:53:22 INFO - 'XDG_SESSION_COOKIE': '41bf3e9aed84707956354da8000001c5-1469044380.585708-1980824796', 12:53:22 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:53:22 INFO - '_': '/tools/buildbot/bin/python'} 12:53:22 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:53:22 INFO - Downloading/unpacking blobuploader==1.2.4 12:53:22 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 12:53:22 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 12:53:22 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 12:53:22 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 12:53:22 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 12:53:22 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 12:53:24 INFO - Downloading blobuploader-1.2.4.tar.gz 12:53:24 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 12:53:24 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 12:53:24 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 12:53:24 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 12:53:24 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 12:53:24 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 12:53:24 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 12:53:24 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 12:53:24 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 12:53:25 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 12:53:25 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:53:25 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:53:25 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:53:25 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:53:25 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:53:25 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:53:25 INFO - Downloading docopt-0.6.1.tar.gz 12:53:25 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 12:53:25 INFO - Installing collected packages: blobuploader, requests, docopt 12:53:25 INFO - Running setup.py install for blobuploader 12:53:25 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 12:53:25 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 12:53:25 INFO - Running setup.py install for requests 12:53:25 INFO - Running setup.py install for docopt 12:53:25 INFO - Successfully installed blobuploader requests docopt 12:53:25 INFO - Cleaning up... 12:53:25 INFO - Return code: 0 12:53:25 INFO - Installing None into virtualenv /builds/slave/test/build/venv 12:53:25 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:53:25 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:53:25 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:53:25 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:53:25 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:53:25 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:53:25 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 0x16da030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x183d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x199b180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19993b0>, '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 0x199a2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x199a740>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build/tests/config', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '41bf3e9aed84707956354da8000001c5-1469044380.585708-1980824796', '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 12:53:25 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 12:53:25 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 12:53:25 INFO - Using env: {'DISPLAY': ':0', 12:53:25 INFO - 'HOME': '/home/cltbld', 12:53:25 INFO - 'LANG': 'en_US.UTF-8', 12:53:25 INFO - 'LANGUAGE': 'en_US:en', 12:53:25 INFO - 'LOGNAME': 'cltbld', 12:53:25 INFO - 'MAIL': '/var/mail/cltbld', 12:53:25 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:53:25 INFO - 'MOZ_NO_REMOTE': '1', 12:53:25 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:53:25 INFO - 'NO_EM_RESTART': '1', 12:53:25 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:53:25 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:53:25 INFO - 'PWD': '/builds/slave/test', 12:53:25 INFO - 'SHELL': '/bin/bash', 12:53:25 INFO - 'SHLVL': '1', 12:53:25 INFO - 'TERM': 'linux', 12:53:25 INFO - 'TMOUT': '86400', 12:53:25 INFO - 'USER': 'cltbld', 12:53:25 INFO - 'XDG_SESSION_COOKIE': '41bf3e9aed84707956354da8000001c5-1469044380.585708-1980824796', 12:53:25 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:53:25 INFO - '_': '/tools/buildbot/bin/python'} 12:53:26 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:53:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 12:53:26 INFO - Running setup.py (path:/tmp/pip-6I3reX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 12:53:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 12:53:26 INFO - Running setup.py (path:/tmp/pip-ZrA6OW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 12:53:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 12:53:26 INFO - Running setup.py (path:/tmp/pip-JkBABg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 12:53:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 12:53:26 INFO - Running setup.py (path:/tmp/pip-y81LMR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 12:53:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 12:53:26 INFO - Running setup.py (path:/tmp/pip-lXmcnk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 12:53:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 12:53:26 INFO - Running setup.py (path:/tmp/pip-dmnB0I-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 12:53:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 12:53:26 INFO - Running setup.py (path:/tmp/pip-zIHGLx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 12:53:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 12:53:26 INFO - Running setup.py (path:/tmp/pip-xnSEat-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 12:53:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 12:53:26 INFO - Running setup.py (path:/tmp/pip-ODitCN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 12:53:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 12:53:26 INFO - Running setup.py (path:/tmp/pip-UAdzdZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 12:53:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 12:53:26 INFO - Running setup.py (path:/tmp/pip-653ufr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 12:53:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 12:53:26 INFO - Running setup.py (path:/tmp/pip-pQsxZN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 12:53:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 12:53:26 INFO - Running setup.py (path:/tmp/pip-jnTumB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 12:53:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 12:53:27 INFO - Running setup.py (path:/tmp/pip-MhTjR9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 12:53:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 12:53:27 INFO - Running setup.py (path:/tmp/pip-Pt1XKB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 12:53:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 12:53:27 INFO - Running setup.py (path:/tmp/pip-eg5c3F-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 12:53:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 12:53:27 INFO - Running setup.py (path:/tmp/pip-FeA38L-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 12:53:27 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 12:53:27 INFO - Running setup.py install for manifestparser 12:53:27 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 12:53:27 INFO - Running setup.py install for mozcrash 12:53:27 INFO - Running setup.py install for mozdebug 12:53:27 INFO - Running setup.py install for mozdevice 12:53:27 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 12:53:27 INFO - Installing dm script to /builds/slave/test/build/venv/bin 12:53:27 INFO - Running setup.py install for mozfile 12:53:27 INFO - Running setup.py install for mozhttpd 12:53:27 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 12:53:27 INFO - Running setup.py install for mozinfo 12:53:28 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 12:53:28 INFO - Running setup.py install for mozInstall 12:53:28 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 12:53:28 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 12:53:28 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 12:53:28 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 12:53:28 INFO - Running setup.py install for mozleak 12:53:28 INFO - Running setup.py install for mozlog 12:53:28 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 12:53:28 INFO - Running setup.py install for moznetwork 12:53:28 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 12:53:28 INFO - Running setup.py install for mozprocess 12:53:28 INFO - Running setup.py install for mozprofile 12:53:28 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 12:53:28 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 12:53:28 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 12:53:28 INFO - Running setup.py install for mozrunner 12:53:28 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 12:53:28 INFO - Running setup.py install for mozscreenshot 12:53:28 INFO - Running setup.py install for moztest 12:53:29 INFO - Running setup.py install for mozversion 12:53:29 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 12:53:29 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 12:53:29 INFO - Cleaning up... 12:53:29 INFO - Return code: 0 12:53:29 INFO - Installing None into virtualenv /builds/slave/test/build/venv 12:53:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:53:29 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:53:29 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:53:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:53:29 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:53:29 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:53:29 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 0x16da030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x183d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x199b180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19993b0>, '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 0x199a2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x199a740>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build/tests/config', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '41bf3e9aed84707956354da8000001c5-1469044380.585708-1980824796', '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 12:53:29 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 12:53:29 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 12:53:29 INFO - Using env: {'DISPLAY': ':0', 12:53:29 INFO - 'HOME': '/home/cltbld', 12:53:29 INFO - 'LANG': 'en_US.UTF-8', 12:53:29 INFO - 'LANGUAGE': 'en_US:en', 12:53:29 INFO - 'LOGNAME': 'cltbld', 12:53:29 INFO - 'MAIL': '/var/mail/cltbld', 12:53:29 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:53:29 INFO - 'MOZ_NO_REMOTE': '1', 12:53:29 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:53:29 INFO - 'NO_EM_RESTART': '1', 12:53:29 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:53:29 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:53:29 INFO - 'PWD': '/builds/slave/test', 12:53:29 INFO - 'SHELL': '/bin/bash', 12:53:29 INFO - 'SHLVL': '1', 12:53:29 INFO - 'TERM': 'linux', 12:53:29 INFO - 'TMOUT': '86400', 12:53:29 INFO - 'USER': 'cltbld', 12:53:29 INFO - 'XDG_SESSION_COOKIE': '41bf3e9aed84707956354da8000001c5-1469044380.585708-1980824796', 12:53:29 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:53:29 INFO - '_': '/tools/buildbot/bin/python'} 12:53:29 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:53:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 12:53:29 INFO - Running setup.py (path:/tmp/pip-yJGkS6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 12:53:29 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)) 12:53:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 12:53:29 INFO - Running setup.py (path:/tmp/pip-KiZTcm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 12:53:29 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)) 12:53:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 12:53:29 INFO - Running setup.py (path:/tmp/pip-oehr8t-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 12:53:29 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)) 12:53:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 12:53:29 INFO - Running setup.py (path:/tmp/pip-HJQiLa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 12:53:29 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)) 12:53:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 12:53:29 INFO - Running setup.py (path:/tmp/pip-9zyHZ0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 12:53:29 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)) 12:53:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 12:53:29 INFO - Running setup.py (path:/tmp/pip-_g2yXh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 12:53:29 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)) 12:53:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 12:53:29 INFO - Running setup.py (path:/tmp/pip-8W44jR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 12:53:29 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)) 12:53:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 12:53:29 INFO - Running setup.py (path:/tmp/pip-mCl7Nc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 12:53:29 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)) 12:53:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 12:53:29 INFO - Running setup.py (path:/tmp/pip-r0j1zR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 12:53:29 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)) 12:53:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 12:53:30 INFO - Running setup.py (path:/tmp/pip-_VmVqh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 12:53:30 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.3 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 12:53:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 12:53:30 INFO - Running setup.py (path:/tmp/pip-EDnHao-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 12:53:30 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)) 12:53:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 12:53:30 INFO - Running setup.py (path:/tmp/pip-Qzd3pA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 12:53:30 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.23 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 12:53:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 12:53:30 INFO - Running setup.py (path:/tmp/pip-tSOSjv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 12:53:30 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)) 12:53:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 12:53:30 INFO - Running setup.py (path:/tmp/pip-ws65Ie-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 12:53:30 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.12 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 12:53:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 12:53:30 INFO - Running setup.py (path:/tmp/pip-FI7l7r-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 12:53:30 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)) 12:53:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 12:53:30 INFO - Running setup.py (path:/tmp/pip-RLYagU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 12:53:30 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)) 12:53:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 12:53:30 INFO - Running setup.py (path:/tmp/pip-H9sB4W-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 12:53:30 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)) 12:53:30 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)) 12:53:30 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)) 12:53:30 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)) 12:53:30 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)) 12:53:30 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)) 12:53:30 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.3->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 12:53:30 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:53:30 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:53:30 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:53:30 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:53:30 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:53:30 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:53:32 INFO - Downloading blessings-1.6.tar.gz 12:53:32 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 12:53:32 INFO - Installing collected packages: blessings 12:53:32 INFO - Running setup.py install for blessings 12:53:32 INFO - Successfully installed blessings 12:53:32 INFO - Cleaning up... 12:53:32 INFO - Return code: 0 12:53:32 INFO - Done creating virtualenv /builds/slave/test/build/venv. 12:53:32 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 12:53:32 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 12:53:32 INFO - Reading from file tmpfile_stdout 12:53:32 INFO - Current package versions: 12:53:32 INFO - argparse == 1.2.1 12:53:32 INFO - blessings == 1.6 12:53:32 INFO - blobuploader == 1.2.4 12:53:32 INFO - docopt == 0.6.1 12:53:32 INFO - functools32 == 3.2.3-2 12:53:32 INFO - jsonschema == 2.5.1 12:53:32 INFO - manifestparser == 1.1 12:53:32 INFO - mozInstall == 1.12 12:53:32 INFO - mozcrash == 0.17 12:53:32 INFO - mozdebug == 0.1 12:53:32 INFO - mozdevice == 0.48 12:53:32 INFO - mozfile == 1.2 12:53:32 INFO - mozhttpd == 0.7 12:53:32 INFO - mozinfo == 0.9 12:53:32 INFO - mozleak == 0.1 12:53:32 INFO - mozlog == 3.3 12:53:32 INFO - moznetwork == 0.27 12:53:32 INFO - mozprocess == 0.23 12:53:32 INFO - mozprofile == 0.28 12:53:32 INFO - mozrunner == 6.12 12:53:32 INFO - mozscreenshot == 0.1 12:53:32 INFO - mozsystemmonitor == 0.3 12:53:32 INFO - moztest == 0.7 12:53:32 INFO - mozversion == 1.4 12:53:32 INFO - psutil == 3.1.1 12:53:32 INFO - requests == 1.2.3 12:53:32 INFO - wsgiref == 0.1.2 12:53:32 INFO - Installing None into virtualenv /builds/slave/test/build/venv 12:53: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')]} 12:53:32 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:53:32 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:53: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')]} 12:53:32 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:53:32 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:53:32 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 0x16da030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x183d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x199b180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19993b0>, '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 0x199a2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x199a740>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build/tests/talos', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '41bf3e9aed84707956354da8000001c5-1469044380.585708-1980824796', '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 12:53:32 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 12:53:32 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 12:53:32 INFO - Using env: {'DISPLAY': ':0', 12:53:32 INFO - 'HOME': '/home/cltbld', 12:53:32 INFO - 'LANG': 'en_US.UTF-8', 12:53:32 INFO - 'LANGUAGE': 'en_US:en', 12:53:32 INFO - 'LOGNAME': 'cltbld', 12:53:32 INFO - 'MAIL': '/var/mail/cltbld', 12:53:32 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:53:32 INFO - 'MOZ_NO_REMOTE': '1', 12:53:32 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:53:32 INFO - 'NO_EM_RESTART': '1', 12:53:32 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:53:32 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:53:32 INFO - 'PWD': '/builds/slave/test', 12:53:32 INFO - 'SHELL': '/bin/bash', 12:53:32 INFO - 'SHLVL': '1', 12:53:32 INFO - 'TERM': 'linux', 12:53:32 INFO - 'TMOUT': '86400', 12:53:32 INFO - 'USER': 'cltbld', 12:53:32 INFO - 'XDG_SESSION_COOKIE': '41bf3e9aed84707956354da8000001c5-1469044380.585708-1980824796', 12:53:32 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:53:32 INFO - '_': '/tools/buildbot/bin/python'} 12:53:33 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:53:33 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)) 12:53:33 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)) 12:53:33 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)) 12:53:33 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)) 12:53:33 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)) 12:53:33 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)) 12:53:33 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)) 12:53:33 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)) 12:53:33 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)) 12:53:33 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)) 12:53:33 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)) 12:53:33 INFO - Cleaning up... 12:53:33 INFO - Return code: 0 12:53:33 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 12:53:33 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:53:33 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:53:33 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:53:33 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:53:33 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:53:33 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:53:33 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 0x16da030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x183d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x199b180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19993b0>, '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 0x199a2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x199a740>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '41bf3e9aed84707956354da8000001c5-1469044380.585708-1980824796', '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 12:53:33 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 12:53:33 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 12:53:33 INFO - Using env: {'DISPLAY': ':0', 12:53:33 INFO - 'HOME': '/home/cltbld', 12:53:33 INFO - 'LANG': 'en_US.UTF-8', 12:53:33 INFO - 'LANGUAGE': 'en_US:en', 12:53:33 INFO - 'LOGNAME': 'cltbld', 12:53:33 INFO - 'MAIL': '/var/mail/cltbld', 12:53:33 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:53:33 INFO - 'MOZ_NO_REMOTE': '1', 12:53:33 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:53:33 INFO - 'NO_EM_RESTART': '1', 12:53:33 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:53:33 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:53:33 INFO - 'PWD': '/builds/slave/test', 12:53:33 INFO - 'SHELL': '/bin/bash', 12:53:33 INFO - 'SHLVL': '1', 12:53:33 INFO - 'TERM': 'linux', 12:53:33 INFO - 'TMOUT': '86400', 12:53:33 INFO - 'USER': 'cltbld', 12:53:33 INFO - 'XDG_SESSION_COOKIE': '41bf3e9aed84707956354da8000001c5-1469044380.585708-1980824796', 12:53:33 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:53:33 INFO - '_': '/tools/buildbot/bin/python'} 12:53:33 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:53:33 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 12:53:33 INFO - Cleaning up... 12:53:33 INFO - Return code: 0 12:53:33 INFO - Running post-action listener: _resource_record_post_action 12:53:33 INFO - Running post-action listener: _start_resource_monitoring 12:53:33 INFO - Starting resource monitoring. 12:53:33 INFO - [mozharness: 2016-07-20 19:53:33.463243Z] Finished create-virtualenv step (success) 12:53:33 INFO - [mozharness: 2016-07-20 19:53:33.463719Z] Running install step. 12:53:33 INFO - Running pre-action listener: _resource_record_pre_action 12:53:33 INFO - Running main action method: install 12:53:33 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 12:53:33 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 12:53:33 INFO - Reading from file tmpfile_stdout 12:53:33 INFO - Detecting whether we're running mozinstall >=1.0... 12:53:33 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 12:53:33 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 12:53:33 INFO - Reading from file tmpfile_stdout 12:53:33 INFO - Output received: 12:53:33 INFO - Usage: mozinstall [options] installer 12:53:33 INFO - Options: 12:53:33 INFO - -h, --help show this help message and exit 12:53:33 INFO - -d DEST, --destination=DEST 12:53:33 INFO - Directory to install application into. [default: 12:53:33 INFO - "/builds/slave/test"] 12:53:33 INFO - --app=APP Application being installed. [default: firefox] 12:53:33 INFO - mkdir: /builds/slave/test/build/application 12:53:33 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'] 12:53:33 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 12:53:50 INFO - Reading from file tmpfile_stdout 12:53:50 INFO - Output received: 12:53:50 INFO - /builds/slave/test/build/application/firefox/firefox 12:53:50 INFO - Running post-action listener: _resource_record_post_action 12:53:50 INFO - [mozharness: 2016-07-20 19:53:50.178967Z] Finished install step (success) 12:53:50 INFO - [mozharness: 2016-07-20 19:53:50.179241Z] Running run-tests step. 12:53:50 INFO - Running pre-action listener: _resource_record_pre_action 12:53:50 INFO - Running main action method: run_tests 12:53:50 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 12:53:50 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 12:53:50 INFO - Python 2.7.3 12:53:50 INFO - Return code: 0 12:53:50 INFO - grabbing minidump binary from tooltool 12:53:50 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')]} 12:53:50 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 0x19993b0>, '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 0x199a2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x199a740>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 12:53:50 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 12:53:50 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 12:53:50 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 12:53:50 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 12:53:50 INFO - Return code: 0 12:53:50 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 12:53:50 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 12:53:50 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 12:53:50 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 12:53:50 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 12:53:50 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/Ss6DX1adQNKwmG9dXJ2qBA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-026', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] in /builds/slave/test/build 12:53:50 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/Ss6DX1adQNKwmG9dXJ2qBA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-026 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log 12:53:50 INFO - Using env: {'DISPLAY': ':0', 12:53:50 INFO - 'HOME': '/home/cltbld', 12:53:50 INFO - 'LANG': 'en_US.UTF-8', 12:53:50 INFO - 'LANGUAGE': 'en_US:en', 12:53:50 INFO - 'LOGNAME': 'cltbld', 12:53:50 INFO - 'MAIL': '/var/mail/cltbld', 12:53:50 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 12:53:50 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 12:53:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:53:50 INFO - 'MOZ_NO_REMOTE': '1', 12:53:50 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 12:53:50 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:53:50 INFO - 'NO_EM_RESTART': '1', 12:53:50 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:53:50 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:53:50 INFO - 'PWD': '/builds/slave/test', 12:53:50 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 12:53:50 INFO - 'SHELL': '/bin/bash', 12:53:50 INFO - 'SHLVL': '1', 12:53:50 INFO - 'TERM': 'linux', 12:53:50 INFO - 'TMOUT': '86400', 12:53:50 INFO - 'USER': 'cltbld', 12:53:50 INFO - 'XDG_SESSION_COOKIE': '41bf3e9aed84707956354da8000001c5-1469044380.585708-1980824796', 12:53:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:53:50 INFO - '_': '/tools/buildbot/bin/python'} 12:53:50 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/Ss6DX1adQNKwmG9dXJ2qBA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-026', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] with output_timeout 3600 12:53:50 INFO - mozversion application_buildid: 20160720121920 12:53:50 INFO - mozversion application_changeset: c050984325e379286c1456a261b0cdc92dab89c1 12:53:50 INFO - mozversion application_display_name: Nightly 12:53:50 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 12:53:50 INFO - mozversion application_name: Firefox 12:53:50 INFO - mozversion application_remotingname: firefox 12:53:50 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 12:53:50 INFO - mozversion application_vendor: Mozilla 12:53:50 INFO - mozversion application_version: 50.0a1 12:53:50 INFO - mozversion platform_buildid: 20160720121920 12:53:50 INFO - mozversion platform_changeset: c050984325e379286c1456a261b0cdc92dab89c1 12:53:50 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 12:53:50 INFO - mozversion platform_version: 50.0a1 12:53:50 INFO - using testdate: 1469044430 12:53:50 INFO - actual date: 1469044430 12:53:50 INFO - starting webserver on 'localhost:35826' 12:53:50 INFO - SUITE-START | Running 2 tests 12:53:50 INFO - TEST-START | dromaeo_css 12:53:50 INFO - operating with platform_type : linux_ 12:53:50 INFO - Initialising browser for dromaeo_css test... 12:53:50 INFO - TEST-INFO | started process 24208 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp4iXZKz/profile http://localhost:35826/getInfo.html) 12:53:54 INFO - PROCESS | 24208 | __metrics Screen width/height:1600/1200 12:53:54 INFO - PROCESS | 24208 | colorDepth:24 12:53:54 INFO - PROCESS | 24208 | Browser inner width/height: 1024/697 12:53:54 INFO - PROCESS | 24208 | __metrics 12:53:55 INFO - PROCESS | 24208 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 693: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 12:53:55 INFO - PROCESS | 24208 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 58: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 12:53:56 INFO - TEST-INFO | 24208: exit 0 12:53:56 INFO - Browser initialized. 12:53:56 INFO - Running cycle 1/1 for dromaeo_css test... 12:53:56 INFO - TEST-INFO | started process 24289 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp4iXZKz/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 12:54:08 INFO - PROCESS | 24289 | RSS: Main: 158351360 12:54:08 INFO - PROCESS | 24289 | 12:55:00 INFO - PROCESS | 24289 | 1469044500142 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] 12:57:11 INFO - PROCESS | 24289 | Cycle 1(1): loaded http://localhost:35826/tests/dromaeo/cssquery-dojo.html (next: http://localhost:35826/tests/dromaeo/cssquery-ext.html) 12:57:12 INFO - PROCESS | 24289 | RSS: Main: 263409664 12:57:12 INFO - PROCESS | 24289 | 13:00:15 INFO - PROCESS | 24289 | Cycle 1(1): loaded http://localhost:35826/tests/dromaeo/cssquery-ext.html (next: http://localhost:35826/tests/dromaeo/cssquery-jquery.html) 13:00:16 INFO - PROCESS | 24289 | RSS: Main: 253358080 13:00:16 INFO - PROCESS | 24289 | 13:03:18 INFO - PROCESS | 24289 | Cycle 1(1): loaded http://localhost:35826/tests/dromaeo/cssquery-jquery.html (next: http://localhost:35826/tests/dromaeo/cssquery-mootools.html) 13:03:18 INFO - PROCESS | 24289 | RSS: Main: 218157056 13:03:18 INFO - PROCESS | 24289 | 13:06:21 INFO - PROCESS | 24289 | Cycle 1(1): loaded http://localhost:35826/tests/dromaeo/cssquery-mootools.html (next: http://localhost:35826/tests/dromaeo/cssquery-prototype.html) 13:06:21 INFO - PROCESS | 24289 | RSS: Main: 197701632 13:06:21 INFO - PROCESS | 24289 | 13:09:24 INFO - PROCESS | 24289 | Cycle 1(1): loaded http://localhost:35826/tests/dromaeo/cssquery-prototype.html (next: http://localhost:35826/tests/dromaeo/cssquery-yui.html) 13:09:25 INFO - PROCESS | 24289 | RSS: Main: 189751296 13:09:25 INFO - PROCESS | 24289 | 13:12:28 INFO - PROCESS | 24289 | Cycle 1(1): loaded http://localhost:35826/tests/dromaeo/cssquery-yui.html (next: http://localhost:35826/tests/dromaeo/cssquery-dojo.html) 13:12:28 INFO - PROCESS | 24289 | RSS: Main: 279982080 13:12:28 INFO - PROCESS | 24289 | 13:12:28 INFO - PROCESS | 24289 | __start_tp_report 13:12:28 INFO - PROCESS | 24289 | _x_x_mozilla_page_load 13:12:28 INFO - PROCESS | 24289 | _x_x_mozilla_page_load_details 13:12:28 INFO - PROCESS | 24289 | |i|pagename|runs| 13:12:28 INFO - PROCESS | 24289 | |0;dojo.html;2570.691517017958;2572.4340645058087;2584.483103379324;2638.907638232662;2642.484715480482;4620.8151673933;4661.184292748764;4738.90522189556;4787.281907713845;4802.08760335536;4673.532646735325;4678.695884767488;4681.695689780162;4717.952820471794;4734;4265.445492086033;4304.935425968613;4359.782010899442;4418.756968366739;4495.910081798362;4402.801873915665;4439.8446054388105;4456.3983862178675;4464.709793863389;4474.485434175079;4219.472565929259;4247.19303332369;4291.3777502262;4331.675124365669;4363.3018717005125;4335.783210839445;4337.457817772778;4340.565943405666;4423.225935461282;4429.601335879786;4366.257736184856;4366.410534577855;4371.388005679208;4403.075354175627;4406.1628290625;4640.698354606973;4717.056588682277;4764.666473346867;4859.392575928009;4864.708117512961;5088.084144853925;5132.28148059272;5134.743262836881;5175.01674681813;5179;5150.0472412603785;5162.6902385856965;5192.324997750268;5215.556677682402;5216.087184742692;4619.19164146273;4717.315989181549;4756.286557016406;4794.568488836021;4835.637327200474;5189.040027594907;5260.815871444481;5295.391030031518;5306.867328316745;5316.255724198615;5025.924611130836;5032.345795046621;5034.79860805571;5075.593952483792;5083.949160508421;4809.591184749265;4821.686590371614;4902.779374928136;5166.3025491558155;5169.914317993188;4918.385201849769;4919.729414882216;4920.114379411669;4967.230079337708;4978.327925730053;4885.291632713308;4892.266160075946;4901.58336541398;4907.386576677915;4951.059298733229;4230.661547076226;4258.936115958263;4262.893427664271;4267.722598031118;4324.243257429937;3779.244151169777;3780.1683629601443;3798.6011468795377;3812.599677033927;3815.923681526354;4293.849715259951;4317.481902171759;4333.71830830995;4340.153670034313;4347.413099231627;5057.039162559102;5088.77100530477;5095.949040509621;5122.538971492583;5122.641415100981;4310.051788606502;4316.158349121891;4317.740935543815;4319.67602429819;4381.605655491021;4450.376947227391;4523.117991991596;4580.473245576802;4589.242774942097;4611.815527378867;4732.52674732524;4805.1590971579835;4810.39870016241;4837.2260438329695;4874.707517548958;5123.666961647481;5142.76857541404;5160.535551800356;5174.068667639861;5175.042617115846;4600.6319494439695;4806.231003039637;4835.830745923876;4839.975800121118;4863.051704917507;4876.536729010738;4949.084419382426;4965.851024469272;4987.1521841287795;5071.366079240095;5047.1419858623385;5052.191649336089;5052.418971818288;5053.065182941167;5113.105206588906;4933.284673722362;4943.629227807857;4961.5534601886;4962.975185124052;5005.424376196784;4828.806847726192;4837.7097374157665;4856.708597484162;4873.171560834596;4935.728534930613;4797.544233297831;4801.351817504592;4809;4813.78337974799;4860.73265970375;4818.759062046954;4836.105320515716;4840.782164802522;4873.585745211697;4885.2427873679635;4687.554682305175;4769.379980602499;4842.7820748065715;4847.709137451764;4907.828226012072 13:12:28 INFO - PROCESS | 24289 | |1;ext.html;513.2737176894694;514.6731825290941;529.0846834975492;569.4931510955248;582.2285471749932;28282.85858570707;41208.38187427187;42176.578234217726;42340.788296058556;45967.540324596746;41750.37374439386;42069.15861682765;42157;42226.57773422265;42229;7850.214978502147;7978.840423191533;7985.321247693924;7986.560739159344;8003;7808.141104478503;7871.88192177115;7882.842343153162;7895.249951254622;7898.447108702393;7924.881126783102;7948.926894869205;7961.562114083752;7965.123836377994;7973;7845.293923546879;7851.8037049073655;7873.763787086396;7878.09401918781;7882.448228623941;7915.089764677078;7949.562774047425;7960.641771120314;7961.36309095271;7966.5618390988475;40459.39310910339;40678.79660601707;40826.183476330305;40834.1833163338;40903.590964090574;2816.2396153038567;2841.573763935426;2907.6074729911616;2970;2984.164433958495;29067.70932290692;29616.8519157405;29999.550006749916;30443.69556304453;31089.22276943072;3334.333133373311;3350.932981340384;3375.443051896434;3397.5073614325784;3418.8290585470627;272822;272827;273791;274087;274272;54283.45716542863;54615;54652.45347546553;54717.72641136769;54758.17862732062;46335;48606.513934860195;49697.75151124294;55859.441405586236;56241.43758562362;14340.067895586963;14860.479883204036;14912.552623421314;14918;14937.70124597502;11617.070634349231;11726.41367931617;11734.823977640342;11745.823812642817;11755.529778808752;13620.455181792815;15474.5357639271;15847.52457426279;16072.598185045468;16677.49967500977;6158.846028849314;6179.196704428396;6283.214598175228;6341.556091073673;6367.904481432783;835.9247667709935;971.9222462203007;1012.1396812709286;1016.6899095775859;1038.4911393417322;29113.56329655057;29908.700912991026;30629;32347.353052938808;32678.509822352684;953.0326718380849;960.500539719342;965.7247684409909;973.8052389522123;976.8899177776111;14457;14998.625034374229;15042.548723538312;15170.165640889856;15270.770938435933;419815;424524;425163;427399;427677;49094;49326.50673493219;49356.25965610519;49392.25911611329;49485;1193.7090944612714;1213.1326101837228;1228.9016878649686;1247.4074814463058;1253.0476837603305;27099;27869.581956270267;27999.160025199275;28247;28720.425591487634;43582;43707.12585748204;43804.123917522105;43871;43875.341869871336;357165;357726;358465;359495;360142;22100.33698989033;22739.886300568392;22769.316920492412;24933.252002439956;25384.111556096188;32096.839515803207;33805.83097084499;41088.794556028224;41957.58042419537;46246.768766155954;35599.64400355963;35622.465663015595;35762.28475430529;36353.454698180074;36579.817100914326;36498.635013650586;37069.25861482701;37581.24837503289;37742.43386349262;38410.42384364181;35353.82323088368;35844.28311433704;35875.64124358723;36053.63946360503;36446.81776591206;29887.402251955275;31114;31228.531572025982;31240.843795780875;31387;25278.368040799127;25525.74474255308;25567.360815979748;25808.612870806577;25817.870910645328 13:12:28 INFO - PROCESS | 24289 | |2;jquery.html;359.6385632439398;367.74074277634264;373.4137404275287;382.3442795605536;383.87524054682217;16370.91814540927;17323.740143897852;18449.815501844976;18547.90726046368;18568.628627427443;18068.548286292847;18383.81616183838;18710.064496775176;18890.149943252552;19010.2395904164;5727.57043221758;5925.851853703649;6019.668918209497;6031.969840150815;6032.849178770522;5690.374058853523;7090.50366474347;7130.500864939457;7247.927520724805;7252.782416527512;7004.789856304294;7212.74755383559;7269.20038795732;7277;7287.890681639779;6991.300869913019;7247.565146091251;7252.0572325597595;7278.9272107278775;7283.235260297698;6937.167539895195;6971.675381677515;6980.127484064492;6984.057152284478;6986.790396288119;23554.175603853782;23604.763952360427;23712.881435592713;24096.156634517884;24537.63193552098;1889.7448844406103;1963.7545306836646;1969.133581224271;1974.7432833731523;2068.8965551722354;14312.42750289987;14426.639334016629;14735.778963315559;15339.775732518834;15792.21038948048;1828.3874901907743;1866.2534986005571;1876.6903460929068;1907.513584036062;1956.471752626797;81396;81949;83271;85829.14170858274;88305.11694883097;16652.916735416246;17297.30810767555;17551.385701500385;17920.10399480047;18041.819581804015;30080.398392032475;30124.698753012628;30145;30239.244018899702;30290.18258904429;9000.144986226298;9110.635574576943;9304.441733496013;9462.621495140118;9529.714108576754;7463.738769143054;7674.30931216182;7724.922750772533;7920.366370690331;8000.83998320042;8480.703175388831;8504.532250726146;8565.314774818;8701.825963480822;8760;3229.9425754726;3252.9349413012083;3260.4457242268873;3300.9834950825093;3376.307856889332;758.768575584441;811.4641744548287;823.2467292427482;857.2242120880613;957.3298690916387;15889.761653575206;16792.496225113267;17122.14389280531;17176.31294748221;17250.396236131925;833.2251006563832;843.0810416645885;862.7454900804278;882.5587206396801;909.5543183840003;9098.954505227564;9284;9524.380915240487;9524.571394287274;9614.375065620852;413135;420991;440867;441320;441897;46613.5338646616;59496.40503594995;74379;82674.17325826785;85135.574322128;872.6378552900602;887.3699673232078;893.9731808045769;896.4083704754961;896.9551522423852;14596.270186490845;14801.629959251104;15112.319945602694;15141.545753627408;15395.923020384826;36539.08652283714;37985.43021854619;38735.22529549449;40418.39372409358;41083.383749243185;50713.74643126761;52230.738846305525;54707.452925470236;54963.45036549583;57282.14076788935;7148.213696493485;7254.528455650366;7375.852482950204;7489.13874904393;7544.924550754422;8091.878621820795;10906.127509799038;11233.32600044;11654.359010254517;11922;9405.294602904947;9419.152276295166;9423.340366174301;10103.141232995278;10249.897501024894;9833.459159745997;9891.703248902544;10022;10025.598976041168;10102.09081182697;9819.558119884765;10042.69871903844;10213.74465638365;10550.366977981346;10561.471926403496;7507.549547027196;7527.623618818928;7677.769666910001;7708.768736937901;7725.961370193113;9046.773830654023;9158.450492970444;9301.581428835583;9492.667756628485;9750.85373719409 13:12:28 INFO - PROCESS | 24289 | |3;mootools.html;1286.5754301080644;1410.041172003038;1447.2618964328192;1531.4639876043386;1755.1399814091092;6836.384725374715;7679.1552929177815;7919.0893047299505;7953.801154971128;8185.386096042791;7935.880961785578;7956.4828286161355;8012.118666946646;8025.357971362277;8034.156413576578;2196.066671664544;2222.899969501368;2233.832462565314;2235.9217427390045;2236.26203352894;2154.2244791874914;2217.9889100554474;2224.7997680208778;2234.754177040524;2235.441139715071;2144.8927553622334;2154.019920935978;2154.7845215478405;2196.791304826039;2264.2075273654254;2167.4267296005414;2196.5936301784222;2200.1639377036786;2205.426589086833;2206.393241858486;2135.562209746998;2136.5940471310555;2137.0490131891315;2138.433315171481;2140.1760322276036;8020.879686804703;8069.717559885435;8077.071136819282;8079.474834135821;8083.717069902584;4660.324252983299;4831.9033619327765;4832.879178020543;4882.853514394574;4891.217405215184;2848.900288489893;2950.395168990352;2998.1755017370397;3000.489916714164;3014.1861697341815;992.3400938376044;995.2386424385351;1005.5625802775743;1007.3301254665638;1018.6892997635719;11002.174836887265;11091.889081109248;11126.443677816076;11129.387883666395;11132.777344453147;4124.649404800625;4355.128974205171;4489.977550112294;4503.279475283939;4518.43519560055;8691.261242794433;8779.473231606124;8788.209061184396;8789.077146899612;8791.824163516694;4796.928046079312;4811.061842940593;4811.27830825372;4811.49479304675;4816.181249187646;3609.620989796086;3730.6082861299715;4346.022145017346;4472.865814025585;4475.507694153641;3474.357243909885;3504.456809194528;3604.9639503604626;3606.6393360664247;3606.6573675500786;1024.9692509224735;1062.0951697108403;1073.3148956138787;1073.7584043590286;1078.9730256743487;793.2226418110284;819.5902048975512;820.5486982159788;822.8436597046542;842.9789255268545;5199.818006369759;5223.9477605223465;5444.972775136178;5477.863053423696;5502.009638265151;406.704461424701;424.1538131427821;430.15259937922866;432.5134223998002;443.1911761036122;3336.966630333714;3391.847366868497;3432.553768010143;3507.3511400391008;3511.859525618998;9506.857397139049;9872.802543949081;9981.500924953869;10015.14871235953;10015.499225038719;9894.257930655229;9897.505124743733;9899.901000990041;9930;9969.102780749767;7488.764353881548;7557.5465472070755;7571.962140189264;7575.924240757632;7577.242275772489;5429.267048948342;5493.313335833021;5627.268455100811;5658.9151162733415;5718.485336319751;9281.814363712823;9346.392484488759;9362.485063321583;9374.531273436438;9463.763405914908;8159.632816523152;8762.386632935888;9103.772405689646;9193;9365.063493650581;7338.522996005243;7547.320741133105;7730.690772369042;7739.032620922385;7741.535507869321;7576.166621671722;7661.770146895602;7672.347850432552;7727.381809455118;7729.690812367668;7009.12385951756;7027.121609798775;7067.752628657972;7104.076470058859;7153.749618763526;6694.397504224643;6790.762323318858;6818.829529261609;6845.151809011639;6980.476464265099;6185.134081228542;6273.811785646255;6294;6297.874042519033;6302.684865756785;4508.256137737368;4541.2052890743325;4675.906481870412;4713.787879545497;4741.099191153669;4647.930281045719;4693.929591056069;4719.197736384892;4739.194336962656;5031.22016087507 13:12:28 INFO - PROCESS | 24289 | |4;prototype.html;287.4595759971254;297.1027496959183;300.3167793270311;300.98946536871216;303.99529554821316;4624.8150073997085;4777.355057067295;4831;4883.633727470441;4887.975560122199;4649.767511624422;4767.785449654765;4778.307145463914;4808.447028591713;4820.156472617296;3832.080300727819;3838.9424158637644;3846.615338466145;3849.7497662651976;3852.5184351955936;3606.6753992140702;3640.6541378568995;3849.1139341722633;3860.942085868714;3863.9034024149482;3742.6818720408796;3772.2455508898192;3802.372608519591;3811.3711237645757;3851.1719980204252;3817.4655548223272;3823.5794062653085;3832.9041773955596;3834.2906562285925;3841.8271177796787;3401.2857299967036;3416;3418.435958066916;3426.554547908781;3426.58880934287;4513.729176249402;4682.976585117087;4695.835645752382;4728.621710263171;4765.714057156547;4321.719088259285;4323.7028891332475;4370.956290437119;4373.322135069069;4390.758508282043;4981.630051735766;5039.244113382985;5046.697198168122;5047.394312682502;5049.697018178921;3617.89146325608;3625.1118475973553;3684.244729830378;3684.7420680552373;3714.275716235335;5192.1173400522;5204.9739751301;5207.921881171786;5210.557102646279;5224.582033437316;3775.867844625425;3782.791946442972;3788;3794.6964242860504;3794.924101517954;3829.468212714881;3832.5209348831395;3865.632764887331;3869.555001174901;3873.2447172801035;4165.201499670676;4243.27864263076;4304.612584867377;4312.741235525878;4333.371661109185;4965.155923493015;4978.904640978979;4982.202847544448;4994.150994330972;5007.924881126786;1253.166644181609;1282.781357710179;1286.899700755859;1316.2168509736691;1334.9265790381621;880.4453194487432;909.5452273863068;910.3309067835136;934.9205317548085;938.0853667674099;4344.478662560513;4370.912581748411;4379.956200438019;4390.100029493946;4400.141972315432;5148.948510514847;5151.047056294523;5159.355080614923;5162.9483705162465;5166.571711295685;4236.85171019019;4451.532589078165;4510.368548403226;4523.208438523246;4527.886802829956;2761.9309517262227;2777.7638900693264;2783.2465546705853;2783.4711404833015;2793.371491414456;4809.591184749335;4969.478204788517;4976.278439626306;4979.875503112451;4981.676191047571;5265.262863199156;5310.628256022119;5311.362636483646;5330.680159190461;5388.164834450667;4875.731834749123;4914.508549145057;4922.809349839287;4931.841017360989;4932.383452068491;5025.592834006484;5102.719350435762;5170.663906846043;5190.2214667800135;5218;5065.670731402594;5069.66795274178;5077.060743762416;5086.694798312114;5107.974460127824;4892.31507588945;4897.436794768647;4915.459299476983;4950.762309422645;4957.801687932587;3614.7831130132276;3705.462707907392;3731.9253614927006;3736.8131593419675;3737.177820879511;5128.384593848762;5134.845954621367;5146.6911985281;5179.22311653255;5196.194589838581;5013.197888337994;5018.197088465828;5018.4730603286125;5075.492450754895;5084.161113416245;4872.171730805842;5008.348914641073;5066.214736715815;5072.1123803335;5091.770870310919;4723.622110231242;4876.195807551228;4892.755362231946;4965.907500349917;4980.900381992267;4867.7365025263425;4887.462379138363;4899.681520701143;4901.362822833009;4969.453360130455;4827.637927155407;4845.3216549682365;4868.537488938545;4870.660568343592;4888.242322440027 13:12:28 INFO - PROCESS | 24289 | |5;yui.html;579.7391173971713;616.4298024327496;635.3043417457882;695.7703957693958;700.6881937537796;13672.31638418079;13935.790963135561;13971.441142354293;14109.92945035276;14207.147571145713;12912.806307905388;12982.93508532456;12987.090903636725;12993.155444896076;12996.870031299684;630.6783540394385;783.4359261331846;802.995985020074;803.6945960535018;804.3846457460048;775.8836174573831;798.8282519258358;799.1249581708021;806.6087947345533;807.475141158246;843.9198276163754;845.720912099009;846.2003406780594;846.4921047371589;846.7586737779734;653.9607623542555;841.6254766628853;842.9157084291583;843.2031730015138;843.7173546861778;598.850287428143;614.1034090228272;617.586217234454;618.0543768034913;618.6257314324814;13123.146995445266;13126.14680045794;13146.014048946367;13149.934250328783;13166.802497962539;12429.440675169548;12638.873611263954;12759.106862519628;13047.739045219138;13273.07088503805;11772.293662380285;11827.467763950643;12013.099017573717;12075.396230188544;12557.811632825515;4149.398337241113;4236.0892408132095;4274.871753847389;4347.956520434786;4353.238183317907;61246.081308780405;61363;61378.38621613771;61432.69283653598;62227.377726222614;10075.34510256831;10209.285350025575;10295.9485202575;10334.121599664113;10650.201234907412;19179.424617261506;19198.616027679367;19353.322633708034;19403.90298048529;19653.901730491256;6943.201531823905;7045.487371813078;7062.223155452896;7102.3962963148715;7131.607761573059;3732.458793474931;3775.1505911169766;3794.127350709297;3794.715396345285;3935.3506671399473;2853.6432945881766;2956.4678357895355;2959.1122663200954;2962.4223276460884;2967.2285205846633;554.6062295769967;575.0999685492192;577.9335376431765;581.988360232793;593.1073734030343;490.759835025381;506.42014892947367;519.2185760430527;523.2256260734135;530.1623434972734;8035.558044307502;8148.633311500997;8229.876551851727;8251.422400432033;8381.580920953927;503.62228328753434;511.54216975806446;518.6991544903947;529.222043595921;531.7341329335333;3783.754055986407;3923.5487918889694;4030.7581545107387;4061.9796901015307;4078.347464405681;82649;84519.5774021126;84897.57551212204;98635.50682246686;109813;47918.760406198446;62943;80040.59979700064;80158;82633;71025.2897471029;71687.28312716911;71860.28139718536;72935;75442.62278688571;8636.524991125549;9155.862662060208;9174.174324310845;9315.906840931504;9384.34309598349;41943.580564193966;42592.36111458269;43298.78350608227;43994.560054399044;45080.77459612681;56460.71769641126;56979;62005.37994619996;66885;70416.29583704303;10787.811148534101;11043.558257669603;11058.336499810037;11696.181267311207;12133.02935765119;11955.222910510789;12354.07344449152;12469.189502682297;12500.93749531283;12976.610701678965;11430;12142.332171730286;12186.695332616755;12398.504059837505;12664.87335126637;10362.948185259025;10409.68770936873;10547.525361358605;10704.571817127538;10760.83858742135;11164.776704466027;11642.53429862796;11683.123765717435;11954.410891064479;12164.817527737268;9749.9025009749;9978.351407158512;10067.899321006696;10183.13443357323;10487.318324308895;9864.06880431173;10622.097121744739;10628.512008318996;10712.785744285227;10800.729981750519 13:12:28 INFO - PROCESS | 24289 | __end_tp_report 13:12:28 INFO - PROCESS | 24289 | __start_cc_report 13:12:28 INFO - PROCESS | 24289 | _x_x_mozilla_cycle_collect,1055 13:12:28 INFO - PROCESS | 24289 | __end_cc_report 13:12:28 INFO - PROCESS | 24289 | __startTimestamp1469045548843__endTimestamp 13:12:28 INFO - PROCESS | 24289 | 13:12:28 INFO - PROCESS | 24289 | ------- Summary: start ------- 13:12:28 INFO - PROCESS | 24289 | Number of tests: 6 13:12:28 INFO - PROCESS | 24289 | 13:12:28 INFO - PROCESS | 24289 | [#0] dojo.html Cycles:165 Average:4676.97 Median:4810.40 stddev:497.92 (10.4%) stddev-sans-first:471.23 13:12:28 INFO - PROCESS | 24289 | Values: 2570.7 2572.4 2584.5 2638.9 2642.5 4620.8 4661.2 4738.9 4787.3 4802.1 4673.5 4678.7 4681.7 4718.0 4734.0 4265.4 4304.9 4359.8 4418.8 4495.9 4402.8 4439.8 4456.4 4464.7 4474.5 4219.5 4247.2 4291.4 4331.7 4363.3 4335.8 4337.5 4340.6 4423.2 4429.6 4366.3 4366.4 4371.4 4403.1 4406.2 4640.7 4717.1 4764.7 4859.4 4864.7 5088.1 5132.3 5134.7 5175.0 5179.0 5150.0 5162.7 5192.3 5215.6 5216.1 4619.2 4717.3 4756.3 4794.6 4835.6 5189.0 5260.8 5295.4 5306.9 5316.3 5025.9 5032.3 5034.8 5075.6 5083.9 4809.6 4821.7 4902.8 5166.3 5169.9 4918.4 4919.7 4920.1 4967.2 4978.3 4885.3 4892.3 4901.6 4907.4 4951.1 4230.7 4258.9 4262.9 4267.7 4324.2 3779.2 3780.2 3798.6 3812.6 3815.9 4293.8 4317.5 4333.7 4340.2 4347.4 5057.0 5088.8 5095.9 5122.5 5122.6 4310.1 4316.2 4317.7 4319.7 4381.6 4450.4 4523.1 4580.5 4589.2 4611.8 4732.5 4805.2 4810.4 4837.2 4874.7 5123.7 5142.8 5160.5 5174.1 5175.0 4600.6 4806.2 4835.8 4840.0 4863.1 4876.5 4949.1 4965.9 4987.2 5071.4 5047.1 5052.2 5052.4 5053.1 5113.1 4933.3 4943.6 4961.6 4963.0 5005.4 4828.8 4837.7 4856.7 4873.2 4935.7 4797.5 4801.4 4809.0 4813.8 4860.7 4818.8 4836.1 4840.8 4873.6 4885.2 4687.6 4769.4 4842.8 4847.7 4907.8 13:12:28 INFO - PROCESS | 24289 | 13:12:28 INFO - PROCESS | 24289 | [#1] ext.html Cycles:180 Average:50260.10 Median:36539.23 stddev:94493.99 (258.6%) stddev-sans-first:94685.25 13:12:28 INFO - PROCESS | 24289 | Values: 513.3 514.7 529.1 569.5 582.2 28282.9 41208.4 42176.6 42340.8 45967.5 41750.4 42069.2 42157.0 42226.6 42229.0 7850.2 7978.8 7985.3 7986.6 8003.0 7808.1 7871.9 7882.8 7895.2 7898.4 7924.9 7948.9 7961.6 7965.1 7973.0 7845.3 7851.8 7873.8 7878.1 7882.4 7915.1 7949.6 7960.6 7961.4 7966.6 40459.4 40678.8 40826.2 40834.2 40903.6 2816.2 2841.6 2907.6 2970.0 2984.2 29067.7 29616.9 29999.6 30443.7 31089.2 3334.3 3350.9 3375.4 3397.5 3418.8 272822.0 272827.0 273791.0 274087.0 274272.0 54283.5 54615.0 54652.5 54717.7 54758.2 46335.0 48606.5 49697.8 55859.4 56241.4 14340.1 14860.5 14912.6 14918.0 14937.7 11617.1 11726.4 11734.8 11745.8 11755.5 13620.5 15474.5 15847.5 16072.6 16677.5 6158.8 6179.2 6283.2 6341.6 6367.9 835.9 971.9 1012.1 1016.7 1038.5 29113.6 29908.7 30629.0 32347.4 32678.5 953.0 960.5 965.7 973.8 976.9 14457.0 14998.6 15042.5 15170.2 15270.8 419815.0 424524.0 425163.0 427399.0 427677.0 49094.0 49326.5 49356.3 49392.3 49485.0 1193.7 1213.1 1228.9 1247.4 1253.0 27099.0 27869.6 27999.2 28247.0 28720.4 43582.0 43707.1 43804.1 43871.0 43875.3 357165.0 357726.0 358465.0 359495.0 360142.0 22100.3 22739.9 22769.3 24933.3 25384.1 32096.8 33805.8 41088.8 41957.6 46246.8 35599.6 35622.5 35762.3 36353.5 36579.8 36498.6 37069.3 37581.2 37742.4 38410.4 35353.8 35844.3 35875.6 36053.6 36446.8 29887.4 31114.0 31228.5 31240.8 31387.0 25278.4 25525.7 25567.4 25808.6 25817.9 13:12:28 INFO - PROCESS | 24289 | 13:12:28 INFO - PROCESS | 24289 | [#2] jquery.html Cycles:180 Average:27156.10 Median:31604.00 stddev:71080.17 (224.9%) stddev-sans-first:71251.09 13:12:28 INFO - PROCESS | 24289 | Values: 359.6 367.7 373.4 382.3 383.9 16370.9 17323.7 18449.8 18547.9 18568.6 18068.5 18383.8 18710.1 18890.1 19010.2 5727.6 5925.9 6019.7 6032.0 6032.8 5690.4 7090.5 7130.5 7247.9 7252.8 7004.8 7212.7 7269.2 7277.0 7287.9 6991.3 7247.6 7252.1 7278.9 7283.2 6937.2 6971.7 6980.1 6984.1 6986.8 23554.2 23604.8 23712.9 24096.2 24537.6 1889.7 1963.8 1969.1 1974.7 2068.9 14312.4 14426.6 14735.8 15339.8 15792.2 1828.4 1866.3 1876.7 1907.5 1956.5 81396.0 81949.0 83271.0 85829.1 88305.1 16652.9 17297.3 17551.4 17920.1 18041.8 30080.4 30124.7 30145.0 30239.2 30290.2 9000.1 9110.6 9304.4 9462.6 9529.7 7463.7 7674.3 7724.9 7920.4 8000.8 8480.7 8504.5 8565.3 8701.8 8760.0 3229.9 3252.9 3260.4 3301.0 3376.3 758.8 811.5 823.2 857.2 957.3 15889.8 16792.5 17122.1 17176.3 17250.4 833.2 843.1 862.7 882.6 909.6 9099.0 9284.0 9524.4 9524.6 9614.4 413135.0 420991.0 440867.0 441320.0 441897.0 46613.5 59496.4 74379.0 82674.2 85135.6 872.6 887.4 894.0 896.4 897.0 14596.3 14801.6 15112.3 15141.5 15395.9 36539.1 37985.4 38735.2 40418.4 41083.4 50713.7 52230.7 54707.5 54963.5 57282.1 7148.2 7254.5 7375.9 7489.1 7544.9 8091.9 10906.1 11233.3 11654.4 11922.0 9405.3 9419.2 9423.3 10103.1 10249.9 9833.5 9891.7 10022.0 10025.6 10102.1 9819.6 10042.7 10213.7 10550.4 10561.5 7507.5 7527.6 7677.8 7708.8 7726.0 9046.8 9158.5 9301.6 9492.7 9750.9 13:12:28 INFO - PROCESS | 24289 | 13:12:28 INFO - PROCESS | 24289 | [#3] mootools.html Cycles:180 Average:5248.81 Median:4832.39 stddev:2989.67 (61.9%) stddev-sans-first:2983.23 13:12:28 INFO - PROCESS | 24289 | Values: 1286.6 1410.0 1447.3 1531.5 1755.1 6836.4 7679.2 7919.1 7953.8 8185.4 7935.9 7956.5 8012.1 8025.4 8034.2 2196.1 2222.9 2233.8 2235.9 2236.3 2154.2 2218.0 2224.8 2234.8 2235.4 2144.9 2154.0 2154.8 2196.8 2264.2 2167.4 2196.6 2200.2 2205.4 2206.4 2135.6 2136.6 2137.0 2138.4 2140.2 8020.9 8069.7 8077.1 8079.5 8083.7 4660.3 4831.9 4832.9 4882.9 4891.2 2848.9 2950.4 2998.2 3000.5 3014.2 992.3 995.2 1005.6 1007.3 1018.7 11002.2 11091.9 11126.4 11129.4 11132.8 4124.6 4355.1 4490.0 4503.3 4518.4 8691.3 8779.5 8788.2 8789.1 8791.8 4796.9 4811.1 4811.3 4811.5 4816.2 3609.6 3730.6 4346.0 4472.9 4475.5 3474.4 3504.5 3605.0 3606.6 3606.7 1025.0 1062.1 1073.3 1073.8 1079.0 793.2 819.6 820.5 822.8 843.0 5199.8 5223.9 5445.0 5477.9 5502.0 406.7 424.2 430.2 432.5 443.2 3337.0 3391.8 3432.6 3507.4 3511.9 9506.9 9872.8 9981.5 10015.1 10015.5 9894.3 9897.5 9899.9 9930.0 9969.1 7488.8 7557.5 7572.0 7575.9 7577.2 5429.3 5493.3 5627.3 5658.9 5718.5 9281.8 9346.4 9362.5 9374.5 9463.8 8159.6 8762.4 9103.8 9193.0 9365.1 7338.5 7547.3 7730.7 7739.0 7741.5 7576.2 7661.8 7672.3 7727.4 7729.7 7009.1 7027.1 7067.8 7104.1 7153.7 6694.4 6790.8 6818.8 6845.2 6980.5 6185.1 6273.8 6294.0 6297.9 6302.7 4508.3 4541.2 4675.9 4713.8 4741.1 4647.9 4693.9 4719.2 4739.2 5031.2 13:12:28 INFO - PROCESS | 24289 | 13:12:28 INFO - PROCESS | 24289 | [#4] prototype.html Cycles:180 Average:4200.94 Median:4793.38 stddev:1194.78 (24.9%) stddev-sans-first:1161.46 13:12:28 INFO - PROCESS | 24289 | Values: 287.5 297.1 300.3 301.0 304.0 4624.8 4777.4 4831.0 4883.6 4888.0 4649.8 4767.8 4778.3 4808.4 4820.2 3832.1 3838.9 3846.6 3849.7 3852.5 3606.7 3640.7 3849.1 3860.9 3863.9 3742.7 3772.2 3802.4 3811.4 3851.2 3817.5 3823.6 3832.9 3834.3 3841.8 3401.3 3416.0 3418.4 3426.6 3426.6 4513.7 4683.0 4695.8 4728.6 4765.7 4321.7 4323.7 4371.0 4373.3 4390.8 4981.6 5039.2 5046.7 5047.4 5049.7 3617.9 3625.1 3684.2 3684.7 3714.3 5192.1 5205.0 5207.9 5210.6 5224.6 3775.9 3782.8 3788.0 3794.7 3794.9 3829.5 3832.5 3865.6 3869.6 3873.2 4165.2 4243.3 4304.6 4312.7 4333.4 4965.2 4978.9 4982.2 4994.2 5007.9 1253.2 1282.8 1286.9 1316.2 1334.9 880.4 909.5 910.3 934.9 938.1 4344.5 4370.9 4380.0 4390.1 4400.1 5148.9 5151.0 5159.4 5162.9 5166.6 4236.9 4451.5 4510.4 4523.2 4527.9 2761.9 2777.8 2783.2 2783.5 2793.4 4809.6 4969.5 4976.3 4979.9 4981.7 5265.3 5310.6 5311.4 5330.7 5388.2 4875.7 4914.5 4922.8 4931.8 4932.4 5025.6 5102.7 5170.7 5190.2 5218.0 5065.7 5069.7 5077.1 5086.7 5108.0 4892.3 4897.4 4915.5 4950.8 4957.8 3614.8 3705.5 3731.9 3736.8 3737.2 5128.4 5134.8 5146.7 5179.2 5196.2 5013.2 5018.2 5018.5 5075.5 5084.2 4872.2 5008.3 5066.2 5072.1 5091.8 4723.6 4876.2 4892.8 4965.9 4980.9 4867.7 4887.5 4899.7 4901.4 4969.5 4827.6 4845.3 4868.5 4870.7 4888.2 13:12:28 INFO - PROCESS | 24289 | 13:12:28 INFO - PROCESS | 24289 | [#5] yui.html Cycles:180 Average:17274.22 Median:24173.90 stddev:23872.46 (98.8%) stddev-sans-first:23906.52 13:12:28 INFO - PROCESS | 24289 | Values: 579.7 616.4 635.3 695.8 700.7 13672.3 13935.8 13971.4 14109.9 14207.1 12912.8 12982.9 12987.1 12993.2 12996.9 630.7 783.4 803.0 803.7 804.4 775.9 798.8 799.1 806.6 807.5 843.9 845.7 846.2 846.5 846.8 654.0 841.6 842.9 843.2 843.7 598.9 614.1 617.6 618.1 618.6 13123.1 13126.1 13146.0 13149.9 13166.8 12429.4 12638.9 12759.1 13047.7 13273.1 11772.3 11827.5 12013.1 12075.4 12557.8 4149.4 4236.1 4274.9 4348.0 4353.2 61246.1 61363.0 61378.4 61432.7 62227.4 10075.3 10209.3 10295.9 10334.1 10650.2 19179.4 19198.6 19353.3 19403.9 19653.9 6943.2 7045.5 7062.2 7102.4 7131.6 3732.5 3775.2 3794.1 3794.7 3935.4 2853.6 2956.5 2959.1 2962.4 2967.2 554.6 575.1 577.9 582.0 593.1 490.8 506.4 519.2 523.2 530.2 8035.6 8148.6 8229.9 8251.4 8381.6 503.6 511.5 518.7 529.2 531.7 3783.8 3923.5 4030.8 4062.0 4078.3 82649.0 84519.6 84897.6 98635.5 109813.0 47918.8 62943.0 80040.6 80158.0 82633.0 71025.3 71687.3 71860.3 72935.0 75442.6 8636.5 9155.9 9174.2 9315.9 9384.3 41943.6 42592.4 43298.8 43994.6 45080.8 56460.7 56979.0 62005.4 66885.0 70416.3 10787.8 11043.6 11058.3 11696.2 12133.0 11955.2 12354.1 12469.2 12500.9 12976.6 11430.0 12142.3 12186.7 12398.5 12664.9 10362.9 10409.7 10547.5 10704.6 10760.8 11164.8 11642.5 11683.1 11954.4 12164.8 9749.9 9978.4 10067.9 10183.1 10487.3 9864.1 10622.1 10628.5 10712.8 10800.7 13:12:28 INFO - PROCESS | 24289 | -------- Summary: end -------- 13:12:28 INFO - PROCESS | 24289 | 13:12:29 INFO - TEST-INFO | 24289: exit 0 13:12:29 INFO - TEST-OK | dromaeo_css | took 1119258ms 13:12:29 INFO - TEST-START | kraken 13:12:29 INFO - operating with platform_type : linux_ 13:12:29 INFO - Initialising browser for kraken test... 13:12:29 INFO - TEST-INFO | started process 24482 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpFdXGvg/profile http://localhost:35826/getInfo.html) 13:12:33 INFO - PROCESS | 24482 | __metrics Screen width/height:1600/1200 13:12:33 INFO - PROCESS | 24482 | colorDepth:24 13:12:33 INFO - PROCESS | 24482 | Browser inner width/height: 1024/697 13:12:33 INFO - PROCESS | 24482 | __metrics 13:12:34 INFO - PROCESS | 24482 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 693: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 13:12:34 INFO - PROCESS | 24482 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 58: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 13:12:35 INFO - TEST-INFO | 24482: exit 0 13:12:35 INFO - Browser initialized. 13:12:35 INFO - Running cycle 1/1 for kraken test... 13:12:35 INFO - TEST-INFO | started process 24560 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpFdXGvg/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 13:12:47 INFO - PROCESS | 24560 | RSS: Main: 158347264 13:12:47 INFO - PROCESS | 24560 | 13:12:50 INFO - PROCESS | 24560 | Cycle 1(1): loaded http://localhost:35826/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:35826/tests/kraken/driver.html?testName=audio-beat-detection) 13:12:51 INFO - PROCESS | 24560 | RSS: Main: 214028288 13:12:51 INFO - PROCESS | 24560 | 13:12:53 INFO - PROCESS | 24560 | Cycle 1(1): loaded http://localhost:35826/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:35826/tests/kraken/driver.html?testName=audio-dft) 13:12:54 INFO - PROCESS | 24560 | RSS: Main: 191479808 13:12:54 INFO - PROCESS | 24560 | 13:12:57 INFO - PROCESS | 24560 | Cycle 1(1): loaded http://localhost:35826/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:35826/tests/kraken/driver.html?testName=audio-fft) 13:12:58 INFO - PROCESS | 24560 | RSS: Main: 272629760 13:12:58 INFO - PROCESS | 24560 | 13:13:00 INFO - PROCESS | 24560 | Cycle 1(1): loaded http://localhost:35826/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:35826/tests/kraken/driver.html?testName=audio-oscillator) 13:13:01 INFO - PROCESS | 24560 | RSS: Main: 181129216 13:13:01 INFO - PROCESS | 24560 | 13:13:03 INFO - PROCESS | 24560 | Cycle 1(1): loaded http://localhost:35826/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:35826/tests/kraken/driver.html?testName=imaging-gaussian-blur) 13:13:04 INFO - PROCESS | 24560 | RSS: Main: 185720832 13:13:04 INFO - PROCESS | 24560 | 13:13:07 INFO - PROCESS | 24560 | Cycle 1(1): loaded http://localhost:35826/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:35826/tests/kraken/driver.html?testName=imaging-darkroom) 13:13:07 INFO - PROCESS | 24560 | RSS: Main: 222076928 13:13:07 INFO - PROCESS | 24560 | 13:13:11 INFO - PROCESS | 24560 | Cycle 1(1): loaded http://localhost:35826/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:35826/tests/kraken/driver.html?testName=imaging-desaturate) 13:13:11 INFO - PROCESS | 24560 | RSS: Main: 221200384 13:13:11 INFO - PROCESS | 24560 | 13:13:14 INFO - PROCESS | 24560 | Cycle 1(1): loaded http://localhost:35826/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:35826/tests/kraken/driver.html?testName=json-parse-financial) 13:13:15 INFO - PROCESS | 24560 | RSS: Main: 221118464 13:13:15 INFO - PROCESS | 24560 | 13:13:17 INFO - PROCESS | 24560 | Cycle 1(1): loaded http://localhost:35826/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:35826/tests/kraken/driver.html?testName=json-stringify-tinderbox) 13:13:17 INFO - PROCESS | 24560 | RSS: Main: 185782272 13:13:17 INFO - PROCESS | 24560 | 13:13:19 INFO - PROCESS | 24560 | Cycle 1(1): loaded http://localhost:35826/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:35826/tests/kraken/driver.html?testName=stanford-crypto-aes) 13:13:20 INFO - PROCESS | 24560 | RSS: Main: 190423040 13:13:20 INFO - PROCESS | 24560 | 13:13:22 INFO - PROCESS | 24560 | Cycle 1(1): loaded http://localhost:35826/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:35826/tests/kraken/driver.html?testName=stanford-crypto-ccm) 13:13:23 INFO - PROCESS | 24560 | RSS: Main: 195178496 13:13:23 INFO - PROCESS | 24560 | 13:13:25 INFO - PROCESS | 24560 | Cycle 1(1): loaded http://localhost:35826/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:35826/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 13:13:26 INFO - PROCESS | 24560 | RSS: Main: 190693376 13:13:26 INFO - PROCESS | 24560 | 13:13:29 INFO - PROCESS | 24560 | Cycle 1(1): loaded http://localhost:35826/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:35826/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 13:13:29 INFO - PROCESS | 24560 | RSS: Main: 193642496 13:13:29 INFO - PROCESS | 24560 | 13:13:31 INFO - PROCESS | 24560 | Cycle 1(1): loaded http://localhost:35826/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:35826/tests/kraken/driver.html?testName=ai-astar) 13:13:31 INFO - PROCESS | 24560 | RSS: Main: 244355072 13:13:31 INFO - PROCESS | 24560 | 13:13:31 INFO - PROCESS | 24560 | __start_tp_report 13:13:31 INFO - PROCESS | 24560 | _x_x_mozilla_page_load 13:13:31 INFO - PROCESS | 24560 | _x_x_mozilla_page_load_details 13:13:31 INFO - PROCESS | 24560 | |i|pagename|runs| 13:13:31 INFO - PROCESS | 24560 | |0;ai-astar;105;114;117;113;114;115;113;115;114;113 13:13:31 INFO - PROCESS | 24560 | |1;audio-beat-detection;145;124;123;181;123;124;156;122;182;125 13:13:31 INFO - PROCESS | 24560 | |2;audio-dft;160;162;161;160;162;160;161;160;161;161 13:13:31 INFO - PROCESS | 24560 | |3;audio-fft;78;76;77;103;76;76;75;75;103;76 13:13:31 INFO - PROCESS | 24560 | |4;audio-oscillator;86;86;122;86;86;85;121;86;86;137 13:13:31 INFO - PROCESS | 24560 | |5;imaging-gaussian-blur;117;117;117;117;117;117;117;116;117;117 13:13:31 INFO - PROCESS | 24560 | |6;imaging-darkroom;147;147;147;146;146;145;145;146;146;146 13:13:31 INFO - PROCESS | 24560 | |7;imaging-desaturate;95;94;95;95;95;94;94;95;94;95 13:13:31 INFO - PROCESS | 24560 | |8;json-parse-financial;63;64;62;63;64;62;63;63;64;63 13:13:31 INFO - PROCESS | 24560 | |9;json-stringify-tinderbox;65;66;66;65;66;66;66;65;66;66 13:13:31 INFO - PROCESS | 24560 | |10;stanford-crypto-aes;90;81;85;79;79;79;79;78;79;82 13:13:31 INFO - PROCESS | 24560 | |11;stanford-crypto-ccm;139;131;129;129;128;125;130;126;180;127 13:13:31 INFO - PROCESS | 24560 | |12;stanford-crypto-pbkdf2;170;165;163;166;167;166;164;163;163;166 13:13:31 INFO - PROCESS | 24560 | |13;stanford-crypto-sha256-iterative;70;67;67;66;66;69;69;66;67;65 13:13:31 INFO - PROCESS | 24560 | __end_tp_report 13:13:31 INFO - PROCESS | 24560 | __start_cc_report 13:13:31 INFO - PROCESS | 24560 | _x_x_mozilla_cycle_collect,1977 13:13:31 INFO - PROCESS | 24560 | __end_cc_report 13:13:31 INFO - PROCESS | 24560 | __startTimestamp1469045611865__endTimestamp 13:13:31 INFO - PROCESS | 24560 | 13:13:31 INFO - PROCESS | 24560 | ------- Summary: start ------- 13:13:31 INFO - PROCESS | 24560 | Number of tests: 14 13:13:31 INFO - PROCESS | 24560 | 13:13:31 INFO - PROCESS | 24560 | [#0] ai-astar Cycles:10 Average:113.30 Median:114.00 stddev:3.16 (2.8%) stddev-sans-first:1.30 13:13:31 INFO - PROCESS | 24560 | Values: 105.0 114.0 117.0 113.0 114.0 115.0 113.0 115.0 114.0 113.0 13:13:31 INFO - PROCESS | 24560 | 13:13:31 INFO - PROCESS | 24560 | [#1] audio-beat-detection Cycles:10 Average:140.50 Median:135.00 stddev:24.41 (18.1%) stddev-sans-first:25.84 13:13:31 INFO - PROCESS | 24560 | Values: 145.0 124.0 123.0 181.0 123.0 124.0 156.0 122.0 182.0 125.0 13:13:31 INFO - PROCESS | 24560 | 13:13:31 INFO - PROCESS | 24560 | [#2] audio-dft Cycles:10 Average:160.80 Median:161.00 stddev:0.79 (0.5%) stddev-sans-first:0.78 13:13:31 INFO - PROCESS | 24560 | Values: 160.0 162.0 161.0 160.0 162.0 160.0 161.0 160.0 161.0 161.0 13:13:31 INFO - PROCESS | 24560 | 13:13:31 INFO - PROCESS | 24560 | [#3] audio-fft Cycles:10 Average:81.50 Median:76.00 stddev:11.37 (15.0%) stddev-sans-first:11.98 13:13:31 INFO - PROCESS | 24560 | Values: 78.0 76.0 77.0 103.0 76.0 76.0 75.0 75.0 103.0 76.0 13:13:31 INFO - PROCESS | 24560 | 13:13:31 INFO - PROCESS | 24560 | [#4] audio-oscillator Cycles:10 Average:98.10 Median:86.00 stddev:20.16 (23.4%) stddev-sans-first:20.91 13:13:31 INFO - PROCESS | 24560 | Values: 86.0 86.0 122.0 86.0 86.0 85.0 121.0 86.0 86.0 137.0 13:13:31 INFO - PROCESS | 24560 | 13:13:31 INFO - PROCESS | 24560 | [#5] imaging-gaussian-blur Cycles:10 Average:116.90 Median:117.00 stddev:0.32 (0.3%) stddev-sans-first:0.33 13:13:31 INFO - PROCESS | 24560 | Values: 117.0 117.0 117.0 117.0 117.0 117.0 117.0 116.0 117.0 117.0 13:13:31 INFO - PROCESS | 24560 | 13:13:31 INFO - PROCESS | 24560 | [#6] imaging-darkroom Cycles:10 Average:146.10 Median:146.00 stddev:0.74 (0.5%) stddev-sans-first:0.71 13:13:31 INFO - PROCESS | 24560 | Values: 147.0 147.0 147.0 146.0 146.0 145.0 145.0 146.0 146.0 146.0 13:13:31 INFO - PROCESS | 24560 | 13:13:31 INFO - PROCESS | 24560 | [#7] imaging-desaturate Cycles:10 Average:94.60 Median:95.00 stddev:0.52 (0.5%) stddev-sans-first:0.53 13:13:31 INFO - PROCESS | 24560 | Values: 95.0 94.0 95.0 95.0 95.0 94.0 94.0 95.0 94.0 95.0 13:13:31 INFO - PROCESS | 24560 | 13:13:31 INFO - PROCESS | 24560 | [#8] json-parse-financial Cycles:10 Average:63.10 Median:63.00 stddev:0.74 (1.2%) stddev-sans-first:0.78 13:13:31 INFO - PROCESS | 24560 | Values: 63.0 64.0 62.0 63.0 64.0 62.0 63.0 63.0 64.0 63.0 13:13:31 INFO - PROCESS | 24560 | 13:13:31 INFO - PROCESS | 24560 | [#9] json-stringify-tinderbox Cycles:10 Average:65.70 Median:66.00 stddev:0.48 (0.7%) stddev-sans-first:0.44 13:13:31 INFO - PROCESS | 24560 | Values: 65.0 66.0 66.0 65.0 66.0 66.0 66.0 65.0 66.0 66.0 13:13:31 INFO - PROCESS | 24560 | 13:13:31 INFO - PROCESS | 24560 | [#10] stanford-crypto-aes Cycles:10 Average:81.10 Median:80.00 stddev:3.75 (4.7%) stddev-sans-first:2.20 13:13:31 INFO - PROCESS | 24560 | Values: 90.0 81.0 85.0 79.0 79.0 79.0 79.0 78.0 79.0 82.0 13:13:31 INFO - PROCESS | 24560 | 13:13:31 INFO - PROCESS | 24560 | [#11] stanford-crypto-ccm Cycles:10 Average:134.40 Median:129.50 stddev:16.48 (12.7%) stddev-sans-first:17.40 13:13:31 INFO - PROCESS | 24560 | Values: 139.0 131.0 129.0 129.0 128.0 125.0 130.0 126.0 180.0 127.0 13:13:31 INFO - PROCESS | 24560 | 13:13:31 INFO - PROCESS | 24560 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:165.30 Median:166.00 stddev:2.21 (1.3%) stddev-sans-first:1.56 13:13:31 INFO - PROCESS | 24560 | Values: 170.0 165.0 163.0 166.0 167.0 166.0 164.0 163.0 163.0 166.0 13:13:31 INFO - PROCESS | 24560 | 13:13:31 INFO - PROCESS | 24560 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:67.20 Median:67.00 stddev:1.62 (2.4%) stddev-sans-first:1.36 13:13:31 INFO - PROCESS | 24560 | Values: 70.0 67.0 67.0 66.0 66.0 69.0 69.0 66.0 67.0 65.0 13:13:31 INFO - PROCESS | 24560 | -------- Summary: end -------- 13:13:31 INFO - PROCESS | 24560 | 13:13:32 INFO - TEST-INFO | 24560: exit 0 13:13:32 INFO - TEST-OK | kraken | took 63217ms 13:13:32 INFO - SUITE-END | took 1182s 13:13:33 INFO - Completed test suite (00:19:42) 13:13:33 INFO - javascript benchmark 13:13:33 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2570.691517017958, 2572.4340645058087, 2584.483103379324, 2638.907638232662, 2642.484715480482, 4620.8151673933, 4661.184292748764, 4738.90522189556, 4787.281907713845, 4802.08760335536, 4673.532646735325, 4678.695884767488, 4681.695689780162, 4717.952820471794, 4734.0, 4265.445492086033, 4304.935425968613, 4359.782010899442, 4418.756968366739, 4495.910081798362, 4402.801873915665, 4439.8446054388105, 4456.3983862178675, 4464.709793863389, 4474.485434175079, 4219.472565929259, 4247.19303332369, 4291.3777502262, 4331.675124365669, 4363.3018717005125, 4335.783210839445, 4337.457817772778, 4340.565943405666, 4423.225935461282, 4429.601335879786, 4366.257736184856, 4366.410534577855, 4371.388005679208, 4403.075354175627, 4406.1628290625, 4640.698354606973, 4717.056588682277, 4764.666473346867, 4859.392575928009, 4864.708117512961, 5088.084144853925, 5132.28148059272, 5134.743262836881, 5175.01674681813, 5179.0, 5150.0472412603785, 5162.6902385856965, 5192.324997750268, 5215.556677682402, 5216.087184742692, 4619.19164146273, 4717.315989181549, 4756.286557016406, 4794.568488836021, 4835.637327200474, 5189.040027594907, 5260.815871444481, 5295.391030031518, 5306.867328316745, 5316.255724198615, 5025.924611130836, 5032.345795046621, 5034.79860805571, 5075.593952483792, 5083.949160508421, 4809.591184749265, 4821.686590371614, 4902.779374928136, 5166.3025491558155, 5169.914317993188, 4918.385201849769, 4919.729414882216, 4920.114379411669, 4967.230079337708, 4978.327925730053, 4885.291632713308, 4892.266160075946, 4901.58336541398, 4907.386576677915, 4951.059298733229, 4230.661547076226, 4258.936115958263, 4262.893427664271, 4267.722598031118, 4324.243257429937, 3779.244151169777, 3780.1683629601443, 3798.6011468795377, 3812.599677033927, 3815.923681526354, 4293.849715259951, 4317.481902171759, 4333.71830830995, 4340.153670034313, 4347.413099231627, 5057.039162559102, 5088.77100530477, 5095.949040509621, 5122.538971492583, 5122.641415100981, 4310.051788606502, 4316.158349121891, 4317.740935543815, 4319.67602429819, 4381.605655491021, 4450.376947227391, 4523.117991991596, 4580.473245576802, 4589.242774942097, 4611.815527378867, 4732.52674732524, 4805.1590971579835, 4810.39870016241, 4837.2260438329695, 4874.707517548958, 5123.666961647481, 5142.76857541404, 5160.535551800356, 5174.068667639861, 5175.042617115846, 4600.6319494439695, 4806.231003039637, 4835.830745923876, 4839.975800121118, 4863.051704917507, 4876.536729010738, 4949.084419382426, 4965.851024469272, 4987.1521841287795, 5071.366079240095, 5047.1419858623385, 5052.191649336089, 5052.418971818288, 5053.065182941167, 5113.105206588906, 4933.284673722362, 4943.629227807857, 4961.5534601886, 4962.975185124052, 5005.424376196784, 4828.806847726192, 4837.7097374157665, 4856.708597484162, 4873.171560834596, 4935.728534930613, 4797.544233297831, 4801.351817504592, 4809.0, 4813.78337974799, 4860.73265970375, 4818.759062046954, 4836.105320515716, 4840.782164802522, 4873.585745211697, 4885.2427873679635, 4687.554682305175, 4769.379980602499, 4842.7820748065715, 4847.709137451764, 4907.828226012072], "value": 4644.635772846032, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [513.2737176894694, 514.6731825290941, 529.0846834975492, 569.4931510955248, 582.2285471749932, 28282.85858570707, 41208.38187427187, 42176.578234217726, 42340.788296058556, 45967.540324596746, 41750.37374439386, 42069.15861682765, 42157.0, 42226.57773422265, 42229.0, 7850.214978502147, 7978.840423191533, 7985.321247693924, 7986.560739159344, 8003.0, 7808.141104478503, 7871.88192177115, 7882.842343153162, 7895.249951254622, 7898.447108702393, 7924.881126783102, 7948.926894869205, 7961.562114083752, 7965.123836377994, 7973.0, 7845.293923546879, 7851.8037049073655, 7873.763787086396, 7878.09401918781, 7882.448228623941, 7915.089764677078, 7949.562774047425, 7960.641771120314, 7961.36309095271, 7966.5618390988475, 40459.39310910339, 40678.79660601707, 40826.183476330305, 40834.1833163338, 40903.590964090574, 2816.2396153038567, 2841.573763935426, 2907.6074729911616, 2970.0, 2984.164433958495, 29067.70932290692, 29616.8519157405, 29999.550006749916, 30443.69556304453, 31089.22276943072, 3334.333133373311, 3350.932981340384, 3375.443051896434, 3397.5073614325784, 3418.8290585470627, 272822.0, 272827.0, 273791.0, 274087.0, 274272.0, 54283.45716542863, 54615.0, 54652.45347546553, 54717.72641136769, 54758.17862732062, 46335.0, 48606.513934860195, 49697.75151124294, 55859.441405586236, 56241.43758562362, 14340.067895586963, 14860.479883204036, 14912.552623421314, 14918.0, 14937.70124597502, 11617.070634349231, 11726.41367931617, 11734.823977640342, 11745.823812642817, 11755.529778808752, 13620.455181792815, 15474.5357639271, 15847.52457426279, 16072.598185045468, 16677.49967500977, 6158.846028849314, 6179.196704428396, 6283.214598175228, 6341.556091073673, 6367.904481432783, 835.9247667709935, 971.9222462203007, 1012.1396812709286, 1016.6899095775859, 1038.4911393417322, 29113.56329655057, 29908.700912991026, 30629.0, 32347.353052938808, 32678.509822352684, 953.0326718380849, 960.500539719342, 965.7247684409909, 973.8052389522123, 976.8899177776111, 14457.0, 14998.625034374229, 15042.548723538312, 15170.165640889856, 15270.770938435933, 419815.0, 424524.0, 425163.0, 427399.0, 427677.0, 49094.0, 49326.50673493219, 49356.25965610519, 49392.25911611329, 49485.0, 1193.7090944612714, 1213.1326101837228, 1228.9016878649686, 1247.4074814463058, 1253.0476837603305, 27099.0, 27869.581956270267, 27999.160025199275, 28247.0, 28720.425591487634, 43582.0, 43707.12585748204, 43804.123917522105, 43871.0, 43875.341869871336, 357165.0, 357726.0, 358465.0, 359495.0, 360142.0, 22100.33698989033, 22739.886300568392, 22769.316920492412, 24933.252002439956, 25384.111556096188, 32096.839515803207, 33805.83097084499, 41088.794556028224, 41957.58042419537, 46246.768766155954, 35599.64400355963, 35622.465663015595, 35762.28475430529, 36353.454698180074, 36579.817100914326, 36498.635013650586, 37069.25861482701, 37581.24837503289, 37742.43386349262, 38410.42384364181, 35353.82323088368, 35844.28311433704, 35875.64124358723, 36053.63946360503, 36446.81776591206, 29887.402251955275, 31114.0, 31228.531572025982, 31240.843795780875, 31387.0, 25278.368040799127, 25525.74474255308, 25567.360815979748, 25808.612870806577, 25817.870910645328], "value": 17656.513985150545, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [359.6385632439398, 367.74074277634264, 373.4137404275287, 382.3442795605536, 383.87524054682217, 16370.91814540927, 17323.740143897852, 18449.815501844976, 18547.90726046368, 18568.628627427443, 18068.548286292847, 18383.81616183838, 18710.064496775176, 18890.149943252552, 19010.2395904164, 5727.57043221758, 5925.851853703649, 6019.668918209497, 6031.969840150815, 6032.849178770522, 5690.374058853523, 7090.50366474347, 7130.500864939457, 7247.927520724805, 7252.782416527512, 7004.789856304294, 7212.74755383559, 7269.20038795732, 7277.0, 7287.890681639779, 6991.300869913019, 7247.565146091251, 7252.0572325597595, 7278.9272107278775, 7283.235260297698, 6937.167539895195, 6971.675381677515, 6980.127484064492, 6984.057152284478, 6986.790396288119, 23554.175603853782, 23604.763952360427, 23712.881435592713, 24096.156634517884, 24537.63193552098, 1889.7448844406103, 1963.7545306836646, 1969.133581224271, 1974.7432833731523, 2068.8965551722354, 14312.42750289987, 14426.639334016629, 14735.778963315559, 15339.775732518834, 15792.21038948048, 1828.3874901907743, 1866.2534986005571, 1876.6903460929068, 1907.513584036062, 1956.471752626797, 81396.0, 81949.0, 83271.0, 85829.14170858274, 88305.11694883097, 16652.916735416246, 17297.30810767555, 17551.385701500385, 17920.10399480047, 18041.819581804015, 30080.398392032475, 30124.698753012628, 30145.0, 30239.244018899702, 30290.18258904429, 9000.144986226298, 9110.635574576943, 9304.441733496013, 9462.621495140118, 9529.714108576754, 7463.738769143054, 7674.30931216182, 7724.922750772533, 7920.366370690331, 8000.83998320042, 8480.703175388831, 8504.532250726146, 8565.314774818, 8701.825963480822, 8760.0, 3229.9425754726, 3252.9349413012083, 3260.4457242268873, 3300.9834950825093, 3376.307856889332, 758.768575584441, 811.4641744548287, 823.2467292427482, 857.2242120880613, 957.3298690916387, 15889.761653575206, 16792.496225113267, 17122.14389280531, 17176.31294748221, 17250.396236131925, 833.2251006563832, 843.0810416645885, 862.7454900804278, 882.5587206396801, 909.5543183840003, 9098.954505227564, 9284.0, 9524.380915240487, 9524.571394287274, 9614.375065620852, 413135.0, 420991.0, 440867.0, 441320.0, 441897.0, 46613.5338646616, 59496.40503594995, 74379.0, 82674.17325826785, 85135.574322128, 872.6378552900602, 887.3699673232078, 893.9731808045769, 896.4083704754961, 896.9551522423852, 14596.270186490845, 14801.629959251104, 15112.319945602694, 15141.545753627408, 15395.923020384826, 36539.08652283714, 37985.43021854619, 38735.22529549449, 40418.39372409358, 41083.383749243185, 50713.74643126761, 52230.738846305525, 54707.452925470236, 54963.45036549583, 57282.14076788935, 7148.213696493485, 7254.528455650366, 7375.852482950204, 7489.13874904393, 7544.924550754422, 8091.878621820795, 10906.127509799038, 11233.32600044, 11654.359010254517, 11922.0, 9405.294602904947, 9419.152276295166, 9423.340366174301, 10103.141232995278, 10249.897501024894, 9833.459159745997, 9891.703248902544, 10022.0, 10025.598976041168, 10102.09081182697, 9819.558119884765, 10042.69871903844, 10213.74465638365, 10550.366977981346, 10561.471926403496, 7507.549547027196, 7527.623618818928, 7677.769666910001, 7708.768736937901, 7725.961370193113, 9046.773830654023, 9158.450492970444, 9301.581428835583, 9492.667756628485, 9750.85373719409], "value": 9431.543734627357, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1286.5754301080644, 1410.041172003038, 1447.2618964328192, 1531.4639876043386, 1755.1399814091092, 6836.384725374715, 7679.1552929177815, 7919.0893047299505, 7953.801154971128, 8185.386096042791, 7935.880961785578, 7956.4828286161355, 8012.118666946646, 8025.357971362277, 8034.156413576578, 2196.066671664544, 2222.899969501368, 2233.832462565314, 2235.9217427390045, 2236.26203352894, 2154.2244791874914, 2217.9889100554474, 2224.7997680208778, 2234.754177040524, 2235.441139715071, 2144.8927553622334, 2154.019920935978, 2154.7845215478405, 2196.791304826039, 2264.2075273654254, 2167.4267296005414, 2196.5936301784222, 2200.1639377036786, 2205.426589086833, 2206.393241858486, 2135.562209746998, 2136.5940471310555, 2137.0490131891315, 2138.433315171481, 2140.1760322276036, 8020.879686804703, 8069.717559885435, 8077.071136819282, 8079.474834135821, 8083.717069902584, 4660.324252983299, 4831.9033619327765, 4832.879178020543, 4882.853514394574, 4891.217405215184, 2848.900288489893, 2950.395168990352, 2998.1755017370397, 3000.489916714164, 3014.1861697341815, 992.3400938376044, 995.2386424385351, 1005.5625802775743, 1007.3301254665638, 1018.6892997635719, 11002.174836887265, 11091.889081109248, 11126.443677816076, 11129.387883666395, 11132.777344453147, 4124.649404800625, 4355.128974205171, 4489.977550112294, 4503.279475283939, 4518.43519560055, 8691.261242794433, 8779.473231606124, 8788.209061184396, 8789.077146899612, 8791.824163516694, 4796.928046079312, 4811.061842940593, 4811.27830825372, 4811.49479304675, 4816.181249187646, 3609.620989796086, 3730.6082861299715, 4346.022145017346, 4472.865814025585, 4475.507694153641, 3474.357243909885, 3504.456809194528, 3604.9639503604626, 3606.6393360664247, 3606.6573675500786, 1024.9692509224735, 1062.0951697108403, 1073.3148956138787, 1073.7584043590286, 1078.9730256743487, 793.2226418110284, 819.5902048975512, 820.5486982159788, 822.8436597046542, 842.9789255268545, 5199.818006369759, 5223.9477605223465, 5444.972775136178, 5477.863053423696, 5502.009638265151, 406.704461424701, 424.1538131427821, 430.15259937922866, 432.5134223998002, 443.1911761036122, 3336.966630333714, 3391.847366868497, 3432.553768010143, 3507.3511400391008, 3511.859525618998, 9506.857397139049, 9872.802543949081, 9981.500924953869, 10015.14871235953, 10015.499225038719, 9894.257930655229, 9897.505124743733, 9899.901000990041, 9930.0, 9969.102780749767, 7488.764353881548, 7557.5465472070755, 7571.962140189264, 7575.924240757632, 7577.242275772489, 5429.267048948342, 5493.313335833021, 5627.268455100811, 5658.9151162733415, 5718.485336319751, 9281.814363712823, 9346.392484488759, 9362.485063321583, 9374.531273436438, 9463.763405914908, 8159.632816523152, 8762.386632935888, 9103.772405689646, 9193.0, 9365.063493650581, 7338.522996005243, 7547.320741133105, 7730.690772369042, 7739.032620922385, 7741.535507869321, 7576.166621671722, 7661.770146895602, 7672.347850432552, 7727.381809455118, 7729.690812367668, 7009.12385951756, 7027.121609798775, 7067.752628657972, 7104.076470058859, 7153.749618763526, 6694.397504224643, 6790.762323318858, 6818.829529261609, 6845.151809011639, 6980.476464265099, 6185.134081228542, 6273.811785646255, 6294.0, 6297.874042519033, 6302.684865756785, 4508.256137737368, 4541.2052890743325, 4675.906481870412, 4713.787879545497, 4741.099191153669, 4647.930281045719, 4693.929591056069, 4719.197736384892, 4739.194336962656, 5031.22016087507], "value": 4130.868956511292, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [287.4595759971254, 297.1027496959183, 300.3167793270311, 300.98946536871216, 303.99529554821316, 4624.8150073997085, 4777.355057067295, 4831.0, 4883.633727470441, 4887.975560122199, 4649.767511624422, 4767.785449654765, 4778.307145463914, 4808.447028591713, 4820.156472617296, 3832.080300727819, 3838.9424158637644, 3846.615338466145, 3849.7497662651976, 3852.5184351955936, 3606.6753992140702, 3640.6541378568995, 3849.1139341722633, 3860.942085868714, 3863.9034024149482, 3742.6818720408796, 3772.2455508898192, 3802.372608519591, 3811.3711237645757, 3851.1719980204252, 3817.4655548223272, 3823.5794062653085, 3832.9041773955596, 3834.2906562285925, 3841.8271177796787, 3401.2857299967036, 3416.0, 3418.435958066916, 3426.554547908781, 3426.58880934287, 4513.729176249402, 4682.976585117087, 4695.835645752382, 4728.621710263171, 4765.714057156547, 4321.719088259285, 4323.7028891332475, 4370.956290437119, 4373.322135069069, 4390.758508282043, 4981.630051735766, 5039.244113382985, 5046.697198168122, 5047.394312682502, 5049.697018178921, 3617.89146325608, 3625.1118475973553, 3684.244729830378, 3684.7420680552373, 3714.275716235335, 5192.1173400522, 5204.9739751301, 5207.921881171786, 5210.557102646279, 5224.582033437316, 3775.867844625425, 3782.791946442972, 3788.0, 3794.6964242860504, 3794.924101517954, 3829.468212714881, 3832.5209348831395, 3865.632764887331, 3869.555001174901, 3873.2447172801035, 4165.201499670676, 4243.27864263076, 4304.612584867377, 4312.741235525878, 4333.371661109185, 4965.155923493015, 4978.904640978979, 4982.202847544448, 4994.150994330972, 5007.924881126786, 1253.166644181609, 1282.781357710179, 1286.899700755859, 1316.2168509736691, 1334.9265790381621, 880.4453194487432, 909.5452273863068, 910.3309067835136, 934.9205317548085, 938.0853667674099, 4344.478662560513, 4370.912581748411, 4379.956200438019, 4390.100029493946, 4400.141972315432, 5148.948510514847, 5151.047056294523, 5159.355080614923, 5162.9483705162465, 5166.571711295685, 4236.85171019019, 4451.532589078165, 4510.368548403226, 4523.208438523246, 4527.886802829956, 2761.9309517262227, 2777.7638900693264, 2783.2465546705853, 2783.4711404833015, 2793.371491414456, 4809.591184749335, 4969.478204788517, 4976.278439626306, 4979.875503112451, 4981.676191047571, 5265.262863199156, 5310.628256022119, 5311.362636483646, 5330.680159190461, 5388.164834450667, 4875.731834749123, 4914.508549145057, 4922.809349839287, 4931.841017360989, 4932.383452068491, 5025.592834006484, 5102.719350435762, 5170.663906846043, 5190.2214667800135, 5218.0, 5065.670731402594, 5069.66795274178, 5077.060743762416, 5086.694798312114, 5107.974460127824, 4892.31507588945, 4897.436794768647, 4915.459299476983, 4950.762309422645, 4957.801687932587, 3614.7831130132276, 3705.462707907392, 3731.9253614927006, 3736.8131593419675, 3737.177820879511, 5128.384593848762, 5134.845954621367, 5146.6911985281, 5179.22311653255, 5196.194589838581, 5013.197888337994, 5018.197088465828, 5018.4730603286125, 5075.492450754895, 5084.161113416245, 4872.171730805842, 5008.348914641073, 5066.214736715815, 5072.1123803335, 5091.770870310919, 4723.622110231242, 4876.195807551228, 4892.755362231946, 4965.907500349917, 4980.900381992267, 4867.7365025263425, 4887.462379138363, 4899.681520701143, 4901.362822833009, 4969.453360130455, 4827.637927155407, 4845.3216549682365, 4868.537488938545, 4870.660568343592, 4888.242322440027], "value": 3823.231005893923, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [579.7391173971713, 616.4298024327496, 635.3043417457882, 695.7703957693958, 700.6881937537796, 13672.31638418079, 13935.790963135561, 13971.441142354293, 14109.92945035276, 14207.147571145713, 12912.806307905388, 12982.93508532456, 12987.090903636725, 12993.155444896076, 12996.870031299684, 630.6783540394385, 783.4359261331846, 802.995985020074, 803.6945960535018, 804.3846457460048, 775.8836174573831, 798.8282519258358, 799.1249581708021, 806.6087947345533, 807.475141158246, 843.9198276163754, 845.720912099009, 846.2003406780594, 846.4921047371589, 846.7586737779734, 653.9607623542555, 841.6254766628853, 842.9157084291583, 843.2031730015138, 843.7173546861778, 598.850287428143, 614.1034090228272, 617.586217234454, 618.0543768034913, 618.6257314324814, 13123.146995445266, 13126.14680045794, 13146.014048946367, 13149.934250328783, 13166.802497962539, 12429.440675169548, 12638.873611263954, 12759.106862519628, 13047.739045219138, 13273.07088503805, 11772.293662380285, 11827.467763950643, 12013.099017573717, 12075.396230188544, 12557.811632825515, 4149.398337241113, 4236.0892408132095, 4274.871753847389, 4347.956520434786, 4353.238183317907, 61246.081308780405, 61363.0, 61378.38621613771, 61432.69283653598, 62227.377726222614, 10075.34510256831, 10209.285350025575, 10295.9485202575, 10334.121599664113, 10650.201234907412, 19179.424617261506, 19198.616027679367, 19353.322633708034, 19403.90298048529, 19653.901730491256, 6943.201531823905, 7045.487371813078, 7062.223155452896, 7102.3962963148715, 7131.607761573059, 3732.458793474931, 3775.1505911169766, 3794.127350709297, 3794.715396345285, 3935.3506671399473, 2853.6432945881766, 2956.4678357895355, 2959.1122663200954, 2962.4223276460884, 2967.2285205846633, 554.6062295769967, 575.0999685492192, 577.9335376431765, 581.988360232793, 593.1073734030343, 490.759835025381, 506.42014892947367, 519.2185760430527, 523.2256260734135, 530.1623434972734, 8035.558044307502, 8148.633311500997, 8229.876551851727, 8251.422400432033, 8381.580920953927, 503.62228328753434, 511.54216975806446, 518.6991544903947, 529.222043595921, 531.7341329335333, 3783.754055986407, 3923.5487918889694, 4030.7581545107387, 4061.9796901015307, 4078.347464405681, 82649.0, 84519.5774021126, 84897.57551212204, 98635.50682246686, 109813.0, 47918.760406198446, 62943.0, 80040.59979700064, 80158.0, 82633.0, 71025.2897471029, 71687.28312716911, 71860.28139718536, 72935.0, 75442.62278688571, 8636.524991125549, 9155.862662060208, 9174.174324310845, 9315.906840931504, 9384.34309598349, 41943.580564193966, 42592.36111458269, 43298.78350608227, 43994.560054399044, 45080.77459612681, 56460.71769641126, 56979.0, 62005.37994619996, 66885.0, 70416.29583704303, 10787.811148534101, 11043.558257669603, 11058.336499810037, 11696.181267311207, 12133.02935765119, 11955.222910510789, 12354.07344449152, 12469.189502682297, 12500.93749531283, 12976.610701678965, 11430.0, 12142.332171730286, 12186.695332616755, 12398.504059837505, 12664.87335126637, 10362.948185259025, 10409.68770936873, 10547.525361358605, 10704.571817127538, 10760.83858742135, 11164.776704466027, 11642.53429862796, 11683.123765717435, 11954.410891064479, 12164.817527737268, 9749.9025009749, 9978.351407158512, 10067.899321006696, 10183.13443357323, 10487.318324308895, 9864.06880431173, 10622.097121744739, 10628.512008318996, 10712.785744285227, 10800.729981750519], "value": 6610.501204861617, "unit": "score"}], "name": "dromaeo_css", "value": 6574.554481463871, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [105.0, 114.0, 117.0, 113.0, 114.0, 115.0, 113.0, 115.0, 114.0, 113.0], "value": 113.3, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [145.0, 124.0, 123.0, 181.0, 123.0, 124.0, 156.0, 122.0, 182.0, 125.0], "value": 140.5, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [160.0, 162.0, 161.0, 160.0, 162.0, 160.0, 161.0, 160.0, 161.0, 161.0], "value": 160.8, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [78.0, 76.0, 77.0, 103.0, 76.0, 76.0, 75.0, 75.0, 103.0, 76.0], "value": 81.5, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [86.0, 86.0, 122.0, 86.0, 86.0, 85.0, 121.0, 86.0, 86.0, 137.0], "value": 98.1, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 117.0, 117.0, 117.0, 117.0, 117.0, 117.0, 116.0, 117.0, 117.0], "value": 116.9, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [147.0, 147.0, 147.0, 146.0, 146.0, 145.0, 145.0, 146.0, 146.0, 146.0], "value": 146.1, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 94.0, 95.0, 95.0, 95.0, 94.0, 94.0, 95.0, 94.0, 95.0], "value": 94.6, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [63.0, 64.0, 62.0, 63.0, 64.0, 62.0, 63.0, 63.0, 64.0, 63.0], "value": 63.1, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [65.0, 66.0, 66.0, 65.0, 66.0, 66.0, 66.0, 65.0, 66.0, 66.0], "value": 65.7, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [90.0, 81.0, 85.0, 79.0, 79.0, 79.0, 79.0, 78.0, 79.0, 82.0], "value": 81.1, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [139.0, 131.0, 129.0, 129.0, 128.0, 125.0, 130.0, 126.0, 180.0, 127.0], "value": 134.4, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [170.0, 165.0, 163.0, 166.0, 167.0, 166.0, 164.0, 163.0, 163.0, 166.0], "value": 165.3, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [70.0, 67.0, 67.0, 66.0, 66.0, 69.0, 69.0, 66.0, 67.0, 65.0], "value": 67.2, "unit": "score"}], "name": "kraken", "value": 1528.6000000000001, "alertThreshold": 2.0}]} 13:13:33 INFO - Return code: 0 13:13:33 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 13:13:33 INFO - # TBPL SUCCESS # 13:13:33 INFO - Running post-action listener: _resource_record_post_action 13:13:33 INFO - [mozharness: 2016-07-20 20:13:33.172091Z] Finished run-tests step (success) 13:13:33 INFO - Running post-run listener: _resource_record_post_run 13:13:33 INFO - Total resource usage - Wall time: 1199s; CPU: 13.0%; Read bytes: 4096; Write bytes: 540614656; Read time: 8; Write time: 435092 13:13:33 INFO - TinderboxPrint: CPU usage
13.0% 13:13:33 INFO - TinderboxPrint: I/O read bytes / time
4,096 / 8 13:13:33 INFO - TinderboxPrint: I/O write bytes / time
540,614,656 / 435,092 13:13:33 INFO - TinderboxPrint: CPU idle
8,327.8 (87.0%) 13:13:33 INFO - TinderboxPrint: CPU user
1,200.1 (12.5%) 13:13:33 INFO - TinderboxPrint: Swap in / out
0 / 0 13:13:33 INFO - install - Wall time: 17s; CPU: 14.0%; Read bytes: 0; Write bytes: 257306624; Read time: 0; Write time: 258252 13:13:33 INFO - run-tests - Wall time: 1183s; CPU: 13.0%; Read bytes: 4096; Write bytes: 283308032; Read time: 8; Write time: 176840 13:13:33 INFO - Running post-run listener: _upload_blobber_files 13:13:33 INFO - Blob upload gear active. 13:13:33 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 13:13:33 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 13:13:33 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'] 13:13:33 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 13:13:34 INFO - (blobuploader) - INFO - Open directory for files ... 13:13:34 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 13:13:34 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 13:13:34 INFO - (blobuploader) - INFO - Uploading, attempt #1. 13:13:34 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 13:13:34 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 13:13:34 INFO - (blobuploader) - INFO - Done attempting. 13:13:34 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 13:13:34 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 13:13:34 INFO - (blobuploader) - INFO - Uploading, attempt #1. 13:13:35 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 13:13:35 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 13:13:35 INFO - (blobuploader) - INFO - Done attempting. 13:13:35 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 13:13:35 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 13:13:35 INFO - (blobuploader) - INFO - Uploading, attempt #1. 13:13:52 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 13:13:52 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 13:13:52 INFO - (blobuploader) - INFO - Done attempting. 13:13:52 INFO - (blobuploader) - INFO - Iteration through files over. 13:13:52 INFO - Return code: 0 13:13:52 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 13:13:52 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 13:13:52 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/b5910103acab8ebdec50c90f616a313d435026779d51605f4c68a5c11de16b786bf6638ce7238ec8557098fca7cddc5a9c36a1adc4e03c7b0bb640b3030eb0de", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/72f9d5f090719099bd339238a29418b60822383d9be3baff647b1a5570eb865f6a1d70741217ea99d42e73fc00d64e726e1f70a57f15070af93a8278f44b43da", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/cc915588062773f4ebaf6ad2fffc4277c4cc814368299ed7570985a7a3835ee16e3280438ea3cab82c2dd5786a9e30aa567c487d98601bbd6d392608ad5c5e3b"} 13:13:52 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 13:13:52 INFO - Writing to file /builds/slave/test/properties/blobber_files 13:13:52 INFO - Contents: 13:13:52 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/b5910103acab8ebdec50c90f616a313d435026779d51605f4c68a5c11de16b786bf6638ce7238ec8557098fca7cddc5a9c36a1adc4e03c7b0bb640b3030eb0de", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/72f9d5f090719099bd339238a29418b60822383d9be3baff647b1a5570eb865f6a1d70741217ea99d42e73fc00d64e726e1f70a57f15070af93a8278f44b43da", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/cc915588062773f4ebaf6ad2fffc4277c4cc814368299ed7570985a7a3835ee16e3280438ea3cab82c2dd5786a9e30aa567c487d98601bbd6d392608ad5c5e3b"} 13:13:52 INFO - Running post-run listener: copy_logs_to_upload_dir 13:13:52 INFO - Copying logs to upload dir... 13:13:52 INFO - mkdir: /builds/slave/test/build/upload/logs 13:13:52 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1249.809031 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 49 secs) (at 2016-07-20 13:13:52.669610) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-07-20 13:13:52.673332) ========= bash -c 'for file in `ls -1`; do cat $file; done' in dir /builds/slave/test/properties (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', 'for file in `ls -1`; do cat $file; done'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test/properties SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=41bf3e9aed84707956354da8000001c5-1469044380.585708-1980824796 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/b5910103acab8ebdec50c90f616a313d435026779d51605f4c68a5c11de16b786bf6638ce7238ec8557098fca7cddc5a9c36a1adc4e03c7b0bb640b3030eb0de", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/72f9d5f090719099bd339238a29418b60822383d9be3baff647b1a5570eb865f6a1d70741217ea99d42e73fc00d64e726e1f70a57f15070af93a8278f44b43da", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/cc915588062773f4ebaf6ad2fffc4277c4cc814368299ed7570985a7a3835ee16e3280438ea3cab82c2dd5786a9e30aa567c487d98601bbd6d392608ad5c5e3b"} build_url:https://queue.taskcluster.net/v1/task/Ss6DX1adQNKwmG9dXJ2qBA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011314 build_url: 'https://queue.taskcluster.net/v1/task/Ss6DX1adQNKwmG9dXJ2qBA/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/b5910103acab8ebdec50c90f616a313d435026779d51605f4c68a5c11de16b786bf6638ce7238ec8557098fca7cddc5a9c36a1adc4e03c7b0bb640b3030eb0de", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/72f9d5f090719099bd339238a29418b60822383d9be3baff647b1a5570eb865f6a1d70741217ea99d42e73fc00d64e726e1f70a57f15070af93a8278f44b43da", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/cc915588062773f4ebaf6ad2fffc4277c4cc814368299ed7570985a7a3835ee16e3280438ea3cab82c2dd5786a9e30aa567c487d98601bbd6d392608ad5c5e3b"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-07-20 13:13:52.698594) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-07-20 13:13:52.698927) ========= rm -f oauth.txt in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['rm', '-f', 'oauth.txt'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=41bf3e9aed84707956354da8000001c5-1469044380.585708-1980824796 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004438 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-07-20 13:13:52.783643) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-07-20 13:13:52.783964) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-07-20 13:13:52.784267) ========= ========= Total master_lag: 0.18 =========