builder: mozilla-inbound_ubuntu64_hw_test-dromaeojs-e10s-pgo slave: talos-linux64-ix-010 starttime: 1474370064.08 results: success (0) buildid: 20160920021501 builduid: 65976f0b1ea14cbc8e51c39ee640a855 revision: 4a3775a4a1ab7ec6adef8ca6518bad4ab3f4e4bc ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-09-20 04:14:24.075808) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-09-20 04:14:24.076328) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-09-20 04:14:24.076944) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-09-20 04:14:24.102494) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-09-20 04:14:24.102797) ========= 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=eca2ab57546de7b41f256b19000001ef-1474370063.452274-1001580825 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-09-20 04:14:24-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 29.1M=0s 2016-09-20 04:14:24 (29.1 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.149681 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-09-20 04:14:24.266829) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-09-20 04:14:24.267154) ========= 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=eca2ab57546de7b41f256b19000001ef-1474370063.452274-1001580825 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.019711 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-09-20 04:14:24.319365) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-09-20 04:14:24.319821) ========= bash -c 'python archiver_client.py mozharness --repo integration/mozilla-inbound --rev 4a3775a4a1ab7ec6adef8ca6518bad4ab3f4e4bc --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo integration/mozilla-inbound --rev 4a3775a4a1ab7ec6adef8ca6518bad4ab3f4e4bc --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=eca2ab57546de7b41f256b19000001ef-1474370063.452274-1001580825 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-09-20 04:14:24,554 truncating revision to first 12 chars 2016-09-20 04:14:24,554 Setting DEBUG logging. 2016-09-20 04:14:24,554 attempt 1/10 2016-09-20 04:14:24,554 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/mozilla-inbound/4a3775a4a1ab?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-09-20 04:14:24,852 unpacking tar archive at: mozilla-inbound-4a3775a4a1ab/testing/mozharness/ program finished with exit code 0 elapsedTime=0.637193 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-09-20 04:14:24.971775) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-09-20 04:14:24.972109) ========= script_repo_revision: 4a3775a4a1ab7ec6adef8ca6518bad4ab3f4e4bc ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-09-20 04:14:24.972487) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-09-20 04:14:24.972835) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-09-20 04:14:25.027699) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 30 secs) (at 2016-09-20 04:14:25.028313) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Mozilla-Inbound --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Inbound 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', 'Mozilla-Inbound', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Mozilla-Inbound'] 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=eca2ab57546de7b41f256b19000001ef-1474370063.452274-1001580825 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 04:14:25 INFO - MultiFileLogger online at 20160920 04:14:25 in /builds/slave/test 04:14:25 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Mozilla-Inbound --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Inbound 04:14:25 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 04:14:25 INFO - {'append_to_log': False, 04:14:25 INFO - 'base_work_dir': '/builds/slave/test', 04:14:25 INFO - 'blob_upload_branch': 'Mozilla-Inbound', 04:14:25 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 04:14:25 INFO - 'branch': 'Mozilla-Inbound', 04:14:25 INFO - 'buildbot_json_path': 'buildprops.json', 04:14:25 INFO - 'config_files': ('talos/linux_config.py',), 04:14:25 INFO - 'default_actions': ('clobber', 04:14:25 INFO - 'read-buildbot-config', 04:14:25 INFO - 'download-and-extract', 04:14:25 INFO - 'populate-webroot', 04:14:25 INFO - 'create-virtualenv', 04:14:25 INFO - 'install', 04:14:25 INFO - 'run-tests'), 04:14:25 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 04:14:25 INFO - 'download_minidump_stackwalk': True, 04:14:25 INFO - 'download_symbols': 'ondemand', 04:14:25 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 04:14:25 INFO - 'tooltool.py': '/tools/tooltool.py', 04:14:25 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 04:14:25 INFO - '/tools/misc-python/virtualenv.py')}, 04:14:25 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 04:14:25 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 04:14:25 INFO - 'installer_path': 'installer.exe', 04:14:25 INFO - 'log_level': 'info', 04:14:25 INFO - 'log_name': 'talos', 04:14:25 INFO - 'log_to_console': True, 04:14:25 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 04:14:25 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 04:14:25 INFO - 'opt_config_files': (), 04:14:25 INFO - 'pip_index': False, 04:14:25 INFO - 'sps_profile': False, 04:14:25 INFO - 'sps_profile_interval': 0, 04:14:25 INFO - 'suite': 'dromaeojs-e10s', 04:14:25 INFO - 'system_bits': '32', 04:14:25 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 04:14:25 INFO - 'title': 'talos-linux64-ix-010', 04:14:25 INFO - 'tooltool_cache': '/builds/tooltool_cache', 04:14:25 INFO - 'use_talos_json': True, 04:14:25 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 04:14:25 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 04:14:25 INFO - 'work_dir': 'build'} 04:14:25 INFO - [mozharness: 2016-09-20 11:14:25.350192Z] Running clobber step. 04:14:25 INFO - Running pre-action listener: _resource_record_pre_action 04:14:25 INFO - Running main action method: clobber 04:14:25 INFO - rmtree: /builds/slave/test/build 04:14:25 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 04:14:25 INFO - Running post-action listener: _resource_record_post_action 04:14:25 INFO - [mozharness: 2016-09-20 11:14:25.825823Z] Finished clobber step (success) 04:14:25 INFO - [mozharness: 2016-09-20 11:14:25.825925Z] Running read-buildbot-config step. 04:14:25 INFO - Running pre-action listener: _resource_record_pre_action 04:14:25 INFO - Running main action method: read_buildbot_config 04:14:25 INFO - Using buildbot properties: 04:14:25 INFO - { 04:14:25 INFO - "project": "", 04:14:25 INFO - "product": "firefox", 04:14:25 INFO - "script_repo_revision": "production", 04:14:25 INFO - "builddir": "mozilla-inbound_ubuntu64_hw_test-dromaeojs-e10s", 04:14:25 INFO - "repository": "", 04:14:25 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-inbound pgo talos dromaeojs-e10s", 04:14:25 INFO - "buildid": "20160920021501", 04:14:25 INFO - "pgo_build": "True", 04:14:25 INFO - "basedir": "/builds/slave/test", 04:14:25 INFO - "buildnumber": 1179, 04:14:25 INFO - "slavename": "talos-linux64-ix-010", 04:14:25 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 04:14:25 INFO - "platform": "ubuntu64_hw", 04:14:25 INFO - "scheduler": "tests-mozilla-inbound-linux64-pgo-talos", 04:14:25 INFO - "branch": "mozilla-inbound", 04:14:25 INFO - "repo_path": "integration/mozilla-inbound", 04:14:25 INFO - "revision": "4a3775a4a1ab7ec6adef8ca6518bad4ab3f4e4bc", 04:14:25 INFO - "stage_platform": "linux64-pgo", 04:14:25 INFO - "builduid": "65976f0b1ea14cbc8e51c39ee640a855", 04:14:25 INFO - "slavebuilddir": "test" 04:14:25 INFO - } 04:14:25 INFO - Found installer url https://queue.taskcluster.net/v1/task/BFHohf2iREuMmsBRTLhwJA/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2. 04:14:25 INFO - Running post-action listener: _resource_record_post_action 04:14:25 INFO - [mozharness: 2016-09-20 11:14:25.828401Z] Finished read-buildbot-config step (success) 04:14:25 INFO - [mozharness: 2016-09-20 11:14:25.828490Z] Running download-and-extract step. 04:14:25 INFO - Running pre-action listener: _resource_record_pre_action 04:14:25 INFO - Running main action method: download_and_extract 04:14:25 INFO - mkdir: /builds/slave/test/build/tests 04:14:25 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:14:25 INFO - trying https://queue.taskcluster.net/v1/task/BFHohf2iREuMmsBRTLhwJA/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.test_packages.json 04:14:25 INFO - Downloading https://queue.taskcluster.net/v1/task/BFHohf2iREuMmsBRTLhwJA/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 04:14:25 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/BFHohf2iREuMmsBRTLhwJA/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 04:14:26 INFO - Downloaded 1361 bytes. 04:14:26 INFO - Reading from file /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.test_packages.json 04:14:26 INFO - Using the following test package requirements: 04:14:26 INFO - {u'common': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip'], 04:14:26 INFO - u'cppunittest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 04:14:26 INFO - u'firefox-51.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 04:14:26 INFO - u'gtest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 04:14:26 INFO - u'firefox-51.0a1.en-US.linux-x86_64.gtest.tests.zip'], 04:14:26 INFO - u'jittest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 04:14:26 INFO - u'jsshell-linux-x86_64.zip'], 04:14:26 INFO - u'mochitest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 04:14:26 INFO - u'firefox-51.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 04:14:26 INFO - u'mozbase': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip'], 04:14:26 INFO - u'reftest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 04:14:26 INFO - u'firefox-51.0a1.en-US.linux-x86_64.reftest.tests.zip'], 04:14:26 INFO - u'talos': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 04:14:26 INFO - u'firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip'], 04:14:26 INFO - u'web-platform': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 04:14:26 INFO - u'firefox-51.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 04:14:26 INFO - u'xpcshell': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 04:14:26 INFO - u'firefox-51.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 04:14:26 INFO - Downloading packages: [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 04:14: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')]} 04:14:26 INFO - trying https://queue.taskcluster.net/v1/task/BFHohf2iREuMmsBRTLhwJA/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip 04:14:26 INFO - Downloading https://queue.taskcluster.net/v1/task/BFHohf2iREuMmsBRTLhwJA/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 04:14:26 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/BFHohf2iREuMmsBRTLhwJA/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 04:14:27 INFO - Downloaded 21824042 bytes. 04:14:27 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'] 04:14:27 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 04:14:28 INFO - Return code: 0 04:14:28 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 04:14:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:14:28 INFO - trying https://queue.taskcluster.net/v1/task/BFHohf2iREuMmsBRTLhwJA/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip 04:14:28 INFO - Downloading https://queue.taskcluster.net/v1/task/BFHohf2iREuMmsBRTLhwJA/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 04:14:28 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/BFHohf2iREuMmsBRTLhwJA/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 04:14:29 INFO - Downloaded 21824042 bytes. 04:14:29 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'] 04:14:29 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 04:14:30 INFO - Return code: 0 04:14: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')]} 04:14:30 INFO - trying https://queue.taskcluster.net/v1/task/BFHohf2iREuMmsBRTLhwJA/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip 04:14:30 INFO - Downloading https://queue.taskcluster.net/v1/task/BFHohf2iREuMmsBRTLhwJA/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 04:14:30 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/BFHohf2iREuMmsBRTLhwJA/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 04:14:31 INFO - Downloaded 14413723 bytes. 04:14:31 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'] 04:14:31 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 04:14:32 INFO - Return code: 0 04:14:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:14:32 INFO - trying https://queue.taskcluster.net/v1/task/BFHohf2iREuMmsBRTLhwJA/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 04:14:32 INFO - Downloading https://queue.taskcluster.net/v1/task/BFHohf2iREuMmsBRTLhwJA/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 04:14:32 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/BFHohf2iREuMmsBRTLhwJA/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 04:14:33 INFO - Downloaded 59375090 bytes. 04:14:33 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/BFHohf2iREuMmsBRTLhwJA/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 04:14:33 INFO - mkdir: /builds/slave/test/properties 04:14:33 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 04:14:33 INFO - Writing to file /builds/slave/test/properties/build_url 04:14:33 INFO - Contents: 04:14:33 INFO - build_url:https://queue.taskcluster.net/v1/task/BFHohf2iREuMmsBRTLhwJA/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 04:14:33 INFO - Running post-action listener: _resource_record_post_action 04:14:33 INFO - Running post-action listener: set_extra_try_arguments 04:14:33 INFO - [mozharness: 2016-09-20 11:14:33.913563Z] Finished download-and-extract step (success) 04:14:33 INFO - [mozharness: 2016-09-20 11:14:33.913795Z] Running populate-webroot step. 04:14:33 INFO - Running pre-action listener: _resource_record_pre_action 04:14:33 INFO - Running main action method: populate_webroot 04:14:33 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 04:14:33 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 04:14:33 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 04:14:33 INFO - '--tppagecycles', 04:14:33 INFO - '7'], 04:14:33 INFO - 'tests': ['tsvgm']}}, 04:14:33 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 04:14:33 INFO - 'tests': ['tresize', 'tcanvasmark']}, 04:14:33 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 04:14:33 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 04:14:33 INFO - 'tests': ['dromaeo_css', 'kraken']}, 04:14:33 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 04:14:33 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:14:33 INFO - 'talos_options': ['--disable-e10s'], 04:14:33 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 04:14:33 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:14:33 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 04:14:33 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:14:33 INFO - 'talos_options': ['--disable-e10s'], 04:14:33 INFO - 'tests': ['damp', 'tps']}, 04:14:33 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:14:33 INFO - 'tests': ['damp', 'tps']}, 04:14:33 INFO - 'g3': {'talos_options': ['--disable-e10s'], 04:14:33 INFO - 'tests': ['dromaeo_dom']}, 04:14:33 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 04:14:33 INFO - 'g4': {'talos_options': ['--disable-e10s'], 04:14:33 INFO - 'tests': ['basic_compositor_video']}, 04:14:33 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 04:14:33 INFO - 'other': {'talos_options': ['--disable-e10s'], 04:14:33 INFO - 'tests': ['a11yr', 04:14:33 INFO - 'ts_paint', 04:14:33 INFO - 'tpaint', 04:14:33 INFO - 'sessionrestore', 04:14:33 INFO - 'sessionrestore_no_auto_restore', 04:14:33 INFO - 'tabpaint']}, 04:14:33 INFO - 'other-e10s': {'tests': ['a11yr', 04:14:33 INFO - 'ts_paint', 04:14:33 INFO - 'tpaint', 04:14:33 INFO - 'sessionrestore', 04:14:33 INFO - 'sessionrestore_no_auto_restore', 04:14:33 INFO - 'tabpaint']}, 04:14:33 INFO - 'other-e10s_l64': {'tests': ['a11yr', 04:14:33 INFO - 'ts_paint', 04:14:33 INFO - 'tpaint', 04:14:33 INFO - 'sessionrestore', 04:14:33 INFO - 'sessionrestore_no_auto_restore', 04:14:33 INFO - 'tabpaint']}, 04:14:33 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 04:14:33 INFO - 'ts_paint', 04:14:33 INFO - 'tpaint', 04:14:33 INFO - 'sessionrestore', 04:14:33 INFO - 'sessionrestore_no_auto_restore', 04:14:33 INFO - 'tabpaint']}, 04:14:33 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 04:14:33 INFO - 'tests': ['a11yr', 04:14:33 INFO - 'ts_paint', 04:14:33 INFO - 'tpaint', 04:14:33 INFO - 'sessionrestore', 04:14:33 INFO - 'sessionrestore_no_auto_restore', 04:14:33 INFO - 'tabpaint']}, 04:14:33 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 04:14:33 INFO - 'tests': ['a11yr', 04:14:33 INFO - 'ts_paint', 04:14:33 INFO - 'tpaint', 04:14:33 INFO - 'sessionrestore', 04:14:33 INFO - 'sessionrestore_no_auto_restore', 04:14:33 INFO - 'tabpaint']}, 04:14:33 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 04:14:33 INFO - 'tests': ['tsvgx', 04:14:33 INFO - 'tsvgr_opacity', 04:14:33 INFO - 'tart', 04:14:33 INFO - 'tscrollx', 04:14:33 INFO - 'cart']}, 04:14:33 INFO - 'svgr-e10s': {'tests': ['tsvgx', 04:14:33 INFO - 'tsvgr_opacity', 04:14:33 INFO - 'tart', 04:14:33 INFO - 'tscrollx', 04:14:33 INFO - 'cart']}, 04:14:33 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:14:33 INFO - 'talos_options': ['--disable-e10s'], 04:14:33 INFO - 'tests': ['tp5o']}, 04:14:33 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:14:33 INFO - 'tests': ['tp5o']}, 04:14:33 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:14:33 INFO - 'talos_options': ['--disable-e10s', 04:14:33 INFO - '--xperf_path', 04:14:33 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 04:14:33 INFO - 'tests': ['tp5n']}, 04:14:33 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:14:33 INFO - 'talos_options': ['--xperf_path', 04:14:33 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 04:14:33 INFO - 'tests': ['tp5n']}}, 04:14:33 INFO - 'talos.zip': {'path': '', 04:14:33 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 04:14:33 INFO - Running post-action listener: _resource_record_post_action 04:14:33 INFO - [mozharness: 2016-09-20 11:14:33.929395Z] Finished populate-webroot step (success) 04:14:33 INFO - [mozharness: 2016-09-20 11:14:33.929485Z] Running create-virtualenv step. 04:14:33 INFO - Running pre-action listener: _resource_record_pre_action 04:14:33 INFO - Running main action method: create_virtualenv 04:14:33 INFO - Creating virtualenv /builds/slave/test/build/venv 04:14:33 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 04:14:33 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 04:14:34 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 04:14:34 INFO - Using real prefix '/usr' 04:14:34 INFO - New python executable in /builds/slave/test/build/venv/bin/python 04:14:34 INFO - Installing distribute.............................................................................................................................................................................................done. 04:14:36 INFO - Installing pip.................done. 04:14:36 INFO - Return code: 0 04:14:36 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 04:14:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:14:36 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:14:36 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:14:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:14:36 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:14:36 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:14:36 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x20f7030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x225a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2326400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23b5570>, '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 0x23b6470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x23b6900>, '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': 'eca2ab57546de7b41f256b19000001ef-1474370063.452274-1001580825', '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 04:14:36 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 04:14:36 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 04:14:36 INFO - Using env: {'DISPLAY': ':0', 04:14:36 INFO - 'HOME': '/home/cltbld', 04:14:36 INFO - 'LANG': 'en_US.UTF-8', 04:14:36 INFO - 'LANGUAGE': 'en_US:en', 04:14:36 INFO - 'LOGNAME': 'cltbld', 04:14:36 INFO - 'MAIL': '/var/mail/cltbld', 04:14:36 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:14:36 INFO - 'MOZ_NO_REMOTE': '1', 04:14:36 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:14:36 INFO - 'NO_EM_RESTART': '1', 04:14:36 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:14:36 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:14:36 INFO - 'PWD': '/builds/slave/test', 04:14:36 INFO - 'SHELL': '/bin/bash', 04:14:36 INFO - 'SHLVL': '1', 04:14:36 INFO - 'TERM': 'linux', 04:14:36 INFO - 'TMOUT': '86400', 04:14:36 INFO - 'USER': 'cltbld', 04:14:36 INFO - 'XDG_SESSION_COOKIE': 'eca2ab57546de7b41f256b19000001ef-1474370063.452274-1001580825', 04:14:36 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:14:36 INFO - '_': '/tools/buildbot/bin/python'} 04:14:36 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:14:36 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 04:14:36 INFO - Cleaning up... 04:14:36 INFO - Return code: 0 04:14:36 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 04:14:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:14:36 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:14:36 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:14:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:14:36 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:14:36 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:14:36 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x20f7030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x225a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2326400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23b5570>, '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 0x23b6470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x23b6900>, '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': 'eca2ab57546de7b41f256b19000001ef-1474370063.452274-1001580825', '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 04:14:36 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 04:14:36 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 04:14:36 INFO - Using env: {'DISPLAY': ':0', 04:14:36 INFO - 'HOME': '/home/cltbld', 04:14:36 INFO - 'LANG': 'en_US.UTF-8', 04:14:36 INFO - 'LANGUAGE': 'en_US:en', 04:14:36 INFO - 'LOGNAME': 'cltbld', 04:14:36 INFO - 'MAIL': '/var/mail/cltbld', 04:14:36 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:14:36 INFO - 'MOZ_NO_REMOTE': '1', 04:14:36 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:14:36 INFO - 'NO_EM_RESTART': '1', 04:14:36 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:14:36 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:14:36 INFO - 'PWD': '/builds/slave/test', 04:14:36 INFO - 'SHELL': '/bin/bash', 04:14:36 INFO - 'SHLVL': '1', 04:14:36 INFO - 'TERM': 'linux', 04:14:36 INFO - 'TMOUT': '86400', 04:14:36 INFO - 'USER': 'cltbld', 04:14:36 INFO - 'XDG_SESSION_COOKIE': 'eca2ab57546de7b41f256b19000001ef-1474370063.452274-1001580825', 04:14:36 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:14:36 INFO - '_': '/tools/buildbot/bin/python'} 04:14:36 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:14:36 INFO - Downloading/unpacking psutil>=3.1.1 04:14:36 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:14:36 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:14:36 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:14:36 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:14:36 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:14:36 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:14:38 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 04:14:38 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 04:14:38 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 04:14:38 INFO - Installing collected packages: psutil 04:14:38 INFO - Running setup.py install for psutil 04:14:39 INFO - building 'psutil._psutil_linux' extension 04:14:39 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 04:14:39 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 04:14:39 INFO - building 'psutil._psutil_posix' extension 04:14:39 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 04:14:39 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 04:14:39 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 04:14:39 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 04:14:39 INFO - Successfully installed psutil 04:14:39 INFO - Cleaning up... 04:14:39 INFO - Return code: 0 04:14:39 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 04:14:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:14:39 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:14:39 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:14:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:14:39 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:14:39 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:14:39 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x20f7030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x225a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2326400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23b5570>, '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 0x23b6470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x23b6900>, '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': 'eca2ab57546de7b41f256b19000001ef-1474370063.452274-1001580825', '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 04:14:39 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 04:14:39 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 04:14:39 INFO - Using env: {'DISPLAY': ':0', 04:14:39 INFO - 'HOME': '/home/cltbld', 04:14:39 INFO - 'LANG': 'en_US.UTF-8', 04:14:39 INFO - 'LANGUAGE': 'en_US:en', 04:14:39 INFO - 'LOGNAME': 'cltbld', 04:14:39 INFO - 'MAIL': '/var/mail/cltbld', 04:14:39 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:14:39 INFO - 'MOZ_NO_REMOTE': '1', 04:14:39 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:14:39 INFO - 'NO_EM_RESTART': '1', 04:14:39 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:14:39 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:14:39 INFO - 'PWD': '/builds/slave/test', 04:14:39 INFO - 'SHELL': '/bin/bash', 04:14:39 INFO - 'SHLVL': '1', 04:14:39 INFO - 'TERM': 'linux', 04:14:39 INFO - 'TMOUT': '86400', 04:14:39 INFO - 'USER': 'cltbld', 04:14:39 INFO - 'XDG_SESSION_COOKIE': 'eca2ab57546de7b41f256b19000001ef-1474370063.452274-1001580825', 04:14:39 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:14:39 INFO - '_': '/tools/buildbot/bin/python'} 04:14:39 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:14:39 INFO - Downloading/unpacking mozsystemmonitor==0.3 04:14:39 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:14:39 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:14:39 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:14:39 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:14:39 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:14:39 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:14:41 INFO - Downloading mozsystemmonitor-0.3.tar.gz 04:14:41 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 04:14:41 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 04:14:41 INFO - Installing collected packages: mozsystemmonitor 04:14:41 INFO - Running setup.py install for mozsystemmonitor 04:14:41 INFO - Successfully installed mozsystemmonitor 04:14:41 INFO - Cleaning up... 04:14:41 INFO - Return code: 0 04:14:41 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 04:14:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:14:41 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:14:41 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:14:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:14:41 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:14:41 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:14:41 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x20f7030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x225a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2326400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23b5570>, '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 0x23b6470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x23b6900>, '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': 'eca2ab57546de7b41f256b19000001ef-1474370063.452274-1001580825', '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 04:14:41 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 04:14:41 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 04:14:41 INFO - Using env: {'DISPLAY': ':0', 04:14:41 INFO - 'HOME': '/home/cltbld', 04:14:41 INFO - 'LANG': 'en_US.UTF-8', 04:14:41 INFO - 'LANGUAGE': 'en_US:en', 04:14:41 INFO - 'LOGNAME': 'cltbld', 04:14:41 INFO - 'MAIL': '/var/mail/cltbld', 04:14:41 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:14:41 INFO - 'MOZ_NO_REMOTE': '1', 04:14:41 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:14:41 INFO - 'NO_EM_RESTART': '1', 04:14:41 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:14:41 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:14:41 INFO - 'PWD': '/builds/slave/test', 04:14:41 INFO - 'SHELL': '/bin/bash', 04:14:41 INFO - 'SHLVL': '1', 04:14:41 INFO - 'TERM': 'linux', 04:14:41 INFO - 'TMOUT': '86400', 04:14:41 INFO - 'USER': 'cltbld', 04:14:41 INFO - 'XDG_SESSION_COOKIE': 'eca2ab57546de7b41f256b19000001ef-1474370063.452274-1001580825', 04:14:41 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:14:41 INFO - '_': '/tools/buildbot/bin/python'} 04:14:42 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:14:42 INFO - Downloading/unpacking jsonschema==2.5.1 04:14:42 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:14:42 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:14:42 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:14:42 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:14:42 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:14:42 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:14:43 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 04:14:43 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 04:14:43 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:14:43 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:14:43 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:14:43 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:14:43 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:14:43 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:14:44 INFO - Downloading functools32-3.2.3-2.tar.gz 04:14:44 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 04:14:44 INFO - warning: no files found matching '*.txt' 04:14:44 INFO - no previously-included directories found matching 'build' 04:14:44 INFO - no previously-included directories found matching 'dist' 04:14:44 INFO - no previously-included directories found matching '.git*' 04:14:44 INFO - Installing collected packages: jsonschema, functools32 04:14:44 INFO - Running setup.py install for functools32 04:14:44 INFO - warning: no files found matching '*.txt' 04:14:44 INFO - no previously-included directories found matching 'build' 04:14:44 INFO - no previously-included directories found matching 'dist' 04:14:44 INFO - no previously-included directories found matching '.git*' 04:14:44 INFO - Successfully installed jsonschema functools32 04:14:44 INFO - Cleaning up... 04:14:44 INFO - Return code: 0 04:14:44 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 04:14:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:14:44 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:14:44 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:14:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:14:44 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:14:44 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:14:44 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x20f7030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x225a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2326400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23b5570>, '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 0x23b6470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x23b6900>, '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': 'eca2ab57546de7b41f256b19000001ef-1474370063.452274-1001580825', '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 04:14:44 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2'] in /builds/slave/test/build 04:14:44 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 04:14:44 INFO - Using env: {'DISPLAY': ':0', 04:14:44 INFO - 'HOME': '/home/cltbld', 04:14:44 INFO - 'LANG': 'en_US.UTF-8', 04:14:44 INFO - 'LANGUAGE': 'en_US:en', 04:14:44 INFO - 'LOGNAME': 'cltbld', 04:14:44 INFO - 'MAIL': '/var/mail/cltbld', 04:14:44 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:14:44 INFO - 'MOZ_NO_REMOTE': '1', 04:14:44 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:14:44 INFO - 'NO_EM_RESTART': '1', 04:14:44 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:14:44 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:14:44 INFO - 'PWD': '/builds/slave/test', 04:14:44 INFO - 'SHELL': '/bin/bash', 04:14:44 INFO - 'SHLVL': '1', 04:14:44 INFO - 'TERM': 'linux', 04:14:44 INFO - 'TMOUT': '86400', 04:14:44 INFO - 'USER': 'cltbld', 04:14:44 INFO - 'XDG_SESSION_COOKIE': 'eca2ab57546de7b41f256b19000001ef-1474370063.452274-1001580825', 04:14:44 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:14:44 INFO - '_': '/tools/buildbot/bin/python'} 04:14:44 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:14:44 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 04:14:44 INFO - Cleaning up... 04:14:44 INFO - Return code: 0 04:14:44 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 04:14:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:14:44 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:14:44 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:14:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:14:44 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:14:44 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:14:44 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x20f7030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x225a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2326400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23b5570>, '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 0x23b6470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x23b6900>, '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': 'eca2ab57546de7b41f256b19000001ef-1474370063.452274-1001580825', '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 04:14:44 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 04:14:44 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 04:14:44 INFO - Using env: {'DISPLAY': ':0', 04:14:44 INFO - 'HOME': '/home/cltbld', 04:14:44 INFO - 'LANG': 'en_US.UTF-8', 04:14:44 INFO - 'LANGUAGE': 'en_US:en', 04:14:44 INFO - 'LOGNAME': 'cltbld', 04:14:44 INFO - 'MAIL': '/var/mail/cltbld', 04:14:44 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:14:44 INFO - 'MOZ_NO_REMOTE': '1', 04:14:44 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:14:44 INFO - 'NO_EM_RESTART': '1', 04:14:44 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:14:44 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:14:44 INFO - 'PWD': '/builds/slave/test', 04:14:44 INFO - 'SHELL': '/bin/bash', 04:14:44 INFO - 'SHLVL': '1', 04:14:44 INFO - 'TERM': 'linux', 04:14:44 INFO - 'TMOUT': '86400', 04:14:44 INFO - 'USER': 'cltbld', 04:14:44 INFO - 'XDG_SESSION_COOKIE': 'eca2ab57546de7b41f256b19000001ef-1474370063.452274-1001580825', 04:14:44 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:14:44 INFO - '_': '/tools/buildbot/bin/python'} 04:14:44 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:14:44 INFO - Downloading/unpacking blobuploader==1.2.4 04:14:44 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:14:44 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:14:44 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:14:44 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:14:44 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:14:44 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:14:46 INFO - Downloading blobuploader-1.2.4.tar.gz 04:14:46 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 04:14:46 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 04:14:46 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:14:46 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:14:46 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:14:46 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:14:46 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:14:46 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:14:47 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 04:14:47 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 04:14:47 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:14:47 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:14:47 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:14:47 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:14:47 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:14:47 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:14:47 INFO - Downloading docopt-0.6.1.tar.gz 04:14:47 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 04:14:47 INFO - Installing collected packages: blobuploader, requests, docopt 04:14:47 INFO - Running setup.py install for blobuploader 04:14:47 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 04:14:47 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 04:14:47 INFO - Running setup.py install for requests 04:14:47 INFO - Running setup.py install for docopt 04:14:48 INFO - Successfully installed blobuploader requests docopt 04:14:48 INFO - Cleaning up... 04:14:48 INFO - Return code: 0 04:14:48 INFO - Installing None into virtualenv /builds/slave/test/build/venv 04:14:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:14:48 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:14:48 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:14:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:14:48 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:14:48 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:14:48 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 0x20f7030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x225a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2326400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23b5570>, '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 0x23b6470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x23b6900>, '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': 'eca2ab57546de7b41f256b19000001ef-1474370063.452274-1001580825', '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 04:14:48 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 04:14:48 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 04:14:48 INFO - Using env: {'DISPLAY': ':0', 04:14:48 INFO - 'HOME': '/home/cltbld', 04:14:48 INFO - 'LANG': 'en_US.UTF-8', 04:14:48 INFO - 'LANGUAGE': 'en_US:en', 04:14:48 INFO - 'LOGNAME': 'cltbld', 04:14:48 INFO - 'MAIL': '/var/mail/cltbld', 04:14:48 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:14:48 INFO - 'MOZ_NO_REMOTE': '1', 04:14:48 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:14:48 INFO - 'NO_EM_RESTART': '1', 04:14:48 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:14:48 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:14:48 INFO - 'PWD': '/builds/slave/test', 04:14:48 INFO - 'SHELL': '/bin/bash', 04:14:48 INFO - 'SHLVL': '1', 04:14:48 INFO - 'TERM': 'linux', 04:14:48 INFO - 'TMOUT': '86400', 04:14:48 INFO - 'USER': 'cltbld', 04:14:48 INFO - 'XDG_SESSION_COOKIE': 'eca2ab57546de7b41f256b19000001ef-1474370063.452274-1001580825', 04:14:48 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:14:48 INFO - '_': '/tools/buildbot/bin/python'} 04:14:48 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:14:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 04:14:48 INFO - Running setup.py (path:/tmp/pip-q6kNWq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 04:14:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 04:14:48 INFO - Running setup.py (path:/tmp/pip-PAvAV6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 04:14:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 04:14:48 INFO - Running setup.py (path:/tmp/pip-OMk9ef-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 04:14:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 04:14:48 INFO - Running setup.py (path:/tmp/pip-msSxhw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 04:14:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 04:14:48 INFO - Running setup.py (path:/tmp/pip-dixLuE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 04:14:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 04:14:48 INFO - Running setup.py (path:/tmp/pip-LVh4Ka-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 04:14:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 04:14:48 INFO - Running setup.py (path:/tmp/pip-ARdFHz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 04:14:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 04:14:48 INFO - Running setup.py (path:/tmp/pip-htCAPa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 04:14:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 04:14:48 INFO - Running setup.py (path:/tmp/pip-v_zGJy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 04:14:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 04:14:48 INFO - Running setup.py (path:/tmp/pip-JFmdCe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 04:14:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 04:14:49 INFO - Running setup.py (path:/tmp/pip-tH6zTj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 04:14:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 04:14:49 INFO - Running setup.py (path:/tmp/pip-viZ2xo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 04:14:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 04:14:49 INFO - Running setup.py (path:/tmp/pip-nBBXkl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 04:14:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 04:14:49 INFO - Running setup.py (path:/tmp/pip-7TDhYm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 04:14:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 04:14:49 INFO - Running setup.py (path:/tmp/pip-dhQkfA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 04:14:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 04:14:49 INFO - Running setup.py (path:/tmp/pip-Bloo86-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 04:14:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 04:14:49 INFO - Running setup.py (path:/tmp/pip-ChEj5v-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 04:14:49 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 04:14:49 INFO - Running setup.py install for manifestparser 04:14:49 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 04:14:49 INFO - Running setup.py install for mozcrash 04:14:49 INFO - Running setup.py install for mozdebug 04:14:49 INFO - Running setup.py install for mozdevice 04:14:49 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 04:14:49 INFO - Installing dm script to /builds/slave/test/build/venv/bin 04:14:49 INFO - Running setup.py install for mozfile 04:14:50 INFO - Running setup.py install for mozhttpd 04:14:50 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 04:14:50 INFO - Running setup.py install for mozinfo 04:14:50 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 04:14:50 INFO - Running setup.py install for mozInstall 04:14:50 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 04:14:50 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 04:14:50 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 04:14:50 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 04:14:50 INFO - Running setup.py install for mozleak 04:14:50 INFO - Running setup.py install for mozlog 04:14:50 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 04:14:50 INFO - Running setup.py install for moznetwork 04:14:50 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 04:14:50 INFO - Running setup.py install for mozprocess 04:14:50 INFO - Running setup.py install for mozprofile 04:14:50 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 04:14:50 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 04:14:50 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 04:14:50 INFO - Running setup.py install for mozrunner 04:14:50 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 04:14:50 INFO - Running setup.py install for mozscreenshot 04:14:51 INFO - Running setup.py install for moztest 04:14:51 INFO - Running setup.py install for mozversion 04:14:51 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 04:14:51 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 04:14:51 INFO - Cleaning up... 04:14:51 INFO - Return code: 0 04:14:51 INFO - Installing None into virtualenv /builds/slave/test/build/venv 04:14:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:14:51 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:14:51 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:14:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:14:51 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:14:51 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:14:51 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 0x20f7030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x225a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2326400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23b5570>, '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 0x23b6470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x23b6900>, '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': 'eca2ab57546de7b41f256b19000001ef-1474370063.452274-1001580825', '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 04:14:51 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 04:14:51 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 04:14:51 INFO - Using env: {'DISPLAY': ':0', 04:14:51 INFO - 'HOME': '/home/cltbld', 04:14:51 INFO - 'LANG': 'en_US.UTF-8', 04:14:51 INFO - 'LANGUAGE': 'en_US:en', 04:14:51 INFO - 'LOGNAME': 'cltbld', 04:14:51 INFO - 'MAIL': '/var/mail/cltbld', 04:14:51 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:14:51 INFO - 'MOZ_NO_REMOTE': '1', 04:14:51 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:14:51 INFO - 'NO_EM_RESTART': '1', 04:14:51 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:14:51 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:14:51 INFO - 'PWD': '/builds/slave/test', 04:14:51 INFO - 'SHELL': '/bin/bash', 04:14:51 INFO - 'SHLVL': '1', 04:14:51 INFO - 'TERM': 'linux', 04:14:51 INFO - 'TMOUT': '86400', 04:14:51 INFO - 'USER': 'cltbld', 04:14:51 INFO - 'XDG_SESSION_COOKIE': 'eca2ab57546de7b41f256b19000001ef-1474370063.452274-1001580825', 04:14:51 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:14:51 INFO - '_': '/tools/buildbot/bin/python'} 04:14:51 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:14:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 04:14:51 INFO - Running setup.py (path:/tmp/pip-bVvXvc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 04:14:51 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)) 04:14:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 04:14:51 INFO - Running setup.py (path:/tmp/pip-O9fsqo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 04:14:51 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)) 04:14:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 04:14:51 INFO - Running setup.py (path:/tmp/pip-4LGPQ1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 04:14:51 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)) 04:14:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 04:14:51 INFO - Running setup.py (path:/tmp/pip-Yt5BUE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 04:14:51 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)) 04:14:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 04:14:51 INFO - Running setup.py (path:/tmp/pip-fH_9Qx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 04:14:51 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)) 04:14:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 04:14:51 INFO - Running setup.py (path:/tmp/pip-Kgedve-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 04:14:51 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)) 04:14:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 04:14:51 INFO - Running setup.py (path:/tmp/pip-vNNUkn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 04:14:52 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)) 04:14:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 04:14:52 INFO - Running setup.py (path:/tmp/pip-WLo9iw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 04:14:52 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)) 04:14:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 04:14:52 INFO - Running setup.py (path:/tmp/pip-Wrhcw5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 04:14:52 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)) 04:14:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 04:14:52 INFO - Running setup.py (path:/tmp/pip-mPgqpK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 04:14:52 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)) 04:14:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 04:14:52 INFO - Running setup.py (path:/tmp/pip-TftRgT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 04:14:52 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)) 04:14:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 04:14:52 INFO - Running setup.py (path:/tmp/pip-VTQy_m-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 04:14:52 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)) 04:14:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 04:14:52 INFO - Running setup.py (path:/tmp/pip-y_Jn9p-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 04:14:52 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)) 04:14:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 04:14:52 INFO - Running setup.py (path:/tmp/pip-GFBBTO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 04:14:52 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)) 04:14:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 04:14:52 INFO - Running setup.py (path:/tmp/pip-Hu6r0S-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 04:14:52 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)) 04:14:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 04:14:52 INFO - Running setup.py (path:/tmp/pip-_b2N27-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 04:14:52 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)) 04:14:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 04:14:52 INFO - Running setup.py (path:/tmp/pip-AEHUsH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 04:14:52 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)) 04:14:52 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)) 04:14:52 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)) 04:14:52 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)) 04:14:52 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)) 04:14:52 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)) 04:14:52 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.3->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 04:14:52 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 04:14:52 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 04:14:52 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 04:14:52 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 04:14:52 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 04:14:52 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 04:14:54 INFO - Downloading blessings-1.6.tar.gz 04:14:54 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 04:14:54 INFO - Installing collected packages: blessings 04:14:54 INFO - Running setup.py install for blessings 04:14:54 INFO - Successfully installed blessings 04:14:54 INFO - Cleaning up... 04:14:54 INFO - Return code: 0 04:14:54 INFO - Done creating virtualenv /builds/slave/test/build/venv. 04:14:54 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 04:14:54 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 04:14:55 INFO - Reading from file tmpfile_stdout 04:14:55 INFO - Current package versions: 04:14:55 INFO - argparse == 1.2.1 04:14:55 INFO - blessings == 1.6 04:14:55 INFO - blobuploader == 1.2.4 04:14:55 INFO - docopt == 0.6.1 04:14:55 INFO - functools32 == 3.2.3-2 04:14:55 INFO - jsonschema == 2.5.1 04:14:55 INFO - manifestparser == 1.1 04:14:55 INFO - mozInstall == 1.12 04:14:55 INFO - mozcrash == 0.17 04:14:55 INFO - mozdebug == 0.1 04:14:55 INFO - mozdevice == 0.48 04:14:55 INFO - mozfile == 1.2 04:14:55 INFO - mozhttpd == 0.7 04:14:55 INFO - mozinfo == 0.9 04:14:55 INFO - mozleak == 0.1 04:14:55 INFO - mozlog == 3.3 04:14:55 INFO - moznetwork == 0.27 04:14:55 INFO - mozprocess == 0.23 04:14:55 INFO - mozprofile == 0.28 04:14:55 INFO - mozrunner == 6.12 04:14:55 INFO - mozscreenshot == 0.1 04:14:55 INFO - mozsystemmonitor == 0.3 04:14:55 INFO - moztest == 0.7 04:14:55 INFO - mozversion == 1.4 04:14:55 INFO - psutil == 3.1.1 04:14:55 INFO - requests == 1.2.3 04:14:55 INFO - wsgiref == 0.1.2 04:14:55 INFO - Installing None into virtualenv /builds/slave/test/build/venv 04:14:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:14:55 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:14:55 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:14:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:14:55 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:14:55 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:14:55 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 0x20f7030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x225a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2326400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23b5570>, '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 0x23b6470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x23b6900>, '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': 'eca2ab57546de7b41f256b19000001ef-1474370063.452274-1001580825', '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 04:14:55 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 04:14:55 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 04:14:55 INFO - Using env: {'DISPLAY': ':0', 04:14:55 INFO - 'HOME': '/home/cltbld', 04:14:55 INFO - 'LANG': 'en_US.UTF-8', 04:14:55 INFO - 'LANGUAGE': 'en_US:en', 04:14:55 INFO - 'LOGNAME': 'cltbld', 04:14:55 INFO - 'MAIL': '/var/mail/cltbld', 04:14:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:14:55 INFO - 'MOZ_NO_REMOTE': '1', 04:14:55 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:14:55 INFO - 'NO_EM_RESTART': '1', 04:14:55 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:14:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:14:55 INFO - 'PWD': '/builds/slave/test', 04:14:55 INFO - 'SHELL': '/bin/bash', 04:14:55 INFO - 'SHLVL': '1', 04:14:55 INFO - 'TERM': 'linux', 04:14:55 INFO - 'TMOUT': '86400', 04:14:55 INFO - 'USER': 'cltbld', 04:14:55 INFO - 'XDG_SESSION_COOKIE': 'eca2ab57546de7b41f256b19000001ef-1474370063.452274-1001580825', 04:14:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:14:55 INFO - '_': '/tools/buildbot/bin/python'} 04:14:55 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:14:55 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)) 04:14:55 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)) 04:14:55 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)) 04:14:55 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)) 04:14:55 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)) 04:14:55 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)) 04:14:55 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)) 04:14:55 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)) 04:14:55 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)) 04:14:55 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)) 04:14:55 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)) 04:14:55 INFO - Cleaning up... 04:14:55 INFO - Return code: 0 04:14:55 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 04:14:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:14:55 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:14:55 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:14:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:14:55 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:14:55 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:14:55 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 0x20f7030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x225a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2326400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23b5570>, '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 0x23b6470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x23b6900>, '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': 'eca2ab57546de7b41f256b19000001ef-1474370063.452274-1001580825', '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 04:14:55 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 04:14:55 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 04:14:55 INFO - Using env: {'DISPLAY': ':0', 04:14:55 INFO - 'HOME': '/home/cltbld', 04:14:55 INFO - 'LANG': 'en_US.UTF-8', 04:14:55 INFO - 'LANGUAGE': 'en_US:en', 04:14:55 INFO - 'LOGNAME': 'cltbld', 04:14:55 INFO - 'MAIL': '/var/mail/cltbld', 04:14:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:14:55 INFO - 'MOZ_NO_REMOTE': '1', 04:14:55 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:14:55 INFO - 'NO_EM_RESTART': '1', 04:14:55 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:14:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:14:55 INFO - 'PWD': '/builds/slave/test', 04:14:55 INFO - 'SHELL': '/bin/bash', 04:14:55 INFO - 'SHLVL': '1', 04:14:55 INFO - 'TERM': 'linux', 04:14:55 INFO - 'TMOUT': '86400', 04:14:55 INFO - 'USER': 'cltbld', 04:14:55 INFO - 'XDG_SESSION_COOKIE': 'eca2ab57546de7b41f256b19000001ef-1474370063.452274-1001580825', 04:14:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:14:55 INFO - '_': '/tools/buildbot/bin/python'} 04:14:55 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:14:55 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 04:14:55 INFO - Cleaning up... 04:14:55 INFO - Return code: 0 04:14:55 INFO - Running post-action listener: _resource_record_post_action 04:14:55 INFO - Running post-action listener: _start_resource_monitoring 04:14:55 INFO - Starting resource monitoring. 04:14:55 INFO - [mozharness: 2016-09-20 11:14:55.584805Z] Finished create-virtualenv step (success) 04:14:55 INFO - [mozharness: 2016-09-20 11:14:55.585306Z] Running install step. 04:14:55 INFO - Running pre-action listener: _resource_record_pre_action 04:14:55 INFO - Running main action method: install 04:14:55 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 04:14:55 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 04:14:55 INFO - Reading from file tmpfile_stdout 04:14:55 INFO - Detecting whether we're running mozinstall >=1.0... 04:14:55 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 04:14:55 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 04:14:55 INFO - Reading from file tmpfile_stdout 04:14:55 INFO - Output received: 04:14:55 INFO - Usage: mozinstall [options] installer 04:14:55 INFO - Options: 04:14:55 INFO - -h, --help show this help message and exit 04:14:55 INFO - -d DEST, --destination=DEST 04:14:55 INFO - Directory to install application into. [default: 04:14:55 INFO - "/builds/slave/test"] 04:14:55 INFO - --app=APP Application being installed. [default: firefox] 04:14:55 INFO - mkdir: /builds/slave/test/build/application 04:14:55 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'] 04:14:55 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 04:15:12 INFO - Reading from file tmpfile_stdout 04:15:12 INFO - Output received: 04:15:12 INFO - /builds/slave/test/build/application/firefox/firefox 04:15:12 INFO - Running post-action listener: _resource_record_post_action 04:15:12 INFO - [mozharness: 2016-09-20 11:15:12.771065Z] Finished install step (success) 04:15:12 INFO - [mozharness: 2016-09-20 11:15:12.771402Z] Running run-tests step. 04:15:12 INFO - Running pre-action listener: _resource_record_pre_action 04:15:12 INFO - Running main action method: run_tests 04:15:12 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 04:15:12 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 04:15:12 INFO - Python 2.7.3 04:15:12 INFO - Return code: 0 04:15:12 INFO - grabbing minidump binary from tooltool 04:15: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')]} 04:15:12 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 0x23b5570>, '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 0x23b6470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x23b6900>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 04:15:12 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 04:15:12 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 04:15:12 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 04:15:12 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 04:15:12 INFO - Return code: 0 04:15:12 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 04:15:12 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 04:15:12 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 04:15:12 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 04:15:12 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 04:15:12 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Inbound', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/BFHohf2iREuMmsBRTLhwJA/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-010', '--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 04:15:12 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Mozilla-Inbound --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/BFHohf2iREuMmsBRTLhwJA/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-010 --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 04:15:12 INFO - Using env: {'DISPLAY': ':0', 04:15:12 INFO - 'HOME': '/home/cltbld', 04:15:12 INFO - 'LANG': 'en_US.UTF-8', 04:15:12 INFO - 'LANGUAGE': 'en_US:en', 04:15:12 INFO - 'LOGNAME': 'cltbld', 04:15:12 INFO - 'MAIL': '/var/mail/cltbld', 04:15:12 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 04:15:12 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 04:15:12 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:15:12 INFO - 'MOZ_NO_REMOTE': '1', 04:15:12 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 04:15:12 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:15:12 INFO - 'NO_EM_RESTART': '1', 04:15:12 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:15:12 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:15:12 INFO - 'PWD': '/builds/slave/test', 04:15:12 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 04:15:12 INFO - 'SHELL': '/bin/bash', 04:15:12 INFO - 'SHLVL': '1', 04:15:12 INFO - 'TERM': 'linux', 04:15:12 INFO - 'TMOUT': '86400', 04:15:12 INFO - 'USER': 'cltbld', 04:15:12 INFO - 'XDG_SESSION_COOKIE': 'eca2ab57546de7b41f256b19000001ef-1474370063.452274-1001580825', 04:15:12 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:15:12 INFO - '_': '/tools/buildbot/bin/python'} 04:15:12 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Inbound', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/BFHohf2iREuMmsBRTLhwJA/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-010', '--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 04:15:13 INFO - mozversion application_buildid: 20160920021501 04:15:13 INFO - mozversion application_changeset: 4a3775a4a1ab7ec6adef8ca6518bad4ab3f4e4bc 04:15:13 INFO - mozversion application_display_name: Nightly 04:15:13 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 04:15:13 INFO - mozversion application_name: Firefox 04:15:13 INFO - mozversion application_remotingname: firefox 04:15:13 INFO - mozversion application_repository: https://hg.mozilla.org/integration/mozilla-inbound 04:15:13 INFO - mozversion application_vendor: Mozilla 04:15:13 INFO - mozversion application_version: 51.0a1 04:15:13 INFO - mozversion platform_buildid: 20160920021501 04:15:13 INFO - mozversion platform_changeset: 4a3775a4a1ab7ec6adef8ca6518bad4ab3f4e4bc 04:15:13 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/mozilla-inbound 04:15:13 INFO - mozversion platform_version: 51.0a1 04:15:13 INFO - using testdate: 1474370113 04:15:13 INFO - actual date: 1474370113 04:15:13 INFO - starting webserver on 'localhost:42870' 04:15:13 INFO - SUITE-START | Running 2 tests 04:15:13 INFO - TEST-START | dromaeo_css 04:15:13 INFO - operating with platform_type : linux_ 04:15:13 INFO - Initialising browser for dromaeo_css test... 04:15:13 INFO - TEST-INFO | started process 23714 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpMuHjV7/profile http://localhost:42870/getInfo.html) 04:15:17 INFO - PROCESS | 23714 | __metrics Screen width/height:1600/1200 04:15:17 INFO - PROCESS | 23714 | colorDepth:24 04:15:17 INFO - PROCESS | 23714 | Browser inner width/height: 1024/697 04:15:17 INFO - PROCESS | 23714 | __metrics 04:15:18 ERROR - PROCESS | 23714 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2968: TypeError: this.tabs is undefined 04:15:19 INFO - TEST-INFO | 23714: exit 0 04:15:19 INFO - Browser initialized. 04:15:19 INFO - Running cycle 1/1 for dromaeo_css test... 04:15:19 INFO - TEST-INFO | started process 23834 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpMuHjV7/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 04:15:31 INFO - PROCESS | 23834 | RSS: Main: 163504128 04:15:31 INFO - PROCESS | 23834 | 04:16:20 INFO - PROCESS | 23834 | 1474370180843 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] 04:18:30 INFO - PROCESS | 23834 | Cycle 1(1): loaded http://localhost:42870/tests/dromaeo/cssquery-dojo.html (next: http://localhost:42870/tests/dromaeo/cssquery-ext.html) 04:18:31 INFO - PROCESS | 23834 | RSS: Main: 167215104 04:18:31 INFO - PROCESS | 23834 | 04:21:33 INFO - PROCESS | 23834 | Cycle 1(1): loaded http://localhost:42870/tests/dromaeo/cssquery-ext.html (next: http://localhost:42870/tests/dromaeo/cssquery-jquery.html) 04:21:34 INFO - PROCESS | 23834 | RSS: Main: 165879808 04:21:34 INFO - PROCESS | 23834 | 04:24:36 INFO - PROCESS | 23834 | Cycle 1(1): loaded http://localhost:42870/tests/dromaeo/cssquery-jquery.html (next: http://localhost:42870/tests/dromaeo/cssquery-mootools.html) 04:24:36 INFO - PROCESS | 23834 | RSS: Main: 170196992 04:24:36 INFO - PROCESS | 23834 | 04:27:38 INFO - PROCESS | 23834 | Cycle 1(1): loaded http://localhost:42870/tests/dromaeo/cssquery-mootools.html (next: http://localhost:42870/tests/dromaeo/cssquery-prototype.html) 04:27:39 INFO - PROCESS | 23834 | RSS: Main: 164921344 04:27:39 INFO - PROCESS | 23834 | 04:30:41 INFO - PROCESS | 23834 | Cycle 1(1): loaded http://localhost:42870/tests/dromaeo/cssquery-prototype.html (next: http://localhost:42870/tests/dromaeo/cssquery-yui.html) 04:30:42 INFO - PROCESS | 23834 | RSS: Main: 167018496 04:30:42 INFO - PROCESS | 23834 | 04:33:45 INFO - PROCESS | 23834 | Cycle 1(1): loaded http://localhost:42870/tests/dromaeo/cssquery-yui.html (next: http://localhost:42870/tests/dromaeo/cssquery-dojo.html) 04:33:45 INFO - PROCESS | 23834 | RSS: Main: 170516480 04:33:45 INFO - PROCESS | 23834 | 04:33:45 INFO - PROCESS | 23834 | __start_tp_report 04:33:45 INFO - PROCESS | 23834 | _x_x_mozilla_page_load 04:33:45 INFO - PROCESS | 23834 | _x_x_mozilla_page_load_details 04:33:45 INFO - PROCESS | 23834 | |i|pagename|runs| 04:33:45 INFO - PROCESS | 23834 | |0;dojo.html;3090.2892334763005;3104.1308433638587;3133.0287610840633;3134.1381120191945;3141.7643676724238;5241.5806735461165;5320.494553017462;5405.351357837065;5416.756245968931;5461.9453805462035;5400.78396864125;5410.783568657249;5471;5511.3937466878615;5512.145617429305;4883.389576302962;4981.053599816023;5001.074801161797;5030.320906677606;5136.768845401966;5082.059818933509;5090.261912022755;5095.159298715707;5146.253793199984;5169.663971841837;4751.572358487718;4907.8773030674165;5026.47222041684;5081.669691470042;5092.261622064817;4936.432310284327;5002.24966255061;5019.573336266421;5050.570701490377;5063;4938.654294199408;4969.7515124244;4974.4776798436005;4993.226049962262;5018.924716129261;5270.710110943896;5348.598855085884;5435.130379139358;5455.372632147314;5472.616916815825;5751.827445176651;5841.153032810261;5841.240638716939;5863.237779088734;5894.204282421861;5863.179154918314;5871.236739223874;5873.1190321451695;5874.97062514689;5877.089051197071;5256.342957130359;5373.11343628297;5421.024215641183;5441.347038355383;5452.372977107644;5820.592558520862;5965.433283838029;5973.79091731796;5999.850003749942;6018.097285407224;5751.971240143856;5763.596548241667;5765.596408251466;5770.394108618619;5773.134029895549;5599.7480113394995;5690.658560486384;5833.941660583425;5849.151872978395;5851.297844258716;5778.595498315161;5780.393058728857;5824.504917082011;5846.444587764156;5860.150278209636;5821.09772985188;5824.242848429762;5828.6502809831545;5832.766689332379;5841.299044114733;4364.8472303469225;4446.666500012512;4485.439320084989;4503.3245013247615;4536.478304994902;3960.584138665456;3997.340438827619;4031.07285324377;4048.3117869962175;4069.2268468990796;5581.944180558224;5596.076647353222;5599.496045355938;5607.52336051432;5608;5690.061139911951;5838.7080645967535;5905.173275741399;5927.288725352985;5946.762129514857;5551.333839939233;5601.607887447921;5615.606907516516;5632.605717599728;5658.688772117491;5061.670991385548;5070.518300761496;5073.695578265242;5084.211947148198;5131.589472842164;5868.471837534642;5920.79277225295;6133.417325354084;6139.324674285825;6155.045967874987;5721.456461636138;5761.02062649359;5788.623739456922;5801.506871915765;5809.8547536311935;6007.038873780174;6007.519398448201;6008.399160083956;6012.3085845126625;6024.096385542204;5587.217789509553;5650.237217975685;5693.28833895763;5695.401982791913;5711.257536520226;5841.415858414294;5842.766289348378;5886;5892.970535147297;5949.1076338549565;5748.080307150836;5765.8558536036935;5766.538676905921;5769.394213607511;5791.420857914343;5452.6183167177915;5560.082586373365;5605.383407825218;5731.111677689964;5774.39368866263;5618.157276408571;5619.297587801525;5621.353544342453;5651.237082993744;5658.915116273177;5663.433656634304;5663.858403539944;5678.6876721779045;5733.111367738007;5740.6268592541355;5362.758675859518;5544.556435485071;5554.472325129106;5569.637973531708;5600.187972744011 04:33:45 INFO - PROCESS | 23834 | |1;ext.html;547.674801153407;594.8631814682624;595.2589026661807;606.5996442348048;618.7710547097574;39734;44475.77762111189;44574.10851782963;44604.33093503592;44708.55291447085;44911.550884491146;45182.09635807282;45373.09253814922;45400.86497837555;45510.77244613781;8618.095100014487;8766.079561646031;8782.736517904441;8807.559622018905;8810.515421651806;8855.468671879675;8900.73297801067;8906.287497000258;8927.910720892805;8978.775530611721;8872.955635221848;8908.643654253821;8940.687075952343;8948.686795962143;8962.686305979292;8938.106189381075;8983.056779038172;8989.775255618597;9007.234385077276;9010.053944335848;8601.698940537051;8610.913890861073;8646.351523635689;8649.178328058824;8657.134286571356;41818.37272440916;41904.1619167618;42159.578404216176;42306.365404518954;42494.57505424937;3004.6544647365395;3336.432806422914;3438.329525742481;3618.421052631593;3945.1320709443876;32258.354832903446;32631;32871.17822054444;32879.34241315184;33419.83290083559;4084.673226141931;4135.731177473484;4190.392393103013;4211;4346.521882592912;323176;324017;324809.9999999976;325549;326534;36137.81931090328;36205.91382258484;36443;36462.63537364645;36560;36785.632143678224;37070.44394334087;37272.509099636256;37282.44076338857;37292.38953273245;14506.637334066521;14656.780148297785;14665.780013299809;14672.486462973744;15259.847401525843;12201.938990305169;12215.450304736309;12339.444724987397;12373.93813030947;12383.19509231897;19285.710714339297;19384.321548745727;19386.4184074478;19420;19472.123754431086;7065.964670176616;7096.112985876765;7169.605671688108;7208.27917208275;7528.247175282428;955.5031383680587;1119.5186069989982;1153.1697178031804;1155.289496959364;1171.0631494804122;32274.193145171088;32800.50799238013;33005.834970824995;33154;33349.83325083359;1102.685734565645;1117.944102794857;1126.0934947367284;1160.8200728887036;1194.3371428857067;16852.157392130346;17348.566285842702;17443.476695699148;17455.301787928594;17487.125643718016;573725;574219;575462;576623;577379;60049.699751500964;60438.69780651069;60447.69776151091;60509.39490605125;60642.393576064555;1326.5953884065452;1330.9068365214341;1346.562367230654;1377.5522955039653;1384.2801743093535;30394.696053040072;32669.836650816593;32968;33196.50205246972;33501.32997340088;51023.48976510188;52139.47860521346;52247;52392.47607523876;52402;435108;440536;441488;441735;443783;29255;29311.85344073266;29459.558106628847;29624.85187574048;29685.554716678835;49007.26489102595;49069.75465122652;49755.75122124366;49893.25160122528;50528.74735626298;41847.37228941629;42246.57753422549;42544.36183457312;44161.55838441703;44390.11219775651;42039.78980105202;42247;42448;43017.3547396783;43971.34042989294;41240;42934.78532607317;43054.78472607617;43409.565904340554;45620.77189614163;33338.66661333355;38415.6158438412;38744;38905.6109438902;39140.804295978334;28910.277243069093;29211.561826572193;29403.85298073496;29464.410711786073;29589 04:33:45 INFO - PROCESS | 23834 | |2;jquery.html;380.5072431201594;389.31869228849513;398.5735263268303;401.1275475840048;420.8358740091365;18181.272749090036;19482.707759383622;20035;20069.498262543406;20175;18753.437396878115;18862.339818106368;19059.523511912208;19170.90414547929;19192.61614767704;5662.773489060443;5741.799037033705;5763.827085187451;5790.420957904218;5806.216160818278;5619.690916999563;5748.568857335696;5775.711214439282;5777.480026797587;5777.480026797587;5364.356277246736;5568.1647752837;5652;5755.136729490568;5769.451902069297;5623.437656234385;5647.661140331552;5671.744771485272;5679.119736440858;5697.230873832021;5614.6631202128;5731.484166425;5751.626144300607;5755.194272801811;5768.817392434583;22462.663060054114;23269.534609307888;23642.054317827267;23719.644205336936;23875;2411.746766589518;2480.131953816168;2504.536660717773;2611.6213149093273;2967.109867039879;10152.39085654863;10350.171986241083;10379.688609341732;13191.604251872459;14103.858961410357;1868.4207895552422;1911.7897031326543;1983.4049785064424;2017.798220177985;2052.3842847145797;89303.32090037374;89526.5523672384;91059;91974.54012729961;92549.76075837313;9146.359754817233;9859.802803943881;9946.259404604165;9958.352707074017;10125.493725313852;13343.799843002364;13492.325383730775;13493.730125397633;13505.2572108533;13550.661233469045;7032.92967070333;7034.824129396806;7084.36240738336;7234.66158760631;7463.552186868806;6284;6486.772962946368;6511.186101737283;6731.225909020427;7290.744823931137;4006.579309172553;4138.089620283533;4140.855070072533;4234.470691163605;4295.8496452624;1921.6156768646326;1931.5943651833272;2030.8273796727444;2047.2220556188554;2077.376786963935;902.4134312696799;910.6767097680361;928.5264515097214;972.3873959405529;999.0159692702682;18900.905495472434;19126.80873191278;19898.60202795965;20285.290014849703;21613.567728645652;911.7538264668502;962.6341990043738;975.331897650112;1000.3747657713928;1019.5259204469809;10997.285176463503;11247.268927519848;11251.43742812856;11298.265612735146;11332.150088743378;482949;485229;488709;491878;492155;64904;71037;82964.58517707374;88553.55723221472;101101.49449252854;1002.5288114586133;1017.3133135133755;1045.717656232813;1051.5688567687212;1056.4612047855649;16958.236879340213;17231.82768172302;17827.910860446133;18136.546586335448;18423.907880460512;36109.916702498966;40866;44747.77626111849;44874.775626121664;45206.54793452023;61331.693341533006;63347;63692.68153659202;64341.678291608245;64957;8456.112108228794;8579.957100214458;8600.483970961763;8622.870656940026;8873.423227490193;13032.934835325763;13463.596092117252;13627.931860340635;13740.10689305232;13850.792238116235;11601.76796464049;11713;11808.350540720343;11835.822462662894;12227.69430764238;11465.082793376676;11513.884861151617;11546.94226528862;11599.188056835941;11723.706907327385;11706.297622142698;11763.235389699643;11894.881051189377;11896.643100706646;12346.814797778221;8509.574521274035;8602.440841345293;8640.04959454472;8855.91144088551;8858.810220324176;10402.947985260025;11594;11854.229475084092;11935.701607459883;12322.445489952794 04:33:45 INFO - PROCESS | 23834 | |3;mootools.html;1478.0688166455136;1494.2080697230467;1634.8119966203883;1781.8930864148151;1804.9729254061199;8071.192880711926;8426;8664.350173736979;9155.908440915597;9162.312826538004;8572.01421836489;8924.107589241088;8948.418352807079;9008.954955225216;9076.727698169048;2351.976480235197;2383.4875501767115;2393.74865639108;2398.5202959408102;2407.3018824540864;2359.9410014749683;2380.6905102336673;2442.096424323003;2453.0678342229926;2462.66753988212;2382.9642555361597;2400.3639035655565;2409.0965887792077;2445.6698345723366;2449.9877500612474;2345.5895218336723;2383.5352106339355;2383.8212134090013;2384.523095380922;2390;2355.422921384272;2357.905683772647;2361.9645705314433;2362.362162216192;2384.3443053160345;9053.59258833354;9085;9094.681686140953;9125.5437228139;9182.678606248815;5210.895782084337;5283.788648454057;5349.59878009147;5360.705161216131;5361.463853614608;3422.195783990785;3433.9656603433896;3513.1217195701074;3524.8061356625376;3530.6292839251764;1124.7975364434399;1146.8165093584987;1154.7979103656826;1159.2059439284117;1171.4142928535732;12474.376281185996;12543.56097536591;12571.308578028205;12589.055820813475;12591.181573197713;4343.739375637472;4612.74629895359;4621.930671039937;4738.47876733559;4787.904241915142;10596.894031059745;10649.307794993301;10654.57381704723;10661.680149595524;10670.41312727792;5287.127623942007;5311.362636483569;5315.813946511854;5316.282301889196;5316.415194328621;4335.783210839445;4686.226772582554;4792.95207047925;4801.51984801524;4893.045856058035;3800.847966081381;3962.5046869141356;4013.4983127109113;4029.6776257899296;4031.3751368537924;1250.6373151786063;1259.2885019963692;1262.8042653388738;1263.7788387032233;1266.7973124300252;844.7845799321134;881.0528681667233;882.4043770454917;935.7847695030181;999.5452069308448;5880.7353669085;6018.879622407615;6058.515318774487;6291.6854157291955;6326.513269381691;462.65301024231826;473.5004570178495;473.583246742871;474.9881252968634;1025.251566356549;4081.428599996003;4378.401883312632;4393.121375724804;4401.823927042947;4423.20382331177;10561.471926403803;10767;10845.295055821347;10859.239853210358;10890.455477226107;10688.946555267174;10731.087857532197;10791.730206744736;10799.946000269949;10852.186086043579;7892.960535197287;8108.472949258279;8153.34773218153;8264.504129752235;8528.445651032664;6193.752249909953;6212.502999759918;6216.129741836237;6320.209973753281;6337.2395312562785;10091.949540252252;10329.690109296733;10348.068673819393;10451.111655509367;10511.842322365017;9959.701208963743;10171.23715721309;10206.744831379276;10258.333208341433;10316.381017138996;7167.139943206848;7656.578888161204;7784.143744188248;7978.521288722695;8089.393295502743;8700.869486957574;8746.256568191775;8789.38474306818;8796.60415281301;8879.91120088791;7724.729634462767;7829.491083079582;7909.288164065261;7963.960180199062;8153.143919888326;7753.65108570127;7797.220277972157;7851.56816375082;7862.72480463181;7895.68417263303;7031.859362812613;7124.750633727795;7154.606496642735;7156.928430715834;7164.426845852424;5046.21783623539;5099.69401835891;5247;5249.921251181312;5489.423610520837;5332.280142180756;5355.598330125178;5486.149646804752;5507.146392309199;5531.612787104864 04:33:45 INFO - PROCESS | 23834 | |4;prototype.html;326.36684831427044;332.8918101616974;334.5099429336023;340.2769115629288;341.96896357482194;5334.986352593005;5372.892542149155;5526.972365138174;5589.379080066781;5590.83227503175;5407.053460754126;5478.534324582405;5486.91769623456;5500.954818584466;5530.834074977747;4320.265554855682;4347.13057388522;4348.456442944632;4356.6514678825615;4357.847475338372;4130.277201489727;4275.786210689469;4318.52496225415;4333.2416827055295;4349.891252718676;4241.597048280424;4245.596668316521;4247;4257.893552661193;4261.403403523509;4235.25882970479;4258.425112609804;4261.744295342274;4263.701540892139;4289.978550107229;3698.4267438547067;3760.3231418344685;3762.097096696773;3765.585785563586;3792.3363411402893;5351.304330437058;5352.277442545284;5362.544183744387;5363.463653634644;5389.353277606712;4863;4870.805167793284;4871.902561948741;4889.804407823683;4890.315355850148;5508.14623733322;5691.373948865621;5726.942730572682;5734.397888221718;5753.482186603184;4084.550699423061;4093.5087789465156;4107.67138628909;4121.175764847013;4133.6693064554765;5894.233749612523;5898;5924.7333869975955;5945.821625351246;5950.196723442323;4163.2298024864895;4263.722858014219;4263.978680106579;4294.0767734937135;4295.613394794484;4332.220200363965;4332.371806088099;4339.7830108494445;4347.934780978288;4380.846670366522;4953.752312384367;4965.708915681948;4971.552560269593;4995.425526064477;4996.275540046673;5682.698507104629;5843.94156058434;5878.617889837147;5880.500157486576;5910.822675319747;1414.2221778022047;1460.393936516355;1460.532629558531;1465.1062851660479;1470.2869108482378;878.499255424402;898.8696638987441;900.6532484993194;902.7607683963755;919.2140719684706;4867.41808912105;4870.683405578626;4872.4883887192045;4899.897523057283;4901.2893130496595;5142.477402978971;5142.768575414116;5192.506711862443;5199;5225.268462415265;4893.143699852582;4944.90110197794;4960.50394960501;4971.37857767779;5191.897281600957;3082.799618024821;3113.9532907006414;3117.9376412471624;3158.3367492826765;3166.6200055993427;6166.876662466815;6186.907196392058;6217.564770466114;6246.500279977591;6252.937470625327;5897;5961.940380596226;5966.85082872923;6026.367231440636;6051.4553690168095;6113.786017489367;6150.907736383958;6200.81397558074;6212.285587157445;6216.564840461215;5812.651240925558;5857.949717598806;5905.379935106752;5968.552358573212;6001.219841420588;5848.707564621837;5880.353161152356;5885.47030767233;5886.58793884424;5901.822945311647;6028.186194863637;6100.6949652516305;6152.384761523812;6172.969135154295;6223.844403889939;4084.4485994390375;4168.39558264044;4188.246115699203;4200.516940551875;4202.810873510638;5715.542756579381;5890.676012819336;5976.641401515923;5997.100434934795;6012.7294271757;5635.591102224444;5715.314162300384;5733.3406658234835;5767.452092051249;5789.247397838254;5723.6851973141875;5731.083026715705;5753.532849123447;5785.595008349375;5788.247527821356;5608.158776183605;5699.886002279848;5726.828195154152;5745.856353591026;5784.50831679312;5740.68426236561;5803.47768700819;5810.448007439287;5812.680302583399;5850.063989761617;5485.588580856372;5692.459216374604;5693.060644993529;5712.200291959046;5740.68426236561 04:33:45 INFO - PROCESS | 23834 | |5;yui.html;703.8486725354051;713.4791602130445;714.2821464428249;756.7616200896717;782.5304817109735;15198.468053618126;16249.268782904768;16395.344186232567;16413.097279649613;16416.83583164168;14877.032992855457;15350.846491535081;15362.539123826304;15379.461718839842;15492.845071549309;805.1706742055692;812.1310198088019;812.8496228197773;813.1868131868132;818.071488860145;799.077065988781;806.2582424169749;806.5604245686116;823.4976664234842;829.0424559633602;866.2290561400358;870.1385628228072;872.5549969515561;873.9344549158807;877.026500584354;864.1833467373335;865.195368307477;869.1569177897429;870.682200996638;870.7561882672861;632.667849379075;632.7057918068075;633.3223450907531;635.5614625908108;637.0762394527953;15103.848961510354;15167.62080947974;15177;15190.468333608382;15194.088354698642;14999.475018374305;15285.847141528553;15338.923305383514;15352.155631440266;15384;12590.307533085677;12855.614331570068;12916.612501624966;13044.217346959213;13115.409806558728;3773.8490460381554;3820.6561409473;3893.552241492236;3900.083480382108;3954.367301231789;87791;88611.55694221487;88969;89367;89402;11791.941040294916;11813.645590632295;12245.510179592717;12426.75146497065;12546.1844980076;21344.679829802564;21680.566388672138;21797;21879.234226801986;21891.343259702233;8344.62449189788;8407.285380742705;8429.40994130405;8816.162464565856;8970.68602598919;4603.217453032992;4658.487566367697;4665.9766701166955;4763.3807605011125;4820.421549414093;3609.3322735294055;3761.8307176177136;3763.002804256819;3767.8869633911027;3777.981110094487;627.1658693937053;632.9588576742497;640.4236187431349;655.7967030220647;661.1009027722293;579.6232448908244;675.7938828657209;687.6355531568277;696.435886931587;699.909011828459;9177.816443671089;9575.808483830284;10065.194784417228;10178;10263.897361026444;580.4862696513616;649.9317571655002;673.9427148692416;678.9796306110825;686.4268335939546;4583.152116858325;5037.823676171316;5049.899002019939;5068.82259120929;5080.59355251579;68915.31084689089;76815.23184768081;113890.43054784673;128700.3564982169;132319.33840330737;111933.70936559595;112510.43744781223;113323;114284.42857785658;115736;60689.78620427567;67545;92997;98058;100102.4994875021;9108.271338293052;9328.454927920584;9342.579583918876;9529.999350068143;9541.093596108358;56237;56293.43706563046;56458;56710.432895672166;59710.70144649249;80710;83446.58276708577;84321.57839210765;84839;87319.56340218258;12308.507659693512;12401.689957750768;12447.813282800946;12688.921441677561;13030.087893847718;13245;13259.071864969359;13322.533711320057;13712.382942767399;14393.92803035978;12812.807807883075;12891.48434062627;13206.537771177962;13233;13280.468781248643;13014.739705205653;13251;13319.66700832487;13376.130551514121;13774.242416666779;12822.23066616006;13010.674733131747;13127.803082953955;13247.138935969131;13691.589252322447;9510.63289753293;9612.951935240559;10385.584576616851;10485.68542943713;10487.951418371082;10550.366977981346;10732.678019659423;10991.945040274748;11002.284851484628;11026.944865275622 04:33:45 INFO - PROCESS | 23834 | __end_tp_report 04:33:45 INFO - PROCESS | 23834 | __start_cc_report 04:33:45 INFO - PROCESS | 23834 | _x_x_mozilla_cycle_collect,347 04:33:45 INFO - PROCESS | 23834 | __end_cc_report 04:33:45 INFO - PROCESS | 23834 | __startTimestamp1474371225625__endTimestamp 04:33:45 INFO - PROCESS | 23834 | 04:33:45 INFO - PROCESS | 23834 | ------- Summary: start ------- 04:33:45 INFO - PROCESS | 23834 | Number of tests: 6 04:33:45 INFO - PROCESS | 23834 | 04:33:45 INFO - PROCESS | 23834 | [#0] dojo.html Cycles:165 Average:5422.55 Median:5615.61 stddev:608.54 (10.8%) stddev-sans-first:582.25 04:33:45 INFO - PROCESS | 23834 | Values: 3090.3 3104.1 3133.0 3134.1 3141.8 5241.6 5320.5 5405.4 5416.8 5461.9 5400.8 5410.8 5471.0 5511.4 5512.1 4883.4 4981.1 5001.1 5030.3 5136.8 5082.1 5090.3 5095.2 5146.3 5169.7 4751.6 4907.9 5026.5 5081.7 5092.3 4936.4 5002.2 5019.6 5050.6 5063.0 4938.7 4969.8 4974.5 4993.2 5018.9 5270.7 5348.6 5435.1 5455.4 5472.6 5751.8 5841.2 5841.2 5863.2 5894.2 5863.2 5871.2 5873.1 5875.0 5877.1 5256.3 5373.1 5421.0 5441.3 5452.4 5820.6 5965.4 5973.8 5999.9 6018.1 5752.0 5763.6 5765.6 5770.4 5773.1 5599.7 5690.7 5833.9 5849.2 5851.3 5778.6 5780.4 5824.5 5846.4 5860.2 5821.1 5824.2 5828.7 5832.8 5841.3 4364.8 4446.7 4485.4 4503.3 4536.5 3960.6 3997.3 4031.1 4048.3 4069.2 5581.9 5596.1 5599.5 5607.5 5608.0 5690.1 5838.7 5905.2 5927.3 5946.8 5551.3 5601.6 5615.6 5632.6 5658.7 5061.7 5070.5 5073.7 5084.2 5131.6 5868.5 5920.8 6133.4 6139.3 6155.0 5721.5 5761.0 5788.6 5801.5 5809.9 6007.0 6007.5 6008.4 6012.3 6024.1 5587.2 5650.2 5693.3 5695.4 5711.3 5841.4 5842.8 5886.0 5893.0 5949.1 5748.1 5765.9 5766.5 5769.4 5791.4 5452.6 5560.1 5605.4 5731.1 5774.4 5618.2 5619.3 5621.4 5651.2 5658.9 5663.4 5663.9 5678.7 5733.1 5740.6 5362.8 5544.6 5554.5 5569.6 5600.2 04:33:45 INFO - PROCESS | 23834 | 04:33:45 INFO - PROCESS | 23834 | [#1] ext.html Cycles:180 Average:59953.49 Median:23047.28 stddev:121911.49 (529.0%) stddev-sans-first:122171.89 04:33:45 INFO - PROCESS | 23834 | Values: 547.7 594.9 595.3 606.6 618.8 39734.0 44475.8 44574.1 44604.3 44708.6 44911.6 45182.1 45373.1 45400.9 45510.8 8618.1 8766.1 8782.7 8807.6 8810.5 8855.5 8900.7 8906.3 8927.9 8978.8 8873.0 8908.6 8940.7 8948.7 8962.7 8938.1 8983.1 8989.8 9007.2 9010.1 8601.7 8610.9 8646.4 8649.2 8657.1 41818.4 41904.2 42159.6 42306.4 42494.6 3004.7 3336.4 3438.3 3618.4 3945.1 32258.4 32631.0 32871.2 32879.3 33419.8 4084.7 4135.7 4190.4 4211.0 4346.5 323176.0 324017.0 324810.0 325549.0 326534.0 36137.8 36205.9 36443.0 36462.6 36560.0 36785.6 37070.4 37272.5 37282.4 37292.4 14506.6 14656.8 14665.8 14672.5 15259.8 12201.9 12215.5 12339.4 12373.9 12383.2 19285.7 19384.3 19386.4 19420.0 19472.1 7066.0 7096.1 7169.6 7208.3 7528.2 955.5 1119.5 1153.2 1155.3 1171.1 32274.2 32800.5 33005.8 33154.0 33349.8 1102.7 1117.9 1126.1 1160.8 1194.3 16852.2 17348.6 17443.5 17455.3 17487.1 573725.0 574219.0 575462.0 576623.0 577379.0 60049.7 60438.7 60447.7 60509.4 60642.4 1326.6 1330.9 1346.6 1377.6 1384.3 30394.7 32669.8 32968.0 33196.5 33501.3 51023.5 52139.5 52247.0 52392.5 52402.0 435108.0 440536.0 441488.0 441735.0 443783.0 29255.0 29311.9 29459.6 29624.9 29685.6 49007.3 49069.8 49755.8 49893.3 50528.7 41847.4 42246.6 42544.4 44161.6 44390.1 42039.8 42247.0 42448.0 43017.4 43971.3 41240.0 42934.8 43054.8 43409.6 45620.8 33338.7 38415.6 38744.0 38905.6 39140.8 28910.3 29211.6 29403.9 29464.4 29589.0 04:33:45 INFO - PROCESS | 23834 | 04:33:45 INFO - PROCESS | 23834 | [#2] jquery.html Cycles:180 Average:29075.37 Median:384.91 stddev:80601.45 (20940.2%) stddev-sans-first:80798.76 04:33:45 INFO - PROCESS | 23834 | Values: 380.5 389.3 398.6 401.1 420.8 18181.3 19482.7 20035.0 20069.5 20175.0 18753.4 18862.3 19059.5 19170.9 19192.6 5662.8 5741.8 5763.8 5790.4 5806.2 5619.7 5748.6 5775.7 5777.5 5777.5 5364.4 5568.2 5652.0 5755.1 5769.5 5623.4 5647.7 5671.7 5679.1 5697.2 5614.7 5731.5 5751.6 5755.2 5768.8 22462.7 23269.5 23642.1 23719.6 23875.0 2411.7 2480.1 2504.5 2611.6 2967.1 10152.4 10350.2 10379.7 13191.6 14103.9 1868.4 1911.8 1983.4 2017.8 2052.4 89303.3 89526.6 91059.0 91974.5 92549.8 9146.4 9859.8 9946.3 9958.4 10125.5 13343.8 13492.3 13493.7 13505.3 13550.7 7032.9 7034.8 7084.4 7234.7 7463.6 6284.0 6486.8 6511.2 6731.2 7290.7 4006.6 4138.1 4140.9 4234.5 4295.8 1921.6 1931.6 2030.8 2047.2 2077.4 902.4 910.7 928.5 972.4 999.0 18900.9 19126.8 19898.6 20285.3 21613.6 911.8 962.6 975.3 1000.4 1019.5 10997.3 11247.3 11251.4 11298.3 11332.2 482949.0 485229.0 488709.0 491878.0 492155.0 64904.0 71037.0 82964.6 88553.6 101101.5 1002.5 1017.3 1045.7 1051.6 1056.5 16958.2 17231.8 17827.9 18136.5 18423.9 36109.9 40866.0 44747.8 44874.8 45206.5 61331.7 63347.0 63692.7 64341.7 64957.0 8456.1 8580.0 8600.5 8622.9 8873.4 13032.9 13463.6 13627.9 13740.1 13850.8 11601.8 11713.0 11808.4 11835.8 12227.7 11465.1 11513.9 11546.9 11599.2 11723.7 11706.3 11763.2 11894.9 11896.6 12346.8 8509.6 8602.4 8640.0 8855.9 8858.8 10402.9 11594.0 11854.2 11935.7 12322.4 04:33:45 INFO - PROCESS | 23834 | 04:33:45 INFO - PROCESS | 23834 | [#3] mootools.html Cycles:180 Average:5885.03 Median:2579.86 stddev:3342.96 (129.6%) stddev-sans-first:3335.93 04:33:45 INFO - PROCESS | 23834 | Values: 1478.1 1494.2 1634.8 1781.9 1805.0 8071.2 8426.0 8664.4 9155.9 9162.3 8572.0 8924.1 8948.4 9009.0 9076.7 2352.0 2383.5 2393.7 2398.5 2407.3 2359.9 2380.7 2442.1 2453.1 2462.7 2383.0 2400.4 2409.1 2445.7 2450.0 2345.6 2383.5 2383.8 2384.5 2390.0 2355.4 2357.9 2362.0 2362.4 2384.3 9053.6 9085.0 9094.7 9125.5 9182.7 5210.9 5283.8 5349.6 5360.7 5361.5 3422.2 3434.0 3513.1 3524.8 3530.6 1124.8 1146.8 1154.8 1159.2 1171.4 12474.4 12543.6 12571.3 12589.1 12591.2 4343.7 4612.7 4621.9 4738.5 4787.9 10596.9 10649.3 10654.6 10661.7 10670.4 5287.1 5311.4 5315.8 5316.3 5316.4 4335.8 4686.2 4793.0 4801.5 4893.0 3800.8 3962.5 4013.5 4029.7 4031.4 1250.6 1259.3 1262.8 1263.8 1266.8 844.8 881.1 882.4 935.8 999.5 5880.7 6018.9 6058.5 6291.7 6326.5 462.7 473.5 473.6 475.0 1025.3 4081.4 4378.4 4393.1 4401.8 4423.2 10561.5 10767.0 10845.3 10859.2 10890.5 10688.9 10731.1 10791.7 10799.9 10852.2 7893.0 8108.5 8153.3 8264.5 8528.4 6193.8 6212.5 6216.1 6320.2 6337.2 10091.9 10329.7 10348.1 10451.1 10511.8 9959.7 10171.2 10206.7 10258.3 10316.4 7167.1 7656.6 7784.1 7978.5 8089.4 8700.9 8746.3 8789.4 8796.6 8879.9 7724.7 7829.5 7909.3 7964.0 8153.1 7753.7 7797.2 7851.6 7862.7 7895.7 7031.9 7124.8 7154.6 7156.9 7164.4 5046.2 5099.7 5247.0 5249.9 5489.4 5332.3 5355.6 5486.1 5507.1 5531.6 04:33:45 INFO - PROCESS | 23834 | 04:33:45 INFO - PROCESS | 23834 | [#4] prototype.html Cycles:180 Average:4809.94 Median:5381.12 stddev:1422.61 (26.4%) stddev-sans-first:1386.22 04:33:45 INFO - PROCESS | 23834 | Values: 326.4 332.9 334.5 340.3 342.0 5335.0 5372.9 5527.0 5589.4 5590.8 5407.1 5478.5 5486.9 5501.0 5530.8 4320.3 4347.1 4348.5 4356.7 4357.8 4130.3 4275.8 4318.5 4333.2 4349.9 4241.6 4245.6 4247.0 4257.9 4261.4 4235.3 4258.4 4261.7 4263.7 4290.0 3698.4 3760.3 3762.1 3765.6 3792.3 5351.3 5352.3 5362.5 5363.5 5389.4 4863.0 4870.8 4871.9 4889.8 4890.3 5508.1 5691.4 5726.9 5734.4 5753.5 4084.6 4093.5 4107.7 4121.2 4133.7 5894.2 5898.0 5924.7 5945.8 5950.2 4163.2 4263.7 4264.0 4294.1 4295.6 4332.2 4332.4 4339.8 4347.9 4380.8 4953.8 4965.7 4971.6 4995.4 4996.3 5682.7 5843.9 5878.6 5880.5 5910.8 1414.2 1460.4 1460.5 1465.1 1470.3 878.5 898.9 900.7 902.8 919.2 4867.4 4870.7 4872.5 4899.9 4901.3 5142.5 5142.8 5192.5 5199.0 5225.3 4893.1 4944.9 4960.5 4971.4 5191.9 3082.8 3114.0 3117.9 3158.3 3166.6 6166.9 6186.9 6217.6 6246.5 6252.9 5897.0 5961.9 5966.9 6026.4 6051.5 6113.8 6150.9 6200.8 6212.3 6216.6 5812.7 5857.9 5905.4 5968.6 6001.2 5848.7 5880.4 5885.5 5886.6 5901.8 6028.2 6100.7 6152.4 6173.0 6223.8 4084.4 4168.4 4188.2 4200.5 4202.8 5715.5 5890.7 5976.6 5997.1 6012.7 5635.6 5715.3 5733.3 5767.5 5789.2 5723.7 5731.1 5753.5 5785.6 5788.2 5608.2 5699.9 5726.8 5745.9 5784.5 5740.7 5803.5 5810.4 5812.7 5850.1 5485.6 5692.5 5693.1 5712.2 5740.7 04:33:45 INFO - PROCESS | 23834 | 04:33:45 INFO - PROCESS | 23834 | [#5] yui.html Cycles:180 Average:21632.56 Median:4593.18 stddev:31841.97 (693.2%) stddev-sans-first:31892.52 04:33:45 INFO - PROCESS | 23834 | Values: 703.8 713.5 714.3 756.8 782.5 15198.5 16249.3 16395.3 16413.1 16416.8 14877.0 15350.8 15362.5 15379.5 15492.8 805.2 812.1 812.8 813.2 818.1 799.1 806.3 806.6 823.5 829.0 866.2 870.1 872.6 873.9 877.0 864.2 865.2 869.2 870.7 870.8 632.7 632.7 633.3 635.6 637.1 15103.8 15167.6 15177.0 15190.5 15194.1 14999.5 15285.8 15338.9 15352.2 15384.0 12590.3 12855.6 12916.6 13044.2 13115.4 3773.8 3820.7 3893.6 3900.1 3954.4 87791.0 88611.6 88969.0 89367.0 89402.0 11791.9 11813.6 12245.5 12426.8 12546.2 21344.7 21680.6 21797.0 21879.2 21891.3 8344.6 8407.3 8429.4 8816.2 8970.7 4603.2 4658.5 4666.0 4763.4 4820.4 3609.3 3761.8 3763.0 3767.9 3778.0 627.2 633.0 640.4 655.8 661.1 579.6 675.8 687.6 696.4 699.9 9177.8 9575.8 10065.2 10178.0 10263.9 580.5 649.9 673.9 679.0 686.4 4583.2 5037.8 5049.9 5068.8 5080.6 68915.3 76815.2 113890.4 128700.4 132319.3 111933.7 112510.4 113323.0 114284.4 115736.0 60689.8 67545.0 92997.0 98058.0 100102.5 9108.3 9328.5 9342.6 9530.0 9541.1 56237.0 56293.4 56458.0 56710.4 59710.7 80710.0 83446.6 84321.6 84839.0 87319.6 12308.5 12401.7 12447.8 12688.9 13030.1 13245.0 13259.1 13322.5 13712.4 14393.9 12812.8 12891.5 13206.5 13233.0 13280.5 13014.7 13251.0 13319.7 13376.1 13774.2 12822.2 13010.7 13127.8 13247.1 13691.6 9510.6 9613.0 10385.6 10485.7 10488.0 10550.4 10732.7 10991.9 11002.3 11026.9 04:33:45 INFO - PROCESS | 23834 | -------- Summary: end -------- 04:33:45 INFO - PROCESS | 23834 | 04:33:46 INFO - TEST-INFO | 23834: exit 0 04:33:46 INFO - TEST-OK | dromaeo_css | took 1113361ms 04:33:46 INFO - TEST-START | kraken 04:33:46 INFO - operating with platform_type : linux_ 04:33:46 INFO - Initialising browser for kraken test... 04:33:46 INFO - TEST-INFO | started process 24085 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpocw7PI/profile http://localhost:42870/getInfo.html) 04:33:51 INFO - PROCESS | 24085 | __metrics Screen width/height:1600/1200 04:33:51 INFO - PROCESS | 24085 | colorDepth:24 04:33:51 INFO - PROCESS | 24085 | Browser inner width/height: 1024/697 04:33:51 INFO - PROCESS | 24085 | __metrics 04:33:52 ERROR - PROCESS | 24085 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2968: TypeError: this.tabs is undefined 04:33:52 INFO - TEST-INFO | 24085: exit 0 04:33:52 INFO - Browser initialized. 04:33:52 INFO - Running cycle 1/1 for kraken test... 04:33:52 INFO - TEST-INFO | started process 24204 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpocw7PI/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 04:34:04 INFO - PROCESS | 24204 | RSS: Main: 163622912 04:34:04 INFO - PROCESS | 24204 | 04:34:07 INFO - PROCESS | 24204 | Cycle 1(1): loaded http://localhost:42870/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:42870/tests/kraken/driver.html?testName=audio-beat-detection) 04:34:08 INFO - PROCESS | 24204 | RSS: Main: 169242624 04:34:08 INFO - PROCESS | 24204 | 04:34:10 INFO - PROCESS | 24204 | Cycle 1(1): loaded http://localhost:42870/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:42870/tests/kraken/driver.html?testName=audio-dft) 04:34:11 INFO - PROCESS | 24204 | RSS: Main: 168140800 04:34:11 INFO - PROCESS | 24204 | 04:34:14 INFO - PROCESS | 24204 | Cycle 1(1): loaded http://localhost:42870/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:42870/tests/kraken/driver.html?testName=audio-fft) 04:34:14 INFO - PROCESS | 24204 | RSS: Main: 163463168 04:34:14 INFO - PROCESS | 24204 | 04:34:17 INFO - PROCESS | 24204 | Cycle 1(1): loaded http://localhost:42870/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:42870/tests/kraken/driver.html?testName=audio-oscillator) 04:34:17 INFO - PROCESS | 24204 | RSS: Main: 165113856 04:34:17 INFO - PROCESS | 24204 | 04:34:19 INFO - PROCESS | 24204 | Cycle 1(1): loaded http://localhost:42870/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:42870/tests/kraken/driver.html?testName=imaging-gaussian-blur) 04:34:20 INFO - PROCESS | 24204 | RSS: Main: 165310464 04:34:20 INFO - PROCESS | 24204 | 04:34:23 INFO - PROCESS | 24204 | Cycle 1(1): loaded http://localhost:42870/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:42870/tests/kraken/driver.html?testName=imaging-darkroom) 04:34:24 INFO - PROCESS | 24204 | RSS: Main: 165310464 04:34:24 INFO - PROCESS | 24204 | 04:34:27 INFO - PROCESS | 24204 | Cycle 1(1): loaded http://localhost:42870/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:42870/tests/kraken/driver.html?testName=imaging-desaturate) 04:34:28 INFO - PROCESS | 24204 | RSS: Main: 162873344 04:34:28 INFO - PROCESS | 24204 | 04:34:31 INFO - PROCESS | 24204 | Cycle 1(1): loaded http://localhost:42870/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:42870/tests/kraken/driver.html?testName=json-parse-financial) 04:34:31 INFO - PROCESS | 24204 | RSS: Main: 165007360 04:34:31 INFO - PROCESS | 24204 | 04:34:33 INFO - PROCESS | 24204 | Cycle 1(1): loaded http://localhost:42870/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:42870/tests/kraken/driver.html?testName=json-stringify-tinderbox) 04:34:33 INFO - PROCESS | 24204 | RSS: Main: 165502976 04:34:33 INFO - PROCESS | 24204 | 04:34:35 INFO - PROCESS | 24204 | Cycle 1(1): loaded http://localhost:42870/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:42870/tests/kraken/driver.html?testName=stanford-crypto-aes) 04:34:36 INFO - PROCESS | 24204 | RSS: Main: 165478400 04:34:36 INFO - PROCESS | 24204 | 04:34:38 INFO - PROCESS | 24204 | Cycle 1(1): loaded http://localhost:42870/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:42870/tests/kraken/driver.html?testName=stanford-crypto-ccm) 04:34:39 INFO - PROCESS | 24204 | RSS: Main: 165883904 04:34:39 INFO - PROCESS | 24204 | 04:34:41 INFO - PROCESS | 24204 | Cycle 1(1): loaded http://localhost:42870/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:42870/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 04:34:42 INFO - PROCESS | 24204 | RSS: Main: 165924864 04:34:42 INFO - PROCESS | 24204 | 04:34:45 INFO - PROCESS | 24204 | Cycle 1(1): loaded http://localhost:42870/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:42870/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 04:34:45 INFO - PROCESS | 24204 | RSS: Main: 166264832 04:34:45 INFO - PROCESS | 24204 | 04:34:47 INFO - PROCESS | 24204 | Cycle 1(1): loaded http://localhost:42870/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:42870/tests/kraken/driver.html?testName=ai-astar) 04:34:47 INFO - PROCESS | 24204 | RSS: Main: 166785024 04:34:47 INFO - PROCESS | 24204 | 04:34:47 INFO - PROCESS | 24204 | __start_tp_report 04:34:47 INFO - PROCESS | 24204 | _x_x_mozilla_page_load 04:34:47 INFO - PROCESS | 24204 | _x_x_mozilla_page_load_details 04:34:47 INFO - PROCESS | 24204 | |i|pagename|runs| 04:34:47 INFO - PROCESS | 24204 | |0;ai-astar;102;111;107;114;112;112;114;112;111;111 04:34:47 INFO - PROCESS | 24204 | |1;audio-beat-detection;147;119;147;174;120;152;153;123;176;118 04:34:47 INFO - PROCESS | 24204 | |2;audio-dft;162;162;166;163;162;164;175;162;162;161 04:34:47 INFO - PROCESS | 24204 | |3;audio-fft;74;75;76;181;78;76;75;76;179;77 04:34:47 INFO - PROCESS | 24204 | |4;audio-oscillator;84;83;166;85;85;85;142;84;85;151 04:34:47 INFO - PROCESS | 24204 | |5;imaging-gaussian-blur;118;118;117;117;118;117;121;120;117;117 04:34:47 INFO - PROCESS | 24204 | |6;imaging-darkroom;152;148;146;147;147;147;147;147;146;147 04:34:47 INFO - PROCESS | 24204 | |7;imaging-desaturate;95;97;95;96;95;96;96;96;96;96 04:34:47 INFO - PROCESS | 24204 | |8;json-parse-financial;50;50;52;49;54;50;50;51;52;52 04:34:47 INFO - PROCESS | 24204 | |9;json-stringify-tinderbox;59;61;64;61;61;59;60;62;61;60 04:34:47 INFO - PROCESS | 24204 | |10;stanford-crypto-aes;77;78;76;81;77;77;78;77;85;77 04:34:47 INFO - PROCESS | 24204 | |11;stanford-crypto-ccm;124;124;123;123;124;137;131;140;139;141 04:34:47 INFO - PROCESS | 24204 | |12;stanford-crypto-pbkdf2;171;160;161;159;165;160;171;169;161;159 04:34:47 INFO - PROCESS | 24204 | |13;stanford-crypto-sha256-iterative;64;67;66;66;67;63;69;64;66;64 04:34:47 INFO - PROCESS | 24204 | __end_tp_report 04:34:47 INFO - PROCESS | 24204 | __start_cc_report 04:34:47 INFO - PROCESS | 24204 | _x_x_mozilla_cycle_collect,876 04:34:47 INFO - PROCESS | 24204 | __end_cc_report 04:34:47 INFO - PROCESS | 24204 | __startTimestamp1474371287756__endTimestamp 04:34:47 INFO - PROCESS | 24204 | 04:34:47 INFO - PROCESS | 24204 | ------- Summary: start ------- 04:34:47 INFO - PROCESS | 24204 | Number of tests: 14 04:34:47 INFO - PROCESS | 24204 | 04:34:47 INFO - PROCESS | 24204 | [#0] ai-astar Cycles:10 Average:110.60 Median:112.00 stddev:3.60 (3.2%) stddev-sans-first:2.07 04:34:47 INFO - PROCESS | 24204 | Values: 102.0 111.0 107.0 114.0 112.0 112.0 114.0 112.0 111.0 111.0 04:34:47 INFO - PROCESS | 24204 | 04:34:47 INFO - PROCESS | 24204 | [#1] audio-beat-detection Cycles:10 Average:142.90 Median:149.50 stddev:22.09 (14.8%) stddev-sans-first:23.38 04:34:47 INFO - PROCESS | 24204 | Values: 147.0 119.0 147.0 174.0 120.0 152.0 153.0 123.0 176.0 118.0 04:34:47 INFO - PROCESS | 24204 | 04:34:47 INFO - PROCESS | 24204 | [#2] audio-dft Cycles:10 Average:163.90 Median:162.50 stddev:4.15 (2.6%) stddev-sans-first:4.34 04:34:47 INFO - PROCESS | 24204 | Values: 162.0 162.0 166.0 163.0 162.0 164.0 175.0 162.0 162.0 161.0 04:34:47 INFO - PROCESS | 24204 | 04:34:47 INFO - PROCESS | 24204 | [#3] audio-fft Cycles:10 Average:96.70 Median:76.00 stddev:43.92 (57.8%) stddev-sans-first:45.81 04:34:47 INFO - PROCESS | 24204 | Values: 74.0 75.0 76.0 181.0 78.0 76.0 75.0 76.0 179.0 77.0 04:34:47 INFO - PROCESS | 24204 | 04:34:47 INFO - PROCESS | 24204 | [#4] audio-oscillator Cycles:10 Average:105.00 Median:84.50 stddev:33.62 (39.8%) stddev-sans-first:34.79 04:34:47 INFO - PROCESS | 24204 | Values: 84.0 83.0 166.0 85.0 85.0 85.0 142.0 84.0 85.0 151.0 04:34:47 INFO - PROCESS | 24204 | 04:34:47 INFO - PROCESS | 24204 | [#5] imaging-gaussian-blur Cycles:10 Average:118.00 Median:118.00 stddev:1.41 (1.2%) stddev-sans-first:1.50 04:34:47 INFO - PROCESS | 24204 | Values: 118.0 118.0 117.0 117.0 118.0 117.0 121.0 120.0 117.0 117.0 04:34:47 INFO - PROCESS | 24204 | 04:34:47 INFO - PROCESS | 24204 | [#6] imaging-darkroom Cycles:10 Average:147.40 Median:147.00 stddev:1.71 (1.2%) stddev-sans-first:0.60 04:34:47 INFO - PROCESS | 24204 | Values: 152.0 148.0 146.0 147.0 147.0 147.0 147.0 147.0 146.0 147.0 04:34:47 INFO - PROCESS | 24204 | 04:34:47 INFO - PROCESS | 24204 | [#7] imaging-desaturate Cycles:10 Average:95.80 Median:96.00 stddev:0.63 (0.7%) stddev-sans-first:0.60 04:34:47 INFO - PROCESS | 24204 | Values: 95.0 97.0 95.0 96.0 95.0 96.0 96.0 96.0 96.0 96.0 04:34:47 INFO - PROCESS | 24204 | 04:34:47 INFO - PROCESS | 24204 | [#8] json-parse-financial Cycles:10 Average:51.00 Median:51.50 stddev:1.49 (2.9%) stddev-sans-first:1.54 04:34:47 INFO - PROCESS | 24204 | Values: 50.0 50.0 52.0 49.0 54.0 50.0 50.0 51.0 52.0 52.0 04:34:47 INFO - PROCESS | 24204 | 04:34:47 INFO - PROCESS | 24204 | [#9] json-stringify-tinderbox Cycles:10 Average:60.80 Median:61.00 stddev:1.48 (2.4%) stddev-sans-first:1.41 04:34:47 INFO - PROCESS | 24204 | Values: 59.0 61.0 64.0 61.0 61.0 59.0 60.0 62.0 61.0 60.0 04:34:47 INFO - PROCESS | 24204 | 04:34:47 INFO - PROCESS | 24204 | [#10] stanford-crypto-aes Cycles:10 Average:78.30 Median:77.50 stddev:2.71 (3.5%) stddev-sans-first:2.83 04:34:47 INFO - PROCESS | 24204 | Values: 77.0 78.0 76.0 81.0 77.0 77.0 78.0 77.0 85.0 77.0 04:34:47 INFO - PROCESS | 24204 | 04:34:47 INFO - PROCESS | 24204 | [#11] stanford-crypto-ccm Cycles:10 Average:130.60 Median:134.00 stddev:7.85 (5.9%) stddev-sans-first:7.95 04:34:47 INFO - PROCESS | 24204 | Values: 124.0 124.0 123.0 123.0 124.0 137.0 131.0 140.0 139.0 141.0 04:34:47 INFO - PROCESS | 24204 | 04:34:47 INFO - PROCESS | 24204 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:163.60 Median:163.00 stddev:4.97 (3.0%) stddev-sans-first:4.49 04:34:47 INFO - PROCESS | 24204 | Values: 171.0 160.0 161.0 159.0 165.0 160.0 171.0 169.0 161.0 159.0 04:34:47 INFO - PROCESS | 24204 | 04:34:47 INFO - PROCESS | 24204 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:65.60 Median:66.00 stddev:1.84 (2.8%) stddev-sans-first:1.86 04:34:47 INFO - PROCESS | 24204 | Values: 64.0 67.0 66.0 66.0 67.0 63.0 69.0 64.0 66.0 64.0 04:34:47 INFO - PROCESS | 24204 | -------- Summary: end -------- 04:34:47 INFO - PROCESS | 24204 | 04:34:48 INFO - TEST-INFO | 24204: exit 0 04:34:48 INFO - TEST-OK | kraken | took 62350ms 04:34:48 INFO - SUITE-END | took 1175s 04:34:48 INFO - Completed test suite (00:19:35) 04:34:48 INFO - javascript benchmark 04:34:48 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7300.250345986327, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3090.2892334763005, 3104.1308433638587, 3133.0287610840633, 3134.1381120191945, 3141.7643676724238, 5241.5806735461165, 5320.494553017462, 5405.351357837065, 5416.756245968931, 5461.9453805462035, 5400.78396864125, 5410.783568657249, 5471.0, 5511.3937466878615, 5512.145617429305, 4883.389576302962, 4981.053599816023, 5001.074801161797, 5030.320906677606, 5136.768845401966, 5082.059818933509, 5090.261912022755, 5095.159298715707, 5146.253793199984, 5169.663971841837, 4751.572358487718, 4907.8773030674165, 5026.47222041684, 5081.669691470042, 5092.261622064817, 4936.432310284327, 5002.24966255061, 5019.573336266421, 5050.570701490377, 5063.0, 4938.654294199408, 4969.7515124244, 4974.4776798436005, 4993.226049962262, 5018.924716129261, 5270.710110943896, 5348.598855085884, 5435.130379139358, 5455.372632147314, 5472.616916815825, 5751.827445176651, 5841.153032810261, 5841.240638716939, 5863.237779088734, 5894.204282421861, 5863.179154918314, 5871.236739223874, 5873.1190321451695, 5874.97062514689, 5877.089051197071, 5256.342957130359, 5373.11343628297, 5421.024215641183, 5441.347038355383, 5452.372977107644, 5820.592558520862, 5965.433283838029, 5973.79091731796, 5999.850003749942, 6018.097285407224, 5751.971240143856, 5763.596548241667, 5765.596408251466, 5770.394108618619, 5773.134029895549, 5599.7480113394995, 5690.658560486384, 5833.941660583425, 5849.151872978395, 5851.297844258716, 5778.595498315161, 5780.393058728857, 5824.504917082011, 5846.444587764156, 5860.150278209636, 5821.09772985188, 5824.242848429762, 5828.6502809831545, 5832.766689332379, 5841.299044114733, 4364.8472303469225, 4446.666500012512, 4485.439320084989, 4503.3245013247615, 4536.478304994902, 3960.584138665456, 3997.340438827619, 4031.07285324377, 4048.3117869962175, 4069.2268468990796, 5581.944180558224, 5596.076647353222, 5599.496045355938, 5607.52336051432, 5608.0, 5690.061139911951, 5838.7080645967535, 5905.173275741399, 5927.288725352985, 5946.762129514857, 5551.333839939233, 5601.607887447921, 5615.606907516516, 5632.605717599728, 5658.688772117491, 5061.670991385548, 5070.518300761496, 5073.695578265242, 5084.211947148198, 5131.589472842164, 5868.471837534642, 5920.79277225295, 6133.417325354084, 6139.324674285825, 6155.045967874987, 5721.456461636138, 5761.02062649359, 5788.623739456922, 5801.506871915765, 5809.8547536311935, 6007.038873780174, 6007.519398448201, 6008.399160083956, 6012.3085845126625, 6024.096385542204, 5587.217789509553, 5650.237217975685, 5693.28833895763, 5695.401982791913, 5711.257536520226, 5841.415858414294, 5842.766289348378, 5886.0, 5892.970535147297, 5949.1076338549565, 5748.080307150836, 5765.8558536036935, 5766.538676905921, 5769.394213607511, 5791.420857914343, 5452.6183167177915, 5560.082586373365, 5605.383407825218, 5731.111677689964, 5774.39368866263, 5618.157276408571, 5619.297587801525, 5621.353544342453, 5651.237082993744, 5658.915116273177, 5663.433656634304, 5663.858403539944, 5678.6876721779045, 5733.111367738007, 5740.6268592541355, 5362.758675859518, 5544.556435485071, 5554.472325129106, 5569.637973531708, 5600.187972744011], "value": 5381.648111143631, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [547.674801153407, 594.8631814682624, 595.2589026661807, 606.5996442348048, 618.7710547097574, 39734.0, 44475.77762111189, 44574.10851782963, 44604.33093503592, 44708.55291447085, 44911.550884491146, 45182.09635807282, 45373.09253814922, 45400.86497837555, 45510.77244613781, 8618.095100014487, 8766.079561646031, 8782.736517904441, 8807.559622018905, 8810.515421651806, 8855.468671879675, 8900.73297801067, 8906.287497000258, 8927.910720892805, 8978.775530611721, 8872.955635221848, 8908.643654253821, 8940.687075952343, 8948.686795962143, 8962.686305979292, 8938.106189381075, 8983.056779038172, 8989.775255618597, 9007.234385077276, 9010.053944335848, 8601.698940537051, 8610.913890861073, 8646.351523635689, 8649.178328058824, 8657.134286571356, 41818.37272440916, 41904.1619167618, 42159.578404216176, 42306.365404518954, 42494.57505424937, 3004.6544647365395, 3336.432806422914, 3438.329525742481, 3618.421052631593, 3945.1320709443876, 32258.354832903446, 32631.0, 32871.17822054444, 32879.34241315184, 33419.83290083559, 4084.673226141931, 4135.731177473484, 4190.392393103013, 4211.0, 4346.521882592912, 323176.0, 324017.0, 324809.9999999976, 325549.0, 326534.0, 36137.81931090328, 36205.91382258484, 36443.0, 36462.63537364645, 36560.0, 36785.632143678224, 37070.44394334087, 37272.509099636256, 37282.44076338857, 37292.38953273245, 14506.637334066521, 14656.780148297785, 14665.780013299809, 14672.486462973744, 15259.847401525843, 12201.938990305169, 12215.450304736309, 12339.444724987397, 12373.93813030947, 12383.19509231897, 19285.710714339297, 19384.321548745727, 19386.4184074478, 19420.0, 19472.123754431086, 7065.964670176616, 7096.112985876765, 7169.605671688108, 7208.27917208275, 7528.247175282428, 955.5031383680587, 1119.5186069989982, 1153.1697178031804, 1155.289496959364, 1171.0631494804122, 32274.193145171088, 32800.50799238013, 33005.834970824995, 33154.0, 33349.83325083359, 1102.685734565645, 1117.944102794857, 1126.0934947367284, 1160.8200728887036, 1194.3371428857067, 16852.157392130346, 17348.566285842702, 17443.476695699148, 17455.301787928594, 17487.125643718016, 573725.0, 574219.0, 575462.0, 576623.0, 577379.0, 60049.699751500964, 60438.69780651069, 60447.69776151091, 60509.39490605125, 60642.393576064555, 1326.5953884065452, 1330.9068365214341, 1346.562367230654, 1377.5522955039653, 1384.2801743093535, 30394.696053040072, 32669.836650816593, 32968.0, 33196.50205246972, 33501.32997340088, 51023.48976510188, 52139.47860521346, 52247.0, 52392.47607523876, 52402.0, 435108.0, 440536.0, 441488.0, 441735.0, 443783.0, 29255.0, 29311.85344073266, 29459.558106628847, 29624.85187574048, 29685.554716678835, 49007.26489102595, 49069.75465122652, 49755.75122124366, 49893.25160122528, 50528.74735626298, 41847.37228941629, 42246.57753422549, 42544.36183457312, 44161.55838441703, 44390.11219775651, 42039.78980105202, 42247.0, 42448.0, 43017.3547396783, 43971.34042989294, 41240.0, 42934.78532607317, 43054.78472607617, 43409.565904340554, 45620.77189614163, 33338.66661333355, 38415.6158438412, 38744.0, 38905.6109438902, 39140.804295978334, 28910.277243069093, 29211.561826572193, 29403.85298073496, 29464.410711786073, 29589.0], "value": 19783.28566601712, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [380.5072431201594, 389.31869228849513, 398.5735263268303, 401.1275475840048, 420.8358740091365, 18181.272749090036, 19482.707759383622, 20035.0, 20069.498262543406, 20175.0, 18753.437396878115, 18862.339818106368, 19059.523511912208, 19170.90414547929, 19192.61614767704, 5662.773489060443, 5741.799037033705, 5763.827085187451, 5790.420957904218, 5806.216160818278, 5619.690916999563, 5748.568857335696, 5775.711214439282, 5777.480026797587, 5777.480026797587, 5364.356277246736, 5568.1647752837, 5652.0, 5755.136729490568, 5769.451902069297, 5623.437656234385, 5647.661140331552, 5671.744771485272, 5679.119736440858, 5697.230873832021, 5614.6631202128, 5731.484166425, 5751.626144300607, 5755.194272801811, 5768.817392434583, 22462.663060054114, 23269.534609307888, 23642.054317827267, 23719.644205336936, 23875.0, 2411.746766589518, 2480.131953816168, 2504.536660717773, 2611.6213149093273, 2967.109867039879, 10152.39085654863, 10350.171986241083, 10379.688609341732, 13191.604251872459, 14103.858961410357, 1868.4207895552422, 1911.7897031326543, 1983.4049785064424, 2017.798220177985, 2052.3842847145797, 89303.32090037374, 89526.5523672384, 91059.0, 91974.54012729961, 92549.76075837313, 9146.359754817233, 9859.802803943881, 9946.259404604165, 9958.352707074017, 10125.493725313852, 13343.799843002364, 13492.325383730775, 13493.730125397633, 13505.2572108533, 13550.661233469045, 7032.92967070333, 7034.824129396806, 7084.36240738336, 7234.66158760631, 7463.552186868806, 6284.0, 6486.772962946368, 6511.186101737283, 6731.225909020427, 7290.744823931137, 4006.579309172553, 4138.089620283533, 4140.855070072533, 4234.470691163605, 4295.8496452624, 1921.6156768646326, 1931.5943651833272, 2030.8273796727444, 2047.2220556188554, 2077.376786963935, 902.4134312696799, 910.6767097680361, 928.5264515097214, 972.3873959405529, 999.0159692702682, 18900.905495472434, 19126.80873191278, 19898.60202795965, 20285.290014849703, 21613.567728645652, 911.7538264668502, 962.6341990043738, 975.331897650112, 1000.3747657713928, 1019.5259204469809, 10997.285176463503, 11247.268927519848, 11251.43742812856, 11298.265612735146, 11332.150088743378, 482949.0, 485229.0, 488709.0, 491878.0, 492155.0, 64904.0, 71037.0, 82964.58517707374, 88553.55723221472, 101101.49449252854, 1002.5288114586133, 1017.3133135133755, 1045.717656232813, 1051.5688567687212, 1056.4612047855649, 16958.236879340213, 17231.82768172302, 17827.910860446133, 18136.546586335448, 18423.907880460512, 36109.916702498966, 40866.0, 44747.77626111849, 44874.775626121664, 45206.54793452023, 61331.693341533006, 63347.0, 63692.68153659202, 64341.678291608245, 64957.0, 8456.112108228794, 8579.957100214458, 8600.483970961763, 8622.870656940026, 8873.423227490193, 13032.934835325763, 13463.596092117252, 13627.931860340635, 13740.10689305232, 13850.792238116235, 11601.76796464049, 11713.0, 11808.350540720343, 11835.822462662894, 12227.69430764238, 11465.082793376676, 11513.884861151617, 11546.94226528862, 11599.188056835941, 11723.706907327385, 11706.297622142698, 11763.235389699643, 11894.881051189377, 11896.643100706646, 12346.814797778221, 8509.574521274035, 8602.440841345293, 8640.04959454472, 8855.91144088551, 8858.810220324176, 10402.947985260025, 11594.0, 11854.229475084092, 11935.701607459883, 12322.445489952794], "value": 9183.01057928224, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1478.0688166455136, 1494.2080697230467, 1634.8119966203883, 1781.8930864148151, 1804.9729254061199, 8071.192880711926, 8426.0, 8664.350173736979, 9155.908440915597, 9162.312826538004, 8572.01421836489, 8924.107589241088, 8948.418352807079, 9008.954955225216, 9076.727698169048, 2351.976480235197, 2383.4875501767115, 2393.74865639108, 2398.5202959408102, 2407.3018824540864, 2359.9410014749683, 2380.6905102336673, 2442.096424323003, 2453.0678342229926, 2462.66753988212, 2382.9642555361597, 2400.3639035655565, 2409.0965887792077, 2445.6698345723366, 2449.9877500612474, 2345.5895218336723, 2383.5352106339355, 2383.8212134090013, 2384.523095380922, 2390.0, 2355.422921384272, 2357.905683772647, 2361.9645705314433, 2362.362162216192, 2384.3443053160345, 9053.59258833354, 9085.0, 9094.681686140953, 9125.5437228139, 9182.678606248815, 5210.895782084337, 5283.788648454057, 5349.59878009147, 5360.705161216131, 5361.463853614608, 3422.195783990785, 3433.9656603433896, 3513.1217195701074, 3524.8061356625376, 3530.6292839251764, 1124.7975364434399, 1146.8165093584987, 1154.7979103656826, 1159.2059439284117, 1171.4142928535732, 12474.376281185996, 12543.56097536591, 12571.308578028205, 12589.055820813475, 12591.181573197713, 4343.739375637472, 4612.74629895359, 4621.930671039937, 4738.47876733559, 4787.904241915142, 10596.894031059745, 10649.307794993301, 10654.57381704723, 10661.680149595524, 10670.41312727792, 5287.127623942007, 5311.362636483569, 5315.813946511854, 5316.282301889196, 5316.415194328621, 4335.783210839445, 4686.226772582554, 4792.95207047925, 4801.51984801524, 4893.045856058035, 3800.847966081381, 3962.5046869141356, 4013.4983127109113, 4029.6776257899296, 4031.3751368537924, 1250.6373151786063, 1259.2885019963692, 1262.8042653388738, 1263.7788387032233, 1266.7973124300252, 844.7845799321134, 881.0528681667233, 882.4043770454917, 935.7847695030181, 999.5452069308448, 5880.7353669085, 6018.879622407615, 6058.515318774487, 6291.6854157291955, 6326.513269381691, 462.65301024231826, 473.5004570178495, 473.583246742871, 474.9881252968634, 1025.251566356549, 4081.428599996003, 4378.401883312632, 4393.121375724804, 4401.823927042947, 4423.20382331177, 10561.471926403803, 10767.0, 10845.295055821347, 10859.239853210358, 10890.455477226107, 10688.946555267174, 10731.087857532197, 10791.730206744736, 10799.946000269949, 10852.186086043579, 7892.960535197287, 8108.472949258279, 8153.34773218153, 8264.504129752235, 8528.445651032664, 6193.752249909953, 6212.502999759918, 6216.129741836237, 6320.209973753281, 6337.2395312562785, 10091.949540252252, 10329.690109296733, 10348.068673819393, 10451.111655509367, 10511.842322365017, 9959.701208963743, 10171.23715721309, 10206.744831379276, 10258.333208341433, 10316.381017138996, 7167.139943206848, 7656.578888161204, 7784.143744188248, 7978.521288722695, 8089.393295502743, 8700.869486957574, 8746.256568191775, 8789.38474306818, 8796.60415281301, 8879.91120088791, 7724.729634462767, 7829.491083079582, 7909.288164065261, 7963.960180199062, 8153.143919888326, 7753.65108570127, 7797.220277972157, 7851.56816375082, 7862.72480463181, 7895.68417263303, 7031.859362812613, 7124.750633727795, 7154.606496642735, 7156.928430715834, 7164.426845852424, 5046.21783623539, 5099.69401835891, 5247.0, 5249.921251181312, 5489.423610520837, 5332.280142180756, 5355.598330125178, 5486.149646804752, 5507.146392309199, 5531.612787104864], "value": 4656.678089784952, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [326.36684831427044, 332.8918101616974, 334.5099429336023, 340.2769115629288, 341.96896357482194, 5334.986352593005, 5372.892542149155, 5526.972365138174, 5589.379080066781, 5590.83227503175, 5407.053460754126, 5478.534324582405, 5486.91769623456, 5500.954818584466, 5530.834074977747, 4320.265554855682, 4347.13057388522, 4348.456442944632, 4356.6514678825615, 4357.847475338372, 4130.277201489727, 4275.786210689469, 4318.52496225415, 4333.2416827055295, 4349.891252718676, 4241.597048280424, 4245.596668316521, 4247.0, 4257.893552661193, 4261.403403523509, 4235.25882970479, 4258.425112609804, 4261.744295342274, 4263.701540892139, 4289.978550107229, 3698.4267438547067, 3760.3231418344685, 3762.097096696773, 3765.585785563586, 3792.3363411402893, 5351.304330437058, 5352.277442545284, 5362.544183744387, 5363.463653634644, 5389.353277606712, 4863.0, 4870.805167793284, 4871.902561948741, 4889.804407823683, 4890.315355850148, 5508.14623733322, 5691.373948865621, 5726.942730572682, 5734.397888221718, 5753.482186603184, 4084.550699423061, 4093.5087789465156, 4107.67138628909, 4121.175764847013, 4133.6693064554765, 5894.233749612523, 5898.0, 5924.7333869975955, 5945.821625351246, 5950.196723442323, 4163.2298024864895, 4263.722858014219, 4263.978680106579, 4294.0767734937135, 4295.613394794484, 4332.220200363965, 4332.371806088099, 4339.7830108494445, 4347.934780978288, 4380.846670366522, 4953.752312384367, 4965.708915681948, 4971.552560269593, 4995.425526064477, 4996.275540046673, 5682.698507104629, 5843.94156058434, 5878.617889837147, 5880.500157486576, 5910.822675319747, 1414.2221778022047, 1460.393936516355, 1460.532629558531, 1465.1062851660479, 1470.2869108482378, 878.499255424402, 898.8696638987441, 900.6532484993194, 902.7607683963755, 919.2140719684706, 4867.41808912105, 4870.683405578626, 4872.4883887192045, 4899.897523057283, 4901.2893130496595, 5142.477402978971, 5142.768575414116, 5192.506711862443, 5199.0, 5225.268462415265, 4893.143699852582, 4944.90110197794, 4960.50394960501, 4971.37857767779, 5191.897281600957, 3082.799618024821, 3113.9532907006414, 3117.9376412471624, 3158.3367492826765, 3166.6200055993427, 6166.876662466815, 6186.907196392058, 6217.564770466114, 6246.500279977591, 6252.937470625327, 5897.0, 5961.940380596226, 5966.85082872923, 6026.367231440636, 6051.4553690168095, 6113.786017489367, 6150.907736383958, 6200.81397558074, 6212.285587157445, 6216.564840461215, 5812.651240925558, 5857.949717598806, 5905.379935106752, 5968.552358573212, 6001.219841420588, 5848.707564621837, 5880.353161152356, 5885.47030767233, 5886.58793884424, 5901.822945311647, 6028.186194863637, 6100.6949652516305, 6152.384761523812, 6172.969135154295, 6223.844403889939, 4084.4485994390375, 4168.39558264044, 4188.246115699203, 4200.516940551875, 4202.810873510638, 5715.542756579381, 5890.676012819336, 5976.641401515923, 5997.100434934795, 6012.7294271757, 5635.591102224444, 5715.314162300384, 5733.3406658234835, 5767.452092051249, 5789.247397838254, 5723.6851973141875, 5731.083026715705, 5753.532849123447, 5785.595008349375, 5788.247527821356, 5608.158776183605, 5699.886002279848, 5726.828195154152, 5745.856353591026, 5784.50831679312, 5740.68426236561, 5803.47768700819, 5810.448007439287, 5812.680302583399, 5850.063989761617, 5485.588580856372, 5692.459216374604, 5693.060644993529, 5712.200291959046, 5740.68426236561], "value": 4349.319568510944, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [703.8486725354051, 713.4791602130445, 714.2821464428249, 756.7616200896717, 782.5304817109735, 15198.468053618126, 16249.268782904768, 16395.344186232567, 16413.097279649613, 16416.83583164168, 14877.032992855457, 15350.846491535081, 15362.539123826304, 15379.461718839842, 15492.845071549309, 805.1706742055692, 812.1310198088019, 812.8496228197773, 813.1868131868132, 818.071488860145, 799.077065988781, 806.2582424169749, 806.5604245686116, 823.4976664234842, 829.0424559633602, 866.2290561400358, 870.1385628228072, 872.5549969515561, 873.9344549158807, 877.026500584354, 864.1833467373335, 865.195368307477, 869.1569177897429, 870.682200996638, 870.7561882672861, 632.667849379075, 632.7057918068075, 633.3223450907531, 635.5614625908108, 637.0762394527953, 15103.848961510354, 15167.62080947974, 15177.0, 15190.468333608382, 15194.088354698642, 14999.475018374305, 15285.847141528553, 15338.923305383514, 15352.155631440266, 15384.0, 12590.307533085677, 12855.614331570068, 12916.612501624966, 13044.217346959213, 13115.409806558728, 3773.8490460381554, 3820.6561409473, 3893.552241492236, 3900.083480382108, 3954.367301231789, 87791.0, 88611.55694221487, 88969.0, 89367.0, 89402.0, 11791.941040294916, 11813.645590632295, 12245.510179592717, 12426.75146497065, 12546.1844980076, 21344.679829802564, 21680.566388672138, 21797.0, 21879.234226801986, 21891.343259702233, 8344.62449189788, 8407.285380742705, 8429.40994130405, 8816.162464565856, 8970.68602598919, 4603.217453032992, 4658.487566367697, 4665.9766701166955, 4763.3807605011125, 4820.421549414093, 3609.3322735294055, 3761.8307176177136, 3763.002804256819, 3767.8869633911027, 3777.981110094487, 627.1658693937053, 632.9588576742497, 640.4236187431349, 655.7967030220647, 661.1009027722293, 579.6232448908244, 675.7938828657209, 687.6355531568277, 696.435886931587, 699.909011828459, 9177.816443671089, 9575.808483830284, 10065.194784417228, 10178.0, 10263.897361026444, 580.4862696513616, 649.9317571655002, 673.9427148692416, 678.9796306110825, 686.4268335939546, 4583.152116858325, 5037.823676171316, 5049.899002019939, 5068.82259120929, 5080.59355251579, 68915.31084689089, 76815.23184768081, 113890.43054784673, 128700.3564982169, 132319.33840330737, 111933.70936559595, 112510.43744781223, 113323.0, 114284.42857785658, 115736.0, 60689.78620427567, 67545.0, 92997.0, 98058.0, 100102.4994875021, 9108.271338293052, 9328.454927920584, 9342.579583918876, 9529.999350068143, 9541.093596108358, 56237.0, 56293.43706563046, 56458.0, 56710.432895672166, 59710.70144649249, 80710.0, 83446.58276708577, 84321.57839210765, 84839.0, 87319.56340218258, 12308.507659693512, 12401.689957750768, 12447.813282800946, 12688.921441677561, 13030.087893847718, 13245.0, 13259.071864969359, 13322.533711320057, 13712.382942767399, 14393.92803035978, 12812.807807883075, 12891.48434062627, 13206.537771177962, 13233.0, 13280.468781248643, 13014.739705205653, 13251.0, 13319.66700832487, 13376.130551514121, 13774.242416666779, 12822.23066616006, 13010.674733131747, 13127.803082953955, 13247.138935969131, 13691.589252322447, 9510.63289753293, 9612.951935240559, 10385.584576616851, 10485.68542943713, 10487.951418371082, 10550.366977981346, 10732.678019659423, 10991.945040274748, 11002.284851484628, 11026.944865275622], "value": 7643.411731292774, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1530.1999999999996, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [102.0, 111.0, 107.0, 114.0, 112.0, 112.0, 114.0, 112.0, 111.0, 111.0], "value": 110.6, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [147.0, 119.0, 147.0, 174.0, 120.0, 152.0, 153.0, 123.0, 176.0, 118.0], "value": 142.9, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [162.0, 162.0, 166.0, 163.0, 162.0, 164.0, 175.0, 162.0, 162.0, 161.0], "value": 163.9, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [74.0, 75.0, 76.0, 181.0, 78.0, 76.0, 75.0, 76.0, 179.0, 77.0], "value": 96.7, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 83.0, 166.0, 85.0, 85.0, 85.0, 142.0, 84.0, 85.0, 151.0], "value": 105.0, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [118.0, 118.0, 117.0, 117.0, 118.0, 117.0, 121.0, 120.0, 117.0, 117.0], "value": 118.0, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [152.0, 148.0, 146.0, 147.0, 147.0, 147.0, 147.0, 147.0, 146.0, 147.0], "value": 147.4, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 97.0, 95.0, 96.0, 95.0, 96.0, 96.0, 96.0, 96.0, 96.0], "value": 95.8, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [50.0, 50.0, 52.0, 49.0, 54.0, 50.0, 50.0, 51.0, 52.0, 52.0], "value": 51.0, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [59.0, 61.0, 64.0, 61.0, 61.0, 59.0, 60.0, 62.0, 61.0, 60.0], "value": 60.8, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [77.0, 78.0, 76.0, 81.0, 77.0, 77.0, 78.0, 77.0, 85.0, 77.0], "value": 78.3, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [124.0, 124.0, 123.0, 123.0, 124.0, 137.0, 131.0, 140.0, 139.0, 141.0], "value": 130.6, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [171.0, 160.0, 161.0, 159.0, 165.0, 160.0, 171.0, 169.0, 161.0, 159.0], "value": 163.6, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [64.0, 67.0, 66.0, 66.0, 67.0, 63.0, 69.0, 64.0, 66.0, 64.0], "value": 65.6, "unit": "score"}]}]} 04:34:49 INFO - Return code: 0 04:34:49 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 04:34:49 ERROR - # TBPL SUCCESS # 04:34:49 INFO - Running post-action listener: _resource_record_post_action 04:34:49 INFO - [mozharness: 2016-09-20 11:34:49.061993Z] Finished run-tests step (success) 04:34:49 INFO - Running post-run listener: _resource_record_post_run 04:34:49 INFO - Total resource usage - Wall time: 1193s; CPU: 13.0%; Read bytes: 4096; Write bytes: 552144896; Read time: 16; Write time: 539660 04:34:49 INFO - TinderboxPrint: CPU usage
13.4% 04:34:49 INFO - TinderboxPrint: I/O read bytes / time
4,096 / 16 04:34:49 INFO - TinderboxPrint: I/O write bytes / time
552,144,896 / 539,660 04:34:49 INFO - TinderboxPrint: CPU idle
8,244.8 (86.6%) 04:34:49 INFO - TinderboxPrint: CPU user
1,215.5 (12.8%) 04:34:49 INFO - TinderboxPrint: Swap in / out
0 / 0 04:34:49 INFO - install - Wall time: 17s; CPU: 14.0%; Read bytes: 0; Write bytes: 262152192; Read time: 0; Write time: 284036 04:34:49 INFO - run-tests - Wall time: 1176s; CPU: 13.0%; Read bytes: 0; Write bytes: 289644544; Read time: 0; Write time: 255540 04:34:49 INFO - Running post-run listener: _upload_blobber_files 04:34:49 INFO - Blob upload gear active. 04:34:49 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 04:34:49 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 04:34:49 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', 'Mozilla-Inbound', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 04:34:49 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 Mozilla-Inbound -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 04:34:50 INFO - (blobuploader) - INFO - Open directory for files ... 04:34:50 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 04:34:50 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 04:34:50 INFO - (blobuploader) - INFO - Uploading, attempt #1. 04:34:53 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 04:34:53 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 04:34:53 INFO - (blobuploader) - INFO - Done attempting. 04:34:53 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 04:34:53 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 04:34:53 INFO - (blobuploader) - INFO - Uploading, attempt #1. 04:34:54 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 04:34:54 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 04:34:54 INFO - (blobuploader) - INFO - Done attempting. 04:34:54 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 04:34:54 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 04:34:54 INFO - (blobuploader) - INFO - Uploading, attempt #1. 04:34:55 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 04:34:55 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 04:34:55 INFO - (blobuploader) - INFO - Done attempting. 04:34:55 INFO - (blobuploader) - INFO - Iteration through files over. 04:34:55 INFO - Return code: 0 04:34:55 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 04:34:55 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 04:34:55 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/8fb105991672af023e28477d97b188635a1775b310d100455629fc7321f588a430785514584dfdd84130cc5da8e7325a446c6da78fd0e6f6839094f0e97191d0", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/3bfb014541700a8afb05f73796a99002b330a75c8302e7e95d6fbd56e73b282c8f0940b0bd41a0328c4b5db877e851165110f7f6a6507397801a81771ce48422", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/214cd9886454568383a993797a780eb01eafe25192924835156094c4d867239590be6a82f79bd54b79e6c5fe85060480f87a0a7807e0f334341b3121c482a3e5"} 04:34:55 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 04:34:55 INFO - Writing to file /builds/slave/test/properties/blobber_files 04:34:55 INFO - Contents: 04:34:55 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/8fb105991672af023e28477d97b188635a1775b310d100455629fc7321f588a430785514584dfdd84130cc5da8e7325a446c6da78fd0e6f6839094f0e97191d0", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/3bfb014541700a8afb05f73796a99002b330a75c8302e7e95d6fbd56e73b282c8f0940b0bd41a0328c4b5db877e851165110f7f6a6507397801a81771ce48422", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/214cd9886454568383a993797a780eb01eafe25192924835156094c4d867239590be6a82f79bd54b79e6c5fe85060480f87a0a7807e0f334341b3121c482a3e5"} 04:34:55 INFO - Running post-run listener: copy_logs_to_upload_dir 04:34:55 INFO - Copying logs to upload dir... 04:34:55 INFO - mkdir: /builds/slave/test/build/upload/logs 04:34:55 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1230.468677 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 30 secs) (at 2016-09-20 04:34:55.512666) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-09-20 04:34:55.516471) ========= 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=eca2ab57546de7b41f256b19000001ef-1474370063.452274-1001580825 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/Mozilla-Inbound/sha512/8fb105991672af023e28477d97b188635a1775b310d100455629fc7321f588a430785514584dfdd84130cc5da8e7325a446c6da78fd0e6f6839094f0e97191d0", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/3bfb014541700a8afb05f73796a99002b330a75c8302e7e95d6fbd56e73b282c8f0940b0bd41a0328c4b5db877e851165110f7f6a6507397801a81771ce48422", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/214cd9886454568383a993797a780eb01eafe25192924835156094c4d867239590be6a82f79bd54b79e6c5fe85060480f87a0a7807e0f334341b3121c482a3e5"} build_url:https://queue.taskcluster.net/v1/task/BFHohf2iREuMmsBRTLhwJA/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011375 build_url: 'https://queue.taskcluster.net/v1/task/BFHohf2iREuMmsBRTLhwJA/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/Mozilla-Inbound/sha512/8fb105991672af023e28477d97b188635a1775b310d100455629fc7321f588a430785514584dfdd84130cc5da8e7325a446c6da78fd0e6f6839094f0e97191d0", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/3bfb014541700a8afb05f73796a99002b330a75c8302e7e95d6fbd56e73b282c8f0940b0bd41a0328c4b5db877e851165110f7f6a6507397801a81771ce48422", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/214cd9886454568383a993797a780eb01eafe25192924835156094c4d867239590be6a82f79bd54b79e6c5fe85060480f87a0a7807e0f334341b3121c482a3e5"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-09-20 04:34:55.542759) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-09-20 04:34:55.543186) ========= 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=eca2ab57546de7b41f256b19000001ef-1474370063.452274-1001580825 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004503 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-09-20 04:34:55.627484) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-09-20 04:34:55.627872) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-09-20 04:34:55.628247) ========= ========= Total master_lag: 0.17 =========