builder: mozilla-central_ubuntu64_hw_test-dromaeojs-e10s slave: talos-linux64-ix-048 starttime: 1470953524.11 results: success (0) buildid: 20160811135022 builduid: f979b05a50f2425ab25770ea7b2ec8b9 revision: 233ab21b64b5d5e9f2f16ea2d4cfb4c8b293c5c4 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-08-11 15:12:04.114476) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-08-11 15:12:04.114954) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-08-11 15:12:04.115229) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-08-11 15:12:04.130202) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-08-11 15:12:04.130545) ========= 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=fa44defc139c4ba8574fe040000001db-1470952962.427132-893099056 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-08-11 15:12:04-- 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% 38.1M=0s 2016-08-11 15:12:04 (38.1 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.155651 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-08-11 15:12:04.300012) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-08-11 15:12:04.300326) ========= 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=fa44defc139c4ba8574fe040000001db-1470952962.427132-893099056 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.019368 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-08-11 15:12:04.357155) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-08-11 15:12:04.357545) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 233ab21b64b5d5e9f2f16ea2d4cfb4c8b293c5c4 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo mozilla-central --rev 233ab21b64b5d5e9f2f16ea2d4cfb4c8b293c5c4 --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=fa44defc139c4ba8574fe040000001db-1470952962.427132-893099056 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-08-11 15:12:04,889 truncating revision to first 12 chars 2016-08-11 15:12:04,889 Setting DEBUG logging. 2016-08-11 15:12:04,889 attempt 1/10 2016-08-11 15:12:04,889 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/233ab21b64b5?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-08-11 15:12:05,193 unpacking tar archive at: mozilla-central-233ab21b64b5/testing/mozharness/ program finished with exit code 0 elapsedTime=0.666111 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-08-11 15:12:05.044423) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-08-11 15:12:05.044798) ========= script_repo_revision: 233ab21b64b5d5e9f2f16ea2d4cfb4c8b293c5c4 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-08-11 15:12:05.045219) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-08-11 15:12:05.045501) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-08-11 15:12:05.058774) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 43 secs) (at 2016-08-11 15:12:05.059041) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Firefox-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox-Non-PGO in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs-e10s', '--add-option', '--webServer,localhost', '--branch-name', 'Firefox-Non-PGO', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Firefox-Non-PGO'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=fa44defc139c4ba8574fe040000001db-1470952962.427132-893099056 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 15:12:05 INFO - MultiFileLogger online at 20160811 15:12:05 in /builds/slave/test 15:12:05 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Firefox-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox-Non-PGO 15:12:05 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 15:12:05 INFO - {'append_to_log': False, 15:12:05 INFO - 'base_work_dir': '/builds/slave/test', 15:12:05 INFO - 'blob_upload_branch': 'Firefox-Non-PGO', 15:12:05 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 15:12:05 INFO - 'branch': 'Firefox-Non-PGO', 15:12:05 INFO - 'buildbot_json_path': 'buildprops.json', 15:12:05 INFO - 'config_files': ('talos/linux_config.py',), 15:12:05 INFO - 'default_actions': ('clobber', 15:12:05 INFO - 'read-buildbot-config', 15:12:05 INFO - 'download-and-extract', 15:12:05 INFO - 'populate-webroot', 15:12:05 INFO - 'create-virtualenv', 15:12:05 INFO - 'install', 15:12:05 INFO - 'run-tests'), 15:12:05 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 15:12:05 INFO - 'download_minidump_stackwalk': True, 15:12:05 INFO - 'download_symbols': 'ondemand', 15:12:05 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 15:12:05 INFO - 'tooltool.py': '/tools/tooltool.py', 15:12:05 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 15:12:05 INFO - '/tools/misc-python/virtualenv.py')}, 15:12:05 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 15:12:05 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 15:12:05 INFO - 'installer_path': 'installer.exe', 15:12:05 INFO - 'log_level': 'info', 15:12:05 INFO - 'log_name': 'talos', 15:12:05 INFO - 'log_to_console': True, 15:12:05 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 15:12:05 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 15:12:05 INFO - 'opt_config_files': (), 15:12:05 INFO - 'pip_index': False, 15:12:05 INFO - 'sps_profile': False, 15:12:05 INFO - 'sps_profile_interval': 0, 15:12:05 INFO - 'suite': 'dromaeojs-e10s', 15:12:05 INFO - 'system_bits': '32', 15:12:05 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 15:12:05 INFO - 'title': 'talos-linux64-ix-048', 15:12:05 INFO - 'tooltool_cache': '/builds/tooltool_cache', 15:12:05 INFO - 'use_talos_json': True, 15:12:05 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 15:12:05 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 15:12:05 INFO - 'work_dir': 'build'} 15:12:05 INFO - [mozharness: 2016-08-11 22:12:05.682838Z] Running clobber step. 15:12:05 INFO - Running pre-action listener: _resource_record_pre_action 15:12:05 INFO - Running main action method: clobber 15:12:05 INFO - rmtree: /builds/slave/test/build 15:12:05 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 15:12:06 INFO - Running post-action listener: _resource_record_post_action 15:12:06 INFO - [mozharness: 2016-08-11 22:12:06.136977Z] Finished clobber step (success) 15:12:06 INFO - [mozharness: 2016-08-11 22:12:06.137078Z] Running read-buildbot-config step. 15:12:06 INFO - Running pre-action listener: _resource_record_pre_action 15:12:06 INFO - Running main action method: read_buildbot_config 15:12:06 INFO - Using buildbot properties: 15:12:06 INFO - { 15:12:06 INFO - "project": "", 15:12:06 INFO - "product": "firefox", 15:12:06 INFO - "script_repo_revision": "production", 15:12:06 INFO - "builddir": "mozilla-central_ubuntu64_hw_test-dromaeojs-e10s", 15:12:06 INFO - "repository": "", 15:12:06 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-central talos dromaeojs-e10s", 15:12:06 INFO - "buildid": "20160811135022", 15:12:06 INFO - "pgo_build": "False", 15:12:06 INFO - "basedir": "/builds/slave/test", 15:12:06 INFO - "buildnumber": 420, 15:12:06 INFO - "slavename": "talos-linux64-ix-048", 15:12:06 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 15:12:06 INFO - "platform": "ubuntu64_hw", 15:12:06 INFO - "scheduler": "tests-mozilla-central-linux64-talos", 15:12:06 INFO - "branch": "mozilla-central", 15:12:06 INFO - "repo_path": "mozilla-central", 15:12:06 INFO - "revision": "233ab21b64b5d5e9f2f16ea2d4cfb4c8b293c5c4", 15:12:06 INFO - "stage_platform": "linux64", 15:12:06 INFO - "builduid": "f979b05a50f2425ab25770ea7b2ec8b9", 15:12:06 INFO - "slavebuilddir": "test" 15:12:06 INFO - } 15:12:06 INFO - Found installer url https://queue.taskcluster.net/v1/task/IpquYUdVSs-rlHetjMt75A/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2. 15:12:06 INFO - Running post-action listener: _resource_record_post_action 15:12:06 INFO - [mozharness: 2016-08-11 22:12:06.139542Z] Finished read-buildbot-config step (success) 15:12:06 INFO - [mozharness: 2016-08-11 22:12:06.139631Z] Running download-and-extract step. 15:12:06 INFO - Running pre-action listener: _resource_record_pre_action 15:12:06 INFO - Running main action method: download_and_extract 15:12:06 INFO - mkdir: /builds/slave/test/build/tests 15:12:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:12:06 INFO - trying https://queue.taskcluster.net/v1/task/IpquYUdVSs-rlHetjMt75A/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.test_packages.json 15:12:06 INFO - Downloading https://queue.taskcluster.net/v1/task/IpquYUdVSs-rlHetjMt75A/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.test_packages.json 15:12:06 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/IpquYUdVSs-rlHetjMt75A/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.test_packages.json'}, attempt #1 15:12:06 INFO - Downloaded 1361 bytes. 15:12:06 INFO - Reading from file /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.test_packages.json 15:12:06 INFO - Using the following test package requirements: 15:12:06 INFO - {u'common': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip'], 15:12:06 INFO - u'cppunittest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 15:12:06 INFO - u'firefox-51.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 15:12:06 INFO - u'gtest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 15:12:06 INFO - u'firefox-51.0a1.en-US.linux-x86_64.gtest.tests.zip'], 15:12:06 INFO - u'jittest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 15:12:06 INFO - u'jsshell-linux-x86_64.zip'], 15:12:06 INFO - u'mochitest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 15:12:06 INFO - u'firefox-51.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 15:12:06 INFO - u'mozbase': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip'], 15:12:06 INFO - u'reftest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 15:12:06 INFO - u'firefox-51.0a1.en-US.linux-x86_64.reftest.tests.zip'], 15:12:06 INFO - u'talos': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 15:12:06 INFO - u'firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip'], 15:12:06 INFO - u'web-platform': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 15:12:06 INFO - u'firefox-51.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 15:12:06 INFO - u'xpcshell': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 15:12:06 INFO - u'firefox-51.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 15:12:06 INFO - Downloading packages: [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 15:12:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:12:06 INFO - trying https://queue.taskcluster.net/v1/task/IpquYUdVSs-rlHetjMt75A/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip 15:12:06 INFO - Downloading https://queue.taskcluster.net/v1/task/IpquYUdVSs-rlHetjMt75A/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip 15:12:06 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/IpquYUdVSs-rlHetjMt75A/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 15:12:07 INFO - Downloaded 20262077 bytes. 15:12:07 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 15:12:07 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 15:12:08 INFO - Return code: 0 15:12:08 INFO - Downloading packages: [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', u'firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 15:12:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:12:08 INFO - trying https://queue.taskcluster.net/v1/task/IpquYUdVSs-rlHetjMt75A/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip 15:12:08 INFO - Downloading https://queue.taskcluster.net/v1/task/IpquYUdVSs-rlHetjMt75A/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip 15:12:08 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/IpquYUdVSs-rlHetjMt75A/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 15:12:09 INFO - Downloaded 20262077 bytes. 15:12:09 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 15:12:09 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 15:12:11 INFO - Return code: 0 15:12: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://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:12:11 INFO - trying https://queue.taskcluster.net/v1/task/IpquYUdVSs-rlHetjMt75A/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip 15:12:11 INFO - Downloading https://queue.taskcluster.net/v1/task/IpquYUdVSs-rlHetjMt75A/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip 15:12:11 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/IpquYUdVSs-rlHetjMt75A/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 15:12:11 INFO - Downloaded 14413719 bytes. 15:12:11 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 15:12:11 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip -d /builds/slave/test/build/tests 15:12:12 INFO - Return code: 0 15:12:12 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://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:12:12 INFO - trying https://queue.taskcluster.net/v1/task/IpquYUdVSs-rlHetjMt75A/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 15:12:12 INFO - Downloading https://queue.taskcluster.net/v1/task/IpquYUdVSs-rlHetjMt75A/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 15:12:12 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/IpquYUdVSs-rlHetjMt75A/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2'}, attempt #1 15:12:44 WARNING - Socket error when accessing https://queue.taskcluster.net/v1/task/IpquYUdVSs-rlHetjMt75A/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2: The read operation timed out 15:12:44 INFO - retry: attempt #1 caught exception: The read operation timed out 15:12:44 INFO - retry: Failed, sleeping 30 seconds before retrying 15:13:14 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/IpquYUdVSs-rlHetjMt75A/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2'}, attempt #2 15:13:15 INFO - Downloaded 55617075 bytes. 15:13:15 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/IpquYUdVSs-rlHetjMt75A/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 15:13:15 INFO - mkdir: /builds/slave/test/properties 15:13:15 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 15:13:15 INFO - Writing to file /builds/slave/test/properties/build_url 15:13:15 INFO - Contents: 15:13:15 INFO - build_url:https://queue.taskcluster.net/v1/task/IpquYUdVSs-rlHetjMt75A/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 15:13:16 INFO - Running post-action listener: _resource_record_post_action 15:13:16 INFO - Running post-action listener: set_extra_try_arguments 15:13:16 INFO - [mozharness: 2016-08-11 22:13:16.474111Z] Finished download-and-extract step (success) 15:13:16 INFO - [mozharness: 2016-08-11 22:13:16.474345Z] Running populate-webroot step. 15:13:16 INFO - Running pre-action listener: _resource_record_pre_action 15:13:16 INFO - Running main action method: populate_webroot 15:13:16 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 15:13:16 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 15:13:16 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 15:13:16 INFO - '--tppagecycles', 15:13:16 INFO - '7'], 15:13:16 INFO - 'tests': ['tsvgm']}}, 15:13:16 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 15:13:16 INFO - 'tests': ['tresize', 'tcanvasmark']}, 15:13:16 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 15:13:16 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 15:13:16 INFO - 'tests': ['dromaeo_css', 'kraken']}, 15:13:16 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 15:13:16 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:13:16 INFO - 'talos_options': ['--disable-e10s'], 15:13:16 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 15:13:16 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:13:16 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 15:13:16 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:13:16 INFO - 'talos_options': ['--disable-e10s'], 15:13:16 INFO - 'tests': ['damp', 'tps']}, 15:13:16 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:13:16 INFO - 'tests': ['damp', 'tps']}, 15:13:16 INFO - 'g3': {'talos_options': ['--disable-e10s'], 15:13:16 INFO - 'tests': ['dromaeo_dom']}, 15:13:16 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 15:13:16 INFO - 'g4': {'talos_options': ['--disable-e10s'], 15:13:16 INFO - 'tests': ['basic_compositor_video']}, 15:13:16 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 15:13:16 INFO - 'other': {'talos_options': ['--disable-e10s'], 15:13:16 INFO - 'tests': ['a11yr', 15:13:16 INFO - 'ts_paint', 15:13:16 INFO - 'tpaint', 15:13:16 INFO - 'sessionrestore', 15:13:16 INFO - 'sessionrestore_no_auto_restore', 15:13:16 INFO - 'tabpaint']}, 15:13:16 INFO - 'other-e10s': {'tests': ['a11yr', 15:13:16 INFO - 'ts_paint', 15:13:16 INFO - 'tpaint', 15:13:16 INFO - 'sessionrestore', 15:13:16 INFO - 'sessionrestore_no_auto_restore', 15:13:16 INFO - 'tabpaint']}, 15:13:16 INFO - 'other-e10s_l64': {'tests': ['a11yr', 15:13:16 INFO - 'ts_paint', 15:13:16 INFO - 'tpaint', 15:13:16 INFO - 'sessionrestore', 15:13:16 INFO - 'sessionrestore_no_auto_restore', 15:13:16 INFO - 'tabpaint']}, 15:13:16 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 15:13:16 INFO - 'ts_paint', 15:13:16 INFO - 'tpaint', 15:13:16 INFO - 'sessionrestore', 15:13:16 INFO - 'sessionrestore_no_auto_restore', 15:13:16 INFO - 'tabpaint']}, 15:13:16 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 15:13:16 INFO - 'tests': ['a11yr', 15:13:16 INFO - 'ts_paint', 15:13:16 INFO - 'tpaint', 15:13:16 INFO - 'sessionrestore', 15:13:16 INFO - 'sessionrestore_no_auto_restore', 15:13:16 INFO - 'tabpaint']}, 15:13:16 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 15:13:16 INFO - 'tests': ['a11yr', 15:13:16 INFO - 'ts_paint', 15:13:16 INFO - 'tpaint', 15:13:16 INFO - 'sessionrestore', 15:13:16 INFO - 'sessionrestore_no_auto_restore', 15:13:16 INFO - 'tabpaint']}, 15:13:16 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 15:13:16 INFO - 'tests': ['tsvgx', 15:13:16 INFO - 'tsvgr_opacity', 15:13:16 INFO - 'tart', 15:13:16 INFO - 'tscrollx', 15:13:16 INFO - 'cart']}, 15:13:16 INFO - 'svgr-e10s': {'tests': ['tsvgx', 15:13:16 INFO - 'tsvgr_opacity', 15:13:16 INFO - 'tart', 15:13:16 INFO - 'tscrollx', 15:13:16 INFO - 'cart']}, 15:13:16 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:13:16 INFO - 'talos_options': ['--disable-e10s'], 15:13:16 INFO - 'tests': ['tp5o']}, 15:13:16 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:13:16 INFO - 'tests': ['tp5o']}, 15:13:16 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:13:16 INFO - 'talos_options': ['--disable-e10s', 15:13:16 INFO - '--xperf_path', 15:13:16 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 15:13:16 INFO - 'tests': ['tp5n']}, 15:13:16 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:13:16 INFO - 'talos_options': ['--xperf_path', 15:13:16 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 15:13:16 INFO - 'tests': ['tp5n']}}, 15:13:16 INFO - 'talos.zip': {'path': '', 15:13:16 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 15:13:16 INFO - Running post-action listener: _resource_record_post_action 15:13:16 INFO - [mozharness: 2016-08-11 22:13:16.493223Z] Finished populate-webroot step (success) 15:13:16 INFO - [mozharness: 2016-08-11 22:13:16.493311Z] Running create-virtualenv step. 15:13:16 INFO - Running pre-action listener: _resource_record_pre_action 15:13:16 INFO - Running main action method: create_virtualenv 15:13:16 INFO - Creating virtualenv /builds/slave/test/build/venv 15:13:16 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 15:13:16 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 15:13:16 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 15:13:16 INFO - Using real prefix '/usr' 15:13:16 INFO - New python executable in /builds/slave/test/build/venv/bin/python 15:13:17 INFO - Installing distribute.............................................................................................................................................................................................done. 15:13:19 INFO - Installing pip.................done. 15:13:19 INFO - Return code: 0 15:13:19 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 15:13:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:13:19 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:13:19 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:13:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:13:19 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:13:19 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:13:19 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2088030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21eb8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x22b7400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2346570>, '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 0x2347470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2347900>, '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': 'fa44defc139c4ba8574fe040000001db-1470952962.427132-893099056', '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 15:13:19 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 15:13:19 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 15:13:19 INFO - Using env: {'DISPLAY': ':0', 15:13:19 INFO - 'HOME': '/home/cltbld', 15:13:19 INFO - 'LANG': 'en_US.UTF-8', 15:13:19 INFO - 'LANGUAGE': 'en_US:en', 15:13:19 INFO - 'LOGNAME': 'cltbld', 15:13:19 INFO - 'MAIL': '/var/mail/cltbld', 15:13:19 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:13:19 INFO - 'MOZ_NO_REMOTE': '1', 15:13:19 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:13:19 INFO - 'NO_EM_RESTART': '1', 15:13:19 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:13:19 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:13:19 INFO - 'PWD': '/builds/slave/test', 15:13:19 INFO - 'SHELL': '/bin/bash', 15:13:19 INFO - 'SHLVL': '1', 15:13:19 INFO - 'TERM': 'linux', 15:13:19 INFO - 'TMOUT': '86400', 15:13:19 INFO - 'USER': 'cltbld', 15:13:19 INFO - 'XDG_SESSION_COOKIE': 'fa44defc139c4ba8574fe040000001db-1470952962.427132-893099056', 15:13:19 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:13:19 INFO - '_': '/tools/buildbot/bin/python'} 15:13:19 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:13:19 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 15:13:19 INFO - Cleaning up... 15:13:19 INFO - Return code: 0 15:13:19 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 15:13:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:13:19 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:13:19 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:13:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:13:19 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:13:19 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:13:19 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x2088030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21eb8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x22b7400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2346570>, '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 0x2347470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2347900>, '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': 'fa44defc139c4ba8574fe040000001db-1470952962.427132-893099056', '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 15:13:19 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 15:13:19 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 15:13:19 INFO - Using env: {'DISPLAY': ':0', 15:13:19 INFO - 'HOME': '/home/cltbld', 15:13:19 INFO - 'LANG': 'en_US.UTF-8', 15:13:19 INFO - 'LANGUAGE': 'en_US:en', 15:13:19 INFO - 'LOGNAME': 'cltbld', 15:13:19 INFO - 'MAIL': '/var/mail/cltbld', 15:13:19 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:13:19 INFO - 'MOZ_NO_REMOTE': '1', 15:13:19 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:13:19 INFO - 'NO_EM_RESTART': '1', 15:13:19 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:13:19 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:13:19 INFO - 'PWD': '/builds/slave/test', 15:13:19 INFO - 'SHELL': '/bin/bash', 15:13:19 INFO - 'SHLVL': '1', 15:13:19 INFO - 'TERM': 'linux', 15:13:19 INFO - 'TMOUT': '86400', 15:13:19 INFO - 'USER': 'cltbld', 15:13:19 INFO - 'XDG_SESSION_COOKIE': 'fa44defc139c4ba8574fe040000001db-1470952962.427132-893099056', 15:13:19 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:13:19 INFO - '_': '/tools/buildbot/bin/python'} 15:13:19 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:13:19 INFO - Downloading/unpacking psutil>=3.1.1 15:13:19 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 15:13:19 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 15:13:19 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 15:13:19 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 15:13:19 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 15:13:19 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 15:13:21 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 15:13:21 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 15:13:21 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 15:13:21 INFO - Installing collected packages: psutil 15:13:21 INFO - Running setup.py install for psutil 15:13:21 INFO - building 'psutil._psutil_linux' extension 15:13:21 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 15:13:21 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 15:13:21 INFO - building 'psutil._psutil_posix' extension 15:13:21 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 15:13:21 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 15:13:21 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 15:13:21 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 15:13:21 INFO - Successfully installed psutil 15:13:21 INFO - Cleaning up... 15:13:22 INFO - Return code: 0 15:13:22 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 15:13:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:13:22 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:13:22 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:13:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:13:22 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:13:22 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:13:22 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2088030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21eb8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x22b7400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2346570>, '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 0x2347470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2347900>, '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': 'fa44defc139c4ba8574fe040000001db-1470952962.427132-893099056', '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 15:13:22 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 15:13:22 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 15:13:22 INFO - Using env: {'DISPLAY': ':0', 15:13:22 INFO - 'HOME': '/home/cltbld', 15:13:22 INFO - 'LANG': 'en_US.UTF-8', 15:13:22 INFO - 'LANGUAGE': 'en_US:en', 15:13:22 INFO - 'LOGNAME': 'cltbld', 15:13:22 INFO - 'MAIL': '/var/mail/cltbld', 15:13:22 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:13:22 INFO - 'MOZ_NO_REMOTE': '1', 15:13:22 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:13:22 INFO - 'NO_EM_RESTART': '1', 15:13:22 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:13:22 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:13:22 INFO - 'PWD': '/builds/slave/test', 15:13:22 INFO - 'SHELL': '/bin/bash', 15:13:22 INFO - 'SHLVL': '1', 15:13:22 INFO - 'TERM': 'linux', 15:13:22 INFO - 'TMOUT': '86400', 15:13:22 INFO - 'USER': 'cltbld', 15:13:22 INFO - 'XDG_SESSION_COOKIE': 'fa44defc139c4ba8574fe040000001db-1470952962.427132-893099056', 15:13:22 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:13:22 INFO - '_': '/tools/buildbot/bin/python'} 15:13:22 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:13:22 INFO - Downloading/unpacking mozsystemmonitor==0.3 15:13:22 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:13:22 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:13:22 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:13:22 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:13:22 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:13:22 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:13:24 INFO - Downloading mozsystemmonitor-0.3.tar.gz 15:13:24 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 15:13:24 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 15:13:24 INFO - Installing collected packages: mozsystemmonitor 15:13:24 INFO - Running setup.py install for mozsystemmonitor 15:13:24 INFO - Successfully installed mozsystemmonitor 15:13:24 INFO - Cleaning up... 15:13:24 INFO - Return code: 0 15:13:24 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 15:13: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://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:13:24 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:13:24 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:13: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://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:13:24 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:13:24 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:13: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', '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 0x2088030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21eb8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x22b7400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2346570>, '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 0x2347470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2347900>, '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': 'fa44defc139c4ba8574fe040000001db-1470952962.427132-893099056', '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 15:13: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', 'jsonschema==2.5.1'] in /builds/slave/test/build 15:13: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 jsonschema==2.5.1 15:13:24 INFO - Using env: {'DISPLAY': ':0', 15:13:24 INFO - 'HOME': '/home/cltbld', 15:13:24 INFO - 'LANG': 'en_US.UTF-8', 15:13:24 INFO - 'LANGUAGE': 'en_US:en', 15:13:24 INFO - 'LOGNAME': 'cltbld', 15:13:24 INFO - 'MAIL': '/var/mail/cltbld', 15:13:24 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:13:24 INFO - 'MOZ_NO_REMOTE': '1', 15:13:24 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:13:24 INFO - 'NO_EM_RESTART': '1', 15:13:24 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:13:24 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:13:24 INFO - 'PWD': '/builds/slave/test', 15:13:24 INFO - 'SHELL': '/bin/bash', 15:13:24 INFO - 'SHLVL': '1', 15:13:24 INFO - 'TERM': 'linux', 15:13:24 INFO - 'TMOUT': '86400', 15:13:24 INFO - 'USER': 'cltbld', 15:13:24 INFO - 'XDG_SESSION_COOKIE': 'fa44defc139c4ba8574fe040000001db-1470952962.427132-893099056', 15:13:24 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:13:24 INFO - '_': '/tools/buildbot/bin/python'} 15:13:24 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:13:24 INFO - Downloading/unpacking jsonschema==2.5.1 15:13: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 15:13: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 15:13: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 15:13: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 15:13: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 15:13: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 15:13:26 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 15:13:26 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 15:13: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 15:13: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 15:13: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 15:13: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 15:13: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 15:13: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 15:13:26 INFO - Downloading functools32-3.2.3-2.tar.gz 15:13:26 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 15:13:26 INFO - warning: no files found matching '*.txt' 15:13:26 INFO - no previously-included directories found matching 'build' 15:13:26 INFO - no previously-included directories found matching 'dist' 15:13:26 INFO - no previously-included directories found matching '.git*' 15:13:26 INFO - Installing collected packages: jsonschema, functools32 15:13:26 INFO - Running setup.py install for functools32 15:13:26 INFO - warning: no files found matching '*.txt' 15:13:26 INFO - no previously-included directories found matching 'build' 15:13:26 INFO - no previously-included directories found matching 'dist' 15:13:26 INFO - no previously-included directories found matching '.git*' 15:13:26 INFO - Successfully installed jsonschema functools32 15:13:26 INFO - Cleaning up... 15:13:26 INFO - Return code: 0 15:13:26 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 15:13: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://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:13:26 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:13:26 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:13: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://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:13:26 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:13:26 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:13: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', 'functools32==3.2.3-2']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2088030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21eb8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x22b7400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2346570>, '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 0x2347470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2347900>, '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': 'fa44defc139c4ba8574fe040000001db-1470952962.427132-893099056', '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 15:13: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', 'functools32==3.2.3-2'] in /builds/slave/test/build 15:13: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 functools32==3.2.3-2 15:13:26 INFO - Using env: {'DISPLAY': ':0', 15:13:26 INFO - 'HOME': '/home/cltbld', 15:13:26 INFO - 'LANG': 'en_US.UTF-8', 15:13:26 INFO - 'LANGUAGE': 'en_US:en', 15:13:26 INFO - 'LOGNAME': 'cltbld', 15:13:26 INFO - 'MAIL': '/var/mail/cltbld', 15:13:26 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:13:26 INFO - 'MOZ_NO_REMOTE': '1', 15:13:26 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:13:26 INFO - 'NO_EM_RESTART': '1', 15:13:26 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:13:26 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:13:26 INFO - 'PWD': '/builds/slave/test', 15:13:26 INFO - 'SHELL': '/bin/bash', 15:13:26 INFO - 'SHLVL': '1', 15:13:26 INFO - 'TERM': 'linux', 15:13:26 INFO - 'TMOUT': '86400', 15:13:26 INFO - 'USER': 'cltbld', 15:13:26 INFO - 'XDG_SESSION_COOKIE': 'fa44defc139c4ba8574fe040000001db-1470952962.427132-893099056', 15:13:26 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:13:26 INFO - '_': '/tools/buildbot/bin/python'} 15:13:27 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:13:27 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 15:13:27 INFO - Cleaning up... 15:13:27 INFO - Return code: 0 15:13:27 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 15:13:27 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://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:13:27 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:13:27 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:13:27 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://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:13:27 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:13:27 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:13:27 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 0x2088030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21eb8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x22b7400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2346570>, '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 0x2347470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2347900>, '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': 'fa44defc139c4ba8574fe040000001db-1470952962.427132-893099056', '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 15:13:27 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 15:13:27 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 15:13:27 INFO - Using env: {'DISPLAY': ':0', 15:13:27 INFO - 'HOME': '/home/cltbld', 15:13:27 INFO - 'LANG': 'en_US.UTF-8', 15:13:27 INFO - 'LANGUAGE': 'en_US:en', 15:13:27 INFO - 'LOGNAME': 'cltbld', 15:13:27 INFO - 'MAIL': '/var/mail/cltbld', 15:13:27 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:13:27 INFO - 'MOZ_NO_REMOTE': '1', 15:13:27 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:13:27 INFO - 'NO_EM_RESTART': '1', 15:13:27 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:13:27 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:13:27 INFO - 'PWD': '/builds/slave/test', 15:13:27 INFO - 'SHELL': '/bin/bash', 15:13:27 INFO - 'SHLVL': '1', 15:13:27 INFO - 'TERM': 'linux', 15:13:27 INFO - 'TMOUT': '86400', 15:13:27 INFO - 'USER': 'cltbld', 15:13:27 INFO - 'XDG_SESSION_COOKIE': 'fa44defc139c4ba8574fe040000001db-1470952962.427132-893099056', 15:13:27 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:13:27 INFO - '_': '/tools/buildbot/bin/python'} 15:13:27 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:13:27 INFO - Downloading/unpacking blobuploader==1.2.4 15:13:27 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 15:13:27 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 15:13:27 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 15:13:27 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 15:13:27 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 15:13:27 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 15:13:29 INFO - Downloading blobuploader-1.2.4.tar.gz 15:13:29 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 15:13:29 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 15:13: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 15:13: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 15:13: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 15:13: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 15:13: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 15:13: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 15:13:29 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 15:13:29 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 15:13: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 15:13: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 15:13: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 15:13: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 15:13: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 15:13: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 15:13:29 INFO - Downloading docopt-0.6.1.tar.gz 15:13:29 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 15:13:30 INFO - Installing collected packages: blobuploader, requests, docopt 15:13:30 INFO - Running setup.py install for blobuploader 15:13:30 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 15:13:30 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 15:13:30 INFO - Running setup.py install for requests 15:13:30 INFO - Running setup.py install for docopt 15:13:30 INFO - Successfully installed blobuploader requests docopt 15:13:30 INFO - Cleaning up... 15:13:30 INFO - Return code: 0 15:13:30 INFO - Installing None into virtualenv /builds/slave/test/build/venv 15:13:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:13:30 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:13:30 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:13:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:13:30 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:13:30 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:13:30 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 0x2088030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21eb8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x22b7400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2346570>, '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 0x2347470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2347900>, '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': 'fa44defc139c4ba8574fe040000001db-1470952962.427132-893099056', '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 15:13:30 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 15:13:30 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 15:13:30 INFO - Using env: {'DISPLAY': ':0', 15:13:30 INFO - 'HOME': '/home/cltbld', 15:13:30 INFO - 'LANG': 'en_US.UTF-8', 15:13:30 INFO - 'LANGUAGE': 'en_US:en', 15:13:30 INFO - 'LOGNAME': 'cltbld', 15:13:30 INFO - 'MAIL': '/var/mail/cltbld', 15:13:30 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:13:30 INFO - 'MOZ_NO_REMOTE': '1', 15:13:30 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:13:30 INFO - 'NO_EM_RESTART': '1', 15:13:30 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:13:30 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:13:30 INFO - 'PWD': '/builds/slave/test', 15:13:30 INFO - 'SHELL': '/bin/bash', 15:13:30 INFO - 'SHLVL': '1', 15:13:30 INFO - 'TERM': 'linux', 15:13:30 INFO - 'TMOUT': '86400', 15:13:30 INFO - 'USER': 'cltbld', 15:13:30 INFO - 'XDG_SESSION_COOKIE': 'fa44defc139c4ba8574fe040000001db-1470952962.427132-893099056', 15:13:30 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:13:30 INFO - '_': '/tools/buildbot/bin/python'} 15:13:30 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:13:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 15:13:30 INFO - Running setup.py (path:/tmp/pip-MV1UwA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 15:13:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 15:13:30 INFO - Running setup.py (path:/tmp/pip-aJ_uxs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 15:13:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 15:13:31 INFO - Running setup.py (path:/tmp/pip-Dkt53Y-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 15:13:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 15:13:31 INFO - Running setup.py (path:/tmp/pip-QIFSac-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 15:13:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 15:13:31 INFO - Running setup.py (path:/tmp/pip-OB5dDi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 15:13:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 15:13:31 INFO - Running setup.py (path:/tmp/pip-8btuLJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 15:13:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 15:13:31 INFO - Running setup.py (path:/tmp/pip-b0el82-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 15:13:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 15:13:31 INFO - Running setup.py (path:/tmp/pip-1Gsxu1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 15:13:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 15:13:31 INFO - Running setup.py (path:/tmp/pip-YnKmW_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 15:13:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 15:13:31 INFO - Running setup.py (path:/tmp/pip-iLrMTw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 15:13:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 15:13:31 INFO - Running setup.py (path:/tmp/pip-3CUlqO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 15:13:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 15:13:31 INFO - Running setup.py (path:/tmp/pip-HHIQnb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 15:13:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 15:13:31 INFO - Running setup.py (path:/tmp/pip-hRojCk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 15:13:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 15:13:31 INFO - Running setup.py (path:/tmp/pip-V325qi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 15:13:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 15:13:31 INFO - Running setup.py (path:/tmp/pip-AGbraY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 15:13:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 15:13:31 INFO - Running setup.py (path:/tmp/pip-I_3XGs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 15:13:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 15:13:32 INFO - Running setup.py (path:/tmp/pip-cB6fny-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 15:13:32 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 15:13:32 INFO - Running setup.py install for manifestparser 15:13:32 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 15:13:32 INFO - Running setup.py install for mozcrash 15:13:32 INFO - Running setup.py install for mozdebug 15:13:32 INFO - Running setup.py install for mozdevice 15:13:32 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 15:13:32 INFO - Installing dm script to /builds/slave/test/build/venv/bin 15:13:32 INFO - Running setup.py install for mozfile 15:13:32 INFO - Running setup.py install for mozhttpd 15:13:32 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 15:13:32 INFO - Running setup.py install for mozinfo 15:13:32 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 15:13:32 INFO - Running setup.py install for mozInstall 15:13:32 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 15:13:32 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 15:13:32 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 15:13:32 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 15:13:32 INFO - Running setup.py install for mozleak 15:13:32 INFO - Running setup.py install for mozlog 15:13:33 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 15:13:33 INFO - Running setup.py install for moznetwork 15:13:33 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 15:13:33 INFO - Running setup.py install for mozprocess 15:13:33 INFO - Running setup.py install for mozprofile 15:13:33 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 15:13:33 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 15:13:33 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 15:13:33 INFO - Running setup.py install for mozrunner 15:13:33 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 15:13:33 INFO - Running setup.py install for mozscreenshot 15:13:33 INFO - Running setup.py install for moztest 15:13:33 INFO - Running setup.py install for mozversion 15:13:33 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 15:13:33 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 15:13:33 INFO - Cleaning up... 15:13:33 INFO - Return code: 0 15:13:33 INFO - Installing None into virtualenv /builds/slave/test/build/venv 15:13:33 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:13:33 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:13:33 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:13:33 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:13:33 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:13:33 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:13:33 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 0x2088030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21eb8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x22b7400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2346570>, '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 0x2347470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2347900>, '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': 'fa44defc139c4ba8574fe040000001db-1470952962.427132-893099056', '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 15:13:33 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 15:13:33 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 15:13:33 INFO - Using env: {'DISPLAY': ':0', 15:13:33 INFO - 'HOME': '/home/cltbld', 15:13:33 INFO - 'LANG': 'en_US.UTF-8', 15:13:33 INFO - 'LANGUAGE': 'en_US:en', 15:13:33 INFO - 'LOGNAME': 'cltbld', 15:13:33 INFO - 'MAIL': '/var/mail/cltbld', 15:13:33 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:13:33 INFO - 'MOZ_NO_REMOTE': '1', 15:13:33 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:13:33 INFO - 'NO_EM_RESTART': '1', 15:13:33 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:13:33 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:13:33 INFO - 'PWD': '/builds/slave/test', 15:13:33 INFO - 'SHELL': '/bin/bash', 15:13:33 INFO - 'SHLVL': '1', 15:13:33 INFO - 'TERM': 'linux', 15:13:33 INFO - 'TMOUT': '86400', 15:13:33 INFO - 'USER': 'cltbld', 15:13:33 INFO - 'XDG_SESSION_COOKIE': 'fa44defc139c4ba8574fe040000001db-1470952962.427132-893099056', 15:13:33 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:13:33 INFO - '_': '/tools/buildbot/bin/python'} 15:13:34 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:13:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 15:13:34 INFO - Running setup.py (path:/tmp/pip-afGIF7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 15:13:34 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)) 15:13:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 15:13:34 INFO - Running setup.py (path:/tmp/pip-2z2fOx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 15:13:34 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)) 15:13:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 15:13:34 INFO - Running setup.py (path:/tmp/pip-l74Pgb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 15:13:34 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)) 15:13:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 15:13:34 INFO - Running setup.py (path:/tmp/pip-AigexH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 15:13:34 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)) 15:13:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 15:13:34 INFO - Running setup.py (path:/tmp/pip-dUELTp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 15:13:34 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)) 15:13:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 15:13:34 INFO - Running setup.py (path:/tmp/pip-n8dPGs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 15:13:34 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)) 15:13:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 15:13:34 INFO - Running setup.py (path:/tmp/pip-3LLGQ5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 15:13:34 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)) 15:13:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 15:13:34 INFO - Running setup.py (path:/tmp/pip-2vrhr7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 15:13:34 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)) 15:13:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 15:13:34 INFO - Running setup.py (path:/tmp/pip-B8jTIP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 15:13:34 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)) 15:13:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 15:13:34 INFO - Running setup.py (path:/tmp/pip-LhJsku-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 15:13:34 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)) 15:13:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 15:13:34 INFO - Running setup.py (path:/tmp/pip-snOyA7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 15:13:34 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)) 15:13:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 15:13:34 INFO - Running setup.py (path:/tmp/pip-fKKh1s-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 15:13:34 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)) 15:13:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 15:13:34 INFO - Running setup.py (path:/tmp/pip-EmY3TA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 15:13:35 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)) 15:13:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 15:13:35 INFO - Running setup.py (path:/tmp/pip-2cj2J0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 15:13:35 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)) 15:13:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 15:13:35 INFO - Running setup.py (path:/tmp/pip-c47CH2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 15:13:35 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)) 15:13:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 15:13:35 INFO - Running setup.py (path:/tmp/pip-oXkE_I-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 15:13:35 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)) 15:13:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 15:13:35 INFO - Running setup.py (path:/tmp/pip-NqdQ59-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 15:13:35 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)) 15:13:35 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)) 15:13:35 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)) 15:13:35 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)) 15:13:35 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)) 15:13:35 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)) 15:13:35 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.3->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 15:13:35 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 15:13:35 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 15:13:35 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 15:13:35 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 15:13:35 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 15:13:35 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 15:13:37 INFO - Downloading blessings-1.6.tar.gz 15:13:37 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 15:13:37 INFO - Installing collected packages: blessings 15:13:37 INFO - Running setup.py install for blessings 15:13:37 INFO - Successfully installed blessings 15:13:37 INFO - Cleaning up... 15:13:37 INFO - Return code: 0 15:13:37 INFO - Done creating virtualenv /builds/slave/test/build/venv. 15:13:37 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 15:13:37 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 15:13:37 INFO - Reading from file tmpfile_stdout 15:13:37 INFO - Current package versions: 15:13:37 INFO - argparse == 1.2.1 15:13:37 INFO - blessings == 1.6 15:13:37 INFO - blobuploader == 1.2.4 15:13:37 INFO - docopt == 0.6.1 15:13:37 INFO - functools32 == 3.2.3-2 15:13:37 INFO - jsonschema == 2.5.1 15:13:37 INFO - manifestparser == 1.1 15:13:37 INFO - mozInstall == 1.12 15:13:37 INFO - mozcrash == 0.17 15:13:37 INFO - mozdebug == 0.1 15:13:37 INFO - mozdevice == 0.48 15:13:37 INFO - mozfile == 1.2 15:13:37 INFO - mozhttpd == 0.7 15:13:37 INFO - mozinfo == 0.9 15:13:37 INFO - mozleak == 0.1 15:13:37 INFO - mozlog == 3.3 15:13:37 INFO - moznetwork == 0.27 15:13:37 INFO - mozprocess == 0.23 15:13:37 INFO - mozprofile == 0.28 15:13:37 INFO - mozrunner == 6.12 15:13:37 INFO - mozscreenshot == 0.1 15:13:37 INFO - mozsystemmonitor == 0.3 15:13:37 INFO - moztest == 0.7 15:13:37 INFO - mozversion == 1.4 15:13:37 INFO - psutil == 3.1.1 15:13:37 INFO - requests == 1.2.3 15:13:37 INFO - wsgiref == 0.1.2 15:13:37 INFO - Installing None into virtualenv /builds/slave/test/build/venv 15:13:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:13:37 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:13:37 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:13:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:13:37 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:13:37 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:13:37 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 0x2088030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21eb8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x22b7400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2346570>, '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 0x2347470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2347900>, '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': 'fa44defc139c4ba8574fe040000001db-1470952962.427132-893099056', '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 15:13:37 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 15:13:37 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 15:13:37 INFO - Using env: {'DISPLAY': ':0', 15:13:37 INFO - 'HOME': '/home/cltbld', 15:13:37 INFO - 'LANG': 'en_US.UTF-8', 15:13:37 INFO - 'LANGUAGE': 'en_US:en', 15:13:37 INFO - 'LOGNAME': 'cltbld', 15:13:37 INFO - 'MAIL': '/var/mail/cltbld', 15:13:37 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:13:37 INFO - 'MOZ_NO_REMOTE': '1', 15:13:37 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:13:37 INFO - 'NO_EM_RESTART': '1', 15:13:37 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:13:37 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:13:37 INFO - 'PWD': '/builds/slave/test', 15:13:37 INFO - 'SHELL': '/bin/bash', 15:13:37 INFO - 'SHLVL': '1', 15:13:37 INFO - 'TERM': 'linux', 15:13:37 INFO - 'TMOUT': '86400', 15:13:37 INFO - 'USER': 'cltbld', 15:13:37 INFO - 'XDG_SESSION_COOKIE': 'fa44defc139c4ba8574fe040000001db-1470952962.427132-893099056', 15:13:37 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:13:37 INFO - '_': '/tools/buildbot/bin/python'} 15:13:37 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:13:37 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)) 15:13:37 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)) 15:13:37 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)) 15:13:37 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)) 15:13:37 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)) 15:13:37 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)) 15:13:37 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)) 15:13:37 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)) 15:13:37 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)) 15:13:37 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)) 15:13:37 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)) 15:13:37 INFO - Cleaning up... 15:13:37 INFO - Return code: 0 15:13:37 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 15:13:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:13:37 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:13:37 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:13:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:13:37 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:13:37 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:13:37 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2088030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21eb8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x22b7400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2346570>, '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 0x2347470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2347900>, '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': 'fa44defc139c4ba8574fe040000001db-1470952962.427132-893099056', '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 15:13:37 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 15:13:37 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 15:13:37 INFO - Using env: {'DISPLAY': ':0', 15:13:37 INFO - 'HOME': '/home/cltbld', 15:13:37 INFO - 'LANG': 'en_US.UTF-8', 15:13:37 INFO - 'LANGUAGE': 'en_US:en', 15:13:37 INFO - 'LOGNAME': 'cltbld', 15:13:37 INFO - 'MAIL': '/var/mail/cltbld', 15:13:37 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:13:37 INFO - 'MOZ_NO_REMOTE': '1', 15:13:37 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:13:37 INFO - 'NO_EM_RESTART': '1', 15:13:37 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:13:37 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:13:37 INFO - 'PWD': '/builds/slave/test', 15:13:37 INFO - 'SHELL': '/bin/bash', 15:13:37 INFO - 'SHLVL': '1', 15:13:37 INFO - 'TERM': 'linux', 15:13:37 INFO - 'TMOUT': '86400', 15:13:37 INFO - 'USER': 'cltbld', 15:13:37 INFO - 'XDG_SESSION_COOKIE': 'fa44defc139c4ba8574fe040000001db-1470952962.427132-893099056', 15:13:37 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:13:37 INFO - '_': '/tools/buildbot/bin/python'} 15:13:38 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:13:38 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 15:13:38 INFO - Cleaning up... 15:13:38 INFO - Return code: 0 15:13:38 INFO - Running post-action listener: _resource_record_post_action 15:13:38 INFO - Running post-action listener: _start_resource_monitoring 15:13:38 INFO - Starting resource monitoring. 15:13:38 INFO - [mozharness: 2016-08-11 22:13:38.169758Z] Finished create-virtualenv step (success) 15:13:38 INFO - [mozharness: 2016-08-11 22:13:38.170200Z] Running install step. 15:13:38 INFO - Running pre-action listener: _resource_record_pre_action 15:13:38 INFO - Running main action method: install 15:13:38 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 15:13:38 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 15:13:38 INFO - Reading from file tmpfile_stdout 15:13:38 INFO - Detecting whether we're running mozinstall >=1.0... 15:13:38 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 15:13:38 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 15:13:38 INFO - Reading from file tmpfile_stdout 15:13:38 INFO - Output received: 15:13:38 INFO - Usage: mozinstall [options] installer 15:13:38 INFO - Options: 15:13:38 INFO - -h, --help show this help message and exit 15:13:38 INFO - -d DEST, --destination=DEST 15:13:38 INFO - Directory to install application into. [default: 15:13:38 INFO - "/builds/slave/test"] 15:13:38 INFO - --app=APP Application being installed. [default: firefox] 15:13:38 INFO - mkdir: /builds/slave/test/build/application 15:13:38 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 15:13:38 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 15:13:54 INFO - Reading from file tmpfile_stdout 15:13:54 INFO - Output received: 15:13:54 INFO - /builds/slave/test/build/application/firefox/firefox 15:13:54 INFO - Running post-action listener: _resource_record_post_action 15:13:54 INFO - [mozharness: 2016-08-11 22:13:54.554031Z] Finished install step (success) 15:13:54 INFO - [mozharness: 2016-08-11 22:13:54.554277Z] Running run-tests step. 15:13:54 INFO - Running pre-action listener: _resource_record_pre_action 15:13:54 INFO - Running main action method: run_tests 15:13:54 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 15:13:54 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 15:13:54 INFO - Python 2.7.3 15:13:54 INFO - Return code: 0 15:13:54 INFO - grabbing minidump binary from tooltool 15:13:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:13:54 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 0x2346570>, '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 0x2347470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2347900>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 15:13:54 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 15:13:54 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 15:13:54 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 15:13:54 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 15:13:54 INFO - Return code: 0 15:13:54 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 15:13:54 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 15:13:54 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 15:13:54 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 15:13:54 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 15:13:54 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox-Non-PGO', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/IpquYUdVSs-rlHetjMt75A/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-048', '--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 15:13:54 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Firefox-Non-PGO --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/IpquYUdVSs-rlHetjMt75A/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-048 --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 15:13:54 INFO - Using env: {'DISPLAY': ':0', 15:13:54 INFO - 'HOME': '/home/cltbld', 15:13:54 INFO - 'LANG': 'en_US.UTF-8', 15:13:54 INFO - 'LANGUAGE': 'en_US:en', 15:13:54 INFO - 'LOGNAME': 'cltbld', 15:13:54 INFO - 'MAIL': '/var/mail/cltbld', 15:13:54 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 15:13:54 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 15:13:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:13:54 INFO - 'MOZ_NO_REMOTE': '1', 15:13:54 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 15:13:54 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:13:54 INFO - 'NO_EM_RESTART': '1', 15:13:54 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:13:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:13:54 INFO - 'PWD': '/builds/slave/test', 15:13:54 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 15:13:54 INFO - 'SHELL': '/bin/bash', 15:13:54 INFO - 'SHLVL': '1', 15:13:54 INFO - 'TERM': 'linux', 15:13:54 INFO - 'TMOUT': '86400', 15:13:54 INFO - 'USER': 'cltbld', 15:13:54 INFO - 'XDG_SESSION_COOKIE': 'fa44defc139c4ba8574fe040000001db-1470952962.427132-893099056', 15:13:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:13:54 INFO - '_': '/tools/buildbot/bin/python'} 15:13:54 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox-Non-PGO', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/IpquYUdVSs-rlHetjMt75A/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-048', '--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 15:13:54 INFO - mozversion application_buildid: 20160811135022 15:13:54 INFO - mozversion application_changeset: 233ab21b64b5d5e9f2f16ea2d4cfb4c8b293c5c4 15:13:54 INFO - mozversion application_display_name: Nightly 15:13:54 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 15:13:54 INFO - mozversion application_name: Firefox 15:13:54 INFO - mozversion application_remotingname: firefox 15:13:54 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 15:13:54 INFO - mozversion application_vendor: Mozilla 15:13:54 INFO - mozversion application_version: 51.0a1 15:13:54 INFO - mozversion platform_buildid: 20160811135022 15:13:54 INFO - mozversion platform_changeset: 233ab21b64b5d5e9f2f16ea2d4cfb4c8b293c5c4 15:13:54 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 15:13:54 INFO - mozversion platform_version: 51.0a1 15:13:54 INFO - using testdate: 1470953634 15:13:54 INFO - actual date: 1470953634 15:13:54 INFO - starting webserver on 'localhost:42830' 15:13:54 INFO - SUITE-START | Running 2 tests 15:13:54 INFO - TEST-START | dromaeo_css 15:13:54 INFO - operating with platform_type : linux_ 15:13:54 INFO - Initialising browser for dromaeo_css test... 15:13:54 INFO - TEST-INFO | started process 20411 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpIgYbZE/profile http://localhost:42830/getInfo.html) 15:13:59 INFO - PROCESS | 20411 | __metrics Screen width/height:1600/1200 15:13:59 INFO - PROCESS | 20411 | colorDepth:24 15:13:59 INFO - PROCESS | 20411 | Browser inner width/height: 1024/697 15:13:59 INFO - PROCESS | 20411 | __metrics 15:14:00 ERROR - PROCESS | 20411 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2983: TypeError: this.tabs is undefined 15:14:01 INFO - TEST-INFO | 20411: exit 0 15:14:01 INFO - Browser initialized. 15:14:01 INFO - Running cycle 1/1 for dromaeo_css test... 15:14:01 INFO - TEST-INFO | started process 20529 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpIgYbZE/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 15:14:13 INFO - PROCESS | 20529 | RSS: Main: 163733504 15:14:13 INFO - PROCESS | 20529 | 15:15:03 INFO - PROCESS | 20529 | 1470953703264 addons.productaddons ERROR Request failed certificate checks: [Exception... "SSL is required and URI scheme is not https." nsresult: "0x8000ffff (NS_ERROR_UNEXPECTED)" location: "JS frame :: resource://gre/modules/CertUtils.jsm :: checkCert :: line 145" data: no] 15:17:16 INFO - PROCESS | 20529 | Cycle 1(1): loaded http://localhost:42830/tests/dromaeo/cssquery-dojo.html (next: http://localhost:42830/tests/dromaeo/cssquery-ext.html) 15:17:17 INFO - PROCESS | 20529 | RSS: Main: 166060032 15:17:17 INFO - PROCESS | 20529 | 15:20:20 INFO - PROCESS | 20529 | Cycle 1(1): loaded http://localhost:42830/tests/dromaeo/cssquery-ext.html (next: http://localhost:42830/tests/dromaeo/cssquery-jquery.html) 15:20:20 INFO - PROCESS | 20529 | RSS: Main: 165744640 15:20:20 INFO - PROCESS | 20529 | 15:23:22 INFO - PROCESS | 20529 | Cycle 1(1): loaded http://localhost:42830/tests/dromaeo/cssquery-jquery.html (next: http://localhost:42830/tests/dromaeo/cssquery-mootools.html) 15:23:23 INFO - PROCESS | 20529 | RSS: Main: 168910848 15:23:23 INFO - PROCESS | 20529 | 15:26:25 INFO - PROCESS | 20529 | Cycle 1(1): loaded http://localhost:42830/tests/dromaeo/cssquery-mootools.html (next: http://localhost:42830/tests/dromaeo/cssquery-prototype.html) 15:26:25 INFO - PROCESS | 20529 | RSS: Main: 163246080 15:26:25 INFO - PROCESS | 20529 | 15:29:28 INFO - PROCESS | 20529 | Cycle 1(1): loaded http://localhost:42830/tests/dromaeo/cssquery-prototype.html (next: http://localhost:42830/tests/dromaeo/cssquery-yui.html) 15:29:29 INFO - PROCESS | 20529 | RSS: Main: 165412864 15:29:29 INFO - PROCESS | 20529 | 15:32:32 INFO - PROCESS | 20529 | Cycle 1(1): loaded http://localhost:42830/tests/dromaeo/cssquery-yui.html (next: http://localhost:42830/tests/dromaeo/cssquery-dojo.html) 15:32:32 INFO - PROCESS | 20529 | RSS: Main: 169349120 15:32:32 INFO - PROCESS | 20529 | 15:32:32 INFO - PROCESS | 20529 | __start_tp_report 15:32:32 INFO - PROCESS | 20529 | _x_x_mozilla_page_load 15:32:32 INFO - PROCESS | 20529 | _x_x_mozilla_page_load_details 15:32:32 INFO - PROCESS | 20529 | |i|pagename|runs| 15:32:32 INFO - PROCESS | 20529 | |0;dojo.html;2694.6092816541595;2695.8652067396624;2719.1842447265817;2725.8091933564647;2743.1907587261767;4750.406199225097;4890;4914.60683145348;4952.950470495294;4960.305557221992;4828.106800241949;4881.536254055859;4892.119418504668;4903.338049363335;4917.778699958501;4373.912521749563;4465.419495465601;4477.395551600541;4479.3057076153245;4565.634749220055;4497.212987727151;4527.592516673499;4539.568740969603;4552.271636538155;4601.585857272845;4349.630281426083;4370.650347972155;4389.363542286383;4500.189965806154;4527.909441811178;4443.4445694288215;4444.6666500012625;4446.177457170402;4459.130469558438;4489.685721999462;4388.670849686255;4422.756748378838;4428.3578881062385;4439.66702497314;4473.530279320657;4735.313379559979;4770.61835053195;4777.28340748887;4814.181589129857;4841.467438581788;5225.190095535198;5234.685918844882;5235.397929238148;5237.973810130963;5280.551153151949;5238.083335416287;5248.763805628756;5249.055170069386;5255.395629502618;5298.284731561228;4696.0842635686395;4824.49342818999;4869.78085986135;4870.14772414826;4898.363212782316;5419;5428.891422171534;5445.782168713286;5463.781448742086;5472.91790623141;5187.429382767892;5190;5194.27280180775;5198.532132108128;5262.894742105136;5096.311997880239;5147.382314122329;5229.137192363293;5294.947050529446;5305.31030965972;5194.27280180775;5197.142471492161;5199.1161502544655;5207.0366982108435;5239.580833533309;5121.052605268037;5167.819126330561;5183.663061900965;5185.7407129644125;5243.8164664236565;4216.746995180299;4344.761038142869;4389.275769498061;4391.385206071152;4394.384786129945;3863.6522712955407;3868.3617203161725;3884.0872394987155;3902.5316961964745;3921.470601468822;4561.178987782165;4586.77066146698;4595.149897269016;4605.0559635274685;4638.257878739386;5163.199704045879;5198.662086964335;5215.817446389358;5290.047791397586;5304.751112020845;4539.182947069493;4541.091781643684;4542.636589072932;4586.587207151306;4597.057603191338;4668.603168730628;4674.0185706105985;4677.4387073550715;4691.296305554126;4691.53084691535;4809;4916.508349165055;4925.1627223372825;4955.380577427822;4970.378702662168;5291.920621190762;5314.840554783363;5328.8401347959625;5333.413324534221;5370.275012873212;4989.201727723546;4991.550760431579;4993.975030124826;5011.072951503837;5046.949530504648;4956.430010548689;5120.590352771844;5184.7926082956255;5194.844154675366;5208;5194.4805519447755;5202.8959420812125;5213.791448342024;5220.21696745476;5273.393559740525;5060.696358218519;5061.569766569735;5073.568746656576;5075.289459475603;5110.693358398508;4902.313676085422;5027.095122877917;5062.265971434048;5105.489451054865;5115.309433226466;4873.561379475864;4972.5027497249985;5035.144025515598;5038.345015148007;5097.770600323069;5131.87170320745;5133.4096578893905;5149.7682604282145;5152.510511501401;5155.948440515547;4859.562639362474;4933.087378834927;4980.377452818398;4997.225430058346;5083.856132370187 15:32:32 INFO - PROCESS | 20529 | |1;ext.html;541.2584758880334;546.969916654584;561.719140429785;566.9801556945507;579.6637949989007;35816;39330.213395732106;39401.60598394022;39437.60562394379;39490.40764388529;39676.80161599195;40102.39846402306;40416;40424;40436.59563404365;7605.84788304235;7791.961040194791;7792.415568832332;7793.766187014398;7797.0643522777345;7625.885611715801;7708.498947568418;7709.730159444421;7718.189590093044;7725.8068548286465;7690.65392057356;7709.845803083935;7710.228977102301;7730.690772369098;7731.149573546933;7628.694852205905;7635.809104772369;7660.042494688164;7663.386929045663;7688;7613.162552119263;7652.196519365498;7677.500962437423;7679.308862202429;7692.076950765888;37776;38233;38348.424773628416;38416.23167536662;38605.227895442215;2929.8095623784384;3129.4523458394688;3173.8329603295647;3252.902412927616;3449.344624521333;29068.20508978293;29283.60340347871;29478.26304342387;29583.112506624835;29843.552346714816;3245.073461112034;3324.5844269466315;3349.463706660015;3407.4718418645148;3436.329915666446;186568;187271;188051;188189;189458;55103;55280;55305;55315.446845531835;55367;33519.664803351654;34308.82845585756;34396.48405273923;36037.09907252339;57831;15157.545273641808;15199.392024318904;15333.080015199124;15372.61568460775;15378.384864605514;11244.381559014333;11361.829572556418;11377.88622113785;11387.0321022714;11392.202545821712;17977.640447191243;18010.729839052423;18016.819831801775;18049.278028878696;18061.09694515269;6423.293437721847;6527.11883895668;6559.737610495622;6583.354161459635;6698.866022679519;787.7282337593521;928.4197376639601;944.5912922048748;959.1128206409044;967.192394350711;28706.569401458994;29068.418631627672;29296.707032929397;29611.407771844442;29751.40497190044;873.6330741088758;978.3738407419257;995.4723996281982;1034.3070143004206;1037.1029059863165;14614.34235459407;15335.92332038355;15341.539753807403;15480.612984675474;15482.690346193012;380630;382242;382848;383327;384468;51533;51933;52167.478325217024;52488.47511524912;52524.474755252726;1138.5047504335475;1139.8176291793272;1156.988430115688;1160.3328086350382;1175.2830773228325;26464.735352646996;27931.301717457227;28518.287042824097;28853.7114628851;29015.419691606472;43209;43699.34450983174;43769.78115109532;43783.562164377945;43799.56200437955;320218;320923;321668;322043;322723;26294.079707210156;26440.471190576467;26450.338741531617;26716.332091697863;26741.732582674704;44208.33687494626;44529.55470445384;44545.77727111473;44685.776571116934;44817.327740083274;37675;37986.62013379941;38023;38518.2296354077;38791.92684768059;37711.434328485644;38072.80963595164;38420.6157938417;38911.80544097262;39195;35204.47193292154;37026;37395.81302093472;37619.43570846385;37652.435213471275;32046.519302210952;34544.82727586346;34576.82711586426;34878;35057.474137888465;26569.867150664122;26701.465970680867;27060.1881943542;27142;27234.863825681536 15:32:32 INFO - PROCESS | 20529 | |2;jquery.html;351.9859205631777;363.7163012849977;368.8690514867222;372.9944050839236;390.88664287356653;15791.605209869746;16718.665626687474;17054.232559534805;17123.400680976167;17262.482125536255;15795.763063554026;16260.593485162877;16522.42171523997;16652.417165399213;16696.2486688099;4969.627277954159;5178.378594568657;5183.326167598207;5186.481351864821;5188;3764.7741135531955;5112.8977420451565;5784.710764461781;5992.580519363646;6049.758009679607;6120.938790612081;6122;6122.35715249899;6126.23422072241;6136.355682653302;5028.723420211887;5246.108161612516;5322.627416080876;5362.544183744387;5370.113931201347;5118.897622047575;5179.223116532513;5183.170692689152;5189.740512974374;5231.136862417697;18149.36477223304;19010.904945475322;19174.520636984187;20149.697754533692;20824.895875520524;1797.272104797546;1872.803355647651;1903.3052935678515;1904.780950190732;2420.2860156253773;8737.781555461164;8781.58482640418;8807.427517211361;8861.468311901306;9021.819563608757;1656.436811484089;1673.4979506148106;1697.5925777813359;1734.6097128146066;1846.815318468156;70010.42014628105;74246.62876685636;74454.62772686101;75871.62064189644;76374.61812690957;8297.709580164665;8522.10517895612;8780.209781119729;9068.501232432147;9477;11482.712932176762;11485.310881347146;11539.826902596467;11558;11558.711032224093;6871.9656401717675;7064.505484616027;7137.072180616487;7279.5996220207335;7294.744683936143;7123.358897699232;7153.928460715326;7325;7381.704731810775;7406.8888966665545;3645.453182022665;3702.241040586673;3745.3258413485833;3777.86777462793;3835.137094153793;1661.6261341198133;1674.6818104560095;1740.947771566855;1766.0551604891577;1797.5236562310997;770.3653505012758;821.7452589697212;822.7737372222567;873.275181599271;921.3688623293066;16941.959393492616;17302.653946920993;17499.737503937453;18140.546486337684;18190.272389104553;848.452747977551;863.9244141044439;869.0657543141149;882.298572634757;942.2273735536794;7430.405567554582;9668;9923;9973.252006099572;10039.899601004043;399995;407122;407145;416953;417497;52761;79664;80221.59889200516;80886.19113808786;84882.5755871229;874.9168828961239;888.5512816027865;894.0478390514081;897.5826240797929;897.9326550508869;12881.355932203165;13668.65828354299;15542.689146217239;15880.2059897007;16394.918025409796;36518.63481365152;37582.24835503329;37735;37746.81126594349;38525.6147438522;54201.728991354794;54599;55332;56289.71855140698;57800.42199577951;7328.816779580553;7396.55620662762;7587.127480339832;7661.693532258871;7842.529448233125;8600.483970961763;11052.944735276273;12166.026717862373;12389.318587477776;12913.225206487265;10617;10758.784824303626;10989.560417583527;11011.504482298476;11046.116310695286;10293;10667.626633067805;11084.501197446296;11100.389478578756;11287.830682539932;10665.680029599125;10979.505922233679;10985;11095.667129986114;11188.328700278009;7158.463115266271;7451.9567260584645;7497.475176737576;7564.092308922744;7681.116671582839;10508;10571.207159462918;10650.520726567169;10705.51857034025;10813 15:32:32 INFO - PROCESS | 20529 | |3;mootools.html;1240.782862998975;1312.5930961401966;1333.4199623163922;1673.1383337581149;1679.6388776413085;6588.341165883409;7274.745383911564;7380.74167404141;7898.881516777245;7910.84178316434;7410.5924174170395;7592.734254301101;7660.502067365617;7674.46278760487;7704.036995375578;2125.2561603438826;2139.422355963889;2163.3401812447196;2165.7076294700173;2171.761106278308;2132.4455641533236;2166.490874644457;2223.5886361023263;2239.5632851593946;2241.4844585745286;2150.7849215078445;2174.2172817785586;2179.2154824263253;2196.5826492966366;2230.453538882976;2136.9679454808193;2151.1180416029433;2155.4288113649895;2163.372621939636;2164.177612507253;2085;2114.1332053858;2119.3535971528677;2141.4432247615578;2149.6882951971875;7748.7675369739;7789.532628042336;7811.414143939171;7820.061592608867;7842.647080881374;4347.869563913087;4507.4365704286965;4621.722696638212;4626.352310676508;4628.5140060293525;3002.369502404498;3069.493533566959;3087.536869469575;3090.969090309113;3126.937461250785;938.1837801113076;991.6231831903903;996.7259003773947;1008.3093081239374;1010.6159659329481;10322;10354.844677329846;10406.583736650526;10410.89589104107;10418;3927.2930872443235;4054.432379466877;4203.516595591546;4206.390073439334;4219.599138081878;8884.8667269991;8915.821683566292;8915.955420222857;8919.509426981578;8922.821543569093;4641.512641172696;4643.558861908114;4647.256438969748;4653.767311634405;4663.230566956482;3474.6004209515722;4099.139180772012;4194.895127621834;4256.829726810893;4285.785710714452;3620.388926927492;3657.8536858525895;3737.579719706494;3799;3895.8052097395016;1193.3138445393934;1195.2171327780318;1197.3594127141937;1198.9460474278678;1219.4634360881184;642.2325321241073;673.9494537909676;701.2987012987013;729.824842037907;744.8435828476081;4885.1206782779445;4979.676321039121;5146.60682782508;5160.174372100446;5234.005538947587;375.6825482467311;403.6226128569797;405.66127283717833;409.8545016519093;410.7843382224356;3599.190182208982;3619.7647152934974;3642.4900513928073;3673.725396493506;3715.4241092630687;9170.495622740813;9622.855657165148;9638.373505722106;9646.469444180637;9649.855252171223;9452.338336316392;9545;9547.188488978376;9559.426434413957;9566.13904748562;7317.304856038668;7344;7349.853002939912;7378.557286562824;7403.370713489306;5080.822171223989;5153.896922061613;5184.118699821115;5235.65968212065;5382.3541175059245;8505.74482765518;8770.12298770118;8773.912260877565;8782.341324400822;8876.911230887608;8819.368416842904;8850.424722393023;8891.822163556562;8894.110588941314;9030.413023153475;6490.902636460362;6638.17022872141;6673.632950187592;6686.364795344434;6695.464362851058;7079.610621415665;7135.393491553276;7157.534760240567;7177.497575169688;7207.13514378278;6394.904076438764;6444.677766111582;6449.226092868886;6499.1551098358805;6648.734050638114;6513.73945042193;6559.7376104955265;6577.835554110994;6720.899186512109;6757.054012438164;6100.511959043177;6134.11055396956;6153.4154255345675;6170.50635949114;6192;4337.6313013392955;4408.735475871458;4459.888502787457;4542.704724192917;4595.035042641083;4442.444694413199;4558.5897269245925;4612.146752850734;4637.930431043605;4704.670673052853 15:32:32 INFO - PROCESS | 20529 | |4;prototype.html;290.36265397452587;290.88219271195163;296.0910006280718;302.1253471200872;304.52342084637553;5024.7738851751665;5101.362329708786;5116.641835071547;5119.157103442758;5119.436861945183;4977.477364876681;4978.6514943953935;5006.173981293091;5036.294918711384;5056;3707.536557930252;3762;3870.916143479816;3894.883153505399;3903.4535165076913;3889.669378102865;3895.1235971906376;3895.4351619015224;3896.2012787378662;3902.824372903226;3870.1679138985114;3873.4189871519216;3877.3020856245867;3880.0493878999687;3882.9516030671703;3821.121142137324;3896.5713771485116;3904.726669133162;3908.1988192420486;3925.5681874993584;3434.4161492546327;3439.105832483547;3444.4155688383375;3445.8277086145595;3450.0857272822723;4929.457759646436;4946.802127914879;4976.2286845539;4978.427480839714;4995.977433652661;4400.9437734943385;4512.210363186462;4517.277235642315;4519.915220347126;4545.749983750892;5260.526552610283;5279.41926388097;5294.364676238837;5298.788048478056;5348.946510534884;3685.65473602136;3694.371956767356;3695.667389934892;3707.870224542155;3717.925641487182;5353.892922141613;5546.667199968015;5554.611177217596;5561.360443549003;5563.638363506399;3830.80845957701;3849.40334248192;3863.74885632433;3864.5555761087835;3867.8452861885207;3923.156521347924;3923.5291764988383;3925.6859451244404;3925.7644541327613;3933.8623148189677;4483.955160448419;4486.3494793254795;4492.9101417972115;4494.550544945545;4514.803577052084;5222.660527065728;5258.605604579672;5282.075636763551;5287;5348.545373643206;1317.5256907513287;1318.1036894911551;1322.307446468522;1331.1281110872394;1333.6130424358557;835.6532039203662;838.4424357802116;863.4646519158163;864.991350086491;873.9257163141077;4467.24056910326;4539.228331183706;4689.531046895283;4699.953000469952;4714.4106986626675;5498.202760599691;5504.311961004874;5517.972410137923;5519.357224231988;5520.184705800071;4525.75350254617;4682.578567928835;4684.962041511885;4706.176419126639;4709.882252943636;2867.533920828086;2896.7827412943693;2908.3020075181803;2915.781316401236;2916.650001999731;5082.18685010404;5101.438841727407;5162.586993040548;5168.423630792644;5180.32655754757;5440.6735595864375;5555.611107222537;5564.8330550083565;5607.7476513556985;5614.550835933115;5103.87240318995;5145.253938178943;5145.305383773143;5165.715885626251;5174.939137476733;5409.458304383389;5453.590980676386;5471.534919531884;5497.780088796403;5505.9174112387545;5140.76866541014;5336.839894803162;5351.652142610717;5356.839294821161;5360.597955153301;5121.231815227746;5149.613778966667;5162.664426812245;5169.276301317894;5169.844904652867;3854.8650797221962;3861.9806900965314;3911.647951684362;3932.9774258692373;3938.5273767148124;5261.605379596469;5404.972975135099;5426.5270227053925;5438.673679579238;5532.419095995024;5285.947140528546;5288.471152884835;5290.761915713879;5294.073537130909;5306;5273;5281.619763351381;5284.969430960926;5301.23132145829;5306.2305965634;4975.93017501239;5265.052290587731;5267;5296.867578310573;5305.098133317269;5171.482851714798;5235.664905449086;5333.546648534918;5393.595480338912;5397.460253974571;5227.2943152675425;5228.451012643618;5243.842684719464;5256.237845512455;5260.658057226268 15:32:32 INFO - PROCESS | 20529 | |5;yui.html;590.8846330138106;613.5796979069338;659.3604203922193;718.9820254493641;730.2697302697303;12474.688132796673;12983.610491685264;13404.396802143927;13450.125741826787;13467.259300738468;13218.272994985296;13496.460141594349;13506.932465337684;13530.120542164777;13551.25468099254;614.3978900677339;739.8483310921275;759.7834617134118;760.5474742528214;760.6006846405626;744.0587656614388;762.6415584675194;768.561919705768;768.7732119024901;769.29225112896;794.5629903553051;794.9761507154794;799.0331698644646;800.0239707556772;800.9559474228915;792.1128336263394;793.9007624046994;796.7092011415821;798.6925033862005;799.432402993875;585.8945389829871;590.9734061967222;591.2136857978878;591.7573794744134;592.1916583863039;13146.342682865914;13181.472741090442;13197.604071877859;13223;13229.073964822466;13337.599872003855;13463.461461541527;13683.521076762265;13735.45058197671;13907.860921390858;10339.534720937501;10575.20685948557;10677.25259231854;10830.133589312836;10925.562977480971;3273.492608645664;3301.5542901708204;3310.536524886518;3315.9171020724434;3319.7012268895915;52775.73612131953;54221.45778542203;61044.08433873495;61737.38262617406;61964;10190.286679932333;10216.948915255525;10410.375377477225;10450.16398688103;10579.735506612396;16077.758833617505;18125.18436670353;18165.27338906429;18224;18276.360327388476;6769.356911093439;6871.347222013901;6897.137857767779;6979.89530157048;7057.470689698293;3653.9817300913855;3707.480952666629;3751.1372384351753;3756.6619004289746;3806.6003069677286;2812.9859350703523;2913.898013569515;2927.9121626351243;2946.219251898249;2947.690492498257;513.6661170239374;517.2577351500533;525.8159644124526;528.9259503669489;533.093740640912;547.5455372041196;558.4610850529259;564.3397225246472;602.9366916473795;613.190588423277;8368.20502052304;8396.496210227406;8450.492970421794;8780.956095219612;8882.378233523592;515.38926372249;558.5475764630581;571.8999175144334;578.0491092153384;604.5425345968623;3844.2695887781792;4039.6970227233073;4103.261412945699;4234.407182994321;4339.153864996296;94531;98707;99264.50367748115;100224;101325;84516.57741711252;85119.57440212883;85702;85909.14090859011;89508.5524572373;44413.33379999302;60216;63450;71478;73204;7760.88358674609;7925.762227133196;8235.29999950011;8322;8480.872786908078;46104.53895461003;46492.7675361621;46774.766126169154;46964;47481.76259118682;54465;56184.43815561792;56480;58004.41995580159;58305;11259;11487.712807179552;11661.416929153678;11796.233244839059;12035.458404371999;12789.61631151067;13007;13059.738805224033;13215.339233038118;13389.66525836862;12410.937945310216;12767.106302558732;13055.673608159872;13078;13276.53532126371;12029.75940481203;12155.209911355734;12854.293013884326;12959.287239201934;12975.480980760663;10226.233032522441;10399.220058495794;10526.526306316387;10544;11517.07863370945;9569.712908612753;9713;10207.948960255151;10242.283040187116;10256.641017564349;8763.530599394482;10408.531616077144;10546.367217966947;10547.894521054692;10559.577616895238 15:32:32 INFO - PROCESS | 20529 | __end_tp_report 15:32:32 INFO - PROCESS | 20529 | __start_cc_report 15:32:32 INFO - PROCESS | 20529 | _x_x_mozilla_cycle_collect,359 15:32:32 INFO - PROCESS | 20529 | __end_cc_report 15:32:32 INFO - PROCESS | 20529 | __startTimestamp1470954752490__endTimestamp 15:32:32 INFO - PROCESS | 20529 | 15:32:32 INFO - PROCESS | 20529 | ------- Summary: start ------- 15:32:32 INFO - PROCESS | 20529 | Number of tests: 6 15:32:32 INFO - PROCESS | 20529 | 15:32:32 INFO - PROCESS | 20529 | [#0] dojo.html Cycles:165 Average:4828.80 Median:4956.43 stddev:515.97 (10.4%) stddev-sans-first:489.64 15:32:32 INFO - PROCESS | 20529 | Values: 2694.6 2695.9 2719.2 2725.8 2743.2 4750.4 4890.0 4914.6 4953.0 4960.3 4828.1 4881.5 4892.1 4903.3 4917.8 4373.9 4465.4 4477.4 4479.3 4565.6 4497.2 4527.6 4539.6 4552.3 4601.6 4349.6 4370.7 4389.4 4500.2 4527.9 4443.4 4444.7 4446.2 4459.1 4489.7 4388.7 4422.8 4428.4 4439.7 4473.5 4735.3 4770.6 4777.3 4814.2 4841.5 5225.2 5234.7 5235.4 5238.0 5280.6 5238.1 5248.8 5249.1 5255.4 5298.3 4696.1 4824.5 4869.8 4870.1 4898.4 5419.0 5428.9 5445.8 5463.8 5472.9 5187.4 5190.0 5194.3 5198.5 5262.9 5096.3 5147.4 5229.1 5294.9 5305.3 5194.3 5197.1 5199.1 5207.0 5239.6 5121.1 5167.8 5183.7 5185.7 5243.8 4216.7 4344.8 4389.3 4391.4 4394.4 3863.7 3868.4 3884.1 3902.5 3921.5 4561.2 4586.8 4595.1 4605.1 4638.3 5163.2 5198.7 5215.8 5290.0 5304.8 4539.2 4541.1 4542.6 4586.6 4597.1 4668.6 4674.0 4677.4 4691.3 4691.5 4809.0 4916.5 4925.2 4955.4 4970.4 5291.9 5314.8 5328.8 5333.4 5370.3 4989.2 4991.6 4994.0 5011.1 5046.9 4956.4 5120.6 5184.8 5194.8 5208.0 5194.5 5202.9 5213.8 5220.2 5273.4 5060.7 5061.6 5073.6 5075.3 5110.7 4902.3 5027.1 5062.3 5105.5 5115.3 4873.6 4972.5 5035.1 5038.3 5097.8 5131.9 5133.4 5149.8 5152.5 5155.9 4859.6 4933.1 4980.4 4997.2 5083.9 15:32:32 INFO - PROCESS | 20529 | 15:32:32 INFO - PROCESS | 20529 | [#1] ext.html Cycles:180 Average:45763.34 Median:38004.81 stddev:81249.85 (213.8%) stddev-sans-first:81406.83 15:32:32 INFO - PROCESS | 20529 | Values: 541.3 547.0 561.7 567.0 579.7 35816.0 39330.2 39401.6 39437.6 39490.4 39676.8 40102.4 40416.0 40424.0 40436.6 7605.8 7792.0 7792.4 7793.8 7797.1 7625.9 7708.5 7709.7 7718.2 7725.8 7690.7 7709.8 7710.2 7730.7 7731.1 7628.7 7635.8 7660.0 7663.4 7688.0 7613.2 7652.2 7677.5 7679.3 7692.1 37776.0 38233.0 38348.4 38416.2 38605.2 2929.8 3129.5 3173.8 3252.9 3449.3 29068.2 29283.6 29478.3 29583.1 29843.6 3245.1 3324.6 3349.5 3407.5 3436.3 186568.0 187271.0 188051.0 188189.0 189458.0 55103.0 55280.0 55305.0 55315.4 55367.0 33519.7 34308.8 34396.5 36037.1 57831.0 15157.5 15199.4 15333.1 15372.6 15378.4 11244.4 11361.8 11377.9 11387.0 11392.2 17977.6 18010.7 18016.8 18049.3 18061.1 6423.3 6527.1 6559.7 6583.4 6698.9 787.7 928.4 944.6 959.1 967.2 28706.6 29068.4 29296.7 29611.4 29751.4 873.6 978.4 995.5 1034.3 1037.1 14614.3 15335.9 15341.5 15480.6 15482.7 380630.0 382242.0 382848.0 383327.0 384468.0 51533.0 51933.0 52167.5 52488.5 52524.5 1138.5 1139.8 1157.0 1160.3 1175.3 26464.7 27931.3 28518.3 28853.7 29015.4 43209.0 43699.3 43769.8 43783.6 43799.6 320218.0 320923.0 321668.0 322043.0 322723.0 26294.1 26440.5 26450.3 26716.3 26741.7 44208.3 44529.6 44545.8 44685.8 44817.3 37675.0 37986.6 38023.0 38518.2 38791.9 37711.4 38072.8 38420.6 38911.8 39195.0 35204.5 37026.0 37395.8 37619.4 37652.4 32046.5 34544.8 34576.8 34878.0 35057.5 26569.9 26701.5 27060.2 27142.0 27234.9 15:32:32 INFO - PROCESS | 20529 | 15:32:32 INFO - PROCESS | 20529 | [#2] jquery.html Cycles:180 Average:25002.51 Median:211233.31 stddev:67714.51 (32.1%) stddev-sans-first:67879.17 15:32:32 INFO - PROCESS | 20529 | Values: 352.0 363.7 368.9 373.0 390.9 15791.6 16718.7 17054.2 17123.4 17262.5 15795.8 16260.6 16522.4 16652.4 16696.2 4969.6 5178.4 5183.3 5186.5 5188.0 3764.8 5112.9 5784.7 5992.6 6049.8 6120.9 6122.0 6122.4 6126.2 6136.4 5028.7 5246.1 5322.6 5362.5 5370.1 5118.9 5179.2 5183.2 5189.7 5231.1 18149.4 19010.9 19174.5 20149.7 20824.9 1797.3 1872.8 1903.3 1904.8 2420.3 8737.8 8781.6 8807.4 8861.5 9021.8 1656.4 1673.5 1697.6 1734.6 1846.8 70010.4 74246.6 74454.6 75871.6 76374.6 8297.7 8522.1 8780.2 9068.5 9477.0 11482.7 11485.3 11539.8 11558.0 11558.7 6872.0 7064.5 7137.1 7279.6 7294.7 7123.4 7153.9 7325.0 7381.7 7406.9 3645.5 3702.2 3745.3 3777.9 3835.1 1661.6 1674.7 1740.9 1766.1 1797.5 770.4 821.7 822.8 873.3 921.4 16942.0 17302.7 17499.7 18140.5 18190.3 848.5 863.9 869.1 882.3 942.2 7430.4 9668.0 9923.0 9973.3 10039.9 399995.0 407122.0 407145.0 416953.0 417497.0 52761.0 79664.0 80221.6 80886.2 84882.6 874.9 888.6 894.0 897.6 897.9 12881.4 13668.7 15542.7 15880.2 16394.9 36518.6 37582.2 37735.0 37746.8 38525.6 54201.7 54599.0 55332.0 56289.7 57800.4 7328.8 7396.6 7587.1 7661.7 7842.5 8600.5 11052.9 12166.0 12389.3 12913.2 10617.0 10758.8 10989.6 11011.5 11046.1 10293.0 10667.6 11084.5 11100.4 11287.8 10665.7 10979.5 10985.0 11095.7 11188.3 7158.5 7452.0 7497.5 7564.1 7681.1 10508.0 10571.2 10650.5 10705.5 10813.0 15:32:32 INFO - PROCESS | 20529 | 15:32:32 INFO - PROCESS | 20529 | [#3] mootools.html Cycles:180 Average:5055.43 Median:4683.95 stddev:2832.65 (60.5%) stddev-sans-first:2826.09 15:32:32 INFO - PROCESS | 20529 | Values: 1240.8 1312.6 1333.4 1673.1 1679.6 6588.3 7274.7 7380.7 7898.9 7910.8 7410.6 7592.7 7660.5 7674.5 7704.0 2125.3 2139.4 2163.3 2165.7 2171.8 2132.4 2166.5 2223.6 2239.6 2241.5 2150.8 2174.2 2179.2 2196.6 2230.5 2137.0 2151.1 2155.4 2163.4 2164.2 2085.0 2114.1 2119.4 2141.4 2149.7 7748.8 7789.5 7811.4 7820.1 7842.6 4347.9 4507.4 4621.7 4626.4 4628.5 3002.4 3069.5 3087.5 3091.0 3126.9 938.2 991.6 996.7 1008.3 1010.6 10322.0 10354.8 10406.6 10410.9 10418.0 3927.3 4054.4 4203.5 4206.4 4219.6 8884.9 8915.8 8916.0 8919.5 8922.8 4641.5 4643.6 4647.3 4653.8 4663.2 3474.6 4099.1 4194.9 4256.8 4285.8 3620.4 3657.9 3737.6 3799.0 3895.8 1193.3 1195.2 1197.4 1198.9 1219.5 642.2 673.9 701.3 729.8 744.8 4885.1 4979.7 5146.6 5160.2 5234.0 375.7 403.6 405.7 409.9 410.8 3599.2 3619.8 3642.5 3673.7 3715.4 9170.5 9622.9 9638.4 9646.5 9649.9 9452.3 9545.0 9547.2 9559.4 9566.1 7317.3 7344.0 7349.9 7378.6 7403.4 5080.8 5153.9 5184.1 5235.7 5382.4 8505.7 8770.1 8773.9 8782.3 8876.9 8819.4 8850.4 8891.8 8894.1 9030.4 6490.9 6638.2 6673.6 6686.4 6695.5 7079.6 7135.4 7157.5 7177.5 7207.1 6394.9 6444.7 6449.2 6499.2 6648.7 6513.7 6559.7 6577.8 6720.9 6757.1 6100.5 6134.1 6153.4 6170.5 6192.0 4337.6 4408.7 4459.9 4542.7 4595.0 4442.4 4558.6 4612.1 4637.9 4704.7 15:32:32 INFO - PROCESS | 20529 | 15:32:32 INFO - PROCESS | 20529 | [#4] prototype.html Cycles:180 Average:4394.16 Median:5046.15 stddev:1290.89 (25.6%) stddev-sans-first:1257.22 15:32:32 INFO - PROCESS | 20529 | Values: 290.4 290.9 296.1 302.1 304.5 5024.8 5101.4 5116.6 5119.2 5119.4 4977.5 4978.7 5006.2 5036.3 5056.0 3707.5 3762.0 3870.9 3894.9 3903.5 3889.7 3895.1 3895.4 3896.2 3902.8 3870.2 3873.4 3877.3 3880.0 3883.0 3821.1 3896.6 3904.7 3908.2 3925.6 3434.4 3439.1 3444.4 3445.8 3450.1 4929.5 4946.8 4976.2 4978.4 4996.0 4400.9 4512.2 4517.3 4519.9 4545.7 5260.5 5279.4 5294.4 5298.8 5348.9 3685.7 3694.4 3695.7 3707.9 3717.9 5353.9 5546.7 5554.6 5561.4 5563.6 3830.8 3849.4 3863.7 3864.6 3867.8 3923.2 3923.5 3925.7 3925.8 3933.9 4484.0 4486.3 4492.9 4494.6 4514.8 5222.7 5258.6 5282.1 5287.0 5348.5 1317.5 1318.1 1322.3 1331.1 1333.6 835.7 838.4 863.5 865.0 873.9 4467.2 4539.2 4689.5 4700.0 4714.4 5498.2 5504.3 5518.0 5519.4 5520.2 4525.8 4682.6 4685.0 4706.2 4709.9 2867.5 2896.8 2908.3 2915.8 2916.7 5082.2 5101.4 5162.6 5168.4 5180.3 5440.7 5555.6 5564.8 5607.7 5614.6 5103.9 5145.3 5145.3 5165.7 5174.9 5409.5 5453.6 5471.5 5497.8 5505.9 5140.8 5336.8 5351.7 5356.8 5360.6 5121.2 5149.6 5162.7 5169.3 5169.8 3854.9 3862.0 3911.6 3933.0 3938.5 5261.6 5405.0 5426.5 5438.7 5532.4 5285.9 5288.5 5290.8 5294.1 5306.0 5273.0 5281.6 5285.0 5301.2 5306.2 4975.9 5265.1 5267.0 5296.9 5305.1 5171.5 5235.7 5333.5 5393.6 5397.5 5227.3 5228.5 5243.8 5256.2 5260.7 15:32:32 INFO - PROCESS | 20529 | 15:32:32 INFO - PROCESS | 20529 | [#5] yui.html Cycles:180 Average:17397.86 Median:46298.65 stddev:24553.85 (53.0%) stddev-sans-first:24590.30 15:32:32 INFO - PROCESS | 20529 | Values: 590.9 613.6 659.4 719.0 730.3 12474.7 12983.6 13404.4 13450.1 13467.3 13218.3 13496.5 13506.9 13530.1 13551.3 614.4 739.8 759.8 760.5 760.6 744.1 762.6 768.6 768.8 769.3 794.6 795.0 799.0 800.0 801.0 792.1 793.9 796.7 798.7 799.4 585.9 591.0 591.2 591.8 592.2 13146.3 13181.5 13197.6 13223.0 13229.1 13337.6 13463.5 13683.5 13735.5 13907.9 10339.5 10575.2 10677.3 10830.1 10925.6 3273.5 3301.6 3310.5 3315.9 3319.7 52775.7 54221.5 61044.1 61737.4 61964.0 10190.3 10216.9 10410.4 10450.2 10579.7 16077.8 18125.2 18165.3 18224.0 18276.4 6769.4 6871.3 6897.1 6979.9 7057.5 3654.0 3707.5 3751.1 3756.7 3806.6 2813.0 2913.9 2927.9 2946.2 2947.7 513.7 517.3 525.8 528.9 533.1 547.5 558.5 564.3 602.9 613.2 8368.2 8396.5 8450.5 8781.0 8882.4 515.4 558.5 571.9 578.0 604.5 3844.3 4039.7 4103.3 4234.4 4339.2 94531.0 98707.0 99264.5 100224.0 101325.0 84516.6 85119.6 85702.0 85909.1 89508.6 44413.3 60216.0 63450.0 71478.0 73204.0 7760.9 7925.8 8235.3 8322.0 8480.9 46104.5 46492.8 46774.8 46964.0 47481.8 54465.0 56184.4 56480.0 58004.4 58305.0 11259.0 11487.7 11661.4 11796.2 12035.5 12789.6 13007.0 13059.7 13215.3 13389.7 12410.9 12767.1 13055.7 13078.0 13276.5 12029.8 12155.2 12854.3 12959.3 12975.5 10226.2 10399.2 10526.5 10544.0 11517.1 9569.7 9713.0 10207.9 10242.3 10256.6 8763.5 10408.5 10546.4 10547.9 10559.6 15:32:32 INFO - PROCESS | 20529 | -------- Summary: end -------- 15:32:32 INFO - PROCESS | 20529 | 15:32:33 INFO - TEST-INFO | 20529: exit 0 15:32:33 INFO - TEST-OK | dromaeo_css | took 1118529ms 15:32:33 INFO - TEST-START | kraken 15:32:33 INFO - operating with platform_type : linux_ 15:32:33 INFO - Initialising browser for kraken test... 15:32:33 INFO - TEST-INFO | started process 20777 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpS7Xwoc/profile http://localhost:42830/getInfo.html) 15:32:38 INFO - PROCESS | 20777 | __metrics Screen width/height:1600/1200 15:32:38 INFO - PROCESS | 20777 | colorDepth:24 15:32:38 INFO - PROCESS | 20777 | Browser inner width/height: 1024/697 15:32:38 INFO - PROCESS | 20777 | __metrics 15:32:38 ERROR - PROCESS | 20777 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2983: TypeError: this.tabs is undefined 15:32:39 INFO - TEST-INFO | 20777: exit 0 15:32:39 INFO - Browser initialized. 15:32:39 INFO - Running cycle 1/1 for kraken test... 15:32:39 INFO - TEST-INFO | started process 20893 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpS7Xwoc/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 15:32:51 INFO - PROCESS | 20893 | RSS: Main: 164130816 15:32:51 INFO - PROCESS | 20893 | 15:32:54 INFO - PROCESS | 20893 | Cycle 1(1): loaded http://localhost:42830/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:42830/tests/kraken/driver.html?testName=audio-beat-detection) 15:32:55 INFO - PROCESS | 20893 | RSS: Main: 169070592 15:32:55 INFO - PROCESS | 20893 | 15:32:58 INFO - PROCESS | 20893 | Cycle 1(1): loaded http://localhost:42830/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:42830/tests/kraken/driver.html?testName=audio-dft) 15:32:58 INFO - PROCESS | 20893 | RSS: Main: 167763968 15:32:58 INFO - PROCESS | 20893 | 15:33:01 INFO - PROCESS | 20893 | Cycle 1(1): loaded http://localhost:42830/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:42830/tests/kraken/driver.html?testName=audio-fft) 15:33:02 INFO - PROCESS | 20893 | RSS: Main: 164524032 15:33:02 INFO - PROCESS | 20893 | 15:33:04 INFO - PROCESS | 20893 | Cycle 1(1): loaded http://localhost:42830/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:42830/tests/kraken/driver.html?testName=audio-oscillator) 15:33:05 INFO - PROCESS | 20893 | RSS: Main: 164626432 15:33:05 INFO - PROCESS | 20893 | 15:33:07 INFO - PROCESS | 20893 | Cycle 1(1): loaded http://localhost:42830/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:42830/tests/kraken/driver.html?testName=imaging-gaussian-blur) 15:33:08 INFO - PROCESS | 20893 | RSS: Main: 165838848 15:33:08 INFO - PROCESS | 20893 | 15:33:11 INFO - PROCESS | 20893 | Cycle 1(1): loaded http://localhost:42830/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:42830/tests/kraken/driver.html?testName=imaging-darkroom) 15:33:12 INFO - PROCESS | 20893 | RSS: Main: 165371904 15:33:12 INFO - PROCESS | 20893 | 15:33:15 INFO - PROCESS | 20893 | Cycle 1(1): loaded http://localhost:42830/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:42830/tests/kraken/driver.html?testName=imaging-desaturate) 15:33:16 INFO - PROCESS | 20893 | RSS: Main: 162336768 15:33:16 INFO - PROCESS | 20893 | 15:33:19 INFO - PROCESS | 20893 | Cycle 1(1): loaded http://localhost:42830/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:42830/tests/kraken/driver.html?testName=json-parse-financial) 15:33:19 INFO - PROCESS | 20893 | RSS: Main: 164163584 15:33:19 INFO - PROCESS | 20893 | 15:33:21 INFO - PROCESS | 20893 | Cycle 1(1): loaded http://localhost:42830/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:42830/tests/kraken/driver.html?testName=json-stringify-tinderbox) 15:33:22 INFO - PROCESS | 20893 | RSS: Main: 164302848 15:33:22 INFO - PROCESS | 20893 | 15:33:24 INFO - PROCESS | 20893 | Cycle 1(1): loaded http://localhost:42830/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:42830/tests/kraken/driver.html?testName=stanford-crypto-aes) 15:33:24 INFO - PROCESS | 20893 | RSS: Main: 164372480 15:33:24 INFO - PROCESS | 20893 | 15:33:27 INFO - PROCESS | 20893 | Cycle 1(1): loaded http://localhost:42830/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:42830/tests/kraken/driver.html?testName=stanford-crypto-ccm) 15:33:27 INFO - PROCESS | 20893 | RSS: Main: 164933632 15:33:27 INFO - PROCESS | 20893 | 15:33:30 INFO - PROCESS | 20893 | Cycle 1(1): loaded http://localhost:42830/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:42830/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 15:33:31 INFO - PROCESS | 20893 | RSS: Main: 165109760 15:33:31 INFO - PROCESS | 20893 | 15:33:34 INFO - PROCESS | 20893 | Cycle 1(1): loaded http://localhost:42830/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:42830/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 15:33:34 INFO - PROCESS | 20893 | RSS: Main: 165466112 15:33:34 INFO - PROCESS | 20893 | 15:33:36 INFO - PROCESS | 20893 | Cycle 1(1): loaded http://localhost:42830/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:42830/tests/kraken/driver.html?testName=ai-astar) 15:33:36 INFO - PROCESS | 20893 | RSS: Main: 166076416 15:33:36 INFO - PROCESS | 20893 | 15:33:36 INFO - PROCESS | 20893 | __start_tp_report 15:33:36 INFO - PROCESS | 20893 | _x_x_mozilla_page_load 15:33:36 INFO - PROCESS | 20893 | _x_x_mozilla_page_load_details 15:33:36 INFO - PROCESS | 20893 | |i|pagename|runs| 15:33:36 INFO - PROCESS | 20893 | |0;ai-astar;106;117;110;117;117;114;116;118;114;113 15:33:36 INFO - PROCESS | 20893 | |1;audio-beat-detection;153;121;149;180;124;160;150;124;186;126 15:33:36 INFO - PROCESS | 20893 | |2;audio-dft;166;165;165;170;162;163;163;165;161;164 15:33:36 INFO - PROCESS | 20893 | |3;audio-fft;77;76;77;180;77;77;83;76;164;77 15:33:36 INFO - PROCESS | 20893 | |4;audio-oscillator;85;89;155;85;86;87;141;87;86;136 15:33:36 INFO - PROCESS | 20893 | |5;imaging-gaussian-blur;119;119;118;118;118;118;118;119;118;118 15:33:36 INFO - PROCESS | 20893 | |6;imaging-darkroom;149;148;147;151;148;149;148;149;148;150 15:33:36 INFO - PROCESS | 20893 | |7;imaging-desaturate;96;98;96;96;96;96;97;96;97;96 15:33:36 INFO - PROCESS | 20893 | |8;json-parse-financial;63;65;66;65;64;63;66;65;64;65 15:33:36 INFO - PROCESS | 20893 | |9;json-stringify-tinderbox;64;66;70;66;66;66;65;66;65;66 15:33:36 INFO - PROCESS | 20893 | |10;stanford-crypto-aes;79;82;81;82;83;85;79;80;86;80 15:33:36 INFO - PROCESS | 20893 | |11;stanford-crypto-ccm;145;137;132;134;143;136;146;148;150;137 15:33:36 INFO - PROCESS | 20893 | |12;stanford-crypto-pbkdf2;172;167;173;167;169;172;167;170;172;170 15:33:36 INFO - PROCESS | 20893 | |13;stanford-crypto-sha256-iterative;73;68;69;70;70;71;68;71;68;70 15:33:36 INFO - PROCESS | 20893 | __end_tp_report 15:33:36 INFO - PROCESS | 20893 | __start_cc_report 15:33:36 INFO - PROCESS | 20893 | _x_x_mozilla_cycle_collect,941 15:33:36 INFO - PROCESS | 20893 | __end_cc_report 15:33:36 INFO - PROCESS | 20893 | __startTimestamp1470954816851__endTimestamp 15:33:36 INFO - PROCESS | 20893 | 15:33:36 INFO - PROCESS | 20893 | ------- Summary: start ------- 15:33:36 INFO - PROCESS | 20893 | Number of tests: 14 15:33:36 INFO - PROCESS | 20893 | 15:33:36 INFO - PROCESS | 20893 | [#0] ai-astar Cycles:10 Average:114.20 Median:116.50 stddev:3.77 (3.2%) stddev-sans-first:2.57 15:33:36 INFO - PROCESS | 20893 | Values: 106.0 117.0 110.0 117.0 117.0 114.0 116.0 118.0 114.0 113.0 15:33:36 INFO - PROCESS | 20893 | 15:33:36 INFO - PROCESS | 20893 | [#1] audio-beat-detection Cycles:10 Average:147.30 Median:151.50 stddev:23.58 (15.6%) stddev-sans-first:24.91 15:33:36 INFO - PROCESS | 20893 | Values: 153.0 121.0 149.0 180.0 124.0 160.0 150.0 124.0 186.0 126.0 15:33:36 INFO - PROCESS | 20893 | 15:33:36 INFO - PROCESS | 20893 | [#2] audio-dft Cycles:10 Average:164.40 Median:165.00 stddev:2.50 (1.5%) stddev-sans-first:2.59 15:33:36 INFO - PROCESS | 20893 | Values: 166.0 165.0 165.0 170.0 162.0 163.0 163.0 165.0 161.0 164.0 15:33:36 INFO - PROCESS | 20893 | 15:33:36 INFO - PROCESS | 20893 | [#3] audio-fft Cycles:10 Average:96.40 Median:77.00 stddev:40.07 (52.0%) stddev-sans-first:41.88 15:33:36 INFO - PROCESS | 20893 | Values: 77.0 76.0 77.0 180.0 77.0 77.0 83.0 76.0 164.0 77.0 15:33:36 INFO - PROCESS | 20893 | 15:33:36 INFO - PROCESS | 20893 | [#4] audio-oscillator Cycles:10 Average:103.70 Median:86.00 stddev:28.22 (32.8%) stddev-sans-first:29.11 15:33:36 INFO - PROCESS | 20893 | Values: 85.0 89.0 155.0 85.0 86.0 87.0 141.0 87.0 86.0 136.0 15:33:36 INFO - PROCESS | 20893 | 15:33:36 INFO - PROCESS | 20893 | [#5] imaging-gaussian-blur Cycles:10 Average:118.30 Median:118.00 stddev:0.48 (0.4%) stddev-sans-first:0.44 15:33:36 INFO - PROCESS | 20893 | Values: 119.0 119.0 118.0 118.0 118.0 118.0 118.0 119.0 118.0 118.0 15:33:36 INFO - PROCESS | 20893 | 15:33:36 INFO - PROCESS | 20893 | [#6] imaging-darkroom Cycles:10 Average:148.70 Median:149.00 stddev:1.16 (0.8%) stddev-sans-first:1.22 15:33:36 INFO - PROCESS | 20893 | Values: 149.0 148.0 147.0 151.0 148.0 149.0 148.0 149.0 148.0 150.0 15:33:36 INFO - PROCESS | 20893 | 15:33:36 INFO - PROCESS | 20893 | [#7] imaging-desaturate Cycles:10 Average:96.40 Median:96.00 stddev:0.70 (0.7%) stddev-sans-first:0.73 15:33:36 INFO - PROCESS | 20893 | Values: 96.0 98.0 96.0 96.0 96.0 96.0 97.0 96.0 97.0 96.0 15:33:36 INFO - PROCESS | 20893 | 15:33:36 INFO - PROCESS | 20893 | [#8] json-parse-financial Cycles:10 Average:64.60 Median:65.00 stddev:1.07 (1.7%) stddev-sans-first:0.97 15:33:36 INFO - PROCESS | 20893 | Values: 63.0 65.0 66.0 65.0 64.0 63.0 66.0 65.0 64.0 65.0 15:33:36 INFO - PROCESS | 20893 | 15:33:36 INFO - PROCESS | 20893 | [#9] json-stringify-tinderbox Cycles:10 Average:66.00 Median:66.00 stddev:1.56 (2.4%) stddev-sans-first:1.48 15:33:36 INFO - PROCESS | 20893 | Values: 64.0 66.0 70.0 66.0 66.0 66.0 65.0 66.0 65.0 66.0 15:33:36 INFO - PROCESS | 20893 | 15:33:36 INFO - PROCESS | 20893 | [#10] stanford-crypto-aes Cycles:10 Average:81.70 Median:82.00 stddev:2.41 (2.9%) stddev-sans-first:2.35 15:33:36 INFO - PROCESS | 20893 | Values: 79.0 82.0 81.0 82.0 83.0 85.0 79.0 80.0 86.0 80.0 15:33:36 INFO - PROCESS | 20893 | 15:33:36 INFO - PROCESS | 20893 | [#11] stanford-crypto-ccm Cycles:10 Average:140.80 Median:144.00 stddev:6.34 (4.4%) stddev-sans-first:6.54 15:33:36 INFO - PROCESS | 20893 | Values: 145.0 137.0 132.0 134.0 143.0 136.0 146.0 148.0 150.0 137.0 15:33:36 INFO - PROCESS | 20893 | 15:33:36 INFO - PROCESS | 20893 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:169.90 Median:171.00 stddev:2.33 (1.4%) stddev-sans-first:2.35 15:33:36 INFO - PROCESS | 20893 | Values: 172.0 167.0 173.0 167.0 169.0 172.0 167.0 170.0 172.0 170.0 15:33:36 INFO - PROCESS | 20893 | 15:33:36 INFO - PROCESS | 20893 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:69.80 Median:70.00 stddev:1.62 (2.3%) stddev-sans-first:1.24 15:33:36 INFO - PROCESS | 20893 | Values: 73.0 68.0 69.0 70.0 70.0 71.0 68.0 71.0 68.0 70.0 15:33:36 INFO - PROCESS | 20893 | -------- Summary: end -------- 15:33:36 INFO - PROCESS | 20893 | 15:33:38 INFO - TEST-INFO | 20893: exit 0 15:33:38 INFO - TEST-OK | kraken | took 64735ms 15:33:38 INFO - SUITE-END | took 1183s 15:33:38 INFO - Completed test suite (00:19:43) 15:33:38 INFO - javascript benchmark 15:33:38 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 6437.540584617059, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2694.6092816541595, 2695.8652067396624, 2719.1842447265817, 2725.8091933564647, 2743.1907587261767, 4750.406199225097, 4890.0, 4914.60683145348, 4952.950470495294, 4960.305557221992, 4828.106800241949, 4881.536254055859, 4892.119418504668, 4903.338049363335, 4917.778699958501, 4373.912521749563, 4465.419495465601, 4477.395551600541, 4479.3057076153245, 4565.634749220055, 4497.212987727151, 4527.592516673499, 4539.568740969603, 4552.271636538155, 4601.585857272845, 4349.630281426083, 4370.650347972155, 4389.363542286383, 4500.189965806154, 4527.909441811178, 4443.4445694288215, 4444.6666500012625, 4446.177457170402, 4459.130469558438, 4489.685721999462, 4388.670849686255, 4422.756748378838, 4428.3578881062385, 4439.66702497314, 4473.530279320657, 4735.313379559979, 4770.61835053195, 4777.28340748887, 4814.181589129857, 4841.467438581788, 5225.190095535198, 5234.685918844882, 5235.397929238148, 5237.973810130963, 5280.551153151949, 5238.083335416287, 5248.763805628756, 5249.055170069386, 5255.395629502618, 5298.284731561228, 4696.0842635686395, 4824.49342818999, 4869.78085986135, 4870.14772414826, 4898.363212782316, 5419.0, 5428.891422171534, 5445.782168713286, 5463.781448742086, 5472.91790623141, 5187.429382767892, 5190.0, 5194.27280180775, 5198.532132108128, 5262.894742105136, 5096.311997880239, 5147.382314122329, 5229.137192363293, 5294.947050529446, 5305.31030965972, 5194.27280180775, 5197.142471492161, 5199.1161502544655, 5207.0366982108435, 5239.580833533309, 5121.052605268037, 5167.819126330561, 5183.663061900965, 5185.7407129644125, 5243.8164664236565, 4216.746995180299, 4344.761038142869, 4389.275769498061, 4391.385206071152, 4394.384786129945, 3863.6522712955407, 3868.3617203161725, 3884.0872394987155, 3902.5316961964745, 3921.470601468822, 4561.178987782165, 4586.77066146698, 4595.149897269016, 4605.0559635274685, 4638.257878739386, 5163.199704045879, 5198.662086964335, 5215.817446389358, 5290.047791397586, 5304.751112020845, 4539.182947069493, 4541.091781643684, 4542.636589072932, 4586.587207151306, 4597.057603191338, 4668.603168730628, 4674.0185706105985, 4677.4387073550715, 4691.296305554126, 4691.53084691535, 4809.0, 4916.508349165055, 4925.1627223372825, 4955.380577427822, 4970.378702662168, 5291.920621190762, 5314.840554783363, 5328.8401347959625, 5333.413324534221, 5370.275012873212, 4989.201727723546, 4991.550760431579, 4993.975030124826, 5011.072951503837, 5046.949530504648, 4956.430010548689, 5120.590352771844, 5184.7926082956255, 5194.844154675366, 5208.0, 5194.4805519447755, 5202.8959420812125, 5213.791448342024, 5220.21696745476, 5273.393559740525, 5060.696358218519, 5061.569766569735, 5073.568746656576, 5075.289459475603, 5110.693358398508, 4902.313676085422, 5027.095122877917, 5062.265971434048, 5105.489451054865, 5115.309433226466, 4873.561379475864, 4972.5027497249985, 5035.144025515598, 5038.345015148007, 5097.770600323069, 5131.87170320745, 5133.4096578893905, 5149.7682604282145, 5152.510511501401, 5155.948440515547, 4859.562639362474, 4933.087378834927, 4980.377452818398, 4997.225430058346, 5083.856132370187], "value": 4795.371764742035, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [541.2584758880334, 546.969916654584, 561.719140429785, 566.9801556945507, 579.6637949989007, 35816.0, 39330.213395732106, 39401.60598394022, 39437.60562394379, 39490.40764388529, 39676.80161599195, 40102.39846402306, 40416.0, 40424.0, 40436.59563404365, 7605.84788304235, 7791.961040194791, 7792.415568832332, 7793.766187014398, 7797.0643522777345, 7625.885611715801, 7708.498947568418, 7709.730159444421, 7718.189590093044, 7725.8068548286465, 7690.65392057356, 7709.845803083935, 7710.228977102301, 7730.690772369098, 7731.149573546933, 7628.694852205905, 7635.809104772369, 7660.042494688164, 7663.386929045663, 7688.0, 7613.162552119263, 7652.196519365498, 7677.500962437423, 7679.308862202429, 7692.076950765888, 37776.0, 38233.0, 38348.424773628416, 38416.23167536662, 38605.227895442215, 2929.8095623784384, 3129.4523458394688, 3173.8329603295647, 3252.902412927616, 3449.344624521333, 29068.20508978293, 29283.60340347871, 29478.26304342387, 29583.112506624835, 29843.552346714816, 3245.073461112034, 3324.5844269466315, 3349.463706660015, 3407.4718418645148, 3436.329915666446, 186568.0, 187271.0, 188051.0, 188189.0, 189458.0, 55103.0, 55280.0, 55305.0, 55315.446845531835, 55367.0, 33519.664803351654, 34308.82845585756, 34396.48405273923, 36037.09907252339, 57831.0, 15157.545273641808, 15199.392024318904, 15333.080015199124, 15372.61568460775, 15378.384864605514, 11244.381559014333, 11361.829572556418, 11377.88622113785, 11387.0321022714, 11392.202545821712, 17977.640447191243, 18010.729839052423, 18016.819831801775, 18049.278028878696, 18061.09694515269, 6423.293437721847, 6527.11883895668, 6559.737610495622, 6583.354161459635, 6698.866022679519, 787.7282337593521, 928.4197376639601, 944.5912922048748, 959.1128206409044, 967.192394350711, 28706.569401458994, 29068.418631627672, 29296.707032929397, 29611.407771844442, 29751.40497190044, 873.6330741088758, 978.3738407419257, 995.4723996281982, 1034.3070143004206, 1037.1029059863165, 14614.34235459407, 15335.92332038355, 15341.539753807403, 15480.612984675474, 15482.690346193012, 380630.0, 382242.0, 382848.0, 383327.0, 384468.0, 51533.0, 51933.0, 52167.478325217024, 52488.47511524912, 52524.474755252726, 1138.5047504335475, 1139.8176291793272, 1156.988430115688, 1160.3328086350382, 1175.2830773228325, 26464.735352646996, 27931.301717457227, 28518.287042824097, 28853.7114628851, 29015.419691606472, 43209.0, 43699.34450983174, 43769.78115109532, 43783.562164377945, 43799.56200437955, 320218.0, 320923.0, 321668.0, 322043.0, 322723.0, 26294.079707210156, 26440.471190576467, 26450.338741531617, 26716.332091697863, 26741.732582674704, 44208.33687494626, 44529.55470445384, 44545.77727111473, 44685.776571116934, 44817.327740083274, 37675.0, 37986.62013379941, 38023.0, 38518.2296354077, 38791.92684768059, 37711.434328485644, 38072.80963595164, 38420.6157938417, 38911.80544097262, 39195.0, 35204.47193292154, 37026.0, 37395.81302093472, 37619.43570846385, 37652.435213471275, 32046.519302210952, 34544.82727586346, 34576.82711586426, 34878.0, 35057.474137888465, 26569.867150664122, 26701.465970680867, 27060.1881943542, 27142.0, 27234.863825681536], "value": 17459.47241154966, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [351.9859205631777, 363.7163012849977, 368.8690514867222, 372.9944050839236, 390.88664287356653, 15791.605209869746, 16718.665626687474, 17054.232559534805, 17123.400680976167, 17262.482125536255, 15795.763063554026, 16260.593485162877, 16522.42171523997, 16652.417165399213, 16696.2486688099, 4969.627277954159, 5178.378594568657, 5183.326167598207, 5186.481351864821, 5188.0, 3764.7741135531955, 5112.8977420451565, 5784.710764461781, 5992.580519363646, 6049.758009679607, 6120.938790612081, 6122.0, 6122.35715249899, 6126.23422072241, 6136.355682653302, 5028.723420211887, 5246.108161612516, 5322.627416080876, 5362.544183744387, 5370.113931201347, 5118.897622047575, 5179.223116532513, 5183.170692689152, 5189.740512974374, 5231.136862417697, 18149.36477223304, 19010.904945475322, 19174.520636984187, 20149.697754533692, 20824.895875520524, 1797.272104797546, 1872.803355647651, 1903.3052935678515, 1904.780950190732, 2420.2860156253773, 8737.781555461164, 8781.58482640418, 8807.427517211361, 8861.468311901306, 9021.819563608757, 1656.436811484089, 1673.4979506148106, 1697.5925777813359, 1734.6097128146066, 1846.815318468156, 70010.42014628105, 74246.62876685636, 74454.62772686101, 75871.62064189644, 76374.61812690957, 8297.709580164665, 8522.10517895612, 8780.209781119729, 9068.501232432147, 9477.0, 11482.712932176762, 11485.310881347146, 11539.826902596467, 11558.0, 11558.711032224093, 6871.9656401717675, 7064.505484616027, 7137.072180616487, 7279.5996220207335, 7294.744683936143, 7123.358897699232, 7153.928460715326, 7325.0, 7381.704731810775, 7406.8888966665545, 3645.453182022665, 3702.241040586673, 3745.3258413485833, 3777.86777462793, 3835.137094153793, 1661.6261341198133, 1674.6818104560095, 1740.947771566855, 1766.0551604891577, 1797.5236562310997, 770.3653505012758, 821.7452589697212, 822.7737372222567, 873.275181599271, 921.3688623293066, 16941.959393492616, 17302.653946920993, 17499.737503937453, 18140.546486337684, 18190.272389104553, 848.452747977551, 863.9244141044439, 869.0657543141149, 882.298572634757, 942.2273735536794, 7430.405567554582, 9668.0, 9923.0, 9973.252006099572, 10039.899601004043, 399995.0, 407122.0, 407145.0, 416953.0, 417497.0, 52761.0, 79664.0, 80221.59889200516, 80886.19113808786, 84882.5755871229, 874.9168828961239, 888.5512816027865, 894.0478390514081, 897.5826240797929, 897.9326550508869, 12881.355932203165, 13668.65828354299, 15542.689146217239, 15880.2059897007, 16394.918025409796, 36518.63481365152, 37582.24835503329, 37735.0, 37746.81126594349, 38525.6147438522, 54201.728991354794, 54599.0, 55332.0, 56289.71855140698, 57800.42199577951, 7328.816779580553, 7396.55620662762, 7587.127480339832, 7661.693532258871, 7842.529448233125, 8600.483970961763, 11052.944735276273, 12166.026717862373, 12389.318587477776, 12913.225206487265, 10617.0, 10758.784824303626, 10989.560417583527, 11011.504482298476, 11046.116310695286, 10293.0, 10667.626633067805, 11084.501197446296, 11100.389478578756, 11287.830682539932, 10665.680029599125, 10979.505922233679, 10985.0, 11095.667129986114, 11188.328700278009, 7158.463115266271, 7451.9567260584645, 7497.475176737576, 7564.092308922744, 7681.116671582839, 10508.0, 10571.207159462918, 10650.520726567169, 10705.51857034025, 10813.0], "value": 8159.297976906575, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1240.782862998975, 1312.5930961401966, 1333.4199623163922, 1673.1383337581149, 1679.6388776413085, 6588.341165883409, 7274.745383911564, 7380.74167404141, 7898.881516777245, 7910.84178316434, 7410.5924174170395, 7592.734254301101, 7660.502067365617, 7674.46278760487, 7704.036995375578, 2125.2561603438826, 2139.422355963889, 2163.3401812447196, 2165.7076294700173, 2171.761106278308, 2132.4455641533236, 2166.490874644457, 2223.5886361023263, 2239.5632851593946, 2241.4844585745286, 2150.7849215078445, 2174.2172817785586, 2179.2154824263253, 2196.5826492966366, 2230.453538882976, 2136.9679454808193, 2151.1180416029433, 2155.4288113649895, 2163.372621939636, 2164.177612507253, 2085.0, 2114.1332053858, 2119.3535971528677, 2141.4432247615578, 2149.6882951971875, 7748.7675369739, 7789.532628042336, 7811.414143939171, 7820.061592608867, 7842.647080881374, 4347.869563913087, 4507.4365704286965, 4621.722696638212, 4626.352310676508, 4628.5140060293525, 3002.369502404498, 3069.493533566959, 3087.536869469575, 3090.969090309113, 3126.937461250785, 938.1837801113076, 991.6231831903903, 996.7259003773947, 1008.3093081239374, 1010.6159659329481, 10322.0, 10354.844677329846, 10406.583736650526, 10410.89589104107, 10418.0, 3927.2930872443235, 4054.432379466877, 4203.516595591546, 4206.390073439334, 4219.599138081878, 8884.8667269991, 8915.821683566292, 8915.955420222857, 8919.509426981578, 8922.821543569093, 4641.512641172696, 4643.558861908114, 4647.256438969748, 4653.767311634405, 4663.230566956482, 3474.6004209515722, 4099.139180772012, 4194.895127621834, 4256.829726810893, 4285.785710714452, 3620.388926927492, 3657.8536858525895, 3737.579719706494, 3799.0, 3895.8052097395016, 1193.3138445393934, 1195.2171327780318, 1197.3594127141937, 1198.9460474278678, 1219.4634360881184, 642.2325321241073, 673.9494537909676, 701.2987012987013, 729.824842037907, 744.8435828476081, 4885.1206782779445, 4979.676321039121, 5146.60682782508, 5160.174372100446, 5234.005538947587, 375.6825482467311, 403.6226128569797, 405.66127283717833, 409.8545016519093, 410.7843382224356, 3599.190182208982, 3619.7647152934974, 3642.4900513928073, 3673.725396493506, 3715.4241092630687, 9170.495622740813, 9622.855657165148, 9638.373505722106, 9646.469444180637, 9649.855252171223, 9452.338336316392, 9545.0, 9547.188488978376, 9559.426434413957, 9566.13904748562, 7317.304856038668, 7344.0, 7349.853002939912, 7378.557286562824, 7403.370713489306, 5080.822171223989, 5153.896922061613, 5184.118699821115, 5235.65968212065, 5382.3541175059245, 8505.74482765518, 8770.12298770118, 8773.912260877565, 8782.341324400822, 8876.911230887608, 8819.368416842904, 8850.424722393023, 8891.822163556562, 8894.110588941314, 9030.413023153475, 6490.902636460362, 6638.17022872141, 6673.632950187592, 6686.364795344434, 6695.464362851058, 7079.610621415665, 7135.393491553276, 7157.534760240567, 7177.497575169688, 7207.13514378278, 6394.904076438764, 6444.677766111582, 6449.226092868886, 6499.1551098358805, 6648.734050638114, 6513.73945042193, 6559.7376104955265, 6577.835554110994, 6720.899186512109, 6757.054012438164, 6100.511959043177, 6134.11055396956, 6153.4154255345675, 6170.50635949114, 6192.0, 4337.6313013392955, 4408.735475871458, 4459.888502787457, 4542.704724192917, 4595.035042641083, 4442.444694413199, 4558.5897269245925, 4612.146752850734, 4637.930431043605, 4704.670673052853], "value": 4004.583989015707, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [290.36265397452587, 290.88219271195163, 296.0910006280718, 302.1253471200872, 304.52342084637553, 5024.7738851751665, 5101.362329708786, 5116.641835071547, 5119.157103442758, 5119.436861945183, 4977.477364876681, 4978.6514943953935, 5006.173981293091, 5036.294918711384, 5056.0, 3707.536557930252, 3762.0, 3870.916143479816, 3894.883153505399, 3903.4535165076913, 3889.669378102865, 3895.1235971906376, 3895.4351619015224, 3896.2012787378662, 3902.824372903226, 3870.1679138985114, 3873.4189871519216, 3877.3020856245867, 3880.0493878999687, 3882.9516030671703, 3821.121142137324, 3896.5713771485116, 3904.726669133162, 3908.1988192420486, 3925.5681874993584, 3434.4161492546327, 3439.105832483547, 3444.4155688383375, 3445.8277086145595, 3450.0857272822723, 4929.457759646436, 4946.802127914879, 4976.2286845539, 4978.427480839714, 4995.977433652661, 4400.9437734943385, 4512.210363186462, 4517.277235642315, 4519.915220347126, 4545.749983750892, 5260.526552610283, 5279.41926388097, 5294.364676238837, 5298.788048478056, 5348.946510534884, 3685.65473602136, 3694.371956767356, 3695.667389934892, 3707.870224542155, 3717.925641487182, 5353.892922141613, 5546.667199968015, 5554.611177217596, 5561.360443549003, 5563.638363506399, 3830.80845957701, 3849.40334248192, 3863.74885632433, 3864.5555761087835, 3867.8452861885207, 3923.156521347924, 3923.5291764988383, 3925.6859451244404, 3925.7644541327613, 3933.8623148189677, 4483.955160448419, 4486.3494793254795, 4492.9101417972115, 4494.550544945545, 4514.803577052084, 5222.660527065728, 5258.605604579672, 5282.075636763551, 5287.0, 5348.545373643206, 1317.5256907513287, 1318.1036894911551, 1322.307446468522, 1331.1281110872394, 1333.6130424358557, 835.6532039203662, 838.4424357802116, 863.4646519158163, 864.991350086491, 873.9257163141077, 4467.24056910326, 4539.228331183706, 4689.531046895283, 4699.953000469952, 4714.4106986626675, 5498.202760599691, 5504.311961004874, 5517.972410137923, 5519.357224231988, 5520.184705800071, 4525.75350254617, 4682.578567928835, 4684.962041511885, 4706.176419126639, 4709.882252943636, 2867.533920828086, 2896.7827412943693, 2908.3020075181803, 2915.781316401236, 2916.650001999731, 5082.18685010404, 5101.438841727407, 5162.586993040548, 5168.423630792644, 5180.32655754757, 5440.6735595864375, 5555.611107222537, 5564.8330550083565, 5607.7476513556985, 5614.550835933115, 5103.87240318995, 5145.253938178943, 5145.305383773143, 5165.715885626251, 5174.939137476733, 5409.458304383389, 5453.590980676386, 5471.534919531884, 5497.780088796403, 5505.9174112387545, 5140.76866541014, 5336.839894803162, 5351.652142610717, 5356.839294821161, 5360.597955153301, 5121.231815227746, 5149.613778966667, 5162.664426812245, 5169.276301317894, 5169.844904652867, 3854.8650797221962, 3861.9806900965314, 3911.647951684362, 3932.9774258692373, 3938.5273767148124, 5261.605379596469, 5404.972975135099, 5426.5270227053925, 5438.673679579238, 5532.419095995024, 5285.947140528546, 5288.471152884835, 5290.761915713879, 5294.073537130909, 5306.0, 5273.0, 5281.619763351381, 5284.969430960926, 5301.23132145829, 5306.2305965634, 4975.93017501239, 5265.052290587731, 5267.0, 5296.867578310573, 5305.098133317269, 5171.482851714798, 5235.664905449086, 5333.546648534918, 5393.595480338912, 5397.460253974571, 5227.2943152675425, 5228.451012643618, 5243.842684719464, 5256.237845512455, 5260.658057226268], "value": 3974.95656364847, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [590.8846330138106, 613.5796979069338, 659.3604203922193, 718.9820254493641, 730.2697302697303, 12474.688132796673, 12983.610491685264, 13404.396802143927, 13450.125741826787, 13467.259300738468, 13218.272994985296, 13496.460141594349, 13506.932465337684, 13530.120542164777, 13551.25468099254, 614.3978900677339, 739.8483310921275, 759.7834617134118, 760.5474742528214, 760.6006846405626, 744.0587656614388, 762.6415584675194, 768.561919705768, 768.7732119024901, 769.29225112896, 794.5629903553051, 794.9761507154794, 799.0331698644646, 800.0239707556772, 800.9559474228915, 792.1128336263394, 793.9007624046994, 796.7092011415821, 798.6925033862005, 799.432402993875, 585.8945389829871, 590.9734061967222, 591.2136857978878, 591.7573794744134, 592.1916583863039, 13146.342682865914, 13181.472741090442, 13197.604071877859, 13223.0, 13229.073964822466, 13337.599872003855, 13463.461461541527, 13683.521076762265, 13735.45058197671, 13907.860921390858, 10339.534720937501, 10575.20685948557, 10677.25259231854, 10830.133589312836, 10925.562977480971, 3273.492608645664, 3301.5542901708204, 3310.536524886518, 3315.9171020724434, 3319.7012268895915, 52775.73612131953, 54221.45778542203, 61044.08433873495, 61737.38262617406, 61964.0, 10190.286679932333, 10216.948915255525, 10410.375377477225, 10450.16398688103, 10579.735506612396, 16077.758833617505, 18125.18436670353, 18165.27338906429, 18224.0, 18276.360327388476, 6769.356911093439, 6871.347222013901, 6897.137857767779, 6979.89530157048, 7057.470689698293, 3653.9817300913855, 3707.480952666629, 3751.1372384351753, 3756.6619004289746, 3806.6003069677286, 2812.9859350703523, 2913.898013569515, 2927.9121626351243, 2946.219251898249, 2947.690492498257, 513.6661170239374, 517.2577351500533, 525.8159644124526, 528.9259503669489, 533.093740640912, 547.5455372041196, 558.4610850529259, 564.3397225246472, 602.9366916473795, 613.190588423277, 8368.20502052304, 8396.496210227406, 8450.492970421794, 8780.956095219612, 8882.378233523592, 515.38926372249, 558.5475764630581, 571.8999175144334, 578.0491092153384, 604.5425345968623, 3844.2695887781792, 4039.6970227233073, 4103.261412945699, 4234.407182994321, 4339.153864996296, 94531.0, 98707.0, 99264.50367748115, 100224.0, 101325.0, 84516.57741711252, 85119.57440212883, 85702.0, 85909.14090859011, 89508.5524572373, 44413.33379999302, 60216.0, 63450.0, 71478.0, 73204.0, 7760.88358674609, 7925.762227133196, 8235.29999950011, 8322.0, 8480.872786908078, 46104.53895461003, 46492.7675361621, 46774.766126169154, 46964.0, 47481.76259118682, 54465.0, 56184.43815561792, 56480.0, 58004.41995580159, 58305.0, 11259.0, 11487.712807179552, 11661.416929153678, 11796.233244839059, 12035.458404371999, 12789.61631151067, 13007.0, 13059.738805224033, 13215.339233038118, 13389.66525836862, 12410.937945310216, 12767.106302558732, 13055.673608159872, 13078.0, 13276.53532126371, 12029.75940481203, 12155.209911355734, 12854.293013884326, 12959.287239201934, 12975.480980760663, 10226.233032522441, 10399.220058495794, 10526.526306316387, 10544.0, 11517.07863370945, 9569.712908612753, 9713.0, 10207.948960255151, 10242.283040187116, 10256.641017564349, 8763.530599394482, 10408.531616077144, 10546.367217966947, 10547.894521054692, 10559.577616895238], "value": 6544.492155583149, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1582.2, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [106.0, 117.0, 110.0, 117.0, 117.0, 114.0, 116.0, 118.0, 114.0, 113.0], "value": 114.2, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [153.0, 121.0, 149.0, 180.0, 124.0, 160.0, 150.0, 124.0, 186.0, 126.0], "value": 147.3, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [166.0, 165.0, 165.0, 170.0, 162.0, 163.0, 163.0, 165.0, 161.0, 164.0], "value": 164.4, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [77.0, 76.0, 77.0, 180.0, 77.0, 77.0, 83.0, 76.0, 164.0, 77.0], "value": 96.4, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [85.0, 89.0, 155.0, 85.0, 86.0, 87.0, 141.0, 87.0, 86.0, 136.0], "value": 103.7, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [119.0, 119.0, 118.0, 118.0, 118.0, 118.0, 118.0, 119.0, 118.0, 118.0], "value": 118.3, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [149.0, 148.0, 147.0, 151.0, 148.0, 149.0, 148.0, 149.0, 148.0, 150.0], "value": 148.7, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [96.0, 98.0, 96.0, 96.0, 96.0, 96.0, 97.0, 96.0, 97.0, 96.0], "value": 96.4, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [63.0, 65.0, 66.0, 65.0, 64.0, 63.0, 66.0, 65.0, 64.0, 65.0], "value": 64.6, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [64.0, 66.0, 70.0, 66.0, 66.0, 66.0, 65.0, 66.0, 65.0, 66.0], "value": 66.0, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [79.0, 82.0, 81.0, 82.0, 83.0, 85.0, 79.0, 80.0, 86.0, 80.0], "value": 81.7, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [145.0, 137.0, 132.0, 134.0, 143.0, 136.0, 146.0, 148.0, 150.0, 137.0], "value": 140.8, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [172.0, 167.0, 173.0, 167.0, 169.0, 172.0, 167.0, 170.0, 172.0, 170.0], "value": 169.9, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [73.0, 68.0, 69.0, 70.0, 70.0, 71.0, 68.0, 71.0, 68.0, 70.0], "value": 69.8, "unit": "score"}]}]} 15:33:38 INFO - Return code: 0 15:33:38 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 15:33:38 ERROR - # TBPL SUCCESS # 15:33:38 INFO - Running post-action listener: _resource_record_post_action 15:33:38 INFO - [mozharness: 2016-08-11 22:33:38.636443Z] Finished run-tests step (success) 15:33:38 INFO - Running post-run listener: _resource_record_post_run 15:33:38 INFO - Total resource usage - Wall time: 1200s; CPU: 13.0%; Read bytes: 0; Write bytes: 306966528; Read time: 0; Write time: 313852 15:33:38 INFO - TinderboxPrint: CPU usage
13.4% 15:33:38 INFO - TinderboxPrint: I/O read bytes / time
0 / 0 15:33:38 INFO - TinderboxPrint: I/O write bytes / time
306,966,528 / 313,852 15:33:38 INFO - TinderboxPrint: CPU idle
8,296.4 (86.6%) 15:33:38 INFO - TinderboxPrint: CPU user
1,221.3 (12.8%) 15:33:38 INFO - TinderboxPrint: Swap in / out
0 / 0 15:33:38 INFO - install - Wall time: 16s; CPU: 13.0%; Read bytes: 0; Write bytes: 13348864; Read time: 0; Write time: 5896 15:33:38 INFO - run-tests - Wall time: 1184s; CPU: 13.0%; Read bytes: 0; Write bytes: 293617664; Read time: 0; Write time: 307956 15:33:39 INFO - Running post-run listener: _upload_blobber_files 15:33:39 INFO - Blob upload gear active. 15:33:39 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 15:33:39 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 15:33:39 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', 'Firefox-Non-PGO', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 15:33:39 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 Firefox-Non-PGO -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 15:33:39 INFO - (blobuploader) - INFO - Open directory for files ... 15:33:39 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 15:33:39 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 15:33:39 INFO - (blobuploader) - INFO - Uploading, attempt #1. 15:33:40 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 15:33:40 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 15:33:40 INFO - (blobuploader) - INFO - Done attempting. 15:33:40 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 15:33:40 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 15:33:40 INFO - (blobuploader) - INFO - Uploading, attempt #1. 15:33:41 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 15:33:41 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 15:33:41 INFO - (blobuploader) - INFO - Done attempting. 15:33:41 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 15:33:41 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 15:33:41 INFO - (blobuploader) - INFO - Uploading, attempt #1. 15:33:49 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 15:33:49 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 15:33:49 INFO - (blobuploader) - INFO - Done attempting. 15:33:49 INFO - (blobuploader) - INFO - Iteration through files over. 15:33:49 INFO - Return code: 0 15:33:49 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 15:33:49 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 15:33:49 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/7513e95e651e64a2956f1f9508b876aff57b517954edcec468518bdb6e9a9574fa9347afe46f7b2c96088d633f473b5cbf3726a714eb41258eb36abb145b922b", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/07ecda10e89b39b650528a0de19155d0ec1366b82be1a00676134320c728d7f8dfc3fd0e1b5ca72a1312a8d97f81b8681e7a54d2000e9f781b6d8a57e0d15523", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/71bb3fca1381f989f9ee40af5d08b7ca79d0e3dcb75df365ba715499422f2b628a6a3bbd88ffad85c3c5121c59b498b849b9318c73df25a3f128857139e97814"} 15:33:49 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 15:33:49 INFO - Writing to file /builds/slave/test/properties/blobber_files 15:33:49 INFO - Contents: 15:33:49 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/7513e95e651e64a2956f1f9508b876aff57b517954edcec468518bdb6e9a9574fa9347afe46f7b2c96088d633f473b5cbf3726a714eb41258eb36abb145b922b", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/07ecda10e89b39b650528a0de19155d0ec1366b82be1a00676134320c728d7f8dfc3fd0e1b5ca72a1312a8d97f81b8681e7a54d2000e9f781b6d8a57e0d15523", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/71bb3fca1381f989f9ee40af5d08b7ca79d0e3dcb75df365ba715499422f2b628a6a3bbd88ffad85c3c5121c59b498b849b9318c73df25a3f128857139e97814"} 15:33:49 INFO - Running post-run listener: copy_logs_to_upload_dir 15:33:49 INFO - Copying logs to upload dir... 15:33:49 INFO - mkdir: /builds/slave/test/build/upload/logs 15:33:49 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1303.867153 ========= master_lag: 0.00 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 43 secs) (at 2016-08-11 15:33:48.927737) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-08-11 15:33:48.931749) ========= 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=fa44defc139c4ba8574fe040000001db-1470952962.427132-893099056 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/Firefox-Non-PGO/sha512/7513e95e651e64a2956f1f9508b876aff57b517954edcec468518bdb6e9a9574fa9347afe46f7b2c96088d633f473b5cbf3726a714eb41258eb36abb145b922b", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/07ecda10e89b39b650528a0de19155d0ec1366b82be1a00676134320c728d7f8dfc3fd0e1b5ca72a1312a8d97f81b8681e7a54d2000e9f781b6d8a57e0d15523", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/71bb3fca1381f989f9ee40af5d08b7ca79d0e3dcb75df365ba715499422f2b628a6a3bbd88ffad85c3c5121c59b498b849b9318c73df25a3f128857139e97814"} build_url:https://queue.taskcluster.net/v1/task/IpquYUdVSs-rlHetjMt75A/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011216 build_url: 'https://queue.taskcluster.net/v1/task/IpquYUdVSs-rlHetjMt75A/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/7513e95e651e64a2956f1f9508b876aff57b517954edcec468518bdb6e9a9574fa9347afe46f7b2c96088d633f473b5cbf3726a714eb41258eb36abb145b922b", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/07ecda10e89b39b650528a0de19155d0ec1366b82be1a00676134320c728d7f8dfc3fd0e1b5ca72a1312a8d97f81b8681e7a54d2000e9f781b6d8a57e0d15523", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/71bb3fca1381f989f9ee40af5d08b7ca79d0e3dcb75df365ba715499422f2b628a6a3bbd88ffad85c3c5121c59b498b849b9318c73df25a3f128857139e97814"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-08-11 15:33:48.956604) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-08-11 15:33:48.956885) ========= 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=fa44defc139c4ba8574fe040000001db-1470952962.427132-893099056 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004663 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-08-11 15:33:49.039787) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-08-11 15:33:49.040059) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-08-11 15:33:49.040320) ========= ========= Total master_lag: 0.17 =========