builder: mozilla-inbound_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-018 starttime: 1470352436.74 results: success (0) buildid: 20160804133004 builduid: 394b8adfa82648c58515d516c1095ecf revision: be293e09860eafd2de5482227ae00ac2f3b0acfb ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-08-04 16:13:56.739510) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-08-04 16:13:56.739925) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-08-04 16:13:56.740204) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-08-04 16:13:56.773146) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-08-04 16:13:56.773518) ========= 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=62c568580acbfdaac3eec7be000001dc-1470352422.749459-898834608 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-08-04 16:13:56-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 112M=0s 2016-08-04 16:13:57 (112 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.131929 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-08-04 16:13:56.922477) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-08-04 16:13:56.922811) ========= 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=62c568580acbfdaac3eec7be000001dc-1470352422.749459-898834608 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.020265 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-08-04 16:13:56.972485) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-08-04 16:13:56.972933) ========= bash -c 'python archiver_client.py mozharness --repo integration/mozilla-inbound --rev be293e09860eafd2de5482227ae00ac2f3b0acfb --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 be293e09860eafd2de5482227ae00ac2f3b0acfb --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=62c568580acbfdaac3eec7be000001dc-1470352422.749459-898834608 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-08-04 16:13:57,208 truncating revision to first 12 chars 2016-08-04 16:13:57,208 Setting DEBUG logging. 2016-08-04 16:13:57,208 attempt 1/10 2016-08-04 16:13:57,208 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/mozilla-inbound/be293e09860e?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-08-04 16:13:57,565 unpacking tar archive at: mozilla-inbound-be293e09860e/testing/mozharness/ program finished with exit code 0 elapsedTime=0.686640 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-08-04 16:13:57.674642) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-08-04 16:13:57.675038) ========= script_repo_revision: be293e09860eafd2de5482227ae00ac2f3b0acfb ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-08-04 16:13:57.675570) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-08-04 16:13:57.675896) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-08-04 16:13:57.687161) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 32 secs) (at 2016-08-04 16:13:57.687586) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --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', '--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=62c568580acbfdaac3eec7be000001dc-1470352422.749459-898834608 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 16:13:58 INFO - MultiFileLogger online at 20160804 16:13:58 in /builds/slave/test 16:13:58 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Inbound --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Inbound 16:13:58 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 16:13:58 INFO - {'append_to_log': False, 16:13:58 INFO - 'base_work_dir': '/builds/slave/test', 16:13:58 INFO - 'blob_upload_branch': 'Mozilla-Inbound', 16:13:58 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 16:13:58 INFO - 'branch': 'Mozilla-Inbound', 16:13:58 INFO - 'buildbot_json_path': 'buildprops.json', 16:13:58 INFO - 'config_files': ('talos/linux_config.py',), 16:13:58 INFO - 'default_actions': ('clobber', 16:13:58 INFO - 'read-buildbot-config', 16:13:58 INFO - 'download-and-extract', 16:13:58 INFO - 'populate-webroot', 16:13:58 INFO - 'create-virtualenv', 16:13:58 INFO - 'install', 16:13:58 INFO - 'run-tests'), 16:13:58 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 16:13:58 INFO - 'download_minidump_stackwalk': True, 16:13:58 INFO - 'download_symbols': 'ondemand', 16:13:58 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 16:13:58 INFO - 'tooltool.py': '/tools/tooltool.py', 16:13:58 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 16:13:58 INFO - '/tools/misc-python/virtualenv.py')}, 16:13:58 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 16:13:58 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 16:13:58 INFO - 'installer_path': 'installer.exe', 16:13:58 INFO - 'log_level': 'info', 16:13:58 INFO - 'log_name': 'talos', 16:13:58 INFO - 'log_to_console': True, 16:13:58 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 16:13:58 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 16:13:58 INFO - 'opt_config_files': (), 16:13:58 INFO - 'pip_index': False, 16:13:58 INFO - 'sps_profile': False, 16:13:58 INFO - 'sps_profile_interval': 0, 16:13:58 INFO - 'suite': 'dromaeojs', 16:13:58 INFO - 'system_bits': '32', 16:13:58 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 16:13:58 INFO - 'title': 'talos-linux64-ix-018', 16:13:58 INFO - 'tooltool_cache': '/builds/tooltool_cache', 16:13:58 INFO - 'use_talos_json': True, 16:13:58 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 16:13:58 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 16:13:58 INFO - 'work_dir': 'build'} 16:13:58 INFO - [mozharness: 2016-08-04 23:13:58.018138Z] Running clobber step. 16:13:58 INFO - Running pre-action listener: _resource_record_pre_action 16:13:58 INFO - Running main action method: clobber 16:13:58 INFO - rmtree: /builds/slave/test/build 16:13:58 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 16:13:58 INFO - Running post-action listener: _resource_record_post_action 16:13:58 INFO - [mozharness: 2016-08-04 23:13:58.992920Z] Finished clobber step (success) 16:13:58 INFO - [mozharness: 2016-08-04 23:13:58.993022Z] Running read-buildbot-config step. 16:13:58 INFO - Running pre-action listener: _resource_record_pre_action 16:13:58 INFO - Running main action method: read_buildbot_config 16:13:58 INFO - Using buildbot properties: 16:13:58 INFO - { 16:13:58 INFO - "project": "", 16:13:58 INFO - "product": "firefox", 16:13:58 INFO - "script_repo_revision": "production", 16:13:58 INFO - "builddir": "mozilla-inbound_ubuntu64_hw_test-dromaeojs", 16:13:58 INFO - "repository": "", 16:13:58 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-inbound pgo talos dromaeojs", 16:13:58 INFO - "buildid": "20160804133004", 16:13:58 INFO - "pgo_build": "True", 16:13:58 INFO - "basedir": "/builds/slave/test", 16:13:58 INFO - "buildnumber": 2198, 16:13:58 INFO - "slavename": "talos-linux64-ix-018", 16:13:58 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 16:13:58 INFO - "platform": "ubuntu64_hw", 16:13:58 INFO - "scheduler": "tests-mozilla-inbound-linux64-pgo-talos", 16:13:58 INFO - "branch": "mozilla-inbound", 16:13:58 INFO - "repo_path": "integration/mozilla-inbound", 16:13:58 INFO - "revision": "be293e09860eafd2de5482227ae00ac2f3b0acfb", 16:13:58 INFO - "stage_platform": "linux64-pgo", 16:13:58 INFO - "builduid": "394b8adfa82648c58515d516c1095ecf", 16:13:58 INFO - "slavebuilddir": "test" 16:13:58 INFO - } 16:13:58 INFO - Found installer url https://queue.taskcluster.net/v1/task/Slkje-RSToSGmGOKEXF4PA/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2. 16:13:58 INFO - Running post-action listener: _resource_record_post_action 16:13:58 INFO - [mozharness: 2016-08-04 23:13:58.995506Z] Finished read-buildbot-config step (success) 16:13:58 INFO - [mozharness: 2016-08-04 23:13:58.995596Z] Running download-and-extract step. 16:13:58 INFO - Running pre-action listener: _resource_record_pre_action 16:13:58 INFO - Running main action method: download_and_extract 16:13:58 INFO - mkdir: /builds/slave/test/build/tests 16:13:58 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')]} 16:13:58 INFO - trying https://queue.taskcluster.net/v1/task/Slkje-RSToSGmGOKEXF4PA/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.test_packages.json 16:13:58 INFO - Downloading https://queue.taskcluster.net/v1/task/Slkje-RSToSGmGOKEXF4PA/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 16:13:58 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/Slkje-RSToSGmGOKEXF4PA/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 16:13:59 INFO - Downloaded 1361 bytes. 16:13:59 INFO - Reading from file /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.test_packages.json 16:13:59 INFO - Using the following test package requirements: 16:13:59 INFO - {u'common': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip'], 16:13:59 INFO - u'cppunittest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 16:13:59 INFO - u'firefox-51.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 16:13:59 INFO - u'gtest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 16:13:59 INFO - u'firefox-51.0a1.en-US.linux-x86_64.gtest.tests.zip'], 16:13:59 INFO - u'jittest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 16:13:59 INFO - u'jsshell-linux-x86_64.zip'], 16:13:59 INFO - u'mochitest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 16:13:59 INFO - u'firefox-51.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 16:13:59 INFO - u'mozbase': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip'], 16:13:59 INFO - u'reftest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 16:13:59 INFO - u'firefox-51.0a1.en-US.linux-x86_64.reftest.tests.zip'], 16:13:59 INFO - u'talos': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 16:13:59 INFO - u'firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip'], 16:13:59 INFO - u'web-platform': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 16:13:59 INFO - u'firefox-51.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 16:13:59 INFO - u'xpcshell': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 16:13:59 INFO - u'firefox-51.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 16:13:59 INFO - Downloading packages: [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 16:13:59 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')]} 16:13:59 INFO - trying https://queue.taskcluster.net/v1/task/Slkje-RSToSGmGOKEXF4PA/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip 16:13:59 INFO - Downloading https://queue.taskcluster.net/v1/task/Slkje-RSToSGmGOKEXF4PA/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 16:13:59 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/Slkje-RSToSGmGOKEXF4PA/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 16:14:00 INFO - Downloaded 21825644 bytes. 16:14:00 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'] 16:14:00 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 16:14:01 INFO - Return code: 0 16:14:01 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 16:14:01 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')]} 16:14:01 INFO - trying https://queue.taskcluster.net/v1/task/Slkje-RSToSGmGOKEXF4PA/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip 16:14:01 INFO - Downloading https://queue.taskcluster.net/v1/task/Slkje-RSToSGmGOKEXF4PA/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 16:14:01 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/Slkje-RSToSGmGOKEXF4PA/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 16:14:02 INFO - Downloaded 21825644 bytes. 16:14:02 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'] 16:14:02 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 16:14:04 INFO - Return code: 0 16:14:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:14:04 INFO - trying https://queue.taskcluster.net/v1/task/Slkje-RSToSGmGOKEXF4PA/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip 16:14:04 INFO - Downloading https://queue.taskcluster.net/v1/task/Slkje-RSToSGmGOKEXF4PA/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 16:14:04 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/Slkje-RSToSGmGOKEXF4PA/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 16:14:05 INFO - Downloaded 14413723 bytes. 16:14:05 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'] 16:14:05 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 16:14:06 INFO - Return code: 0 16:14:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:14:06 INFO - trying https://queue.taskcluster.net/v1/task/Slkje-RSToSGmGOKEXF4PA/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 16:14:06 INFO - Downloading https://queue.taskcluster.net/v1/task/Slkje-RSToSGmGOKEXF4PA/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 16:14:06 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/Slkje-RSToSGmGOKEXF4PA/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 16:14:09 INFO - Downloaded 59376220 bytes. 16:14:09 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/Slkje-RSToSGmGOKEXF4PA/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 16:14:09 INFO - mkdir: /builds/slave/test/properties 16:14:09 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 16:14:09 INFO - Writing to file /builds/slave/test/properties/build_url 16:14:09 INFO - Contents: 16:14:09 INFO - build_url:https://queue.taskcluster.net/v1/task/Slkje-RSToSGmGOKEXF4PA/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 16:14:10 INFO - Running post-action listener: _resource_record_post_action 16:14:10 INFO - Running post-action listener: set_extra_try_arguments 16:14:10 INFO - [mozharness: 2016-08-04 23:14:10.646129Z] Finished download-and-extract step (success) 16:14:10 INFO - [mozharness: 2016-08-04 23:14:10.646364Z] Running populate-webroot step. 16:14:10 INFO - Running pre-action listener: _resource_record_pre_action 16:14:10 INFO - Running main action method: populate_webroot 16:14:10 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 16:14:10 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 16:14:10 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 16:14:10 INFO - '--tppagecycles', 16:14:10 INFO - '7'], 16:14:10 INFO - 'tests': ['tsvgm']}}, 16:14:10 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 16:14:10 INFO - 'tests': ['tresize', 'tcanvasmark']}, 16:14:10 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 16:14:10 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 16:14:10 INFO - 'tests': ['dromaeo_css', 'kraken']}, 16:14:10 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 16:14:10 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:14:10 INFO - 'talos_options': ['--disable-e10s'], 16:14:10 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 16:14:10 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:14:10 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 16:14:10 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:14:10 INFO - 'talos_options': ['--disable-e10s'], 16:14:10 INFO - 'tests': ['damp', 'tps']}, 16:14:10 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:14:10 INFO - 'tests': ['damp', 'tps']}, 16:14:10 INFO - 'g3': {'talos_options': ['--disable-e10s'], 16:14:10 INFO - 'tests': ['dromaeo_dom']}, 16:14:10 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 16:14:10 INFO - 'g4': {'talos_options': ['--disable-e10s'], 16:14:10 INFO - 'tests': ['basic_compositor_video']}, 16:14:10 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 16:14:10 INFO - 'other': {'talos_options': ['--disable-e10s'], 16:14:10 INFO - 'tests': ['a11yr', 16:14:10 INFO - 'ts_paint', 16:14:10 INFO - 'tpaint', 16:14:10 INFO - 'sessionrestore', 16:14:10 INFO - 'sessionrestore_no_auto_restore', 16:14:10 INFO - 'tabpaint']}, 16:14:10 INFO - 'other-e10s': {'tests': ['a11yr', 16:14:10 INFO - 'ts_paint', 16:14:10 INFO - 'tpaint', 16:14:10 INFO - 'sessionrestore', 16:14:10 INFO - 'sessionrestore_no_auto_restore', 16:14:10 INFO - 'tabpaint']}, 16:14:10 INFO - 'other-e10s_l64': {'tests': ['a11yr', 16:14:10 INFO - 'ts_paint', 16:14:10 INFO - 'tpaint', 16:14:10 INFO - 'sessionrestore', 16:14:10 INFO - 'sessionrestore_no_auto_restore', 16:14:10 INFO - 'tabpaint']}, 16:14:10 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 16:14:10 INFO - 'ts_paint', 16:14:10 INFO - 'tpaint', 16:14:10 INFO - 'sessionrestore', 16:14:10 INFO - 'sessionrestore_no_auto_restore', 16:14:10 INFO - 'tabpaint']}, 16:14:10 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 16:14:10 INFO - 'tests': ['a11yr', 16:14:10 INFO - 'ts_paint', 16:14:10 INFO - 'tpaint', 16:14:10 INFO - 'sessionrestore', 16:14:10 INFO - 'sessionrestore_no_auto_restore', 16:14:10 INFO - 'tabpaint']}, 16:14:10 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 16:14:10 INFO - 'tests': ['a11yr', 16:14:10 INFO - 'ts_paint', 16:14:10 INFO - 'tpaint', 16:14:10 INFO - 'sessionrestore', 16:14:10 INFO - 'sessionrestore_no_auto_restore', 16:14:10 INFO - 'tabpaint']}, 16:14:10 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 16:14:10 INFO - 'tests': ['tsvgx', 16:14:10 INFO - 'tsvgr_opacity', 16:14:10 INFO - 'tart', 16:14:10 INFO - 'tscrollx', 16:14:10 INFO - 'cart']}, 16:14:10 INFO - 'svgr-e10s': {'tests': ['tsvgx', 16:14:10 INFO - 'tsvgr_opacity', 16:14:10 INFO - 'tart', 16:14:10 INFO - 'tscrollx', 16:14:10 INFO - 'cart']}, 16:14:10 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:14:10 INFO - 'talos_options': ['--disable-e10s'], 16:14:10 INFO - 'tests': ['tp5o']}, 16:14:10 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:14:10 INFO - 'tests': ['tp5o']}, 16:14:10 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:14:10 INFO - 'talos_options': ['--disable-e10s', 16:14:10 INFO - '--xperf_path', 16:14:10 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 16:14:10 INFO - 'tests': ['tp5n']}, 16:14:10 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:14:10 INFO - 'talos_options': ['--xperf_path', 16:14:10 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 16:14:10 INFO - 'tests': ['tp5n']}}, 16:14:10 INFO - 'talos.zip': {'path': '', 16:14:10 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 16:14:10 INFO - Running post-action listener: _resource_record_post_action 16:14:10 INFO - [mozharness: 2016-08-04 23:14:10.661794Z] Finished populate-webroot step (success) 16:14:10 INFO - [mozharness: 2016-08-04 23:14:10.661883Z] Running create-virtualenv step. 16:14:10 INFO - Running pre-action listener: _resource_record_pre_action 16:14:10 INFO - Running main action method: create_virtualenv 16:14:10 INFO - Creating virtualenv /builds/slave/test/build/venv 16:14:10 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 16:14:10 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 16:14:10 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 16:14:10 INFO - Using real prefix '/usr' 16:14:10 INFO - New python executable in /builds/slave/test/build/venv/bin/python 16:14:11 INFO - Installing distribute.............................................................................................................................................................................................done. 16:14:13 INFO - Installing pip.................done. 16:14:13 INFO - Return code: 0 16:14:13 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 16:14:13 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')]} 16:14:13 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:14:13 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:14:13 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')]} 16:14:13 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:14:13 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:14:13 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 0x282e030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29918a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2aef180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2aed3b0>, '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 0x2aee2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2aee740>, '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': '62c568580acbfdaac3eec7be000001dc-1470352422.749459-898834608', '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 16:14:13 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 16:14:13 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 16:14:13 INFO - Using env: {'DISPLAY': ':0', 16:14:13 INFO - 'HOME': '/home/cltbld', 16:14:13 INFO - 'LANG': 'en_US.UTF-8', 16:14:13 INFO - 'LANGUAGE': 'en_US:en', 16:14:13 INFO - 'LOGNAME': 'cltbld', 16:14:13 INFO - 'MAIL': '/var/mail/cltbld', 16:14:13 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:14:13 INFO - 'MOZ_NO_REMOTE': '1', 16:14:13 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:14:13 INFO - 'NO_EM_RESTART': '1', 16:14:13 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:14:13 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:14:13 INFO - 'PWD': '/builds/slave/test', 16:14:13 INFO - 'SHELL': '/bin/bash', 16:14:13 INFO - 'SHLVL': '1', 16:14:13 INFO - 'TERM': 'linux', 16:14:13 INFO - 'TMOUT': '86400', 16:14:13 INFO - 'USER': 'cltbld', 16:14:13 INFO - 'XDG_SESSION_COOKIE': '62c568580acbfdaac3eec7be000001dc-1470352422.749459-898834608', 16:14:13 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:14:13 INFO - '_': '/tools/buildbot/bin/python'} 16:14:13 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:14:13 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 16:14:13 INFO - Cleaning up... 16:14:13 INFO - Return code: 0 16:14:13 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 16:14:13 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')]} 16:14:13 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:14:13 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:14:13 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')]} 16:14:13 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:14:13 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:14:13 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 0x282e030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29918a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2aef180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2aed3b0>, '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 0x2aee2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2aee740>, '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': '62c568580acbfdaac3eec7be000001dc-1470352422.749459-898834608', '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 16:14:13 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 16:14:13 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 16:14:13 INFO - Using env: {'DISPLAY': ':0', 16:14:13 INFO - 'HOME': '/home/cltbld', 16:14:13 INFO - 'LANG': 'en_US.UTF-8', 16:14:13 INFO - 'LANGUAGE': 'en_US:en', 16:14:13 INFO - 'LOGNAME': 'cltbld', 16:14:13 INFO - 'MAIL': '/var/mail/cltbld', 16:14:13 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:14:13 INFO - 'MOZ_NO_REMOTE': '1', 16:14:13 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:14:13 INFO - 'NO_EM_RESTART': '1', 16:14:13 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:14:13 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:14:13 INFO - 'PWD': '/builds/slave/test', 16:14:13 INFO - 'SHELL': '/bin/bash', 16:14:13 INFO - 'SHLVL': '1', 16:14:13 INFO - 'TERM': 'linux', 16:14:13 INFO - 'TMOUT': '86400', 16:14:13 INFO - 'USER': 'cltbld', 16:14:13 INFO - 'XDG_SESSION_COOKIE': '62c568580acbfdaac3eec7be000001dc-1470352422.749459-898834608', 16:14:13 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:14:13 INFO - '_': '/tools/buildbot/bin/python'} 16:14:13 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:14:13 INFO - Downloading/unpacking psutil>=3.1.1 16:14:13 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 16:14:13 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 16:14:13 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 16:14:13 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 16:14:13 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 16:14:13 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 16:14:15 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 16:14:15 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 16:14:15 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 16:14:15 INFO - Installing collected packages: psutil 16:14:15 INFO - Running setup.py install for psutil 16:14:15 INFO - building 'psutil._psutil_linux' extension 16:14:15 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 16:14:15 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 16:14:15 INFO - building 'psutil._psutil_posix' extension 16:14:15 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 16:14:16 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 16:14:16 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 16:14:16 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 16:14:16 INFO - Successfully installed psutil 16:14:16 INFO - Cleaning up... 16:14:16 INFO - Return code: 0 16:14:16 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 16:14:16 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:14:16 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:14:16 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:14:16 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:14:16 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:14:16 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:14:16 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 0x282e030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29918a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2aef180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2aed3b0>, '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 0x2aee2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2aee740>, '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': '62c568580acbfdaac3eec7be000001dc-1470352422.749459-898834608', '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 16:14:16 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 16:14:16 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 16:14:16 INFO - Using env: {'DISPLAY': ':0', 16:14:16 INFO - 'HOME': '/home/cltbld', 16:14:16 INFO - 'LANG': 'en_US.UTF-8', 16:14:16 INFO - 'LANGUAGE': 'en_US:en', 16:14:16 INFO - 'LOGNAME': 'cltbld', 16:14:16 INFO - 'MAIL': '/var/mail/cltbld', 16:14:16 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:14:16 INFO - 'MOZ_NO_REMOTE': '1', 16:14:16 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:14:16 INFO - 'NO_EM_RESTART': '1', 16:14:16 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:14:16 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:14:16 INFO - 'PWD': '/builds/slave/test', 16:14:16 INFO - 'SHELL': '/bin/bash', 16:14:16 INFO - 'SHLVL': '1', 16:14:16 INFO - 'TERM': 'linux', 16:14:16 INFO - 'TMOUT': '86400', 16:14:16 INFO - 'USER': 'cltbld', 16:14:16 INFO - 'XDG_SESSION_COOKIE': '62c568580acbfdaac3eec7be000001dc-1470352422.749459-898834608', 16:14:16 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:14:16 INFO - '_': '/tools/buildbot/bin/python'} 16:14:16 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:14:16 INFO - Downloading/unpacking mozsystemmonitor==0.3 16:14:16 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 16:14:16 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 16:14:16 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 16:14:16 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 16:14:16 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 16:14:16 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 16:14:18 INFO - Downloading mozsystemmonitor-0.3.tar.gz 16:14:18 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 16:14:18 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 16:14:18 INFO - Installing collected packages: mozsystemmonitor 16:14:18 INFO - Running setup.py install for mozsystemmonitor 16:14:18 INFO - Successfully installed mozsystemmonitor 16:14:18 INFO - Cleaning up... 16:14:18 INFO - Return code: 0 16:14:18 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 16:14:18 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')]} 16:14:18 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:14:18 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:14:18 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')]} 16:14:18 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:14:18 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:14:18 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 0x282e030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29918a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2aef180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2aed3b0>, '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 0x2aee2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2aee740>, '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': '62c568580acbfdaac3eec7be000001dc-1470352422.749459-898834608', '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 16:14:18 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 16:14:18 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 16:14:18 INFO - Using env: {'DISPLAY': ':0', 16:14:18 INFO - 'HOME': '/home/cltbld', 16:14:18 INFO - 'LANG': 'en_US.UTF-8', 16:14:18 INFO - 'LANGUAGE': 'en_US:en', 16:14:18 INFO - 'LOGNAME': 'cltbld', 16:14:18 INFO - 'MAIL': '/var/mail/cltbld', 16:14:18 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:14:18 INFO - 'MOZ_NO_REMOTE': '1', 16:14:18 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:14:18 INFO - 'NO_EM_RESTART': '1', 16:14:18 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:14:18 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:14:18 INFO - 'PWD': '/builds/slave/test', 16:14:18 INFO - 'SHELL': '/bin/bash', 16:14:18 INFO - 'SHLVL': '1', 16:14:18 INFO - 'TERM': 'linux', 16:14:18 INFO - 'TMOUT': '86400', 16:14:18 INFO - 'USER': 'cltbld', 16:14:18 INFO - 'XDG_SESSION_COOKIE': '62c568580acbfdaac3eec7be000001dc-1470352422.749459-898834608', 16:14:18 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:14:18 INFO - '_': '/tools/buildbot/bin/python'} 16:14:18 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:14:18 INFO - Downloading/unpacking jsonschema==2.5.1 16:14:18 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 16:14:18 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 16:14:18 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 16:14:18 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 16:14:18 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 16:14:18 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 16:14:20 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 16:14:20 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 16:14:20 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:14:20 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:14:20 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:14:20 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:14:20 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:14:20 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:14:20 INFO - Downloading functools32-3.2.3-2.tar.gz 16:14:20 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 16:14:21 INFO - warning: no files found matching '*.txt' 16:14:21 INFO - no previously-included directories found matching 'build' 16:14:21 INFO - no previously-included directories found matching 'dist' 16:14:21 INFO - no previously-included directories found matching '.git*' 16:14:21 INFO - Installing collected packages: jsonschema, functools32 16:14:21 INFO - Running setup.py install for functools32 16:14:21 INFO - warning: no files found matching '*.txt' 16:14:21 INFO - no previously-included directories found matching 'build' 16:14:21 INFO - no previously-included directories found matching 'dist' 16:14:21 INFO - no previously-included directories found matching '.git*' 16:14:21 INFO - Successfully installed jsonschema functools32 16:14:21 INFO - Cleaning up... 16:14:21 INFO - Return code: 0 16:14:21 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 16:14:21 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:14:21 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:14:21 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:14:21 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:14:21 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:14:21 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:14:21 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x282e030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29918a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2aef180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2aed3b0>, '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 0x2aee2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2aee740>, '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': '62c568580acbfdaac3eec7be000001dc-1470352422.749459-898834608', '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 16:14:21 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2'] in /builds/slave/test/build 16:14:21 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 16:14:21 INFO - Using env: {'DISPLAY': ':0', 16:14:21 INFO - 'HOME': '/home/cltbld', 16:14:21 INFO - 'LANG': 'en_US.UTF-8', 16:14:21 INFO - 'LANGUAGE': 'en_US:en', 16:14:21 INFO - 'LOGNAME': 'cltbld', 16:14:21 INFO - 'MAIL': '/var/mail/cltbld', 16:14:21 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:14:21 INFO - 'MOZ_NO_REMOTE': '1', 16:14:21 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:14:21 INFO - 'NO_EM_RESTART': '1', 16:14:21 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:14:21 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:14:21 INFO - 'PWD': '/builds/slave/test', 16:14:21 INFO - 'SHELL': '/bin/bash', 16:14:21 INFO - 'SHLVL': '1', 16:14:21 INFO - 'TERM': 'linux', 16:14:21 INFO - 'TMOUT': '86400', 16:14:21 INFO - 'USER': 'cltbld', 16:14:21 INFO - 'XDG_SESSION_COOKIE': '62c568580acbfdaac3eec7be000001dc-1470352422.749459-898834608', 16:14:21 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:14:21 INFO - '_': '/tools/buildbot/bin/python'} 16:14:21 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:14:21 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 16:14:21 INFO - Cleaning up... 16:14:21 INFO - Return code: 0 16:14:21 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 16:14:21 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:14:21 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:14:21 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:14:21 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:14:21 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:14:21 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:14:21 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x282e030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29918a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2aef180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2aed3b0>, '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 0x2aee2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2aee740>, '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': '62c568580acbfdaac3eec7be000001dc-1470352422.749459-898834608', '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 16:14:21 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 16:14:21 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 16:14:21 INFO - Using env: {'DISPLAY': ':0', 16:14:21 INFO - 'HOME': '/home/cltbld', 16:14:21 INFO - 'LANG': 'en_US.UTF-8', 16:14:21 INFO - 'LANGUAGE': 'en_US:en', 16:14:21 INFO - 'LOGNAME': 'cltbld', 16:14:21 INFO - 'MAIL': '/var/mail/cltbld', 16:14:21 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:14:21 INFO - 'MOZ_NO_REMOTE': '1', 16:14:21 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:14:21 INFO - 'NO_EM_RESTART': '1', 16:14:21 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:14:21 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:14:21 INFO - 'PWD': '/builds/slave/test', 16:14:21 INFO - 'SHELL': '/bin/bash', 16:14:21 INFO - 'SHLVL': '1', 16:14:21 INFO - 'TERM': 'linux', 16:14:21 INFO - 'TMOUT': '86400', 16:14:21 INFO - 'USER': 'cltbld', 16:14:21 INFO - 'XDG_SESSION_COOKIE': '62c568580acbfdaac3eec7be000001dc-1470352422.749459-898834608', 16:14:21 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:14:21 INFO - '_': '/tools/buildbot/bin/python'} 16:14:21 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:14:21 INFO - Downloading/unpacking blobuploader==1.2.4 16:14:21 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:14:21 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:14:21 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:14:21 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:14:21 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:14:21 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:14:23 INFO - Downloading blobuploader-1.2.4.tar.gz 16:14:23 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 16:14:23 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 16:14:23 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 16:14:23 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 16:14:23 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 16:14:23 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 16:14:23 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 16:14:23 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 16:14:23 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 16:14:24 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 16:14:24 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:14:24 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:14:24 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:14:24 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:14:24 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:14:24 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:14:24 INFO - Downloading docopt-0.6.1.tar.gz 16:14:24 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 16:14:24 INFO - Installing collected packages: blobuploader, requests, docopt 16:14:24 INFO - Running setup.py install for blobuploader 16:14:24 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 16:14:24 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 16:14:24 INFO - Running setup.py install for requests 16:14:24 INFO - Running setup.py install for docopt 16:14:24 INFO - Successfully installed blobuploader requests docopt 16:14:24 INFO - Cleaning up... 16:14:24 INFO - Return code: 0 16:14:24 INFO - Installing None into virtualenv /builds/slave/test/build/venv 16:14:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:14:24 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:14:24 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:14:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:14:24 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:14:24 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:14:24 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 0x282e030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29918a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2aef180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2aed3b0>, '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 0x2aee2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2aee740>, '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': '62c568580acbfdaac3eec7be000001dc-1470352422.749459-898834608', '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 16:14:24 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 16:14:24 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 16:14:24 INFO - Using env: {'DISPLAY': ':0', 16:14:24 INFO - 'HOME': '/home/cltbld', 16:14:24 INFO - 'LANG': 'en_US.UTF-8', 16:14:24 INFO - 'LANGUAGE': 'en_US:en', 16:14:24 INFO - 'LOGNAME': 'cltbld', 16:14:24 INFO - 'MAIL': '/var/mail/cltbld', 16:14:24 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:14:24 INFO - 'MOZ_NO_REMOTE': '1', 16:14:24 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:14:24 INFO - 'NO_EM_RESTART': '1', 16:14:24 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:14:24 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:14:24 INFO - 'PWD': '/builds/slave/test', 16:14:24 INFO - 'SHELL': '/bin/bash', 16:14:24 INFO - 'SHLVL': '1', 16:14:24 INFO - 'TERM': 'linux', 16:14:24 INFO - 'TMOUT': '86400', 16:14:24 INFO - 'USER': 'cltbld', 16:14:24 INFO - 'XDG_SESSION_COOKIE': '62c568580acbfdaac3eec7be000001dc-1470352422.749459-898834608', 16:14:24 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:14:24 INFO - '_': '/tools/buildbot/bin/python'} 16:14:25 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:14:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 16:14:25 INFO - Running setup.py (path:/tmp/pip-50dECk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 16:14:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 16:14:25 INFO - Running setup.py (path:/tmp/pip-0kFKXc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 16:14:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 16:14:25 INFO - Running setup.py (path:/tmp/pip-RpaVaJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 16:14:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 16:14:25 INFO - Running setup.py (path:/tmp/pip-y6qP3K-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 16:14:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 16:14:25 INFO - Running setup.py (path:/tmp/pip-2SHaCe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 16:14:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 16:14:25 INFO - Running setup.py (path:/tmp/pip-2TPPhj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 16:14:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 16:14:25 INFO - Running setup.py (path:/tmp/pip-bu2thn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 16:14:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 16:14:25 INFO - Running setup.py (path:/tmp/pip-mv3kRA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 16:14:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 16:14:25 INFO - Running setup.py (path:/tmp/pip-oy1Xyr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 16:14:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 16:14:25 INFO - Running setup.py (path:/tmp/pip-ofwMxE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 16:14:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 16:14:25 INFO - Running setup.py (path:/tmp/pip-jAWXKK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 16:14:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 16:14:25 INFO - Running setup.py (path:/tmp/pip-J8V4DN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 16:14:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 16:14:26 INFO - Running setup.py (path:/tmp/pip-hNbsIx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 16:14:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 16:14:26 INFO - Running setup.py (path:/tmp/pip-ZjwtTw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 16:14:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 16:14:26 INFO - Running setup.py (path:/tmp/pip-IfdeTm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 16:14:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 16:14:26 INFO - Running setup.py (path:/tmp/pip-CMLQQF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 16:14:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 16:14:26 INFO - Running setup.py (path:/tmp/pip-rsoKRE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 16:14:26 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 16:14:26 INFO - Running setup.py install for manifestparser 16:14:26 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 16:14:26 INFO - Running setup.py install for mozcrash 16:14:26 INFO - Running setup.py install for mozdebug 16:14:26 INFO - Running setup.py install for mozdevice 16:14:26 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 16:14:26 INFO - Installing dm script to /builds/slave/test/build/venv/bin 16:14:26 INFO - Running setup.py install for mozfile 16:14:26 INFO - Running setup.py install for mozhttpd 16:14:27 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 16:14:27 INFO - Running setup.py install for mozinfo 16:14:27 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 16:14:27 INFO - Running setup.py install for mozInstall 16:14:27 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 16:14:27 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 16:14:27 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 16:14:27 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 16:14:27 INFO - Running setup.py install for mozleak 16:14:27 INFO - Running setup.py install for mozlog 16:14:27 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 16:14:27 INFO - Running setup.py install for moznetwork 16:14:27 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 16:14:27 INFO - Running setup.py install for mozprocess 16:14:27 INFO - Running setup.py install for mozprofile 16:14:27 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 16:14:27 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 16:14:27 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 16:14:27 INFO - Running setup.py install for mozrunner 16:14:27 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 16:14:27 INFO - Running setup.py install for mozscreenshot 16:14:27 INFO - Running setup.py install for moztest 16:14:28 INFO - Running setup.py install for mozversion 16:14:28 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 16:14:28 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 16:14:28 INFO - Cleaning up... 16:14:28 INFO - Return code: 0 16:14:28 INFO - Installing None into virtualenv /builds/slave/test/build/venv 16: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')]} 16:14:28 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:14:28 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16: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')]} 16:14:28 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:14:28 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:14:28 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 0x282e030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29918a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2aef180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2aed3b0>, '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 0x2aee2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2aee740>, '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': '62c568580acbfdaac3eec7be000001dc-1470352422.749459-898834608', '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 16:14:28 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 16:14:28 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 16:14:28 INFO - Using env: {'DISPLAY': ':0', 16:14:28 INFO - 'HOME': '/home/cltbld', 16:14:28 INFO - 'LANG': 'en_US.UTF-8', 16:14:28 INFO - 'LANGUAGE': 'en_US:en', 16:14:28 INFO - 'LOGNAME': 'cltbld', 16:14:28 INFO - 'MAIL': '/var/mail/cltbld', 16:14:28 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:14:28 INFO - 'MOZ_NO_REMOTE': '1', 16:14:28 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:14:28 INFO - 'NO_EM_RESTART': '1', 16:14:28 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:14:28 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:14:28 INFO - 'PWD': '/builds/slave/test', 16:14:28 INFO - 'SHELL': '/bin/bash', 16:14:28 INFO - 'SHLVL': '1', 16:14:28 INFO - 'TERM': 'linux', 16:14:28 INFO - 'TMOUT': '86400', 16:14:28 INFO - 'USER': 'cltbld', 16:14:28 INFO - 'XDG_SESSION_COOKIE': '62c568580acbfdaac3eec7be000001dc-1470352422.749459-898834608', 16:14:28 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:14:28 INFO - '_': '/tools/buildbot/bin/python'} 16:14:28 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:14:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 16:14:28 INFO - Running setup.py (path:/tmp/pip-zpC83A-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 16:14:28 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)) 16:14:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 16:14:28 INFO - Running setup.py (path:/tmp/pip-oopU_v-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 16:14:28 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)) 16:14:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 16:14:28 INFO - Running setup.py (path:/tmp/pip-mm5Eeu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 16:14:28 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)) 16:14:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 16:14:28 INFO - Running setup.py (path:/tmp/pip-7YZVX9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 16:14:28 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)) 16:14:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 16:14:28 INFO - Running setup.py (path:/tmp/pip-kvFMlS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 16:14:28 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)) 16:14:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 16:14:28 INFO - Running setup.py (path:/tmp/pip-3d8EFW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 16:14:28 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)) 16:14:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 16:14:28 INFO - Running setup.py (path:/tmp/pip-vJPDy3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 16:14:28 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)) 16:14:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 16:14:28 INFO - Running setup.py (path:/tmp/pip-KgGRBq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 16:14:28 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)) 16:14:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 16:14:28 INFO - Running setup.py (path:/tmp/pip-mom3KI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 16:14:29 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 16:14:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 16:14:29 INFO - Running setup.py (path:/tmp/pip-wwC3ga-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 16:14:29 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)) 16:14:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 16:14:29 INFO - Running setup.py (path:/tmp/pip-BD90pH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 16:14:29 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)) 16:14:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 16:14:29 INFO - Running setup.py (path:/tmp/pip-aI_4lB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 16:14:29 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)) 16:14:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 16:14:29 INFO - Running setup.py (path:/tmp/pip-b8I7hw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 16:14:29 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)) 16:14:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 16:14:29 INFO - Running setup.py (path:/tmp/pip-cFnNDF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 16:14:29 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)) 16:14:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 16:14:29 INFO - Running setup.py (path:/tmp/pip-9WPNxx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 16:14:29 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)) 16:14:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 16:14:29 INFO - Running setup.py (path:/tmp/pip-f4_56C-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 16:14:29 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)) 16:14:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 16:14:29 INFO - Running setup.py (path:/tmp/pip-FYDZ_a-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 16:14:29 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)) 16:14:29 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)) 16:14:29 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)) 16:14:29 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)) 16:14:29 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)) 16:14:29 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)) 16:14:29 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.3->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 16:14:29 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:14:29 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:14:29 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:14:29 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:14:29 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:14:29 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:14:31 INFO - Downloading blessings-1.6.tar.gz 16:14:31 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 16:14:31 INFO - Installing collected packages: blessings 16:14:31 INFO - Running setup.py install for blessings 16:14:31 INFO - Successfully installed blessings 16:14:31 INFO - Cleaning up... 16:14:32 INFO - Return code: 0 16:14:32 INFO - Done creating virtualenv /builds/slave/test/build/venv. 16:14:32 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 16:14:32 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 16:14:32 INFO - Reading from file tmpfile_stdout 16:14:32 INFO - Current package versions: 16:14:32 INFO - argparse == 1.2.1 16:14:32 INFO - blessings == 1.6 16:14:32 INFO - blobuploader == 1.2.4 16:14:32 INFO - docopt == 0.6.1 16:14:32 INFO - functools32 == 3.2.3-2 16:14:32 INFO - jsonschema == 2.5.1 16:14:32 INFO - manifestparser == 1.1 16:14:32 INFO - mozInstall == 1.12 16:14:32 INFO - mozcrash == 0.17 16:14:32 INFO - mozdebug == 0.1 16:14:32 INFO - mozdevice == 0.48 16:14:32 INFO - mozfile == 1.2 16:14:32 INFO - mozhttpd == 0.7 16:14:32 INFO - mozinfo == 0.9 16:14:32 INFO - mozleak == 0.1 16:14:32 INFO - mozlog == 3.3 16:14:32 INFO - moznetwork == 0.27 16:14:32 INFO - mozprocess == 0.23 16:14:32 INFO - mozprofile == 0.28 16:14:32 INFO - mozrunner == 6.12 16:14:32 INFO - mozscreenshot == 0.1 16:14:32 INFO - mozsystemmonitor == 0.3 16:14:32 INFO - moztest == 0.7 16:14:32 INFO - mozversion == 1.4 16:14:32 INFO - psutil == 3.1.1 16:14:32 INFO - requests == 1.2.3 16:14:32 INFO - wsgiref == 0.1.2 16:14:32 INFO - Installing None into virtualenv /builds/slave/test/build/venv 16: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')]} 16:14:32 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:14:32 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16: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')]} 16:14:32 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:14:32 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:14:32 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x282e030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29918a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2aef180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2aed3b0>, '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 0x2aee2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2aee740>, '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': '62c568580acbfdaac3eec7be000001dc-1470352422.749459-898834608', '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 16:14:32 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 16:14:32 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 16:14:32 INFO - Using env: {'DISPLAY': ':0', 16:14:32 INFO - 'HOME': '/home/cltbld', 16:14:32 INFO - 'LANG': 'en_US.UTF-8', 16:14:32 INFO - 'LANGUAGE': 'en_US:en', 16:14:32 INFO - 'LOGNAME': 'cltbld', 16:14:32 INFO - 'MAIL': '/var/mail/cltbld', 16:14:32 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:14:32 INFO - 'MOZ_NO_REMOTE': '1', 16:14:32 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:14:32 INFO - 'NO_EM_RESTART': '1', 16:14:32 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:14:32 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:14:32 INFO - 'PWD': '/builds/slave/test', 16:14:32 INFO - 'SHELL': '/bin/bash', 16:14:32 INFO - 'SHLVL': '1', 16:14:32 INFO - 'TERM': 'linux', 16:14:32 INFO - 'TMOUT': '86400', 16:14:32 INFO - 'USER': 'cltbld', 16:14:32 INFO - 'XDG_SESSION_COOKIE': '62c568580acbfdaac3eec7be000001dc-1470352422.749459-898834608', 16:14:32 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:14:32 INFO - '_': '/tools/buildbot/bin/python'} 16:14:32 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:14:32 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)) 16:14:32 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)) 16:14:32 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)) 16:14:32 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)) 16:14:32 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)) 16:14:32 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)) 16:14:32 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)) 16:14:32 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)) 16:14:32 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)) 16:14:32 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)) 16:14:32 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)) 16:14:32 INFO - Cleaning up... 16:14:32 INFO - Return code: 0 16:14:32 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 16: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')]} 16:14:32 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:14:32 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16: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')]} 16:14:32 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:14:32 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:14:32 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 0x282e030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29918a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2aef180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2aed3b0>, '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 0x2aee2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2aee740>, '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': '62c568580acbfdaac3eec7be000001dc-1470352422.749459-898834608', '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 16:14:32 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 16:14:32 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 16:14:32 INFO - Using env: {'DISPLAY': ':0', 16:14:32 INFO - 'HOME': '/home/cltbld', 16:14:32 INFO - 'LANG': 'en_US.UTF-8', 16:14:32 INFO - 'LANGUAGE': 'en_US:en', 16:14:32 INFO - 'LOGNAME': 'cltbld', 16:14:32 INFO - 'MAIL': '/var/mail/cltbld', 16:14:32 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:14:32 INFO - 'MOZ_NO_REMOTE': '1', 16:14:32 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:14:32 INFO - 'NO_EM_RESTART': '1', 16:14:32 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:14:32 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:14:32 INFO - 'PWD': '/builds/slave/test', 16:14:32 INFO - 'SHELL': '/bin/bash', 16:14:32 INFO - 'SHLVL': '1', 16:14:32 INFO - 'TERM': 'linux', 16:14:32 INFO - 'TMOUT': '86400', 16:14:32 INFO - 'USER': 'cltbld', 16:14:32 INFO - 'XDG_SESSION_COOKIE': '62c568580acbfdaac3eec7be000001dc-1470352422.749459-898834608', 16:14:32 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:14:32 INFO - '_': '/tools/buildbot/bin/python'} 16:14:32 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:14:32 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 16:14:32 INFO - Cleaning up... 16:14:32 INFO - Return code: 0 16:14:32 INFO - Running post-action listener: _resource_record_post_action 16:14:32 INFO - Running post-action listener: _start_resource_monitoring 16:14:32 INFO - Starting resource monitoring. 16:14:32 INFO - [mozharness: 2016-08-04 23:14:32.674544Z] Finished create-virtualenv step (success) 16:14:32 INFO - [mozharness: 2016-08-04 23:14:32.674979Z] Running install step. 16:14:32 INFO - Running pre-action listener: _resource_record_pre_action 16:14:32 INFO - Running main action method: install 16:14:32 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 16:14:32 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 16:14:32 INFO - Reading from file tmpfile_stdout 16:14:32 INFO - Detecting whether we're running mozinstall >=1.0... 16:14:32 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 16:14:32 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 16:14:32 INFO - Reading from file tmpfile_stdout 16:14:32 INFO - Output received: 16:14:32 INFO - Usage: mozinstall [options] installer 16:14:32 INFO - Options: 16:14:32 INFO - -h, --help show this help message and exit 16:14:32 INFO - -d DEST, --destination=DEST 16:14:32 INFO - Directory to install application into. [default: 16:14:32 INFO - "/builds/slave/test"] 16:14:32 INFO - --app=APP Application being installed. [default: firefox] 16:14:32 INFO - mkdir: /builds/slave/test/build/application 16:14:32 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'] 16:14:32 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 16:14:49 INFO - Reading from file tmpfile_stdout 16:14:49 INFO - Output received: 16:14:49 INFO - /builds/slave/test/build/application/firefox/firefox 16:14:49 INFO - Running post-action listener: _resource_record_post_action 16:14:49 INFO - [mozharness: 2016-08-04 23:14:49.831120Z] Finished install step (success) 16:14:49 INFO - [mozharness: 2016-08-04 23:14:49.831366Z] Running run-tests step. 16:14:49 INFO - Running pre-action listener: _resource_record_pre_action 16:14:49 INFO - Running main action method: run_tests 16:14:49 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 16:14:49 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 16:14:49 INFO - Python 2.7.3 16:14:49 INFO - Return code: 0 16:14:49 INFO - grabbing minidump binary from tooltool 16:14:49 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')]} 16:14:49 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 0x2aed3b0>, '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 0x2aee2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2aee740>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 16:14:49 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 16:14:49 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 16:14:49 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 16:14:49 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 16:14:49 INFO - Return code: 0 16:14:49 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 16:14:49 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 16:14:49 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 16:14:49 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 16:14:49 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 16:14:49 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', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/Slkje-RSToSGmGOKEXF4PA/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-018', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] in /builds/slave/test/build 16:14:49 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 --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/Slkje-RSToSGmGOKEXF4PA/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-018 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log 16:14:49 INFO - Using env: {'DISPLAY': ':0', 16:14:49 INFO - 'HOME': '/home/cltbld', 16:14:49 INFO - 'LANG': 'en_US.UTF-8', 16:14:49 INFO - 'LANGUAGE': 'en_US:en', 16:14:49 INFO - 'LOGNAME': 'cltbld', 16:14:49 INFO - 'MAIL': '/var/mail/cltbld', 16:14:49 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 16:14:49 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 16:14:49 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:14:49 INFO - 'MOZ_NO_REMOTE': '1', 16:14:49 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 16:14:49 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:14:49 INFO - 'NO_EM_RESTART': '1', 16:14:49 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:14:49 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:14:49 INFO - 'PWD': '/builds/slave/test', 16:14:49 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 16:14:49 INFO - 'SHELL': '/bin/bash', 16:14:49 INFO - 'SHLVL': '1', 16:14:49 INFO - 'TERM': 'linux', 16:14:49 INFO - 'TMOUT': '86400', 16:14:49 INFO - 'USER': 'cltbld', 16:14:49 INFO - 'XDG_SESSION_COOKIE': '62c568580acbfdaac3eec7be000001dc-1470352422.749459-898834608', 16:14:49 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:14:49 INFO - '_': '/tools/buildbot/bin/python'} 16:14:49 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Inbound', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/Slkje-RSToSGmGOKEXF4PA/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-018', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] with output_timeout 3600 16:14:50 INFO - mozversion application_buildid: 20160804133004 16:14:50 INFO - mozversion application_changeset: be293e09860eafd2de5482227ae00ac2f3b0acfb 16:14:50 INFO - mozversion application_display_name: Nightly 16:14:50 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 16:14:50 INFO - mozversion application_name: Firefox 16:14:50 INFO - mozversion application_remotingname: firefox 16:14:50 INFO - mozversion application_repository: https://hg.mozilla.org/integration/mozilla-inbound 16:14:50 INFO - mozversion application_vendor: Mozilla 16:14:50 INFO - mozversion application_version: 51.0a1 16:14:50 INFO - mozversion platform_buildid: 20160804133004 16:14:50 INFO - mozversion platform_changeset: be293e09860eafd2de5482227ae00ac2f3b0acfb 16:14:50 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/mozilla-inbound 16:14:50 INFO - mozversion platform_version: 51.0a1 16:14:50 INFO - using testdate: 1470352490 16:14:50 INFO - actual date: 1470352490 16:14:50 INFO - starting webserver on 'localhost:55193' 16:14:50 INFO - SUITE-START | Running 2 tests 16:14:50 INFO - TEST-START | dromaeo_css 16:14:50 INFO - operating with platform_type : linux_ 16:14:50 INFO - Initialising browser for dromaeo_css test... 16:14:50 INFO - TEST-INFO | started process 14475 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp5wXb4S/profile http://localhost:55193/getInfo.html) 16:14:53 INFO - PROCESS | 14475 | __metrics Screen width/height:1600/1200 16:14:53 INFO - PROCESS | 14475 | colorDepth:24 16:14:53 INFO - PROCESS | 14475 | Browser inner width/height: 1024/697 16:14:53 INFO - PROCESS | 14475 | __metrics 16:14:54 INFO - PROCESS | 14475 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 693: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 16:14:54 INFO - PROCESS | 14475 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 122: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 16:14:55 INFO - TEST-INFO | 14475: exit 0 16:14:55 INFO - Browser initialized. 16:14:55 INFO - Running cycle 1/1 for dromaeo_css test... 16:14:55 INFO - TEST-INFO | started process 14555 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp5wXb4S/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 16:15:07 INFO - PROCESS | 14555 | RSS: Main: 156385280 16:15:07 INFO - PROCESS | 14555 | 16:15:59 INFO - PROCESS | 14555 | 1470352559011 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] 16:18:07 INFO - PROCESS | 14555 | Cycle 1(1): loaded http://localhost:55193/tests/dromaeo/cssquery-dojo.html (next: http://localhost:55193/tests/dromaeo/cssquery-ext.html) 16:18:09 INFO - PROCESS | 14555 | RSS: Main: 240021504 16:18:09 INFO - PROCESS | 14555 | 16:21:11 INFO - PROCESS | 14555 | Cycle 1(1): loaded http://localhost:55193/tests/dromaeo/cssquery-ext.html (next: http://localhost:55193/tests/dromaeo/cssquery-jquery.html) 16:21:12 INFO - PROCESS | 14555 | RSS: Main: 247377920 16:21:12 INFO - PROCESS | 14555 | 16:24:13 INFO - PROCESS | 14555 | Cycle 1(1): loaded http://localhost:55193/tests/dromaeo/cssquery-jquery.html (next: http://localhost:55193/tests/dromaeo/cssquery-mootools.html) 16:24:14 INFO - PROCESS | 14555 | RSS: Main: 244621312 16:24:14 INFO - PROCESS | 14555 | 16:27:16 INFO - PROCESS | 14555 | Cycle 1(1): loaded http://localhost:55193/tests/dromaeo/cssquery-mootools.html (next: http://localhost:55193/tests/dromaeo/cssquery-prototype.html) 16:27:17 INFO - PROCESS | 14555 | RSS: Main: 185499648 16:27:17 INFO - PROCESS | 14555 | 16:30:19 INFO - PROCESS | 14555 | Cycle 1(1): loaded http://localhost:55193/tests/dromaeo/cssquery-prototype.html (next: http://localhost:55193/tests/dromaeo/cssquery-yui.html) 16:30:20 INFO - PROCESS | 14555 | RSS: Main: 185503744 16:30:20 INFO - PROCESS | 14555 | 16:33:23 INFO - PROCESS | 14555 | Cycle 1(1): loaded http://localhost:55193/tests/dromaeo/cssquery-yui.html (next: http://localhost:55193/tests/dromaeo/cssquery-dojo.html) 16:33:23 INFO - PROCESS | 14555 | RSS: Main: 275148800 16:33:23 INFO - PROCESS | 14555 | 16:33:23 INFO - PROCESS | 14555 | __start_tp_report 16:33:23 INFO - PROCESS | 14555 | _x_x_mozilla_page_load 16:33:23 INFO - PROCESS | 14555 | _x_x_mozilla_page_load_details 16:33:23 INFO - PROCESS | 14555 | |i|pagename|runs| 16:33:23 INFO - PROCESS | 14555 | |0;dojo.html;2993.6407631084267;3002.4895767719486;3031.590735250741;3042.9847850760743;3054.755619550436;5181.4300426953005;5220.6084543659235;5279.4984476474765;5311.60162987776;5354.143337066075;5259.789608415668;5259.894802103956;5306.310179676646;5307.973460132704;5326.147816349385;4754.286856971465;4802.687825291362;4823.951760482403;4830.589399900995;4983.401991760976;4890.951090489103;4898.902021959559;4926.334944782444;4944.629152813535;4948.777305021283;4731.78706958186;4739.857804265843;4794.448638406593;4803.639727020487;4887.16918123918;4799.712017278975;4806;4812.374391329105;4817.9036419271415;4920.188168952119;4821.421429428491;4842.685225460334;4843.709377437365;4855.101806165835;4887.413510378742;5163.225516172567;5179.2749015137915;5193.272941788153;5195.090859099642;5312.335958005249;5546.112621980504;5587.8603034924045;5603.551715862721;5605.467480589337;5613.635113717636;5585.218069470277;5636.239107720447;5637.8590535236535;5641.351244606841;5651.237082993825;5103.9489605103845;5123.103456895028;5166.974165129151;5170.896582068338;5242.842714718565;5675.3757086720425;5736.483716465538;5737.655740655574;5738.741756620962;5740.684262365527;5451.454854514517;5459.863503412446;5500.944990550123;5501.724913754297;5513.035218836688;5455.509004189642;5508.614396992172;5552.7223638817895;5562.694051827108;5636.915446268309;5563.304586926634;5564.221009058735;5566.109422492382;5571.470710282517;5571.972140139354;5529.364123125812;5565.970295495346;5580.023495888203;5580.218769372291;5634.239377684042;4246.129543443587;4249.405083288342;4295.463067116548;4299.548547402478;4306.074194048295;3853.2293541291856;3866.980665096713;3872.8450861965207;3897.6686981606313;3903.843846246175;5245.790168393298;5268.947310526923;5272.261883336336;5299.894002120013;5314.388845282765;5594.356648985418;5601.187827764951;5609.747561359749;5620.072688006515;5668.064769313017;5042.319286896222;5232.3982741985155;5289.550388217045;5295.12630415977;5305.469453054664;4834.178189707688;4851.757412129379;4886.29148773433;4890.682105663121;4926.704397736147;5900.793472228452;5905.527557795452;5908.763649454059;5909.172715819789;5914.8817023659285;5430.266913966564;5557.944420555743;5666.263385759825;5669.518090962314;5709.914351284651;5786.334571524329;5880.852978675567;5895.764169433174;5915.645061296336;5927.8221653350465;5523.088690366045;5523.171524271231;5527.723613819373;5531.976584331912;5535.557155427476;5457.454254574511;5565.888682226414;5590.468905453975;5602.775888964396;5616.634918730269;5490.588205884655;5522.889542209214;5535.750891209986;5554.722263886871;5613.045782217115;5506.807261745819;5518.586106041983;5552.361478430033;5559.24950131727;5568.16477528374;5265.3944796348915;5485.451454854483;5498;5499.642523235977;5542.61201715876;5498.972505137449;5543.8891222176135;5552.3892371839875;5569.415211402745;5628.212050313042;5445.1832225166545;5460.836174914759;5461.426550212171;5462.3445186577865;5463.125899856004 16:33:23 INFO - PROCESS | 14555 | |1;ext.html;590.7755053079832;603.6981509245377;611.5871786544081;631.9083732858738;637.6014990630854;33503.497447538306;44206.33690494645;45141.32288015674;45291.77354113225;45338.31992520115;46521;46932.53067469324;46952.76523617386;46998.29502557465;47160.76419617897;9002.504862232574;9119.589618467151;9124.041975592567;9132.452052876815;9132.589033493476;9051.728448146567;9131.497767622777;9131.771705707344;9134;9139.405938613969;9115.726528204164;9170;9174.724758257264;9176.541172941326;9180.036096209902;9109.908900910972;9127.087291270886;9150.359474836798;9160.992290848002;9162.083791620851;8936.195742383152;9023.142801433853;9028.277737780962;9028.368014239006;9045.909540904573;43011;43445.782771086255;43467.130657386675;43472.17430866983;43485.56514434847;3456.0668619472603;3489.2498112905846;3709.3879509880835;3944.250592387466;4073.5926407359325;32819.34361312784;33282.500762488584;33289.3342133156;33643.83178084094;35109.47335789965;4085.5097388313593;4171.311733563958;4272.530021697611;4308.332208507655;4417.580329868657;384245;391325;392797;393882;395207;53540.46459535433;62507.687461562404;63189.36810631927;63209;63304;55150;58255.70872145612;58295.41704582985;62626;64495.35504644988;15932.761008584881;16110.516684499484;16188.75716864248;16239.675206495804;16268.186590670419;12240.387980600934;12294.815577766341;12304.876951230373;12346.259224446561;12351;17316.913415432842;19228.0031132085;19446.18133095126;19477.375644333202;19477.718023400277;6280.623162610166;7367.4106071515225;7440.627968601549;7530.698772049166;7612.619369031526;968.1673760565908;1050.3802756373775;1089.0090018083506;1097.5609756097465;1121.5755989892791;33575.83212083924;34020.829895850366;34029;34157.48763768545;34552;1099.7525556749667;1154.8325492803497;1160.5995931403652;1160.651804458676;1168.9415529223504;17297.394591189248;17364.739528907077;17770.200340984688;17784.46646600604;17795;567411;570865;572435;578429;582495;61895.69052154801;62592.37407625956;62593.37406625967;62651.37348626547;62661.686691566254;1321.8876395506297;1342.3422522963679;1361.7140400516003;1370.294298436306;1390.3534856291874;31538.684613153575;33474.66525334716;33636.1590960228;33650.83174584111;34059.65940340565;53910.46089539054;54347.456525435824;54353;54488;54544.454555453936;483270;486222;486228;487084;487426;26126;29625.703742962294;30024.099277021724;42375.152496950504;45887.311690324;41782;43675.77803802306;51866.22200666917;52375;52804.47195527996;41040.38439423471;41101.588984110975;43848.34227486527;43888.561114388445;45390.00709921972;43932.78033609811;44870.312569781534;44927.32609010933;45218.32172517481;45643;44511;44854.3271850929;44971;45311;46076.30885536653;37421.43867842039;39457;39676.404853927794;39839.402408964466;40170.59829401669;29089.272768180967;29774.702252977193;30021.249468763457;30061;30074.54888176723 16:33:23 INFO - PROCESS | 14555 | |2;jquery.html;370.93137769512623;373.3857803912564;397.19567875053025;404.0585435934273;416.6416881481925;16999.575010624725;19946.60106797863;19958.50103747407;20227.292044778435;20749;19556.804431955676;19625.11686974086;19984.400467985983;20160.495987600316;20179;5189.6886186828915;5541.445855414467;5866.941330586682;5884.146798714184;5910.61580997236;5766.394528574502;5839.824805255849;5844.707764611774;5845.09401042839;5848.707564621752;5569.248151499536;5719.542436605062;5736.770529178828;5737.770489180428;5818.738156782955;5591.329040515124;5627.999999999979;5649.68926709035;5657.773689052433;5659.037963546207;5058.721770302632;5165.121929271995;5166.948330516684;5202.531772140488;5220.216967454912;20468.078936447895;20852.791472085235;24012.759872401228;24345.513089738106;24361.14735984232;2349.941251468727;2352.6588644646604;2411.3489357873277;2430.3559556717482;2444.779969802726;14217.289135543182;14290.356933937894;14439.494617688435;15501.844981550266;15878.36486540537;1833.8441232495254;1907.0845993922994;1908.2271679969635;1928.2961718972474;1986.5728868293243;83665.69104398256;85078;86347;86973.99999999937;87416;10795.19036072282;10801.83797243042;10948.835767463494;11152.553897844158;11325.773484530264;15268.465603703817;15269;15269.312880920384;15282.235888205545;15293.082415055133;7852.136265010844;8099.311558517474;8102.716404925799;8193.71322003727;8268.049174344907;7573.924260757432;7574.166841647414;7839.725609603751;7844.411669124838;7865.685372585147;6774.424173945171;6829.180498340231;6878.415334696507;6882.4149947254045;6905.37851593359;1871.410505690703;1891.3569386408687;1891.8675692701654;1973.9802601973797;2003.8897860617806;902.2421166220406;921.4149015375151;1025.3950169400089;1049.968500944973;1092.819684752023;19768;20224.69662955057;20313.187472500933;20348.89825550863;20665.89667051655;943.6131186213756;971.6987733802544;984.9212063035084;1028.3161697471098;1055.7360659835042;10656.467176641137;10777.89222107769;10799.460026998619;11211.9348661877;11490.482928268248;414326;423664;519370;534572;537881;53058;65475.67262163754;97660;97897.51051244698;101461;1003.6437064841876;1048.046277887119;1054.641421916552;1069.6844430892904;1074.3768614203743;17367.47897563075;17737.113144342988;18044.54888627795;18126.909365453088;18604.34884779026;44162;44455.77772111119;44908.326375103745;45420.318695218935;46326.76836615795;57905.42094579;59341.70329148499;60083.39916600953;60362.69818650879;63181.36818631755;8289.4197406181;8341.624626891926;8412.831743365221;8587.527685977331;8625.454401378745;9113.3165012623;12887;13184.274864882524;13479.730405392034;13842.515511957034;11560.30638161713;11687.415629218674;11708.765824683629;11767.23512971654;11804.881951180721;10813;11155.832662509907;11434.028107610946;11457.885421145682;12111;10578.471076445992;11015.889841101807;11535.942320288344;11571.884281157081;11594;8354;8361.289290410383;8422.873656895028;8681.479111253346;8823.205911467998;8129.579790965024;10994.615188468366;11107;11802.94098529502;11955.222910510789 16:33:23 INFO - PROCESS | 14555 | |3;mootools.html;1387.8057072009915;1511.6825466651999;1556.1830039229403;1701.7617533545306;1815.6731788278105;8603.827923441535;8822.338324625654;8935.240504557112;9187.862182067274;9200.585973631187;9042.728718138449;9169.083091690827;9185.173334399902;9231.6307347706;9236.630534778618;2386.7851893329553;2407.5064611754547;2410.2889647553925;2413.095089341497;2414.9637755433682;2366.6213405855065;2404.2546810488716;2410.505846301504;2412.7104747430335;2421.769931856471;2353.1646265575732;2362.55111528809;2374.1097088591778;2383;2388.044782087162;2267.353804165821;2318.5826551220857;2319.524497478013;2320.97679023211;2326.150954901466;2232.1852523828848;2259.344790010895;2262.0951619352227;2262.7963483286585;2263.207877242968;9064.68273610427;9099;9200.539973001323;9210.03294654065;9215.631374745002;5187.066328060948;5343.893122137574;5345.812896548602;5355.544778693816;5357.7589008494715;3271.4438545447333;3290.93418131636;3291.8024918504966;3313.353895990283;3367.410703126943;1036.9377837329785;1071.919606029551;1075.6181555547746;1081.3349789879246;1097.5993762276792;12889.742205155844;12902.290374029424;13088.934555327258;13093;13098.541551045668;4439.822407103679;4480.686351955397;4622.607078398307;4639.118567472169;4642.605378542862;10176.135028522658;10185.337953033177;10190.949045254727;10193.439360835077;10193.796124077477;5274;5280.683159010472;5291.100512912737;5301.310829592128;5308.761105750174;4310.094880075157;4768.1417344878255;4906.533879281463;4913.336699545515;4944.208926571731;3756.398976163801;3891.3384724596885;3926.155876486569;3945.684345252373;3987.401889716508;1166.731651720109;1168.9181757277079;1174.5569216030635;1185.5731936502852;1189.851268591426;860.3203469259215;963.5375019990444;971.4608392342177;1003.1623594298842;1012.1295685710284;5949.464548190597;6147.938520614826;6214.627122372582;6300.117983482316;6381.489480841522;453.36302494993924;1004.2618675273668;1064.3932958213898;1112.933224006562;1129.4917287220783;4014.1770936957855;4122.40225167355;4182.309918863353;4213.831446742096;4291.141771645621;11448.255863368855;11918;11923.1653784236;11924.940375298069;11930.821037684442;11840.644780656594;11847.111466640037;11851.585194518151;11859.16985810985;11859.169858110023;7961.880571791427;8285.42002059862;8285.461445006054;8477.321814254721;8667.089955554577;6250.718717657625;6289.496840252677;6444.7744328948265;6479.384458476626;6521.217453905561;10523.684289471328;10630.30902991303;10885;11033.117350611772;11038.889611104107;10495.737606559896;10867.619633312795;10918.908109189335;10921.344719316867;11008.724781880517;7251.492395532473;8052.476589021695;8175;8210.917890821254;8349.206825351583;9215;9271.536423178948;9279.814403711753;9297.256219502287;9302.302327325342;7977.641006154621;7994.400419968642;8052.798680033046;8246.628901699318;8335.374846886629;7846.960765196138;7996.56018918965;8076.515409075474;8102.392320575863;8132.227438393344;7457.440691948234;7469.626518673936;7543;7545.207753185837;7553.7356192533;5282.630215884851;5388.946110538845;5416.593755468277;5434;5481.068218402801;5396.163594642837;5494.2582751329655;5542.72286385671;5571.9721401392735;5621.747021383966 16:33:23 INFO - PROCESS | 14555 | |4;prototype.html;332.7240034467816;339.23164033464207;341.07908646654033;344.78278684428807;347.319254261647;5200.713960732158;5229.8169564065265;5251.71115588643;5266.210068489729;5285.550728188104;5172.431032586422;5180.352455943007;5215.739213039352;5227.484029631411;5242.711650859202;3967.1668949520636;4007.799610019502;4113.547509773923;4133.7106402551835;4134.73124246923;4113.4858142732155;4118.485189351331;4150.169966006795;4150.7340261220315;4163.292240319153;4088.5298190708004;4090.365993271048;4101.753894766309;4105.137921036571;4110.198511290299;3937.8621748238816;3938.2320447512748;4096.1193343431305;4099.672026237894;4150.481189851269;3650.5619325680823;3655.830134357007;3658.6158453362546;3664.303782281358;3668.633136686337;5079.898402031976;5094.2103973884105;5097.852983078815;5142;5159.484051594848;4482.21561226784;4660.207764680013;4665.020345727367;4671.462781780105;4699.295105734167;5419.972900135474;5420.864478388033;5425.511703946664;5426.9185962210595;5444.7822087116465;3957.920841583152;3963.7225394222414;3966.2067586482817;3987.5414327352437;3994.1612261425134;5486.588505862076;5602.803901863456;5607.803726869581;5671.6880571568545;5698;4000.659943904801;4001.339778936443;4003.7597744135446;4012.1775036117524;4035.1324465240114;4076.5515793262716;4079.673626109904;4080.449139366207;4095.365218391154;4101.733387329814;4572.511092277728;4610.4697959734385;4631.560001799824;4662.184117779375;4682.41469816273;5443.891122177534;5444.8094316698725;5445.482679145475;5466.316710411199;5478.616496845262;1394.0938390046551;1409.189715913354;1412.78808178774;1414.2009764483034;1418.6027912184604;861.763015170833;904.7511934218143;926.2960150285832;940.3699521320732;940.8400571902793;5098.4646612105935;5159.432462429129;5187.118189907725;5210.895782084337;5211.765470553834;5505.972470137704;5518.255035570227;5526.47498487643;5535.169724541271;5572.124391157737;5006.974965125151;5166.43169251382;5226.92159617606;5233.607479439057;5238.449962753933;2926.5317549192027;2940.456015637114;2963.7628989681207;2985.7462115719973;2988.2379993102054;5743.167240750151;5757.13642953552;5777.3933736957015;5802.158686990363;5802.187693722883;5399.487048730364;5673.943260567424;5696.914546281809;5759.366469688331;5760.6543607382855;5814.563907706939;5827.533797296291;5834.066549352084;5851.566366240213;5859.1797148399255;5418.241446197614;5630.493255607015;5632.774689012557;5633.324001119892;5655.406182350794;5519.475649813261;5525.143602741581;5530.364008139116;5534.142207957612;5541.473560011793;5762.1849117527845;5774.191613174243;5777.653340799566;5813.418658134153;5834.299884013945;3978.801059947049;3980.8805735827973;4017.819198136149;4037;4060.3706425504092;5622.353429355513;5635.520980716685;5635.746391412478;5636.436356364495;5643.52030077448;5502.944970550403;5554.555635549065;5555.30558680165;5586.329640443173;5588.692621905671;5379.488948549882;5434.673919564839;5447.155690867922;5460.535854452416;5495.818399044225;5357.633803380113;5378.892422151614;5403.351597808288;5418.187271909245;5448.128299472065;5258.158694608845;5295.173165258134;5424.810131645373;5457.645253058538;5464.879699661639;5327.6025788396155;5357.776522743018;5381.48875856793;5390.784368625211;5399.514043735925 16:33:23 INFO - PROCESS | 14555 | |5;yui.html;771.7530390275115;776.4368301122458;786.2412771675336;831.1937420701917;841.6591280531384;15582.844171558296;17212.364825341574;17236.224369903353;17267.222974966124;17274.654506909854;14314.642133946656;14336.641583960407;14367.856321436782;14400.135991840498;14406.855931440683;601.263452270969;798.8801679748055;801.0587559617455;819.5902048975512;824.6536454689045;814.5072231300067;825.591332290517;827.3877330775243;827.5779352530193;828.1594181905341;883.6156272021659;886.3573908916017;886.9334799890034;888.005433914014;888.4580405952364;706.4701473894605;835.9707410240612;862.9913700863036;875.0986483921539;875.7066382761783;634.9492040636738;639.0829160155192;639.5011890725242;639.7664852328913;640.7052755732323;13705.862941370558;13726.45094196231;13736.587902362946;13739.931300343535;13751.724965500734;14134.929325353307;14464.006356931766;14531;14592.270386480739;14667;12669.873301267055;12678.80981785274;12686.111972161953;12850;13351.265680387574;4439.467263928317;4511.8646440606835;4514.264897423496;4547.499775024778;4683.367745354368;83762.16237837604;84279.15720842835;84470.57764711199;84583;84753.15246847576;11001.449927503592;11090.390028548345;11296.887031129583;11450.713732156597;11531.88468115325;21080.578388432452;21415.46461338479;21427.357179284645;21484.355469335944;21506.784932150476;8306.750797476085;8307.626156822958;8483.872741908875;8638.222559969507;8777.473351598797;4830.29960655703;4873.512648735098;4878.487758785347;4924.852254432372;5032.874178145576;3295.868165273362;3367.4275373186615;3369.4777309517062;3374.7806392584403;3381.036404624719;580.1413907417046;585.1252377695373;605.1860247966478;606.0273261415452;606.3178923710825;581.988360232793;638.658317799984;707.005419380494;736.3446532586003;737.9151397589346;9709.611615535441;9737.267340954038;9792.902070979342;9918.702438926844;10059.748506287402;634.4480302137171;681.7886455198905;714.6319645382632;715.8783006888841;730.2223132364015;4562.908741825145;4826.686265392808;4858.805647774049;4910.950890491121;4927.826524561899;125244;125392;127776.36111819382;130290;134979.32510337385;101931;103240.48379758053;106233.93766062395;109033;113910.43044784723;56222.43777562254;91960;92001;95465;96437.51781240909;8730.214280714767;8877;8946.507942063248;9179.265658747418;10067.546960386946;40904.181916362104;56161;57603.711981439825;58731.706341468016;61044.08433873584;84423.5778821102;84716.03493877931;84832;87722.56138719266;88580.5570972141;14125.15249085017;14340.426382944564;14540.49108281205;14560.344784484512;15123.924380378028;13835.723285534434;14146.43414263418;14150.646233844236;14307.356168972214;14609.213250517818;14602;14629.85370146285;14766;14832.851671483148;15109.71537605313;14734.115953042852;14738;15123.243837808286;15135.243237837843;15620.68758624844;14091.365888534836;14129.293535323399;14552.49066282675;15000.249987500363;15458.381664733284;12407.689807754517;12537.87462125367;12542.372881355714;12589.811152832897;13082.869171308546;10824;11591.594294199662;11791.1117761483;11871.503500865983;12420.875791241971 16:33:23 INFO - PROCESS | 14555 | __end_tp_report 16:33:23 INFO - PROCESS | 14555 | __start_cc_report 16:33:23 INFO - PROCESS | 14555 | _x_x_mozilla_cycle_collect,1095 16:33:23 INFO - PROCESS | 14555 | __end_cc_report 16:33:23 INFO - PROCESS | 14555 | __startTimestamp1470353603303__endTimestamp 16:33:23 INFO - PROCESS | 14555 | 16:33:23 INFO - PROCESS | 14555 | ------- Summary: start ------- 16:33:23 INFO - PROCESS | 14555 | Number of tests: 6 16:33:23 INFO - PROCESS | 14555 | 16:33:23 INFO - PROCESS | 14555 | [#0] dojo.html Cycles:165 Average:5228.20 Median:5460.84 stddev:586.04 (10.7%) stddev-sans-first:561.01 16:33:23 INFO - PROCESS | 14555 | Values: 2993.6 3002.5 3031.6 3043.0 3054.8 5181.4 5220.6 5279.5 5311.6 5354.1 5259.8 5259.9 5306.3 5308.0 5326.1 4754.3 4802.7 4824.0 4830.6 4983.4 4891.0 4898.9 4926.3 4944.6 4948.8 4731.8 4739.9 4794.4 4803.6 4887.2 4799.7 4806.0 4812.4 4817.9 4920.2 4821.4 4842.7 4843.7 4855.1 4887.4 5163.2 5179.3 5193.3 5195.1 5312.3 5546.1 5587.9 5603.6 5605.5 5613.6 5585.2 5636.2 5637.9 5641.4 5651.2 5103.9 5123.1 5167.0 5170.9 5242.8 5675.4 5736.5 5737.7 5738.7 5740.7 5451.5 5459.9 5500.9 5501.7 5513.0 5455.5 5508.6 5552.7 5562.7 5636.9 5563.3 5564.2 5566.1 5571.5 5572.0 5529.4 5566.0 5580.0 5580.2 5634.2 4246.1 4249.4 4295.5 4299.5 4306.1 3853.2 3867.0 3872.8 3897.7 3903.8 5245.8 5268.9 5272.3 5299.9 5314.4 5594.4 5601.2 5609.7 5620.1 5668.1 5042.3 5232.4 5289.6 5295.1 5305.5 4834.2 4851.8 4886.3 4890.7 4926.7 5900.8 5905.5 5908.8 5909.2 5914.9 5430.3 5557.9 5666.3 5669.5 5709.9 5786.3 5880.9 5895.8 5915.6 5927.8 5523.1 5523.2 5527.7 5532.0 5535.6 5457.5 5565.9 5590.5 5602.8 5616.6 5490.6 5522.9 5535.8 5554.7 5613.0 5506.8 5518.6 5552.4 5559.2 5568.2 5265.4 5485.5 5498.0 5499.6 5542.6 5499.0 5543.9 5552.4 5569.4 5628.2 5445.2 5460.8 5461.4 5462.3 5463.1 16:33:23 INFO - PROCESS | 14555 | 16:33:23 INFO - PROCESS | 14555 | [#1] ext.html Cycles:180 Average:64974.61 Median:24311.96 stddev:129946.78 (534.5%) stddev-sans-first:130221.40 16:33:23 INFO - PROCESS | 14555 | Values: 590.8 603.7 611.6 631.9 637.6 33503.5 44206.3 45141.3 45291.8 45338.3 46521.0 46932.5 46952.8 46998.3 47160.8 9002.5 9119.6 9124.0 9132.5 9132.6 9051.7 9131.5 9131.8 9134.0 9139.4 9115.7 9170.0 9174.7 9176.5 9180.0 9109.9 9127.1 9150.4 9161.0 9162.1 8936.2 9023.1 9028.3 9028.4 9045.9 43011.0 43445.8 43467.1 43472.2 43485.6 3456.1 3489.2 3709.4 3944.3 4073.6 32819.3 33282.5 33289.3 33643.8 35109.5 4085.5 4171.3 4272.5 4308.3 4417.6 384245.0 391325.0 392797.0 393882.0 395207.0 53540.5 62507.7 63189.4 63209.0 63304.0 55150.0 58255.7 58295.4 62626.0 64495.4 15932.8 16110.5 16188.8 16239.7 16268.2 12240.4 12294.8 12304.9 12346.3 12351.0 17316.9 19228.0 19446.2 19477.4 19477.7 6280.6 7367.4 7440.6 7530.7 7612.6 968.2 1050.4 1089.0 1097.6 1121.6 33575.8 34020.8 34029.0 34157.5 34552.0 1099.8 1154.8 1160.6 1160.7 1168.9 17297.4 17364.7 17770.2 17784.5 17795.0 567411.0 570865.0 572435.0 578429.0 582495.0 61895.7 62592.4 62593.4 62651.4 62661.7 1321.9 1342.3 1361.7 1370.3 1390.4 31538.7 33474.7 33636.2 33650.8 34059.7 53910.5 54347.5 54353.0 54488.0 54544.5 483270.0 486222.0 486228.0 487084.0 487426.0 26126.0 29625.7 30024.1 42375.2 45887.3 41782.0 43675.8 51866.2 52375.0 52804.5 41040.4 41101.6 43848.3 43888.6 45390.0 43932.8 44870.3 44927.3 45218.3 45643.0 44511.0 44854.3 44971.0 45311.0 46076.3 37421.4 39457.0 39676.4 39839.4 40170.6 29089.3 29774.7 30021.2 30061.0 30074.5 16:33:23 INFO - PROCESS | 14555 | 16:33:23 INFO - PROCESS | 14555 | [#2] jquery.html Cycles:180 Average:29108.12 Median:13387.93 stddev:80662.52 (602.5%) stddev-sans-first:80859.94 16:33:23 INFO - PROCESS | 14555 | Values: 370.9 373.4 397.2 404.1 416.6 16999.6 19946.6 19958.5 20227.3 20749.0 19556.8 19625.1 19984.4 20160.5 20179.0 5189.7 5541.4 5866.9 5884.1 5910.6 5766.4 5839.8 5844.7 5845.1 5848.7 5569.2 5719.5 5736.8 5737.8 5818.7 5591.3 5628.0 5649.7 5657.8 5659.0 5058.7 5165.1 5166.9 5202.5 5220.2 20468.1 20852.8 24012.8 24345.5 24361.1 2349.9 2352.7 2411.3 2430.4 2444.8 14217.3 14290.4 14439.5 15501.8 15878.4 1833.8 1907.1 1908.2 1928.3 1986.6 83665.7 85078.0 86347.0 86974.0 87416.0 10795.2 10801.8 10948.8 11152.6 11325.8 15268.5 15269.0 15269.3 15282.2 15293.1 7852.1 8099.3 8102.7 8193.7 8268.0 7573.9 7574.2 7839.7 7844.4 7865.7 6774.4 6829.2 6878.4 6882.4 6905.4 1871.4 1891.4 1891.9 1974.0 2003.9 902.2 921.4 1025.4 1050.0 1092.8 19768.0 20224.7 20313.2 20348.9 20665.9 943.6 971.7 984.9 1028.3 1055.7 10656.5 10777.9 10799.5 11211.9 11490.5 414326.0 423664.0 519370.0 534572.0 537881.0 53058.0 65475.7 97660.0 97897.5 101461.0 1003.6 1048.0 1054.6 1069.7 1074.4 17367.5 17737.1 18044.5 18126.9 18604.3 44162.0 44455.8 44908.3 45420.3 46326.8 57905.4 59341.7 60083.4 60362.7 63181.4 8289.4 8341.6 8412.8 8587.5 8625.5 9113.3 12887.0 13184.3 13479.7 13842.5 11560.3 11687.4 11708.8 11767.2 11804.9 10813.0 11155.8 11434.0 11457.9 12111.0 10578.5 11015.9 11535.9 11571.9 11594.0 8354.0 8361.3 8422.9 8681.5 8823.2 8129.6 10994.6 11107.0 11802.9 11955.2 16:33:23 INFO - PROCESS | 14555 | 16:33:23 INFO - PROCESS | 14555 | [#3] mootools.html Cycles:180 Average:6040.46 Median:4300.62 stddev:3533.15 (82.2%) stddev-sans-first:3525.76 16:33:23 INFO - PROCESS | 14555 | Values: 1387.8 1511.7 1556.2 1701.8 1815.7 8603.8 8822.3 8935.2 9187.9 9200.6 9042.7 9169.1 9185.2 9231.6 9236.6 2386.8 2407.5 2410.3 2413.1 2415.0 2366.6 2404.3 2410.5 2412.7 2421.8 2353.2 2362.6 2374.1 2383.0 2388.0 2267.4 2318.6 2319.5 2321.0 2326.2 2232.2 2259.3 2262.1 2262.8 2263.2 9064.7 9099.0 9200.5 9210.0 9215.6 5187.1 5343.9 5345.8 5355.5 5357.8 3271.4 3290.9 3291.8 3313.4 3367.4 1036.9 1071.9 1075.6 1081.3 1097.6 12889.7 12902.3 13088.9 13093.0 13098.5 4439.8 4480.7 4622.6 4639.1 4642.6 10176.1 10185.3 10190.9 10193.4 10193.8 5274.0 5280.7 5291.1 5301.3 5308.8 4310.1 4768.1 4906.5 4913.3 4944.2 3756.4 3891.3 3926.2 3945.7 3987.4 1166.7 1168.9 1174.6 1185.6 1189.9 860.3 963.5 971.5 1003.2 1012.1 5949.5 6147.9 6214.6 6300.1 6381.5 453.4 1004.3 1064.4 1112.9 1129.5 4014.2 4122.4 4182.3 4213.8 4291.1 11448.3 11918.0 11923.2 11924.9 11930.8 11840.6 11847.1 11851.6 11859.2 11859.2 7961.9 8285.4 8285.5 8477.3 8667.1 6250.7 6289.5 6444.8 6479.4 6521.2 10523.7 10630.3 10885.0 11033.1 11038.9 10495.7 10867.6 10918.9 10921.3 11008.7 7251.5 8052.5 8175.0 8210.9 8349.2 9215.0 9271.5 9279.8 9297.3 9302.3 7977.6 7994.4 8052.8 8246.6 8335.4 7847.0 7996.6 8076.5 8102.4 8132.2 7457.4 7469.6 7543.0 7545.2 7553.7 5282.6 5388.9 5416.6 5434.0 5481.1 5396.2 5494.3 5542.7 5572.0 5621.7 16:33:23 INFO - PROCESS | 14555 | 16:33:23 INFO - PROCESS | 14555 | [#4] prototype.html Cycles:180 Average:4608.80 Median:5240.58 stddev:1345.62 (25.7%) stddev-sans-first:1310.56 16:33:23 INFO - PROCESS | 14555 | Values: 332.7 339.2 341.1 344.8 347.3 5200.7 5229.8 5251.7 5266.2 5285.6 5172.4 5180.4 5215.7 5227.5 5242.7 3967.2 4007.8 4113.5 4133.7 4134.7 4113.5 4118.5 4150.2 4150.7 4163.3 4088.5 4090.4 4101.8 4105.1 4110.2 3937.9 3938.2 4096.1 4099.7 4150.5 3650.6 3655.8 3658.6 3664.3 3668.6 5079.9 5094.2 5097.9 5142.0 5159.5 4482.2 4660.2 4665.0 4671.5 4699.3 5420.0 5420.9 5425.5 5426.9 5444.8 3957.9 3963.7 3966.2 3987.5 3994.2 5486.6 5602.8 5607.8 5671.7 5698.0 4000.7 4001.3 4003.8 4012.2 4035.1 4076.6 4079.7 4080.4 4095.4 4101.7 4572.5 4610.5 4631.6 4662.2 4682.4 5443.9 5444.8 5445.5 5466.3 5478.6 1394.1 1409.2 1412.8 1414.2 1418.6 861.8 904.8 926.3 940.4 940.8 5098.5 5159.4 5187.1 5210.9 5211.8 5506.0 5518.3 5526.5 5535.2 5572.1 5007.0 5166.4 5226.9 5233.6 5238.4 2926.5 2940.5 2963.8 2985.7 2988.2 5743.2 5757.1 5777.4 5802.2 5802.2 5399.5 5673.9 5696.9 5759.4 5760.7 5814.6 5827.5 5834.1 5851.6 5859.2 5418.2 5630.5 5632.8 5633.3 5655.4 5519.5 5525.1 5530.4 5534.1 5541.5 5762.2 5774.2 5777.7 5813.4 5834.3 3978.8 3980.9 4017.8 4037.0 4060.4 5622.4 5635.5 5635.7 5636.4 5643.5 5502.9 5554.6 5555.3 5586.3 5588.7 5379.5 5434.7 5447.2 5460.5 5495.8 5357.6 5378.9 5403.4 5418.2 5448.1 5258.2 5295.2 5424.8 5457.6 5464.9 5327.6 5357.8 5381.5 5390.8 5399.5 16:33:23 INFO - PROCESS | 14555 | 16:33:23 INFO - PROCESS | 14555 | [#5] yui.html Cycles:180 Average:22271.36 Median:4530.88 stddev:32924.82 (726.7%) stddev-sans-first:32977.61 16:33:23 INFO - PROCESS | 14555 | Values: 771.8 776.4 786.2 831.2 841.7 15582.8 17212.4 17236.2 17267.2 17274.7 14314.6 14336.6 14367.9 14400.1 14406.9 601.3 798.9 801.1 819.6 824.7 814.5 825.6 827.4 827.6 828.2 883.6 886.4 886.9 888.0 888.5 706.5 836.0 863.0 875.1 875.7 634.9 639.1 639.5 639.8 640.7 13705.9 13726.5 13736.6 13739.9 13751.7 14134.9 14464.0 14531.0 14592.3 14667.0 12669.9 12678.8 12686.1 12850.0 13351.3 4439.5 4511.9 4514.3 4547.5 4683.4 83762.2 84279.2 84470.6 84583.0 84753.2 11001.4 11090.4 11296.9 11450.7 11531.9 21080.6 21415.5 21427.4 21484.4 21506.8 8306.8 8307.6 8483.9 8638.2 8777.5 4830.3 4873.5 4878.5 4924.9 5032.9 3295.9 3367.4 3369.5 3374.8 3381.0 580.1 585.1 605.2 606.0 606.3 582.0 638.7 707.0 736.3 737.9 9709.6 9737.3 9792.9 9918.7 10059.7 634.4 681.8 714.6 715.9 730.2 4562.9 4826.7 4858.8 4911.0 4927.8 125244.0 125392.0 127776.4 130290.0 134979.3 101931.0 103240.5 106233.9 109033.0 113910.4 56222.4 91960.0 92001.0 95465.0 96437.5 8730.2 8877.0 8946.5 9179.3 10067.5 40904.2 56161.0 57603.7 58731.7 61044.1 84423.6 84716.0 84832.0 87722.6 88580.6 14125.2 14340.4 14540.5 14560.3 15123.9 13835.7 14146.4 14150.6 14307.4 14609.2 14602.0 14629.9 14766.0 14832.9 15109.7 14734.1 14738.0 15123.2 15135.2 15620.7 14091.4 14129.3 14552.5 15000.2 15458.4 12407.7 12537.9 12542.4 12589.8 13082.9 10824.0 11591.6 11791.1 11871.5 12420.9 16:33:23 INFO - PROCESS | 14555 | -------- Summary: end -------- 16:33:23 INFO - PROCESS | 14555 | 16:33:24 INFO - TEST-INFO | 14555: exit 0 16:33:24 INFO - TEST-OK | dromaeo_css | took 1114001ms 16:33:24 INFO - TEST-START | kraken 16:33:24 INFO - operating with platform_type : linux_ 16:33:24 INFO - Initialising browser for kraken test... 16:33:24 INFO - TEST-INFO | started process 14751 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpAP9vgk/profile http://localhost:55193/getInfo.html) 16:33:27 INFO - PROCESS | 14751 | __metrics Screen width/height:1600/1200 16:33:27 INFO - PROCESS | 14751 | colorDepth:24 16:33:27 INFO - PROCESS | 14751 | Browser inner width/height: 1024/697 16:33:27 INFO - PROCESS | 14751 | __metrics 16:33:28 INFO - PROCESS | 14751 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 693: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 16:33:28 INFO - PROCESS | 14751 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 122: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 16:33:29 INFO - TEST-INFO | 14751: exit 0 16:33:29 INFO - Browser initialized. 16:33:29 INFO - Running cycle 1/1 for kraken test... 16:33:29 INFO - TEST-INFO | started process 14833 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpAP9vgk/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 16:33:41 INFO - PROCESS | 14833 | RSS: Main: 157081600 16:33:41 INFO - PROCESS | 14833 | 16:33:43 INFO - PROCESS | 14833 | Cycle 1(1): loaded http://localhost:55193/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:55193/tests/kraken/driver.html?testName=audio-beat-detection) 16:33:44 INFO - PROCESS | 14833 | RSS: Main: 213319680 16:33:44 INFO - PROCESS | 14833 | 16:33:47 INFO - PROCESS | 14833 | Cycle 1(1): loaded http://localhost:55193/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:55193/tests/kraken/driver.html?testName=audio-dft) 16:33:47 INFO - PROCESS | 14833 | RSS: Main: 191500288 16:33:47 INFO - PROCESS | 14833 | 16:33:50 INFO - PROCESS | 14833 | Cycle 1(1): loaded http://localhost:55193/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:55193/tests/kraken/driver.html?testName=audio-fft) 16:33:51 INFO - PROCESS | 14833 | RSS: Main: 268828672 16:33:51 INFO - PROCESS | 14833 | 16:33:53 INFO - PROCESS | 14833 | Cycle 1(1): loaded http://localhost:55193/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:55193/tests/kraken/driver.html?testName=audio-oscillator) 16:33:53 INFO - PROCESS | 14833 | RSS: Main: 179597312 16:33:53 INFO - PROCESS | 14833 | 16:33:56 INFO - PROCESS | 14833 | Cycle 1(1): loaded http://localhost:55193/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:55193/tests/kraken/driver.html?testName=imaging-gaussian-blur) 16:33:56 INFO - PROCESS | 14833 | RSS: Main: 185049088 16:33:56 INFO - PROCESS | 14833 | 16:33:59 INFO - PROCESS | 14833 | Cycle 1(1): loaded http://localhost:55193/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:55193/tests/kraken/driver.html?testName=imaging-darkroom) 16:34:00 INFO - PROCESS | 14833 | RSS: Main: 219484160 16:34:00 INFO - PROCESS | 14833 | 16:34:03 INFO - PROCESS | 14833 | Cycle 1(1): loaded http://localhost:55193/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:55193/tests/kraken/driver.html?testName=imaging-desaturate) 16:34:04 INFO - PROCESS | 14833 | RSS: Main: 219742208 16:34:04 INFO - PROCESS | 14833 | 16:34:07 INFO - PROCESS | 14833 | Cycle 1(1): loaded http://localhost:55193/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:55193/tests/kraken/driver.html?testName=json-parse-financial) 16:34:07 INFO - PROCESS | 14833 | RSS: Main: 219754496 16:34:07 INFO - PROCESS | 14833 | 16:34:09 INFO - PROCESS | 14833 | Cycle 1(1): loaded http://localhost:55193/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:55193/tests/kraken/driver.html?testName=json-stringify-tinderbox) 16:34:09 INFO - PROCESS | 14833 | RSS: Main: 184225792 16:34:09 INFO - PROCESS | 14833 | 16:34:11 INFO - PROCESS | 14833 | Cycle 1(1): loaded http://localhost:55193/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:55193/tests/kraken/driver.html?testName=stanford-crypto-aes) 16:34:12 INFO - PROCESS | 14833 | RSS: Main: 190164992 16:34:12 INFO - PROCESS | 14833 | 16:34:14 INFO - PROCESS | 14833 | Cycle 1(1): loaded http://localhost:55193/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:55193/tests/kraken/driver.html?testName=stanford-crypto-ccm) 16:34:14 INFO - PROCESS | 14833 | RSS: Main: 194904064 16:34:14 INFO - PROCESS | 14833 | 16:34:17 INFO - PROCESS | 14833 | Cycle 1(1): loaded http://localhost:55193/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:55193/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 16:34:18 INFO - PROCESS | 14833 | RSS: Main: 193277952 16:34:18 INFO - PROCESS | 14833 | 16:34:20 INFO - PROCESS | 14833 | Cycle 1(1): loaded http://localhost:55193/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:55193/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 16:34:21 INFO - PROCESS | 14833 | RSS: Main: 196472832 16:34:21 INFO - PROCESS | 14833 | 16:34:22 INFO - PROCESS | 14833 | Cycle 1(1): loaded http://localhost:55193/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:55193/tests/kraken/driver.html?testName=ai-astar) 16:34:23 INFO - PROCESS | 14833 | RSS: Main: 243449856 16:34:23 INFO - PROCESS | 14833 | 16:34:23 INFO - PROCESS | 14833 | __start_tp_report 16:34:23 INFO - PROCESS | 14833 | _x_x_mozilla_page_load 16:34:23 INFO - PROCESS | 14833 | _x_x_mozilla_page_load_details 16:34:23 INFO - PROCESS | 14833 | |i|pagename|runs| 16:34:23 INFO - PROCESS | 14833 | |0;ai-astar;103;112;111;110;111;111;112;110;110;111 16:34:23 INFO - PROCESS | 14833 | |1;audio-beat-detection;142;116;124;186;117;125;148;116;152;117 16:34:23 INFO - PROCESS | 14833 | |2;audio-dft;161;159;160;160;160;160;160;161;161;160 16:34:23 INFO - PROCESS | 14833 | |3;audio-fft;74;75;74;134;75;77;74;74;108;75 16:34:23 INFO - PROCESS | 14833 | |4;audio-oscillator;84;83;118;84;84;83;115;83;84;134 16:34:23 INFO - PROCESS | 14833 | |5;imaging-gaussian-blur;117;116;116;116;116;117;117;116;116;117 16:34:23 INFO - PROCESS | 14833 | |6;imaging-darkroom;145;145;146;146;146;146;146;146;145;146 16:34:23 INFO - PROCESS | 14833 | |7;imaging-desaturate;95;94;95;95;95;95;95;96;95;96 16:34:23 INFO - PROCESS | 14833 | |8;json-parse-financial;49;49;49;49;49;50;52;50;49;49 16:34:23 INFO - PROCESS | 14833 | |9;json-stringify-tinderbox;59;60;59;59;59;60;59;59;59;59 16:34:23 INFO - PROCESS | 14833 | |10;stanford-crypto-aes;77;76;76;75;76;74;75;77;78;75 16:34:23 INFO - PROCESS | 14833 | |11;stanford-crypto-ccm;121;119;136;122;127;138;117;137;126;131 16:34:23 INFO - PROCESS | 14833 | |12;stanford-crypto-pbkdf2;158;159;156;155;160;160;157;158;158;156 16:34:23 INFO - PROCESS | 14833 | |13;stanford-crypto-sha256-iterative;64;64;64;68;63;64;62;63;61;61 16:34:23 INFO - PROCESS | 14833 | __end_tp_report 16:34:23 INFO - PROCESS | 14833 | __start_cc_report 16:34:23 INFO - PROCESS | 14833 | _x_x_mozilla_cycle_collect,1691 16:34:23 INFO - PROCESS | 14833 | __end_cc_report 16:34:23 INFO - PROCESS | 14833 | __startTimestamp1470353663222__endTimestamp 16:34:23 INFO - PROCESS | 14833 | 16:34:23 INFO - PROCESS | 14833 | ------- Summary: start ------- 16:34:23 INFO - PROCESS | 14833 | Number of tests: 14 16:34:23 INFO - PROCESS | 14833 | 16:34:23 INFO - PROCESS | 14833 | [#0] ai-astar Cycles:10 Average:110.10 Median:111.00 stddev:2.60 (2.3%) stddev-sans-first:0.78 16:34:23 INFO - PROCESS | 14833 | Values: 103.0 112.0 111.0 110.0 111.0 111.0 112.0 110.0 110.0 111.0 16:34:23 INFO - PROCESS | 14833 | 16:34:23 INFO - PROCESS | 14833 | [#1] audio-beat-detection Cycles:10 Average:134.30 Median:133.50 stddev:22.84 (17.1%) stddev-sans-first:24.05 16:34:23 INFO - PROCESS | 14833 | Values: 142.0 116.0 124.0 186.0 117.0 125.0 148.0 116.0 152.0 117.0 16:34:23 INFO - PROCESS | 14833 | 16:34:23 INFO - PROCESS | 14833 | [#2] audio-dft Cycles:10 Average:160.20 Median:160.00 stddev:0.63 (0.4%) stddev-sans-first:0.60 16:34:23 INFO - PROCESS | 14833 | Values: 161.0 159.0 160.0 160.0 160.0 160.0 160.0 161.0 161.0 160.0 16:34:23 INFO - PROCESS | 14833 | 16:34:23 INFO - PROCESS | 14833 | [#3] audio-fft Cycles:10 Average:84.00 Median:74.50 stddev:20.46 (27.5%) stddev-sans-first:21.38 16:34:23 INFO - PROCESS | 14833 | Values: 74.0 75.0 74.0 134.0 75.0 77.0 74.0 74.0 108.0 75.0 16:34:23 INFO - PROCESS | 14833 | 16:34:23 INFO - PROCESS | 14833 | [#4] audio-oscillator Cycles:10 Average:95.20 Median:83.50 stddev:19.34 (23.2%) stddev-sans-first:20.08 16:34:23 INFO - PROCESS | 14833 | Values: 84.0 83.0 118.0 84.0 84.0 83.0 115.0 83.0 84.0 134.0 16:34:23 INFO - PROCESS | 14833 | 16:34:23 INFO - PROCESS | 14833 | [#5] imaging-gaussian-blur Cycles:10 Average:116.40 Median:116.50 stddev:0.52 (0.4%) stddev-sans-first:0.50 16:34:23 INFO - PROCESS | 14833 | Values: 117.0 116.0 116.0 116.0 116.0 117.0 117.0 116.0 116.0 117.0 16:34:23 INFO - PROCESS | 14833 | 16:34:23 INFO - PROCESS | 14833 | [#6] imaging-darkroom Cycles:10 Average:145.70 Median:146.00 stddev:0.48 (0.3%) stddev-sans-first:0.44 16:34:23 INFO - PROCESS | 14833 | Values: 145.0 145.0 146.0 146.0 146.0 146.0 146.0 146.0 145.0 146.0 16:34:23 INFO - PROCESS | 14833 | 16:34:23 INFO - PROCESS | 14833 | [#7] imaging-desaturate Cycles:10 Average:95.10 Median:95.00 stddev:0.57 (0.6%) stddev-sans-first:0.60 16:34:23 INFO - PROCESS | 14833 | Values: 95.0 94.0 95.0 95.0 95.0 95.0 95.0 96.0 95.0 96.0 16:34:23 INFO - PROCESS | 14833 | 16:34:23 INFO - PROCESS | 14833 | [#8] json-parse-financial Cycles:10 Average:49.50 Median:49.00 stddev:0.97 (2.0%) stddev-sans-first:1.01 16:34:23 INFO - PROCESS | 14833 | Values: 49.0 49.0 49.0 49.0 49.0 50.0 52.0 50.0 49.0 49.0 16:34:23 INFO - PROCESS | 14833 | 16:34:23 INFO - PROCESS | 14833 | [#9] json-stringify-tinderbox Cycles:10 Average:59.20 Median:59.00 stddev:0.42 (0.7%) stddev-sans-first:0.44 16:34:23 INFO - PROCESS | 14833 | Values: 59.0 60.0 59.0 59.0 59.0 60.0 59.0 59.0 59.0 59.0 16:34:23 INFO - PROCESS | 14833 | 16:34:23 INFO - PROCESS | 14833 | [#10] stanford-crypto-aes Cycles:10 Average:75.90 Median:76.00 stddev:1.20 (1.6%) stddev-sans-first:1.20 16:34:23 INFO - PROCESS | 14833 | Values: 77.0 76.0 76.0 75.0 76.0 74.0 75.0 77.0 78.0 75.0 16:34:23 INFO - PROCESS | 14833 | 16:34:23 INFO - PROCESS | 14833 | [#11] stanford-crypto-ccm Cycles:10 Average:127.40 Median:129.00 stddev:7.76 (6.0%) stddev-sans-first:7.88 16:34:23 INFO - PROCESS | 14833 | Values: 121.0 119.0 136.0 122.0 127.0 138.0 117.0 137.0 126.0 131.0 16:34:23 INFO - PROCESS | 14833 | 16:34:23 INFO - PROCESS | 14833 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:157.70 Median:158.00 stddev:1.70 (1.1%) stddev-sans-first:1.80 16:34:23 INFO - PROCESS | 14833 | Values: 158.0 159.0 156.0 155.0 160.0 160.0 157.0 158.0 158.0 156.0 16:34:23 INFO - PROCESS | 14833 | 16:34:23 INFO - PROCESS | 14833 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:63.40 Median:64.00 stddev:2.01 (3.1%) stddev-sans-first:2.12 16:34:23 INFO - PROCESS | 14833 | Values: 64.0 64.0 64.0 68.0 63.0 64.0 62.0 63.0 61.0 61.0 16:34:23 INFO - PROCESS | 14833 | -------- Summary: end -------- 16:34:23 INFO - PROCESS | 14833 | 16:34:24 INFO - TEST-INFO | 14833: exit 0 16:34:24 INFO - TEST-OK | kraken | took 60081ms 16:34:24 INFO - SUITE-END | took 1174s 16:34:24 INFO - Completed test suite (00:19:34) 16:34:24 INFO - javascript benchmark 16:34:24 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2993.6407631084267, 3002.4895767719486, 3031.590735250741, 3042.9847850760743, 3054.755619550436, 5181.4300426953005, 5220.6084543659235, 5279.4984476474765, 5311.60162987776, 5354.143337066075, 5259.789608415668, 5259.894802103956, 5306.310179676646, 5307.973460132704, 5326.147816349385, 4754.286856971465, 4802.687825291362, 4823.951760482403, 4830.589399900995, 4983.401991760976, 4890.951090489103, 4898.902021959559, 4926.334944782444, 4944.629152813535, 4948.777305021283, 4731.78706958186, 4739.857804265843, 4794.448638406593, 4803.639727020487, 4887.16918123918, 4799.712017278975, 4806.0, 4812.374391329105, 4817.9036419271415, 4920.188168952119, 4821.421429428491, 4842.685225460334, 4843.709377437365, 4855.101806165835, 4887.413510378742, 5163.225516172567, 5179.2749015137915, 5193.272941788153, 5195.090859099642, 5312.335958005249, 5546.112621980504, 5587.8603034924045, 5603.551715862721, 5605.467480589337, 5613.635113717636, 5585.218069470277, 5636.239107720447, 5637.8590535236535, 5641.351244606841, 5651.237082993825, 5103.9489605103845, 5123.103456895028, 5166.974165129151, 5170.896582068338, 5242.842714718565, 5675.3757086720425, 5736.483716465538, 5737.655740655574, 5738.741756620962, 5740.684262365527, 5451.454854514517, 5459.863503412446, 5500.944990550123, 5501.724913754297, 5513.035218836688, 5455.509004189642, 5508.614396992172, 5552.7223638817895, 5562.694051827108, 5636.915446268309, 5563.304586926634, 5564.221009058735, 5566.109422492382, 5571.470710282517, 5571.972140139354, 5529.364123125812, 5565.970295495346, 5580.023495888203, 5580.218769372291, 5634.239377684042, 4246.129543443587, 4249.405083288342, 4295.463067116548, 4299.548547402478, 4306.074194048295, 3853.2293541291856, 3866.980665096713, 3872.8450861965207, 3897.6686981606313, 3903.843846246175, 5245.790168393298, 5268.947310526923, 5272.261883336336, 5299.894002120013, 5314.388845282765, 5594.356648985418, 5601.187827764951, 5609.747561359749, 5620.072688006515, 5668.064769313017, 5042.319286896222, 5232.3982741985155, 5289.550388217045, 5295.12630415977, 5305.469453054664, 4834.178189707688, 4851.757412129379, 4886.29148773433, 4890.682105663121, 4926.704397736147, 5900.793472228452, 5905.527557795452, 5908.763649454059, 5909.172715819789, 5914.8817023659285, 5430.266913966564, 5557.944420555743, 5666.263385759825, 5669.518090962314, 5709.914351284651, 5786.334571524329, 5880.852978675567, 5895.764169433174, 5915.645061296336, 5927.8221653350465, 5523.088690366045, 5523.171524271231, 5527.723613819373, 5531.976584331912, 5535.557155427476, 5457.454254574511, 5565.888682226414, 5590.468905453975, 5602.775888964396, 5616.634918730269, 5490.588205884655, 5522.889542209214, 5535.750891209986, 5554.722263886871, 5613.045782217115, 5506.807261745819, 5518.586106041983, 5552.361478430033, 5559.24950131727, 5568.16477528374, 5265.3944796348915, 5485.451454854483, 5498.0, 5499.642523235977, 5542.61201715876, 5498.972505137449, 5543.8891222176135, 5552.3892371839875, 5569.415211402745, 5628.212050313042, 5445.1832225166545, 5460.836174914759, 5461.426550212171, 5462.3445186577865, 5463.125899856004], "value": 5188.87810513873, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [590.7755053079832, 603.6981509245377, 611.5871786544081, 631.9083732858738, 637.6014990630854, 33503.497447538306, 44206.33690494645, 45141.32288015674, 45291.77354113225, 45338.31992520115, 46521.0, 46932.53067469324, 46952.76523617386, 46998.29502557465, 47160.76419617897, 9002.504862232574, 9119.589618467151, 9124.041975592567, 9132.452052876815, 9132.589033493476, 9051.728448146567, 9131.497767622777, 9131.771705707344, 9134.0, 9139.405938613969, 9115.726528204164, 9170.0, 9174.724758257264, 9176.541172941326, 9180.036096209902, 9109.908900910972, 9127.087291270886, 9150.359474836798, 9160.992290848002, 9162.083791620851, 8936.195742383152, 9023.142801433853, 9028.277737780962, 9028.368014239006, 9045.909540904573, 43011.0, 43445.782771086255, 43467.130657386675, 43472.17430866983, 43485.56514434847, 3456.0668619472603, 3489.2498112905846, 3709.3879509880835, 3944.250592387466, 4073.5926407359325, 32819.34361312784, 33282.500762488584, 33289.3342133156, 33643.83178084094, 35109.47335789965, 4085.5097388313593, 4171.311733563958, 4272.530021697611, 4308.332208507655, 4417.580329868657, 384245.0, 391325.0, 392797.0, 393882.0, 395207.0, 53540.46459535433, 62507.687461562404, 63189.36810631927, 63209.0, 63304.0, 55150.0, 58255.70872145612, 58295.41704582985, 62626.0, 64495.35504644988, 15932.761008584881, 16110.516684499484, 16188.75716864248, 16239.675206495804, 16268.186590670419, 12240.387980600934, 12294.815577766341, 12304.876951230373, 12346.259224446561, 12351.0, 17316.913415432842, 19228.0031132085, 19446.18133095126, 19477.375644333202, 19477.718023400277, 6280.623162610166, 7367.4106071515225, 7440.627968601549, 7530.698772049166, 7612.619369031526, 968.1673760565908, 1050.3802756373775, 1089.0090018083506, 1097.5609756097465, 1121.5755989892791, 33575.83212083924, 34020.829895850366, 34029.0, 34157.48763768545, 34552.0, 1099.7525556749667, 1154.8325492803497, 1160.5995931403652, 1160.651804458676, 1168.9415529223504, 17297.394591189248, 17364.739528907077, 17770.200340984688, 17784.46646600604, 17795.0, 567411.0, 570865.0, 572435.0, 578429.0, 582495.0, 61895.69052154801, 62592.37407625956, 62593.37406625967, 62651.37348626547, 62661.686691566254, 1321.8876395506297, 1342.3422522963679, 1361.7140400516003, 1370.294298436306, 1390.3534856291874, 31538.684613153575, 33474.66525334716, 33636.1590960228, 33650.83174584111, 34059.65940340565, 53910.46089539054, 54347.456525435824, 54353.0, 54488.0, 54544.454555453936, 483270.0, 486222.0, 486228.0, 487084.0, 487426.0, 26126.0, 29625.703742962294, 30024.099277021724, 42375.152496950504, 45887.311690324, 41782.0, 43675.77803802306, 51866.22200666917, 52375.0, 52804.47195527996, 41040.38439423471, 41101.588984110975, 43848.34227486527, 43888.561114388445, 45390.00709921972, 43932.78033609811, 44870.312569781534, 44927.32609010933, 45218.32172517481, 45643.0, 44511.0, 44854.3271850929, 44971.0, 45311.0, 46076.30885536653, 37421.43867842039, 39457.0, 39676.404853927794, 39839.402408964466, 40170.59829401669, 29089.272768180967, 29774.702252977193, 30021.249468763457, 30061.0, 30074.54888176723], "value": 20974.622504864885, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [370.93137769512623, 373.3857803912564, 397.19567875053025, 404.0585435934273, 416.6416881481925, 16999.575010624725, 19946.60106797863, 19958.50103747407, 20227.292044778435, 20749.0, 19556.804431955676, 19625.11686974086, 19984.400467985983, 20160.495987600316, 20179.0, 5189.6886186828915, 5541.445855414467, 5866.941330586682, 5884.146798714184, 5910.61580997236, 5766.394528574502, 5839.824805255849, 5844.707764611774, 5845.09401042839, 5848.707564621752, 5569.248151499536, 5719.542436605062, 5736.770529178828, 5737.770489180428, 5818.738156782955, 5591.329040515124, 5627.999999999979, 5649.68926709035, 5657.773689052433, 5659.037963546207, 5058.721770302632, 5165.121929271995, 5166.948330516684, 5202.531772140488, 5220.216967454912, 20468.078936447895, 20852.791472085235, 24012.759872401228, 24345.513089738106, 24361.14735984232, 2349.941251468727, 2352.6588644646604, 2411.3489357873277, 2430.3559556717482, 2444.779969802726, 14217.289135543182, 14290.356933937894, 14439.494617688435, 15501.844981550266, 15878.36486540537, 1833.8441232495254, 1907.0845993922994, 1908.2271679969635, 1928.2961718972474, 1986.5728868293243, 83665.69104398256, 85078.0, 86347.0, 86973.99999999937, 87416.0, 10795.19036072282, 10801.83797243042, 10948.835767463494, 11152.553897844158, 11325.773484530264, 15268.465603703817, 15269.0, 15269.312880920384, 15282.235888205545, 15293.082415055133, 7852.136265010844, 8099.311558517474, 8102.716404925799, 8193.71322003727, 8268.049174344907, 7573.924260757432, 7574.166841647414, 7839.725609603751, 7844.411669124838, 7865.685372585147, 6774.424173945171, 6829.180498340231, 6878.415334696507, 6882.4149947254045, 6905.37851593359, 1871.410505690703, 1891.3569386408687, 1891.8675692701654, 1973.9802601973797, 2003.8897860617806, 902.2421166220406, 921.4149015375151, 1025.3950169400089, 1049.968500944973, 1092.819684752023, 19768.0, 20224.69662955057, 20313.187472500933, 20348.89825550863, 20665.89667051655, 943.6131186213756, 971.6987733802544, 984.9212063035084, 1028.3161697471098, 1055.7360659835042, 10656.467176641137, 10777.89222107769, 10799.460026998619, 11211.9348661877, 11490.482928268248, 414326.0, 423664.0, 519370.0, 534572.0, 537881.0, 53058.0, 65475.67262163754, 97660.0, 97897.51051244698, 101461.0, 1003.6437064841876, 1048.046277887119, 1054.641421916552, 1069.6844430892904, 1074.3768614203743, 17367.47897563075, 17737.113144342988, 18044.54888627795, 18126.909365453088, 18604.34884779026, 44162.0, 44455.77772111119, 44908.326375103745, 45420.318695218935, 46326.76836615795, 57905.42094579, 59341.70329148499, 60083.39916600953, 60362.69818650879, 63181.36818631755, 8289.4197406181, 8341.624626891926, 8412.831743365221, 8587.527685977331, 8625.454401378745, 9113.3165012623, 12887.0, 13184.274864882524, 13479.730405392034, 13842.515511957034, 11560.30638161713, 11687.415629218674, 11708.765824683629, 11767.23512971654, 11804.881951180721, 10813.0, 11155.832662509907, 11434.028107610946, 11457.885421145682, 12111.0, 10578.471076445992, 11015.889841101807, 11535.942320288344, 11571.884281157081, 11594.0, 8354.0, 8361.289290410383, 8422.873656895028, 8681.479111253346, 8823.205911467998, 8129.579790965024, 10994.615188468366, 11107.0, 11802.94098529502, 11955.222910510789], "value": 9394.072528768602, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1387.8057072009915, 1511.6825466651999, 1556.1830039229403, 1701.7617533545306, 1815.6731788278105, 8603.827923441535, 8822.338324625654, 8935.240504557112, 9187.862182067274, 9200.585973631187, 9042.728718138449, 9169.083091690827, 9185.173334399902, 9231.6307347706, 9236.630534778618, 2386.7851893329553, 2407.5064611754547, 2410.2889647553925, 2413.095089341497, 2414.9637755433682, 2366.6213405855065, 2404.2546810488716, 2410.505846301504, 2412.7104747430335, 2421.769931856471, 2353.1646265575732, 2362.55111528809, 2374.1097088591778, 2383.0, 2388.044782087162, 2267.353804165821, 2318.5826551220857, 2319.524497478013, 2320.97679023211, 2326.150954901466, 2232.1852523828848, 2259.344790010895, 2262.0951619352227, 2262.7963483286585, 2263.207877242968, 9064.68273610427, 9099.0, 9200.539973001323, 9210.03294654065, 9215.631374745002, 5187.066328060948, 5343.893122137574, 5345.812896548602, 5355.544778693816, 5357.7589008494715, 3271.4438545447333, 3290.93418131636, 3291.8024918504966, 3313.353895990283, 3367.410703126943, 1036.9377837329785, 1071.919606029551, 1075.6181555547746, 1081.3349789879246, 1097.5993762276792, 12889.742205155844, 12902.290374029424, 13088.934555327258, 13093.0, 13098.541551045668, 4439.822407103679, 4480.686351955397, 4622.607078398307, 4639.118567472169, 4642.605378542862, 10176.135028522658, 10185.337953033177, 10190.949045254727, 10193.439360835077, 10193.796124077477, 5274.0, 5280.683159010472, 5291.100512912737, 5301.310829592128, 5308.761105750174, 4310.094880075157, 4768.1417344878255, 4906.533879281463, 4913.336699545515, 4944.208926571731, 3756.398976163801, 3891.3384724596885, 3926.155876486569, 3945.684345252373, 3987.401889716508, 1166.731651720109, 1168.9181757277079, 1174.5569216030635, 1185.5731936502852, 1189.851268591426, 860.3203469259215, 963.5375019990444, 971.4608392342177, 1003.1623594298842, 1012.1295685710284, 5949.464548190597, 6147.938520614826, 6214.627122372582, 6300.117983482316, 6381.489480841522, 453.36302494993924, 1004.2618675273668, 1064.3932958213898, 1112.933224006562, 1129.4917287220783, 4014.1770936957855, 4122.40225167355, 4182.309918863353, 4213.831446742096, 4291.141771645621, 11448.255863368855, 11918.0, 11923.1653784236, 11924.940375298069, 11930.821037684442, 11840.644780656594, 11847.111466640037, 11851.585194518151, 11859.16985810985, 11859.169858110023, 7961.880571791427, 8285.42002059862, 8285.461445006054, 8477.321814254721, 8667.089955554577, 6250.718717657625, 6289.496840252677, 6444.7744328948265, 6479.384458476626, 6521.217453905561, 10523.684289471328, 10630.30902991303, 10885.0, 11033.117350611772, 11038.889611104107, 10495.737606559896, 10867.619633312795, 10918.908109189335, 10921.344719316867, 11008.724781880517, 7251.492395532473, 8052.476589021695, 8175.0, 8210.917890821254, 8349.206825351583, 9215.0, 9271.536423178948, 9279.814403711753, 9297.256219502287, 9302.302327325342, 7977.641006154621, 7994.400419968642, 8052.798680033046, 8246.628901699318, 8335.374846886629, 7846.960765196138, 7996.56018918965, 8076.515409075474, 8102.392320575863, 8132.227438393344, 7457.440691948234, 7469.626518673936, 7543.0, 7545.207753185837, 7553.7356192533, 5282.630215884851, 5388.946110538845, 5416.593755468277, 5434.0, 5481.068218402801, 5396.163594642837, 5494.2582751329655, 5542.72286385671, 5571.9721401392735, 5621.747021383966], "value": 4764.632805410817, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [332.7240034467816, 339.23164033464207, 341.07908646654033, 344.78278684428807, 347.319254261647, 5200.713960732158, 5229.8169564065265, 5251.71115588643, 5266.210068489729, 5285.550728188104, 5172.431032586422, 5180.352455943007, 5215.739213039352, 5227.484029631411, 5242.711650859202, 3967.1668949520636, 4007.799610019502, 4113.547509773923, 4133.7106402551835, 4134.73124246923, 4113.4858142732155, 4118.485189351331, 4150.169966006795, 4150.7340261220315, 4163.292240319153, 4088.5298190708004, 4090.365993271048, 4101.753894766309, 4105.137921036571, 4110.198511290299, 3937.8621748238816, 3938.2320447512748, 4096.1193343431305, 4099.672026237894, 4150.481189851269, 3650.5619325680823, 3655.830134357007, 3658.6158453362546, 3664.303782281358, 3668.633136686337, 5079.898402031976, 5094.2103973884105, 5097.852983078815, 5142.0, 5159.484051594848, 4482.21561226784, 4660.207764680013, 4665.020345727367, 4671.462781780105, 4699.295105734167, 5419.972900135474, 5420.864478388033, 5425.511703946664, 5426.9185962210595, 5444.7822087116465, 3957.920841583152, 3963.7225394222414, 3966.2067586482817, 3987.5414327352437, 3994.1612261425134, 5486.588505862076, 5602.803901863456, 5607.803726869581, 5671.6880571568545, 5698.0, 4000.659943904801, 4001.339778936443, 4003.7597744135446, 4012.1775036117524, 4035.1324465240114, 4076.5515793262716, 4079.673626109904, 4080.449139366207, 4095.365218391154, 4101.733387329814, 4572.511092277728, 4610.4697959734385, 4631.560001799824, 4662.184117779375, 4682.41469816273, 5443.891122177534, 5444.8094316698725, 5445.482679145475, 5466.316710411199, 5478.616496845262, 1394.0938390046551, 1409.189715913354, 1412.78808178774, 1414.2009764483034, 1418.6027912184604, 861.763015170833, 904.7511934218143, 926.2960150285832, 940.3699521320732, 940.8400571902793, 5098.4646612105935, 5159.432462429129, 5187.118189907725, 5210.895782084337, 5211.765470553834, 5505.972470137704, 5518.255035570227, 5526.47498487643, 5535.169724541271, 5572.124391157737, 5006.974965125151, 5166.43169251382, 5226.92159617606, 5233.607479439057, 5238.449962753933, 2926.5317549192027, 2940.456015637114, 2963.7628989681207, 2985.7462115719973, 2988.2379993102054, 5743.167240750151, 5757.13642953552, 5777.3933736957015, 5802.158686990363, 5802.187693722883, 5399.487048730364, 5673.943260567424, 5696.914546281809, 5759.366469688331, 5760.6543607382855, 5814.563907706939, 5827.533797296291, 5834.066549352084, 5851.566366240213, 5859.1797148399255, 5418.241446197614, 5630.493255607015, 5632.774689012557, 5633.324001119892, 5655.406182350794, 5519.475649813261, 5525.143602741581, 5530.364008139116, 5534.142207957612, 5541.473560011793, 5762.1849117527845, 5774.191613174243, 5777.653340799566, 5813.418658134153, 5834.299884013945, 3978.801059947049, 3980.8805735827973, 4017.819198136149, 4037.0, 4060.3706425504092, 5622.353429355513, 5635.520980716685, 5635.746391412478, 5636.436356364495, 5643.52030077448, 5502.944970550403, 5554.555635549065, 5555.30558680165, 5586.329640443173, 5588.692621905671, 5379.488948549882, 5434.673919564839, 5447.155690867922, 5460.535854452416, 5495.818399044225, 5357.633803380113, 5378.892422151614, 5403.351597808288, 5418.187271909245, 5448.128299472065, 5258.158694608845, 5295.173165258134, 5424.810131645373, 5457.645253058538, 5464.879699661639, 5327.6025788396155, 5357.776522743018, 5381.48875856793, 5390.784368625211, 5399.514043735925], "value": 4182.163387955406, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [771.7530390275115, 776.4368301122458, 786.2412771675336, 831.1937420701917, 841.6591280531384, 15582.844171558296, 17212.364825341574, 17236.224369903353, 17267.222974966124, 17274.654506909854, 14314.642133946656, 14336.641583960407, 14367.856321436782, 14400.135991840498, 14406.855931440683, 601.263452270969, 798.8801679748055, 801.0587559617455, 819.5902048975512, 824.6536454689045, 814.5072231300067, 825.591332290517, 827.3877330775243, 827.5779352530193, 828.1594181905341, 883.6156272021659, 886.3573908916017, 886.9334799890034, 888.005433914014, 888.4580405952364, 706.4701473894605, 835.9707410240612, 862.9913700863036, 875.0986483921539, 875.7066382761783, 634.9492040636738, 639.0829160155192, 639.5011890725242, 639.7664852328913, 640.7052755732323, 13705.862941370558, 13726.45094196231, 13736.587902362946, 13739.931300343535, 13751.724965500734, 14134.929325353307, 14464.006356931766, 14531.0, 14592.270386480739, 14667.0, 12669.873301267055, 12678.80981785274, 12686.111972161953, 12850.0, 13351.265680387574, 4439.467263928317, 4511.8646440606835, 4514.264897423496, 4547.499775024778, 4683.367745354368, 83762.16237837604, 84279.15720842835, 84470.57764711199, 84583.0, 84753.15246847576, 11001.449927503592, 11090.390028548345, 11296.887031129583, 11450.713732156597, 11531.88468115325, 21080.578388432452, 21415.46461338479, 21427.357179284645, 21484.355469335944, 21506.784932150476, 8306.750797476085, 8307.626156822958, 8483.872741908875, 8638.222559969507, 8777.473351598797, 4830.29960655703, 4873.512648735098, 4878.487758785347, 4924.852254432372, 5032.874178145576, 3295.868165273362, 3367.4275373186615, 3369.4777309517062, 3374.7806392584403, 3381.036404624719, 580.1413907417046, 585.1252377695373, 605.1860247966478, 606.0273261415452, 606.3178923710825, 581.988360232793, 638.658317799984, 707.005419380494, 736.3446532586003, 737.9151397589346, 9709.611615535441, 9737.267340954038, 9792.902070979342, 9918.702438926844, 10059.748506287402, 634.4480302137171, 681.7886455198905, 714.6319645382632, 715.8783006888841, 730.2223132364015, 4562.908741825145, 4826.686265392808, 4858.805647774049, 4910.950890491121, 4927.826524561899, 125244.0, 125392.0, 127776.36111819382, 130290.0, 134979.32510337385, 101931.0, 103240.48379758053, 106233.93766062395, 109033.0, 113910.43044784723, 56222.43777562254, 91960.0, 92001.0, 95465.0, 96437.51781240909, 8730.214280714767, 8877.0, 8946.507942063248, 9179.265658747418, 10067.546960386946, 40904.181916362104, 56161.0, 57603.711981439825, 58731.706341468016, 61044.08433873584, 84423.5778821102, 84716.03493877931, 84832.0, 87722.56138719266, 88580.5570972141, 14125.15249085017, 14340.426382944564, 14540.49108281205, 14560.344784484512, 15123.924380378028, 13835.723285534434, 14146.43414263418, 14150.646233844236, 14307.356168972214, 14609.213250517818, 14602.0, 14629.85370146285, 14766.0, 14832.851671483148, 15109.71537605313, 14734.115953042852, 14738.0, 15123.243837808286, 15135.243237837843, 15620.68758624844, 14091.365888534836, 14129.293535323399, 14552.49066282675, 15000.249987500363, 15458.381664733284, 12407.689807754517, 12537.87462125367, 12542.372881355714, 12589.811152832897, 13082.869171308546, 10824.0, 11591.594294199662, 11791.1117761483, 11871.503500865983, 12420.875791241971], "value": 7804.492013478906, "unit": "score"}], "name": "dromaeo_css", "value": 7360.499838776799, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [103.0, 112.0, 111.0, 110.0, 111.0, 111.0, 112.0, 110.0, 110.0, 111.0], "value": 110.1, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [142.0, 116.0, 124.0, 186.0, 117.0, 125.0, 148.0, 116.0, 152.0, 117.0], "value": 134.3, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [161.0, 159.0, 160.0, 160.0, 160.0, 160.0, 160.0, 161.0, 161.0, 160.0], "value": 160.2, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [74.0, 75.0, 74.0, 134.0, 75.0, 77.0, 74.0, 74.0, 108.0, 75.0], "value": 84.0, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 83.0, 118.0, 84.0, 84.0, 83.0, 115.0, 83.0, 84.0, 134.0], "value": 95.2, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 116.0, 116.0, 116.0, 116.0, 117.0, 117.0, 116.0, 116.0, 117.0], "value": 116.4, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [145.0, 145.0, 146.0, 146.0, 146.0, 146.0, 146.0, 146.0, 145.0, 146.0], "value": 145.7, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 94.0, 95.0, 95.0, 95.0, 95.0, 95.0, 96.0, 95.0, 96.0], "value": 95.1, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [49.0, 49.0, 49.0, 49.0, 49.0, 50.0, 52.0, 50.0, 49.0, 49.0], "value": 49.5, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [59.0, 60.0, 59.0, 59.0, 59.0, 60.0, 59.0, 59.0, 59.0, 59.0], "value": 59.2, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [77.0, 76.0, 76.0, 75.0, 76.0, 74.0, 75.0, 77.0, 78.0, 75.0], "value": 75.9, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [121.0, 119.0, 136.0, 122.0, 127.0, 138.0, 117.0, 137.0, 126.0, 131.0], "value": 127.4, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [158.0, 159.0, 156.0, 155.0, 160.0, 160.0, 157.0, 158.0, 158.0, 156.0], "value": 157.7, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [64.0, 64.0, 64.0, 68.0, 63.0, 64.0, 62.0, 63.0, 61.0, 61.0], "value": 63.4, "unit": "score"}], "name": "kraken", "value": 1474.1000000000004, "alertThreshold": 2.0}]} 16:34:24 INFO - Return code: 0 16:34:24 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 16:34:24 INFO - # TBPL SUCCESS # 16:34:24 INFO - Running post-action listener: _resource_record_post_action 16:34:24 INFO - [mozharness: 2016-08-04 23:34:24.513209Z] Finished run-tests step (success) 16:34:24 INFO - Running post-run listener: _resource_record_post_run 16:34:24 INFO - Total resource usage - Wall time: 1191s; CPU: 13.0%; Read bytes: 4096; Write bytes: 544104448; Read time: 4; Write time: 481964 16:34:24 INFO - TinderboxPrint: CPU usage
13.0% 16:34:24 INFO - TinderboxPrint: I/O read bytes / time
4,096 / 4 16:34:24 INFO - TinderboxPrint: I/O write bytes / time
544,104,448 / 481,964 16:34:24 INFO - TinderboxPrint: CPU idle
8,272.2 (87.0%) 16:34:24 INFO - TinderboxPrint: CPU user
1,190.2 (12.5%) 16:34:24 INFO - TinderboxPrint: Swap in / out
0 / 0 16:34:24 INFO - install - Wall time: 17s; CPU: 13.0%; Read bytes: 0; Write bytes: 247201792; Read time: 0; Write time: 236564 16:34:24 INFO - run-tests - Wall time: 1175s; CPU: 13.0%; Read bytes: 0; Write bytes: 295596032; Read time: 0; Write time: 245320 16:34:25 INFO - Running post-run listener: _upload_blobber_files 16:34:25 INFO - Blob upload gear active. 16:34:25 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 16:34:25 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 16:34:25 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'] 16:34:25 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 16:34:25 INFO - (blobuploader) - INFO - Open directory for files ... 16:34:25 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 16:34:25 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 16:34:25 INFO - (blobuploader) - INFO - Uploading, attempt #1. 16:34:26 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 16:34:26 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 16:34:26 INFO - (blobuploader) - INFO - Done attempting. 16:34:26 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 16:34:26 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 16:34:26 INFO - (blobuploader) - INFO - Uploading, attempt #1. 16:34:27 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 16:34:27 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 16:34:27 INFO - (blobuploader) - INFO - Done attempting. 16:34:27 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 16:34:27 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 16:34:27 INFO - (blobuploader) - INFO - Uploading, attempt #1. 16:34:30 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 16:34:30 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 16:34:30 INFO - (blobuploader) - INFO - Done attempting. 16:34:30 INFO - (blobuploader) - INFO - Iteration through files over. 16:34:30 INFO - Return code: 0 16:34:30 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 16:34:30 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 16:34:30 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/437ce20a9574051d27a5748f2f8bdf6e1b4cb4d84a63dc114c392e475ba7adaf2d1e1aba8bc45f722b6295a65c1d406fea689683b6c7ccae77dcb5adeb7f07f0", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/d405bc766eece0bed23d3ec6d8be5dc03a52099fb6555b699cb6305f57287fd180f46874f089abeb91a0f2fa6e195b3d2d640c1a77af1c51a39172c1c4e839f6", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/13b79768d9cd4656e929a303857e9cc0d708806df2ed01408d08462210c783f5058da1f0f828bb574ca6edbf191cedfb60673dac4eba64c744343e41fed70ed5"} 16:34:30 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 16:34:30 INFO - Writing to file /builds/slave/test/properties/blobber_files 16:34:30 INFO - Contents: 16:34:30 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/437ce20a9574051d27a5748f2f8bdf6e1b4cb4d84a63dc114c392e475ba7adaf2d1e1aba8bc45f722b6295a65c1d406fea689683b6c7ccae77dcb5adeb7f07f0", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/d405bc766eece0bed23d3ec6d8be5dc03a52099fb6555b699cb6305f57287fd180f46874f089abeb91a0f2fa6e195b3d2d640c1a77af1c51a39172c1c4e839f6", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/13b79768d9cd4656e929a303857e9cc0d708806df2ed01408d08462210c783f5058da1f0f828bb574ca6edbf191cedfb60673dac4eba64c744343e41fed70ed5"} 16:34:30 INFO - Running post-run listener: copy_logs_to_upload_dir 16:34:30 INFO - Copying logs to upload dir... 16:34:30 INFO - mkdir: /builds/slave/test/build/upload/logs 16:34:30 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1232.675136 ========= master_lag: 0.03 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 32 secs) (at 2016-08-04 16:34:30.388223) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-08-04 16:34:30.391902) ========= 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=62c568580acbfdaac3eec7be000001dc-1470352422.749459-898834608 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/437ce20a9574051d27a5748f2f8bdf6e1b4cb4d84a63dc114c392e475ba7adaf2d1e1aba8bc45f722b6295a65c1d406fea689683b6c7ccae77dcb5adeb7f07f0", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/d405bc766eece0bed23d3ec6d8be5dc03a52099fb6555b699cb6305f57287fd180f46874f089abeb91a0f2fa6e195b3d2d640c1a77af1c51a39172c1c4e839f6", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/13b79768d9cd4656e929a303857e9cc0d708806df2ed01408d08462210c783f5058da1f0f828bb574ca6edbf191cedfb60673dac4eba64c744343e41fed70ed5"} build_url:https://queue.taskcluster.net/v1/task/Slkje-RSToSGmGOKEXF4PA/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011357 build_url: 'https://queue.taskcluster.net/v1/task/Slkje-RSToSGmGOKEXF4PA/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/437ce20a9574051d27a5748f2f8bdf6e1b4cb4d84a63dc114c392e475ba7adaf2d1e1aba8bc45f722b6295a65c1d406fea689683b6c7ccae77dcb5adeb7f07f0", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/d405bc766eece0bed23d3ec6d8be5dc03a52099fb6555b699cb6305f57287fd180f46874f089abeb91a0f2fa6e195b3d2d640c1a77af1c51a39172c1c4e839f6", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/13b79768d9cd4656e929a303857e9cc0d708806df2ed01408d08462210c783f5058da1f0f828bb574ca6edbf191cedfb60673dac4eba64c744343e41fed70ed5"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-08-04 16:34:30.422245) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-08-04 16:34:30.422668) ========= 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=62c568580acbfdaac3eec7be000001dc-1470352422.749459-898834608 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004399 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-08-04 16:34:30.507420) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-08-04 16:34:30.507775) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-08-04 16:34:30.508106) ========= ========= Total master_lag: 0.19 =========