builder: fx-team_ubuntu64_hw_test-dromaeojs-e10s-pgo slave: talos-linux64-ix-023 starttime: 1469383617.12 results: success (0) buildid: 20160724083055 builduid: 7ab1d157d4fb436796617e7e5fbd070a revision: d12890b78b043ccc2445dcef144e982f83b65e5f ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-07-24 11:06:57.122018) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-07-24 11:06:57.122517) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-07-24 11:06:57.122846) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-07-24 11:06:57.239214) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-24 11:06:57.239773) ========= bash -c 'wget -Oarchiver_client.py --no-check-certificate --tries=10 --waitretry=3 https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', 'wget -Oarchiver_client.py --no-check-certificate --tries=10 --waitretry=3 https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=6d15e502d8e29d5d2676d664000001c3-1469381342.99020-40446717 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-07-24 11:06:58-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 37.7M=0s 2016-07-24 11:06:58 (37.7 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.128239 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-24 11:06:57.384530) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-07-24 11:06:57.384868) ========= rm -rf scripts properties in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['rm', '-rf', 'scripts', 'properties'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=6d15e502d8e29d5d2676d664000001c3-1469381342.99020-40446717 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.021379 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-07-24 11:06:57.436030) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-07-24 11:06:57.436467) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev d12890b78b043ccc2445dcef144e982f83b65e5f --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 d12890b78b043ccc2445dcef144e982f83b65e5f --destination scripts --debug'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=6d15e502d8e29d5d2676d664000001c3-1469381342.99020-40446717 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-07-24 11:06:58,258 truncating revision to first 12 chars 2016-07-24 11:06:58,258 Setting DEBUG logging. 2016-07-24 11:06:58,258 attempt 1/10 2016-07-24 11:06:58,258 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/d12890b78b04?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-07-24 11:06:59,470 unpacking tar archive at: fx-team-d12890b78b04/testing/mozharness/ program finished with exit code 0 elapsedTime=1.568978 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-07-24 11:06:59.020273) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-07-24 11:06:59.020677) ========= script_repo_revision: d12890b78b043ccc2445dcef144e982f83b65e5f ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-07-24 11:06:59.021159) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-07-24 11:06:59.021486) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-07-24 11:06:59.032386) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 57 secs) (at 2016-07-24 11:06:59.032832) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Fx-Team --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team 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', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Fx-Team'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=6d15e502d8e29d5d2676d664000001c3-1469381342.99020-40446717 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 11:06:59 INFO - MultiFileLogger online at 20160724 11:06:59 in /builds/slave/test 11:06:59 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Fx-Team --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team 11:06:59 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 11:06:59 INFO - {'append_to_log': False, 11:06:59 INFO - 'base_work_dir': '/builds/slave/test', 11:06:59 INFO - 'blob_upload_branch': 'Fx-Team', 11:06:59 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 11:06:59 INFO - 'branch': 'Fx-Team', 11:06:59 INFO - 'buildbot_json_path': 'buildprops.json', 11:06:59 INFO - 'config_files': ('talos/linux_config.py',), 11:06:59 INFO - 'default_actions': ('clobber', 11:06:59 INFO - 'read-buildbot-config', 11:06:59 INFO - 'download-and-extract', 11:06:59 INFO - 'populate-webroot', 11:06:59 INFO - 'create-virtualenv', 11:06:59 INFO - 'install', 11:06:59 INFO - 'run-tests'), 11:06:59 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 11:06:59 INFO - 'download_minidump_stackwalk': True, 11:06:59 INFO - 'download_symbols': 'ondemand', 11:06:59 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 11:06:59 INFO - 'tooltool.py': '/tools/tooltool.py', 11:06:59 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 11:06:59 INFO - '/tools/misc-python/virtualenv.py')}, 11:06:59 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 11:06:59 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 11:06:59 INFO - 'installer_path': 'installer.exe', 11:06:59 INFO - 'log_level': 'info', 11:06:59 INFO - 'log_name': 'talos', 11:06:59 INFO - 'log_to_console': True, 11:06:59 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 11:06:59 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 11:06:59 INFO - 'opt_config_files': (), 11:06:59 INFO - 'pip_index': False, 11:06:59 INFO - 'sps_profile': False, 11:06:59 INFO - 'sps_profile_interval': 0, 11:06:59 INFO - 'suite': 'dromaeojs-e10s', 11:06:59 INFO - 'system_bits': '32', 11:06:59 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 11:06:59 INFO - 'title': 'talos-linux64-ix-023', 11:06:59 INFO - 'tooltool_cache': '/builds/tooltool_cache', 11:06:59 INFO - 'use_talos_json': True, 11:06:59 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 11:06:59 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 11:06:59 INFO - 'work_dir': 'build'} 11:06:59 INFO - [mozharness: 2016-07-24 18:06:59.952019Z] Running clobber step. 11:06:59 INFO - Running pre-action listener: _resource_record_pre_action 11:06:59 INFO - Running main action method: clobber 11:06:59 INFO - rmtree: /builds/slave/test/build 11:06:59 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 11:07:00 INFO - Running post-action listener: _resource_record_post_action 11:07:00 INFO - [mozharness: 2016-07-24 18:07:00.421163Z] Finished clobber step (success) 11:07:00 INFO - [mozharness: 2016-07-24 18:07:00.421265Z] Running read-buildbot-config step. 11:07:00 INFO - Running pre-action listener: _resource_record_pre_action 11:07:00 INFO - Running main action method: read_buildbot_config 11:07:00 INFO - Using buildbot properties: 11:07:00 INFO - { 11:07:00 INFO - "project": "", 11:07:00 INFO - "product": "firefox", 11:07:00 INFO - "script_repo_revision": "production", 11:07:00 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs-e10s", 11:07:00 INFO - "repository": "", 11:07:00 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team pgo talos dromaeojs-e10s", 11:07:00 INFO - "buildid": "20160724083055", 11:07:00 INFO - "pgo_build": "True", 11:07:00 INFO - "basedir": "/builds/slave/test", 11:07:00 INFO - "buildnumber": 970, 11:07:00 INFO - "slavename": "talos-linux64-ix-023", 11:07:00 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 11:07:00 INFO - "platform": "ubuntu64_hw", 11:07:00 INFO - "scheduler": "tests-fx-team-linux64-pgo-talos", 11:07:00 INFO - "branch": "fx-team", 11:07:00 INFO - "repo_path": "integration/fx-team", 11:07:00 INFO - "revision": "d12890b78b043ccc2445dcef144e982f83b65e5f", 11:07:00 INFO - "stage_platform": "linux64-pgo", 11:07:00 INFO - "builduid": "7ab1d157d4fb436796617e7e5fbd070a", 11:07:00 INFO - "slavebuilddir": "test" 11:07:00 INFO - } 11:07:00 INFO - Found installer url https://queue.taskcluster.net/v1/task/UinhjyB_Qdau-Gs9Dxz_lw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2. 11:07:00 INFO - Running post-action listener: _resource_record_post_action 11:07:00 INFO - [mozharness: 2016-07-24 18:07:00.423715Z] Finished read-buildbot-config step (success) 11:07:00 INFO - [mozharness: 2016-07-24 18:07:00.423805Z] Running download-and-extract step. 11:07:00 INFO - Running pre-action listener: _resource_record_pre_action 11:07:00 INFO - Running main action method: download_and_extract 11:07:00 INFO - mkdir: /builds/slave/test/build/tests 11:07:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:07:00 INFO - https://queue.taskcluster.net/v1/task/UinhjyB_Qdau-Gs9Dxz_lw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 11:07:00 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/UinhjyB_Qdau-Gs9Dxz_lw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 11:07:00 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/UinhjyB_Qdau-Gs9Dxz_lw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 11:07:00 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/UinhjyB_Qdau-Gs9Dxz_lw/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 11:07:00 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/UinhjyB_Qdau-Gs9Dxz_lw/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 11:07:05 INFO - Downloaded 1361 bytes. 11:07:05 INFO - Reading from file /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 11:07:05 INFO - Using the following test package requirements: 11:07:05 INFO - {u'common': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 11:07:05 INFO - u'cppunittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 11:07:05 INFO - u'firefox-50.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 11:07:05 INFO - u'gtest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 11:07:05 INFO - u'firefox-50.0a1.en-US.linux-x86_64.gtest.tests.zip'], 11:07:05 INFO - u'jittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 11:07:05 INFO - u'jsshell-linux-x86_64.zip'], 11:07:05 INFO - u'mochitest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 11:07:05 INFO - u'firefox-50.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 11:07:05 INFO - u'mozbase': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 11:07:05 INFO - u'reftest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 11:07:05 INFO - u'firefox-50.0a1.en-US.linux-x86_64.reftest.tests.zip'], 11:07:05 INFO - u'talos': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 11:07:05 INFO - u'firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip'], 11:07:05 INFO - u'web-platform': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 11:07:05 INFO - u'firefox-50.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 11:07:05 INFO - u'xpcshell': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 11:07:05 INFO - u'firefox-50.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 11:07:05 INFO - Downloading packages: [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 11:07:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:07:05 INFO - https://queue.taskcluster.net/v1/task/UinhjyB_Qdau-Gs9Dxz_lw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 11:07:05 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/UinhjyB_Qdau-Gs9Dxz_lw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 11:07:05 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/UinhjyB_Qdau-Gs9Dxz_lw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 11:07:05 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/UinhjyB_Qdau-Gs9Dxz_lw/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 11:07:05 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/UinhjyB_Qdau-Gs9Dxz_lw/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 11:07:10 INFO - Downloaded 24307605 bytes. 11:07:10 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'] 11:07:10 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 11:07:11 INFO - Return code: 0 11:07:11 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 11:07: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')]} 11:07:11 INFO - https://queue.taskcluster.net/v1/task/UinhjyB_Qdau-Gs9Dxz_lw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 11:07:11 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/UinhjyB_Qdau-Gs9Dxz_lw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 11:07:11 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/UinhjyB_Qdau-Gs9Dxz_lw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 11:07:11 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/UinhjyB_Qdau-Gs9Dxz_lw/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 11:07:11 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/UinhjyB_Qdau-Gs9Dxz_lw/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 11:07:13 INFO - Downloaded 24307605 bytes. 11:07:13 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'] 11:07:13 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 11:07:15 INFO - Return code: 0 11:07:15 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')]} 11:07:15 INFO - https://queue.taskcluster.net/v1/task/UinhjyB_Qdau-Gs9Dxz_lw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 11:07:15 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/UinhjyB_Qdau-Gs9Dxz_lw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 11:07:15 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/UinhjyB_Qdau-Gs9Dxz_lw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 11:07:15 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/UinhjyB_Qdau-Gs9Dxz_lw/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 11:07:15 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/UinhjyB_Qdau-Gs9Dxz_lw/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 11:07:16 INFO - Downloaded 14403289 bytes. 11:07:16 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'] 11:07:16 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 11:07:16 INFO - Return code: 0 11:07: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')]} 11:07:16 INFO - https://queue.taskcluster.net/v1/task/UinhjyB_Qdau-Gs9Dxz_lw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 11:07:16 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/UinhjyB_Qdau-Gs9Dxz_lw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 11:07:16 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/UinhjyB_Qdau-Gs9Dxz_lw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 11:07:16 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/UinhjyB_Qdau-Gs9Dxz_lw/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 11:07:16 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/UinhjyB_Qdau-Gs9Dxz_lw/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 11:07:17 INFO - Downloaded 60849840 bytes. 11:07:17 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/UinhjyB_Qdau-Gs9Dxz_lw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 11:07:17 INFO - mkdir: /builds/slave/test/properties 11:07:17 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 11:07:17 INFO - Writing to file /builds/slave/test/properties/build_url 11:07:17 INFO - Contents: 11:07:17 INFO - build_url:https://queue.taskcluster.net/v1/task/UinhjyB_Qdau-Gs9Dxz_lw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 11:07:18 INFO - Running post-action listener: _resource_record_post_action 11:07:18 INFO - Running post-action listener: set_extra_try_arguments 11:07:18 INFO - [mozharness: 2016-07-24 18:07:18.376922Z] Finished download-and-extract step (success) 11:07:18 INFO - [mozharness: 2016-07-24 18:07:18.377156Z] Running populate-webroot step. 11:07:18 INFO - Running pre-action listener: _resource_record_pre_action 11:07:18 INFO - Running main action method: populate_webroot 11:07:18 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 11:07:18 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 11:07:18 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 11:07:18 INFO - '--tppagecycles', 11:07:18 INFO - '7'], 11:07:18 INFO - 'tests': ['tsvgm']}}, 11:07:18 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 11:07:18 INFO - 'tests': ['tresize', 'tcanvasmark']}, 11:07:18 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 11:07:18 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 11:07:18 INFO - 'tests': ['dromaeo_css', 'kraken']}, 11:07:18 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 11:07:18 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:07:18 INFO - 'talos_options': ['--disable-e10s'], 11:07:18 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 11:07:18 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:07:18 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 11:07:18 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:07:18 INFO - 'talos_options': ['--disable-e10s'], 11:07:18 INFO - 'tests': ['damp', 'tps']}, 11:07:18 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:07:18 INFO - 'tests': ['damp', 'tps']}, 11:07:18 INFO - 'g3': {'talos_options': ['--disable-e10s'], 11:07:18 INFO - 'tests': ['dromaeo_dom']}, 11:07:18 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 11:07:18 INFO - 'g4': {'talos_options': ['--disable-e10s'], 11:07:18 INFO - 'tests': ['basic_compositor_video']}, 11:07:18 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 11:07:18 INFO - 'other': {'talos_options': ['--disable-e10s'], 11:07:18 INFO - 'tests': ['a11yr', 11:07:18 INFO - 'ts_paint', 11:07:18 INFO - 'tpaint', 11:07:18 INFO - 'sessionrestore', 11:07:18 INFO - 'sessionrestore_no_auto_restore', 11:07:18 INFO - 'tabpaint']}, 11:07:18 INFO - 'other-e10s': {'tests': ['a11yr', 11:07:18 INFO - 'ts_paint', 11:07:18 INFO - 'tpaint', 11:07:18 INFO - 'sessionrestore', 11:07:18 INFO - 'sessionrestore_no_auto_restore', 11:07:18 INFO - 'tabpaint']}, 11:07:18 INFO - 'other-e10s_l64': {'tests': ['a11yr', 11:07:18 INFO - 'ts_paint', 11:07:18 INFO - 'tpaint', 11:07:18 INFO - 'sessionrestore', 11:07:18 INFO - 'sessionrestore_no_auto_restore', 11:07:18 INFO - 'tabpaint']}, 11:07:18 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 11:07:18 INFO - 'ts_paint', 11:07:18 INFO - 'tpaint', 11:07:18 INFO - 'sessionrestore', 11:07:18 INFO - 'sessionrestore_no_auto_restore', 11:07:18 INFO - 'tabpaint']}, 11:07:18 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 11:07:18 INFO - 'tests': ['a11yr', 11:07:18 INFO - 'ts_paint', 11:07:18 INFO - 'tpaint', 11:07:18 INFO - 'sessionrestore', 11:07:18 INFO - 'sessionrestore_no_auto_restore', 11:07:18 INFO - 'tabpaint']}, 11:07:18 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 11:07:18 INFO - 'tests': ['a11yr', 11:07:18 INFO - 'ts_paint', 11:07:18 INFO - 'tpaint', 11:07:18 INFO - 'sessionrestore', 11:07:18 INFO - 'sessionrestore_no_auto_restore', 11:07:18 INFO - 'tabpaint']}, 11:07:18 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 11:07:18 INFO - 'tests': ['tsvgx', 11:07:18 INFO - 'tsvgr_opacity', 11:07:18 INFO - 'tart', 11:07:18 INFO - 'tscrollx', 11:07:18 INFO - 'cart']}, 11:07:18 INFO - 'svgr-e10s': {'tests': ['tsvgx', 11:07:18 INFO - 'tsvgr_opacity', 11:07:18 INFO - 'tart', 11:07:18 INFO - 'tscrollx', 11:07:18 INFO - 'cart']}, 11:07:18 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:07:18 INFO - 'talos_options': ['--disable-e10s'], 11:07:18 INFO - 'tests': ['tp5o']}, 11:07:18 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:07:18 INFO - 'tests': ['tp5o']}, 11:07:18 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:07:18 INFO - 'talos_options': ['--disable-e10s', 11:07:18 INFO - '--xperf_path', 11:07:18 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 11:07:18 INFO - 'tests': ['tp5n']}, 11:07:18 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:07:18 INFO - 'talos_options': ['--xperf_path', 11:07:18 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 11:07:18 INFO - 'tests': ['tp5n']}}, 11:07:18 INFO - 'talos.zip': {'path': '', 11:07:18 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 11:07:18 INFO - Running post-action listener: _resource_record_post_action 11:07:18 INFO - [mozharness: 2016-07-24 18:07:18.394633Z] Finished populate-webroot step (success) 11:07:18 INFO - [mozharness: 2016-07-24 18:07:18.394723Z] Running create-virtualenv step. 11:07:18 INFO - Running pre-action listener: _resource_record_pre_action 11:07:18 INFO - Running main action method: create_virtualenv 11:07:18 INFO - Creating virtualenv /builds/slave/test/build/venv 11:07:18 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 11:07:18 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 11:07:18 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 11:07:18 INFO - Using real prefix '/usr' 11:07:18 INFO - New python executable in /builds/slave/test/build/venv/bin/python 11:07:19 INFO - Installing distribute.............................................................................................................................................................................................done. 11:07:20 INFO - Installing pip.................done. 11:07:20 INFO - Return code: 0 11:07:20 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 11:07:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:07:20 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:07:20 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:07:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:07:20 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:07:20 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:07:20 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 0x29cd030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b308a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2c8e180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2c8c3b0>, '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 0x2c8d2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2c8d740>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '6d15e502d8e29d5d2676d664000001c3-1469381342.99020-40446717', '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 11:07:20 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 11:07:20 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 11:07:20 INFO - Using env: {'DISPLAY': ':0', 11:07:20 INFO - 'HOME': '/home/cltbld', 11:07:20 INFO - 'LANG': 'en_US.UTF-8', 11:07:20 INFO - 'LANGUAGE': 'en_US:en', 11:07:20 INFO - 'LOGNAME': 'cltbld', 11:07:20 INFO - 'MAIL': '/var/mail/cltbld', 11:07:20 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:07:20 INFO - 'MOZ_NO_REMOTE': '1', 11:07:20 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:07:20 INFO - 'NO_EM_RESTART': '1', 11:07:20 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:07:20 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:07:20 INFO - 'PWD': '/builds/slave/test', 11:07:20 INFO - 'SHELL': '/bin/bash', 11:07:20 INFO - 'SHLVL': '1', 11:07:20 INFO - 'TERM': 'linux', 11:07:20 INFO - 'TMOUT': '86400', 11:07:20 INFO - 'USER': 'cltbld', 11:07:20 INFO - 'XDG_SESSION_COOKIE': '6d15e502d8e29d5d2676d664000001c3-1469381342.99020-40446717', 11:07:20 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:07:20 INFO - '_': '/tools/buildbot/bin/python'} 11:07:21 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:07:21 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 11:07:21 INFO - Cleaning up... 11:07:21 INFO - Return code: 0 11:07:21 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 11:07:21 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')]} 11:07:21 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:07:21 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:07:21 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')]} 11:07:21 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:07:21 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:07:21 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 0x29cd030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b308a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2c8e180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2c8c3b0>, '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 0x2c8d2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2c8d740>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '6d15e502d8e29d5d2676d664000001c3-1469381342.99020-40446717', '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 11:07:21 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 11:07:21 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 11:07:21 INFO - Using env: {'DISPLAY': ':0', 11:07:21 INFO - 'HOME': '/home/cltbld', 11:07:21 INFO - 'LANG': 'en_US.UTF-8', 11:07:21 INFO - 'LANGUAGE': 'en_US:en', 11:07:21 INFO - 'LOGNAME': 'cltbld', 11:07:21 INFO - 'MAIL': '/var/mail/cltbld', 11:07:21 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:07:21 INFO - 'MOZ_NO_REMOTE': '1', 11:07:21 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:07:21 INFO - 'NO_EM_RESTART': '1', 11:07:21 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:07:21 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:07:21 INFO - 'PWD': '/builds/slave/test', 11:07:21 INFO - 'SHELL': '/bin/bash', 11:07:21 INFO - 'SHLVL': '1', 11:07:21 INFO - 'TERM': 'linux', 11:07:21 INFO - 'TMOUT': '86400', 11:07:21 INFO - 'USER': 'cltbld', 11:07:21 INFO - 'XDG_SESSION_COOKIE': '6d15e502d8e29d5d2676d664000001c3-1469381342.99020-40446717', 11:07:21 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:07:21 INFO - '_': '/tools/buildbot/bin/python'} 11:07:21 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:07:21 INFO - Downloading/unpacking psutil>=3.1.1 11:07:21 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:07:21 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:07:21 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:07:21 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:07:21 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:07:21 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:07:23 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 11:07:23 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 11:07:23 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 11:07:23 INFO - Installing collected packages: psutil 11:07:23 INFO - Running setup.py install for psutil 11:07:23 INFO - building 'psutil._psutil_linux' extension 11:07:23 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 11:07:23 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 11:07:23 INFO - building 'psutil._psutil_posix' extension 11:07:23 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 11:07:23 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 11:07:23 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 11:07:23 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 11:07:23 INFO - Successfully installed psutil 11:07:23 INFO - Cleaning up... 11:07:23 INFO - Return code: 0 11:07:23 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 11:07: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')]} 11:07:24 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:07:24 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:07: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')]} 11:07:24 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:07:24 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:07:24 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x29cd030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b308a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2c8e180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2c8c3b0>, '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 0x2c8d2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2c8d740>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '6d15e502d8e29d5d2676d664000001c3-1469381342.99020-40446717', '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 11:07:24 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 11:07:24 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 11:07:24 INFO - Using env: {'DISPLAY': ':0', 11:07:24 INFO - 'HOME': '/home/cltbld', 11:07:24 INFO - 'LANG': 'en_US.UTF-8', 11:07:24 INFO - 'LANGUAGE': 'en_US:en', 11:07:24 INFO - 'LOGNAME': 'cltbld', 11:07:24 INFO - 'MAIL': '/var/mail/cltbld', 11:07:24 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:07:24 INFO - 'MOZ_NO_REMOTE': '1', 11:07:24 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:07:24 INFO - 'NO_EM_RESTART': '1', 11:07:24 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:07:24 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:07:24 INFO - 'PWD': '/builds/slave/test', 11:07:24 INFO - 'SHELL': '/bin/bash', 11:07:24 INFO - 'SHLVL': '1', 11:07:24 INFO - 'TERM': 'linux', 11:07:24 INFO - 'TMOUT': '86400', 11:07:24 INFO - 'USER': 'cltbld', 11:07:24 INFO - 'XDG_SESSION_COOKIE': '6d15e502d8e29d5d2676d664000001c3-1469381342.99020-40446717', 11:07:24 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:07:24 INFO - '_': '/tools/buildbot/bin/python'} 11:07:24 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:07:24 INFO - Downloading/unpacking mozsystemmonitor==0.3 11:07:24 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:07:24 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:07:24 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:07:24 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:07:24 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:07:24 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:07:26 INFO - Downloading mozsystemmonitor-0.3.tar.gz 11:07:26 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 11:07:26 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 11:07:26 INFO - Installing collected packages: mozsystemmonitor 11:07:26 INFO - Running setup.py install for mozsystemmonitor 11:07:26 INFO - Successfully installed mozsystemmonitor 11:07:26 INFO - Cleaning up... 11:07:26 INFO - Return code: 0 11:07:26 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 11:07: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')]} 11:07:26 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:07:26 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:07: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')]} 11:07:26 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:07:26 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:07:26 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 0x29cd030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b308a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2c8e180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2c8c3b0>, '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 0x2c8d2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2c8d740>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '6d15e502d8e29d5d2676d664000001c3-1469381342.99020-40446717', '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 11:07:26 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 11:07:26 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 11:07:26 INFO - Using env: {'DISPLAY': ':0', 11:07:26 INFO - 'HOME': '/home/cltbld', 11:07:26 INFO - 'LANG': 'en_US.UTF-8', 11:07:26 INFO - 'LANGUAGE': 'en_US:en', 11:07:26 INFO - 'LOGNAME': 'cltbld', 11:07:26 INFO - 'MAIL': '/var/mail/cltbld', 11:07:26 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:07:26 INFO - 'MOZ_NO_REMOTE': '1', 11:07:26 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:07:26 INFO - 'NO_EM_RESTART': '1', 11:07:26 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:07:26 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:07:26 INFO - 'PWD': '/builds/slave/test', 11:07:26 INFO - 'SHELL': '/bin/bash', 11:07:26 INFO - 'SHLVL': '1', 11:07:26 INFO - 'TERM': 'linux', 11:07:26 INFO - 'TMOUT': '86400', 11:07:26 INFO - 'USER': 'cltbld', 11:07:26 INFO - 'XDG_SESSION_COOKIE': '6d15e502d8e29d5d2676d664000001c3-1469381342.99020-40446717', 11:07:26 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:07:26 INFO - '_': '/tools/buildbot/bin/python'} 11:07:26 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:07:26 INFO - Downloading/unpacking jsonschema==2.5.1 11:07:26 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 11:07:26 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 11:07:26 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 11:07:26 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 11:07:26 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 11:07:26 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 11:07:28 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 11:07:28 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 11:07:28 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 11:07:28 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 11:07:28 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 11:07:28 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 11:07:28 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 11:07:28 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 11:07:28 INFO - Downloading functools32-3.2.3-2.tar.gz 11:07:28 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 11:07:28 INFO - warning: no files found matching '*.txt' 11:07:28 INFO - no previously-included directories found matching 'build' 11:07:28 INFO - no previously-included directories found matching 'dist' 11:07:28 INFO - no previously-included directories found matching '.git*' 11:07:28 INFO - Installing collected packages: jsonschema, functools32 11:07:28 INFO - Running setup.py install for functools32 11:07:28 INFO - warning: no files found matching '*.txt' 11:07:28 INFO - no previously-included directories found matching 'build' 11:07:28 INFO - no previously-included directories found matching 'dist' 11:07:28 INFO - no previously-included directories found matching '.git*' 11:07:28 INFO - Successfully installed jsonschema functools32 11:07:28 INFO - Cleaning up... 11:07:28 INFO - Return code: 0 11:07:28 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 11:07:28 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')]} 11:07:28 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:07:28 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:07:28 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')]} 11:07:28 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:07:28 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:07:28 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 0x29cd030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b308a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2c8e180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2c8c3b0>, '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 0x2c8d2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2c8d740>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '6d15e502d8e29d5d2676d664000001c3-1469381342.99020-40446717', '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 11:07:28 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 11:07:28 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 11:07:28 INFO - Using env: {'DISPLAY': ':0', 11:07:28 INFO - 'HOME': '/home/cltbld', 11:07:28 INFO - 'LANG': 'en_US.UTF-8', 11:07:28 INFO - 'LANGUAGE': 'en_US:en', 11:07:28 INFO - 'LOGNAME': 'cltbld', 11:07:28 INFO - 'MAIL': '/var/mail/cltbld', 11:07:28 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:07:28 INFO - 'MOZ_NO_REMOTE': '1', 11:07:28 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:07:28 INFO - 'NO_EM_RESTART': '1', 11:07:28 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:07:28 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:07:28 INFO - 'PWD': '/builds/slave/test', 11:07:28 INFO - 'SHELL': '/bin/bash', 11:07:28 INFO - 'SHLVL': '1', 11:07:28 INFO - 'TERM': 'linux', 11:07:28 INFO - 'TMOUT': '86400', 11:07:28 INFO - 'USER': 'cltbld', 11:07:28 INFO - 'XDG_SESSION_COOKIE': '6d15e502d8e29d5d2676d664000001c3-1469381342.99020-40446717', 11:07:28 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:07:28 INFO - '_': '/tools/buildbot/bin/python'} 11:07:29 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:07:29 INFO - Downloading/unpacking blobuploader==1.2.4 11:07:29 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 11:07:29 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 11:07:29 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 11:07:29 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 11:07:29 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 11:07:29 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 11:07:30 INFO - Downloading blobuploader-1.2.4.tar.gz 11:07:30 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 11:07:31 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 11:07:31 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 11:07:31 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 11:07:31 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 11:07:31 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 11:07:31 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 11:07:31 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 11:07:31 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 11:07:31 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 11:07:31 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 11:07:31 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 11:07:31 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 11:07:31 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 11:07:31 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 11:07:31 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 11:07:31 INFO - Downloading docopt-0.6.1.tar.gz 11:07:31 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 11:07:31 INFO - Installing collected packages: blobuploader, requests, docopt 11:07:31 INFO - Running setup.py install for blobuploader 11:07:31 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 11:07:31 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 11:07:31 INFO - Running setup.py install for requests 11:07:32 INFO - Running setup.py install for docopt 11:07:32 INFO - Successfully installed blobuploader requests docopt 11:07:32 INFO - Cleaning up... 11:07:32 INFO - Return code: 0 11:07:32 INFO - Installing None into virtualenv /builds/slave/test/build/venv 11:07:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:07:32 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:07:32 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:07:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:07:32 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:07:32 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:07:32 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 0x29cd030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b308a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2c8e180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2c8c3b0>, '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 0x2c8d2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2c8d740>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build/tests/config', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '6d15e502d8e29d5d2676d664000001c3-1469381342.99020-40446717', '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 11:07:32 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 11:07:32 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 11:07:32 INFO - Using env: {'DISPLAY': ':0', 11:07:32 INFO - 'HOME': '/home/cltbld', 11:07:32 INFO - 'LANG': 'en_US.UTF-8', 11:07:32 INFO - 'LANGUAGE': 'en_US:en', 11:07:32 INFO - 'LOGNAME': 'cltbld', 11:07:32 INFO - 'MAIL': '/var/mail/cltbld', 11:07:32 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:07:32 INFO - 'MOZ_NO_REMOTE': '1', 11:07:32 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:07:32 INFO - 'NO_EM_RESTART': '1', 11:07:32 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:07:32 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:07:32 INFO - 'PWD': '/builds/slave/test', 11:07:32 INFO - 'SHELL': '/bin/bash', 11:07:32 INFO - 'SHLVL': '1', 11:07:32 INFO - 'TERM': 'linux', 11:07:32 INFO - 'TMOUT': '86400', 11:07:32 INFO - 'USER': 'cltbld', 11:07:32 INFO - 'XDG_SESSION_COOKIE': '6d15e502d8e29d5d2676d664000001c3-1469381342.99020-40446717', 11:07:32 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:07:32 INFO - '_': '/tools/buildbot/bin/python'} 11:07:32 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:07:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 11:07:32 INFO - Running setup.py (path:/tmp/pip-iWRlF1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 11:07:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 11:07:32 INFO - Running setup.py (path:/tmp/pip-HQ2oas-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 11:07:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 11:07:32 INFO - Running setup.py (path:/tmp/pip-IN8W2O-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 11:07:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 11:07:32 INFO - Running setup.py (path:/tmp/pip-crLCJj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 11:07:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 11:07:32 INFO - Running setup.py (path:/tmp/pip-SU4tul-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 11:07:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 11:07:32 INFO - Running setup.py (path:/tmp/pip-ZL4_NP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 11:07:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 11:07:33 INFO - Running setup.py (path:/tmp/pip-DeyGw9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 11:07:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 11:07:33 INFO - Running setup.py (path:/tmp/pip-W5npIz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 11:07:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 11:07:33 INFO - Running setup.py (path:/tmp/pip-aXVDkB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 11:07:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 11:07:33 INFO - Running setup.py (path:/tmp/pip-UaTYro-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 11:07:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 11:07:33 INFO - Running setup.py (path:/tmp/pip-jKJ8dJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 11:07:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 11:07:33 INFO - Running setup.py (path:/tmp/pip-NXTxXl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 11:07:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 11:07:33 INFO - Running setup.py (path:/tmp/pip-b8rHwS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 11:07:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 11:07:33 INFO - Running setup.py (path:/tmp/pip-XJvwPQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 11:07:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 11:07:33 INFO - Running setup.py (path:/tmp/pip-a3Q24Z-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 11:07:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 11:07:33 INFO - Running setup.py (path:/tmp/pip-s3lWXw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 11:07:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 11:07:33 INFO - Running setup.py (path:/tmp/pip-sDDdBw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 11:07:33 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 11:07:33 INFO - Running setup.py install for manifestparser 11:07:33 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 11:07:33 INFO - Running setup.py install for mozcrash 11:07:34 INFO - Running setup.py install for mozdebug 11:07:34 INFO - Running setup.py install for mozdevice 11:07:34 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 11:07:34 INFO - Installing dm script to /builds/slave/test/build/venv/bin 11:07:34 INFO - Running setup.py install for mozfile 11:07:34 INFO - Running setup.py install for mozhttpd 11:07:34 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 11:07:34 INFO - Running setup.py install for mozinfo 11:07:34 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 11:07:34 INFO - Running setup.py install for mozInstall 11:07:34 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 11:07:34 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 11:07:34 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 11:07:34 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 11:07:34 INFO - Running setup.py install for mozleak 11:07:34 INFO - Running setup.py install for mozlog 11:07:34 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 11:07:34 INFO - Running setup.py install for moznetwork 11:07:34 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 11:07:34 INFO - Running setup.py install for mozprocess 11:07:35 INFO - Running setup.py install for mozprofile 11:07:35 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 11:07:35 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 11:07:35 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 11:07:35 INFO - Running setup.py install for mozrunner 11:07:35 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 11:07:35 INFO - Running setup.py install for mozscreenshot 11:07:35 INFO - Running setup.py install for moztest 11:07:35 INFO - Running setup.py install for mozversion 11:07:35 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 11:07:35 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 11:07:35 INFO - Cleaning up... 11:07:35 INFO - Return code: 0 11:07:35 INFO - Installing None into virtualenv /builds/slave/test/build/venv 11:07:35 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')]} 11:07:35 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:07:35 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:07:35 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')]} 11:07:35 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:07:35 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:07:35 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 0x29cd030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b308a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2c8e180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2c8c3b0>, '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 0x2c8d2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2c8d740>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build/tests/config', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '6d15e502d8e29d5d2676d664000001c3-1469381342.99020-40446717', '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 11:07:35 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 11:07:35 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 11:07:35 INFO - Using env: {'DISPLAY': ':0', 11:07:35 INFO - 'HOME': '/home/cltbld', 11:07:35 INFO - 'LANG': 'en_US.UTF-8', 11:07:35 INFO - 'LANGUAGE': 'en_US:en', 11:07:35 INFO - 'LOGNAME': 'cltbld', 11:07:35 INFO - 'MAIL': '/var/mail/cltbld', 11:07:35 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:07:35 INFO - 'MOZ_NO_REMOTE': '1', 11:07:35 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:07:35 INFO - 'NO_EM_RESTART': '1', 11:07:35 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:07:35 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:07:35 INFO - 'PWD': '/builds/slave/test', 11:07:35 INFO - 'SHELL': '/bin/bash', 11:07:35 INFO - 'SHLVL': '1', 11:07:35 INFO - 'TERM': 'linux', 11:07:35 INFO - 'TMOUT': '86400', 11:07:35 INFO - 'USER': 'cltbld', 11:07:35 INFO - 'XDG_SESSION_COOKIE': '6d15e502d8e29d5d2676d664000001c3-1469381342.99020-40446717', 11:07:35 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:07:35 INFO - '_': '/tools/buildbot/bin/python'} 11:07:35 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:07:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 11:07:35 INFO - Running setup.py (path:/tmp/pip-5AvfP0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 11:07:35 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)) 11:07:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 11:07:35 INFO - Running setup.py (path:/tmp/pip-LIEO3W-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 11:07:35 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)) 11:07:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 11:07:35 INFO - Running setup.py (path:/tmp/pip-3rFLcq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 11:07:36 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)) 11:07:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 11:07:36 INFO - Running setup.py (path:/tmp/pip-Ej8y0p-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 11:07:36 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)) 11:07:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 11:07:36 INFO - Running setup.py (path:/tmp/pip-Y3IzRt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 11:07:36 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)) 11:07:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 11:07:36 INFO - Running setup.py (path:/tmp/pip-3IPoXQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 11:07:36 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)) 11:07:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 11:07:36 INFO - Running setup.py (path:/tmp/pip-rX70mN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 11:07:36 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)) 11:07:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 11:07:36 INFO - Running setup.py (path:/tmp/pip-8mggIi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 11:07:36 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)) 11:07:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 11:07:36 INFO - Running setup.py (path:/tmp/pip-LIy6OP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 11:07:36 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)) 11:07:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 11:07:36 INFO - Running setup.py (path:/tmp/pip-bNoCsY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 11:07:36 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.3 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 11:07:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 11:07:36 INFO - Running setup.py (path:/tmp/pip-7ZdeVd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 11:07:36 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)) 11:07:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 11:07:36 INFO - Running setup.py (path:/tmp/pip-2FDFFF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 11:07:36 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)) 11:07:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 11:07:36 INFO - Running setup.py (path:/tmp/pip-tOMrPZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 11:07:36 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)) 11:07:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 11:07:36 INFO - Running setup.py (path:/tmp/pip-sZQ0o1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 11:07:36 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)) 11:07:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 11:07:36 INFO - Running setup.py (path:/tmp/pip-dPLT7F-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 11:07:36 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)) 11:07:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 11:07:36 INFO - Running setup.py (path:/tmp/pip-dCgMVe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 11:07:36 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)) 11:07:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 11:07:36 INFO - Running setup.py (path:/tmp/pip-EM8PiK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 11:07:37 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)) 11:07:37 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)) 11:07:37 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)) 11:07:37 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)) 11:07:37 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)) 11:07:37 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)) 11:07:37 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.3->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 11:07:37 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 11:07:37 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 11:07:37 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 11:07:37 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 11:07:37 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 11:07:37 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 11:07:38 INFO - Downloading blessings-1.6.tar.gz 11:07:38 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 11:07:39 INFO - Installing collected packages: blessings 11:07:39 INFO - Running setup.py install for blessings 11:07:39 INFO - Successfully installed blessings 11:07:39 INFO - Cleaning up... 11:07:39 INFO - Return code: 0 11:07:39 INFO - Done creating virtualenv /builds/slave/test/build/venv. 11:07:39 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 11:07:39 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 11:07:39 INFO - Reading from file tmpfile_stdout 11:07:39 INFO - Current package versions: 11:07:39 INFO - argparse == 1.2.1 11:07:39 INFO - blessings == 1.6 11:07:39 INFO - blobuploader == 1.2.4 11:07:39 INFO - docopt == 0.6.1 11:07:39 INFO - functools32 == 3.2.3-2 11:07:39 INFO - jsonschema == 2.5.1 11:07:39 INFO - manifestparser == 1.1 11:07:39 INFO - mozInstall == 1.12 11:07:39 INFO - mozcrash == 0.17 11:07:39 INFO - mozdebug == 0.1 11:07:39 INFO - mozdevice == 0.48 11:07:39 INFO - mozfile == 1.2 11:07:39 INFO - mozhttpd == 0.7 11:07:39 INFO - mozinfo == 0.9 11:07:39 INFO - mozleak == 0.1 11:07:39 INFO - mozlog == 3.3 11:07:39 INFO - moznetwork == 0.27 11:07:39 INFO - mozprocess == 0.23 11:07:39 INFO - mozprofile == 0.28 11:07:39 INFO - mozrunner == 6.12 11:07:39 INFO - mozscreenshot == 0.1 11:07:39 INFO - mozsystemmonitor == 0.3 11:07:39 INFO - moztest == 0.7 11:07:39 INFO - mozversion == 1.4 11:07:39 INFO - psutil == 3.1.1 11:07:39 INFO - requests == 1.2.3 11:07:39 INFO - wsgiref == 0.1.2 11:07:39 INFO - Installing None into virtualenv /builds/slave/test/build/venv 11:07:39 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')]} 11:07:39 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:07:39 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:07:39 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')]} 11:07:39 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:07:39 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:07:39 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 0x29cd030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b308a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2c8e180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2c8c3b0>, '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 0x2c8d2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2c8d740>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build/tests/talos', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '6d15e502d8e29d5d2676d664000001c3-1469381342.99020-40446717', '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 11:07:39 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 11:07:39 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 11:07:39 INFO - Using env: {'DISPLAY': ':0', 11:07:39 INFO - 'HOME': '/home/cltbld', 11:07:39 INFO - 'LANG': 'en_US.UTF-8', 11:07:39 INFO - 'LANGUAGE': 'en_US:en', 11:07:39 INFO - 'LOGNAME': 'cltbld', 11:07:39 INFO - 'MAIL': '/var/mail/cltbld', 11:07:39 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:07:39 INFO - 'MOZ_NO_REMOTE': '1', 11:07:39 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:07:39 INFO - 'NO_EM_RESTART': '1', 11:07:39 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:07:39 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:07:39 INFO - 'PWD': '/builds/slave/test', 11:07:39 INFO - 'SHELL': '/bin/bash', 11:07:39 INFO - 'SHLVL': '1', 11:07:39 INFO - 'TERM': 'linux', 11:07:39 INFO - 'TMOUT': '86400', 11:07:39 INFO - 'USER': 'cltbld', 11:07:39 INFO - 'XDG_SESSION_COOKIE': '6d15e502d8e29d5d2676d664000001c3-1469381342.99020-40446717', 11:07:39 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:07:39 INFO - '_': '/tools/buildbot/bin/python'} 11:07:39 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:07:39 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)) 11:07:39 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)) 11:07:39 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)) 11:07:39 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)) 11:07:39 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)) 11:07:39 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)) 11:07:39 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)) 11:07:39 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)) 11:07:39 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)) 11:07:39 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)) 11:07:39 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)) 11:07:39 INFO - Cleaning up... 11:07:39 INFO - Return code: 0 11:07:39 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 11:07:39 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')]} 11:07:39 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:07:39 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:07:39 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')]} 11:07:39 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:07:39 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:07:39 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 0x29cd030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b308a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2c8e180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2c8c3b0>, '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 0x2c8d2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2c8d740>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '6d15e502d8e29d5d2676d664000001c3-1469381342.99020-40446717', '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 11:07:39 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 11:07:39 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 11:07:39 INFO - Using env: {'DISPLAY': ':0', 11:07:39 INFO - 'HOME': '/home/cltbld', 11:07:39 INFO - 'LANG': 'en_US.UTF-8', 11:07:39 INFO - 'LANGUAGE': 'en_US:en', 11:07:39 INFO - 'LOGNAME': 'cltbld', 11:07:39 INFO - 'MAIL': '/var/mail/cltbld', 11:07:39 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:07:39 INFO - 'MOZ_NO_REMOTE': '1', 11:07:39 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:07:39 INFO - 'NO_EM_RESTART': '1', 11:07:39 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:07:39 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:07:39 INFO - 'PWD': '/builds/slave/test', 11:07:39 INFO - 'SHELL': '/bin/bash', 11:07:39 INFO - 'SHLVL': '1', 11:07:39 INFO - 'TERM': 'linux', 11:07:39 INFO - 'TMOUT': '86400', 11:07:39 INFO - 'USER': 'cltbld', 11:07:39 INFO - 'XDG_SESSION_COOKIE': '6d15e502d8e29d5d2676d664000001c3-1469381342.99020-40446717', 11:07:39 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:07:39 INFO - '_': '/tools/buildbot/bin/python'} 11:07:39 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:07:39 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 11:07:39 INFO - Cleaning up... 11:07:39 INFO - Return code: 0 11:07:39 INFO - Running post-action listener: _resource_record_post_action 11:07:39 INFO - Running post-action listener: _start_resource_monitoring 11:07:39 INFO - Starting resource monitoring. 11:07:39 INFO - [mozharness: 2016-07-24 18:07:39.888456Z] Finished create-virtualenv step (success) 11:07:39 INFO - [mozharness: 2016-07-24 18:07:39.888892Z] Running install step. 11:07:39 INFO - Running pre-action listener: _resource_record_pre_action 11:07:39 INFO - Running main action method: install 11:07:39 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 11:07:39 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 11:07:40 INFO - Reading from file tmpfile_stdout 11:07:40 INFO - Detecting whether we're running mozinstall >=1.0... 11:07:40 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 11:07:40 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 11:07:40 INFO - Reading from file tmpfile_stdout 11:07:40 INFO - Output received: 11:07:40 INFO - Usage: mozinstall [options] installer 11:07:40 INFO - Options: 11:07:40 INFO - -h, --help show this help message and exit 11:07:40 INFO - -d DEST, --destination=DEST 11:07:40 INFO - Directory to install application into. [default: 11:07:40 INFO - "/builds/slave/test"] 11:07:40 INFO - --app=APP Application being installed. [default: firefox] 11:07:40 INFO - mkdir: /builds/slave/test/build/application 11:07:40 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'] 11:07:40 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 11:07:57 INFO - Reading from file tmpfile_stdout 11:07:57 INFO - Output received: 11:07:57 INFO - /builds/slave/test/build/application/firefox/firefox 11:07:57 INFO - Running post-action listener: _resource_record_post_action 11:07:57 INFO - [mozharness: 2016-07-24 18:07:57.401722Z] Finished install step (success) 11:07:57 INFO - [mozharness: 2016-07-24 18:07:57.402007Z] Running run-tests step. 11:07:57 INFO - Running pre-action listener: _resource_record_pre_action 11:07:57 INFO - Running main action method: run_tests 11:07:57 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 11:07:57 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 11:07:57 INFO - Python 2.7.3 11:07:57 INFO - Return code: 0 11:07:57 INFO - grabbing minidump binary from tooltool 11:07:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:07:57 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 0x2c8c3b0>, '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 0x2c8d2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2c8d740>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 11:07:57 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 11:07:57 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 11:07:57 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 11:07:57 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 11:07:57 INFO - Return code: 0 11:07:57 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 11:07:57 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 11:07:57 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 11:07:57 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 11:07:57 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 11:07:57 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/UinhjyB_Qdau-Gs9Dxz_lw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-023', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] in /builds/slave/test/build 11:07:57 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Fx-Team --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/UinhjyB_Qdau-Gs9Dxz_lw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-023 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log 11:07:57 INFO - Using env: {'DISPLAY': ':0', 11:07:57 INFO - 'HOME': '/home/cltbld', 11:07:57 INFO - 'LANG': 'en_US.UTF-8', 11:07:57 INFO - 'LANGUAGE': 'en_US:en', 11:07:57 INFO - 'LOGNAME': 'cltbld', 11:07:57 INFO - 'MAIL': '/var/mail/cltbld', 11:07:57 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 11:07:57 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 11:07:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:07:57 INFO - 'MOZ_NO_REMOTE': '1', 11:07:57 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 11:07:57 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:07:57 INFO - 'NO_EM_RESTART': '1', 11:07:57 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:07:57 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:07:57 INFO - 'PWD': '/builds/slave/test', 11:07:57 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 11:07:57 INFO - 'SHELL': '/bin/bash', 11:07:57 INFO - 'SHLVL': '1', 11:07:57 INFO - 'TERM': 'linux', 11:07:57 INFO - 'TMOUT': '86400', 11:07:57 INFO - 'USER': 'cltbld', 11:07:57 INFO - 'XDG_SESSION_COOKIE': '6d15e502d8e29d5d2676d664000001c3-1469381342.99020-40446717', 11:07:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:07:57 INFO - '_': '/tools/buildbot/bin/python'} 11:07:57 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/UinhjyB_Qdau-Gs9Dxz_lw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-023', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] with output_timeout 3600 11:07:57 INFO - mozversion application_buildid: 20160724083055 11:07:57 INFO - mozversion application_changeset: d12890b78b043ccc2445dcef144e982f83b65e5f 11:07:57 INFO - mozversion application_display_name: Nightly 11:07:57 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 11:07:57 INFO - mozversion application_name: Firefox 11:07:57 INFO - mozversion application_remotingname: firefox 11:07:57 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 11:07:57 INFO - mozversion application_vendor: Mozilla 11:07:57 INFO - mozversion application_version: 50.0a1 11:07:57 INFO - mozversion platform_buildid: 20160724083055 11:07:57 INFO - mozversion platform_changeset: d12890b78b043ccc2445dcef144e982f83b65e5f 11:07:57 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 11:07:57 INFO - mozversion platform_version: 50.0a1 11:07:57 INFO - using testdate: 1469383677 11:07:57 INFO - actual date: 1469383677 11:07:57 INFO - starting webserver on 'localhost:37692' 11:07:57 INFO - SUITE-START | Running 2 tests 11:07:57 INFO - TEST-START | dromaeo_css 11:07:57 INFO - operating with platform_type : linux_ 11:07:57 INFO - Initialising browser for dromaeo_css test... 11:07:57 INFO - TEST-INFO | started process 21153 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpiVT5VR/profile http://localhost:37692/getInfo.html) 11:08:00 INFO - PROCESS | 21153 | JavaScript error: , line 0: uncaught exception: undefined 11:08:02 INFO - PROCESS | 21153 | __metrics Screen width/height:1600/1200 11:08:02 INFO - PROCESS | 21153 | colorDepth:24 11:08:02 INFO - PROCESS | 21153 | Browser inner width/height: 1024/697 11:08:02 INFO - PROCESS | 21153 | __metrics 11:08:02 ERROR - PROCESS | 21153 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2968: TypeError: this.tabs is undefined 11:08:03 INFO - TEST-INFO | 21153: exit 0 11:08:03 INFO - Browser initialized. 11:08:03 INFO - Running cycle 1/1 for dromaeo_css test... 11:08:03 INFO - TEST-INFO | started process 21275 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpiVT5VR/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 11:08:15 INFO - PROCESS | 21275 | RSS: Main: 167817216 11:08:15 INFO - PROCESS | 21275 | 11:09:05 INFO - PROCESS | 21275 | 1469383745164 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] 11:11:14 INFO - PROCESS | 21275 | Cycle 1(1): loaded http://localhost:37692/tests/dromaeo/cssquery-dojo.html (next: http://localhost:37692/tests/dromaeo/cssquery-ext.html) 11:11:15 INFO - PROCESS | 21275 | RSS: Main: 172093440 11:11:15 INFO - PROCESS | 21275 | 11:14:17 INFO - PROCESS | 21275 | Cycle 1(1): loaded http://localhost:37692/tests/dromaeo/cssquery-ext.html (next: http://localhost:37692/tests/dromaeo/cssquery-jquery.html) 11:14:17 INFO - PROCESS | 21275 | RSS: Main: 170127360 11:14:17 INFO - PROCESS | 21275 | 11:17:19 INFO - PROCESS | 21275 | Cycle 1(1): loaded http://localhost:37692/tests/dromaeo/cssquery-jquery.html (next: http://localhost:37692/tests/dromaeo/cssquery-mootools.html) 11:17:20 INFO - PROCESS | 21275 | RSS: Main: 173789184 11:17:20 INFO - PROCESS | 21275 | 11:20:22 INFO - PROCESS | 21275 | Cycle 1(1): loaded http://localhost:37692/tests/dromaeo/cssquery-mootools.html (next: http://localhost:37692/tests/dromaeo/cssquery-prototype.html) 11:20:22 INFO - PROCESS | 21275 | RSS: Main: 168538112 11:20:22 INFO - PROCESS | 21275 | 11:23:25 INFO - PROCESS | 21275 | Cycle 1(1): loaded http://localhost:37692/tests/dromaeo/cssquery-prototype.html (next: http://localhost:37692/tests/dromaeo/cssquery-yui.html) 11:23:25 INFO - PROCESS | 21275 | RSS: Main: 169889792 11:23:25 INFO - PROCESS | 21275 | 11:26:28 INFO - PROCESS | 21275 | Cycle 1(1): loaded http://localhost:37692/tests/dromaeo/cssquery-yui.html (next: http://localhost:37692/tests/dromaeo/cssquery-dojo.html) 11:26:28 INFO - PROCESS | 21275 | RSS: Main: 172830720 11:26:28 INFO - PROCESS | 21275 | 11:26:28 INFO - PROCESS | 21275 | __start_tp_report 11:26:28 INFO - PROCESS | 21275 | _x_x_mozilla_page_load 11:26:28 INFO - PROCESS | 21275 | _x_x_mozilla_page_load_details 11:26:28 INFO - PROCESS | 21275 | |i|pagename|runs| 11:26:28 INFO - PROCESS | 21275 | |0;dojo.html;3108.471559834828;3121.3913286909046;3147.74818014559;3152.4798408262636;3152.8581213845373;5512.228288039672;5567.164925261208;5598.776048958041;5622.634528755628;5623.0721930881455;5362.8123015694455;5458.208559758833;5501.944980550194;5530.944690553093;5601.047821870282;4920.753962301879;4963.70217786934;5060.974695126519;5073.822416215433;5150.1244788385875;4975.27858460523;5076.974615126919;5125.4618265082;5131.384233891919;5156.123459011958;4945.480724523909;5027.170516864713;5052.065367906912;5059.443461219263;5130.820421285237;5065.39215294167;5086.084504789136;5097.260897169889;5111.309973153614;5143.382794064699;5050.3434553507805;5060.7722652480725;5077;5083.567896728782;5091.312672789163;5403.48879600081;5438.129899216106;5446.264754258164;5505.311836020497;5569.443055694439;5876.44173803488;5881.558883083743;5886.23478947734;5897.0859516774535;5910.615809972338;5930.673812940329;5933.643981361132;5936.46571808535;5936.821895343147;5942.049272116441;5405.648632838892;5437.048516509634;5497.972510137463;5499.780008799643;5575.553955683536;6039.607425517327;6045.6070355426755;6045.63726176422;6050.3949605040025;6051.122587224828;5791.7683292667825;5791.942080579224;5793.826185214451;5797.739101740432;5809.215755872988;5802.419758024248;5871.471567558855;5925.970370148121;5933.970330148321;6039.7282122304605;5736.053551164095;5834.562407819346;5905.498032667271;5905.995980683294;5922.170896074553;5841.88316233673;5891.145783861316;5950.553708471882;5961.195238642815;5968.612040217372;4408.779561021936;4476.485204201558;4480.865574032719;4511.210538155875;4513.954860451419;4041.373587094005;4044.797760111983;4059.5534491205945;4082.7346222496035;4083.0813067059676;5635.943640563624;5643.294588176478;5646.548276137899;5669.801556945487;5695.231143795618;5770;5923.822285331447;5951.1073338999495;5963.612365196248;5976.641401515923;5677.37548869624;5683;5691.459311365414;5706.144078388275;5716.114002329646;5155.639105262596;5156.664816786897;5157.613179011514;5166.61250406221;5206.219067139959;5997;6108.760397969407;6111.755529778759;6178.0424034273865;6205;6019.127226552037;6020.789272375446;6026.126211699367;6071.483923866521;6073.787417440369;6114.2357205349335;6127.14220009208;6132.08018797184;6142;6145.477634401126;5598.300212473441;5755.3381361144;5804.100364443518;5823.4176582343125;5850.5027072699295;5854.0340843760305;5889.204957330706;5903.852403689943;5904.940950590439;5950.404959504015;5761.164631128547;5781.768729250783;5790.478856902899;5793.073108302651;5793.536517078539;5665.03694371966;5767.077267637158;5780.971095144498;5785.710714464344;5794.884102317846;5762.654240745569;5789.421057894177;5814.505767009682;5861.531077513874;5862.091375836752;5860.677662728591;5868.767558812697;5871.588988770745;5945.227120474311;5953.583249172516;5596.748146333506;5612.7754889803955;5697.943020569741;5751.9137212941005;5763.7982670606325 11:26:28 INFO - PROCESS | 21275 | |1;ext.html;550.5273835669054;592.3454582686131;595.1162523652379;617.3486971245335;642.9871402571952;41790.79104604477;42602.573974260245;42611.869406529666;42758.50345237918;42903.57096429031;43371;43903.560964390344;43903.560964390344;43989.7800510997;44051.77974110125;8846.82306353874;9016.41393309436;9024.684136055239;9031.729048128567;9039.41243819153;8912.910870891274;8996.280297576179;9015.143561361692;9037.41256818308;9042.186203241707;8996.730098097034;9095.772605684844;9101.544922753868;9107.68123115691;9123;9025.864612030791;9042.367034307601;9063.274938004977;9065.818683626356;9084.8637270441;8923.375363724543;8938.284937205073;8985.955070224607;8986.865197021985;9061.048589898031;40307.99230019244;40688.593114068775;40784.796076019724;40811.59188408108;40930;3667.0465678923406;3671.86055922188;3763.322601931651;3848.615138486157;4342.587454191878;32276.424786686282;32383.83808080968;32838.469744857735;33036.834815826005;33253.16867078318;4411.845585404495;4420.248557745159;4440.467143942716;4451.621612162938;4662.347271382009;372621;375065;375939;376047;376539;58006.70996645074;58172.70913645489;58199.709001455565;58213;58362.708186458796;35836.46245306323;36913.26173476569;36985.81507092447;38380.8080959599;60819;16031.118288494245;16226.594335141479;16275.51173464798;16299;16401.917990409973;12179.573714920112;12225.083118766128;12254.08094392924;12264.141510094209;12276.693082672826;19236;19393.22427102928;19407.161064202508;19509.985013766334;19592.412227633195;7012.580659672405;7050.400715939202;7082.433405327562;7174.677139528734;7341.3392794648735;1008.7528555503949;1048.2714513413105;1111.5998240633367;1123.5393488669606;1133.7505748735266;33041.3391732164;33384.49923251153;33481.66518334785;33642.831785840914;33788.49317260243;1133.1274918313018;1158.0272571040366;1172.806486929664;1174.8707642159357;1216.3310179401294;17276.654466910844;17345.913270433568;17407;17411.65176696459;17621;568263;569631;573441;573491;574705;60703;61053.08420373698;61070;61121.69439152865;61412.16584424472;1312.5996571045732;1353.8646135386382;1363.4614327340844;1371.6845125620964;1379.5792283353674;31424.34361814804;32853.17867053343;32970.67029329676;33222.16944576405;33474.33051339008;51972.48027519828;52660.21009684781;52701.47298527119;52817.20774188313;52887;462153;462352;463217;466525;468266;28410.431791363644;28633.713662863105;28767.280817979718;28920.7107928918;28979.130626081253;49091.50908490869;49408.75295623499;49871.75064124656;50417.74791126168;50770;41065.384019239136;41770.58229417788;41993.58006419897;42596.1480770389;43847.34228986504;41381.58618413898;41780;42015.579844201166;43368.349474758536;43525.56474435215;41112.58887411088;41307;43095.78452107719;43202.567974319856;43390.13219735651;35513.28973420569;38275.61724382832;38346;38377.232455350175;39032.41451378288;28670.56994145131;28924;28933.276668082624;29016.7098329014;29270.26824329409 11:26:28 INFO - PROCESS | 21275 | |2;jquery.html;378.8749712594844;379.9086031397158;393.44917116037544;396.4232042378339;416.3255526047803;18639.5340116497;19391.224351025976;20222.59554808903;20237.392878213657;20288.391348259538;18979.52551186221;19149.521261968424;19219.423417297505;19434.611307773837;19514.512137196543;5812.070068788995;5845.941540584604;5864.941350586503;5889.8822023559505;5918.674472903988;5711.7144142792695;5730.398308177623;5809.070548712207;5846.941530584703;5877.235959325281;5662.688552129631;5734.7419366128415;5795.971020144893;5812.941870581282;5849.181114643932;5729.541636669098;5749.482546570829;5800.9129863052085;5806.564507661942;5813.157092221646;4992.375953005874;5133.871653208662;5166.457521960216;5167.638265321429;5170.922436163461;22753.317400478012;22999.54000919989;23068.76931230683;23132;23220.53558928812;2162.9567408651897;2254.3237028891267;2357.045396614357;2407.879606019692;2503.6119401492797;10180.134688551481;10293.845592316122;10354.275200735952;10544.051035406774;10616.363018218854;1939.9030048497518;1971.8225359717694;2003.5391859872166;2010.5275260313815;2014.355406269994;72183;83656.58171709163;84003.57998210032;86244.56877715634;89628.55185724095;10693.732656683489;10741.624043158452;10920.50857711389;10967.177461690406;11143.498542565441;15014.624634384008;15044.774328385083;15085;15108.622284442978;15132.773008404884;7398.3341499265325;7478.2147874473485;7548.433867459853;7589.6205189741395;7708;7052.858942821114;7083.291670832876;7271.3455788979245;7278;7426.777196684108;4368.541303163122;4461.643068554573;4486.1252055849445;4543.114092751882;4792.634099281758;1965.3219639224444;2029.7450636222184;2038.0624912540102;2051.282051282069;2064.5251592133895;841.835842010802;890.2922176869405;955.3599088610648;966.6761634852263;1032.6385764982347;18851.245950162112;19661.901690491457;19711.80288197128;19762.209511619374;19917.800821991885;962.4177372689562;981.9263555233387;988.9208863290919;989.9010098990043;993.4982833669095;9388.95305523468;10926;10946.890531094587;10981.835272470918;11094.889051109385;536348;539985;554780;554817;556070;57298.42701573014;92803;93304;97422.5128874351;97745.51127244318;979.299800642544;985.280745056113;991.6578780320777;1048.0776916313748;1062.054771253585;17005.48983530496;17359.652806944043;17852.375166869097;17852.91073544624;18575.071246437896;43620.56379436165;43670.78164609284;43676.6896993078;43977.56022439735;44658.3301250475;54473;56825;60760.39239607548;62481.68759156175;63144.68427657832;8043.839123217386;8265.338772898274;8292.917070829455;8403.621837017472;8415.95792021036;12207.389630518615;12658.620241392773;12828.935855320664;12960.351982400654;13465.326733663082;11840.881591183977;11957.701057473632;12066.336351500751;12346.259224446561;12534.874651253736;11265.324080555192;11511.424428778695;11513.884861151617;11590.710232243924;11620.244684095507;6153;11067.889321107008;11569.537218511165;12111.576094836639;12439.626811195678;7340.229275925951;7499.737509187153;7693.192214817587;7781.766547003599;8373.95813020931;10576.259661823906;11602.477888495207;11711.941440292743;12102.939485302517;12132.818007729715 11:26:28 INFO - PROCESS | 21275 | |3;mootools.html;1495.1851241073614;1517.1883042572222;1662.2519866060268;1746.1618423156892;1803.981960180398;7983.682692355769;8459.746207613782;8651.307895368363;9070.092990700927;9076.092390760929;8410.91589084109;8580.699675511358;8713.128687131299;8731.956340218307;8767.956160219206;2203.6914831923505;2268.0587556164255;2271.716035495563;2271.8636881787065;2273.022600281878;2242.8093612042994;2267.5918334699745;2309.0763694522243;2333.9299821005397;2336.6728657987896;2297.896594653236;2303.251443280932;2320;2322.0247496051616;2344.601417758985;2202.8458007939453;2203.0857194264363;2203.2508946958033;2209.3151123151874;2225.121077174507;2200.2849074050996;2205.8345624078097;2213.302809614966;2214.7010153629217;2216.9778302217096;8862.069482704288;8873.689420870238;8936.285097192209;8940.374173807835;8954.955225223832;4937.506249375069;5010.323606313137;5030.547250747413;5056.367954005749;5066.822661206877;3129.640091389474;3166.255929856482;3278.327942771726;3314.9171270718184;3336.5328853960464;1019.9184065274834;1102.652664410708;1125.9324440533512;1126.938018408987;1133.9603113890973;12095.334756588383;12344.13591048627;12362.320072396014;12405.193662411913;12406.62780116598;4212.4523811904255;4291.31338985767;4432.778361081933;4436.556344365602;4477.1493416250805;10438.843417348746;10465.424401657981;10506.894931050745;10507.474626268657;10517.684469465928;5105.310783044316;5108.795648174106;5126.487351264844;5134.922976155361;5135.6148288878485;4297.828086876552;4665.766711664403;4682.063587282557;4712.52874712526;4779.665423420397;3941.921161576752;4030.133521292936;4061.5329237138108;4168.333066709372;4181.1010632714115;1249.2816630437535;1259.3388471052588;1268.0489632775418;1270.0347735720734;1270.733146039342;919.8206349761866;955.4362925873768;1015.9644412445529;1026.296986564206;1042.2652030318607;6173.81478555644;6259.812205633838;6343.746250149942;6362.713677884506;6368.29948705642;425.57442557442556;427.6706935659587;428.5157771717939;433.8633330500882;441.15298626636934;4382.101669157879;4449.510553839075;4499.59503644667;4540.636749060067;4598.494165641777;10579;10948.56205751761;11046.447677616086;11049.668509944715;11166.776664466664;10062.547185376676;10487.265891387682;10540.367577945348;11042.779144417067;11042.889571104186;8222.095569487352;8418.87371689413;8436.325093992466;8445.662173513114;8450.323974082059;6155.692215389302;6162.322144564184;6195.4424101831055;6201.410865967726;6294.590851594632;10388.428636424767;10419;10431.68704938853;10470.528826202686;10487.737806554896;9870.950645246729;10062.748431289276;10247.128994035591;10382.844257335995;10511.211659125749;7362.77911662651;7573.9242607573215;7798.727044553413;7820.648070836713;8065.717699880476;8711.869321960303;8720.694775682821;8727;8736.170063843925;8752.781180470285;7678.654460549177;7851.254130857559;7975.2423519765525;8028.397870159878;8058.637361318638;7594.468387212842;7731.806704832424;7737.187595302637;7772.7668169954995;7830.33442157423;7121.287871212838;7213.134423869169;7232.74685386009;7240;7241.45689073311;5344.732763361739;5419;5435.728213589384;5486.533644640251;5532.197831314517;5331;5416.431274716256;5434.157705555645;5435.402105768283;5569 11:26:28 INFO - PROCESS | 21275 | |4;prototype.html;314.7959056608473;324.4419598290939;330.90569187781455;332.30548154357393;338.55141936933563;5422.457754224575;5463.562914966803;5629.549636029118;5653.830385088449;5667.263255776748;5490.588205884555;5510.8071217507395;5528.087865502197;5528.861778455541;5557.305336832896;4326.490635431443;4360;4366.214081465327;4396.252637051709;4422.11557688462;4136.3381858902585;4333.956660433402;4365.825366985317;4406.493253275867;4424.889377765549;4294.763787991659;4298.570142985708;4312.460942382202;4327.978360108211;4329.895876551475;4301.462317210348;4332.263515202408;4363.323684828857;4374.58441448062;4374.8906277343;3694.131879008431;3782.3380908341205;3791.2796568652143;3792.5259342582176;3830.6552410283207;5429.642589352662;5444.564434845203;5467.152591348347;5494.230807686927;5506.339239291271;4943.357363542752;4946.975265123688;4969.229769385751;4974.303597496353;4977.975110124463;5627.6060675752715;5758.971205143947;5789.797357092481;5795.507381872546;5858.033424484955;4120.690948178899;4127.7936103194725;4139.606737359976;4141.937870931938;4171.976591353191;5859.589828711992;6068.393160683941;6082.5742198046155;6108.5418593605655;6113.755449782004;4227.87316380509;4229.45017147775;4236.343366778093;4245.150969806051;4260.956065763846;4273.700840941105;4314.223439780807;4314.762688052125;4321.870343889688;4328.8268469260875;4930.901381972412;4965.32968049316;4966.279889416014;4972.875678108004;4981.975090124526;5593.161025846074;5706.686132262683;5857.326407463196;5870.7945221917025;5870.882582348329;1423.555091582045;1455.9563213103413;1462.334637739826;1462.7586448235922;1465.157534417714;902.6885724425194;929.6327950459531;944.6410364061612;965.6861520006026;965.9323847330619;4894.510548945077;4936.3829521309835;4965.280034395065;5041.521055499722;5091.2363145527725;5305.920411193835;5380.435054319319;5382.542483888835;5386.165144402624;5427.348718153847;4747.199152499972;4977.805326721633;5079.415867175248;5083.729067733067;5112.6421150519855;2822.5766135079493;2835.2344866886237;2854.372038151603;2861.4563232986084;2899.565065240231;5447.264619276426;5493.9286839066;5555.388907220203;5583.804566840141;5610.129010982409;5202.973985130126;5318.521333079964;5359.732013399314;5364.51719345253;5441.347038355423;5434.864128396822;5446.856160206401;5490.423505531941;5502.2296878437055;5522;5242.475752424727;5245.685258884327;5297.54970827484;5304.655197412156;5360.43715409892;5575.609707320611;5964.194833697396;6006.579539432198;6006.939930600638;6058.848528786815;6293.779717709858;6309.148264984352;6314.242290925118;6331.493480521455;6376.171097757262;4188.979055104705;4200.928763165373;4231.513375961681;4236.5339812621205;4244.554321796167;5874.383189765013;6031.517478601613;6054.243219597551;6067.939320606914;6090.482309003607;5930.614510056833;5951.166836642787;5963.493103086286;5968.31364393083;5979.641221526722;5871.500922421642;5906.26171728534;5929.258842644669;5936.7922122725495;5966.433188847052;5600.915986260291;5854.736536855767;5875.618084824473;5894.174815525744;5896.469317761422;5884.176215329771;5976.491998180203;6019.428154325332;6028.57799953999;6031.355855990775;5645.640843697993;5824.912626310524;5824.970875145597;5834.570530220123;5836.387179346108 11:26:28 INFO - PROCESS | 21275 | |5;yui.html;789.917058708836;819.4919150126922;820.2822530285999;834.0200264688989;849.5794581682069;15332.080075195496;15583.922080389582;15783.289751961147;15796.684066318667;15927.124008179546;14237.145771253732;14348.497802576912;14408.783868241984;14483;15176;805.2390490986036;826.6114925984778;826.6858593734372;826.6858593734372;827.9213474719922;806.2622700229283;835.8996920369564;836.5817091454273;839.0309192882231;840.5671079394117;866.3805379153904;869.8260347930408;872.1496540872662;875.4353442029887;876.3208513402133;870.3907264914521;876.3952872517974;876.3952872518006;876.4171825735909;878.3851304087101;636.0840389838618;639.4085470939362;641.6567136581906;642.2068745099798;643.4048505132733;16188.271527781279;16293.429729959513;16301.347946082142;16323.673526529521;16384.426545070866;15195;15214.847851521454;15301.46444874424;15311;15350.539483815392;12148.149629525937;12507.249565026128;12561.560345387868;13174.53889113886;13372.799408008888;3833.367494363427;3882.417637354391;3920.529536455615;3936.7637941723588;4079.102597428561;80715.59642201751;82231;83043.16956830415;83503;83751;10812.405317707444;10844.240903136704;11020.50407731654;11169.537443392412;11311.717207069725;21891.67162492564;21899.014544345544;21941;21944.45138871541;21959;8506.106858779864;8642;8826.735197944072;9034.593443295067;9050.728478145666;4787.42550893888;4798.640101992295;4948.4309304429735;5117.309163262912;5119.769610367543;3594.8137114752594;3666.9083272917856;3743.1016556026357;3774.698024158116;3777.4522694209186;611.6452457574596;621.273110460753;641.9358064193543;650.6974256970436;664.7008846019311;648.5006544960354;752.7214930475759;789.4710543935577;798.5528104261632;806.9596520173968;10097.848532272023;10332.431716255678;10518.263721539419;10793;10811.297265677864;684.336193891924;704.7568588836843;715.7029832619509;719.4675939804507;728.308107298069;4750.168720473903;4890.266460031024;5100;5167.121589329748;5168.3797944246935;97857.51071244598;100043.49978250063;102219.755826859;115431;117506;98325;99005;99104.50447747715;99835.50082249688;100172;66353;85013.57493212618;85471;87510.56244718736;87785.5610721955;9746.561404736945;9933.950330248303;9962.551685174329;10037.89962100399;10064.949675251577;52741.208881866034;53119.20321195263;53228.4677153239;53398.73300633472;54180.72909635427;74665;79684;80617.59691201507;81496.18503815123;82366;12502.937485312515;12512.749745004867;12675.429605667583;13058.934705326412;13658.026963832803;15326.310316035582;15669.451569195024;15866.608861181809;15915.840841591436;16176.757348639545;14048.297585120907;14634;14640.487582934546;15216.847831521543;15332.546792513145;14310;14541.345639446461;14602.196879171748;15098.094114353175;15155.924220378827;14022.22877741734;14087.506937257147;14157.716845663235;14434.206118663154;14878.479253226085;11360.9431952843;11426.371549564854;11433.771324573629;11526.59656912004;11531.423428828357;9924.541502173632;10044.899551004397;10183.49082545855;11754.412279386168;11805.645830624751 11:26:28 INFO - PROCESS | 21275 | __end_tp_report 11:26:28 INFO - PROCESS | 21275 | __start_cc_report 11:26:28 INFO - PROCESS | 21275 | _x_x_mozilla_cycle_collect,366 11:26:28 INFO - PROCESS | 21275 | __end_cc_report 11:26:28 INFO - PROCESS | 21275 | __startTimestamp1469384788847__endTimestamp 11:26:28 INFO - PROCESS | 21275 | 11:26:28 INFO - PROCESS | 21275 | ------- Summary: start ------- 11:26:28 INFO - PROCESS | 21275 | Number of tests: 6 11:26:28 INFO - PROCESS | 21275 | 11:26:28 INFO - PROCESS | 21275 | [#0] dojo.html Cycles:165 Average:5508.03 Median:5755.34 stddev:630.13 (10.9%) stddev-sans-first:603.29 11:26:28 INFO - PROCESS | 21275 | Values: 3108.5 3121.4 3147.7 3152.5 3152.9 5512.2 5567.2 5598.8 5622.6 5623.1 5362.8 5458.2 5501.9 5530.9 5601.0 4920.8 4963.7 5061.0 5073.8 5150.1 4975.3 5077.0 5125.5 5131.4 5156.1 4945.5 5027.2 5052.1 5059.4 5130.8 5065.4 5086.1 5097.3 5111.3 5143.4 5050.3 5060.8 5077.0 5083.6 5091.3 5403.5 5438.1 5446.3 5505.3 5569.4 5876.4 5881.6 5886.2 5897.1 5910.6 5930.7 5933.6 5936.5 5936.8 5942.0 5405.6 5437.0 5498.0 5499.8 5575.6 6039.6 6045.6 6045.6 6050.4 6051.1 5791.8 5791.9 5793.8 5797.7 5809.2 5802.4 5871.5 5926.0 5934.0 6039.7 5736.1 5834.6 5905.5 5906.0 5922.2 5841.9 5891.1 5950.6 5961.2 5968.6 4408.8 4476.5 4480.9 4511.2 4514.0 4041.4 4044.8 4059.6 4082.7 4083.1 5635.9 5643.3 5646.5 5669.8 5695.2 5770.0 5923.8 5951.1 5963.6 5976.6 5677.4 5683.0 5691.5 5706.1 5716.1 5155.6 5156.7 5157.6 5166.6 5206.2 5997.0 6108.8 6111.8 6178.0 6205.0 6019.1 6020.8 6026.1 6071.5 6073.8 6114.2 6127.1 6132.1 6142.0 6145.5 5598.3 5755.3 5804.1 5823.4 5850.5 5854.0 5889.2 5903.9 5904.9 5950.4 5761.2 5781.8 5790.5 5793.1 5793.5 5665.0 5767.1 5781.0 5785.7 5794.9 5762.7 5789.4 5814.5 5861.5 5862.1 5860.7 5868.8 5871.6 5945.2 5953.6 5596.7 5612.8 5697.9 5751.9 5763.8 11:26:28 INFO - PROCESS | 21275 | 11:26:28 INFO - PROCESS | 21275 | [#1] ext.html Cycles:180 Average:62615.06 Median:42004.58 stddev:126785.53 (301.8%) stddev-sans-first:127055.56 11:26:28 INFO - PROCESS | 21275 | Values: 550.5 592.3 595.1 617.3 643.0 41790.8 42602.6 42611.9 42758.5 42903.6 43371.0 43903.6 43903.6 43989.8 44051.8 8846.8 9016.4 9024.7 9031.7 9039.4 8912.9 8996.3 9015.1 9037.4 9042.2 8996.7 9095.8 9101.5 9107.7 9123.0 9025.9 9042.4 9063.3 9065.8 9084.9 8923.4 8938.3 8986.0 8986.9 9061.0 40308.0 40688.6 40784.8 40811.6 40930.0 3667.0 3671.9 3763.3 3848.6 4342.6 32276.4 32383.8 32838.5 33036.8 33253.2 4411.8 4420.2 4440.5 4451.6 4662.3 372621.0 375065.0 375939.0 376047.0 376539.0 58006.7 58172.7 58199.7 58213.0 58362.7 35836.5 36913.3 36985.8 38380.8 60819.0 16031.1 16226.6 16275.5 16299.0 16401.9 12179.6 12225.1 12254.1 12264.1 12276.7 19236.0 19393.2 19407.2 19510.0 19592.4 7012.6 7050.4 7082.4 7174.7 7341.3 1008.8 1048.3 1111.6 1123.5 1133.8 33041.3 33384.5 33481.7 33642.8 33788.5 1133.1 1158.0 1172.8 1174.9 1216.3 17276.7 17345.9 17407.0 17411.7 17621.0 568263.0 569631.0 573441.0 573491.0 574705.0 60703.0 61053.1 61070.0 61121.7 61412.2 1312.6 1353.9 1363.5 1371.7 1379.6 31424.3 32853.2 32970.7 33222.2 33474.3 51972.5 52660.2 52701.5 52817.2 52887.0 462153.0 462352.0 463217.0 466525.0 468266.0 28410.4 28633.7 28767.3 28920.7 28979.1 49091.5 49408.8 49871.8 50417.7 50770.0 41065.4 41770.6 41993.6 42596.1 43847.3 41381.6 41780.0 42015.6 43368.3 43525.6 41112.6 41307.0 43095.8 43202.6 43390.1 35513.3 38275.6 38346.0 38377.2 39032.4 28670.6 28924.0 28933.3 29016.7 29270.3 11:26:28 INFO - PROCESS | 21275 | 11:26:28 INFO - PROCESS | 21275 | [#2] jquery.html Cycles:180 Average:30589.42 Median:22018.44 stddev:90186.63 (409.6%) stddev-sans-first:90411.10 11:26:28 INFO - PROCESS | 21275 | Values: 378.9 379.9 393.4 396.4 416.3 18639.5 19391.2 20222.6 20237.4 20288.4 18979.5 19149.5 19219.4 19434.6 19514.5 5812.1 5845.9 5864.9 5889.9 5918.7 5711.7 5730.4 5809.1 5846.9 5877.2 5662.7 5734.7 5796.0 5812.9 5849.2 5729.5 5749.5 5800.9 5806.6 5813.2 4992.4 5133.9 5166.5 5167.6 5170.9 22753.3 22999.5 23068.8 23132.0 23220.5 2163.0 2254.3 2357.0 2407.9 2503.6 10180.1 10293.8 10354.3 10544.1 10616.4 1939.9 1971.8 2003.5 2010.5 2014.4 72183.0 83656.6 84003.6 86244.6 89628.6 10693.7 10741.6 10920.5 10967.2 11143.5 15014.6 15044.8 15085.0 15108.6 15132.8 7398.3 7478.2 7548.4 7589.6 7708.0 7052.9 7083.3 7271.3 7278.0 7426.8 4368.5 4461.6 4486.1 4543.1 4792.6 1965.3 2029.7 2038.1 2051.3 2064.5 841.8 890.3 955.4 966.7 1032.6 18851.2 19661.9 19711.8 19762.2 19917.8 962.4 981.9 988.9 989.9 993.5 9389.0 10926.0 10946.9 10981.8 11094.9 536348.0 539985.0 554780.0 554817.0 556070.0 57298.4 92803.0 93304.0 97422.5 97745.5 979.3 985.3 991.7 1048.1 1062.1 17005.5 17359.7 17852.4 17852.9 18575.1 43620.6 43670.8 43676.7 43977.6 44658.3 54473.0 56825.0 60760.4 62481.7 63144.7 8043.8 8265.3 8292.9 8403.6 8416.0 12207.4 12658.6 12828.9 12960.4 13465.3 11840.9 11957.7 12066.3 12346.3 12534.9 11265.3 11511.4 11513.9 11590.7 11620.2 6153.0 11067.9 11569.5 12111.6 12439.6 7340.2 7499.7 7693.2 7781.8 8374.0 10576.3 11602.5 11711.9 12102.9 12132.8 11:26:28 INFO - PROCESS | 21275 | 11:26:28 INFO - PROCESS | 21275 | [#3] mootools.html Cycles:180 Average:5834.35 Median:2436.97 stddev:3351.60 (137.5%) stddev-sans-first:3345.14 11:26:28 INFO - PROCESS | 21275 | Values: 1495.2 1517.2 1662.3 1746.2 1804.0 7983.7 8459.7 8651.3 9070.1 9076.1 8410.9 8580.7 8713.1 8732.0 8768.0 2203.7 2268.1 2271.7 2271.9 2273.0 2242.8 2267.6 2309.1 2333.9 2336.7 2297.9 2303.3 2320.0 2322.0 2344.6 2202.8 2203.1 2203.3 2209.3 2225.1 2200.3 2205.8 2213.3 2214.7 2217.0 8862.1 8873.7 8936.3 8940.4 8955.0 4937.5 5010.3 5030.5 5056.4 5066.8 3129.6 3166.3 3278.3 3314.9 3336.5 1019.9 1102.7 1125.9 1126.9 1134.0 12095.3 12344.1 12362.3 12405.2 12406.6 4212.5 4291.3 4432.8 4436.6 4477.1 10438.8 10465.4 10506.9 10507.5 10517.7 5105.3 5108.8 5126.5 5134.9 5135.6 4297.8 4665.8 4682.1 4712.5 4779.7 3941.9 4030.1 4061.5 4168.3 4181.1 1249.3 1259.3 1268.0 1270.0 1270.7 919.8 955.4 1016.0 1026.3 1042.3 6173.8 6259.8 6343.7 6362.7 6368.3 425.6 427.7 428.5 433.9 441.2 4382.1 4449.5 4499.6 4540.6 4598.5 10579.0 10948.6 11046.4 11049.7 11166.8 10062.5 10487.3 10540.4 11042.8 11042.9 8222.1 8418.9 8436.3 8445.7 8450.3 6155.7 6162.3 6195.4 6201.4 6294.6 10388.4 10419.0 10431.7 10470.5 10487.7 9871.0 10062.7 10247.1 10382.8 10511.2 7362.8 7573.9 7798.7 7820.6 8065.7 8711.9 8720.7 8727.0 8736.2 8752.8 7678.7 7851.3 7975.2 8028.4 8058.6 7594.5 7731.8 7737.2 7772.8 7830.3 7121.3 7213.1 7232.7 7240.0 7241.5 5344.7 5419.0 5435.7 5486.5 5532.2 5331.0 5416.4 5434.2 5435.4 5569.0 11:26:28 INFO - PROCESS | 21275 | 11:26:28 INFO - PROCESS | 21275 | [#4] prototype.html Cycles:180 Average:4791.11 Median:5381.49 stddev:1411.80 (26.2%) stddev-sans-first:1375.20 11:26:28 INFO - PROCESS | 21275 | Values: 314.8 324.4 330.9 332.3 338.6 5422.5 5463.6 5629.5 5653.8 5667.3 5490.6 5510.8 5528.1 5528.9 5557.3 4326.5 4360.0 4366.2 4396.3 4422.1 4136.3 4334.0 4365.8 4406.5 4424.9 4294.8 4298.6 4312.5 4328.0 4329.9 4301.5 4332.3 4363.3 4374.6 4374.9 3694.1 3782.3 3791.3 3792.5 3830.7 5429.6 5444.6 5467.2 5494.2 5506.3 4943.4 4947.0 4969.2 4974.3 4978.0 5627.6 5759.0 5789.8 5795.5 5858.0 4120.7 4127.8 4139.6 4141.9 4172.0 5859.6 6068.4 6082.6 6108.5 6113.8 4227.9 4229.5 4236.3 4245.2 4261.0 4273.7 4314.2 4314.8 4321.9 4328.8 4930.9 4965.3 4966.3 4972.9 4982.0 5593.2 5706.7 5857.3 5870.8 5870.9 1423.6 1456.0 1462.3 1462.8 1465.2 902.7 929.6 944.6 965.7 965.9 4894.5 4936.4 4965.3 5041.5 5091.2 5305.9 5380.4 5382.5 5386.2 5427.3 4747.2 4977.8 5079.4 5083.7 5112.6 2822.6 2835.2 2854.4 2861.5 2899.6 5447.3 5493.9 5555.4 5583.8 5610.1 5203.0 5318.5 5359.7 5364.5 5441.3 5434.9 5446.9 5490.4 5502.2 5522.0 5242.5 5245.7 5297.5 5304.7 5360.4 5575.6 5964.2 6006.6 6006.9 6058.8 6293.8 6309.1 6314.2 6331.5 6376.2 4189.0 4200.9 4231.5 4236.5 4244.6 5874.4 6031.5 6054.2 6067.9 6090.5 5930.6 5951.2 5963.5 5968.3 5979.6 5871.5 5906.3 5929.3 5936.8 5966.4 5600.9 5854.7 5875.6 5894.2 5896.5 5884.2 5976.5 6019.4 6028.6 6031.4 5645.6 5824.9 5825.0 5834.6 5836.4 11:26:28 INFO - PROCESS | 21275 | 11:26:28 INFO - PROCESS | 21275 | [#5] yui.html Cycles:180 Average:21114.82 Median:4414.64 stddev:29684.29 (672.4%) stddev-sans-first:29728.33 11:26:28 INFO - PROCESS | 21275 | Values: 789.9 819.5 820.3 834.0 849.6 15332.1 15583.9 15783.3 15796.7 15927.1 14237.1 14348.5 14408.8 14483.0 15176.0 805.2 826.6 826.7 826.7 827.9 806.3 835.9 836.6 839.0 840.6 866.4 869.8 872.1 875.4 876.3 870.4 876.4 876.4 876.4 878.4 636.1 639.4 641.7 642.2 643.4 16188.3 16293.4 16301.3 16323.7 16384.4 15195.0 15214.8 15301.5 15311.0 15350.5 12148.1 12507.2 12561.6 13174.5 13372.8 3833.4 3882.4 3920.5 3936.8 4079.1 80715.6 82231.0 83043.2 83503.0 83751.0 10812.4 10844.2 11020.5 11169.5 11311.7 21891.7 21899.0 21941.0 21944.5 21959.0 8506.1 8642.0 8826.7 9034.6 9050.7 4787.4 4798.6 4948.4 5117.3 5119.8 3594.8 3666.9 3743.1 3774.7 3777.5 611.6 621.3 641.9 650.7 664.7 648.5 752.7 789.5 798.6 807.0 10097.8 10332.4 10518.3 10793.0 10811.3 684.3 704.8 715.7 719.5 728.3 4750.2 4890.3 5100.0 5167.1 5168.4 97857.5 100043.5 102219.8 115431.0 117506.0 98325.0 99005.0 99104.5 99835.5 100172.0 66353.0 85013.6 85471.0 87510.6 87785.6 9746.6 9934.0 9962.6 10037.9 10064.9 52741.2 53119.2 53228.5 53398.7 54180.7 74665.0 79684.0 80617.6 81496.2 82366.0 12502.9 12512.7 12675.4 13058.9 13658.0 15326.3 15669.5 15866.6 15915.8 16176.8 14048.3 14634.0 14640.5 15216.8 15332.5 14310.0 14541.3 14602.2 15098.1 15155.9 14022.2 14087.5 14157.7 14434.2 14878.5 11360.9 11426.4 11433.8 11526.6 11531.4 9924.5 10044.9 10183.5 11754.4 11805.6 11:26:28 INFO - PROCESS | 21275 | -------- Summary: end -------- 11:26:28 INFO - PROCESS | 21275 | 11:26:29 INFO - TEST-INFO | 21275: exit 0 11:26:29 INFO - TEST-OK | dromaeo_css | took 1111900ms 11:26:29 INFO - TEST-START | kraken 11:26:29 INFO - operating with platform_type : linux_ 11:26:29 INFO - Initialising browser for kraken test... 11:26:29 INFO - TEST-INFO | started process 21525 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpkkbcXX/profile http://localhost:37692/getInfo.html) 11:26:32 INFO - PROCESS | 21525 | JavaScript error: , line 0: uncaught exception: undefined 11:26:34 INFO - PROCESS | 21525 | __metrics Screen width/height:1600/1200 11:26:34 INFO - PROCESS | 21525 | colorDepth:24 11:26:34 INFO - PROCESS | 21525 | Browser inner width/height: 1024/697 11:26:34 INFO - PROCESS | 21525 | __metrics 11:26:34 ERROR - PROCESS | 21525 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2968: TypeError: this.tabs is undefined 11:26:35 INFO - TEST-INFO | 21525: exit 0 11:26:35 INFO - Browser initialized. 11:26:35 INFO - Running cycle 1/1 for kraken test... 11:26:35 INFO - TEST-INFO | started process 21647 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpkkbcXX/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 11:26:47 INFO - PROCESS | 21647 | RSS: Main: 168034304 11:26:47 INFO - PROCESS | 21647 | 11:26:49 INFO - PROCESS | 21647 | Cycle 1(1): loaded http://localhost:37692/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:37692/tests/kraken/driver.html?testName=audio-beat-detection) 11:26:50 INFO - PROCESS | 21647 | RSS: Main: 173817856 11:26:50 INFO - PROCESS | 21647 | 11:26:53 INFO - PROCESS | 21647 | Cycle 1(1): loaded http://localhost:37692/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:37692/tests/kraken/driver.html?testName=audio-dft) 11:26:53 INFO - PROCESS | 21647 | RSS: Main: 172179456 11:26:53 INFO - PROCESS | 21647 | 11:26:56 INFO - PROCESS | 21647 | Cycle 1(1): loaded http://localhost:37692/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:37692/tests/kraken/driver.html?testName=audio-fft) 11:26:57 INFO - PROCESS | 21647 | RSS: Main: 168402944 11:26:57 INFO - PROCESS | 21647 | 11:26:59 INFO - PROCESS | 21647 | Cycle 1(1): loaded http://localhost:37692/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:37692/tests/kraken/driver.html?testName=audio-oscillator) 11:27:00 INFO - PROCESS | 21647 | RSS: Main: 170201088 11:27:00 INFO - PROCESS | 21647 | 11:27:02 INFO - PROCESS | 21647 | Cycle 1(1): loaded http://localhost:37692/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:37692/tests/kraken/driver.html?testName=imaging-gaussian-blur) 11:27:03 INFO - PROCESS | 21647 | RSS: Main: 170029056 11:27:03 INFO - PROCESS | 21647 | 11:27:06 INFO - PROCESS | 21647 | Cycle 1(1): loaded http://localhost:37692/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:37692/tests/kraken/driver.html?testName=imaging-darkroom) 11:27:06 INFO - PROCESS | 21647 | RSS: Main: 170696704 11:27:06 INFO - PROCESS | 21647 | 11:27:10 INFO - PROCESS | 21647 | Cycle 1(1): loaded http://localhost:37692/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:37692/tests/kraken/driver.html?testName=imaging-desaturate) 11:27:10 INFO - PROCESS | 21647 | RSS: Main: 168148992 11:27:10 INFO - PROCESS | 21647 | 11:27:13 INFO - PROCESS | 21647 | Cycle 1(1): loaded http://localhost:37692/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:37692/tests/kraken/driver.html?testName=json-parse-financial) 11:27:14 INFO - PROCESS | 21647 | RSS: Main: 168882176 11:27:14 INFO - PROCESS | 21647 | 11:27:15 INFO - PROCESS | 21647 | Cycle 1(1): loaded http://localhost:37692/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:37692/tests/kraken/driver.html?testName=json-stringify-tinderbox) 11:27:16 INFO - PROCESS | 21647 | RSS: Main: 169279488 11:27:16 INFO - PROCESS | 21647 | 11:27:18 INFO - PROCESS | 21647 | Cycle 1(1): loaded http://localhost:37692/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:37692/tests/kraken/driver.html?testName=stanford-crypto-aes) 11:27:19 INFO - PROCESS | 21647 | RSS: Main: 169684992 11:27:19 INFO - PROCESS | 21647 | 11:27:21 INFO - PROCESS | 21647 | Cycle 1(1): loaded http://localhost:37692/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:37692/tests/kraken/driver.html?testName=stanford-crypto-ccm) 11:27:21 INFO - PROCESS | 21647 | RSS: Main: 169869312 11:27:21 INFO - PROCESS | 21647 | 11:27:24 INFO - PROCESS | 21647 | Cycle 1(1): loaded http://localhost:37692/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:37692/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 11:27:25 INFO - PROCESS | 21647 | RSS: Main: 170143744 11:27:25 INFO - PROCESS | 21647 | 11:27:27 INFO - PROCESS | 21647 | Cycle 1(1): loaded http://localhost:37692/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:37692/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 11:27:28 INFO - PROCESS | 21647 | RSS: Main: 170553344 11:27:28 INFO - PROCESS | 21647 | 11:27:30 INFO - PROCESS | 21647 | Cycle 1(1): loaded http://localhost:37692/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:37692/tests/kraken/driver.html?testName=ai-astar) 11:27:30 INFO - PROCESS | 21647 | RSS: Main: 170987520 11:27:30 INFO - PROCESS | 21647 | 11:27:30 INFO - PROCESS | 21647 | __start_tp_report 11:27:30 INFO - PROCESS | 21647 | _x_x_mozilla_page_load 11:27:30 INFO - PROCESS | 21647 | _x_x_mozilla_page_load_details 11:27:30 INFO - PROCESS | 21647 | |i|pagename|runs| 11:27:30 INFO - PROCESS | 21647 | |0;ai-astar;104;113;108;114;114;112;114;114;110;111 11:27:30 INFO - PROCESS | 21647 | |1;audio-beat-detection;157;119;147;187;120;151;149;122;186;118 11:27:30 INFO - PROCESS | 21647 | |2;audio-dft;163;163;161;162;162;165;177;165;162;163 11:27:30 INFO - PROCESS | 21647 | |3;audio-fft;75;79;74;165;77;76;75;76;175;77 11:27:30 INFO - PROCESS | 21647 | |4;audio-oscillator;89;85;149;93;84;85;153;84;86;146 11:27:30 INFO - PROCESS | 21647 | |5;imaging-gaussian-blur;117;118;117;117;117;117;118;118;117;117 11:27:30 INFO - PROCESS | 21647 | |6;imaging-darkroom;147;146;146;147;150;147;146;147;146;147 11:27:30 INFO - PROCESS | 21647 | |7;imaging-desaturate;96;95;95;95;95;95;96;96;96;95 11:27:30 INFO - PROCESS | 21647 | |8;json-parse-financial;57;56;55;55;58;55;56;54;56;54 11:27:30 INFO - PROCESS | 21647 | |9;json-stringify-tinderbox;62;63;63;63;64;62;62;62;63;63 11:27:30 INFO - PROCESS | 21647 | |10;stanford-crypto-aes;77;77;83;77;77;77;76;77;81;80 11:27:30 INFO - PROCESS | 21647 | |11;stanford-crypto-ccm;137;123;123;121;123;128;125;139;158;124 11:27:30 INFO - PROCESS | 21647 | |12;stanford-crypto-pbkdf2;158;173;161;155;156;157;157;157;154;169 11:27:30 INFO - PROCESS | 21647 | |13;stanford-crypto-sha256-iterative;63;65;64;65;65;63;64;64;64;63 11:27:30 INFO - PROCESS | 21647 | __end_tp_report 11:27:30 INFO - PROCESS | 21647 | __start_cc_report 11:27:30 INFO - PROCESS | 21647 | _x_x_mozilla_cycle_collect,927 11:27:30 INFO - PROCESS | 21647 | __end_cc_report 11:27:30 INFO - PROCESS | 21647 | __startTimestamp1469384850281__endTimestamp 11:27:30 INFO - PROCESS | 21647 | 11:27:30 INFO - PROCESS | 21647 | ------- Summary: start ------- 11:27:30 INFO - PROCESS | 21647 | Number of tests: 14 11:27:30 INFO - PROCESS | 21647 | 11:27:30 INFO - PROCESS | 21647 | [#0] ai-astar Cycles:10 Average:111.40 Median:113.50 stddev:3.31 (2.9%) stddev-sans-first:2.17 11:27:30 INFO - PROCESS | 21647 | Values: 104.0 113.0 108.0 114.0 114.0 112.0 114.0 114.0 110.0 111.0 11:27:30 INFO - PROCESS | 21647 | 11:27:30 INFO - PROCESS | 21647 | [#1] audio-beat-detection Cycles:10 Average:145.60 Median:150.00 stddev:26.25 (17.5%) stddev-sans-first:27.51 11:27:30 INFO - PROCESS | 21647 | Values: 157.0 119.0 147.0 187.0 120.0 151.0 149.0 122.0 186.0 118.0 11:27:30 INFO - PROCESS | 21647 | 11:27:30 INFO - PROCESS | 21647 | [#2] audio-dft Cycles:10 Average:164.30 Median:163.00 stddev:4.64 (2.8%) stddev-sans-first:4.90 11:27:30 INFO - PROCESS | 21647 | Values: 163.0 163.0 161.0 162.0 162.0 165.0 177.0 165.0 162.0 163.0 11:27:30 INFO - PROCESS | 21647 | 11:27:30 INFO - PROCESS | 21647 | [#3] audio-fft Cycles:10 Average:94.90 Median:76.00 stddev:39.67 (52.2%) stddev-sans-first:41.42 11:27:30 INFO - PROCESS | 21647 | Values: 75.0 79.0 74.0 165.0 77.0 76.0 75.0 76.0 175.0 77.0 11:27:30 INFO - PROCESS | 21647 | 11:27:30 INFO - PROCESS | 21647 | [#4] audio-oscillator Cycles:10 Average:105.40 Median:85.00 stddev:30.48 (35.9%) stddev-sans-first:31.75 11:27:30 INFO - PROCESS | 21647 | Values: 89.0 85.0 149.0 93.0 84.0 85.0 153.0 84.0 86.0 146.0 11:27:30 INFO - PROCESS | 21647 | 11:27:30 INFO - PROCESS | 21647 | [#5] imaging-gaussian-blur Cycles:10 Average:117.30 Median:117.00 stddev:0.48 (0.4%) stddev-sans-first:0.50 11:27:30 INFO - PROCESS | 21647 | Values: 117.0 118.0 117.0 117.0 117.0 117.0 118.0 118.0 117.0 117.0 11:27:30 INFO - PROCESS | 21647 | 11:27:30 INFO - PROCESS | 21647 | [#6] imaging-darkroom Cycles:10 Average:146.90 Median:147.00 stddev:1.20 (0.8%) stddev-sans-first:1.27 11:27:30 INFO - PROCESS | 21647 | Values: 147.0 146.0 146.0 147.0 150.0 147.0 146.0 147.0 146.0 147.0 11:27:30 INFO - PROCESS | 21647 | 11:27:30 INFO - PROCESS | 21647 | [#7] imaging-desaturate Cycles:10 Average:95.40 Median:95.50 stddev:0.52 (0.5%) stddev-sans-first:0.50 11:27:30 INFO - PROCESS | 21647 | Values: 96.0 95.0 95.0 95.0 95.0 95.0 96.0 96.0 96.0 95.0 11:27:30 INFO - PROCESS | 21647 | 11:27:30 INFO - PROCESS | 21647 | [#8] json-parse-financial Cycles:10 Average:55.60 Median:56.00 stddev:1.26 (2.3%) stddev-sans-first:1.24 11:27:30 INFO - PROCESS | 21647 | Values: 57.0 56.0 55.0 55.0 58.0 55.0 56.0 54.0 56.0 54.0 11:27:30 INFO - PROCESS | 21647 | 11:27:30 INFO - PROCESS | 21647 | [#9] json-stringify-tinderbox Cycles:10 Average:62.70 Median:63.00 stddev:0.67 (1.1%) stddev-sans-first:0.67 11:27:30 INFO - PROCESS | 21647 | Values: 62.0 63.0 63.0 63.0 64.0 62.0 62.0 62.0 63.0 63.0 11:27:30 INFO - PROCESS | 21647 | 11:27:30 INFO - PROCESS | 21647 | [#10] stanford-crypto-aes Cycles:10 Average:78.20 Median:77.00 stddev:2.30 (3.0%) stddev-sans-first:2.40 11:27:30 INFO - PROCESS | 21647 | Values: 77.0 77.0 83.0 77.0 77.0 77.0 76.0 77.0 81.0 80.0 11:27:30 INFO - PROCESS | 21647 | 11:27:30 INFO - PROCESS | 21647 | [#11] stanford-crypto-ccm Cycles:10 Average:130.10 Median:126.50 stddev:11.58 (9.2%) stddev-sans-first:12.01 11:27:30 INFO - PROCESS | 21647 | Values: 137.0 123.0 123.0 121.0 123.0 128.0 125.0 139.0 158.0 124.0 11:27:30 INFO - PROCESS | 21647 | 11:27:30 INFO - PROCESS | 21647 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:159.70 Median:157.50 stddev:6.31 (4.0%) stddev-sans-first:6.66 11:27:30 INFO - PROCESS | 21647 | Values: 158.0 173.0 161.0 155.0 156.0 157.0 157.0 157.0 154.0 169.0 11:27:30 INFO - PROCESS | 21647 | 11:27:30 INFO - PROCESS | 21647 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:64.00 Median:64.00 stddev:0.82 (1.3%) stddev-sans-first:0.78 11:27:30 INFO - PROCESS | 21647 | Values: 63.0 65.0 64.0 65.0 65.0 63.0 64.0 64.0 64.0 63.0 11:27:30 INFO - PROCESS | 21647 | -------- Summary: end -------- 11:27:30 INFO - PROCESS | 21647 | 11:27:31 INFO - TEST-INFO | 21647: exit 0 11:27:31 INFO - TEST-OK | kraken | took 61690ms 11:27:31 INFO - SUITE-END | took 1173s 11:27:31 INFO - Completed test suite (00:19:33) 11:27:31 INFO - javascript benchmark 11:27:31 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7347.401447009299, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3108.471559834828, 3121.3913286909046, 3147.74818014559, 3152.4798408262636, 3152.8581213845373, 5512.228288039672, 5567.164925261208, 5598.776048958041, 5622.634528755628, 5623.0721930881455, 5362.8123015694455, 5458.208559758833, 5501.944980550194, 5530.944690553093, 5601.047821870282, 4920.753962301879, 4963.70217786934, 5060.974695126519, 5073.822416215433, 5150.1244788385875, 4975.27858460523, 5076.974615126919, 5125.4618265082, 5131.384233891919, 5156.123459011958, 4945.480724523909, 5027.170516864713, 5052.065367906912, 5059.443461219263, 5130.820421285237, 5065.39215294167, 5086.084504789136, 5097.260897169889, 5111.309973153614, 5143.382794064699, 5050.3434553507805, 5060.7722652480725, 5077.0, 5083.567896728782, 5091.312672789163, 5403.48879600081, 5438.129899216106, 5446.264754258164, 5505.311836020497, 5569.443055694439, 5876.44173803488, 5881.558883083743, 5886.23478947734, 5897.0859516774535, 5910.615809972338, 5930.673812940329, 5933.643981361132, 5936.46571808535, 5936.821895343147, 5942.049272116441, 5405.648632838892, 5437.048516509634, 5497.972510137463, 5499.780008799643, 5575.553955683536, 6039.607425517327, 6045.6070355426755, 6045.63726176422, 6050.3949605040025, 6051.122587224828, 5791.7683292667825, 5791.942080579224, 5793.826185214451, 5797.739101740432, 5809.215755872988, 5802.419758024248, 5871.471567558855, 5925.970370148121, 5933.970330148321, 6039.7282122304605, 5736.053551164095, 5834.562407819346, 5905.498032667271, 5905.995980683294, 5922.170896074553, 5841.88316233673, 5891.145783861316, 5950.553708471882, 5961.195238642815, 5968.612040217372, 4408.779561021936, 4476.485204201558, 4480.865574032719, 4511.210538155875, 4513.954860451419, 4041.373587094005, 4044.797760111983, 4059.5534491205945, 4082.7346222496035, 4083.0813067059676, 5635.943640563624, 5643.294588176478, 5646.548276137899, 5669.801556945487, 5695.231143795618, 5770.0, 5923.822285331447, 5951.1073338999495, 5963.612365196248, 5976.641401515923, 5677.37548869624, 5683.0, 5691.459311365414, 5706.144078388275, 5716.114002329646, 5155.639105262596, 5156.664816786897, 5157.613179011514, 5166.61250406221, 5206.219067139959, 5997.0, 6108.760397969407, 6111.755529778759, 6178.0424034273865, 6205.0, 6019.127226552037, 6020.789272375446, 6026.126211699367, 6071.483923866521, 6073.787417440369, 6114.2357205349335, 6127.14220009208, 6132.08018797184, 6142.0, 6145.477634401126, 5598.300212473441, 5755.3381361144, 5804.100364443518, 5823.4176582343125, 5850.5027072699295, 5854.0340843760305, 5889.204957330706, 5903.852403689943, 5904.940950590439, 5950.404959504015, 5761.164631128547, 5781.768729250783, 5790.478856902899, 5793.073108302651, 5793.536517078539, 5665.03694371966, 5767.077267637158, 5780.971095144498, 5785.710714464344, 5794.884102317846, 5762.654240745569, 5789.421057894177, 5814.505767009682, 5861.531077513874, 5862.091375836752, 5860.677662728591, 5868.767558812697, 5871.588988770745, 5945.227120474311, 5953.583249172516, 5596.748146333506, 5612.7754889803955, 5697.943020569741, 5751.9137212941005, 5763.7982670606325], "value": 5464.548276616217, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [550.5273835669054, 592.3454582686131, 595.1162523652379, 617.3486971245335, 642.9871402571952, 41790.79104604477, 42602.573974260245, 42611.869406529666, 42758.50345237918, 42903.57096429031, 43371.0, 43903.560964390344, 43903.560964390344, 43989.7800510997, 44051.77974110125, 8846.82306353874, 9016.41393309436, 9024.684136055239, 9031.729048128567, 9039.41243819153, 8912.910870891274, 8996.280297576179, 9015.143561361692, 9037.41256818308, 9042.186203241707, 8996.730098097034, 9095.772605684844, 9101.544922753868, 9107.68123115691, 9123.0, 9025.864612030791, 9042.367034307601, 9063.274938004977, 9065.818683626356, 9084.8637270441, 8923.375363724543, 8938.284937205073, 8985.955070224607, 8986.865197021985, 9061.048589898031, 40307.99230019244, 40688.593114068775, 40784.796076019724, 40811.59188408108, 40930.0, 3667.0465678923406, 3671.86055922188, 3763.322601931651, 3848.615138486157, 4342.587454191878, 32276.424786686282, 32383.83808080968, 32838.469744857735, 33036.834815826005, 33253.16867078318, 4411.845585404495, 4420.248557745159, 4440.467143942716, 4451.621612162938, 4662.347271382009, 372621.0, 375065.0, 375939.0, 376047.0, 376539.0, 58006.70996645074, 58172.70913645489, 58199.709001455565, 58213.0, 58362.708186458796, 35836.46245306323, 36913.26173476569, 36985.81507092447, 38380.8080959599, 60819.0, 16031.118288494245, 16226.594335141479, 16275.51173464798, 16299.0, 16401.917990409973, 12179.573714920112, 12225.083118766128, 12254.08094392924, 12264.141510094209, 12276.693082672826, 19236.0, 19393.22427102928, 19407.161064202508, 19509.985013766334, 19592.412227633195, 7012.580659672405, 7050.400715939202, 7082.433405327562, 7174.677139528734, 7341.3392794648735, 1008.7528555503949, 1048.2714513413105, 1111.5998240633367, 1123.5393488669606, 1133.7505748735266, 33041.3391732164, 33384.49923251153, 33481.66518334785, 33642.831785840914, 33788.49317260243, 1133.1274918313018, 1158.0272571040366, 1172.806486929664, 1174.8707642159357, 1216.3310179401294, 17276.654466910844, 17345.913270433568, 17407.0, 17411.65176696459, 17621.0, 568263.0, 569631.0, 573441.0, 573491.0, 574705.0, 60703.0, 61053.08420373698, 61070.0, 61121.69439152865, 61412.16584424472, 1312.5996571045732, 1353.8646135386382, 1363.4614327340844, 1371.6845125620964, 1379.5792283353674, 31424.34361814804, 32853.17867053343, 32970.67029329676, 33222.16944576405, 33474.33051339008, 51972.48027519828, 52660.21009684781, 52701.47298527119, 52817.20774188313, 52887.0, 462153.0, 462352.0, 463217.0, 466525.0, 468266.0, 28410.431791363644, 28633.713662863105, 28767.280817979718, 28920.7107928918, 28979.130626081253, 49091.50908490869, 49408.75295623499, 49871.75064124656, 50417.74791126168, 50770.0, 41065.384019239136, 41770.58229417788, 41993.58006419897, 42596.1480770389, 43847.34228986504, 41381.58618413898, 41780.0, 42015.579844201166, 43368.349474758536, 43525.56474435215, 41112.58887411088, 41307.0, 43095.78452107719, 43202.567974319856, 43390.13219735651, 35513.28973420569, 38275.61724382832, 38346.0, 38377.232455350175, 39032.41451378288, 28670.56994145131, 28924.0, 28933.276668082624, 29016.7098329014, 29270.26824329409], "value": 20361.26789766918, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [378.8749712594844, 379.9086031397158, 393.44917116037544, 396.4232042378339, 416.3255526047803, 18639.5340116497, 19391.224351025976, 20222.59554808903, 20237.392878213657, 20288.391348259538, 18979.52551186221, 19149.521261968424, 19219.423417297505, 19434.611307773837, 19514.512137196543, 5812.070068788995, 5845.941540584604, 5864.941350586503, 5889.8822023559505, 5918.674472903988, 5711.7144142792695, 5730.398308177623, 5809.070548712207, 5846.941530584703, 5877.235959325281, 5662.688552129631, 5734.7419366128415, 5795.971020144893, 5812.941870581282, 5849.181114643932, 5729.541636669098, 5749.482546570829, 5800.9129863052085, 5806.564507661942, 5813.157092221646, 4992.375953005874, 5133.871653208662, 5166.457521960216, 5167.638265321429, 5170.922436163461, 22753.317400478012, 22999.54000919989, 23068.76931230683, 23132.0, 23220.53558928812, 2162.9567408651897, 2254.3237028891267, 2357.045396614357, 2407.879606019692, 2503.6119401492797, 10180.134688551481, 10293.845592316122, 10354.275200735952, 10544.051035406774, 10616.363018218854, 1939.9030048497518, 1971.8225359717694, 2003.5391859872166, 2010.5275260313815, 2014.355406269994, 72183.0, 83656.58171709163, 84003.57998210032, 86244.56877715634, 89628.55185724095, 10693.732656683489, 10741.624043158452, 10920.50857711389, 10967.177461690406, 11143.498542565441, 15014.624634384008, 15044.774328385083, 15085.0, 15108.622284442978, 15132.773008404884, 7398.3341499265325, 7478.2147874473485, 7548.433867459853, 7589.6205189741395, 7708.0, 7052.858942821114, 7083.291670832876, 7271.3455788979245, 7278.0, 7426.777196684108, 4368.541303163122, 4461.643068554573, 4486.1252055849445, 4543.114092751882, 4792.634099281758, 1965.3219639224444, 2029.7450636222184, 2038.0624912540102, 2051.282051282069, 2064.5251592133895, 841.835842010802, 890.2922176869405, 955.3599088610648, 966.6761634852263, 1032.6385764982347, 18851.245950162112, 19661.901690491457, 19711.80288197128, 19762.209511619374, 19917.800821991885, 962.4177372689562, 981.9263555233387, 988.9208863290919, 989.9010098990043, 993.4982833669095, 9388.95305523468, 10926.0, 10946.890531094587, 10981.835272470918, 11094.889051109385, 536348.0, 539985.0, 554780.0, 554817.0, 556070.0, 57298.42701573014, 92803.0, 93304.0, 97422.5128874351, 97745.51127244318, 979.299800642544, 985.280745056113, 991.6578780320777, 1048.0776916313748, 1062.054771253585, 17005.48983530496, 17359.652806944043, 17852.375166869097, 17852.91073544624, 18575.071246437896, 43620.56379436165, 43670.78164609284, 43676.6896993078, 43977.56022439735, 44658.3301250475, 54473.0, 56825.0, 60760.39239607548, 62481.68759156175, 63144.68427657832, 8043.839123217386, 8265.338772898274, 8292.917070829455, 8403.621837017472, 8415.95792021036, 12207.389630518615, 12658.620241392773, 12828.935855320664, 12960.351982400654, 13465.326733663082, 11840.881591183977, 11957.701057473632, 12066.336351500751, 12346.259224446561, 12534.874651253736, 11265.324080555192, 11511.424428778695, 11513.884861151617, 11590.710232243924, 11620.244684095507, 6153.0, 11067.889321107008, 11569.537218511165, 12111.576094836639, 12439.626811195678, 7340.229275925951, 7499.737509187153, 7693.192214817587, 7781.766547003599, 8373.95813020931, 10576.259661823906, 11602.477888495207, 11711.941440292743, 12102.939485302517, 12132.818007729715], "value": 9152.553008106212, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1495.1851241073614, 1517.1883042572222, 1662.2519866060268, 1746.1618423156892, 1803.981960180398, 7983.682692355769, 8459.746207613782, 8651.307895368363, 9070.092990700927, 9076.092390760929, 8410.91589084109, 8580.699675511358, 8713.128687131299, 8731.956340218307, 8767.956160219206, 2203.6914831923505, 2268.0587556164255, 2271.716035495563, 2271.8636881787065, 2273.022600281878, 2242.8093612042994, 2267.5918334699745, 2309.0763694522243, 2333.9299821005397, 2336.6728657987896, 2297.896594653236, 2303.251443280932, 2320.0, 2322.0247496051616, 2344.601417758985, 2202.8458007939453, 2203.0857194264363, 2203.2508946958033, 2209.3151123151874, 2225.121077174507, 2200.2849074050996, 2205.8345624078097, 2213.302809614966, 2214.7010153629217, 2216.9778302217096, 8862.069482704288, 8873.689420870238, 8936.285097192209, 8940.374173807835, 8954.955225223832, 4937.506249375069, 5010.323606313137, 5030.547250747413, 5056.367954005749, 5066.822661206877, 3129.640091389474, 3166.255929856482, 3278.327942771726, 3314.9171270718184, 3336.5328853960464, 1019.9184065274834, 1102.652664410708, 1125.9324440533512, 1126.938018408987, 1133.9603113890973, 12095.334756588383, 12344.13591048627, 12362.320072396014, 12405.193662411913, 12406.62780116598, 4212.4523811904255, 4291.31338985767, 4432.778361081933, 4436.556344365602, 4477.1493416250805, 10438.843417348746, 10465.424401657981, 10506.894931050745, 10507.474626268657, 10517.684469465928, 5105.310783044316, 5108.795648174106, 5126.487351264844, 5134.922976155361, 5135.6148288878485, 4297.828086876552, 4665.766711664403, 4682.063587282557, 4712.52874712526, 4779.665423420397, 3941.921161576752, 4030.133521292936, 4061.5329237138108, 4168.333066709372, 4181.1010632714115, 1249.2816630437535, 1259.3388471052588, 1268.0489632775418, 1270.0347735720734, 1270.733146039342, 919.8206349761866, 955.4362925873768, 1015.9644412445529, 1026.296986564206, 1042.2652030318607, 6173.81478555644, 6259.812205633838, 6343.746250149942, 6362.713677884506, 6368.29948705642, 425.57442557442556, 427.6706935659587, 428.5157771717939, 433.8633330500882, 441.15298626636934, 4382.101669157879, 4449.510553839075, 4499.59503644667, 4540.636749060067, 4598.494165641777, 10579.0, 10948.56205751761, 11046.447677616086, 11049.668509944715, 11166.776664466664, 10062.547185376676, 10487.265891387682, 10540.367577945348, 11042.779144417067, 11042.889571104186, 8222.095569487352, 8418.87371689413, 8436.325093992466, 8445.662173513114, 8450.323974082059, 6155.692215389302, 6162.322144564184, 6195.4424101831055, 6201.410865967726, 6294.590851594632, 10388.428636424767, 10419.0, 10431.68704938853, 10470.528826202686, 10487.737806554896, 9870.950645246729, 10062.748431289276, 10247.128994035591, 10382.844257335995, 10511.211659125749, 7362.77911662651, 7573.9242607573215, 7798.727044553413, 7820.648070836713, 8065.717699880476, 8711.869321960303, 8720.694775682821, 8727.0, 8736.170063843925, 8752.781180470285, 7678.654460549177, 7851.254130857559, 7975.2423519765525, 8028.397870159878, 8058.637361318638, 7594.468387212842, 7731.806704832424, 7737.187595302637, 7772.7668169954995, 7830.33442157423, 7121.287871212838, 7213.134423869169, 7232.74685386009, 7240.0, 7241.45689073311, 5344.732763361739, 5419.0, 5435.728213589384, 5486.533644640251, 5532.197831314517, 5331.0, 5416.431274716256, 5434.157705555645, 5435.402105768283, 5569.0], "value": 4565.634069259744, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [314.7959056608473, 324.4419598290939, 330.90569187781455, 332.30548154357393, 338.55141936933563, 5422.457754224575, 5463.562914966803, 5629.549636029118, 5653.830385088449, 5667.263255776748, 5490.588205884555, 5510.8071217507395, 5528.087865502197, 5528.861778455541, 5557.305336832896, 4326.490635431443, 4360.0, 4366.214081465327, 4396.252637051709, 4422.11557688462, 4136.3381858902585, 4333.956660433402, 4365.825366985317, 4406.493253275867, 4424.889377765549, 4294.763787991659, 4298.570142985708, 4312.460942382202, 4327.978360108211, 4329.895876551475, 4301.462317210348, 4332.263515202408, 4363.323684828857, 4374.58441448062, 4374.8906277343, 3694.131879008431, 3782.3380908341205, 3791.2796568652143, 3792.5259342582176, 3830.6552410283207, 5429.642589352662, 5444.564434845203, 5467.152591348347, 5494.230807686927, 5506.339239291271, 4943.357363542752, 4946.975265123688, 4969.229769385751, 4974.303597496353, 4977.975110124463, 5627.6060675752715, 5758.971205143947, 5789.797357092481, 5795.507381872546, 5858.033424484955, 4120.690948178899, 4127.7936103194725, 4139.606737359976, 4141.937870931938, 4171.976591353191, 5859.589828711992, 6068.393160683941, 6082.5742198046155, 6108.5418593605655, 6113.755449782004, 4227.87316380509, 4229.45017147775, 4236.343366778093, 4245.150969806051, 4260.956065763846, 4273.700840941105, 4314.223439780807, 4314.762688052125, 4321.870343889688, 4328.8268469260875, 4930.901381972412, 4965.32968049316, 4966.279889416014, 4972.875678108004, 4981.975090124526, 5593.161025846074, 5706.686132262683, 5857.326407463196, 5870.7945221917025, 5870.882582348329, 1423.555091582045, 1455.9563213103413, 1462.334637739826, 1462.7586448235922, 1465.157534417714, 902.6885724425194, 929.6327950459531, 944.6410364061612, 965.6861520006026, 965.9323847330619, 4894.510548945077, 4936.3829521309835, 4965.280034395065, 5041.521055499722, 5091.2363145527725, 5305.920411193835, 5380.435054319319, 5382.542483888835, 5386.165144402624, 5427.348718153847, 4747.199152499972, 4977.805326721633, 5079.415867175248, 5083.729067733067, 5112.6421150519855, 2822.5766135079493, 2835.2344866886237, 2854.372038151603, 2861.4563232986084, 2899.565065240231, 5447.264619276426, 5493.9286839066, 5555.388907220203, 5583.804566840141, 5610.129010982409, 5202.973985130126, 5318.521333079964, 5359.732013399314, 5364.51719345253, 5441.347038355423, 5434.864128396822, 5446.856160206401, 5490.423505531941, 5502.2296878437055, 5522.0, 5242.475752424727, 5245.685258884327, 5297.54970827484, 5304.655197412156, 5360.43715409892, 5575.609707320611, 5964.194833697396, 6006.579539432198, 6006.939930600638, 6058.848528786815, 6293.779717709858, 6309.148264984352, 6314.242290925118, 6331.493480521455, 6376.171097757262, 4188.979055104705, 4200.928763165373, 4231.513375961681, 4236.5339812621205, 4244.554321796167, 5874.383189765013, 6031.517478601613, 6054.243219597551, 6067.939320606914, 6090.482309003607, 5930.614510056833, 5951.166836642787, 5963.493103086286, 5968.31364393083, 5979.641221526722, 5871.500922421642, 5906.26171728534, 5929.258842644669, 5936.7922122725495, 5966.433188847052, 5600.915986260291, 5854.736536855767, 5875.618084824473, 5894.174815525744, 5896.469317761422, 5884.176215329771, 5976.491998180203, 6019.428154325332, 6028.57799953999, 6031.355855990775, 5645.640843697993, 5824.912626310524, 5824.970875145597, 5834.570530220123, 5836.387179346108], "value": 4334.574098280689, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [789.917058708836, 819.4919150126922, 820.2822530285999, 834.0200264688989, 849.5794581682069, 15332.080075195496, 15583.922080389582, 15783.289751961147, 15796.684066318667, 15927.124008179546, 14237.145771253732, 14348.497802576912, 14408.783868241984, 14483.0, 15176.0, 805.2390490986036, 826.6114925984778, 826.6858593734372, 826.6858593734372, 827.9213474719922, 806.2622700229283, 835.8996920369564, 836.5817091454273, 839.0309192882231, 840.5671079394117, 866.3805379153904, 869.8260347930408, 872.1496540872662, 875.4353442029887, 876.3208513402133, 870.3907264914521, 876.3952872517974, 876.3952872518006, 876.4171825735909, 878.3851304087101, 636.0840389838618, 639.4085470939362, 641.6567136581906, 642.2068745099798, 643.4048505132733, 16188.271527781279, 16293.429729959513, 16301.347946082142, 16323.673526529521, 16384.426545070866, 15195.0, 15214.847851521454, 15301.46444874424, 15311.0, 15350.539483815392, 12148.149629525937, 12507.249565026128, 12561.560345387868, 13174.53889113886, 13372.799408008888, 3833.367494363427, 3882.417637354391, 3920.529536455615, 3936.7637941723588, 4079.102597428561, 80715.59642201751, 82231.0, 83043.16956830415, 83503.0, 83751.0, 10812.405317707444, 10844.240903136704, 11020.50407731654, 11169.537443392412, 11311.717207069725, 21891.67162492564, 21899.014544345544, 21941.0, 21944.45138871541, 21959.0, 8506.106858779864, 8642.0, 8826.735197944072, 9034.593443295067, 9050.728478145666, 4787.42550893888, 4798.640101992295, 4948.4309304429735, 5117.309163262912, 5119.769610367543, 3594.8137114752594, 3666.9083272917856, 3743.1016556026357, 3774.698024158116, 3777.4522694209186, 611.6452457574596, 621.273110460753, 641.9358064193543, 650.6974256970436, 664.7008846019311, 648.5006544960354, 752.7214930475759, 789.4710543935577, 798.5528104261632, 806.9596520173968, 10097.848532272023, 10332.431716255678, 10518.263721539419, 10793.0, 10811.297265677864, 684.336193891924, 704.7568588836843, 715.7029832619509, 719.4675939804507, 728.308107298069, 4750.168720473903, 4890.266460031024, 5100.0, 5167.121589329748, 5168.3797944246935, 97857.51071244598, 100043.49978250063, 102219.755826859, 115431.0, 117506.0, 98325.0, 99005.0, 99104.50447747715, 99835.50082249688, 100172.0, 66353.0, 85013.57493212618, 85471.0, 87510.56244718736, 87785.5610721955, 9746.561404736945, 9933.950330248303, 9962.551685174329, 10037.89962100399, 10064.949675251577, 52741.208881866034, 53119.20321195263, 53228.4677153239, 53398.73300633472, 54180.72909635427, 74665.0, 79684.0, 80617.59691201507, 81496.18503815123, 82366.0, 12502.937485312515, 12512.749745004867, 12675.429605667583, 13058.934705326412, 13658.026963832803, 15326.310316035582, 15669.451569195024, 15866.608861181809, 15915.840841591436, 16176.757348639545, 14048.297585120907, 14634.0, 14640.487582934546, 15216.847831521543, 15332.546792513145, 14310.0, 14541.345639446461, 14602.196879171748, 15098.094114353175, 15155.924220378827, 14022.22877741734, 14087.506937257147, 14157.716845663235, 14434.206118663154, 14878.479253226085, 11360.9431952843, 11426.371549564854, 11433.771324573629, 11526.59656912004, 11531.423428828357, 9924.541502173632, 10044.899551004397, 10183.49082545855, 11754.412279386168, 11805.645830624751], "value": 7805.652287510401, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1531.5, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [104.0, 113.0, 108.0, 114.0, 114.0, 112.0, 114.0, 114.0, 110.0, 111.0], "value": 111.4, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [157.0, 119.0, 147.0, 187.0, 120.0, 151.0, 149.0, 122.0, 186.0, 118.0], "value": 145.6, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [163.0, 163.0, 161.0, 162.0, 162.0, 165.0, 177.0, 165.0, 162.0, 163.0], "value": 164.3, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 79.0, 74.0, 165.0, 77.0, 76.0, 75.0, 76.0, 175.0, 77.0], "value": 94.9, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [89.0, 85.0, 149.0, 93.0, 84.0, 85.0, 153.0, 84.0, 86.0, 146.0], "value": 105.4, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 118.0, 117.0, 117.0, 117.0, 117.0, 118.0, 118.0, 117.0, 117.0], "value": 117.3, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [147.0, 146.0, 146.0, 147.0, 150.0, 147.0, 146.0, 147.0, 146.0, 147.0], "value": 146.9, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [96.0, 95.0, 95.0, 95.0, 95.0, 95.0, 96.0, 96.0, 96.0, 95.0], "value": 95.4, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [57.0, 56.0, 55.0, 55.0, 58.0, 55.0, 56.0, 54.0, 56.0, 54.0], "value": 55.6, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [62.0, 63.0, 63.0, 63.0, 64.0, 62.0, 62.0, 62.0, 63.0, 63.0], "value": 62.7, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [77.0, 77.0, 83.0, 77.0, 77.0, 77.0, 76.0, 77.0, 81.0, 80.0], "value": 78.2, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [137.0, 123.0, 123.0, 121.0, 123.0, 128.0, 125.0, 139.0, 158.0, 124.0], "value": 130.1, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [158.0, 173.0, 161.0, 155.0, 156.0, 157.0, 157.0, 157.0, 154.0, 169.0], "value": 159.7, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [63.0, 65.0, 64.0, 65.0, 65.0, 63.0, 64.0, 64.0, 64.0, 63.0], "value": 64.0, "unit": "score"}]}]} 11:27:31 INFO - Return code: 0 11:27:31 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 11:27:31 ERROR - # TBPL SUCCESS # 11:27:31 INFO - Running post-action listener: _resource_record_post_action 11:27:31 INFO - [mozharness: 2016-07-24 18:27:31.599782Z] Finished run-tests step (success) 11:27:31 INFO - Running post-run listener: _resource_record_post_run 11:27:31 INFO - Total resource usage - Wall time: 1191s; CPU: 13.0%; Read bytes: 4096; Write bytes: 554717184; Read time: 20; Write time: 571988 11:27:31 INFO - TinderboxPrint: CPU usage
13.3% 11:27:31 INFO - TinderboxPrint: I/O read bytes / time
4,096 / 20 11:27:31 INFO - TinderboxPrint: I/O write bytes / time
554,717,184 / 571,988 11:27:31 INFO - TinderboxPrint: CPU idle
8,234.8 (86.7%) 11:27:31 INFO - TinderboxPrint: CPU user
1,209.8 (12.7%) 11:27:31 INFO - TinderboxPrint: Swap in / out
0 / 0 11:27:31 INFO - install - Wall time: 18s; CPU: 14.0%; Read bytes: 0; Write bytes: 257097728; Read time: 0; Write time: 321808 11:27:31 INFO - run-tests - Wall time: 1174s; CPU: 13.0%; Read bytes: 0; Write bytes: 297172992; Read time: 0; Write time: 250148 11:27:32 INFO - Running post-run listener: _upload_blobber_files 11:27:32 INFO - Blob upload gear active. 11:27:32 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 11:27:32 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 11:27:32 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', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 11:27:32 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 -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 11:27:32 INFO - (blobuploader) - INFO - Open directory for files ... 11:27:32 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 11:27:32 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 11:27:32 INFO - (blobuploader) - INFO - Uploading, attempt #1. 11:27:33 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 11:27:33 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 11:27:33 INFO - (blobuploader) - INFO - Done attempting. 11:27:33 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 11:27:33 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 11:27:33 INFO - (blobuploader) - INFO - Uploading, attempt #1. 11:27:34 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 11:27:34 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 11:27:34 INFO - (blobuploader) - INFO - Done attempting. 11:27:34 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 11:27:34 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 11:27:34 INFO - (blobuploader) - INFO - Uploading, attempt #1. 11:27:57 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 11:27:57 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 11:27:57 INFO - (blobuploader) - INFO - Done attempting. 11:27:57 INFO - (blobuploader) - INFO - Iteration through files over. 11:27:57 INFO - Return code: 0 11:27:57 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 11:27:57 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 11:27:57 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/21898388186ad137a2b72df81f83a0d0cc53674c3f5fb0fa23b7617d77afb284ed4bc24379ad3a4d08c3af14dcf5a7a3ab935f80b266bfe1ae7462ac265779b2", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/262430ebcb7d03219dd472fbde4c12ad553fece4fbd9170b1213936b4d55ae8a875ffe8228ecbf226dc6559a4b8c578bc1a2a1075255ab0d0483a5a23fb73efe", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/282c90725d3fdb1ec4bffed2acea42e2d1078d0517d290e81eeb1e9d26db2c14f43b67d3ef61cb06fc4b7f2136b28ed1ef855676d2cb5b3147a2bf028657a530"} 11:27:57 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 11:27:57 INFO - Writing to file /builds/slave/test/properties/blobber_files 11:27:57 INFO - Contents: 11:27:57 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/21898388186ad137a2b72df81f83a0d0cc53674c3f5fb0fa23b7617d77afb284ed4bc24379ad3a4d08c3af14dcf5a7a3ab935f80b266bfe1ae7462ac265779b2", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/262430ebcb7d03219dd472fbde4c12ad553fece4fbd9170b1213936b4d55ae8a875ffe8228ecbf226dc6559a4b8c578bc1a2a1075255ab0d0483a5a23fb73efe", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/282c90725d3fdb1ec4bffed2acea42e2d1078d0517d290e81eeb1e9d26db2c14f43b67d3ef61cb06fc4b7f2136b28ed1ef855676d2cb5b3147a2bf028657a530"} 11:27:57 INFO - Running post-run listener: copy_logs_to_upload_dir 11:27:57 INFO - Copying logs to upload dir... 11:27:57 INFO - mkdir: /builds/slave/test/build/upload/logs 11:27:57 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1257.487237 ========= master_lag: 0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 57 secs) (at 2016-07-24 11:27:56.534903) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-07-24 11:27:56.538860) ========= bash -c 'for file in `ls -1`; do cat $file; done' in dir /builds/slave/test/properties (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', 'for file in `ls -1`; do cat $file; done'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test/properties SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=6d15e502d8e29d5d2676d664000001c3-1469381342.99020-40446717 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/sha512/21898388186ad137a2b72df81f83a0d0cc53674c3f5fb0fa23b7617d77afb284ed4bc24379ad3a4d08c3af14dcf5a7a3ab935f80b266bfe1ae7462ac265779b2", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/262430ebcb7d03219dd472fbde4c12ad553fece4fbd9170b1213936b4d55ae8a875ffe8228ecbf226dc6559a4b8c578bc1a2a1075255ab0d0483a5a23fb73efe", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/282c90725d3fdb1ec4bffed2acea42e2d1078d0517d290e81eeb1e9d26db2c14f43b67d3ef61cb06fc4b7f2136b28ed1ef855676d2cb5b3147a2bf028657a530"} build_url:https://queue.taskcluster.net/v1/task/UinhjyB_Qdau-Gs9Dxz_lw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011308 build_url: 'https://queue.taskcluster.net/v1/task/UinhjyB_Qdau-Gs9Dxz_lw/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/sha512/21898388186ad137a2b72df81f83a0d0cc53674c3f5fb0fa23b7617d77afb284ed4bc24379ad3a4d08c3af14dcf5a7a3ab935f80b266bfe1ae7462ac265779b2", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/262430ebcb7d03219dd472fbde4c12ad553fece4fbd9170b1213936b4d55ae8a875ffe8228ecbf226dc6559a4b8c578bc1a2a1075255ab0d0483a5a23fb73efe", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/282c90725d3fdb1ec4bffed2acea42e2d1078d0517d290e81eeb1e9d26db2c14f43b67d3ef61cb06fc4b7f2136b28ed1ef855676d2cb5b3147a2bf028657a530"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-07-24 11:27:56.567946) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-07-24 11:27:56.568488) ========= rm -f oauth.txt in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['rm', '-f', 'oauth.txt'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=6d15e502d8e29d5d2676d664000001c3-1469381342.99020-40446717 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004544 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-07-24 11:27:56.653600) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-07-24 11:27:56.654371) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-07-24 11:27:56.655062) ========= ========= Total master_lag: 0.17 =========