builder: fx-team_ubuntu64_hw_test-dromaeojs-e10s slave: talos-linux64-ix-058 starttime: 1468619827.75 results: success (0) buildid: 20160715141452 builduid: d4b0a68295b04f62aebdcfe41c7c76be revision: 3db372da6fe108ddb0727003447f22c2483fb86d ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-07-15 14:57:07.750946) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-07-15 14:57:07.751354) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-07-15 14:57:07.751640) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-07-15 14:57:07.799806) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-15 14:57:07.800062) ========= 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=0e2a256762fed810e2f0f810000001b3-1468616785.323493-1948727444 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-07-15 14:57:07-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 70.8M=0s 2016-07-15 14:57:08 (70.8 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.145069 ========= master_lag: 0.05 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-15 14:57:07.993862) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-07-15 14:57:07.994153) ========= 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=0e2a256762fed810e2f0f810000001b3-1468616785.323493-1948727444 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.088636 ========= master_lag: 0.01 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-07-15 14:57:08.095089) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-15 14:57:08.095597) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev 3db372da6fe108ddb0727003447f22c2483fb86d --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 3db372da6fe108ddb0727003447f22c2483fb86d --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=0e2a256762fed810e2f0f810000001b3-1468616785.323493-1948727444 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-07-15 14:57:08,197 truncating revision to first 12 chars 2016-07-15 14:57:08,197 Setting DEBUG logging. 2016-07-15 14:57:08,197 attempt 1/10 2016-07-15 14:57:08,197 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/3db372da6fe1?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-07-15 14:57:08,575 unpacking tar archive at: fx-team-3db372da6fe1/testing/mozharness/ program finished with exit code 0 elapsedTime=0.714851 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-15 14:57:08.823850) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-07-15 14:57:08.824148) ========= script_repo_revision: 3db372da6fe108ddb0727003447f22c2483fb86d ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-07-15 14:57:08.824533) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-07-15 14:57:08.824801) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-07-15 14:57:08.834935) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 51 secs) (at 2016-07-15 14:57:08.835208) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --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-e10s', '--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=0e2a256762fed810e2f0f810000001b3-1468616785.323493-1948727444 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 14:57:09 INFO - MultiFileLogger online at 20160715 14:57:09 in /builds/slave/test 14:57:09 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --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 14:57:09 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 14:57:09 INFO - {'append_to_log': False, 14:57:09 INFO - 'base_work_dir': '/builds/slave/test', 14:57:09 INFO - 'blob_upload_branch': 'Fx-Team-Non-PGO', 14:57:09 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 14:57:09 INFO - 'branch': 'Fx-Team-Non-PGO', 14:57:09 INFO - 'buildbot_json_path': 'buildprops.json', 14:57:09 INFO - 'config_files': ('talos/linux_config.py',), 14:57:09 INFO - 'default_actions': ('clobber', 14:57:09 INFO - 'read-buildbot-config', 14:57:09 INFO - 'download-and-extract', 14:57:09 INFO - 'populate-webroot', 14:57:09 INFO - 'create-virtualenv', 14:57:09 INFO - 'install', 14:57:09 INFO - 'run-tests'), 14:57:09 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 14:57:09 INFO - 'download_minidump_stackwalk': True, 14:57:09 INFO - 'download_symbols': 'ondemand', 14:57:09 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 14:57:09 INFO - 'tooltool.py': '/tools/tooltool.py', 14:57:09 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 14:57:09 INFO - '/tools/misc-python/virtualenv.py')}, 14:57:09 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 14:57:09 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 14:57:09 INFO - 'installer_path': 'installer.exe', 14:57:09 INFO - 'log_level': 'info', 14:57:09 INFO - 'log_name': 'talos', 14:57:09 INFO - 'log_to_console': True, 14:57:09 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 14:57:09 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 14:57:09 INFO - 'opt_config_files': (), 14:57:09 INFO - 'pip_index': False, 14:57:09 INFO - 'sps_profile': False, 14:57:09 INFO - 'sps_profile_interval': 0, 14:57:09 INFO - 'suite': 'dromaeojs-e10s', 14:57:09 INFO - 'system_bits': '32', 14:57:09 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 14:57:09 INFO - 'title': 'talos-linux64-ix-058', 14:57:09 INFO - 'tooltool_cache': '/builds/tooltool_cache', 14:57:09 INFO - 'use_talos_json': True, 14:57:09 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 14:57:09 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 14:57:09 INFO - 'work_dir': 'build'} 14:57:09 INFO - ##### 14:57:09 INFO - ##### Running clobber step. 14:57:09 INFO - ##### 14:57:09 INFO - Running pre-action listener: _resource_record_pre_action 14:57:09 INFO - Running main action method: clobber 14:57:09 INFO - rmtree: /builds/slave/test/build 14:57:09 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 14:57:10 INFO - Running post-action listener: _resource_record_post_action 14:57:10 INFO - ##### 14:57:10 INFO - ##### Finished clobber step (success) 14:57:10 INFO - ##### 14:57:10 INFO - ##### 14:57:10 INFO - ##### Running read-buildbot-config step. 14:57:10 INFO - ##### 14:57:10 INFO - Running pre-action listener: _resource_record_pre_action 14:57:10 INFO - Running main action method: read_buildbot_config 14:57:10 INFO - Using buildbot properties: 14:57:10 INFO - { 14:57:10 INFO - "project": "", 14:57:10 INFO - "product": "firefox", 14:57:10 INFO - "script_repo_revision": "production", 14:57:10 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs-e10s", 14:57:10 INFO - "repository": "", 14:57:10 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team talos dromaeojs-e10s", 14:57:10 INFO - "buildid": "20160715141452", 14:57:10 INFO - "pgo_build": "False", 14:57:10 INFO - "basedir": "/builds/slave/test", 14:57:10 INFO - "buildnumber": 1666, 14:57:10 INFO - "slavename": "talos-linux64-ix-058", 14:57:10 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 14:57:10 INFO - "platform": "ubuntu64_hw", 14:57:10 INFO - "scheduler": "tests-fx-team-linux64-talos", 14:57:10 INFO - "branch": "fx-team", 14:57:10 INFO - "repo_path": "integration/fx-team", 14:57:10 INFO - "revision": "3db372da6fe108ddb0727003447f22c2483fb86d", 14:57:10 INFO - "stage_platform": "linux64", 14:57:10 INFO - "builduid": "d4b0a68295b04f62aebdcfe41c7c76be", 14:57:10 INFO - "slavebuilddir": "test" 14:57:10 INFO - } 14:57:10 INFO - Found installer url https://queue.taskcluster.net/v1/task/AU76KAG0T5yTp1qDGKJ5ZQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2. 14:57:10 INFO - Running post-action listener: _resource_record_post_action 14:57:10 INFO - ##### 14:57:10 INFO - ##### Finished read-buildbot-config step (success) 14:57:10 INFO - ##### 14:57:10 INFO - ##### 14:57:10 INFO - ##### Running download-and-extract step. 14:57:10 INFO - ##### 14:57:10 INFO - Running pre-action listener: _resource_record_pre_action 14:57:10 INFO - Running main action method: download_and_extract 14:57:10 INFO - mkdir: /builds/slave/test/build/tests 14:57:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:57:10 INFO - https://queue.taskcluster.net/v1/task/AU76KAG0T5yTp1qDGKJ5ZQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 14:57:10 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/AU76KAG0T5yTp1qDGKJ5ZQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 14:57:10 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/AU76KAG0T5yTp1qDGKJ5ZQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 14:57:10 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/AU76KAG0T5yTp1qDGKJ5ZQ/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 14:57:10 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/AU76KAG0T5yTp1qDGKJ5ZQ/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 14:57:11 INFO - Downloaded 1361 bytes. 14:57:11 INFO - Reading from file /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 14:57:11 INFO - Using the following test package requirements: 14:57:11 INFO - {u'common': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 14:57:11 INFO - u'cppunittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 14:57:11 INFO - u'firefox-50.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 14:57:11 INFO - u'gtest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 14:57:11 INFO - u'firefox-50.0a1.en-US.linux-x86_64.gtest.tests.zip'], 14:57:11 INFO - u'jittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 14:57:11 INFO - u'jsshell-linux-x86_64.zip'], 14:57:11 INFO - u'mochitest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 14:57:11 INFO - u'firefox-50.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 14:57:11 INFO - u'mozbase': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 14:57:11 INFO - u'reftest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 14:57:11 INFO - u'firefox-50.0a1.en-US.linux-x86_64.reftest.tests.zip'], 14:57:11 INFO - u'talos': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 14:57:11 INFO - u'firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip'], 14:57:11 INFO - u'web-platform': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 14:57:11 INFO - u'firefox-50.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 14:57:11 INFO - u'xpcshell': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 14:57:11 INFO - u'firefox-50.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 14:57:11 INFO - Downloading packages: [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 14:57:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:57:11 INFO - https://queue.taskcluster.net/v1/task/AU76KAG0T5yTp1qDGKJ5ZQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 14:57:11 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/AU76KAG0T5yTp1qDGKJ5ZQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 14:57:11 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/AU76KAG0T5yTp1qDGKJ5ZQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 14:57:11 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/AU76KAG0T5yTp1qDGKJ5ZQ/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 14:57:11 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/AU76KAG0T5yTp1qDGKJ5ZQ/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 14:57:15 INFO - Downloaded 22757261 bytes. 14:57:15 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'] 14:57:15 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 14:57:16 INFO - Return code: 0 14:57:16 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 14:57:16 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:57:16 INFO - https://queue.taskcluster.net/v1/task/AU76KAG0T5yTp1qDGKJ5ZQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 14:57:16 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/AU76KAG0T5yTp1qDGKJ5ZQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 14:57:16 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/AU76KAG0T5yTp1qDGKJ5ZQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 14:57:16 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/AU76KAG0T5yTp1qDGKJ5ZQ/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 14:57:16 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/AU76KAG0T5yTp1qDGKJ5ZQ/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 14:57:23 INFO - Downloaded 22757261 bytes. 14:57:23 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 14:57:23 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 14:57:24 INFO - Return code: 0 14:57:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:57:24 INFO - https://queue.taskcluster.net/v1/task/AU76KAG0T5yTp1qDGKJ5ZQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 14:57:24 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/AU76KAG0T5yTp1qDGKJ5ZQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 14:57:24 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/AU76KAG0T5yTp1qDGKJ5ZQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 14:57:24 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/AU76KAG0T5yTp1qDGKJ5ZQ/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 14:57:24 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/AU76KAG0T5yTp1qDGKJ5ZQ/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 14:57:25 INFO - Downloaded 14403317 bytes. 14:57:25 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'] 14:57:25 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 14:57:26 INFO - Return code: 0 14:57:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:57:26 INFO - https://queue.taskcluster.net/v1/task/AU76KAG0T5yTp1qDGKJ5ZQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 14:57:26 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/AU76KAG0T5yTp1qDGKJ5ZQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 14:57:26 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/AU76KAG0T5yTp1qDGKJ5ZQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 14:57:26 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/AU76KAG0T5yTp1qDGKJ5ZQ/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 14:57:26 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/AU76KAG0T5yTp1qDGKJ5ZQ/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 14:57:27 INFO - Downloaded 57080425 bytes. 14:57:27 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/AU76KAG0T5yTp1qDGKJ5ZQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 14:57:27 INFO - mkdir: /builds/slave/test/properties 14:57:27 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 14:57:27 INFO - Writing to file /builds/slave/test/properties/build_url 14:57:27 INFO - Contents: 14:57:27 INFO - build_url:https://queue.taskcluster.net/v1/task/AU76KAG0T5yTp1qDGKJ5ZQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 14:57:28 INFO - Running post-action listener: _resource_record_post_action 14:57:28 INFO - Running post-action listener: set_extra_try_arguments 14:57:28 INFO - ##### 14:57:28 INFO - ##### Finished download-and-extract step (success) 14:57:28 INFO - ##### 14:57:28 INFO - ##### 14:57:28 INFO - ##### Running populate-webroot step. 14:57:28 INFO - ##### 14:57:28 INFO - Running pre-action listener: _resource_record_pre_action 14:57:28 INFO - Running main action method: populate_webroot 14:57:28 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 14:57:28 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 14:57:28 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 14:57:28 INFO - '--tppagecycles', 14:57:28 INFO - '7'], 14:57:28 INFO - 'tests': ['tsvgm']}}, 14:57:28 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 14:57:28 INFO - 'tests': ['tresize', 'tcanvasmark']}, 14:57:28 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 14:57:28 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 14:57:28 INFO - 'tests': ['dromaeo_css', 'kraken']}, 14:57:28 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 14:57:28 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:57:28 INFO - 'talos_options': ['--disable-e10s'], 14:57:28 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 14:57:28 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:57:28 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 14:57:28 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:57:28 INFO - 'talos_options': ['--disable-e10s'], 14:57:28 INFO - 'tests': ['damp', 'tps']}, 14:57:28 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:57:28 INFO - 'tests': ['damp', 'tps']}, 14:57:28 INFO - 'g3': {'talos_options': ['--disable-e10s'], 14:57:28 INFO - 'tests': ['dromaeo_dom']}, 14:57:28 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 14:57:28 INFO - 'g4': {'talos_options': ['--disable-e10s'], 14:57:28 INFO - 'tests': ['basic_compositor_video']}, 14:57:28 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 14:57:28 INFO - 'other': {'talos_options': ['--disable-e10s'], 14:57:28 INFO - 'tests': ['a11yr', 14:57:28 INFO - 'ts_paint', 14:57:28 INFO - 'tpaint', 14:57:28 INFO - 'sessionrestore', 14:57:28 INFO - 'sessionrestore_no_auto_restore', 14:57:28 INFO - 'tabpaint']}, 14:57:28 INFO - 'other-e10s': {'tests': ['a11yr', 14:57:28 INFO - 'ts_paint', 14:57:28 INFO - 'tpaint', 14:57:28 INFO - 'sessionrestore', 14:57:28 INFO - 'sessionrestore_no_auto_restore', 14:57:28 INFO - 'tabpaint']}, 14:57:28 INFO - 'other-e10s_l64': {'tests': ['a11yr', 14:57:28 INFO - 'ts_paint', 14:57:28 INFO - 'tpaint', 14:57:28 INFO - 'sessionrestore', 14:57:28 INFO - 'sessionrestore_no_auto_restore', 14:57:28 INFO - 'tabpaint']}, 14:57:28 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 14:57:28 INFO - 'ts_paint', 14:57:28 INFO - 'tpaint', 14:57:28 INFO - 'sessionrestore', 14:57:28 INFO - 'sessionrestore_no_auto_restore', 14:57:28 INFO - 'tabpaint']}, 14:57:28 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 14:57:28 INFO - 'tests': ['a11yr', 14:57:28 INFO - 'ts_paint', 14:57:28 INFO - 'tpaint', 14:57:28 INFO - 'sessionrestore', 14:57:28 INFO - 'sessionrestore_no_auto_restore', 14:57:28 INFO - 'tabpaint']}, 14:57:28 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 14:57:28 INFO - 'tests': ['a11yr', 14:57:28 INFO - 'ts_paint', 14:57:28 INFO - 'tpaint', 14:57:28 INFO - 'sessionrestore', 14:57:28 INFO - 'sessionrestore_no_auto_restore', 14:57:28 INFO - 'tabpaint']}, 14:57:28 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 14:57:28 INFO - 'tests': ['tsvgx', 14:57:28 INFO - 'tsvgr_opacity', 14:57:28 INFO - 'tart', 14:57:28 INFO - 'tscrollx', 14:57:28 INFO - 'cart']}, 14:57:28 INFO - 'svgr-e10s': {'tests': ['tsvgx', 14:57:28 INFO - 'tsvgr_opacity', 14:57:28 INFO - 'tart', 14:57:28 INFO - 'tscrollx', 14:57:28 INFO - 'cart']}, 14:57:28 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:57:28 INFO - 'talos_options': ['--disable-e10s'], 14:57:28 INFO - 'tests': ['tp5o']}, 14:57:28 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:57:28 INFO - 'tests': ['tp5o']}, 14:57:28 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:57:28 INFO - 'talos_options': ['--disable-e10s', 14:57:28 INFO - '--xperf_path', 14:57:28 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 14:57:28 INFO - 'tests': ['tp5n']}, 14:57:28 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:57:28 INFO - 'talos_options': ['--xperf_path', 14:57:28 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 14:57:28 INFO - 'tests': ['tp5n']}}, 14:57:28 INFO - 'talos.zip': {'path': '', 14:57:28 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 14:57:28 INFO - Running post-action listener: _resource_record_post_action 14:57:28 INFO - ##### 14:57:28 INFO - ##### Finished populate-webroot step (success) 14:57:28 INFO - ##### 14:57:28 INFO - ##### 14:57:28 INFO - ##### Running create-virtualenv step. 14:57:28 INFO - ##### 14:57:28 INFO - Running pre-action listener: _resource_record_pre_action 14:57:28 INFO - Running main action method: create_virtualenv 14:57:28 INFO - Creating virtualenv /builds/slave/test/build/venv 14:57:28 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 14:57:28 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 14:57:28 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 14:57:28 INFO - Using real prefix '/usr' 14:57:28 INFO - New python executable in /builds/slave/test/build/venv/bin/python 14:57:29 INFO - Installing distribute.............................................................................................................................................................................................done. 14:57:31 INFO - Installing pip.................done. 14:57:31 INFO - Return code: 0 14:57:31 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 14:57:31 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:57:31 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:57:31 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:57:31 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:57:31 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:57:31 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:57:31 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 0x2351030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24b48a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2580400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x260f570>, '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 0x2610470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2610900>, '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': '0e2a256762fed810e2f0f810000001b3-1468616785.323493-1948727444', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 14:57:31 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 14:57:31 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 14:57:31 INFO - Using env: {'DISPLAY': ':0', 14:57:31 INFO - 'HOME': '/home/cltbld', 14:57:31 INFO - 'LANG': 'en_US.UTF-8', 14:57:31 INFO - 'LANGUAGE': 'en_US:en', 14:57:31 INFO - 'LOGNAME': 'cltbld', 14:57:31 INFO - 'MAIL': '/var/mail/cltbld', 14:57:31 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:57:31 INFO - 'MOZ_NO_REMOTE': '1', 14:57:31 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:57:31 INFO - 'NO_EM_RESTART': '1', 14:57:31 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:57:31 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:57:31 INFO - 'PWD': '/builds/slave/test', 14:57:31 INFO - 'SHELL': '/bin/bash', 14:57:31 INFO - 'SHLVL': '1', 14:57:31 INFO - 'TERM': 'linux', 14:57:31 INFO - 'TMOUT': '86400', 14:57:31 INFO - 'USER': 'cltbld', 14:57:31 INFO - 'XDG_SESSION_COOKIE': '0e2a256762fed810e2f0f810000001b3-1468616785.323493-1948727444', 14:57:31 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:57:31 INFO - '_': '/tools/buildbot/bin/python'} 14:57:31 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:57:31 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 14:57:31 INFO - Cleaning up... 14:57:31 INFO - Return code: 0 14:57:31 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 14:57:31 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:57:31 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:57:31 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:57:31 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:57:31 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:57:31 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:57:31 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 0x2351030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24b48a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2580400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x260f570>, '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 0x2610470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2610900>, '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': '0e2a256762fed810e2f0f810000001b3-1468616785.323493-1948727444', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 14:57:31 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 14:57:31 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 14:57:31 INFO - Using env: {'DISPLAY': ':0', 14:57:31 INFO - 'HOME': '/home/cltbld', 14:57:31 INFO - 'LANG': 'en_US.UTF-8', 14:57:31 INFO - 'LANGUAGE': 'en_US:en', 14:57:31 INFO - 'LOGNAME': 'cltbld', 14:57:31 INFO - 'MAIL': '/var/mail/cltbld', 14:57:31 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:57:31 INFO - 'MOZ_NO_REMOTE': '1', 14:57:31 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:57:31 INFO - 'NO_EM_RESTART': '1', 14:57:31 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:57:31 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:57:31 INFO - 'PWD': '/builds/slave/test', 14:57:31 INFO - 'SHELL': '/bin/bash', 14:57:31 INFO - 'SHLVL': '1', 14:57:31 INFO - 'TERM': 'linux', 14:57:31 INFO - 'TMOUT': '86400', 14:57:31 INFO - 'USER': 'cltbld', 14:57:31 INFO - 'XDG_SESSION_COOKIE': '0e2a256762fed810e2f0f810000001b3-1468616785.323493-1948727444', 14:57:31 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:57:31 INFO - '_': '/tools/buildbot/bin/python'} 14:57:32 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:57:32 INFO - Downloading/unpacking psutil>=3.1.1 14:57:32 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:57:32 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:57:32 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:57:32 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:57:32 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:57:32 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:57:33 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 14:57:34 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 14:57:34 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 14:57:34 INFO - Installing collected packages: psutil 14:57:34 INFO - Running setup.py install for psutil 14:57:34 INFO - building 'psutil._psutil_linux' extension 14:57:34 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -DPSUTIL_VERSION=311 -I/usr/include/python2.7 -c psutil/_psutil_linux.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o 14:57:35 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_linux.so 14:57:36 INFO - building 'psutil._psutil_posix' extension 14:57:36 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -I/usr/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o 14:57:36 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_posix.so 14:57:36 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 14:57:36 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 14:57:36 INFO - Successfully installed psutil 14:57:36 INFO - Cleaning up... 14:57:36 INFO - Return code: 0 14:57:36 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 14:57:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:57:36 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:57:36 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:57:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:57:36 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:57:36 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:57:36 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 0x2351030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24b48a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2580400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x260f570>, '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 0x2610470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2610900>, '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': '0e2a256762fed810e2f0f810000001b3-1468616785.323493-1948727444', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 14:57:36 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 14:57:36 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 14:57:36 INFO - Using env: {'DISPLAY': ':0', 14:57:36 INFO - 'HOME': '/home/cltbld', 14:57:36 INFO - 'LANG': 'en_US.UTF-8', 14:57:36 INFO - 'LANGUAGE': 'en_US:en', 14:57:36 INFO - 'LOGNAME': 'cltbld', 14:57:36 INFO - 'MAIL': '/var/mail/cltbld', 14:57:36 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:57:36 INFO - 'MOZ_NO_REMOTE': '1', 14:57:36 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:57:36 INFO - 'NO_EM_RESTART': '1', 14:57:36 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:57:36 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:57:36 INFO - 'PWD': '/builds/slave/test', 14:57:36 INFO - 'SHELL': '/bin/bash', 14:57:36 INFO - 'SHLVL': '1', 14:57:36 INFO - 'TERM': 'linux', 14:57:36 INFO - 'TMOUT': '86400', 14:57:36 INFO - 'USER': 'cltbld', 14:57:36 INFO - 'XDG_SESSION_COOKIE': '0e2a256762fed810e2f0f810000001b3-1468616785.323493-1948727444', 14:57:36 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:57:36 INFO - '_': '/tools/buildbot/bin/python'} 14:57:36 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:57:36 INFO - Downloading/unpacking mozsystemmonitor==0.3 14:57:36 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:57:36 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:57:36 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:57:36 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:57:36 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:57:36 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:57:38 INFO - Downloading mozsystemmonitor-0.3.tar.gz 14:57:38 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 14:57:38 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 14:57:38 INFO - Installing collected packages: mozsystemmonitor 14:57:38 INFO - Running setup.py install for mozsystemmonitor 14:57:38 INFO - Successfully installed mozsystemmonitor 14:57:38 INFO - Cleaning up... 14:57:38 INFO - Return code: 0 14:57:38 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 14:57:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:57:38 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:57:38 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:57:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:57:38 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:57:38 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:57:38 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x2351030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24b48a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2580400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x260f570>, '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 0x2610470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2610900>, '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': '0e2a256762fed810e2f0f810000001b3-1468616785.323493-1948727444', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 14:57:38 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 14:57:38 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 14:57:38 INFO - Using env: {'DISPLAY': ':0', 14:57:38 INFO - 'HOME': '/home/cltbld', 14:57:38 INFO - 'LANG': 'en_US.UTF-8', 14:57:38 INFO - 'LANGUAGE': 'en_US:en', 14:57:38 INFO - 'LOGNAME': 'cltbld', 14:57:38 INFO - 'MAIL': '/var/mail/cltbld', 14:57:38 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:57:38 INFO - 'MOZ_NO_REMOTE': '1', 14:57:38 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:57:38 INFO - 'NO_EM_RESTART': '1', 14:57:38 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:57:38 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:57:38 INFO - 'PWD': '/builds/slave/test', 14:57:38 INFO - 'SHELL': '/bin/bash', 14:57:38 INFO - 'SHLVL': '1', 14:57:38 INFO - 'TERM': 'linux', 14:57:38 INFO - 'TMOUT': '86400', 14:57:38 INFO - 'USER': 'cltbld', 14:57:38 INFO - 'XDG_SESSION_COOKIE': '0e2a256762fed810e2f0f810000001b3-1468616785.323493-1948727444', 14:57:38 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:57:38 INFO - '_': '/tools/buildbot/bin/python'} 14:57:39 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:57:39 INFO - Downloading/unpacking jsonschema==2.5.1 14:57:39 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:57:39 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:57:39 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:57:39 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:57:39 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:57:39 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:57:41 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 14:57:41 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 14:57:41 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:57:41 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:57:41 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:57:41 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:57:41 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:57:41 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:57:41 INFO - Downloading functools32-3.2.3-2.tar.gz 14:57:41 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 14:57:41 INFO - warning: no files found matching '*.txt' 14:57:41 INFO - no previously-included directories found matching 'build' 14:57:41 INFO - no previously-included directories found matching 'dist' 14:57:41 INFO - no previously-included directories found matching '.git*' 14:57:41 INFO - Installing collected packages: jsonschema, functools32 14:57:41 INFO - Running setup.py install for functools32 14:57:41 INFO - warning: no files found matching '*.txt' 14:57:41 INFO - no previously-included directories found matching 'build' 14:57:41 INFO - no previously-included directories found matching 'dist' 14:57:41 INFO - no previously-included directories found matching '.git*' 14:57:41 INFO - Successfully installed jsonschema functools32 14:57:41 INFO - Cleaning up... 14:57:41 INFO - Return code: 0 14:57:41 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 14:57:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:57:41 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:57:41 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:57:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:57:41 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:57:41 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:57:41 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 0x2351030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24b48a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2580400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x260f570>, '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 0x2610470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2610900>, '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': '0e2a256762fed810e2f0f810000001b3-1468616785.323493-1948727444', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 14:57:41 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 14:57:41 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 14:57:41 INFO - Using env: {'DISPLAY': ':0', 14:57:41 INFO - 'HOME': '/home/cltbld', 14:57:41 INFO - 'LANG': 'en_US.UTF-8', 14:57:41 INFO - 'LANGUAGE': 'en_US:en', 14:57:41 INFO - 'LOGNAME': 'cltbld', 14:57:41 INFO - 'MAIL': '/var/mail/cltbld', 14:57:41 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:57:41 INFO - 'MOZ_NO_REMOTE': '1', 14:57:41 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:57:41 INFO - 'NO_EM_RESTART': '1', 14:57:41 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:57:41 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:57:41 INFO - 'PWD': '/builds/slave/test', 14:57:41 INFO - 'SHELL': '/bin/bash', 14:57:41 INFO - 'SHLVL': '1', 14:57:41 INFO - 'TERM': 'linux', 14:57:41 INFO - 'TMOUT': '86400', 14:57:41 INFO - 'USER': 'cltbld', 14:57:41 INFO - 'XDG_SESSION_COOKIE': '0e2a256762fed810e2f0f810000001b3-1468616785.323493-1948727444', 14:57:41 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:57:41 INFO - '_': '/tools/buildbot/bin/python'} 14:57:41 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:57:41 INFO - Downloading/unpacking blobuploader==1.2.4 14:57:41 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:57:41 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:57:41 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:57:41 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:57:41 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:57:41 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:57:43 INFO - Downloading blobuploader-1.2.4.tar.gz 14:57:43 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 14:57:43 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 14:57:43 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:57:43 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:57:43 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:57:43 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:57:43 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:57:43 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:57:44 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 14:57:44 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 14:57:44 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:57:44 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:57:44 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:57:44 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:57:44 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:57:44 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:57:44 INFO - Downloading docopt-0.6.1.tar.gz 14:57:44 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 14:57:44 INFO - Installing collected packages: blobuploader, requests, docopt 14:57:44 INFO - Running setup.py install for blobuploader 14:57:44 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 14:57:44 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 14:57:44 INFO - Running setup.py install for requests 14:57:44 INFO - Running setup.py install for docopt 14:57:45 INFO - Successfully installed blobuploader requests docopt 14:57:45 INFO - Cleaning up... 14:57:45 INFO - Return code: 0 14:57:45 INFO - Installing None into virtualenv /builds/slave/test/build/venv 14:57:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:57:45 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:57:45 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:57:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:57:45 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:57:45 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:57:45 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 0x2351030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24b48a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2580400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x260f570>, '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 0x2610470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2610900>, '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': '0e2a256762fed810e2f0f810000001b3-1468616785.323493-1948727444', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 14:57:45 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 14:57:45 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 14:57:45 INFO - Using env: {'DISPLAY': ':0', 14:57:45 INFO - 'HOME': '/home/cltbld', 14:57:45 INFO - 'LANG': 'en_US.UTF-8', 14:57:45 INFO - 'LANGUAGE': 'en_US:en', 14:57:45 INFO - 'LOGNAME': 'cltbld', 14:57:45 INFO - 'MAIL': '/var/mail/cltbld', 14:57:45 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:57:45 INFO - 'MOZ_NO_REMOTE': '1', 14:57:45 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:57:45 INFO - 'NO_EM_RESTART': '1', 14:57:45 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:57:45 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:57:45 INFO - 'PWD': '/builds/slave/test', 14:57:45 INFO - 'SHELL': '/bin/bash', 14:57:45 INFO - 'SHLVL': '1', 14:57:45 INFO - 'TERM': 'linux', 14:57:45 INFO - 'TMOUT': '86400', 14:57:45 INFO - 'USER': 'cltbld', 14:57:45 INFO - 'XDG_SESSION_COOKIE': '0e2a256762fed810e2f0f810000001b3-1468616785.323493-1948727444', 14:57:45 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:57:45 INFO - '_': '/tools/buildbot/bin/python'} 14:57:45 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:57:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 14:57:45 INFO - Running setup.py (path:/tmp/pip-CpnQMZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 14:57:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 14:57:45 INFO - Running setup.py (path:/tmp/pip-d98qcm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 14:57:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 14:57:45 INFO - Running setup.py (path:/tmp/pip-piiCai-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 14:57:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 14:57:45 INFO - Running setup.py (path:/tmp/pip-xsdUV3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 14:57:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 14:57:45 INFO - Running setup.py (path:/tmp/pip-MiUbXZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 14:57:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 14:57:45 INFO - Running setup.py (path:/tmp/pip-UiqMaq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 14:57:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 14:57:45 INFO - Running setup.py (path:/tmp/pip-AXslp4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 14:57:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 14:57:45 INFO - Running setup.py (path:/tmp/pip-HIUR9D-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 14:57:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 14:57:45 INFO - Running setup.py (path:/tmp/pip-rvfifJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 14:57:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 14:57:45 INFO - Running setup.py (path:/tmp/pip-9Qu0lM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 14:57:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 14:57:46 INFO - Running setup.py (path:/tmp/pip-T0A4s2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 14:57:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 14:57:46 INFO - Running setup.py (path:/tmp/pip-5SMPwk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 14:57:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 14:57:46 INFO - Running setup.py (path:/tmp/pip-0Nn976-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 14:57:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 14:57:46 INFO - Running setup.py (path:/tmp/pip-PXsziH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 14:57:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 14:57:46 INFO - Running setup.py (path:/tmp/pip-zEPcbH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 14:57:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 14:57:46 INFO - Running setup.py (path:/tmp/pip-Xg91Xm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 14:57:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 14:57:46 INFO - Running setup.py (path:/tmp/pip-u53vZP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 14:57:46 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 14:57:46 INFO - Running setup.py install for manifestparser 14:57:46 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 14:57:46 INFO - Running setup.py install for mozcrash 14:57:46 INFO - Running setup.py install for mozdebug 14:57:46 INFO - Running setup.py install for mozdevice 14:57:46 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 14:57:46 INFO - Installing dm script to /builds/slave/test/build/venv/bin 14:57:46 INFO - Running setup.py install for mozfile 14:57:47 INFO - Running setup.py install for mozhttpd 14:57:47 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 14:57:47 INFO - Running setup.py install for mozinfo 14:57:47 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 14:57:47 INFO - Running setup.py install for mozInstall 14:57:47 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 14:57:47 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 14:57:47 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 14:57:47 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 14:57:47 INFO - Running setup.py install for mozleak 14:57:47 INFO - Running setup.py install for mozlog 14:57:47 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 14:57:47 INFO - Running setup.py install for moznetwork 14:57:47 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 14:57:47 INFO - Running setup.py install for mozprocess 14:57:47 INFO - Running setup.py install for mozprofile 14:57:47 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 14:57:47 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 14:57:47 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 14:57:47 INFO - Running setup.py install for mozrunner 14:57:48 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 14:57:48 INFO - Running setup.py install for mozscreenshot 14:57:48 INFO - Running setup.py install for moztest 14:57:48 INFO - Running setup.py install for mozversion 14:57:48 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 14:57:48 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 14:57:48 INFO - Cleaning up... 14:57:48 INFO - Return code: 0 14:57:48 INFO - Installing None into virtualenv /builds/slave/test/build/venv 14:57:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:57:48 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:57:48 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:57:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:57:48 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:57:48 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:57:48 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 0x2351030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24b48a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2580400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x260f570>, '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 0x2610470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2610900>, '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': '0e2a256762fed810e2f0f810000001b3-1468616785.323493-1948727444', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 14:57:48 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 14:57:48 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 14:57:48 INFO - Using env: {'DISPLAY': ':0', 14:57:48 INFO - 'HOME': '/home/cltbld', 14:57:48 INFO - 'LANG': 'en_US.UTF-8', 14:57:48 INFO - 'LANGUAGE': 'en_US:en', 14:57:48 INFO - 'LOGNAME': 'cltbld', 14:57:48 INFO - 'MAIL': '/var/mail/cltbld', 14:57:48 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:57:48 INFO - 'MOZ_NO_REMOTE': '1', 14:57:48 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:57:48 INFO - 'NO_EM_RESTART': '1', 14:57:48 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:57:48 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:57:48 INFO - 'PWD': '/builds/slave/test', 14:57:48 INFO - 'SHELL': '/bin/bash', 14:57:48 INFO - 'SHLVL': '1', 14:57:48 INFO - 'TERM': 'linux', 14:57:48 INFO - 'TMOUT': '86400', 14:57:48 INFO - 'USER': 'cltbld', 14:57:48 INFO - 'XDG_SESSION_COOKIE': '0e2a256762fed810e2f0f810000001b3-1468616785.323493-1948727444', 14:57:48 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:57:48 INFO - '_': '/tools/buildbot/bin/python'} 14:57:48 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:57:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 14:57:48 INFO - Running setup.py (path:/tmp/pip-B5jHtn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 14:57:48 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 14:57:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 14:57:48 INFO - Running setup.py (path:/tmp/pip-mm7ng7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 14:57:48 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.17 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 14:57:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 14:57:48 INFO - Running setup.py (path:/tmp/pip-zHcRNC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 14:57:48 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 14:57:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 14:57:48 INFO - Running setup.py (path:/tmp/pip-iux4db-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 14:57:48 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.48 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 14:57:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 14:57:48 INFO - Running setup.py (path:/tmp/pip-Tva8Ht-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 14:57:48 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 14:57:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 14:57:48 INFO - Running setup.py (path:/tmp/pip-WSZ2Df-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 14:57:49 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 14:57:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 14:57:49 INFO - Running setup.py (path:/tmp/pip-u3mATl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 14:57:49 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 14:57:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 14:57:49 INFO - Running setup.py (path:/tmp/pip-7k9ywb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 14:57:49 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 14:57:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 14:57:49 INFO - Running setup.py (path:/tmp/pip-u60EgK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 14:57:49 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 14:57:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 14:57:49 INFO - Running setup.py (path:/tmp/pip-HcdjEL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 14:57:49 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.2 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 14:57:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 14:57:49 INFO - Running setup.py (path:/tmp/pip-EdE9pj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 14:57:49 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 14:57:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 14:57:49 INFO - Running setup.py (path:/tmp/pip-d_kxCT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 14:57:49 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.23 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 14:57:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 14:57:49 INFO - Running setup.py (path:/tmp/pip-mTpHXL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 14:57:49 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 14:57:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 14:57:49 INFO - Running setup.py (path:/tmp/pip-vpLxSW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 14:57:49 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.12 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 14:57:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 14:57:49 INFO - Running setup.py (path:/tmp/pip-9lV0FY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 14:57:49 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 14:57:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 14:57:49 INFO - Running setup.py (path:/tmp/pip-EoHHiC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 14:57:49 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 14:57:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 14:57:49 INFO - Running setup.py (path:/tmp/pip-wUF5LM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 14:57:49 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 14:57:49 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 14:57:49 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 14:57:49 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 14:57:49 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 14:57:49 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 14:57:49 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.2->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 14:57:49 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:57:49 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:57:49 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:57:49 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:57:49 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:57:49 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:57:51 INFO - Downloading blessings-1.6.tar.gz 14:57:51 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 14:57:51 INFO - Installing collected packages: blessings 14:57:51 INFO - Running setup.py install for blessings 14:57:51 INFO - Successfully installed blessings 14:57:51 INFO - Cleaning up... 14:57:52 INFO - Return code: 0 14:57:52 INFO - Done creating virtualenv /builds/slave/test/build/venv. 14:57:52 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 14:57:52 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 14:57:52 INFO - Reading from file tmpfile_stdout 14:57:52 INFO - Current package versions: 14:57:52 INFO - argparse == 1.2.1 14:57:52 INFO - blessings == 1.6 14:57:52 INFO - blobuploader == 1.2.4 14:57:52 INFO - docopt == 0.6.1 14:57:52 INFO - functools32 == 3.2.3-2 14:57:52 INFO - jsonschema == 2.5.1 14:57:52 INFO - manifestparser == 1.1 14:57:52 INFO - mozInstall == 1.12 14:57:52 INFO - mozcrash == 0.17 14:57:52 INFO - mozdebug == 0.1 14:57:52 INFO - mozdevice == 0.48 14:57:52 INFO - mozfile == 1.2 14:57:52 INFO - mozhttpd == 0.7 14:57:52 INFO - mozinfo == 0.9 14:57:52 INFO - mozleak == 0.1 14:57:52 INFO - mozlog == 3.2 14:57:52 INFO - moznetwork == 0.27 14:57:52 INFO - mozprocess == 0.23 14:57:52 INFO - mozprofile == 0.28 14:57:52 INFO - mozrunner == 6.12 14:57:52 INFO - mozscreenshot == 0.1 14:57:52 INFO - mozsystemmonitor == 0.3 14:57:52 INFO - moztest == 0.7 14:57:52 INFO - mozversion == 1.4 14:57:52 INFO - psutil == 3.1.1 14:57:52 INFO - requests == 1.2.3 14:57:52 INFO - wsgiref == 0.1.2 14:57:52 INFO - Installing None into virtualenv /builds/slave/test/build/venv 14:57:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:57:52 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:57:52 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:57:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:57:52 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:57:52 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:57:52 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 0x2351030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24b48a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2580400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x260f570>, '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 0x2610470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2610900>, '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': '0e2a256762fed810e2f0f810000001b3-1468616785.323493-1948727444', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 14:57:52 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 14:57:52 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 14:57:52 INFO - Using env: {'DISPLAY': ':0', 14:57:52 INFO - 'HOME': '/home/cltbld', 14:57:52 INFO - 'LANG': 'en_US.UTF-8', 14:57:52 INFO - 'LANGUAGE': 'en_US:en', 14:57:52 INFO - 'LOGNAME': 'cltbld', 14:57:52 INFO - 'MAIL': '/var/mail/cltbld', 14:57:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:57:52 INFO - 'MOZ_NO_REMOTE': '1', 14:57:52 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:57:52 INFO - 'NO_EM_RESTART': '1', 14:57:52 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:57:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:57:52 INFO - 'PWD': '/builds/slave/test', 14:57:52 INFO - 'SHELL': '/bin/bash', 14:57:52 INFO - 'SHLVL': '1', 14:57:52 INFO - 'TERM': 'linux', 14:57:52 INFO - 'TMOUT': '86400', 14:57:52 INFO - 'USER': 'cltbld', 14:57:52 INFO - 'XDG_SESSION_COOKIE': '0e2a256762fed810e2f0f810000001b3-1468616785.323493-1948727444', 14:57:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:57:52 INFO - '_': '/tools/buildbot/bin/python'} 14:57:52 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:57:52 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 14:57:52 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 14:57:52 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 14:57:52 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 14:57:52 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 14:57:52 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 14:57:52 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 14:57:52 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 14:57:52 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 9)) 14:57:52 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 14:57:52 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 14:57:52 INFO - Cleaning up... 14:57:52 INFO - Return code: 0 14:57:52 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 14:57:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:57:52 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:57:52 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:57:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:57:52 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:57:52 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:57:52 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 0x2351030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24b48a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2580400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x260f570>, '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 0x2610470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2610900>, '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': '0e2a256762fed810e2f0f810000001b3-1468616785.323493-1948727444', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 14:57:52 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 14:57:52 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 14:57:52 INFO - Using env: {'DISPLAY': ':0', 14:57:52 INFO - 'HOME': '/home/cltbld', 14:57:52 INFO - 'LANG': 'en_US.UTF-8', 14:57:52 INFO - 'LANGUAGE': 'en_US:en', 14:57:52 INFO - 'LOGNAME': 'cltbld', 14:57:52 INFO - 'MAIL': '/var/mail/cltbld', 14:57:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:57:52 INFO - 'MOZ_NO_REMOTE': '1', 14:57:52 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:57:52 INFO - 'NO_EM_RESTART': '1', 14:57:52 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:57:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:57:52 INFO - 'PWD': '/builds/slave/test', 14:57:52 INFO - 'SHELL': '/bin/bash', 14:57:52 INFO - 'SHLVL': '1', 14:57:52 INFO - 'TERM': 'linux', 14:57:52 INFO - 'TMOUT': '86400', 14:57:52 INFO - 'USER': 'cltbld', 14:57:52 INFO - 'XDG_SESSION_COOKIE': '0e2a256762fed810e2f0f810000001b3-1468616785.323493-1948727444', 14:57:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:57:52 INFO - '_': '/tools/buildbot/bin/python'} 14:57:52 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:57:52 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 14:57:52 INFO - Cleaning up... 14:57:52 INFO - Return code: 0 14:57:52 INFO - Running post-action listener: _resource_record_post_action 14:57:52 INFO - Running post-action listener: _start_resource_monitoring 14:57:52 INFO - Starting resource monitoring. 14:57:52 INFO - ##### 14:57:52 INFO - ##### Finished create-virtualenv step (success) 14:57:52 INFO - ##### 14:57:52 INFO - ##### 14:57:52 INFO - ##### Running install step. 14:57:52 INFO - ##### 14:57:52 INFO - Running pre-action listener: _resource_record_pre_action 14:57:52 INFO - Running main action method: install 14:57:52 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 14:57:52 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 14:57:52 INFO - Reading from file tmpfile_stdout 14:57:52 INFO - Detecting whether we're running mozinstall >=1.0... 14:57:52 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 14:57:52 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 14:57:52 INFO - Reading from file tmpfile_stdout 14:57:52 INFO - Output received: 14:57:52 INFO - Usage: mozinstall [options] installer 14:57:52 INFO - Options: 14:57:52 INFO - -h, --help show this help message and exit 14:57:52 INFO - -d DEST, --destination=DEST 14:57:52 INFO - Directory to install application into. [default: 14:57:52 INFO - "/builds/slave/test"] 14:57:52 INFO - --app=APP Application being installed. [default: firefox] 14:57:52 INFO - mkdir: /builds/slave/test/build/application 14:57:52 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'] 14:57:52 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 14:58:09 INFO - Reading from file tmpfile_stdout 14:58:09 INFO - Output received: 14:58:09 INFO - /builds/slave/test/build/application/firefox/firefox 14:58:09 INFO - Running post-action listener: _resource_record_post_action 14:58:09 INFO - ##### 14:58:09 INFO - ##### Finished install step (success) 14:58:09 INFO - ##### 14:58:09 INFO - ##### 14:58:09 INFO - ##### Running run-tests step. 14:58:09 INFO - ##### 14:58:09 INFO - Running pre-action listener: _resource_record_pre_action 14:58:09 INFO - Running main action method: run_tests 14:58:09 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 14:58:09 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 14:58:09 INFO - Python 2.7.3 14:58:09 INFO - Return code: 0 14:58:09 INFO - grabbing minidump binary from tooltool 14:58: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')]} 14:58:09 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 0x260f570>, '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 0x2610470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2610900>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 14:58:09 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 14:58:09 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest -o -c /builds/tooltool_cache 14:58:09 INFO - Calling ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] with output_timeout 600 14:58:09 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 14:58:09 INFO - Return code: 0 14:58:09 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 14:58:09 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 14:58:09 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 14:58:09 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 14:58:09 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 14:58:09 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-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/AU76KAG0T5yTp1qDGKJ5ZQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-058', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] in /builds/slave/test/build 14:58:09 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-e10s --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/AU76KAG0T5yTp1qDGKJ5ZQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-058 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log 14:58:09 INFO - Using env: {'DISPLAY': ':0', 14:58:09 INFO - 'HOME': '/home/cltbld', 14:58:09 INFO - 'LANG': 'en_US.UTF-8', 14:58:09 INFO - 'LANGUAGE': 'en_US:en', 14:58:09 INFO - 'LOGNAME': 'cltbld', 14:58:09 INFO - 'MAIL': '/var/mail/cltbld', 14:58:09 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 14:58:09 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 14:58:09 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:58:09 INFO - 'MOZ_NO_REMOTE': '1', 14:58:09 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 14:58:09 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:58:09 INFO - 'NO_EM_RESTART': '1', 14:58:09 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:58:09 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:58:09 INFO - 'PWD': '/builds/slave/test', 14:58:09 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 14:58:09 INFO - 'SHELL': '/bin/bash', 14:58:09 INFO - 'SHLVL': '1', 14:58:09 INFO - 'TERM': 'linux', 14:58:09 INFO - 'TMOUT': '86400', 14:58:09 INFO - 'USER': 'cltbld', 14:58:09 INFO - 'XDG_SESSION_COOKIE': '0e2a256762fed810e2f0f810000001b3-1468616785.323493-1948727444', 14:58:09 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:58:09 INFO - '_': '/tools/buildbot/bin/python'} 14:58:09 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-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/AU76KAG0T5yTp1qDGKJ5ZQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-058', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] with output_timeout 3600 14:58:09 INFO - mozversion application_buildid: 20160715141452 14:58:09 INFO - mozversion application_changeset: 3db372da6fe108ddb0727003447f22c2483fb86d 14:58:09 INFO - mozversion application_display_name: Nightly 14:58:09 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 14:58:09 INFO - mozversion application_name: Firefox 14:58:09 INFO - mozversion application_remotingname: firefox 14:58:09 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 14:58:09 INFO - mozversion application_vendor: Mozilla 14:58:09 INFO - mozversion application_version: 50.0a1 14:58:09 INFO - mozversion platform_buildid: 20160715141452 14:58:09 INFO - mozversion platform_changeset: 3db372da6fe108ddb0727003447f22c2483fb86d 14:58:09 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 14:58:09 INFO - mozversion platform_version: 50.0a1 14:58:09 INFO - using testdate: 1468619889 14:58:09 INFO - actual date: 1468619889 14:58:09 INFO - starting webserver on 'localhost:54045' 14:58:09 INFO - SUITE-START | Running 2 tests 14:58:09 INFO - TEST-START | dromaeo_css 14:58:09 INFO - operating with platform_type : linux_ 14:58:09 INFO - Initialising browser for dromaeo_css test... 14:58:09 INFO - TEST-INFO | started process 3295 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpRSWaN7/profile http://localhost:54045/getInfo.html) 14:58:16 INFO - PROCESS | 3295 | __metrics Screen width/height:1600/1200 14:58:16 INFO - PROCESS | 3295 | colorDepth:24 14:58:16 INFO - PROCESS | 3295 | Browser inner width/height: 1024/697 14:58:16 INFO - PROCESS | 3295 | __metrics 14:58:16 ERROR - PROCESS | 3295 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2964: TypeError: this.tabs is undefined 14:58:19 INFO - TEST-INFO | 3295: exit 0 14:58:19 INFO - Browser initialized. 14:58:19 INFO - Running cycle 1/1 for dromaeo_css test... 14:58:19 INFO - TEST-INFO | started process 3419 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpRSWaN7/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 14:58:31 INFO - PROCESS | 3419 | RSS: Main: 169230336 14:58:31 INFO - PROCESS | 3419 | 14:59:21 INFO - PROCESS | 3419 | 1468619961029 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] 15:01:33 INFO - PROCESS | 3419 | Cycle 1(1): loaded http://localhost:54045/tests/dromaeo/cssquery-dojo.html (next: http://localhost:54045/tests/dromaeo/cssquery-ext.html) 15:01:34 INFO - PROCESS | 3419 | RSS: Main: 173309952 15:01:34 INFO - PROCESS | 3419 | 15:04:37 INFO - PROCESS | 3419 | Cycle 1(1): loaded http://localhost:54045/tests/dromaeo/cssquery-ext.html (next: http://localhost:54045/tests/dromaeo/cssquery-jquery.html) 15:04:37 INFO - PROCESS | 3419 | RSS: Main: 168853504 15:04:37 INFO - PROCESS | 3419 | 15:07:39 INFO - PROCESS | 3419 | Cycle 1(1): loaded http://localhost:54045/tests/dromaeo/cssquery-jquery.html (next: http://localhost:54045/tests/dromaeo/cssquery-mootools.html) 15:07:40 INFO - PROCESS | 3419 | RSS: Main: 172703744 15:07:40 INFO - PROCESS | 3419 | 15:10:42 INFO - PROCESS | 3419 | Cycle 1(1): loaded http://localhost:54045/tests/dromaeo/cssquery-mootools.html (next: http://localhost:54045/tests/dromaeo/cssquery-prototype.html) 15:10:43 INFO - PROCESS | 3419 | RSS: Main: 167362560 15:10:43 INFO - PROCESS | 3419 | 15:13:45 INFO - PROCESS | 3419 | Cycle 1(1): loaded http://localhost:54045/tests/dromaeo/cssquery-prototype.html (next: http://localhost:54045/tests/dromaeo/cssquery-yui.html) 15:13:46 INFO - PROCESS | 3419 | RSS: Main: 169107456 15:13:46 INFO - PROCESS | 3419 | 15:16:49 INFO - PROCESS | 3419 | Cycle 1(1): loaded http://localhost:54045/tests/dromaeo/cssquery-yui.html (next: http://localhost:54045/tests/dromaeo/cssquery-dojo.html) 15:16:49 INFO - PROCESS | 3419 | RSS: Main: 170504192 15:16:49 INFO - PROCESS | 3419 | 15:16:49 INFO - PROCESS | 3419 | __start_tp_report 15:16:49 INFO - PROCESS | 3419 | _x_x_mozilla_page_load 15:16:49 INFO - PROCESS | 3419 | _x_x_mozilla_page_load_details 15:16:49 INFO - PROCESS | 3419 | |i|pagename|runs| 15:16:49 INFO - PROCESS | 3419 | |0;dojo.html;2622.3968487247935;2637.749413805689;2674.893004279829;2677.183459044993;2690.381212321166;4771.498992605779;4805.591524720398;4830.855074347766;4856.732879691615;4907.82822601209;4720.315554244632;4784.880377990552;4815.590674792638;4841.4190297164305;4858.757062146888;4434.756088415136;4479.193745125876;4500.504944456107;4534.659900507459;4538.795754191053;4397.208502469554;4440.777961101948;4465.330200469923;4489.775511224442;4496.213162696531;4458.2866741321395;4536.72779633223;4555.7949892254765;4562.1560011398;4612.769361531927;4419.182451246497;4454.443194600675;4497.10057988402;4500.4149460569915;4502.077074199781;4413.801378937956;4426.269665505188;4442.4669039715445;4478.888027799331;4484.910301793946;4760.119377915063;4783.1868582341085;4803.591694705954;4818.566329030404;4848.587870031051;4993.650444468889;5059;5065.772040258161;5172.19830926207;5182.792688292501;5105.744712764347;5119;5122.1804511278015;5145.331106956071;5179.637425380225;4823.589994850442;4883.706977581321;4910.459849416561;4912.975435122873;4942.950570494321;5228.869278267997;5263.578913686896;5360.758765855546;5370.2750128732905;5371.973140134274;5084.542391184737;5086.465921078234;5091.1090559152;5095.15929871567;5152.252923326172;5166.405863325691;5179.48205179479;5181.248718935733;5207.0887594670785;5210.114280572312;5008.974955125201;5115.104856650146;5122.923156152586;5144.331236939174;5153.304303918998;5125.769340379692;5148.536631703165;5153.561947234527;5158;5167.379914410295;4051.6556092731857;4066.410370496321;4072.3484242521054;4073.124278280184;4076.103257283393;3422.212891035026;3509.964900350964;3546.024843168098;3553.875614353537;3559.6796288334176;4460.799264033127;4491.8203271869415;4495.730256184639;4506.639468842484;4558.726476411426;5026.447090820006;5208.062548741263;5212.061828870764;5234.895302093937;5242.13504771716;4430.091831174602;4473.843415480507;4484.730916145042;4501.279795232747;4517.435320584927;4635.6986795858165;4650.581447669726;4669.533046695304;4698.110661942949;4698.624110071186;4706.411698537683;4870.220764677634;4930.654854160246;4934.777934993006;4943.678660887031;5204.271402003798;5215.921761173509;5230.973845130902;5245.449227831175;5289.021531016774;4904.632152588499;4909.77905994224;4910.361652985089;4926.901461970669;4956.900861982812;4930.186519224431;5011.523905228997;5054.949450505448;5147.871303217449;5162.922556161586;5121.718305493085;5133.56364708989;5134.358205224347;5139.331886854685;5167.509086636764;4992.522147857791;5003.949960500494;5004.224345226496;5005.749712514287;5044.4451110377095;4873.122837889072;4984.875378115431;4990.301357809837;4990.50094990498;5040.596752259884;4800.135975524439;4898.902021959612;4948.331975183304;4956.8760780980765;4997.800087996439;5101.107306221322;5129.204973229155;5131.332926719502;5132.948670513247;5168.689878607295;4733.36099626546;4861.781219845187;4895.877603059952;5016.59867210615;5030.170021946338 15:16:49 INFO - PROCESS | 3419 | |1;ext.html;556.8858384031277;557.5177471487164;566.6345207341267;569.4647031790117;581.8429024163473;36630.633693663054;39949.40075898864;40020.59979400205;40058.198836023264;40135.59864401355;40415.79792101035;40980.180396392054;41014.179716405655;41056.58943410565;41077.794611026904;7762.45662803604;7883.290503854652;7889.289963903248;7899.091604465474;7924.08872979609;7796.922030779676;7825.100113486937;7852.882206766903;7876.054873415198;7882.448228623999;7828.491148075385;7835.451518393715;7902.841943161134;7922.128565857751;7927.762167134995;7833.41249406294;7862.292393684567;7870.842583148334;7871.606419678993;7910.80222994424;7644.120926093515;7679.6928122875015;7710.730124445618;7728.6908523658985;7753.728619498291;39133;39343.40984885229;39367.803160984295;39377.80311098455;39390.40914386258;2825.788065895066;2896.782741294411;3083.6762139975203;3132.592762940826;3166.4617015107488;29285.26786830325;29463;29507.55738663922;29743.40513189724;29902.252443688863;3423.8116903570294;3512.8594856205723;3538.486919396673;3541.6812486876047;3553.200529880782;259527;261429.69285153644;262006;262381;263139;52574.47425525772;53338.73330633322;53340;53342;53403;32949.67050329466;33950.49074263888;34319.14202144966;35474;35510.82244588812;15377;15557.533274001798;15667.84332156664;15681.137537435323;15754.212289385485;11360.772784544262;11502.424878756028;11521.654350369334;11584.189106762446;11598.536058557564;18578.163982620816;18601;18621.44135675932;18650.813491865178;18679;6746.763863264762;6872.175338959357;6951.513394062468;7084.468664850054;7116.92883071173;744.133084956031;811.15234579863;837.8324335132997;847.8855354527183;881.3566096749408;27473.587896181172;28072.157835264974;28490.85754571214;28990.42019159605;29032.274193144916;906.4153620914605;925.5048549026238;926.1757036237753;927.6335847340263;951.833429149896;14681.48614798477;14852.480163194236;14971.343134811861;15034.293827111007;15308.617284567976;401907;405418;406028;406206;406272;51273.23090153651;51810.74094629578;51817.7409112952;51971.22043169355;52033.73983130136;1221.9022478201723;1224.577520755338;1231.846019247594;1236.5610208376077;1241.85097788266;26732.465350692488;27125.350715884193;27820.992320852867;27991.860040699667;28169.43661126725;44372.55627443813;44697.55302446934;44705;44831.32753008642;44858.55141448544;273979;274565;274963;275550;276481.32315368863;25542.616860747476;25614.743852561234;25839.224823255332;25974.87012564925;25982.480350393264;42373.576264238196;42848.57151428446;43685.344719828594;44095.55904441043;49350;36307;37700.81149594235;37863.62136378601;39430;41203.7939810299;37994.620053800216;38517.80741096276;39036;39433.605663942995;39662.2067558653;30665.693343067178;35212.29575408426;35786.284274313846;36242.55695708904;36378.45432318465;32857;33746.70725428768;34860.47709284312;34878.476822848184;34951.82524087363;25763.871180643975;25862.612060818727;25931.611025835005;26049.609255861556;26233.868830655723 15:16:49 INFO - PROCESS | 3419 | |2;jquery.html;376.576351604445;378.19633279281527;380.391373801917;386.31043587196825;396;16123.528069601092;17135.74296385555;17882.910585447087;18090.63818723628;18406.44780656579;17186.570335741613;17304.480865574053;17994.550136246602;18012.81987180128;18083.72874406885;5085.262636917645;5225.608079394042;5248.475152484759;5265.736713164346;5271.077561426754;3701.7223708221854;5774.769009239625;6060.3939606039485;6069.78755743549;6169.074638804171;5094.974525127369;6046.54650901182;6075.058365953284;6092.756289748427;6097.908531372033;5337.866553336159;5412.810551630674;5441.29263195784;5445.564354851603;5456.236126942231;5215.243789650517;5264.815731449381;5269.314989051399;5279.841604751864;5296.735163241861;13206.075574709774;13291.468341266338;13329.800052999213;16241.51275461738;20492.795072049237;1772.521419216817;1836.137015602678;1869.2990128701738;2148.1836901977304;2455.9508809823883;8846.203841654282;9363.110504502061;9452.763680907963;9477.241820654332;9728.708138755848;1624.2284914665559;1677.6141487457953;1738.9217485213196;1767.9116044197867;1771.2914834066348;65335;67237;69303.65348173278;70019;70791.64604176997;10054.69835904924;10094.49527523621;10097.091261786474;10118.645847395306;10259.076683098558;13761.31193440324;13804.861951380357;13835.03154779176;13848.930755346159;13873.09824861401;7292.161401438796;7460.776176714708;7487.438442116863;7572.4699271050495;7574.962125189339;7046.61243631595;7058.788236352918;7074.893876591856;7237;7238.059052323164;4217.472815898012;4219.641330486882;4235.428217190702;4263.744175349489;4304.321314687274;1674.8660107191395;1689.3327135781296;1792.7400526923523;1817.2549254805467;1839.9908000459911;826.615623734954;864.6411739128317;887.5828360670474;911.7355966769562;912.7682815516132;16712.201505396955;16730.58173545671;16789.916050419914;16999.23503442348;17124;858.5020688000944;869.2784988459564;875.8160786234962;886.472548833443;940.5250348573926;9154;9531;9550.235981121494;9636.614535418505;9654.469004204837;369590;375955;376401;377721;378796;79765.60117199493;80698;80777.59611202024;81026;82623.17376826276;870.1994165367877;881.7398867334152;888.7244954064131;892.1747383670079;892.3931726425963;14393.712125757216;14904.254787260377;14924.62688432798;14943.701125977637;15164.772528412303;35452.822735886155;35926.820365898006;37051.629483705896;37726.02098490647;37922.62077379301;47101.52898471108;48973.2654010183;50038;50064.749676251384;50617.49382506275;7219.0976127984;7402.703891844266;7427.183009868802;7468.215837337001;7679.462437629312;8747.60635771379;11707.590234342098;11782.82325765097;11835.881641183478;12154.149209555246;9927.950360248153;10399.896001039893;10610.469476526298;11168.888311117109;11278.718032049264;9271.30465215098;9493;11037.448127593427;11041.613543525938;11137.109031277316;10093.243006774668;10116.84824727615;10550.208734344802;10647.148228141885;10656.84014739795;7168.820779480555;7369.415575651261;7380.852382952418;7385.556866588022;7624.466287359832;7381.077365329334;8949.507777072324;10000.799984000134;10248.692539223835;10277.434741089312 15:16:49 INFO - PROCESS | 3419 | |3;mootools.html;1389.506725112585;1425.287356321839;1519.217602934489;1702.855257303129;1742.686316463037;6981.860362792741;7415.1843297237265;7864.764057078282;8125.2687258146825;8144.918550814497;7784.221577842213;8065.3144482719035;8147;8203.097659257477;8227.300679442254;2138.7861213878605;2180.3132013415725;2188.420068681801;2192.967105493419;2193.144673577306;2136.220279597951;2177.0203408466255;2183.1049269799387;2188.6498160294354;2190.200576789476;2150.354893531942;2155.137944822076;2157.3635777445693;2164.2316977473006;2190.9561808763815;2108.68369744538;2112.112912576714;2118.555103428282;2121.469632591852;2122.554263604645;2026.847986401011;2100.873947563136;2113.408245691209;2117.57648470305;2122.57548490301;8060.193980601893;8137.552434616094;8143.633536490872;8151.225633564802;8205;4539.0694907543875;4684.625229981593;4690.390249267608;4692.507286734912;4700.224462963607;2767.875445604953;2869.153599688097;2870.583765354012;2903.8693258803405;2950.867210975511;861.6854847980442;883.4478450968145;900.7658008917663;901.9684311049082;923.672096405773;11048.668539943814;11157.66527004191;11183.105351571936;11214.383208923506;11244.325340479516;4086.346184610448;4128.649064829463;4303.827846886152;4318;4326.480822301344;9409.905900940903;9434.90565094354;9490.430574165572;9495.05049495045;9503.477308748084;4709.058188362341;4718.95281047192;4734.455537613149;4735.171345014609;4739.289106634033;3659.2864391443945;4209.2633789086785;4264.786760661955;4321.7406955582765;4356.607905288539;3657.798821064867;3705.9073523161596;3740.1023754299317;3775.301569209705;3780.4140358244517;1188;1210.4371467267763;1218.8842060004285;1241.3172754984903;1256.0705078242036;764.4419573711222;766.8734658781239;787.263908245792;804.5373910001772;806.6007326373366;4962;5232.607554433433;5304.177852432879;5412.161115027177;5419.0245755764345;372.4431974198536;387.33378588827173;390.1183325683975;402.28995822373537;410.07323449004866;3359.9328013439595;3382.9492557611657;3422.982885085559;3430.3482338355634;3566.946495802565;9726.95136524327;9820.508974551243;9910.405375677483;9920.454375009444;10148.644797432054;9771.413715177112;9821.852672209923;9833.459159746282;9837.360571562825;9887.45618990948;7260.636968151572;7295.051643286445;7450.552966822008;7551.320381165611;7575.204603516661;5220.504052115195;5256.868578285574;5296.894062118813;5349.893002140013;5427.674339539641;9312.44125352481;9344.766380840534;9361.251099912128;9362.344635875696;9399.154076133182;8767.386282960131;9196.08039196075;9207.67773127964;9365.344425890122;9504.904950950402;6209.441150296495;6726.764563240263;6929.826754331182;6974.442044636518;7130.928690713026;7531.322181003736;7553.018107645971;7591.696332146652;7597.2022937592965;7647.541147531166;6840.41856442208;6911.3779759821855;6960.721571137098;6994.510384273256;7034.1910680270375;6867.553609015398;6912.758053468105;6967.616781076887;7139.928600713926;7177.569345839266;5930.911036334544;6092.964196086587;6116.724747386467;6270.592411493239;6338.651374174465;4504.346869703809;4551.431071116111;4575.565321294472;4627.490975992706;4664.416947881515;4589.357489951342;4602.4937256902385;4628.305754136906;4646.721196728207;4797.64017698681 15:16:49 INFO - PROCESS | 3419 | |4;prototype.html;284.268009874573;291.3982625877563;295.97336239738416;299.97150270724273;301.73748838510494;4914.803407863681;4928.063667903096;5068.898622027562;5152.355955505562;5167.689938603687;4986.426560945483;5024.572911302544;5025.924611130836;5051.191809310511;5056.140456122459;3962.385830196324;3981.9999999999927;3982.780947047911;3987.8205480753436;4007.5792041835625;3879.9030024249337;3904.2777086238993;3993.9201215975663;3995.8601448949294;4011.799410029487;3888.4556162137183;3888.530782952817;3893;3898.629630185128;3903.3754599264125;3902.492675952122;3905.1213476967596;3911.941320880189;3912.2371137628174;3917.7061720370803;3243.4161850866835;3356.882509112194;3368.444206705891;3371.5954085509898;3467.618561958208;4897.1674815281485;4911.582515486152;4924.655274130812;4936.827211047632;4957.925631115536;4435.711678740904;4435.713643043514;4444.28894875472;4462.464504259509;4469.374287599739;5073.746312684388;5218.712970786605;5218.8695282617855;5292.153255479105;5304.817109734167;3633.5276414066266;3654.250878569887;3664.2121943782213;3683.778973261613;3689;5551.333839939192;5556.277683901067;5581.386047534768;5583.8604034899045;5590.720463976825;3702.796346200931;3776.490173826553;3803.1823158021157;3807.961920380816;3814.9618503815163;3801.5438147422487;3823.751456155341;3833.3674943633987;3841.9039524012123;3859.96140038596;4397.626201772885;4413.16149931512;4432.867013989586;4437.822487100544;4444.28891377378;5153.768080436389;5282.683039017671;5317.9202311965355;5331.893362132736;5336.4129945705945;1295.8920123294447;1319.9340032998311;1320.947162113524;1321.200673592482;1325.4896864707157;821.6549049399266;822.2722890242179;834.2825170353491;843.502333623153;849.0999540487103;4101.764538326619;4110.848962290504;4130.822715526061;4143.958560414358;4152.833886644561;4771.904561908743;4772.880677983008;4774.236122220428;4824.879378015507;4838.806387784046;4152.1280531088205;4161.667066634662;4170.4995400552125;4171.97914010428;4184.979075104666;2501.8359119361985;2515.6352328912203;2563.8077144214258;2571.7942564594787;2578.200757765099;4550.681452298373;4556.270996640522;4564.2240819060835;4578.221702310615;4608.28571571407;4921.375945937832;4928.901421971541;4932.950670493321;4972.825951091694;5006.249062640633;4557.589816916494;4760.309755085494;5149.716765577854;5169.948300516947;5226.294450249244;5451.400345961862;5511.559075274049;5518.558515318685;5533.335999680065;5540.86147846291;5161.277421161116;5340.890348312472;5370.489803468664;5402.837914862561;5428.45715428454;5125.384953805567;5131.717755523482;5140.742962851918;5163.328767260232;5200.817971371135;3553.307105114478;3658.560972683295;3771.151490914522;3810.695144388387;3813.275477659236;5400.783968641211;5427.99582077317;5443.156310771837;5451.236826844324;5499.50504454601;5266.499682530153;5294.576433885203;5304.681719096867;5304.708241046779;5360.410354860885;5233.162693968947;5247.291615631993;5279.340082489689;5319.38827034896;5328.813491527933;5163.715995620127;5183;5196.818111366084;5219.243209734491;5230.790768369223;5110.61670374716;5283.682979021117;5286.074936886106;5302.602304827076;5307.230451584576;5178.585713142864;5180.922286165635;5188.22176673502;5188.948110518997;5190.766415511235 15:16:49 INFO - PROCESS | 3419 | |5;yui.html;671.5265737654954;693.3290769246117;714.1323292199976;718.403724908326;727.2763600217783;11860.347680877549;12645.241285522876;12729.42717577709;12756.936215318921;14140.929295353535;13456.865431345683;13471.326433678301;14044;14062.929685351584;14064.859351406483;625.1435533319359;764.1823249123427;785.3246208260891;790.4308897593723;790.9920900791004;761.9903627693328;789.5341748368461;795.4988357334871;795.932345750612;796.0010187215066;827.6523859978823;833.170994860115;834.6285902773268;834.9415540912139;835.5655059369125;820.7578764264497;826.9462484938459;830.2693629605939;832.0930186097153;832.4381042796118;603.1074010464537;603.6197195766683;604.4227762486814;604.5647134063468;605.6245128020655;13813.309334533233;13819.101758385672;13825.446982120704;13844.169349839041;13858.653533661638;13581.524646637321;13959.720805583831;13993.580192594136;14076.366563504564;14081.366338514688;10445.68662940113;10482;10626.203034772423;10663.786724265472;10685.252032357737;3352.1619595101224;3352.6814952579466;3370.96629033709;3374.6287908330064;3429.5198672185916;61755.38244617586;62030.37969620291;62124.06813897795;62259.37740622627;63593;10720;10724.195685323632;10756.247062705535;10762.892371076188;10925.890741092646;19094.2362305509;19263.614727705648;19301.4209573713;19486;19532.51168720765;6986.301369863075;7133.215346311901;7133.89299160513;7148.892766608505;7171.748988785367;3717.3308804414924;3826.253880493277;3871.96128038716;3873.7288389812443;3882.7864467453996;2862.4990626640256;2957.7633789296806;2962.2890506278336;2962.8370439625596;2970.4653162430536;507.3911306432296;508.3442359356389;513.3275409213942;518.7795187045491;525.8212207849273;603.7645318325856;604.8639056212405;639.3478651775164;640.7244884699624;643.9098526206335;8365.874511882326;8403.369747268856;8411.948506436695;8576.485410875368;8807.603657835412;499.9025190087898;532.6165161084014;542.2544001997254;551.37969783993;553.5516231852132;3903.531576210816;4038.495188101487;4058.2492238935893;4081.346984482528;4273.786310684453;57359.426405736245;63627;96577;105331.4733426328;105722;50201.49798502041;88127.55936220278;89151;89865;91763;45990.540094599295;78834;80609.59695201486;82613.58693206495;82886.17113828784;7361.668724907285;7479.17729049815;7619.504732192389;7685.346745526693;7771.650275737492;48206.5179348202;48829.2675609859;49242;49391.506084938694;50426.495735043645;52273.47726522686;52834.47165528449;53446.46553534415;60102.39897600968;62017.829375971625;11210.103191744804;11226.326420414802;11298.548058077586;11321.094312455149;11359.54561817518;12853;12993.220406775623;13093.476260949836;13229.140105893086;13306.268155251168;10922.781544369227;10988.230823842254;11154.609588664358;11230.438478075901;11269.436528173723;11099.667009989713;11154.55381784752;11604.535818567501;11833.089690424255;12046.638600841989;11647.12646551529;11693.649190524298;11880.76238475243;12041.879581204075;12497;9682.322237443594;9829.725200075414;9964.302498825302;9990.950045249727;10175.491225438847;9750.414975101517;10350.275480716578;10350.844737328796;10364.740881478023;10403.479826008821 15:16:49 INFO - PROCESS | 3419 | __end_tp_report 15:16:49 INFO - PROCESS | 3419 | __start_cc_report 15:16:49 INFO - PROCESS | 3419 | _x_x_mozilla_cycle_collect,396 15:16:49 INFO - PROCESS | 3419 | __end_cc_report 15:16:49 INFO - PROCESS | 3419 | __startTimestamp1468621009455__endTimestamp 15:16:49 INFO - PROCESS | 3419 | 15:16:49 INFO - PROCESS | 3419 | ------- Summary: start ------- 15:16:49 INFO - PROCESS | 3419 | Number of tests: 6 15:16:49 INFO - PROCESS | 3419 | 15:16:49 INFO - PROCESS | 3419 | [#0] dojo.html Cycles:165 Average:4761.48 Median:4910.36 stddev:529.25 (10.8%) stddev-sans-first:503.56 15:16:49 INFO - PROCESS | 3419 | Values: 2622.4 2637.7 2674.9 2677.2 2690.4 4771.5 4805.6 4830.9 4856.7 4907.8 4720.3 4784.9 4815.6 4841.4 4858.8 4434.8 4479.2 4500.5 4534.7 4538.8 4397.2 4440.8 4465.3 4489.8 4496.2 4458.3 4536.7 4555.8 4562.2 4612.8 4419.2 4454.4 4497.1 4500.4 4502.1 4413.8 4426.3 4442.5 4478.9 4484.9 4760.1 4783.2 4803.6 4818.6 4848.6 4993.7 5059.0 5065.8 5172.2 5182.8 5105.7 5119.0 5122.2 5145.3 5179.6 4823.6 4883.7 4910.5 4913.0 4943.0 5228.9 5263.6 5360.8 5370.3 5372.0 5084.5 5086.5 5091.1 5095.2 5152.3 5166.4 5179.5 5181.2 5207.1 5210.1 5009.0 5115.1 5122.9 5144.3 5153.3 5125.8 5148.5 5153.6 5158.0 5167.4 4051.7 4066.4 4072.3 4073.1 4076.1 3422.2 3510.0 3546.0 3553.9 3559.7 4460.8 4491.8 4495.7 4506.6 4558.7 5026.4 5208.1 5212.1 5234.9 5242.1 4430.1 4473.8 4484.7 4501.3 4517.4 4635.7 4650.6 4669.5 4698.1 4698.6 4706.4 4870.2 4930.7 4934.8 4943.7 5204.3 5215.9 5231.0 5245.4 5289.0 4904.6 4909.8 4910.4 4926.9 4956.9 4930.2 5011.5 5054.9 5147.9 5162.9 5121.7 5133.6 5134.4 5139.3 5167.5 4992.5 5003.9 5004.2 5005.7 5044.4 4873.1 4984.9 4990.3 4990.5 5040.6 4800.1 4898.9 4948.3 4956.9 4997.8 5101.1 5129.2 5131.3 5132.9 5168.7 4733.4 4861.8 4895.9 5016.6 5030.2 15:16:49 INFO - PROCESS | 3419 | 15:16:49 INFO - PROCESS | 3419 | [#1] ext.html Cycles:180 Average:46970.61 Median:38776.90 stddev:84375.01 (217.6%) stddev-sans-first:84539.74 15:16:49 INFO - PROCESS | 3419 | Values: 556.9 557.5 566.6 569.5 581.8 36630.6 39949.4 40020.6 40058.2 40135.6 40415.8 40980.2 41014.2 41056.6 41077.8 7762.5 7883.3 7889.3 7899.1 7924.1 7796.9 7825.1 7852.9 7876.1 7882.4 7828.5 7835.5 7902.8 7922.1 7927.8 7833.4 7862.3 7870.8 7871.6 7910.8 7644.1 7679.7 7710.7 7728.7 7753.7 39133.0 39343.4 39367.8 39377.8 39390.4 2825.8 2896.8 3083.7 3132.6 3166.5 29285.3 29463.0 29507.6 29743.4 29902.3 3423.8 3512.9 3538.5 3541.7 3553.2 259527.0 261429.7 262006.0 262381.0 263139.0 52574.5 53338.7 53340.0 53342.0 53403.0 32949.7 33950.5 34319.1 35474.0 35510.8 15377.0 15557.5 15667.8 15681.1 15754.2 11360.8 11502.4 11521.7 11584.2 11598.5 18578.2 18601.0 18621.4 18650.8 18679.0 6746.8 6872.2 6951.5 7084.5 7116.9 744.1 811.2 837.8 847.9 881.4 27473.6 28072.2 28490.9 28990.4 29032.3 906.4 925.5 926.2 927.6 951.8 14681.5 14852.5 14971.3 15034.3 15308.6 401907.0 405418.0 406028.0 406206.0 406272.0 51273.2 51810.7 51817.7 51971.2 52033.7 1221.9 1224.6 1231.8 1236.6 1241.9 26732.5 27125.4 27821.0 27991.9 28169.4 44372.6 44697.6 44705.0 44831.3 44858.6 273979.0 274565.0 274963.0 275550.0 276481.3 25542.6 25614.7 25839.2 25974.9 25982.5 42373.6 42848.6 43685.3 44095.6 49350.0 36307.0 37700.8 37863.6 39430.0 41203.8 37994.6 38517.8 39036.0 39433.6 39662.2 30665.7 35212.3 35786.3 36242.6 36378.5 32857.0 33746.7 34860.5 34878.5 34951.8 25763.9 25862.6 25931.6 26049.6 26233.9 15:16:49 INFO - PROCESS | 3419 | 15:16:49 INFO - PROCESS | 3419 | [#2] jquery.html Cycles:180 Average:23837.80 Median:48037.40 stddev:62208.30 (129.5%) stddev-sans-first:62357.87 15:16:49 INFO - PROCESS | 3419 | Values: 376.6 378.2 380.4 386.3 396.0 16123.5 17135.7 17882.9 18090.6 18406.4 17186.6 17304.5 17994.6 18012.8 18083.7 5085.3 5225.6 5248.5 5265.7 5271.1 3701.7 5774.8 6060.4 6069.8 6169.1 5095.0 6046.5 6075.1 6092.8 6097.9 5337.9 5412.8 5441.3 5445.6 5456.2 5215.2 5264.8 5269.3 5279.8 5296.7 13206.1 13291.5 13329.8 16241.5 20492.8 1772.5 1836.1 1869.3 2148.2 2456.0 8846.2 9363.1 9452.8 9477.2 9728.7 1624.2 1677.6 1738.9 1767.9 1771.3 65335.0 67237.0 69303.7 70019.0 70791.6 10054.7 10094.5 10097.1 10118.6 10259.1 13761.3 13804.9 13835.0 13848.9 13873.1 7292.2 7460.8 7487.4 7572.5 7575.0 7046.6 7058.8 7074.9 7237.0 7238.1 4217.5 4219.6 4235.4 4263.7 4304.3 1674.9 1689.3 1792.7 1817.3 1840.0 826.6 864.6 887.6 911.7 912.8 16712.2 16730.6 16789.9 16999.2 17124.0 858.5 869.3 875.8 886.5 940.5 9154.0 9531.0 9550.2 9636.6 9654.5 369590.0 375955.0 376401.0 377721.0 378796.0 79765.6 80698.0 80777.6 81026.0 82623.2 870.2 881.7 888.7 892.2 892.4 14393.7 14904.3 14924.6 14943.7 15164.8 35452.8 35926.8 37051.6 37726.0 37922.6 47101.5 48973.3 50038.0 50064.7 50617.5 7219.1 7402.7 7427.2 7468.2 7679.5 8747.6 11707.6 11782.8 11835.9 12154.1 9928.0 10399.9 10610.5 11168.9 11278.7 9271.3 9493.0 11037.4 11041.6 11137.1 10093.2 10116.8 10550.2 10647.1 10656.8 7168.8 7369.4 7380.9 7385.6 7624.5 7381.1 8949.5 10000.8 10248.7 10277.4 15:16:49 INFO - PROCESS | 3419 | 15:16:49 INFO - PROCESS | 3419 | [#3] mootools.html Cycles:180 Average:5222.24 Median:4879.82 stddev:3016.91 (61.8%) stddev-sans-first:3011.63 15:16:49 INFO - PROCESS | 3419 | Values: 1389.5 1425.3 1519.2 1702.9 1742.7 6981.9 7415.2 7864.8 8125.3 8144.9 7784.2 8065.3 8147.0 8203.1 8227.3 2138.8 2180.3 2188.4 2193.0 2193.1 2136.2 2177.0 2183.1 2188.6 2190.2 2150.4 2155.1 2157.4 2164.2 2191.0 2108.7 2112.1 2118.6 2121.5 2122.6 2026.8 2100.9 2113.4 2117.6 2122.6 8060.2 8137.6 8143.6 8151.2 8205.0 4539.1 4684.6 4690.4 4692.5 4700.2 2767.9 2869.2 2870.6 2903.9 2950.9 861.7 883.4 900.8 902.0 923.7 11048.7 11157.7 11183.1 11214.4 11244.3 4086.3 4128.6 4303.8 4318.0 4326.5 9409.9 9434.9 9490.4 9495.1 9503.5 4709.1 4719.0 4734.5 4735.2 4739.3 3659.3 4209.3 4264.8 4321.7 4356.6 3657.8 3705.9 3740.1 3775.3 3780.4 1188.0 1210.4 1218.9 1241.3 1256.1 764.4 766.9 787.3 804.5 806.6 4962.0 5232.6 5304.2 5412.2 5419.0 372.4 387.3 390.1 402.3 410.1 3359.9 3382.9 3423.0 3430.3 3566.9 9727.0 9820.5 9910.4 9920.5 10148.6 9771.4 9821.9 9833.5 9837.4 9887.5 7260.6 7295.1 7450.6 7551.3 7575.2 5220.5 5256.9 5296.9 5349.9 5427.7 9312.4 9344.8 9361.3 9362.3 9399.2 8767.4 9196.1 9207.7 9365.3 9504.9 6209.4 6726.8 6929.8 6974.4 7130.9 7531.3 7553.0 7591.7 7597.2 7647.5 6840.4 6911.4 6960.7 6994.5 7034.2 6867.6 6912.8 6967.6 7139.9 7177.6 5930.9 6093.0 6116.7 6270.6 6338.7 4504.3 4551.4 4575.6 4627.5 4664.4 4589.4 4602.5 4628.3 4646.7 4797.6 15:16:49 INFO - PROCESS | 3419 | 15:16:49 INFO - PROCESS | 3419 | [#4] prototype.html Cycles:180 Average:4286.72 Median:4831.84 stddev:1273.70 (26.4%) stddev-sans-first:1241.34 15:16:49 INFO - PROCESS | 3419 | Values: 284.3 291.4 296.0 300.0 301.7 4914.8 4928.1 5068.9 5152.4 5167.7 4986.4 5024.6 5025.9 5051.2 5056.1 3962.4 3982.0 3982.8 3987.8 4007.6 3879.9 3904.3 3993.9 3995.9 4011.8 3888.5 3888.5 3893.0 3898.6 3903.4 3902.5 3905.1 3911.9 3912.2 3917.7 3243.4 3356.9 3368.4 3371.6 3467.6 4897.2 4911.6 4924.7 4936.8 4957.9 4435.7 4435.7 4444.3 4462.5 4469.4 5073.7 5218.7 5218.9 5292.2 5304.8 3633.5 3654.3 3664.2 3683.8 3689.0 5551.3 5556.3 5581.4 5583.9 5590.7 3702.8 3776.5 3803.2 3808.0 3815.0 3801.5 3823.8 3833.4 3841.9 3860.0 4397.6 4413.2 4432.9 4437.8 4444.3 5153.8 5282.7 5317.9 5331.9 5336.4 1295.9 1319.9 1320.9 1321.2 1325.5 821.7 822.3 834.3 843.5 849.1 4101.8 4110.8 4130.8 4144.0 4152.8 4771.9 4772.9 4774.2 4824.9 4838.8 4152.1 4161.7 4170.5 4172.0 4185.0 2501.8 2515.6 2563.8 2571.8 2578.2 4550.7 4556.3 4564.2 4578.2 4608.3 4921.4 4928.9 4933.0 4972.8 5006.2 4557.6 4760.3 5149.7 5169.9 5226.3 5451.4 5511.6 5518.6 5533.3 5540.9 5161.3 5340.9 5370.5 5402.8 5428.5 5125.4 5131.7 5140.7 5163.3 5200.8 3553.3 3658.6 3771.2 3810.7 3813.3 5400.8 5428.0 5443.2 5451.2 5499.5 5266.5 5294.6 5304.7 5304.7 5360.4 5233.2 5247.3 5279.3 5319.4 5328.8 5163.7 5183.0 5196.8 5219.2 5230.8 5110.6 5283.7 5286.1 5302.6 5307.2 5178.6 5180.9 5188.2 5188.9 5190.8 15:16:49 INFO - PROCESS | 3419 | 15:16:49 INFO - PROCESS | 3419 | [#5] yui.html Cycles:180 Average:17426.00 Median:49316.75 stddev:24488.02 (49.7%) stddev-sans-first:24524.40 15:16:49 INFO - PROCESS | 3419 | Values: 671.5 693.3 714.1 718.4 727.3 11860.3 12645.2 12729.4 12756.9 14140.9 13456.9 13471.3 14044.0 14062.9 14064.9 625.1 764.2 785.3 790.4 791.0 762.0 789.5 795.5 795.9 796.0 827.7 833.2 834.6 834.9 835.6 820.8 826.9 830.3 832.1 832.4 603.1 603.6 604.4 604.6 605.6 13813.3 13819.1 13825.4 13844.2 13858.7 13581.5 13959.7 13993.6 14076.4 14081.4 10445.7 10482.0 10626.2 10663.8 10685.3 3352.2 3352.7 3371.0 3374.6 3429.5 61755.4 62030.4 62124.1 62259.4 63593.0 10720.0 10724.2 10756.2 10762.9 10925.9 19094.2 19263.6 19301.4 19486.0 19532.5 6986.3 7133.2 7133.9 7148.9 7171.7 3717.3 3826.3 3872.0 3873.7 3882.8 2862.5 2957.8 2962.3 2962.8 2970.5 507.4 508.3 513.3 518.8 525.8 603.8 604.9 639.3 640.7 643.9 8365.9 8403.4 8411.9 8576.5 8807.6 499.9 532.6 542.3 551.4 553.6 3903.5 4038.5 4058.2 4081.3 4273.8 57359.4 63627.0 96577.0 105331.5 105722.0 50201.5 88127.6 89151.0 89865.0 91763.0 45990.5 78834.0 80609.6 82613.6 82886.2 7361.7 7479.2 7619.5 7685.3 7771.7 48206.5 48829.3 49242.0 49391.5 50426.5 52273.5 52834.5 53446.5 60102.4 62017.8 11210.1 11226.3 11298.5 11321.1 11359.5 12853.0 12993.2 13093.5 13229.1 13306.3 10922.8 10988.2 11154.6 11230.4 11269.4 11099.7 11154.6 11604.5 11833.1 12046.6 11647.1 11693.6 11880.8 12041.9 12497.0 9682.3 9829.7 9964.3 9991.0 10175.5 9750.4 10350.3 10350.8 10364.7 10403.5 15:16:49 INFO - PROCESS | 3419 | -------- Summary: end -------- 15:16:49 INFO - PROCESS | 3419 | 15:16:50 INFO - TEST-INFO | 3419: exit 0 15:16:50 INFO - TEST-OK | dromaeo_css | took 1120531ms 15:16:50 INFO - TEST-START | kraken 15:16:50 INFO - operating with platform_type : linux_ 15:16:50 INFO - Initialising browser for kraken test... 15:16:50 INFO - TEST-INFO | started process 3663 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmprMrPYa/profile http://localhost:54045/getInfo.html) 15:16:55 INFO - PROCESS | 3663 | __metrics Screen width/height:1600/1200 15:16:55 INFO - PROCESS | 3663 | colorDepth:24 15:16:55 INFO - PROCESS | 3663 | Browser inner width/height: 1024/697 15:16:55 INFO - PROCESS | 3663 | __metrics 15:16:55 ERROR - PROCESS | 3663 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2964: TypeError: this.tabs is undefined 15:16:56 INFO - TEST-INFO | 3663: exit 0 15:16:56 INFO - Browser initialized. 15:16:56 INFO - Running cycle 1/1 for kraken test... 15:16:56 INFO - TEST-INFO | started process 3782 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmprMrPYa/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 15:17:08 INFO - PROCESS | 3782 | RSS: Main: 168677376 15:17:08 INFO - PROCESS | 3782 | 15:17:11 INFO - PROCESS | 3782 | Cycle 1(1): loaded http://localhost:54045/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:54045/tests/kraken/driver.html?testName=audio-beat-detection) 15:17:12 INFO - PROCESS | 3782 | RSS: Main: 174518272 15:17:12 INFO - PROCESS | 3782 | 15:17:14 INFO - PROCESS | 3782 | Cycle 1(1): loaded http://localhost:54045/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:54045/tests/kraken/driver.html?testName=audio-dft) 15:17:15 INFO - PROCESS | 3782 | RSS: Main: 173936640 15:17:15 INFO - PROCESS | 3782 | 15:17:18 INFO - PROCESS | 3782 | Cycle 1(1): loaded http://localhost:54045/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:54045/tests/kraken/driver.html?testName=audio-fft) 15:17:19 INFO - PROCESS | 3782 | RSS: Main: 169193472 15:17:19 INFO - PROCESS | 3782 | 15:17:21 INFO - PROCESS | 3782 | Cycle 1(1): loaded http://localhost:54045/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:54045/tests/kraken/driver.html?testName=audio-oscillator) 15:17:21 INFO - PROCESS | 3782 | RSS: Main: 168779776 15:17:21 INFO - PROCESS | 3782 | 15:17:24 INFO - PROCESS | 3782 | Cycle 1(1): loaded http://localhost:54045/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:54045/tests/kraken/driver.html?testName=imaging-gaussian-blur) 15:17:24 INFO - PROCESS | 3782 | RSS: Main: 168984576 15:17:24 INFO - PROCESS | 3782 | 15:17:27 INFO - PROCESS | 3782 | Cycle 1(1): loaded http://localhost:54045/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:54045/tests/kraken/driver.html?testName=imaging-darkroom) 15:17:28 INFO - PROCESS | 3782 | RSS: Main: 169639936 15:17:28 INFO - PROCESS | 3782 | 15:17:32 INFO - PROCESS | 3782 | Cycle 1(1): loaded http://localhost:54045/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:54045/tests/kraken/driver.html?testName=imaging-desaturate) 15:17:32 INFO - PROCESS | 3782 | RSS: Main: 166678528 15:17:32 INFO - PROCESS | 3782 | 15:17:35 INFO - PROCESS | 3782 | Cycle 1(1): loaded http://localhost:54045/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:54045/tests/kraken/driver.html?testName=json-parse-financial) 15:17:36 INFO - PROCESS | 3782 | RSS: Main: 168370176 15:17:36 INFO - PROCESS | 3782 | 15:17:38 INFO - PROCESS | 3782 | Cycle 1(1): loaded http://localhost:54045/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:54045/tests/kraken/driver.html?testName=json-stringify-tinderbox) 15:17:38 INFO - PROCESS | 3782 | RSS: Main: 168652800 15:17:38 INFO - PROCESS | 3782 | 15:17:40 INFO - PROCESS | 3782 | Cycle 1(1): loaded http://localhost:54045/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:54045/tests/kraken/driver.html?testName=stanford-crypto-aes) 15:17:41 INFO - PROCESS | 3782 | RSS: Main: 169385984 15:17:41 INFO - PROCESS | 3782 | 15:17:43 INFO - PROCESS | 3782 | Cycle 1(1): loaded http://localhost:54045/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:54045/tests/kraken/driver.html?testName=stanford-crypto-ccm) 15:17:44 INFO - PROCESS | 3782 | RSS: Main: 169504768 15:17:44 INFO - PROCESS | 3782 | 15:17:47 INFO - PROCESS | 3782 | Cycle 1(1): loaded http://localhost:54045/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:54045/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 15:17:47 INFO - PROCESS | 3782 | RSS: Main: 169787392 15:17:47 INFO - PROCESS | 3782 | 15:17:50 INFO - PROCESS | 3782 | Cycle 1(1): loaded http://localhost:54045/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:54045/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 15:17:51 INFO - PROCESS | 3782 | RSS: Main: 169517056 15:17:51 INFO - PROCESS | 3782 | 15:17:53 INFO - PROCESS | 3782 | Cycle 1(1): loaded http://localhost:54045/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:54045/tests/kraken/driver.html?testName=ai-astar) 15:17:53 INFO - PROCESS | 3782 | RSS: Main: 170573824 15:17:53 INFO - PROCESS | 3782 | 15:17:53 INFO - PROCESS | 3782 | __start_tp_report 15:17:53 INFO - PROCESS | 3782 | _x_x_mozilla_page_load 15:17:53 INFO - PROCESS | 3782 | _x_x_mozilla_page_load_details 15:17:53 INFO - PROCESS | 3782 | |i|pagename|runs| 15:17:53 INFO - PROCESS | 3782 | |0;ai-astar;107;117;109;121;117;116;118;116;115;115 15:17:53 INFO - PROCESS | 3782 | |1;audio-beat-detection;152;128;147;177;124;152;147;130;194;130 15:17:53 INFO - PROCESS | 3782 | |2;audio-dft;166;165;166;176;162;164;162;163;162;163 15:17:53 INFO - PROCESS | 3782 | |3;audio-fft;77;75;75;150;77;76;76;76;155;76 15:17:53 INFO - PROCESS | 3782 | |4;audio-oscillator;85;86;148;86;88;86;138;85;87;141 15:17:53 INFO - PROCESS | 3782 | |5;imaging-gaussian-blur;118;118;118;117;118;119;118;118;120;120 15:17:53 INFO - PROCESS | 3782 | |6;imaging-darkroom;149;149;149;149;148;148;147;148;148;148 15:17:53 INFO - PROCESS | 3782 | |7;imaging-desaturate;100;101;96;96;96;96;97;95;96;96 15:17:53 INFO - PROCESS | 3782 | |8;json-parse-financial;72;69;70;71;67;67;68;68;65;71 15:17:53 INFO - PROCESS | 3782 | |9;json-stringify-tinderbox;66;67;67;66;66;67;66;66;67;67 15:17:53 INFO - PROCESS | 3782 | |10;stanford-crypto-aes;80;91;80;82;80;79;81;79;84;80 15:17:53 INFO - PROCESS | 3782 | |11;stanford-crypto-ccm;131;138;136;133;132;132;130;140;169;131 15:17:53 INFO - PROCESS | 3782 | |12;stanford-crypto-pbkdf2;166;166;169;174;165;174;164;168;171;164 15:17:53 INFO - PROCESS | 3782 | |13;stanford-crypto-sha256-iterative;68;72;68;67;66;66;68;69;67;73 15:17:53 INFO - PROCESS | 3782 | __end_tp_report 15:17:53 INFO - PROCESS | 3782 | __start_cc_report 15:17:53 INFO - PROCESS | 3782 | _x_x_mozilla_cycle_collect,1010 15:17:53 INFO - PROCESS | 3782 | __end_cc_report 15:17:53 INFO - PROCESS | 3782 | __startTimestamp1468621073255__endTimestamp 15:17:53 INFO - PROCESS | 3782 | 15:17:53 INFO - PROCESS | 3782 | ------- Summary: start ------- 15:17:53 INFO - PROCESS | 3782 | Number of tests: 14 15:17:53 INFO - PROCESS | 3782 | 15:17:53 INFO - PROCESS | 3782 | [#0] ai-astar Cycles:10 Average:115.10 Median:116.50 stddev:4.15 (3.6%) stddev-sans-first:3.20 15:17:53 INFO - PROCESS | 3782 | Values: 107.0 117.0 109.0 121.0 117.0 116.0 118.0 116.0 115.0 115.0 15:17:53 INFO - PROCESS | 3782 | 15:17:53 INFO - PROCESS | 3782 | [#1] audio-beat-detection Cycles:10 Average:148.10 Median:149.50 stddev:22.64 (15.1%) stddev-sans-first:23.97 15:17:53 INFO - PROCESS | 3782 | Values: 152.0 128.0 147.0 177.0 124.0 152.0 147.0 130.0 194.0 130.0 15:17:53 INFO - PROCESS | 3782 | 15:17:53 INFO - PROCESS | 3782 | [#2] audio-dft Cycles:10 Average:164.90 Median:164.50 stddev:4.20 (2.6%) stddev-sans-first:4.44 15:17:53 INFO - PROCESS | 3782 | Values: 166.0 165.0 166.0 176.0 162.0 164.0 162.0 163.0 162.0 163.0 15:17:53 INFO - PROCESS | 3782 | 15:17:53 INFO - PROCESS | 3782 | [#3] audio-fft Cycles:10 Average:91.30 Median:76.00 stddev:32.28 (42.5%) stddev-sans-first:33.82 15:17:53 INFO - PROCESS | 3782 | Values: 77.0 75.0 75.0 150.0 77.0 76.0 76.0 76.0 155.0 76.0 15:17:53 INFO - PROCESS | 3782 | 15:17:53 INFO - PROCESS | 3782 | [#4] audio-oscillator Cycles:10 Average:103.00 Median:86.00 stddev:27.26 (31.7%) stddev-sans-first:28.13 15:17:53 INFO - PROCESS | 3782 | Values: 85.0 86.0 148.0 86.0 88.0 86.0 138.0 85.0 87.0 141.0 15:17:53 INFO - PROCESS | 3782 | 15:17:53 INFO - PROCESS | 3782 | [#5] imaging-gaussian-blur Cycles:10 Average:118.40 Median:118.00 stddev:0.97 (0.8%) stddev-sans-first:1.01 15:17:53 INFO - PROCESS | 3782 | Values: 118.0 118.0 118.0 117.0 118.0 119.0 118.0 118.0 120.0 120.0 15:17:53 INFO - PROCESS | 3782 | 15:17:53 INFO - PROCESS | 3782 | [#6] imaging-darkroom Cycles:10 Average:148.30 Median:148.50 stddev:0.67 (0.5%) stddev-sans-first:0.67 15:17:53 INFO - PROCESS | 3782 | Values: 149.0 149.0 149.0 149.0 148.0 148.0 147.0 148.0 148.0 148.0 15:17:53 INFO - PROCESS | 3782 | 15:17:53 INFO - PROCESS | 3782 | [#7] imaging-desaturate Cycles:10 Average:96.90 Median:96.00 stddev:1.97 (2.1%) stddev-sans-first:1.74 15:17:53 INFO - PROCESS | 3782 | Values: 100.0 101.0 96.0 96.0 96.0 96.0 97.0 95.0 96.0 96.0 15:17:53 INFO - PROCESS | 3782 | 15:17:53 INFO - PROCESS | 3782 | [#8] json-parse-financial Cycles:10 Average:68.80 Median:69.50 stddev:2.20 (3.2%) stddev-sans-first:2.01 15:17:53 INFO - PROCESS | 3782 | Values: 72.0 69.0 70.0 71.0 67.0 67.0 68.0 68.0 65.0 71.0 15:17:53 INFO - PROCESS | 3782 | 15:17:53 INFO - PROCESS | 3782 | [#9] json-stringify-tinderbox Cycles:10 Average:66.50 Median:67.00 stddev:0.53 (0.8%) stddev-sans-first:0.53 15:17:53 INFO - PROCESS | 3782 | Values: 66.0 67.0 67.0 66.0 66.0 67.0 66.0 66.0 67.0 67.0 15:17:53 INFO - PROCESS | 3782 | 15:17:53 INFO - PROCESS | 3782 | [#10] stanford-crypto-aes Cycles:10 Average:81.60 Median:80.50 stddev:3.63 (4.5%) stddev-sans-first:3.80 15:17:53 INFO - PROCESS | 3782 | Values: 80.0 91.0 80.0 82.0 80.0 79.0 81.0 79.0 84.0 80.0 15:17:53 INFO - PROCESS | 3782 | 15:17:53 INFO - PROCESS | 3782 | [#11] stanford-crypto-ccm Cycles:10 Average:137.20 Median:134.50 stddev:11.65 (8.7%) stddev-sans-first:12.14 15:17:53 INFO - PROCESS | 3782 | Values: 131.0 138.0 136.0 133.0 132.0 132.0 130.0 140.0 169.0 131.0 15:17:53 INFO - PROCESS | 3782 | 15:17:53 INFO - PROCESS | 3782 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:168.10 Median:168.50 stddev:3.81 (2.3%) stddev-sans-first:3.97 15:17:53 INFO - PROCESS | 3782 | Values: 166.0 166.0 169.0 174.0 165.0 174.0 164.0 168.0 171.0 164.0 15:17:53 INFO - PROCESS | 3782 | 15:17:53 INFO - PROCESS | 3782 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:68.40 Median:68.00 stddev:2.37 (3.5%) stddev-sans-first:2.51 15:17:53 INFO - PROCESS | 3782 | Values: 68.0 72.0 68.0 67.0 66.0 66.0 68.0 69.0 67.0 73.0 15:17:53 INFO - PROCESS | 3782 | -------- Summary: end -------- 15:17:53 INFO - PROCESS | 3782 | 15:17:54 INFO - TEST-INFO | 3782: exit 0 15:17:54 INFO - TEST-OK | kraken | took 64062ms 15:17:54 INFO - SUITE-END | took 1184s 15:17:54 INFO - Completed test suite (00:19:44) 15:17:54 INFO - javascript benchmark 15:17:54 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 6431.643778852859, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2622.3968487247935, 2637.749413805689, 2674.893004279829, 2677.183459044993, 2690.381212321166, 4771.498992605779, 4805.591524720398, 4830.855074347766, 4856.732879691615, 4907.82822601209, 4720.315554244632, 4784.880377990552, 4815.590674792638, 4841.4190297164305, 4858.757062146888, 4434.756088415136, 4479.193745125876, 4500.504944456107, 4534.659900507459, 4538.795754191053, 4397.208502469554, 4440.777961101948, 4465.330200469923, 4489.775511224442, 4496.213162696531, 4458.2866741321395, 4536.72779633223, 4555.7949892254765, 4562.1560011398, 4612.769361531927, 4419.182451246497, 4454.443194600675, 4497.10057988402, 4500.4149460569915, 4502.077074199781, 4413.801378937956, 4426.269665505188, 4442.4669039715445, 4478.888027799331, 4484.910301793946, 4760.119377915063, 4783.1868582341085, 4803.591694705954, 4818.566329030404, 4848.587870031051, 4993.650444468889, 5059.0, 5065.772040258161, 5172.19830926207, 5182.792688292501, 5105.744712764347, 5119.0, 5122.1804511278015, 5145.331106956071, 5179.637425380225, 4823.589994850442, 4883.706977581321, 4910.459849416561, 4912.975435122873, 4942.950570494321, 5228.869278267997, 5263.578913686896, 5360.758765855546, 5370.2750128732905, 5371.973140134274, 5084.542391184737, 5086.465921078234, 5091.1090559152, 5095.15929871567, 5152.252923326172, 5166.405863325691, 5179.48205179479, 5181.248718935733, 5207.0887594670785, 5210.114280572312, 5008.974955125201, 5115.104856650146, 5122.923156152586, 5144.331236939174, 5153.304303918998, 5125.769340379692, 5148.536631703165, 5153.561947234527, 5158.0, 5167.379914410295, 4051.6556092731857, 4066.410370496321, 4072.3484242521054, 4073.124278280184, 4076.103257283393, 3422.212891035026, 3509.964900350964, 3546.024843168098, 3553.875614353537, 3559.6796288334176, 4460.799264033127, 4491.8203271869415, 4495.730256184639, 4506.639468842484, 4558.726476411426, 5026.447090820006, 5208.062548741263, 5212.061828870764, 5234.895302093937, 5242.13504771716, 4430.091831174602, 4473.843415480507, 4484.730916145042, 4501.279795232747, 4517.435320584927, 4635.6986795858165, 4650.581447669726, 4669.533046695304, 4698.110661942949, 4698.624110071186, 4706.411698537683, 4870.220764677634, 4930.654854160246, 4934.777934993006, 4943.678660887031, 5204.271402003798, 5215.921761173509, 5230.973845130902, 5245.449227831175, 5289.021531016774, 4904.632152588499, 4909.77905994224, 4910.361652985089, 4926.901461970669, 4956.900861982812, 4930.186519224431, 5011.523905228997, 5054.949450505448, 5147.871303217449, 5162.922556161586, 5121.718305493085, 5133.56364708989, 5134.358205224347, 5139.331886854685, 5167.509086636764, 4992.522147857791, 5003.949960500494, 5004.224345226496, 5005.749712514287, 5044.4451110377095, 4873.122837889072, 4984.875378115431, 4990.301357809837, 4990.50094990498, 5040.596752259884, 4800.135975524439, 4898.902021959612, 4948.331975183304, 4956.8760780980765, 4997.800087996439, 5101.107306221322, 5129.204973229155, 5131.332926719502, 5132.948670513247, 5168.689878607295, 4733.36099626546, 4861.781219845187, 4895.877603059952, 5016.59867210615, 5030.170021946338], "value": 4725.416481705514, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [556.8858384031277, 557.5177471487164, 566.6345207341267, 569.4647031790117, 581.8429024163473, 36630.633693663054, 39949.40075898864, 40020.59979400205, 40058.198836023264, 40135.59864401355, 40415.79792101035, 40980.180396392054, 41014.179716405655, 41056.58943410565, 41077.794611026904, 7762.45662803604, 7883.290503854652, 7889.289963903248, 7899.091604465474, 7924.08872979609, 7796.922030779676, 7825.100113486937, 7852.882206766903, 7876.054873415198, 7882.448228623999, 7828.491148075385, 7835.451518393715, 7902.841943161134, 7922.128565857751, 7927.762167134995, 7833.41249406294, 7862.292393684567, 7870.842583148334, 7871.606419678993, 7910.80222994424, 7644.120926093515, 7679.6928122875015, 7710.730124445618, 7728.6908523658985, 7753.728619498291, 39133.0, 39343.40984885229, 39367.803160984295, 39377.80311098455, 39390.40914386258, 2825.788065895066, 2896.782741294411, 3083.6762139975203, 3132.592762940826, 3166.4617015107488, 29285.26786830325, 29463.0, 29507.55738663922, 29743.40513189724, 29902.252443688863, 3423.8116903570294, 3512.8594856205723, 3538.486919396673, 3541.6812486876047, 3553.200529880782, 259527.0, 261429.69285153644, 262006.0, 262381.0, 263139.0, 52574.47425525772, 53338.73330633322, 53340.0, 53342.0, 53403.0, 32949.67050329466, 33950.49074263888, 34319.14202144966, 35474.0, 35510.82244588812, 15377.0, 15557.533274001798, 15667.84332156664, 15681.137537435323, 15754.212289385485, 11360.772784544262, 11502.424878756028, 11521.654350369334, 11584.189106762446, 11598.536058557564, 18578.163982620816, 18601.0, 18621.44135675932, 18650.813491865178, 18679.0, 6746.763863264762, 6872.175338959357, 6951.513394062468, 7084.468664850054, 7116.92883071173, 744.133084956031, 811.15234579863, 837.8324335132997, 847.8855354527183, 881.3566096749408, 27473.587896181172, 28072.157835264974, 28490.85754571214, 28990.42019159605, 29032.274193144916, 906.4153620914605, 925.5048549026238, 926.1757036237753, 927.6335847340263, 951.833429149896, 14681.48614798477, 14852.480163194236, 14971.343134811861, 15034.293827111007, 15308.617284567976, 401907.0, 405418.0, 406028.0, 406206.0, 406272.0, 51273.23090153651, 51810.74094629578, 51817.7409112952, 51971.22043169355, 52033.73983130136, 1221.9022478201723, 1224.577520755338, 1231.846019247594, 1236.5610208376077, 1241.85097788266, 26732.465350692488, 27125.350715884193, 27820.992320852867, 27991.860040699667, 28169.43661126725, 44372.55627443813, 44697.55302446934, 44705.0, 44831.32753008642, 44858.55141448544, 273979.0, 274565.0, 274963.0, 275550.0, 276481.32315368863, 25542.616860747476, 25614.743852561234, 25839.224823255332, 25974.87012564925, 25982.480350393264, 42373.576264238196, 42848.57151428446, 43685.344719828594, 44095.55904441043, 49350.0, 36307.0, 37700.81149594235, 37863.62136378601, 39430.0, 41203.7939810299, 37994.620053800216, 38517.80741096276, 39036.0, 39433.605663942995, 39662.2067558653, 30665.693343067178, 35212.29575408426, 35786.284274313846, 36242.55695708904, 36378.45432318465, 32857.0, 33746.70725428768, 34860.47709284312, 34878.476822848184, 34951.82524087363, 25763.871180643975, 25862.612060818727, 25931.611025835005, 26049.609255861556, 26233.868830655723], "value": 17503.996430358584, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [376.576351604445, 378.19633279281527, 380.391373801917, 386.31043587196825, 396.0, 16123.528069601092, 17135.74296385555, 17882.910585447087, 18090.63818723628, 18406.44780656579, 17186.570335741613, 17304.480865574053, 17994.550136246602, 18012.81987180128, 18083.72874406885, 5085.262636917645, 5225.608079394042, 5248.475152484759, 5265.736713164346, 5271.077561426754, 3701.7223708221854, 5774.769009239625, 6060.3939606039485, 6069.78755743549, 6169.074638804171, 5094.974525127369, 6046.54650901182, 6075.058365953284, 6092.756289748427, 6097.908531372033, 5337.866553336159, 5412.810551630674, 5441.29263195784, 5445.564354851603, 5456.236126942231, 5215.243789650517, 5264.815731449381, 5269.314989051399, 5279.841604751864, 5296.735163241861, 13206.075574709774, 13291.468341266338, 13329.800052999213, 16241.51275461738, 20492.795072049237, 1772.521419216817, 1836.137015602678, 1869.2990128701738, 2148.1836901977304, 2455.9508809823883, 8846.203841654282, 9363.110504502061, 9452.763680907963, 9477.241820654332, 9728.708138755848, 1624.2284914665559, 1677.6141487457953, 1738.9217485213196, 1767.9116044197867, 1771.2914834066348, 65335.0, 67237.0, 69303.65348173278, 70019.0, 70791.64604176997, 10054.69835904924, 10094.49527523621, 10097.091261786474, 10118.645847395306, 10259.076683098558, 13761.31193440324, 13804.861951380357, 13835.03154779176, 13848.930755346159, 13873.09824861401, 7292.161401438796, 7460.776176714708, 7487.438442116863, 7572.4699271050495, 7574.962125189339, 7046.61243631595, 7058.788236352918, 7074.893876591856, 7237.0, 7238.059052323164, 4217.472815898012, 4219.641330486882, 4235.428217190702, 4263.744175349489, 4304.321314687274, 1674.8660107191395, 1689.3327135781296, 1792.7400526923523, 1817.2549254805467, 1839.9908000459911, 826.615623734954, 864.6411739128317, 887.5828360670474, 911.7355966769562, 912.7682815516132, 16712.201505396955, 16730.58173545671, 16789.916050419914, 16999.23503442348, 17124.0, 858.5020688000944, 869.2784988459564, 875.8160786234962, 886.472548833443, 940.5250348573926, 9154.0, 9531.0, 9550.235981121494, 9636.614535418505, 9654.469004204837, 369590.0, 375955.0, 376401.0, 377721.0, 378796.0, 79765.60117199493, 80698.0, 80777.59611202024, 81026.0, 82623.17376826276, 870.1994165367877, 881.7398867334152, 888.7244954064131, 892.1747383670079, 892.3931726425963, 14393.712125757216, 14904.254787260377, 14924.62688432798, 14943.701125977637, 15164.772528412303, 35452.822735886155, 35926.820365898006, 37051.629483705896, 37726.02098490647, 37922.62077379301, 47101.52898471108, 48973.2654010183, 50038.0, 50064.749676251384, 50617.49382506275, 7219.0976127984, 7402.703891844266, 7427.183009868802, 7468.215837337001, 7679.462437629312, 8747.60635771379, 11707.590234342098, 11782.82325765097, 11835.881641183478, 12154.149209555246, 9927.950360248153, 10399.896001039893, 10610.469476526298, 11168.888311117109, 11278.718032049264, 9271.30465215098, 9493.0, 11037.448127593427, 11041.613543525938, 11137.109031277316, 10093.243006774668, 10116.84824727615, 10550.208734344802, 10647.148228141885, 10656.84014739795, 7168.820779480555, 7369.415575651261, 7380.852382952418, 7385.556866588022, 7624.466287359832, 7381.077365329334, 8949.507777072324, 10000.799984000134, 10248.692539223835, 10277.434741089312], "value": 8164.668147216761, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1389.506725112585, 1425.287356321839, 1519.217602934489, 1702.855257303129, 1742.686316463037, 6981.860362792741, 7415.1843297237265, 7864.764057078282, 8125.2687258146825, 8144.918550814497, 7784.221577842213, 8065.3144482719035, 8147.0, 8203.097659257477, 8227.300679442254, 2138.7861213878605, 2180.3132013415725, 2188.420068681801, 2192.967105493419, 2193.144673577306, 2136.220279597951, 2177.0203408466255, 2183.1049269799387, 2188.6498160294354, 2190.200576789476, 2150.354893531942, 2155.137944822076, 2157.3635777445693, 2164.2316977473006, 2190.9561808763815, 2108.68369744538, 2112.112912576714, 2118.555103428282, 2121.469632591852, 2122.554263604645, 2026.847986401011, 2100.873947563136, 2113.408245691209, 2117.57648470305, 2122.57548490301, 8060.193980601893, 8137.552434616094, 8143.633536490872, 8151.225633564802, 8205.0, 4539.0694907543875, 4684.625229981593, 4690.390249267608, 4692.507286734912, 4700.224462963607, 2767.875445604953, 2869.153599688097, 2870.583765354012, 2903.8693258803405, 2950.867210975511, 861.6854847980442, 883.4478450968145, 900.7658008917663, 901.9684311049082, 923.672096405773, 11048.668539943814, 11157.66527004191, 11183.105351571936, 11214.383208923506, 11244.325340479516, 4086.346184610448, 4128.649064829463, 4303.827846886152, 4318.0, 4326.480822301344, 9409.905900940903, 9434.90565094354, 9490.430574165572, 9495.05049495045, 9503.477308748084, 4709.058188362341, 4718.95281047192, 4734.455537613149, 4735.171345014609, 4739.289106634033, 3659.2864391443945, 4209.2633789086785, 4264.786760661955, 4321.7406955582765, 4356.607905288539, 3657.798821064867, 3705.9073523161596, 3740.1023754299317, 3775.301569209705, 3780.4140358244517, 1188.0, 1210.4371467267763, 1218.8842060004285, 1241.3172754984903, 1256.0705078242036, 764.4419573711222, 766.8734658781239, 787.263908245792, 804.5373910001772, 806.6007326373366, 4962.0, 5232.607554433433, 5304.177852432879, 5412.161115027177, 5419.0245755764345, 372.4431974198536, 387.33378588827173, 390.1183325683975, 402.28995822373537, 410.07323449004866, 3359.9328013439595, 3382.9492557611657, 3422.982885085559, 3430.3482338355634, 3566.946495802565, 9726.95136524327, 9820.508974551243, 9910.405375677483, 9920.454375009444, 10148.644797432054, 9771.413715177112, 9821.852672209923, 9833.459159746282, 9837.360571562825, 9887.45618990948, 7260.636968151572, 7295.051643286445, 7450.552966822008, 7551.320381165611, 7575.204603516661, 5220.504052115195, 5256.868578285574, 5296.894062118813, 5349.893002140013, 5427.674339539641, 9312.44125352481, 9344.766380840534, 9361.251099912128, 9362.344635875696, 9399.154076133182, 8767.386282960131, 9196.08039196075, 9207.67773127964, 9365.344425890122, 9504.904950950402, 6209.441150296495, 6726.764563240263, 6929.826754331182, 6974.442044636518, 7130.928690713026, 7531.322181003736, 7553.018107645971, 7591.696332146652, 7597.2022937592965, 7647.541147531166, 6840.41856442208, 6911.3779759821855, 6960.721571137098, 6994.510384273256, 7034.1910680270375, 6867.553609015398, 6912.758053468105, 6967.616781076887, 7139.928600713926, 7177.569345839266, 5930.911036334544, 6092.964196086587, 6116.724747386467, 6270.592411493239, 6338.651374174465, 4504.346869703809, 4551.431071116111, 4575.565321294472, 4627.490975992706, 4664.416947881515, 4589.357489951342, 4602.4937256902385, 4628.305754136906, 4646.721196728207, 4797.64017698681], "value": 4090.2613246174974, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [284.268009874573, 291.3982625877563, 295.97336239738416, 299.97150270724273, 301.73748838510494, 4914.803407863681, 4928.063667903096, 5068.898622027562, 5152.355955505562, 5167.689938603687, 4986.426560945483, 5024.572911302544, 5025.924611130836, 5051.191809310511, 5056.140456122459, 3962.385830196324, 3981.9999999999927, 3982.780947047911, 3987.8205480753436, 4007.5792041835625, 3879.9030024249337, 3904.2777086238993, 3993.9201215975663, 3995.8601448949294, 4011.799410029487, 3888.4556162137183, 3888.530782952817, 3893.0, 3898.629630185128, 3903.3754599264125, 3902.492675952122, 3905.1213476967596, 3911.941320880189, 3912.2371137628174, 3917.7061720370803, 3243.4161850866835, 3356.882509112194, 3368.444206705891, 3371.5954085509898, 3467.618561958208, 4897.1674815281485, 4911.582515486152, 4924.655274130812, 4936.827211047632, 4957.925631115536, 4435.711678740904, 4435.713643043514, 4444.28894875472, 4462.464504259509, 4469.374287599739, 5073.746312684388, 5218.712970786605, 5218.8695282617855, 5292.153255479105, 5304.817109734167, 3633.5276414066266, 3654.250878569887, 3664.2121943782213, 3683.778973261613, 3689.0, 5551.333839939192, 5556.277683901067, 5581.386047534768, 5583.8604034899045, 5590.720463976825, 3702.796346200931, 3776.490173826553, 3803.1823158021157, 3807.961920380816, 3814.9618503815163, 3801.5438147422487, 3823.751456155341, 3833.3674943633987, 3841.9039524012123, 3859.96140038596, 4397.626201772885, 4413.16149931512, 4432.867013989586, 4437.822487100544, 4444.28891377378, 5153.768080436389, 5282.683039017671, 5317.9202311965355, 5331.893362132736, 5336.4129945705945, 1295.8920123294447, 1319.9340032998311, 1320.947162113524, 1321.200673592482, 1325.4896864707157, 821.6549049399266, 822.2722890242179, 834.2825170353491, 843.502333623153, 849.0999540487103, 4101.764538326619, 4110.848962290504, 4130.822715526061, 4143.958560414358, 4152.833886644561, 4771.904561908743, 4772.880677983008, 4774.236122220428, 4824.879378015507, 4838.806387784046, 4152.1280531088205, 4161.667066634662, 4170.4995400552125, 4171.97914010428, 4184.979075104666, 2501.8359119361985, 2515.6352328912203, 2563.8077144214258, 2571.7942564594787, 2578.200757765099, 4550.681452298373, 4556.270996640522, 4564.2240819060835, 4578.221702310615, 4608.28571571407, 4921.375945937832, 4928.901421971541, 4932.950670493321, 4972.825951091694, 5006.249062640633, 4557.589816916494, 4760.309755085494, 5149.716765577854, 5169.948300516947, 5226.294450249244, 5451.400345961862, 5511.559075274049, 5518.558515318685, 5533.335999680065, 5540.86147846291, 5161.277421161116, 5340.890348312472, 5370.489803468664, 5402.837914862561, 5428.45715428454, 5125.384953805567, 5131.717755523482, 5140.742962851918, 5163.328767260232, 5200.817971371135, 3553.307105114478, 3658.560972683295, 3771.151490914522, 3810.695144388387, 3813.275477659236, 5400.783968641211, 5427.99582077317, 5443.156310771837, 5451.236826844324, 5499.50504454601, 5266.499682530153, 5294.576433885203, 5304.681719096867, 5304.708241046779, 5360.410354860885, 5233.162693968947, 5247.291615631993, 5279.340082489689, 5319.38827034896, 5328.813491527933, 5163.715995620127, 5183.0, 5196.818111366084, 5219.243209734491, 5230.790768369223, 5110.61670374716, 5283.682979021117, 5286.074936886106, 5302.602304827076, 5307.230451584576, 5178.585713142864, 5180.922286165635, 5188.22176673502, 5188.948110518997, 5190.766415511235], "value": 3876.1011730086184, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [671.5265737654954, 693.3290769246117, 714.1323292199976, 718.403724908326, 727.2763600217783, 11860.347680877549, 12645.241285522876, 12729.42717577709, 12756.936215318921, 14140.929295353535, 13456.865431345683, 13471.326433678301, 14044.0, 14062.929685351584, 14064.859351406483, 625.1435533319359, 764.1823249123427, 785.3246208260891, 790.4308897593723, 790.9920900791004, 761.9903627693328, 789.5341748368461, 795.4988357334871, 795.932345750612, 796.0010187215066, 827.6523859978823, 833.170994860115, 834.6285902773268, 834.9415540912139, 835.5655059369125, 820.7578764264497, 826.9462484938459, 830.2693629605939, 832.0930186097153, 832.4381042796118, 603.1074010464537, 603.6197195766683, 604.4227762486814, 604.5647134063468, 605.6245128020655, 13813.309334533233, 13819.101758385672, 13825.446982120704, 13844.169349839041, 13858.653533661638, 13581.524646637321, 13959.720805583831, 13993.580192594136, 14076.366563504564, 14081.366338514688, 10445.68662940113, 10482.0, 10626.203034772423, 10663.786724265472, 10685.252032357737, 3352.1619595101224, 3352.6814952579466, 3370.96629033709, 3374.6287908330064, 3429.5198672185916, 61755.38244617586, 62030.37969620291, 62124.06813897795, 62259.37740622627, 63593.0, 10720.0, 10724.195685323632, 10756.247062705535, 10762.892371076188, 10925.890741092646, 19094.2362305509, 19263.614727705648, 19301.4209573713, 19486.0, 19532.51168720765, 6986.301369863075, 7133.215346311901, 7133.89299160513, 7148.892766608505, 7171.748988785367, 3717.3308804414924, 3826.253880493277, 3871.96128038716, 3873.7288389812443, 3882.7864467453996, 2862.4990626640256, 2957.7633789296806, 2962.2890506278336, 2962.8370439625596, 2970.4653162430536, 507.3911306432296, 508.3442359356389, 513.3275409213942, 518.7795187045491, 525.8212207849273, 603.7645318325856, 604.8639056212405, 639.3478651775164, 640.7244884699624, 643.9098526206335, 8365.874511882326, 8403.369747268856, 8411.948506436695, 8576.485410875368, 8807.603657835412, 499.9025190087898, 532.6165161084014, 542.2544001997254, 551.37969783993, 553.5516231852132, 3903.531576210816, 4038.495188101487, 4058.2492238935893, 4081.346984482528, 4273.786310684453, 57359.426405736245, 63627.0, 96577.0, 105331.4733426328, 105722.0, 50201.49798502041, 88127.55936220278, 89151.0, 89865.0, 91763.0, 45990.540094599295, 78834.0, 80609.59695201486, 82613.58693206495, 82886.17113828784, 7361.668724907285, 7479.17729049815, 7619.504732192389, 7685.346745526693, 7771.650275737492, 48206.5179348202, 48829.2675609859, 49242.0, 49391.506084938694, 50426.495735043645, 52273.47726522686, 52834.47165528449, 53446.46553534415, 60102.39897600968, 62017.829375971625, 11210.103191744804, 11226.326420414802, 11298.548058077586, 11321.094312455149, 11359.54561817518, 12853.0, 12993.220406775623, 13093.476260949836, 13229.140105893086, 13306.268155251168, 10922.781544369227, 10988.230823842254, 11154.609588664358, 11230.438478075901, 11269.436528173723, 11099.667009989713, 11154.55381784752, 11604.535818567501, 11833.089690424255, 12046.638600841989, 11647.12646551529, 11693.649190524298, 11880.76238475243, 12041.879581204075, 12497.0, 9682.322237443594, 9829.725200075414, 9964.302498825302, 9990.950045249727, 10175.491225438847, 9750.414975101517, 10350.275480716578, 10350.844737328796, 10364.740881478023, 10403.479826008821], "value": 6610.30080230162, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1576.6, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [107.0, 117.0, 109.0, 121.0, 117.0, 116.0, 118.0, 116.0, 115.0, 115.0], "value": 115.1, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [152.0, 128.0, 147.0, 177.0, 124.0, 152.0, 147.0, 130.0, 194.0, 130.0], "value": 148.1, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [166.0, 165.0, 166.0, 176.0, 162.0, 164.0, 162.0, 163.0, 162.0, 163.0], "value": 164.9, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [77.0, 75.0, 75.0, 150.0, 77.0, 76.0, 76.0, 76.0, 155.0, 76.0], "value": 91.3, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [85.0, 86.0, 148.0, 86.0, 88.0, 86.0, 138.0, 85.0, 87.0, 141.0], "value": 103.0, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [118.0, 118.0, 118.0, 117.0, 118.0, 119.0, 118.0, 118.0, 120.0, 120.0], "value": 118.4, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [149.0, 149.0, 149.0, 149.0, 148.0, 148.0, 147.0, 148.0, 148.0, 148.0], "value": 148.3, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [100.0, 101.0, 96.0, 96.0, 96.0, 96.0, 97.0, 95.0, 96.0, 96.0], "value": 96.9, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [72.0, 69.0, 70.0, 71.0, 67.0, 67.0, 68.0, 68.0, 65.0, 71.0], "value": 68.8, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [66.0, 67.0, 67.0, 66.0, 66.0, 67.0, 66.0, 66.0, 67.0, 67.0], "value": 66.5, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [80.0, 91.0, 80.0, 82.0, 80.0, 79.0, 81.0, 79.0, 84.0, 80.0], "value": 81.6, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [131.0, 138.0, 136.0, 133.0, 132.0, 132.0, 130.0, 140.0, 169.0, 131.0], "value": 137.2, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [166.0, 166.0, 169.0, 174.0, 165.0, 174.0, 164.0, 168.0, 171.0, 164.0], "value": 168.1, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [68.0, 72.0, 68.0, 67.0, 66.0, 66.0, 68.0, 69.0, 67.0, 73.0], "value": 68.4, "unit": "score"}]}]} 15:17:54 INFO - Return code: 0 15:17:54 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 15:17:54 ERROR - # TBPL SUCCESS # 15:17:54 INFO - Running post-action listener: _resource_record_post_action 15:17:54 INFO - ##### 15:17:54 INFO - ##### Finished run-tests step (success) 15:17:54 INFO - ##### 15:17:54 INFO - Running post-run listener: _resource_record_post_run 15:17:54 INFO - Total resource usage - Wall time: 1201s; CPU: 13.0%; Read bytes: 7786496; Write bytes: 365174784; Read time: 1844; Write time: 308716 15:17:54 INFO - TinderboxPrint: CPU usage
13.3% 15:17:54 INFO - TinderboxPrint: I/O read bytes / time
7,786,496 / 1,844 15:17:54 INFO - TinderboxPrint: I/O write bytes / time
365,174,784 / 308,716 15:17:54 INFO - TinderboxPrint: CPU idle
8,304.8 (86.7%) 15:17:54 INFO - TinderboxPrint: CPU user
1,221.9 (12.8%) 15:17:54 INFO - TinderboxPrint: Swap in / out
0 / 0 15:17:54 INFO - install - Wall time: 17s; CPU: 13.0%; Read bytes: 0; Write bytes: 5812224; Read time: 0; Write time: 696 15:17:54 INFO - run-tests - Wall time: 1185s; CPU: 13.0%; Read bytes: 5632000; Write bytes: 359362560; Read time: 1716; Write time: 308020 15:17:55 INFO - Running post-run listener: _upload_blobber_files 15:17:55 INFO - Blob upload gear active. 15:17:55 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 15:17:55 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 15:17:55 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'] 15:17:55 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 15:17:55 INFO - (blobuploader) - INFO - Open directory for files ... 15:17:55 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 15:17:55 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 15:17:55 INFO - (blobuploader) - INFO - Uploading, attempt #1. 15:17:58 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 15:17:58 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 15:17:58 INFO - (blobuploader) - INFO - Done attempting. 15:17:58 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 15:17:58 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 15:17:58 INFO - (blobuploader) - INFO - Uploading, attempt #1. 15:17:59 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 15:17:59 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 15:17:59 INFO - (blobuploader) - INFO - Done attempting. 15:17:59 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 15:17:59 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 15:17:59 INFO - (blobuploader) - INFO - Uploading, attempt #1. 15:18:00 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 15:18:00 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 15:18:00 INFO - (blobuploader) - INFO - Done attempting. 15:18:00 INFO - (blobuploader) - INFO - Iteration through files over. 15:18:00 INFO - Return code: 0 15:18:00 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 15:18:00 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 15:18:00 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/9cac5ec4f66f6f1bdfa304034bf5965ec5523bb9e242435e8905cc195c92dc2c3a2f6a90defe0524341ba65a66876bad365a2a475161dc6bf746d22953d17104", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/ae32e713597b3d27672c69cd7fb65362ffede7aef9759f1327e169f1d41997a9c8f26912a27bcb8b7e59ccb9fb07d2f9b8ee8786c9e44b7b2485622dd155bc97", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/5ee9d5bf94a503b6d3f35e12e44f84c4d2e66f630a5dc86b36245b8b59d563c856ed04dc75ff7b9346add0e875592b8bfdad2991cce6a06d4bb2da87b83e8a28"} 15:18:00 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 15:18:00 INFO - Writing to file /builds/slave/test/properties/blobber_files 15:18:00 INFO - Contents: 15:18:00 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/9cac5ec4f66f6f1bdfa304034bf5965ec5523bb9e242435e8905cc195c92dc2c3a2f6a90defe0524341ba65a66876bad365a2a475161dc6bf746d22953d17104", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/ae32e713597b3d27672c69cd7fb65362ffede7aef9759f1327e169f1d41997a9c8f26912a27bcb8b7e59ccb9fb07d2f9b8ee8786c9e44b7b2485622dd155bc97", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/5ee9d5bf94a503b6d3f35e12e44f84c4d2e66f630a5dc86b36245b8b59d563c856ed04dc75ff7b9346add0e875592b8bfdad2991cce6a06d4bb2da87b83e8a28"} 15:18:00 INFO - Running post-run listener: copy_logs_to_upload_dir 15:18:00 INFO - Copying logs to upload dir... 15:18:00 INFO - mkdir: /builds/slave/test/build/upload/logs 15:18:00 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1251.545543 ========= master_lag: 0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 51 secs) (at 2016-07-15 15:18:00.390729) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-07-15 15:18:00.393810) ========= 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=0e2a256762fed810e2f0f810000001b3-1468616785.323493-1948727444 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/9cac5ec4f66f6f1bdfa304034bf5965ec5523bb9e242435e8905cc195c92dc2c3a2f6a90defe0524341ba65a66876bad365a2a475161dc6bf746d22953d17104", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/ae32e713597b3d27672c69cd7fb65362ffede7aef9759f1327e169f1d41997a9c8f26912a27bcb8b7e59ccb9fb07d2f9b8ee8786c9e44b7b2485622dd155bc97", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/5ee9d5bf94a503b6d3f35e12e44f84c4d2e66f630a5dc86b36245b8b59d563c856ed04dc75ff7b9346add0e875592b8bfdad2991cce6a06d4bb2da87b83e8a28"} build_url:https://queue.taskcluster.net/v1/task/AU76KAG0T5yTp1qDGKJ5ZQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011222 build_url: 'https://queue.taskcluster.net/v1/task/AU76KAG0T5yTp1qDGKJ5ZQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/9cac5ec4f66f6f1bdfa304034bf5965ec5523bb9e242435e8905cc195c92dc2c3a2f6a90defe0524341ba65a66876bad365a2a475161dc6bf746d22953d17104", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/ae32e713597b3d27672c69cd7fb65362ffede7aef9759f1327e169f1d41997a9c8f26912a27bcb8b7e59ccb9fb07d2f9b8ee8786c9e44b7b2485622dd155bc97", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/5ee9d5bf94a503b6d3f35e12e44f84c4d2e66f630a5dc86b36245b8b59d563c856ed04dc75ff7b9346add0e875592b8bfdad2991cce6a06d4bb2da87b83e8a28"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-07-15 15:18:00.419037) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-07-15 15:18:00.419365) ========= 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=0e2a256762fed810e2f0f810000001b3-1468616785.323493-1948727444 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004415 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-07-15 15:18:00.503143) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-07-15 15:18:00.503465) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-07-15 15:18:00.503743) ========= ========= Total master_lag: 0.18 =========